builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1474647959.02 results: success (0) buildid: 20160923063008 builduid: d67bb725fca74bb783ebe531911d00ac revision: 2e46d0c12db68401969a817832329187da8add06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.022331) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.022711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.022983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.042589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.042882) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 09:25: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.3M=0s 2016-09-23 09:25:59 (60.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114532 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.361042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.361346) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020068 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:25:59.398803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 09:25:59.399122) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 09:25:59,804 truncating revision to first 12 chars 2016-09-23 09:25:59,804 Setting DEBUG logging. 2016-09-23 09:25:59,804 attempt 1/10 2016-09-23 09:25:59,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e46d0c12db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 09:26:00,528 unpacking tar archive at: fx-team-2e46d0c12db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.029744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 09:26:00.446357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:26:00.446748) ========= script_repo_revision: 2e46d0c12db68401969a817832329187da8add06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:26:00.447234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:26:00.447541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:26:00.456471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-23 09:26:00.456802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:26:00 INFO - MultiFileLogger online at 20160923 09:26:00 in /builds/slave/test 09:26:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:26:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:26:00 INFO - {'append_to_log': False, 09:26:00 INFO - 'base_work_dir': '/builds/slave/test', 09:26:00 INFO - 'blob_upload_branch': 'Fx-Team', 09:26:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:26:00 INFO - 'branch': 'Fx-Team', 09:26:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:26:00 INFO - 'config_files': ('talos/linux_config.py',), 09:26:00 INFO - 'default_actions': ('clobber', 09:26:00 INFO - 'read-buildbot-config', 09:26:00 INFO - 'download-and-extract', 09:26:00 INFO - 'populate-webroot', 09:26:00 INFO - 'create-virtualenv', 09:26:00 INFO - 'install', 09:26:00 INFO - 'run-tests'), 09:26:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:26:00 INFO - 'download_minidump_stackwalk': True, 09:26:00 INFO - 'download_symbols': 'ondemand', 09:26:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:26:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:26:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:26:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:26:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:26:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:26:00 INFO - 'installer_path': 'installer.exe', 09:26:00 INFO - 'log_level': 'info', 09:26:00 INFO - 'log_name': 'talos', 09:26:00 INFO - 'log_to_console': True, 09:26:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:26:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:26:00 INFO - 'opt_config_files': (), 09:26:00 INFO - 'pip_index': False, 09:26:00 INFO - 'sps_profile': False, 09:26:00 INFO - 'sps_profile_interval': 0, 09:26:00 INFO - 'suite': 'dromaeojs', 09:26:00 INFO - 'system_bits': '32', 09:26:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:26:00 INFO - 'title': 'talos-linux64-ix-067', 09:26:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:26:00 INFO - 'use_talos_json': True, 09:26:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:26:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:26:00 INFO - 'work_dir': 'build'} 09:26:00 INFO - [mozharness: 2016-09-23 16:26:00.948947Z] Running clobber step. 09:26:00 INFO - Running pre-action listener: _resource_record_pre_action 09:26:00 INFO - Running main action method: clobber 09:26:00 INFO - rmtree: /builds/slave/test/build 09:26:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:26:01 INFO - Running post-action listener: _resource_record_post_action 09:26:01 INFO - [mozharness: 2016-09-23 16:26:01.403035Z] Finished clobber step (success) 09:26:01 INFO - [mozharness: 2016-09-23 16:26:01.403136Z] Running read-buildbot-config step. 09:26:01 INFO - Running pre-action listener: _resource_record_pre_action 09:26:01 INFO - Running main action method: read_buildbot_config 09:26:01 INFO - Using buildbot properties: 09:26:01 INFO - { 09:26:01 INFO - "project": "", 09:26:01 INFO - "product": "firefox", 09:26:01 INFO - "script_repo_revision": "production", 09:26:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:26:01 INFO - "repository": "", 09:26:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:26:01 INFO - "buildid": "20160923063008", 09:26:01 INFO - "pgo_build": "True", 09:26:01 INFO - "basedir": "/builds/slave/test", 09:26:01 INFO - "buildnumber": 1593, 09:26:01 INFO - "slavename": "talos-linux64-ix-067", 09:26:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:26:01 INFO - "platform": "ubuntu64_hw", 09:26:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:26:01 INFO - "branch": "fx-team", 09:26:01 INFO - "repo_path": "integration/fx-team", 09:26:01 INFO - "revision": "2e46d0c12db68401969a817832329187da8add06", 09:26:01 INFO - "stage_platform": "linux64-pgo", 09:26:01 INFO - "builduid": "d67bb725fca74bb783ebe531911d00ac", 09:26:01 INFO - "slavebuilddir": "test" 09:26:01 INFO - } 09:26:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:26:01 INFO - Running post-action listener: _resource_record_post_action 09:26:01 INFO - [mozharness: 2016-09-23 16:26:01.405579Z] Finished read-buildbot-config step (success) 09:26:01 INFO - [mozharness: 2016-09-23 16:26:01.405669Z] Running download-and-extract step. 09:26:01 INFO - Running pre-action listener: _resource_record_pre_action 09:26:01 INFO - Running main action method: download_and_extract 09:26:01 INFO - mkdir: /builds/slave/test/build/tests 09:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:01 INFO - trying https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:26:01 INFO - Downloaded 1361 bytes. 09:26:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:26:01 INFO - Using the following test package requirements: 09:26:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:26:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:26:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:26:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'jsshell-linux-x86_64.zip'], 09:26:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:26:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:26:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:26:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:26:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:26:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:26:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:26:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:26:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:26:02 INFO - Expected file size: 21948233 09:26:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:26:07 INFO - Expected file size: 21948233 09:26:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:26:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:26:12 INFO - Expected file size: 14414059 09:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:13 INFO - trying https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:26:14 INFO - Downloaded 59685650 bytes. 09:26:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:26:14 INFO - mkdir: /builds/slave/test/properties 09:26:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:14 INFO - Contents: 09:26:14 INFO - build_url:https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:26:15 INFO - Running post-action listener: _resource_record_post_action 09:26:15 INFO - Running post-action listener: set_extra_try_arguments 09:26:15 INFO - [mozharness: 2016-09-23 16:26:15.143171Z] Finished download-and-extract step (success) 09:26:15 INFO - [mozharness: 2016-09-23 16:26:15.143399Z] Running populate-webroot step. 09:26:15 INFO - Running pre-action listener: _resource_record_pre_action 09:26:15 INFO - Running main action method: populate_webroot 09:26:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:15 INFO - '--tppagecycles', 09:26:15 INFO - '7'], 09:26:15 INFO - 'tests': ['tsvgm']}}, 09:26:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:26:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:26:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['damp', 'tps']}, 09:26:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'tests': ['damp', 'tps']}, 09:26:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['dromaeo_dom']}, 09:26:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['basic_compositor_video']}, 09:26:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:26:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'other-e10s': {'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['a11yr', 09:26:15 INFO - 'ts_paint', 09:26:15 INFO - 'tpaint', 09:26:15 INFO - 'sessionrestore', 09:26:15 INFO - 'sessionrestore_no_auto_restore', 09:26:15 INFO - 'tabpaint']}, 09:26:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['tsvgx', 09:26:15 INFO - 'tsvgr_opacity', 09:26:15 INFO - 'tart', 09:26:15 INFO - 'tscrollx', 09:26:15 INFO - 'cart']}, 09:26:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:26:15 INFO - 'tsvgr_opacity', 09:26:15 INFO - 'tart', 09:26:15 INFO - 'tscrollx', 09:26:15 INFO - 'cart']}, 09:26:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'talos_options': ['--disable-e10s'], 09:26:15 INFO - 'tests': ['tp5o']}, 09:26:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'tests': ['tp5o']}, 09:26:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'talos_options': ['--disable-e10s', 09:26:15 INFO - '--xperf_path', 09:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:15 INFO - 'tests': ['tp5n']}, 09:26:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:15 INFO - 'talos_options': ['--xperf_path', 09:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:15 INFO - 'tests': ['tp5n']}}, 09:26:15 INFO - 'talos.zip': {'path': '', 09:26:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:15 INFO - Running post-action listener: _resource_record_post_action 09:26:15 INFO - [mozharness: 2016-09-23 16:26:15.163776Z] Finished populate-webroot step (success) 09:26:15 INFO - [mozharness: 2016-09-23 16:26:15.163866Z] Running create-virtualenv step. 09:26:15 INFO - Running pre-action listener: _resource_record_pre_action 09:26:15 INFO - Running main action method: create_virtualenv 09:26:15 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:26:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:15 INFO - Using real prefix '/usr' 09:26:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:17 INFO - Installing pip.................done. 09:26:17 INFO - Return code: 0 09:26:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:26:17 INFO - Using env: {'DISPLAY': ':0', 09:26:17 INFO - 'HOME': '/home/cltbld', 09:26:17 INFO - 'LANG': 'en_US.UTF-8', 09:26:17 INFO - 'LANGUAGE': 'en_US:en', 09:26:17 INFO - 'LOGNAME': 'cltbld', 09:26:17 INFO - 'MAIL': '/var/mail/cltbld', 09:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:17 INFO - 'MOZ_NO_REMOTE': '1', 09:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:17 INFO - 'NO_EM_RESTART': '1', 09:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:17 INFO - 'PWD': '/builds/slave/test', 09:26:17 INFO - 'SHELL': '/bin/bash', 09:26:17 INFO - 'SHLVL': '1', 09:26:17 INFO - 'TERM': 'linux', 09:26:17 INFO - 'TMOUT': '86400', 09:26:17 INFO - 'USER': 'cltbld', 09:26:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:17 INFO - '_': '/tools/buildbot/bin/python'} 09:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:26:17 INFO - Cleaning up... 09:26:17 INFO - Return code: 0 09:26:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:26:17 INFO - Using env: {'DISPLAY': ':0', 09:26:17 INFO - 'HOME': '/home/cltbld', 09:26:17 INFO - 'LANG': 'en_US.UTF-8', 09:26:17 INFO - 'LANGUAGE': 'en_US:en', 09:26:17 INFO - 'LOGNAME': 'cltbld', 09:26:17 INFO - 'MAIL': '/var/mail/cltbld', 09:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:17 INFO - 'MOZ_NO_REMOTE': '1', 09:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:17 INFO - 'NO_EM_RESTART': '1', 09:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:17 INFO - 'PWD': '/builds/slave/test', 09:26:17 INFO - 'SHELL': '/bin/bash', 09:26:17 INFO - 'SHLVL': '1', 09:26:17 INFO - 'TERM': 'linux', 09:26:17 INFO - 'TMOUT': '86400', 09:26:17 INFO - 'USER': 'cltbld', 09:26:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:17 INFO - '_': '/tools/buildbot/bin/python'} 09:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:18 INFO - Downloading/unpacking psutil>=3.1.1 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:20 INFO - Installing collected packages: psutil 09:26:20 INFO - Running setup.py install for psutil 09:26:20 INFO - building 'psutil._psutil_linux' extension 09:26:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:26:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:26:20 INFO - building 'psutil._psutil_posix' extension 09:26:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:26:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:26:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:20 INFO - Successfully installed psutil 09:26:20 INFO - Cleaning up... 09:26:20 INFO - Return code: 0 09:26:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:20 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:26:20 INFO - Using env: {'DISPLAY': ':0', 09:26:20 INFO - 'HOME': '/home/cltbld', 09:26:20 INFO - 'LANG': 'en_US.UTF-8', 09:26:20 INFO - 'LANGUAGE': 'en_US:en', 09:26:20 INFO - 'LOGNAME': 'cltbld', 09:26:20 INFO - 'MAIL': '/var/mail/cltbld', 09:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:20 INFO - 'MOZ_NO_REMOTE': '1', 09:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:20 INFO - 'NO_EM_RESTART': '1', 09:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:20 INFO - 'PWD': '/builds/slave/test', 09:26:20 INFO - 'SHELL': '/bin/bash', 09:26:20 INFO - 'SHLVL': '1', 09:26:20 INFO - 'TERM': 'linux', 09:26:20 INFO - 'TMOUT': '86400', 09:26:20 INFO - 'USER': 'cltbld', 09:26:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:20 INFO - '_': '/tools/buildbot/bin/python'} 09:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:26:22 INFO - Installing collected packages: mozsystemmonitor 09:26:22 INFO - Running setup.py install for mozsystemmonitor 09:26:22 INFO - Successfully installed mozsystemmonitor 09:26:22 INFO - Cleaning up... 09:26:23 INFO - Return code: 0 09:26:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:23 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:26:23 INFO - Using env: {'DISPLAY': ':0', 09:26:23 INFO - 'HOME': '/home/cltbld', 09:26:23 INFO - 'LANG': 'en_US.UTF-8', 09:26:23 INFO - 'LANGUAGE': 'en_US:en', 09:26:23 INFO - 'LOGNAME': 'cltbld', 09:26:23 INFO - 'MAIL': '/var/mail/cltbld', 09:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:23 INFO - 'MOZ_NO_REMOTE': '1', 09:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:23 INFO - 'NO_EM_RESTART': '1', 09:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:23 INFO - 'PWD': '/builds/slave/test', 09:26:23 INFO - 'SHELL': '/bin/bash', 09:26:23 INFO - 'SHLVL': '1', 09:26:23 INFO - 'TERM': 'linux', 09:26:23 INFO - 'TMOUT': '86400', 09:26:23 INFO - 'USER': 'cltbld', 09:26:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:23 INFO - '_': '/tools/buildbot/bin/python'} 09:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:25 INFO - warning: no files found matching '*.txt' 09:26:25 INFO - no previously-included directories found matching 'build' 09:26:25 INFO - no previously-included directories found matching 'dist' 09:26:25 INFO - no previously-included directories found matching '.git*' 09:26:25 INFO - Installing collected packages: jsonschema, functools32 09:26:25 INFO - Running setup.py install for functools32 09:26:25 INFO - warning: no files found matching '*.txt' 09:26:25 INFO - no previously-included directories found matching 'build' 09:26:25 INFO - no previously-included directories found matching 'dist' 09:26:25 INFO - no previously-included directories found matching '.git*' 09:26:25 INFO - Successfully installed jsonschema functools32 09:26:25 INFO - Cleaning up... 09:26:25 INFO - Return code: 0 09:26:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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', '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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:26: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 functools32==3.2.3-2 09:26:25 INFO - Using env: {'DISPLAY': ':0', 09:26:25 INFO - 'HOME': '/home/cltbld', 09:26:25 INFO - 'LANG': 'en_US.UTF-8', 09:26:25 INFO - 'LANGUAGE': 'en_US:en', 09:26:25 INFO - 'LOGNAME': 'cltbld', 09:26:25 INFO - 'MAIL': '/var/mail/cltbld', 09:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:25 INFO - 'MOZ_NO_REMOTE': '1', 09:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:25 INFO - 'NO_EM_RESTART': '1', 09:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:25 INFO - 'PWD': '/builds/slave/test', 09:26:25 INFO - 'SHELL': '/bin/bash', 09:26:25 INFO - 'SHLVL': '1', 09:26:25 INFO - 'TERM': 'linux', 09:26:25 INFO - 'TMOUT': '86400', 09:26:25 INFO - 'USER': 'cltbld', 09:26:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:25 INFO - '_': '/tools/buildbot/bin/python'} 09:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:26:25 INFO - Cleaning up... 09:26:25 INFO - Return code: 0 09:26:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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', '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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:26: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 blobuploader==1.2.4 09:26:25 INFO - Using env: {'DISPLAY': ':0', 09:26:25 INFO - 'HOME': '/home/cltbld', 09:26:25 INFO - 'LANG': 'en_US.UTF-8', 09:26:25 INFO - 'LANGUAGE': 'en_US:en', 09:26:25 INFO - 'LOGNAME': 'cltbld', 09:26:25 INFO - 'MAIL': '/var/mail/cltbld', 09:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:25 INFO - 'MOZ_NO_REMOTE': '1', 09:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:25 INFO - 'NO_EM_RESTART': '1', 09:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:25 INFO - 'PWD': '/builds/slave/test', 09:26:25 INFO - 'SHELL': '/bin/bash', 09:26:25 INFO - 'SHLVL': '1', 09:26:25 INFO - 'TERM': 'linux', 09:26:25 INFO - 'TMOUT': '86400', 09:26:25 INFO - 'USER': 'cltbld', 09:26:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:25 INFO - '_': '/tools/buildbot/bin/python'} 09:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:28 INFO - Downloading docopt-0.6.1.tar.gz 09:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:28 INFO - Running setup.py install for blobuploader 09:26:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:28 INFO - Running setup.py install for requests 09:26:29 INFO - Running setup.py install for docopt 09:26:29 INFO - Successfully installed blobuploader requests docopt 09:26:29 INFO - Cleaning up... 09:26:29 INFO - Return code: 0 09:26:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:29 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:29 INFO - Using env: {'DISPLAY': ':0', 09:26:29 INFO - 'HOME': '/home/cltbld', 09:26:29 INFO - 'LANG': 'en_US.UTF-8', 09:26:29 INFO - 'LANGUAGE': 'en_US:en', 09:26:29 INFO - 'LOGNAME': 'cltbld', 09:26:29 INFO - 'MAIL': '/var/mail/cltbld', 09:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:29 INFO - 'MOZ_NO_REMOTE': '1', 09:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:29 INFO - 'NO_EM_RESTART': '1', 09:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:29 INFO - 'PWD': '/builds/slave/test', 09:26:29 INFO - 'SHELL': '/bin/bash', 09:26:29 INFO - 'SHLVL': '1', 09:26:29 INFO - 'TERM': 'linux', 09:26:29 INFO - 'TMOUT': '86400', 09:26:29 INFO - 'USER': 'cltbld', 09:26:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:29 INFO - '_': '/tools/buildbot/bin/python'} 09:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:29 INFO - Running setup.py (path:/tmp/pip-HbyONx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:29 INFO - Running setup.py (path:/tmp/pip-e6DpEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:29 INFO - Running setup.py (path:/tmp/pip-aCFXFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:29 INFO - Running setup.py (path:/tmp/pip-E__zLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:29 INFO - Running setup.py (path:/tmp/pip-ADW_Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:29 INFO - Running setup.py (path:/tmp/pip-CDkoke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:29 INFO - Running setup.py (path:/tmp/pip-aky4hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:29 INFO - Running setup.py (path:/tmp/pip-zu8mca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:30 INFO - Running setup.py (path:/tmp/pip-q1BvoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:30 INFO - Running setup.py (path:/tmp/pip-ZjANzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:30 INFO - Running setup.py (path:/tmp/pip-kpdapS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:30 INFO - Running setup.py (path:/tmp/pip-XrfGOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:30 INFO - Running setup.py (path:/tmp/pip-XLwcQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:30 INFO - Running setup.py (path:/tmp/pip-u0oCEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:30 INFO - Running setup.py (path:/tmp/pip-QdXX38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:30 INFO - Running setup.py (path:/tmp/pip-FCa0M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:30 INFO - Running setup.py (path:/tmp/pip-bctMej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:30 INFO - Running setup.py install for manifestparser 09:26:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:30 INFO - Running setup.py install for mozcrash 09:26:30 INFO - Running setup.py install for mozdebug 09:26:30 INFO - Running setup.py install for mozdevice 09:26:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for mozfile 09:26:31 INFO - Running setup.py install for mozhttpd 09:26:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for mozinfo 09:26:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for mozInstall 09:26:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for mozleak 09:26:31 INFO - Running setup.py install for mozlog 09:26:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for moznetwork 09:26:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:31 INFO - Running setup.py install for mozprocess 09:26:31 INFO - Running setup.py install for mozprofile 09:26:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Running setup.py install for mozrunner 09:26:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Running setup.py install for mozscreenshot 09:26:32 INFO - Running setup.py install for moztest 09:26:32 INFO - Running setup.py install for mozversion 09:26:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:32 INFO - Cleaning up... 09:26:32 INFO - Return code: 0 09:26:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:32 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:32 INFO - Using env: {'DISPLAY': ':0', 09:26:32 INFO - 'HOME': '/home/cltbld', 09:26:32 INFO - 'LANG': 'en_US.UTF-8', 09:26:32 INFO - 'LANGUAGE': 'en_US:en', 09:26:32 INFO - 'LOGNAME': 'cltbld', 09:26:32 INFO - 'MAIL': '/var/mail/cltbld', 09:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:32 INFO - 'MOZ_NO_REMOTE': '1', 09:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:32 INFO - 'NO_EM_RESTART': '1', 09:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:32 INFO - 'PWD': '/builds/slave/test', 09:26:32 INFO - 'SHELL': '/bin/bash', 09:26:32 INFO - 'SHLVL': '1', 09:26:32 INFO - 'TERM': 'linux', 09:26:32 INFO - 'TMOUT': '86400', 09:26:32 INFO - 'USER': 'cltbld', 09:26:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:32 INFO - '_': '/tools/buildbot/bin/python'} 09:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:32 INFO - Running setup.py (path:/tmp/pip-DerNg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:32 INFO - Running setup.py (path:/tmp/pip-GNME8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:32 INFO - Running setup.py (path:/tmp/pip-IBz_Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:32 INFO - Running setup.py (path:/tmp/pip-iZm35b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:33 INFO - Running setup.py (path:/tmp/pip-5o0M1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:33 INFO - Running setup.py (path:/tmp/pip-Dki1Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:33 INFO - Running setup.py (path:/tmp/pip-fIs4f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:33 INFO - Running setup.py (path:/tmp/pip-cAzn7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:33 INFO - Running setup.py (path:/tmp/pip-RJRnB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:33 INFO - Running setup.py (path:/tmp/pip-COeM0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:33 INFO - Running setup.py (path:/tmp/pip-j9lG5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:33 INFO - Running setup.py (path:/tmp/pip-QaUp0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:33 INFO - Running setup.py (path:/tmp/pip-I4AH7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:33 INFO - Running setup.py (path:/tmp/pip-9SSIyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:33 INFO - Running setup.py (path:/tmp/pip-1YERVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:33 INFO - Running setup.py (path:/tmp/pip-wU92O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:33 INFO - Running setup.py (path:/tmp/pip-kNbnPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:35 INFO - Downloading blessings-1.6.tar.gz 09:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:35 INFO - Installing collected packages: blessings 09:26:35 INFO - Running setup.py install for blessings 09:26:36 INFO - Successfully installed blessings 09:26:36 INFO - Cleaning up... 09:26:36 INFO - Return code: 0 09:26:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:26:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:36 INFO - Reading from file tmpfile_stdout 09:26:36 INFO - Current package versions: 09:26:36 INFO - argparse == 1.2.1 09:26:36 INFO - blessings == 1.6 09:26:36 INFO - blobuploader == 1.2.4 09:26:36 INFO - docopt == 0.6.1 09:26:36 INFO - functools32 == 3.2.3-2 09:26:36 INFO - jsonschema == 2.5.1 09:26:36 INFO - manifestparser == 1.1 09:26:36 INFO - mozInstall == 1.12 09:26:36 INFO - mozcrash == 0.17 09:26:36 INFO - mozdebug == 0.1 09:26:36 INFO - mozdevice == 0.48 09:26:36 INFO - mozfile == 1.2 09:26:36 INFO - mozhttpd == 0.7 09:26:36 INFO - mozinfo == 0.9 09:26:36 INFO - mozleak == 0.1 09:26:36 INFO - mozlog == 3.4 09:26:36 INFO - moznetwork == 0.27 09:26:36 INFO - mozprocess == 0.23 09:26:36 INFO - mozprofile == 0.28 09:26:36 INFO - mozrunner == 6.12 09:26:36 INFO - mozscreenshot == 0.1 09:26:36 INFO - mozsystemmonitor == 0.3 09:26:36 INFO - moztest == 0.7 09:26:36 INFO - mozversion == 1.4 09:26:36 INFO - psutil == 3.1.1 09:26:36 INFO - requests == 1.2.3 09:26:36 INFO - wsgiref == 0.1.2 09:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:36 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 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:36 INFO - Using env: {'DISPLAY': ':0', 09:26:36 INFO - 'HOME': '/home/cltbld', 09:26:36 INFO - 'LANG': 'en_US.UTF-8', 09:26:36 INFO - 'LANGUAGE': 'en_US:en', 09:26:36 INFO - 'LOGNAME': 'cltbld', 09:26:36 INFO - 'MAIL': '/var/mail/cltbld', 09:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:36 INFO - 'MOZ_NO_REMOTE': '1', 09:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:36 INFO - 'NO_EM_RESTART': '1', 09:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:36 INFO - 'PWD': '/builds/slave/test', 09:26:36 INFO - 'SHELL': '/bin/bash', 09:26:36 INFO - 'SHLVL': '1', 09:26:36 INFO - 'TERM': 'linux', 09:26:36 INFO - 'TMOUT': '86400', 09:26:36 INFO - 'USER': 'cltbld', 09:26:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:36 INFO - '_': '/tools/buildbot/bin/python'} 09:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:26:36 INFO - Cleaning up... 09:26:36 INFO - Return code: 0 09:26:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89fcf44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:26:36 INFO - Using env: {'DISPLAY': ':0', 09:26:36 INFO - 'HOME': '/home/cltbld', 09:26:36 INFO - 'LANG': 'en_US.UTF-8', 09:26:36 INFO - 'LANGUAGE': 'en_US:en', 09:26:36 INFO - 'LOGNAME': 'cltbld', 09:26:36 INFO - 'MAIL': '/var/mail/cltbld', 09:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:36 INFO - 'MOZ_NO_REMOTE': '1', 09:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:36 INFO - 'NO_EM_RESTART': '1', 09:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:36 INFO - 'PWD': '/builds/slave/test', 09:26:36 INFO - 'SHELL': '/bin/bash', 09:26:36 INFO - 'SHLVL': '1', 09:26:36 INFO - 'TERM': 'linux', 09:26:36 INFO - 'TMOUT': '86400', 09:26:36 INFO - 'USER': 'cltbld', 09:26:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:36 INFO - '_': '/tools/buildbot/bin/python'} 09:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:26:36 INFO - Cleaning up... 09:26:36 INFO - Return code: 0 09:26:36 INFO - Running post-action listener: _resource_record_post_action 09:26:36 INFO - Running post-action listener: _start_resource_monitoring 09:26:36 INFO - Starting resource monitoring. 09:26:36 INFO - [mozharness: 2016-09-23 16:26:36.793392Z] Finished create-virtualenv step (success) 09:26:36 INFO - [mozharness: 2016-09-23 16:26:36.793849Z] Running install step. 09:26:36 INFO - Running pre-action listener: _resource_record_pre_action 09:26:36 INFO - Running main action method: install 09:26:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:37 INFO - Reading from file tmpfile_stdout 09:26:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:26:37 INFO - Reading from file tmpfile_stdout 09:26:37 INFO - Output received: 09:26:37 INFO - Usage: mozinstall [options] installer 09:26:37 INFO - Options: 09:26:37 INFO - -h, --help show this help message and exit 09:26:37 INFO - -d DEST, --destination=DEST 09:26:37 INFO - Directory to install application into. [default: 09:26:37 INFO - "/builds/slave/test"] 09:26:37 INFO - --app=APP Application being installed. [default: firefox] 09:26:37 INFO - mkdir: /builds/slave/test/build/application 09:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:26:54 INFO - Reading from file tmpfile_stdout 09:26:54 INFO - Output received: 09:26:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:26:54 INFO - Running post-action listener: _resource_record_post_action 09:26:54 INFO - [mozharness: 2016-09-23 16:26:54.055861Z] Finished install step (success) 09:26:54 INFO - [mozharness: 2016-09-23 16:26:54.056106Z] Running run-tests step. 09:26:54 INFO - Running pre-action listener: _resource_record_pre_action 09:26:54 INFO - Running main action method: run_tests 09:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:54 INFO - Python 2.7.3 09:26:54 INFO - Return code: 0 09:26:54 INFO - grabbing minidump binary from tooltool 09:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:54 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 0x2944930>, '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 0x2945830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2945cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:26:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:26:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:26:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:54 INFO - Return code: 0 09:26:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:26:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:26:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:26:54 INFO - Using env: {'DISPLAY': ':0', 09:26:54 INFO - 'HOME': '/home/cltbld', 09:26:54 INFO - 'LANG': 'en_US.UTF-8', 09:26:54 INFO - 'LANGUAGE': 'en_US:en', 09:26:54 INFO - 'LOGNAME': 'cltbld', 09:26:54 INFO - 'MAIL': '/var/mail/cltbld', 09:26:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:54 INFO - 'MOZ_NO_REMOTE': '1', 09:26:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:54 INFO - 'NO_EM_RESTART': '1', 09:26:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:54 INFO - 'PWD': '/builds/slave/test', 09:26:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:54 INFO - 'SHELL': '/bin/bash', 09:26:54 INFO - 'SHLVL': '1', 09:26:54 INFO - 'TERM': 'linux', 09:26:54 INFO - 'TMOUT': '86400', 09:26:54 INFO - 'USER': 'cltbld', 09:26:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450', 09:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:54 INFO - '_': '/tools/buildbot/bin/python'} 09:26:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:26:54 INFO - mozversion application_buildid: 20160923063008 09:26:54 INFO - mozversion application_changeset: 2e46d0c12db68401969a817832329187da8add06 09:26:54 INFO - mozversion application_display_name: Nightly 09:26:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:54 INFO - mozversion application_name: Firefox 09:26:54 INFO - mozversion application_remotingname: firefox 09:26:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:26:54 INFO - mozversion application_vendor: Mozilla 09:26:54 INFO - mozversion application_version: 52.0a1 09:26:54 INFO - mozversion platform_buildid: 20160923063008 09:26:54 INFO - mozversion platform_changeset: 2e46d0c12db68401969a817832329187da8add06 09:26:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:26:54 INFO - mozversion platform_version: 52.0a1 09:26:54 INFO - using testdate: 1474648014 09:26:54 INFO - actual date: 1474648014 09:26:54 INFO - starting webserver on 'localhost:39773' 09:26:54 INFO - SUITE-START | Running 2 tests 09:26:54 INFO - TEST-START | dromaeo_css 09:26:54 INFO - operating with platform_type : linux_ 09:26:54 INFO - Initialising browser for dromaeo_css test... 09:26:54 INFO - TEST-INFO | started process 1581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQPJyyH/profile http://localhost:39773/getInfo.html) 09:26:58 INFO - PROCESS | 1581 | __metrics Screen width/height:1600/1200 09:26:58 INFO - PROCESS | 1581 | colorDepth:24 09:26:58 INFO - PROCESS | 1581 | Browser inner width/height: 1024/697 09:26:58 INFO - PROCESS | 1581 | __metrics 09:26:58 INFO - PROCESS | 1581 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:26:58 INFO - PROCESS | 1581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:59 INFO - PROCESS | 1581 | console.error: PushService: 09:26:59 INFO - PROCESS | 1581 | stateChangeProcessEnqueue: Error transitioning state 09:26:59 INFO - PROCESS | 1581 | UnknownError 09:27:00 INFO - TEST-INFO | 1581: exit 0 09:27:00 INFO - Browser initialized. 09:27:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:00 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQPJyyH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:12 INFO - PROCESS | 1664 | RSS: Main: 173244416 09:27:12 INFO - PROCESS | 1664 | 09:28:03 INFO - PROCESS | 1664 | 1474648083994 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:30:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39773/tests/dromaeo/cssquery-ext.html) 09:30:14 INFO - PROCESS | 1664 | RSS: Main: 312868864 09:30:14 INFO - PROCESS | 1664 | 09:33:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-ext.html (next: http://localhost:39773/tests/dromaeo/cssquery-jquery.html) 09:33:17 INFO - PROCESS | 1664 | RSS: Main: 271618048 09:33:17 INFO - PROCESS | 1664 | 09:36:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39773/tests/dromaeo/cssquery-mootools.html) 09:36:19 INFO - PROCESS | 1664 | RSS: Main: 215191552 09:36:19 INFO - PROCESS | 1664 | 09:39:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39773/tests/dromaeo/cssquery-prototype.html) 09:39:22 INFO - PROCESS | 1664 | RSS: Main: 255516672 09:39:22 INFO - PROCESS | 1664 | 09:42:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39773/tests/dromaeo/cssquery-yui.html) 09:42:25 INFO - PROCESS | 1664 | RSS: Main: 216768512 09:42:25 INFO - PROCESS | 1664 | 09:45:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-yui.html (next: http://localhost:39773/tests/dromaeo/cssquery-dojo.html) 09:45:29 INFO - PROCESS | 1664 | RSS: Main: 307617792 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | __start_tp_report 09:45:29 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 09:45:29 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 09:45:29 INFO - PROCESS | 1664 | |i|pagename|runs| 09:45:29 INFO - PROCESS | 1664 | |0;dojo.html;3000.6249218847643;3035.5143177091654;3041.756659467242;3063.678313777055;3090.845457727113;5166.638335316529;5231.659942103761;5233.607479439038;5295.841124766258;5360.356757189133;5232.1628539433605;5250.107481728106;5300.09898317287;5309.230161626571;5386.569074474042;4751.786169622358;4775.904481910377;4811.663183577151;4864.221724524077;4884.951150488494;4831.08209440207;4865.6594038417325;4947.77735001924;4949.901001979958;4963.230699241623;4880.658353915227;4910.459849416561;4935.876603084934;4964.60283177345;5001.624878134155;4709.105269998689;4736.407949006374;4760.833370832039;4794.640401969867;4802.759862006886;4694.882627934295;4705.600023997964;4708.9875676729325;4728.054389122155;4769.952300476985;5198.506141916512;5214.426413094595;5226.947730522684;5239.921401178985;5244.396894357122;5465.07093794056;5529.861753456155;5556.472135147154;5566.387697353288;5635.098384258499;5690.4025077367105;5698.316202055738;5711.828645140652;5713.228714123582;5766.740496677618;5315.415304316522;5322.680639161663;5325.334333208349;5325.600579956557;5337.687397951595;5640.266765320482;5687.800926967537;5747.540196784247;5784.161296611967;5882.735276912464;5571.9442805571425;5572.164175373645;5575.52608028314;5631.549476041989;5639.210510528529;5639.774409023676;5645.774169033275;5648.971755141198;5651.350094739158;5655;5419.187121931742;5524.723763811793;5533.03171944908;5625.606207565431;5631.18347839561;5547.11246200606;5605.971970140205;5607.467290607386;5651.0675738503505;5676.091825307931;4290.957090429119;4342.261815491374;4344.543822898613;4350.151720414488;4394.670399720034;3817.3701339279264;3818.961810381916;3857.556381016219;3916.5887581804072;3937.015746063484;5259.526642602184;5319.28189694394;5323.760430780624;5377.489138531833;5388.2725832012175;5654.97172514143;5658.97170514153;5659.518940890071;5664.85837854057;5667.036603777367;5179.093658609803;5210.218467229945;5346.037713211582;5346.331708536433;5417.6478528895495;4794.065157294364;4800.855974320776;4805.447373552086;4831.4685384607665;4897.412310522689;5773.624714393551;5774.48029677331;5824.5340372770925;5830.125481177857;5842.2405087338375;5580.302462192226;5587.832365029056;5652.236948011966;5653.349864765604;5658.773649053992;5635.239242702347;5667.773289068391;5791.478766910998;5816.36020037804;5818.330891947311;5554.472325129106;5575.609707320448;5592.748326325406;5637.8590535236945;5641.830745077655;5661.547076233809;5666.858328541819;5670.574706896917;5673.489385955284;5681.119426488901;5414;5541.639793413416;5547.195656629847;5548.4174161712435;5551.944480555143;5419.160030195326;5531.917021244765;5554.861128471821;5574.749136288958;5625.268715067179;5517.475839795213;5527;5531.9723401382735;5533.114701647717;5533.3083364579425;5599.496045355938;5604.551635869202;5611.675617775401;5614.326280846324;5616.66300022;5333.893322133458;5348.679079255257;5366.168243922199;5372.274742909657;5401.756920938488 09:45:29 INFO - PROCESS | 1664 | |1;ext.html;564.8841987392582;603.9245094363205;617.5214208988034;631.7283568065733;632.9683515824207;30934.69065309349;42410;44064.45774397901;44074;44091;42784.35823462643;43182.56817431832;43194.784026079906;43232.56767432325;43343;8160.673573057071;8878.644854205824;9017.504037277948;9024.232940200058;9034.14175653312;7828.334591559696;10603.946980265087;10862.239643224977;10867.619633312836;11129.610463633775;11033.117350611932;11086.556537738481;11094.1124710023;11097.278676885977;11102.056325212367;8144.226298501692;8377.581120943989;10807.243492955497;10902.345859248391;10907.236493445462;8186.304164146055;8244.670213191464;10283.177345812317;10666.520006599721;10670.786584268271;42359;42690;42708.57291427077;42728.57271427277;42767;3418.7606867519285;3455.4644030175364;3525.453554699026;3644.9817750911343;3846.344093467738;30801.38397232065;31816.363672726417;32148.35703285921;32330.83834580812;32952.176195595064;4100.220958017967;4165.937510937339;4192.308269135589;4257.446531950826;4267.146570685875;322374;324744;324842;327359;327744;56955.71522142363;57171.42828571661;57405.71297143488;57439.71280143572;57453;59469.70265148646;59517.40482595205;59547;59657.40342596518;59678;14499.855001450062;14922.403103875724;14925.25373731309;14933.626659333386;14936.850631493764;11013.614523491638;11304.660860174208;11760.88239117615;11828.940855295668;11884;16749.24628391725;16830.15849207535;16855.241514131892;16881.32474701023;17064.317427303016;5762.279715035621;5965.671888046112;5987.880242395127;6004.309504406961;6119.326874043852;938.4463166731662;949.6533765175799;993.2848349188573;1041.968740937758;1072.9141668666643;31308.217294567818;31978.680213198037;32155;32204.355912882078;32782.18044548858;1045.0646671229208;1058.957641694339;1063.4363787192801;1090.6727981605486;1151.073385924322;15869.52391428259;17015.574610634587;17044.573885652957;17144;17214.397496087826;441420;443690;444062;444903;446775.0241229532;56820.14769778457;57007;57080.42919570834;57135.14297285544;57153.14270285949;1210.6791700199453;1238.6717519857245;1314.7304802515462;1315.7039666075057;1347.6361382426885;29299.85350073236;32718;33684.831575842945;34054.65945340614;34147.829260853534;49158.26262605992;49642.50357496523;49768;49855.75072124761;49923.75038124786;367243;369671;369832;369971;370904;27286.317842054108;28006.2998425041;28085.71914280913;29294.853525733088;29336.55995160117;47051.29423058726;47543.28685069796;47633;47958.28062579134;48386.03227935492;39366.752514409105;40138;40267.798661006505;40980.59019409768;41435.585644144376;39358.60641393549;39725;40278.798606006785;40599.797001014806;41730.582694173885;40388.79805601071;40650.18699625932;41948.580514194466;41977.370339445544;42067.7896610515;33301.33397331991;35451.64548354483;36799.376112300044;36965;36986.630133698316;27372.45255094847;27472.862635687492;27678.16965490958;27787.722122778512;28044.29889252785 09:45:29 INFO - PROCESS | 1664 | |2;jquery.html;352.86767462201675;356.68611621772834;368.92621475704857;369.17305236270755;376.6497157643391;14309.28453577321;18288.177032033556;18595.5351116222;19513.317033903815;19677.311294104707;15232.543023709306;16284.918575407106;18377.264909403606;19054.523636909085;19175.712364314546;5522.66863988161;5772.942270577303;5773.422657734235;5779.248697669318;5782.24830771999;4090;4183.686223533232;4465.866024019285;5641.830745077655;5732.4554167354245;4482.843100491484;6538.411542961133;6548.476121910236;6549.952007678772;6575.835604109888;6290.119383286366;6480.546361754679;6526.184226971629;6526.934730652728;6531.51013673974;5664.376918538957;5689.431056894319;5703.40114288002;5703.857403564903;5704.686242256675;22527;22937.426564336027;23011.1946081888;23036;23042.53914921709;2211.7124773779465;2295.127851416451;2356.8939397727145;2434.257551446808;2635.8813853376646;13788.241646709528;14263.714725705531;14404.855951440457;14704.191269480281;14871.992281042028;1736.157963387756;1746.4585978346754;1857.4334827877492;1904.2954106980367;1990.8108729670657;49252.50747492551;70327;80812.59593702052;82294;82595.5870220645;9866.753331166778;9939.254555908192;9993.650222242186;10143.949280253699;10224.488775561193;13885.097468664504;13893.235872026933;13903.374348154357;13906.4437422504;14027.71944561103;7749.457537972288;7924.4056695746895;7991.043313973751;8122.065962414398;8205.71280005197;7751.418643601753;7822.8435431291055;7917.841643167105;8022.638981245858;8081.838363232702;6238.376162383725;6340.9365906340345;6344.841378965562;6482.157319548429;6577.112089867902;1698.3036954848453;1827.8629102817342;1838.705807070889;1843.1889968413855;1851.8055604161639;942.2697409507687;942.820864035831;986.3637953520083;998.2597769123656;1076.4510099849133;18931.337403191097;19393.515162120777;19916.90041549783;20040.098195581235;20403.38789836307;951.4434056077134;977.1352353167356;980.1374790184592;985.9852102218473;995.3231802374455;10470.16238700902;10828.133749300037;11123.555057797597;11630.302181869114;11726.472308746126;421871;432430;434162;437037;437549;84886;90649.54675226581;90781.02817380166;93344;94853.26795264205;1016.3698506925754;1030.0677886512717;1041.7499800048085;1041.8801837788599;1042.0309112525272;17718.645627087644;17799.110044497465;18422.35521756732;18422.90788546049;18593.44219673412;42120.78939605282;42250;42583;42604.5739542613;42909.57090429181;58299.4170058294;59956;59961.40038599732;60556.091658626035;61275.38724612697;7809.531428114331;8126.146754590683;8140.226678465537;8150.470219435718;8225.383096267684;12092.455839487067;12722.809157862454;12810.167339122927;12853.485860565472;12974.481020759064;10244.180465562587;11101.167412443938;11230.887691123311;11694.824577631513;11713.590024349107;10188.134008609351;10411.271211015157;10462.110720588531;11158.609448669258;11178.608748693756;11576.24754390962;11676.474558645052;11759.588414405454;11827.112966527373;11936;8103.149169337371;8155.266026057683;8356.687138513074;8408.705695300636;8633.179847914438;9340;11265.436728163395;11310.773784524099;11421.828672570084;11766.352850593299 09:45:29 INFO - PROCESS | 1664 | |3;mootools.html;1352.8511863694998;1463.04901813821;1516.4692357674812;1612.3308826836862;1791.6954117799964;7565.281298276662;8569.957150214248;8850.645974161025;8855.070217627153;9162.633494660206;8842.204201621853;8945.463272203673;8947.686830960918;8953.373263871532;8959.23846473049;2330.592146374386;2343.2267351773876;2348.236823032513;2351.905923763047;2353.188150088217;2302.9078836846506;2321;2353.2822489140804;2355.4229213842546;2360.280114565057;2285.165914441234;2301.0680674326923;2303.8041766449874;2309.976900230993;2325.7790509901615;2249.268987579035;2255.8533695309916;2262.7171603549555;2266.8186545076437;2280.1791355112146;2264.7735226477384;2268;2268.478250002492;2274.101729816713;2276.5560715660454;8666.436681615738;8843.11568843117;8890.86663700045;8897;8924.643014279422;5149.665271757323;5361.892762144775;5363.731813409314;5366.597505187126;5371.086915224382;3384.5938487381427;3432.1248081738995;3443.6900678938764;3493.3188028334484;3495.2834668892815;1058.8517607534952;1089.1776708585046;2059.104289633999;2107.599556084339;2119.73503312086;12124.333161676104;12148.271103733716;12256.938715306456;12310.076744244217;12334.814977775251;4293.420388247547;4452.821887124479;4566.018306064212;4586.174488592019;4652.883677908079;9635.22918166545;9648.565814538362;9658.661946831828;9660;9664.613415463444;5147.974260128675;5150.922736158961;5152.639315247971;5153.6907785532985;5164.122099243138;4088.5911408858874;4210.221109094828;4254.298040823292;4367.803448844809;4751.192297309466;3469.219425629213;3796.4495148203355;3802.068493219179;3810.428435734662;3813.599572044951;1096.6216655253925;1118.2340097033396;1132.3036332655358;1142.7485953090472;1144.416347662698;943.3302355327794;948.5921053946869;956.5791051937125;967.5307475874196;984.699666601679;5669.291338582677;5825.533957283407;5928.318243401977;5936.604897849002;6091.48222401092;435.75162157569883;447.3163498589116;447.6441229222776;448.0367210497391;458.52542618390476;3977.8607748728655;4158.875233742932;4166.104287578185;4166.166766646683;4185.183889141649;10764.331528613078;11050.944745276383;11120.332780033224;11126.888731112585;11143.16426268017;10994;11040.723981900517;11045.558177672803;11064.889351106547;11067.059299959432;7744.612769361622;8167.305779008732;8249;8257.05043919957;8272.875906861402;5777.364489906191;5881.794137205177;5913.822585322448;5929.940700592939;6054.939450605614;9396.530173491436;9551.474668893277;9858.901410986085;9922.702318930444;9936.403815771077;9182.265418766348;9612.711618651452;9847.704568862659;9996.600135994478;10403.427811470441;6818.352256535622;7324.853502930018;7478.5138965967035;7513.661885215069;7707.267809558083;8216.34269258446;8324.042735085543;8324.542150181556;8390.664373424994;8474.830503389774;7492.400607951242;7525.059367579052;7558.319751222416;7580.54516728998;7599.240075992357;7098.751543695946;7168.856622867409;7256.492045556761;7360.595167265852;7663.808404789925;7045;7139.428845692436;7150.392216661642;7227.891581626174;7233.1681856587165;4943.530364615356;5076.974615126901;5165.767540460613;5182.455842136521;5277.920831187458;5017.147084995632;5022.045811295842;5078.238264260391;5108.335916330853;5328.200769884548 09:45:29 INFO - PROCESS | 1664 | |4;prototype.html;312.5733373944565;321.60121449402743;322.7885734843678;323.23393557269276;324.4613940858175;5111.718855462948;5261.1319132343115;5315.68105913645;5330.413654498002;5350;5039.4204666463365;5195.506426889449;5209.942072881209;5234.476552344764;5280.9207861882105;4146.336586146217;4151.294279972412;4156.210320039198;4181.28918083925;4190.3923931029985;3912.8239229234755;4084.5098588169462;4187.120704652027;4194.454720886296;4214.810333534998;4058.533268674111;4064.3700226464944;4075.4294398784195;4075.8981025474304;4101;4053.0070132817355;4061.3704875744306;4061.634452899253;4067.6745860331253;4091.488563929509;3459.930801383958;3571.8392672329805;3573.9642603573893;3587.6053634100226;3597.190632107781;5144.356955380577;5146.614003949719;5149.536541711226;5164.457731938168;5171.120909445366;4665.440147182326;4710.31700403443;4725.810967561293;4725.929111063337;4734.313524538922;5472;5492.862678433031;5529.861753456155;5576.079946808772;5581.274434323553;3931.28988889831;3936.8031598419966;3947;3958.1094253792953;3973.701972352056;5734.770609175628;5760.395158508338;5808.8838223235725;5820.44705752957;5821.243238379026;3943.5662077171487;4000.6799456043445;4037.37420699792;4047.1096358801015;4048.9797551012643;4068.389741538793;4072.7759973201164;4082.2856000199845;4084.2648323301496;4092.3656833190903;4609.377734005933;4648.674592778473;4674.78455601546;4699.483056863811;4735.526447355237;5464.180372944011;5542.649020518873;5575.247341608912;5599.552035837123;5612.5229355504425;1329.2622594459974;1357.1924704800629;1375.0168629430007;1404.6628809085746;1407.5144075294006;928.8064836684828;945.4164274839616;958.8034452937131;964.2334344196381;967.2165545907837;5299.205119232146;5313.44208858072;5323.3079699639575;5328.49379308965;5330.360356757214;5581.190727344512;5609.298837645294;5624.3813180550105;5627.212190293362;5634.577406694432;5197.714125723046;5331.760070796823;5332.2801421808335;5332.5467335276935;5348.705821179872;2647.3116989582845;2662.4142688608476;2687.50281197979;2690.3005218643293;2698.2984424049887;5137.5376216139975;5153.639245252872;5160.813013007029;5162.535371816554;5187.198912587236;4914.33656456381;5138.254953031789;5152.742362881916;5174.974125129425;5191.195364718475;5110.495857030029;5135.87160320995;5150.755024334645;5163.509466600667;5194.558462530652;5003.249512573143;5013.924791128209;5023.773930173078;5054.16606259963;5104.285400043923;4710.882227944328;4880.412412332396;4883.267509873405;4888.975555122344;4915.336429582104;5087.821926232564;5093.261477085728;5096.1336572781975;5099.838100377641;5124.052050370693;3601.981990090033;3608.1778701755447;3638.199596088856;3643.781373117515;3648.872289469962;4720;4940.6038071535995;4953.504649535018;5048.5203905628905;5395.3525576931015;5384.353877534721;5385.4076051635075;5457.890842183214;5488.204210389551;5541.1991102892525;5504.862378440571;5509.889802204014;5525.640833345819;5530.529904957963;5598.160275958476;5266.236395722675;5447.630280827852;5480.205370221216;5489.533389661764;5546.389897111395;5564.443555644403;5594.468525490072;5603.523700485504;5604.85987850307;5615.522680572034;5447.264619276505;5476.205950137288;5495.2856128703015;5514.228008078952;5522.22688823557 09:45:29 INFO - PROCESS | 1664 | |5;yui.html;731.2760367236435;736.1056316575363;742.7029188324666;784.8665726826439;815.3029160068144;15713.214339283033;16563.337466501354;16569.917150414247;16571.50285491437;16575.33698652054;14120.858791412084;14128.646783830409;14157.646058848533;14228.146311221308;14402.423903043866;654.0548906829633;672.5258692621715;776.7786180938434;790.4664351562701;804.111456840192;799.3006119645311;806.733777853307;806.8466991271669;808.8786681997689;810.0481933727875;848.0925409811504;849.5157760076759;850.4769566716486;850.7702920211539;853.5476197615274;692.0829900382014;710.641126231255;819.7663665855263;847.3687103108163;847.7795773099008;610.1366566308668;614.1095411653076;614.6281499692666;614.6680792372114;614.7418084404561;14797.33411996452;14830.184339861304;14866.331015104346;14900.254987250593;14948.775768363483;14040.789388159186;14241.287935603179;14279.286035698173;14360.856391436057;14507.564773056825;11383.601573944956;11623.535058597647;11732.120090993125;12402.379881005914;12700.872991270062;4320.395144679747;4391.187630288407;4418.867433976986;4437.245668236407;4551.34005569194;81484;82541.58729206315;84252;86046;86567;10566.551679573682;10795.56817727282;10812.837807432894;10902.563897444013;11086.16853735973;21556.245531406326;21695.24066657691;21756.673649895263;21763.23828665989;21768.673469897964;7768.10666773317;7841.725539606086;7880.684772609146;7885.605719714106;8018.398620103516;4333.674974376934;4400.163968845973;4426.22541055314;4437.600615944581;4518.683692141584;3588.5693716753635;3672;3683.5211422514903;3709.0727318170457;3709.0912726382207;644.9613023218621;675.999520709353;685.9622720750407;688.1535711075405;699.3076853914588;697.7069630755095;714.5248409807524;723.3020135569201;726.8110291324293;758.2341834746835;9435.811283774286;9686.128248457531;9867.506624668738;9912.851307230398;10102.343347682377;726.1358982810439;758.7647829172975;761.7790840656147;764.1288930619098;780.1184661332658;4485.955140448619;4643;4762.738049407316;4938.530839570307;4951.8266860659705;122416.38791806162;123690;126024;128822;130082;110914;110950;111072.44463777791;113999.43000285112;114997;75371.62314188395;76893.6155319231;96669.51665241629;97752.51123744335;98031.50984245034;9272;9616.75958101053;9919.15687166599;9975.301728878909;10053.899461005296;44466;48744;49223.75388123036;49347.50652493573;50397.74801125971;53970.73014635059;61657.691711541156;63509.364906352195;67132.32867671261;68269.65865170643;12950.417231224428;13003.609891703263;13004;13101.868981310065;13258.270795106362;13485.662858428617;13752.243626600633;14247.572572822832;14812.925935370255;15023.173725444769;12751.61745147647;13380.19718816874;13733.381997809922;14093.506727264497;14197.787033194303;11690.47392867306;12050.819237711617;12143.878561214628;12631.557895473614;12968.286744229157;12206.572769953364;12264.570740024414;13312.534061307808;13351.465941362625;13745.931270343584;10150.492475376053;10484.161267098767;11001.17491188148;11442.313461192354;11860.466279017292;10704.571817127227;10876;11012.119030477703;11015.118790496901;11105.722356941142 09:45:29 INFO - PROCESS | 1664 | __end_tp_report 09:45:29 INFO - PROCESS | 1664 | __start_cc_report 09:45:29 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1033 09:45:29 INFO - PROCESS | 1664 | __end_cc_report 09:45:29 INFO - PROCESS | 1664 | __startTimestamp1474649129076__endTimestamp 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | ------- Summary: start ------- 09:45:29 INFO - PROCESS | 1664 | Number of tests: 6 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5244.76 Median:5419.19 stddev:588.79 (10.9%) stddev-sans-first:563.66 09:45:29 INFO - PROCESS | 1664 | Values: 3000.6 3035.5 3041.8 3063.7 3090.8 5166.6 5231.7 5233.6 5295.8 5360.4 5232.2 5250.1 5300.1 5309.2 5386.6 4751.8 4775.9 4811.7 4864.2 4885.0 4831.1 4865.7 4947.8 4949.9 4963.2 4880.7 4910.5 4935.9 4964.6 5001.6 4709.1 4736.4 4760.8 4794.6 4802.8 4694.9 4705.6 4709.0 4728.1 4770.0 5198.5 5214.4 5226.9 5239.9 5244.4 5465.1 5529.9 5556.5 5566.4 5635.1 5690.4 5698.3 5711.8 5713.2 5766.7 5315.4 5322.7 5325.3 5325.6 5337.7 5640.3 5687.8 5747.5 5784.2 5882.7 5571.9 5572.2 5575.5 5631.5 5639.2 5639.8 5645.8 5649.0 5651.4 5655.0 5419.2 5524.7 5533.0 5625.6 5631.2 5547.1 5606.0 5607.5 5651.1 5676.1 4291.0 4342.3 4344.5 4350.2 4394.7 3817.4 3819.0 3857.6 3916.6 3937.0 5259.5 5319.3 5323.8 5377.5 5388.3 5655.0 5659.0 5659.5 5664.9 5667.0 5179.1 5210.2 5346.0 5346.3 5417.6 4794.1 4800.9 4805.4 4831.5 4897.4 5773.6 5774.5 5824.5 5830.1 5842.2 5580.3 5587.8 5652.2 5653.3 5658.8 5635.2 5667.8 5791.5 5816.4 5818.3 5554.5 5575.6 5592.7 5637.9 5641.8 5661.5 5666.9 5670.6 5673.5 5681.1 5414.0 5541.6 5547.2 5548.4 5551.9 5419.2 5531.9 5554.9 5574.7 5625.3 5517.5 5527.0 5532.0 5533.1 5533.3 5599.5 5604.6 5611.7 5614.3 5616.7 5333.9 5348.7 5366.2 5372.3 5401.8 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:54883.12 Median:370437.50 stddev:100833.57 (27.2%) stddev-sans-first:101033.96 09:45:29 INFO - PROCESS | 1664 | Values: 564.9 603.9 617.5 631.7 633.0 30934.7 42410.0 44064.5 44074.0 44091.0 42784.4 43182.6 43194.8 43232.6 43343.0 8160.7 8878.6 9017.5 9024.2 9034.1 7828.3 10603.9 10862.2 10867.6 11129.6 11033.1 11086.6 11094.1 11097.3 11102.1 8144.2 8377.6 10807.2 10902.3 10907.2 8186.3 8244.7 10283.2 10666.5 10670.8 42359.0 42690.0 42708.6 42728.6 42767.0 3418.8 3455.5 3525.5 3645.0 3846.3 30801.4 31816.4 32148.4 32330.8 32952.2 4100.2 4165.9 4192.3 4257.4 4267.1 322374.0 324744.0 324842.0 327359.0 327744.0 56955.7 57171.4 57405.7 57439.7 57453.0 59469.7 59517.4 59547.0 59657.4 59678.0 14499.9 14922.4 14925.3 14933.6 14936.9 11013.6 11304.7 11760.9 11828.9 11884.0 16749.2 16830.2 16855.2 16881.3 17064.3 5762.3 5965.7 5987.9 6004.3 6119.3 938.4 949.7 993.3 1042.0 1072.9 31308.2 31978.7 32155.0 32204.4 32782.2 1045.1 1059.0 1063.4 1090.7 1151.1 15869.5 17015.6 17044.6 17144.0 17214.4 441420.0 443690.0 444062.0 444903.0 446775.0 56820.1 57007.0 57080.4 57135.1 57153.1 1210.7 1238.7 1314.7 1315.7 1347.6 29299.9 32718.0 33684.8 34054.7 34147.8 49158.3 49642.5 49768.0 49855.8 49923.8 367243.0 369671.0 369832.0 369971.0 370904.0 27286.3 28006.3 28085.7 29294.9 29336.6 47051.3 47543.3 47633.0 47958.3 48386.0 39366.8 40138.0 40267.8 40980.6 41435.6 39358.6 39725.0 40278.8 40599.8 41730.6 40388.8 40650.2 41948.6 41977.4 42067.8 33301.3 35451.6 36799.4 36965.0 36986.6 27372.5 27472.9 27678.2 27787.7 28044.3 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:27207.67 Median:372.91 stddev:71570.91 (19192.5%) stddev-sans-first:71743.28 09:45:29 INFO - PROCESS | 1664 | Values: 352.9 356.7 368.9 369.2 376.6 14309.3 18288.2 18595.5 19513.3 19677.3 15232.5 16284.9 18377.3 19054.5 19175.7 5522.7 5772.9 5773.4 5779.2 5782.2 4090.0 4183.7 4465.9 5641.8 5732.5 4482.8 6538.4 6548.5 6550.0 6575.8 6290.1 6480.5 6526.2 6526.9 6531.5 5664.4 5689.4 5703.4 5703.9 5704.7 22527.0 22937.4 23011.2 23036.0 23042.5 2211.7 2295.1 2356.9 2434.3 2635.9 13788.2 14263.7 14404.9 14704.2 14872.0 1736.2 1746.5 1857.4 1904.3 1990.8 49252.5 70327.0 80812.6 82294.0 82595.6 9866.8 9939.3 9993.7 10143.9 10224.5 13885.1 13893.2 13903.4 13906.4 14027.7 7749.5 7924.4 7991.0 8122.1 8205.7 7751.4 7822.8 7917.8 8022.6 8081.8 6238.4 6340.9 6344.8 6482.2 6577.1 1698.3 1827.9 1838.7 1843.2 1851.8 942.3 942.8 986.4 998.3 1076.5 18931.3 19393.5 19916.9 20040.1 20403.4 951.4 977.1 980.1 986.0 995.3 10470.2 10828.1 11123.6 11630.3 11726.5 421871.0 432430.0 434162.0 437037.0 437549.0 84886.0 90649.5 90781.0 93344.0 94853.3 1016.4 1030.1 1041.7 1041.9 1042.0 17718.6 17799.1 18422.4 18422.9 18593.4 42120.8 42250.0 42583.0 42604.6 42909.6 58299.4 59956.0 59961.4 60556.1 61275.4 7809.5 8126.1 8140.2 8150.5 8225.4 12092.5 12722.8 12810.2 12853.5 12974.5 10244.2 11101.2 11230.9 11694.8 11713.6 10188.1 10411.3 10462.1 11158.6 11178.6 11576.2 11676.5 11759.6 11827.1 11936.0 8103.1 8155.3 8356.7 8408.7 8633.2 9340.0 11265.4 11310.8 11421.8 11766.4 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5714.84 Median:5093.29 stddev:3258.58 (64.0%) stddev-sans-first:3251.23 09:45:29 INFO - PROCESS | 1664 | Values: 1352.9 1463.0 1516.5 1612.3 1791.7 7565.3 8570.0 8850.6 8855.1 9162.6 8842.2 8945.5 8947.7 8953.4 8959.2 2330.6 2343.2 2348.2 2351.9 2353.2 2302.9 2321.0 2353.3 2355.4 2360.3 2285.2 2301.1 2303.8 2310.0 2325.8 2249.3 2255.9 2262.7 2266.8 2280.2 2264.8 2268.0 2268.5 2274.1 2276.6 8666.4 8843.1 8890.9 8897.0 8924.6 5149.7 5361.9 5363.7 5366.6 5371.1 3384.6 3432.1 3443.7 3493.3 3495.3 1058.9 1089.2 2059.1 2107.6 2119.7 12124.3 12148.3 12256.9 12310.1 12334.8 4293.4 4452.8 4566.0 4586.2 4652.9 9635.2 9648.6 9658.7 9660.0 9664.6 5148.0 5150.9 5152.6 5153.7 5164.1 4088.6 4210.2 4254.3 4367.8 4751.2 3469.2 3796.4 3802.1 3810.4 3813.6 1096.6 1118.2 1132.3 1142.7 1144.4 943.3 948.6 956.6 967.5 984.7 5669.3 5825.5 5928.3 5936.6 6091.5 435.8 447.3 447.6 448.0 458.5 3977.9 4158.9 4166.1 4166.2 4185.2 10764.3 11050.9 11120.3 11126.9 11143.2 10994.0 11040.7 11045.6 11064.9 11067.1 7744.6 8167.3 8249.0 8257.1 8272.9 5777.4 5881.8 5913.8 5929.9 6054.9 9396.5 9551.5 9858.9 9922.7 9936.4 9182.3 9612.7 9847.7 9996.6 10403.4 6818.4 7324.9 7478.5 7513.7 7707.3 8216.3 8324.0 8324.5 8390.7 8474.8 7492.4 7525.1 7558.3 7580.5 7599.2 7098.8 7168.9 7256.5 7360.6 7663.8 7045.0 7139.4 7150.4 7227.9 7233.2 4943.5 5077.0 5165.8 5182.5 5277.9 5017.1 5022.0 5078.2 5108.3 5328.2 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4501.75 Median:5111.11 stddev:1311.50 (25.7%) stddev-sans-first:1276.93 09:45:29 INFO - PROCESS | 1664 | Values: 312.6 321.6 322.8 323.2 324.5 5111.7 5261.1 5315.7 5330.4 5350.0 5039.4 5195.5 5209.9 5234.5 5280.9 4146.3 4151.3 4156.2 4181.3 4190.4 3912.8 4084.5 4187.1 4194.5 4214.8 4058.5 4064.4 4075.4 4075.9 4101.0 4053.0 4061.4 4061.6 4067.7 4091.5 3459.9 3571.8 3574.0 3587.6 3597.2 5144.4 5146.6 5149.5 5164.5 5171.1 4665.4 4710.3 4725.8 4725.9 4734.3 5472.0 5492.9 5529.9 5576.1 5581.3 3931.3 3936.8 3947.0 3958.1 3973.7 5734.8 5760.4 5808.9 5820.4 5821.2 3943.6 4000.7 4037.4 4047.1 4049.0 4068.4 4072.8 4082.3 4084.3 4092.4 4609.4 4648.7 4674.8 4699.5 4735.5 5464.2 5542.6 5575.2 5599.6 5612.5 1329.3 1357.2 1375.0 1404.7 1407.5 928.8 945.4 958.8 964.2 967.2 5299.2 5313.4 5323.3 5328.5 5330.4 5581.2 5609.3 5624.4 5627.2 5634.6 5197.7 5331.8 5332.3 5332.5 5348.7 2647.3 2662.4 2687.5 2690.3 2698.3 5137.5 5153.6 5160.8 5162.5 5187.2 4914.3 5138.3 5152.7 5175.0 5191.2 5110.5 5135.9 5150.8 5163.5 5194.6 5003.2 5013.9 5023.8 5054.2 5104.3 4710.9 4880.4 4883.3 4889.0 4915.3 5087.8 5093.3 5096.1 5099.8 5124.1 3602.0 3608.2 3638.2 3643.8 3648.9 4720.0 4940.6 4953.5 5048.5 5395.4 5384.4 5385.4 5457.9 5488.2 5541.2 5504.9 5509.9 5525.6 5530.5 5598.2 5266.2 5447.6 5480.2 5489.5 5546.4 5564.4 5594.5 5603.5 5604.9 5615.5 5447.3 5476.2 5495.3 5514.2 5522.2 09:45:29 INFO - PROCESS | 1664 | 09:45:29 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:21303.67 Median:4409.52 stddev:32043.92 (726.7%) stddev-sans-first:32096.58 09:45:29 INFO - PROCESS | 1664 | Values: 731.3 736.1 742.7 784.9 815.3 15713.2 16563.3 16569.9 16571.5 16575.3 14120.9 14128.6 14157.6 14228.1 14402.4 654.1 672.5 776.8 790.5 804.1 799.3 806.7 806.8 808.9 810.0 848.1 849.5 850.5 850.8 853.5 692.1 710.6 819.8 847.4 847.8 610.1 614.1 614.6 614.7 614.7 14797.3 14830.2 14866.3 14900.3 14948.8 14040.8 14241.3 14279.3 14360.9 14507.6 11383.6 11623.5 11732.1 12402.4 12700.9 4320.4 4391.2 4418.9 4437.2 4551.3 81484.0 82541.6 84252.0 86046.0 86567.0 10566.6 10795.6 10812.8 10902.6 11086.2 21556.2 21695.2 21756.7 21763.2 21768.7 7768.1 7841.7 7880.7 7885.6 8018.4 4333.7 4400.2 4426.2 4437.6 4518.7 3588.6 3672.0 3683.5 3709.1 3709.1 645.0 676.0 686.0 688.2 699.3 697.7 714.5 723.3 726.8 758.2 9435.8 9686.1 9867.5 9912.9 10102.3 726.1 758.8 761.8 764.1 780.1 4486.0 4643.0 4762.7 4938.5 4951.8 122416.4 123690.0 126024.0 128822.0 130082.0 110914.0 110950.0 111072.4 113999.4 114997.0 75371.6 76893.6 96669.5 97752.5 98031.5 9272.0 9616.8 9919.2 9975.3 10053.9 44466.0 48744.0 49223.8 49347.5 50397.7 53970.7 61657.7 63509.4 67132.3 68269.7 12950.4 13003.6 13004.0 13101.9 13258.3 13485.7 13752.2 14247.6 14812.9 15023.2 12751.6 13380.2 13733.4 14093.5 14197.8 11690.5 12050.8 12143.9 12631.6 12968.3 12206.6 12264.6 13312.5 13351.5 13745.9 10150.5 10484.2 11001.2 11442.3 11860.5 10704.6 10876.0 11012.1 11015.1 11105.7 09:45:29 INFO - PROCESS | 1664 | -------- Summary: end -------- 09:45:29 INFO - PROCESS | 1664 | 09:45:30 INFO - TEST-INFO | 1664: exit 0 09:45:30 INFO - TEST-OK | dromaeo_css | took 1115711ms 09:45:30 INFO - TEST-START | kraken 09:45:30 INFO - operating with platform_type : linux_ 09:45:30 INFO - Initialising browser for kraken test... 09:45:30 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08FZfT/profile http://localhost:39773/getInfo.html) 09:45:34 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 09:45:34 INFO - PROCESS | 1973 | colorDepth:24 09:45:34 INFO - PROCESS | 1973 | Browser inner width/height: 1024/697 09:45:34 INFO - PROCESS | 1973 | __metrics 09:45:34 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:45:34 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:35 INFO - PROCESS | 1973 | console.error: PushService: 09:45:35 INFO - PROCESS | 1973 | stateChangeProcessEnqueue: Error transitioning state 09:45:35 INFO - PROCESS | 1973 | UnknownError 09:45:35 INFO - TEST-INFO | 1973: exit 0 09:45:35 INFO - Browser initialized. 09:45:35 INFO - Running cycle 1/1 for kraken test... 09:45:35 INFO - TEST-INFO | started process 2057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08FZfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:47 INFO - PROCESS | 2057 | RSS: Main: 173305856 09:45:47 INFO - PROCESS | 2057 | 09:45:50 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:51 INFO - PROCESS | 2057 | RSS: Main: 231833600 09:45:51 INFO - PROCESS | 2057 | 09:45:53 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-dft) 09:45:54 INFO - PROCESS | 2057 | RSS: Main: 216989696 09:45:54 INFO - PROCESS | 2057 | 09:45:57 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-fft) 09:45:58 INFO - PROCESS | 2057 | RSS: Main: 298393600 09:45:58 INFO - PROCESS | 2057 | 09:46:00 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-oscillator) 09:46:00 INFO - PROCESS | 2057 | RSS: Main: 207826944 09:46:00 INFO - PROCESS | 2057 | 09:46:03 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:03 INFO - PROCESS | 2057 | RSS: Main: 212418560 09:46:03 INFO - PROCESS | 2057 | 09:46:06 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:07 INFO - PROCESS | 2057 | RSS: Main: 249540608 09:46:07 INFO - PROCESS | 2057 | 09:46:10 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:11 INFO - PROCESS | 2057 | RSS: Main: 248651776 09:46:11 INFO - PROCESS | 2057 | 09:46:14 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39773/tests/kraken/driver.html?testName=json-parse-financial) 09:46:14 INFO - PROCESS | 2057 | RSS: Main: 248807424 09:46:14 INFO - PROCESS | 2057 | 09:46:16 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:16 INFO - PROCESS | 2057 | RSS: Main: 210538496 09:46:16 INFO - PROCESS | 2057 | 09:46:18 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:19 INFO - PROCESS | 2057 | RSS: Main: 217640960 09:46:19 INFO - PROCESS | 2057 | 09:46:21 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:21 INFO - PROCESS | 2057 | RSS: Main: 222466048 09:46:21 INFO - PROCESS | 2057 | 09:46:24 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:24 INFO - PROCESS | 2057 | RSS: Main: 222920704 09:46:24 INFO - PROCESS | 2057 | 09:46:27 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:28 INFO - PROCESS | 2057 | RSS: Main: 221196288 09:46:28 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39773/tests/kraken/driver.html?testName=ai-astar) 09:46:30 INFO - PROCESS | 2057 | RSS: Main: 273063936 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | __start_tp_report 09:46:30 INFO - PROCESS | 2057 | _x_x_mozilla_page_load 09:46:30 INFO - PROCESS | 2057 | _x_x_mozilla_page_load_details 09:46:30 INFO - PROCESS | 2057 | |i|pagename|runs| 09:46:30 INFO - PROCESS | 2057 | |0;ai-astar;111;112;113;113;112;112;112;113;112;112 09:46:30 INFO - PROCESS | 2057 | |1;audio-beat-detection;148;118;120;163;120;119;122;120;169;121 09:46:30 INFO - PROCESS | 2057 | |2;audio-dft;159;159;162;161;162;160;160;161;160;161 09:46:30 INFO - PROCESS | 2057 | |3;audio-fft;74;75;77;109;78;77;77;76;107;76 09:46:30 INFO - PROCESS | 2057 | |4;audio-oscillator;83;82;128;83;82;82;110;83;83;123 09:46:30 INFO - PROCESS | 2057 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;116 09:46:30 INFO - PROCESS | 2057 | |6;imaging-darkroom;145;145;147;145;145;146;145;146;145;145 09:46:30 INFO - PROCESS | 2057 | |7;imaging-desaturate;94;94;95;95;95;95;94;95;95;94 09:46:30 INFO - PROCESS | 2057 | |8;json-parse-financial;53;50;50;50;51;51;53;51;51;51 09:46:30 INFO - PROCESS | 2057 | |9;json-stringify-tinderbox;60;60;60;60;62;61;60;61;60;61 09:46:30 INFO - PROCESS | 2057 | |10;stanford-crypto-aes;88;82;81;84;80;78;80;82;79;85 09:46:30 INFO - PROCESS | 2057 | |11;stanford-crypto-ccm;125;123;126;132;123;123;128;124;158;125 09:46:30 INFO - PROCESS | 2057 | |12;stanford-crypto-pbkdf2;171;164;167;168;163;166;163;162;166;167 09:46:30 INFO - PROCESS | 2057 | |13;stanford-crypto-sha256-iterative;66;64;65;64;64;66;65;65;65;65 09:46:30 INFO - PROCESS | 2057 | __end_tp_report 09:46:30 INFO - PROCESS | 2057 | __start_cc_report 09:46:30 INFO - PROCESS | 2057 | _x_x_mozilla_cycle_collect,1632 09:46:30 INFO - PROCESS | 2057 | __end_cc_report 09:46:30 INFO - PROCESS | 2057 | __startTimestamp1474649190286__endTimestamp 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | ------- Summary: start ------- 09:46:30 INFO - PROCESS | 2057 | Number of tests: 14 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 09:46:30 INFO - PROCESS | 2057 | Values: 111.0 112.0 113.0 113.0 112.0 112.0 112.0 113.0 112.0 112.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:121.50 stddev:20.01 (16.5%) stddev-sans-first:20.37 09:46:30 INFO - PROCESS | 2057 | Values: 148.0 118.0 120.0 163.0 120.0 119.0 122.0 120.0 169.0 121.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 09:46:30 INFO - PROCESS | 2057 | Values: 159.0 159.0 162.0 161.0 162.0 160.0 160.0 161.0 160.0 161.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:13.44 (17.6%) stddev-sans-first:13.89 09:46:30 INFO - PROCESS | 2057 | Values: 74.0 75.0 77.0 109.0 78.0 77.0 77.0 76.0 107.0 76.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:82.50 stddev:18.76 (22.7%) stddev-sans-first:19.48 09:46:30 INFO - PROCESS | 2057 | Values: 83.0 82.0 128.0 83.0 82.0 82.0 110.0 83.0 83.0 123.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:46:30 INFO - PROCESS | 2057 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:46:30 INFO - PROCESS | 2057 | Values: 145.0 145.0 147.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:46:30 INFO - PROCESS | 2057 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:1.10 (2.2%) stddev-sans-first:0.93 09:46:30 INFO - PROCESS | 2057 | Values: 53.0 50.0 50.0 50.0 51.0 51.0 53.0 51.0 51.0 51.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 09:46:30 INFO - PROCESS | 2057 | Values: 60.0 60.0 60.0 60.0 62.0 61.0 60.0 61.0 60.0 61.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:3.03 (3.7%) stddev-sans-first:2.28 09:46:30 INFO - PROCESS | 2057 | Values: 88.0 82.0 81.0 84.0 80.0 78.0 80.0 82.0 79.0 85.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:125.50 stddev:10.67 (8.5%) stddev-sans-first:11.23 09:46:30 INFO - PROCESS | 2057 | Values: 125.0 123.0 126.0 132.0 123.0 123.0 128.0 124.0 158.0 125.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.50 stddev:2.75 (1.7%) stddev-sans-first:2.15 09:46:30 INFO - PROCESS | 2057 | Values: 171.0 164.0 167.0 168.0 163.0 166.0 163.0 162.0 166.0 167.0 09:46:30 INFO - PROCESS | 2057 | 09:46:30 INFO - PROCESS | 2057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 09:46:30 INFO - PROCESS | 2057 | Values: 66.0 64.0 65.0 64.0 64.0 66.0 65.0 65.0 65.0 65.0 09:46:30 INFO - PROCESS | 2057 | -------- Summary: end -------- 09:46:30 INFO - PROCESS | 2057 | 09:46:31 INFO - TEST-INFO | 2057: exit 0 09:46:31 INFO - TEST-OK | kraken | took 61397ms 09:46:31 INFO - SUITE-END | took 1177s 09:46:31 INFO - Completed test suite (00:19:37) 09:46:31 INFO - javascript benchmark 09:46:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.6249218847643, 3035.5143177091654, 3041.756659467242, 3063.678313777055, 3090.845457727113, 5166.638335316529, 5231.659942103761, 5233.607479439038, 5295.841124766258, 5360.356757189133, 5232.1628539433605, 5250.107481728106, 5300.09898317287, 5309.230161626571, 5386.569074474042, 4751.786169622358, 4775.904481910377, 4811.663183577151, 4864.221724524077, 4884.951150488494, 4831.08209440207, 4865.6594038417325, 4947.77735001924, 4949.901001979958, 4963.230699241623, 4880.658353915227, 4910.459849416561, 4935.876603084934, 4964.60283177345, 5001.624878134155, 4709.105269998689, 4736.407949006374, 4760.833370832039, 4794.640401969867, 4802.759862006886, 4694.882627934295, 4705.600023997964, 4708.9875676729325, 4728.054389122155, 4769.952300476985, 5198.506141916512, 5214.426413094595, 5226.947730522684, 5239.921401178985, 5244.396894357122, 5465.07093794056, 5529.861753456155, 5556.472135147154, 5566.387697353288, 5635.098384258499, 5690.4025077367105, 5698.316202055738, 5711.828645140652, 5713.228714123582, 5766.740496677618, 5315.415304316522, 5322.680639161663, 5325.334333208349, 5325.600579956557, 5337.687397951595, 5640.266765320482, 5687.800926967537, 5747.540196784247, 5784.161296611967, 5882.735276912464, 5571.9442805571425, 5572.164175373645, 5575.52608028314, 5631.549476041989, 5639.210510528529, 5639.774409023676, 5645.774169033275, 5648.971755141198, 5651.350094739158, 5655.0, 5419.187121931742, 5524.723763811793, 5533.03171944908, 5625.606207565431, 5631.18347839561, 5547.11246200606, 5605.971970140205, 5607.467290607386, 5651.0675738503505, 5676.091825307931, 4290.957090429119, 4342.261815491374, 4344.543822898613, 4350.151720414488, 4394.670399720034, 3817.3701339279264, 3818.961810381916, 3857.556381016219, 3916.5887581804072, 3937.015746063484, 5259.526642602184, 5319.28189694394, 5323.760430780624, 5377.489138531833, 5388.2725832012175, 5654.97172514143, 5658.97170514153, 5659.518940890071, 5664.85837854057, 5667.036603777367, 5179.093658609803, 5210.218467229945, 5346.037713211582, 5346.331708536433, 5417.6478528895495, 4794.065157294364, 4800.855974320776, 4805.447373552086, 4831.4685384607665, 4897.412310522689, 5773.624714393551, 5774.48029677331, 5824.5340372770925, 5830.125481177857, 5842.2405087338375, 5580.302462192226, 5587.832365029056, 5652.236948011966, 5653.349864765604, 5658.773649053992, 5635.239242702347, 5667.773289068391, 5791.478766910998, 5816.36020037804, 5818.330891947311, 5554.472325129106, 5575.609707320448, 5592.748326325406, 5637.8590535236945, 5641.830745077655, 5661.547076233809, 5666.858328541819, 5670.574706896917, 5673.489385955284, 5681.119426488901, 5414.0, 5541.639793413416, 5547.195656629847, 5548.4174161712435, 5551.944480555143, 5419.160030195326, 5531.917021244765, 5554.861128471821, 5574.749136288958, 5625.268715067179, 5517.475839795213, 5527.0, 5531.9723401382735, 5533.114701647717, 5533.3083364579425, 5599.496045355938, 5604.551635869202, 5611.675617775401, 5614.326280846324, 5616.66300022, 5333.893322133458, 5348.679079255257, 5366.168243922199, 5372.274742909657, 5401.756920938488], "value": 5205.211206223403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8841987392582, 603.9245094363205, 617.5214208988034, 631.7283568065733, 632.9683515824207, 30934.69065309349, 42410.0, 44064.45774397901, 44074.0, 44091.0, 42784.35823462643, 43182.56817431832, 43194.784026079906, 43232.56767432325, 43343.0, 8160.673573057071, 8878.644854205824, 9017.504037277948, 9024.232940200058, 9034.14175653312, 7828.334591559696, 10603.946980265087, 10862.239643224977, 10867.619633312836, 11129.610463633775, 11033.117350611932, 11086.556537738481, 11094.1124710023, 11097.278676885977, 11102.056325212367, 8144.226298501692, 8377.581120943989, 10807.243492955497, 10902.345859248391, 10907.236493445462, 8186.304164146055, 8244.670213191464, 10283.177345812317, 10666.520006599721, 10670.786584268271, 42359.0, 42690.0, 42708.57291427077, 42728.57271427277, 42767.0, 3418.7606867519285, 3455.4644030175364, 3525.453554699026, 3644.9817750911343, 3846.344093467738, 30801.38397232065, 31816.363672726417, 32148.35703285921, 32330.83834580812, 32952.176195595064, 4100.220958017967, 4165.937510937339, 4192.308269135589, 4257.446531950826, 4267.146570685875, 322374.0, 324744.0, 324842.0, 327359.0, 327744.0, 56955.71522142363, 57171.42828571661, 57405.71297143488, 57439.71280143572, 57453.0, 59469.70265148646, 59517.40482595205, 59547.0, 59657.40342596518, 59678.0, 14499.855001450062, 14922.403103875724, 14925.25373731309, 14933.626659333386, 14936.850631493764, 11013.614523491638, 11304.660860174208, 11760.88239117615, 11828.940855295668, 11884.0, 16749.24628391725, 16830.15849207535, 16855.241514131892, 16881.32474701023, 17064.317427303016, 5762.279715035621, 5965.671888046112, 5987.880242395127, 6004.309504406961, 6119.326874043852, 938.4463166731662, 949.6533765175799, 993.2848349188573, 1041.968740937758, 1072.9141668666643, 31308.217294567818, 31978.680213198037, 32155.0, 32204.355912882078, 32782.18044548858, 1045.0646671229208, 1058.957641694339, 1063.4363787192801, 1090.6727981605486, 1151.073385924322, 15869.52391428259, 17015.574610634587, 17044.573885652957, 17144.0, 17214.397496087826, 441420.0, 443690.0, 444062.0, 444903.0, 446775.0241229532, 56820.14769778457, 57007.0, 57080.42919570834, 57135.14297285544, 57153.14270285949, 1210.6791700199453, 1238.6717519857245, 1314.7304802515462, 1315.7039666075057, 1347.6361382426885, 29299.85350073236, 32718.0, 33684.831575842945, 34054.65945340614, 34147.829260853534, 49158.26262605992, 49642.50357496523, 49768.0, 49855.75072124761, 49923.75038124786, 367243.0, 369671.0, 369832.0, 369971.0, 370904.0, 27286.317842054108, 28006.2998425041, 28085.71914280913, 29294.853525733088, 29336.55995160117, 47051.29423058726, 47543.28685069796, 47633.0, 47958.28062579134, 48386.03227935492, 39366.752514409105, 40138.0, 40267.798661006505, 40980.59019409768, 41435.585644144376, 39358.60641393549, 39725.0, 40278.798606006785, 40599.797001014806, 41730.582694173885, 40388.79805601071, 40650.18699625932, 41948.580514194466, 41977.370339445544, 42067.7896610515, 33301.33397331991, 35451.64548354483, 36799.376112300044, 36965.0, 36986.630133698316, 27372.45255094847, 27472.862635687492, 27678.16965490958, 27787.722122778512, 28044.29889252785], "value": 19731.175828533585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.86767462201675, 356.68611621772834, 368.92621475704857, 369.17305236270755, 376.6497157643391, 14309.28453577321, 18288.177032033556, 18595.5351116222, 19513.317033903815, 19677.311294104707, 15232.543023709306, 16284.918575407106, 18377.264909403606, 19054.523636909085, 19175.712364314546, 5522.66863988161, 5772.942270577303, 5773.422657734235, 5779.248697669318, 5782.24830771999, 4090.0, 4183.686223533232, 4465.866024019285, 5641.830745077655, 5732.4554167354245, 4482.843100491484, 6538.411542961133, 6548.476121910236, 6549.952007678772, 6575.835604109888, 6290.119383286366, 6480.546361754679, 6526.184226971629, 6526.934730652728, 6531.51013673974, 5664.376918538957, 5689.431056894319, 5703.40114288002, 5703.857403564903, 5704.686242256675, 22527.0, 22937.426564336027, 23011.1946081888, 23036.0, 23042.53914921709, 2211.7124773779465, 2295.127851416451, 2356.8939397727145, 2434.257551446808, 2635.8813853376646, 13788.241646709528, 14263.714725705531, 14404.855951440457, 14704.191269480281, 14871.992281042028, 1736.157963387756, 1746.4585978346754, 1857.4334827877492, 1904.2954106980367, 1990.8108729670657, 49252.50747492551, 70327.0, 80812.59593702052, 82294.0, 82595.5870220645, 9866.753331166778, 9939.254555908192, 9993.650222242186, 10143.949280253699, 10224.488775561193, 13885.097468664504, 13893.235872026933, 13903.374348154357, 13906.4437422504, 14027.71944561103, 7749.457537972288, 7924.4056695746895, 7991.043313973751, 8122.065962414398, 8205.71280005197, 7751.418643601753, 7822.8435431291055, 7917.841643167105, 8022.638981245858, 8081.838363232702, 6238.376162383725, 6340.9365906340345, 6344.841378965562, 6482.157319548429, 6577.112089867902, 1698.3036954848453, 1827.8629102817342, 1838.705807070889, 1843.1889968413855, 1851.8055604161639, 942.2697409507687, 942.820864035831, 986.3637953520083, 998.2597769123656, 1076.4510099849133, 18931.337403191097, 19393.515162120777, 19916.90041549783, 20040.098195581235, 20403.38789836307, 951.4434056077134, 977.1352353167356, 980.1374790184592, 985.9852102218473, 995.3231802374455, 10470.16238700902, 10828.133749300037, 11123.555057797597, 11630.302181869114, 11726.472308746126, 421871.0, 432430.0, 434162.0, 437037.0, 437549.0, 84886.0, 90649.54675226581, 90781.02817380166, 93344.0, 94853.26795264205, 1016.3698506925754, 1030.0677886512717, 1041.7499800048085, 1041.8801837788599, 1042.0309112525272, 17718.645627087644, 17799.110044497465, 18422.35521756732, 18422.90788546049, 18593.44219673412, 42120.78939605282, 42250.0, 42583.0, 42604.5739542613, 42909.57090429181, 58299.4170058294, 59956.0, 59961.40038599732, 60556.091658626035, 61275.38724612697, 7809.531428114331, 8126.146754590683, 8140.226678465537, 8150.470219435718, 8225.383096267684, 12092.455839487067, 12722.809157862454, 12810.167339122927, 12853.485860565472, 12974.481020759064, 10244.180465562587, 11101.167412443938, 11230.887691123311, 11694.824577631513, 11713.590024349107, 10188.134008609351, 10411.271211015157, 10462.110720588531, 11158.609448669258, 11178.608748693756, 11576.24754390962, 11676.474558645052, 11759.588414405454, 11827.112966527373, 11936.0, 8103.149169337371, 8155.266026057683, 8356.687138513074, 8408.705695300636, 8633.179847914438, 9340.0, 11265.436728163395, 11310.773784524099, 11421.828672570084, 11766.352850593299], "value": 9159.603900479085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.8511863694998, 1463.04901813821, 1516.4692357674812, 1612.3308826836862, 1791.6954117799964, 7565.281298276662, 8569.957150214248, 8850.645974161025, 8855.070217627153, 9162.633494660206, 8842.204201621853, 8945.463272203673, 8947.686830960918, 8953.373263871532, 8959.23846473049, 2330.592146374386, 2343.2267351773876, 2348.236823032513, 2351.905923763047, 2353.188150088217, 2302.9078836846506, 2321.0, 2353.2822489140804, 2355.4229213842546, 2360.280114565057, 2285.165914441234, 2301.0680674326923, 2303.8041766449874, 2309.976900230993, 2325.7790509901615, 2249.268987579035, 2255.8533695309916, 2262.7171603549555, 2266.8186545076437, 2280.1791355112146, 2264.7735226477384, 2268.0, 2268.478250002492, 2274.101729816713, 2276.5560715660454, 8666.436681615738, 8843.11568843117, 8890.86663700045, 8897.0, 8924.643014279422, 5149.665271757323, 5361.892762144775, 5363.731813409314, 5366.597505187126, 5371.086915224382, 3384.5938487381427, 3432.1248081738995, 3443.6900678938764, 3493.3188028334484, 3495.2834668892815, 1058.8517607534952, 1089.1776708585046, 2059.104289633999, 2107.599556084339, 2119.73503312086, 12124.333161676104, 12148.271103733716, 12256.938715306456, 12310.076744244217, 12334.814977775251, 4293.420388247547, 4452.821887124479, 4566.018306064212, 4586.174488592019, 4652.883677908079, 9635.22918166545, 9648.565814538362, 9658.661946831828, 9660.0, 9664.613415463444, 5147.974260128675, 5150.922736158961, 5152.639315247971, 5153.6907785532985, 5164.122099243138, 4088.5911408858874, 4210.221109094828, 4254.298040823292, 4367.803448844809, 4751.192297309466, 3469.219425629213, 3796.4495148203355, 3802.068493219179, 3810.428435734662, 3813.599572044951, 1096.6216655253925, 1118.2340097033396, 1132.3036332655358, 1142.7485953090472, 1144.416347662698, 943.3302355327794, 948.5921053946869, 956.5791051937125, 967.5307475874196, 984.699666601679, 5669.291338582677, 5825.533957283407, 5928.318243401977, 5936.604897849002, 6091.48222401092, 435.75162157569883, 447.3163498589116, 447.6441229222776, 448.0367210497391, 458.52542618390476, 3977.8607748728655, 4158.875233742932, 4166.104287578185, 4166.166766646683, 4185.183889141649, 10764.331528613078, 11050.944745276383, 11120.332780033224, 11126.888731112585, 11143.16426268017, 10994.0, 11040.723981900517, 11045.558177672803, 11064.889351106547, 11067.059299959432, 7744.612769361622, 8167.305779008732, 8249.0, 8257.05043919957, 8272.875906861402, 5777.364489906191, 5881.794137205177, 5913.822585322448, 5929.940700592939, 6054.939450605614, 9396.530173491436, 9551.474668893277, 9858.901410986085, 9922.702318930444, 9936.403815771077, 9182.265418766348, 9612.711618651452, 9847.704568862659, 9996.600135994478, 10403.427811470441, 6818.352256535622, 7324.853502930018, 7478.5138965967035, 7513.661885215069, 7707.267809558083, 8216.34269258446, 8324.042735085543, 8324.542150181556, 8390.664373424994, 8474.830503389774, 7492.400607951242, 7525.059367579052, 7558.319751222416, 7580.54516728998, 7599.240075992357, 7098.751543695946, 7168.856622867409, 7256.492045556761, 7360.595167265852, 7663.808404789925, 7045.0, 7139.428845692436, 7150.392216661642, 7227.891581626174, 7233.1681856587165, 4943.530364615356, 5076.974615126901, 5165.767540460613, 5182.455842136521, 5277.920831187458, 5017.147084995632, 5022.045811295842, 5078.238264260391, 5108.335916330853, 5328.200769884548], "value": 4523.929734461323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5733373944565, 321.60121449402743, 322.7885734843678, 323.23393557269276, 324.4613940858175, 5111.718855462948, 5261.1319132343115, 5315.68105913645, 5330.413654498002, 5350.0, 5039.4204666463365, 5195.506426889449, 5209.942072881209, 5234.476552344764, 5280.9207861882105, 4146.336586146217, 4151.294279972412, 4156.210320039198, 4181.28918083925, 4190.3923931029985, 3912.8239229234755, 4084.5098588169462, 4187.120704652027, 4194.454720886296, 4214.810333534998, 4058.533268674111, 4064.3700226464944, 4075.4294398784195, 4075.8981025474304, 4101.0, 4053.0070132817355, 4061.3704875744306, 4061.634452899253, 4067.6745860331253, 4091.488563929509, 3459.930801383958, 3571.8392672329805, 3573.9642603573893, 3587.6053634100226, 3597.190632107781, 5144.356955380577, 5146.614003949719, 5149.536541711226, 5164.457731938168, 5171.120909445366, 4665.440147182326, 4710.31700403443, 4725.810967561293, 4725.929111063337, 4734.313524538922, 5472.0, 5492.862678433031, 5529.861753456155, 5576.079946808772, 5581.274434323553, 3931.28988889831, 3936.8031598419966, 3947.0, 3958.1094253792953, 3973.701972352056, 5734.770609175628, 5760.395158508338, 5808.8838223235725, 5820.44705752957, 5821.243238379026, 3943.5662077171487, 4000.6799456043445, 4037.37420699792, 4047.1096358801015, 4048.9797551012643, 4068.389741538793, 4072.7759973201164, 4082.2856000199845, 4084.2648323301496, 4092.3656833190903, 4609.377734005933, 4648.674592778473, 4674.78455601546, 4699.483056863811, 4735.526447355237, 5464.180372944011, 5542.649020518873, 5575.247341608912, 5599.552035837123, 5612.5229355504425, 1329.2622594459974, 1357.1924704800629, 1375.0168629430007, 1404.6628809085746, 1407.5144075294006, 928.8064836684828, 945.4164274839616, 958.8034452937131, 964.2334344196381, 967.2165545907837, 5299.205119232146, 5313.44208858072, 5323.3079699639575, 5328.49379308965, 5330.360356757214, 5581.190727344512, 5609.298837645294, 5624.3813180550105, 5627.212190293362, 5634.577406694432, 5197.714125723046, 5331.760070796823, 5332.2801421808335, 5332.5467335276935, 5348.705821179872, 2647.3116989582845, 2662.4142688608476, 2687.50281197979, 2690.3005218643293, 2698.2984424049887, 5137.5376216139975, 5153.639245252872, 5160.813013007029, 5162.535371816554, 5187.198912587236, 4914.33656456381, 5138.254953031789, 5152.742362881916, 5174.974125129425, 5191.195364718475, 5110.495857030029, 5135.87160320995, 5150.755024334645, 5163.509466600667, 5194.558462530652, 5003.249512573143, 5013.924791128209, 5023.773930173078, 5054.16606259963, 5104.285400043923, 4710.882227944328, 4880.412412332396, 4883.267509873405, 4888.975555122344, 4915.336429582104, 5087.821926232564, 5093.261477085728, 5096.1336572781975, 5099.838100377641, 5124.052050370693, 3601.981990090033, 3608.1778701755447, 3638.199596088856, 3643.781373117515, 3648.872289469962, 4720.0, 4940.6038071535995, 4953.504649535018, 5048.5203905628905, 5395.3525576931015, 5384.353877534721, 5385.4076051635075, 5457.890842183214, 5488.204210389551, 5541.1991102892525, 5504.862378440571, 5509.889802204014, 5525.640833345819, 5530.529904957963, 5598.160275958476, 5266.236395722675, 5447.630280827852, 5480.205370221216, 5489.533389661764, 5546.389897111395, 5564.443555644403, 5594.468525490072, 5603.523700485504, 5604.85987850307, 5615.522680572034, 5447.264619276505, 5476.205950137288, 5495.2856128703015, 5514.228008078952, 5522.22688823557], "value": 4085.3550387188875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.2760367236435, 736.1056316575363, 742.7029188324666, 784.8665726826439, 815.3029160068144, 15713.214339283033, 16563.337466501354, 16569.917150414247, 16571.50285491437, 16575.33698652054, 14120.858791412084, 14128.646783830409, 14157.646058848533, 14228.146311221308, 14402.423903043866, 654.0548906829633, 672.5258692621715, 776.7786180938434, 790.4664351562701, 804.111456840192, 799.3006119645311, 806.733777853307, 806.8466991271669, 808.8786681997689, 810.0481933727875, 848.0925409811504, 849.5157760076759, 850.4769566716486, 850.7702920211539, 853.5476197615274, 692.0829900382014, 710.641126231255, 819.7663665855263, 847.3687103108163, 847.7795773099008, 610.1366566308668, 614.1095411653076, 614.6281499692666, 614.6680792372114, 614.7418084404561, 14797.33411996452, 14830.184339861304, 14866.331015104346, 14900.254987250593, 14948.775768363483, 14040.789388159186, 14241.287935603179, 14279.286035698173, 14360.856391436057, 14507.564773056825, 11383.601573944956, 11623.535058597647, 11732.120090993125, 12402.379881005914, 12700.872991270062, 4320.395144679747, 4391.187630288407, 4418.867433976986, 4437.245668236407, 4551.34005569194, 81484.0, 82541.58729206315, 84252.0, 86046.0, 86567.0, 10566.551679573682, 10795.56817727282, 10812.837807432894, 10902.563897444013, 11086.16853735973, 21556.245531406326, 21695.24066657691, 21756.673649895263, 21763.23828665989, 21768.673469897964, 7768.10666773317, 7841.725539606086, 7880.684772609146, 7885.605719714106, 8018.398620103516, 4333.674974376934, 4400.163968845973, 4426.22541055314, 4437.600615944581, 4518.683692141584, 3588.5693716753635, 3672.0, 3683.5211422514903, 3709.0727318170457, 3709.0912726382207, 644.9613023218621, 675.999520709353, 685.9622720750407, 688.1535711075405, 699.3076853914588, 697.7069630755095, 714.5248409807524, 723.3020135569201, 726.8110291324293, 758.2341834746835, 9435.811283774286, 9686.128248457531, 9867.506624668738, 9912.851307230398, 10102.343347682377, 726.1358982810439, 758.7647829172975, 761.7790840656147, 764.1288930619098, 780.1184661332658, 4485.955140448619, 4643.0, 4762.738049407316, 4938.530839570307, 4951.8266860659705, 122416.38791806162, 123690.0, 126024.0, 128822.0, 130082.0, 110914.0, 110950.0, 111072.44463777791, 113999.43000285112, 114997.0, 75371.62314188395, 76893.6155319231, 96669.51665241629, 97752.51123744335, 98031.50984245034, 9272.0, 9616.75958101053, 9919.15687166599, 9975.301728878909, 10053.899461005296, 44466.0, 48744.0, 49223.75388123036, 49347.50652493573, 50397.74801125971, 53970.73014635059, 61657.691711541156, 63509.364906352195, 67132.32867671261, 68269.65865170643, 12950.417231224428, 13003.609891703263, 13004.0, 13101.868981310065, 13258.270795106362, 13485.662858428617, 13752.243626600633, 14247.572572822832, 14812.925935370255, 15023.173725444769, 12751.61745147647, 13380.19718816874, 13733.381997809922, 14093.506727264497, 14197.787033194303, 11690.47392867306, 12050.819237711617, 12143.878561214628, 12631.557895473614, 12968.286744229157, 12206.572769953364, 12264.570740024414, 13312.534061307808, 13351.465941362625, 13745.931270343584, 10150.492475376053, 10484.161267098767, 11001.17491188148, 11442.313461192354, 11860.466279017292, 10704.571817127227, 10876.0, 11012.119030477703, 11015.118790496901, 11105.722356941142], "value": 7545.985732931856, "unit": "score"}], "name": "dromaeo_css", "value": 7128.4668663150405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 120.0, 163.0, 120.0, 119.0, 122.0, 120.0, 169.0, 121.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 162.0, 161.0, 162.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 109.0, 78.0, 77.0, 77.0, 76.0, 107.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 83.0, 82.0, 82.0, 110.0, 83.0, 83.0, 123.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 50.0, 51.0, 51.0, 53.0, 51.0, 51.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 62.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 81.0, 84.0, 80.0, 78.0, 80.0, 82.0, 79.0, 85.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 126.0, 132.0, 123.0, 123.0, 128.0, 124.0, 158.0, 125.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 167.0, 168.0, 163.0, 166.0, 163.0, 162.0, 166.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1491.0000000000002, "alertThreshold": 2.0}]} 09:46:31 INFO - Return code: 0 09:46:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:46:31 INFO - # TBPL SUCCESS # 09:46:31 INFO - Running post-action listener: _resource_record_post_action 09:46:31 INFO - [mozharness: 2016-09-23 16:46:31.604175Z] Finished run-tests step (success) 09:46:31 INFO - Running post-run listener: _resource_record_post_run 09:46:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403496960; Read time: 12; Write time: 233348 09:46:31 INFO - TinderboxPrint: CPU usage
13.1% 09:46:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:46:31 INFO - TinderboxPrint: I/O write bytes / time
403,496,960 / 233,348 09:46:31 INFO - TinderboxPrint: CPU idle
8,282.3 (86.9%) 09:46:31 INFO - TinderboxPrint: CPU user
1,194.5 (12.5%) 09:46:31 INFO - TinderboxPrint: Swap in / out
0 / 0 09:46:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114429952; Read time: 0; Write time: 57336 09:46:31 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287780864; Read time: 0; Write time: 175928 09:46:32 INFO - Running post-run listener: _upload_blobber_files 09:46:32 INFO - Blob upload gear active. 09:46:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:46:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:46:32 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:46:32 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:46:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:46:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:40 INFO - (blobuploader) - INFO - Done attempting. 09:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:46:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:41 INFO - (blobuploader) - INFO - Done attempting. 09:46:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:46:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:46:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:42 INFO - (blobuploader) - INFO - Done attempting. 09:46:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:46:42 INFO - Return code: 0 09:46:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:46:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:46:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894def8798f20a400764f4e1166be487298d42a8be2e6c638bddff42d1ff1e046856d82ca5f665ae4d9bf261970dcc4ec0787a4c8876526b1b2bfaab07342ef0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01a965449c496ebef3b7708c6f985618c3b734f4495eb7d7eeb97ee568e4012c8c7a78f3ff26e7ff0f1e6e9b4263d840d8f810fd66cf6fae947dc6ea389b4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163529acec7ca2408f8bce73ca9ed912dd101cc13d5a01a0b65d9ba79144f1a7b7dfeb9adb9ea44f2b5a29344161530304edd150ef820a4683783e4e5c061e71"} 09:46:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:46:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:46:42 INFO - Contents: 09:46:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894def8798f20a400764f4e1166be487298d42a8be2e6c638bddff42d1ff1e046856d82ca5f665ae4d9bf261970dcc4ec0787a4c8876526b1b2bfaab07342ef0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01a965449c496ebef3b7708c6f985618c3b734f4495eb7d7eeb97ee568e4012c8c7a78f3ff26e7ff0f1e6e9b4263d840d8f810fd66cf6fae947dc6ea389b4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163529acec7ca2408f8bce73ca9ed912dd101cc13d5a01a0b65d9ba79144f1a7b7dfeb9adb9ea44f2b5a29344161530304edd150ef820a4683783e4e5c061e71"} 09:46:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:46:42 INFO - Copying logs to upload dir... 09:46:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:46:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.759812 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-23 09:46:42.215750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:46:42.221201) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894def8798f20a400764f4e1166be487298d42a8be2e6c638bddff42d1ff1e046856d82ca5f665ae4d9bf261970dcc4ec0787a4c8876526b1b2bfaab07342ef0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01a965449c496ebef3b7708c6f985618c3b734f4495eb7d7eeb97ee568e4012c8c7a78f3ff26e7ff0f1e6e9b4263d840d8f810fd66cf6fae947dc6ea389b4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163529acec7ca2408f8bce73ca9ed912dd101cc13d5a01a0b65d9ba79144f1a7b7dfeb9adb9ea44f2b5a29344161530304edd150ef820a4683783e4e5c061e71"} build_url:https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/ZOy3sss3TuGfCMZYPoirIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894def8798f20a400764f4e1166be487298d42a8be2e6c638bddff42d1ff1e046856d82ca5f665ae4d9bf261970dcc4ec0787a4c8876526b1b2bfaab07342ef0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01a965449c496ebef3b7708c6f985618c3b734f4495eb7d7eeb97ee568e4012c8c7a78f3ff26e7ff0f1e6e9b4263d840d8f810fd66cf6fae947dc6ea389b4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/163529acec7ca2408f8bce73ca9ed912dd101cc13d5a01a0b65d9ba79144f1a7b7dfeb9adb9ea44f2b5a29344161530304edd150ef820a4683783e4e5c061e71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:46:42.247457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:46:42.247918) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1474647903.773019-1244116450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:46:42.333058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:46:42.333819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:46:42.334477) ========= ========= Total master_lag: 0.33 =========