builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1475123696.5 results: success (0) buildid: 20160928183006 builduid: d476dbbd49824f57984e3b3e4db36f99 revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.496513) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.497473) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.498096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.515619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.516329) ========= 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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 21:34:56-- 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% 103M=0s 2016-09-28 21:34:56 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.648021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.648402) ========= 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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:56.698523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 21:34:56.698899) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 182fd3e63603ca64d166a08c86a3347af1ff7385 --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 182fd3e63603ca64d166a08c86a3347af1ff7385 --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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 21:34:56,839 truncating revision to first 12 chars 2016-09-28 21:34:56,839 Setting DEBUG logging. 2016-09-28 21:34:56,840 attempt 1/10 2016-09-28 21:34:56,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/182fd3e63603?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 21:34:58,283 unpacking tar archive at: fx-team-182fd3e63603/testing/mozharness/ program finished with exit code 0 elapsedTime=1.795928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 21:34:58.508133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:58.508448) ========= script_repo_revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:58.508847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:58.509109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:34:58.518230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-28 21:34:58.518495) ========= /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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:58 INFO - MultiFileLogger online at 20160928 21:34:58 in /builds/slave/test 21:34:58 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 21:34:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:58 INFO - {'append_to_log': False, 21:34:58 INFO - 'base_work_dir': '/builds/slave/test', 21:34:58 INFO - 'blob_upload_branch': 'Fx-Team', 21:34:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:58 INFO - 'branch': 'Fx-Team', 21:34:58 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:58 INFO - 'config_files': ('talos/linux_config.py',), 21:34:58 INFO - 'default_actions': ('clobber', 21:34:58 INFO - 'read-buildbot-config', 21:34:58 INFO - 'download-and-extract', 21:34:58 INFO - 'populate-webroot', 21:34:58 INFO - 'create-virtualenv', 21:34:58 INFO - 'install', 21:34:58 INFO - 'run-tests'), 21:34:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:58 INFO - 'download_minidump_stackwalk': True, 21:34:58 INFO - 'download_symbols': 'ondemand', 21:34:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:58 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:58 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:58 INFO - 'installer_path': 'installer.exe', 21:34:58 INFO - 'log_level': 'info', 21:34:58 INFO - 'log_name': 'talos', 21:34:58 INFO - 'log_to_console': True, 21:34:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:58 INFO - 'opt_config_files': (), 21:34:58 INFO - 'pip_index': False, 21:34:58 INFO - 'sps_profile': False, 21:34:58 INFO - 'sps_profile_interval': 0, 21:34:58 INFO - 'suite': 'dromaeojs', 21:34:58 INFO - 'system_bits': '32', 21:34:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:58 INFO - 'title': 'talos-linux64-ix-048', 21:34:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:58 INFO - 'use_talos_json': True, 21:34:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:58 INFO - 'work_dir': 'build'} 21:34:58 INFO - [mozharness: 2016-09-29 04:34:58.754978Z] Running clobber step. 21:34:58 INFO - Running pre-action listener: _resource_record_pre_action 21:34:58 INFO - Running main action method: clobber 21:34:58 INFO - rmtree: /builds/slave/test/build 21:34:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:59 INFO - Running post-action listener: _resource_record_post_action 21:34:59 INFO - [mozharness: 2016-09-29 04:34:59.207578Z] Finished clobber step (success) 21:34:59 INFO - [mozharness: 2016-09-29 04:34:59.207681Z] Running read-buildbot-config step. 21:34:59 INFO - Running pre-action listener: _resource_record_pre_action 21:34:59 INFO - Running main action method: read_buildbot_config 21:34:59 INFO - Using buildbot properties: 21:34:59 INFO - { 21:34:59 INFO - "project": "", 21:34:59 INFO - "product": "firefox", 21:34:59 INFO - "script_repo_revision": "production", 21:34:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:34:59 INFO - "repository": "", 21:34:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:34:59 INFO - "buildid": "20160928183006", 21:34:59 INFO - "pgo_build": "True", 21:34:59 INFO - "basedir": "/builds/slave/test", 21:34:59 INFO - "buildnumber": 1604, 21:34:59 INFO - "slavename": "talos-linux64-ix-048", 21:34:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:34:59 INFO - "platform": "ubuntu64_hw", 21:34:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:34:59 INFO - "branch": "fx-team", 21:34:59 INFO - "repo_path": "integration/fx-team", 21:34:59 INFO - "revision": "182fd3e63603ca64d166a08c86a3347af1ff7385", 21:34:59 INFO - "stage_platform": "linux64-pgo", 21:34:59 INFO - "builduid": "d476dbbd49824f57984e3b3e4db36f99", 21:34:59 INFO - "slavebuilddir": "test" 21:34:59 INFO - } 21:34:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:34:59 INFO - Running post-action listener: _resource_record_post_action 21:34:59 INFO - [mozharness: 2016-09-29 04:34:59.210100Z] Finished read-buildbot-config step (success) 21:34:59 INFO - [mozharness: 2016-09-29 04:34:59.210188Z] Running download-and-extract step. 21:34:59 INFO - Running pre-action listener: _resource_record_pre_action 21:34:59 INFO - Running main action method: download_and_extract 21:34:59 INFO - mkdir: /builds/slave/test/build/tests 21:34:59 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')]} 21:34:59 INFO - trying https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:34:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/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 21:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/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 21:34:59 INFO - Downloaded 1361 bytes. 21:34:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:34:59 INFO - Using the following test package requirements: 21:34:59 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:34:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'jsshell-linux-x86_64.zip'], 21:34:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:34:59 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:34:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:34:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:59 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:35:00 INFO - Expected file size: 21987076 21:35:00 INFO - Content-Encoding None 21:35:00 INFO - Content-Type application/zip 21:35:00 INFO - Http code 200 21:35:04 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 21:35:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:35:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:35:04 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:35:05 INFO - Expected file size: 21987076 21:35:05 INFO - Content-Encoding None 21:35:05 INFO - Content-Type application/zip 21:35:05 INFO - Http code 200 21:35:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:35:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:35:09 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:35:10 INFO - Expected file size: 14414067 21:35:10 INFO - Content-Encoding None 21:35:10 INFO - Content-Type application/zip 21:35:10 INFO - Http code 200 21:35:10 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')]} 21:35:10 INFO - trying https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:35:10 INFO - Downloading https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/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 21:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/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 21:35:12 INFO - Downloaded 59727918 bytes. 21:35:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:35:12 INFO - mkdir: /builds/slave/test/properties 21:35:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:12 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:12 INFO - Contents: 21:35:12 INFO - build_url:https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:35:12 INFO - Running post-action listener: _resource_record_post_action 21:35:12 INFO - Running post-action listener: set_extra_try_arguments 21:35:12 INFO - [mozharness: 2016-09-29 04:35:12.731686Z] Finished download-and-extract step (success) 21:35:12 INFO - [mozharness: 2016-09-29 04:35:12.731913Z] Running populate-webroot step. 21:35:12 INFO - Running pre-action listener: _resource_record_pre_action 21:35:12 INFO - Running main action method: populate_webroot 21:35:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:35:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:35:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:35:12 INFO - '--tppagecycles', 21:35:12 INFO - '7'], 21:35:12 INFO - 'tests': ['tsvgm']}}, 21:35:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:35:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:35:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['damp', 'tps']}, 21:35:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'tests': ['damp', 'tps']}, 21:35:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['dromaeo_dom']}, 21:35:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['basic_compositor_video']}, 21:35:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:35:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['a11yr', 21:35:12 INFO - 'ts_paint', 21:35:12 INFO - 'tpaint', 21:35:12 INFO - 'sessionrestore', 21:35:12 INFO - 'sessionrestore_no_auto_restore', 21:35:12 INFO - 'tabpaint']}, 21:35:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['tsvgx', 21:35:12 INFO - 'tsvgr_opacity', 21:35:12 INFO - 'tart', 21:35:12 INFO - 'tscrollx', 21:35:12 INFO - 'cart']}, 21:35:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:12 INFO - 'tsvgr_opacity', 21:35:12 INFO - 'tart', 21:35:12 INFO - 'tscrollx', 21:35:12 INFO - 'cart']}, 21:35:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'talos_options': ['--disable-e10s'], 21:35:12 INFO - 'tests': ['tp5o']}, 21:35:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'tests': ['tp5o']}, 21:35:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'talos_options': ['--disable-e10s', 21:35:12 INFO - '--xperf_path', 21:35:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:12 INFO - 'tests': ['tp5n']}, 21:35:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:12 INFO - 'talos_options': ['--xperf_path', 21:35:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:12 INFO - 'tests': ['tp5n']}}, 21:35:12 INFO - 'talos.zip': {'path': '', 21:35:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:35:12 INFO - Running post-action listener: _resource_record_post_action 21:35:12 INFO - [mozharness: 2016-09-29 04:35:12.752502Z] Finished populate-webroot step (success) 21:35:12 INFO - [mozharness: 2016-09-29 04:35:12.752589Z] Running create-virtualenv step. 21:35:12 INFO - Running pre-action listener: _resource_record_pre_action 21:35:12 INFO - Running main action method: create_virtualenv 21:35:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:12 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 21:35:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:35:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:12 INFO - Using real prefix '/usr' 21:35:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:13 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:15 INFO - Installing pip.................done. 21:35:15 INFO - Return code: 0 21:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:15 INFO - Reading from file tmpfile_stdout 21:35:15 INFO - Output received: 21:35:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:15 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 21:35:15 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 21:35:15 INFO - Using env: {'DISPLAY': ':0', 21:35:15 INFO - 'HOME': '/home/cltbld', 21:35:15 INFO - 'LANG': 'en_US.UTF-8', 21:35:15 INFO - 'LANGUAGE': 'en_US:en', 21:35:15 INFO - 'LOGNAME': 'cltbld', 21:35:15 INFO - 'MAIL': '/var/mail/cltbld', 21:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:15 INFO - 'MOZ_NO_REMOTE': '1', 21:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:15 INFO - 'NO_EM_RESTART': '1', 21:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:15 INFO - 'PWD': '/builds/slave/test', 21:35:15 INFO - 'SHELL': '/bin/bash', 21:35:15 INFO - 'SHLVL': '1', 21:35:15 INFO - 'TERM': 'linux', 21:35:15 INFO - 'TMOUT': '86400', 21:35:15 INFO - 'USER': 'cltbld', 21:35:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:15 INFO - '_': '/tools/buildbot/bin/python'} 21:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:15 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 21:35:15 INFO - Cleaning up... 21:35:15 INFO - Return code: 0 21:35:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:15 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 21:35:15 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 21:35:15 INFO - Using env: {'DISPLAY': ':0', 21:35:15 INFO - 'HOME': '/home/cltbld', 21:35:15 INFO - 'LANG': 'en_US.UTF-8', 21:35:15 INFO - 'LANGUAGE': 'en_US:en', 21:35:15 INFO - 'LOGNAME': 'cltbld', 21:35:15 INFO - 'MAIL': '/var/mail/cltbld', 21:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:15 INFO - 'MOZ_NO_REMOTE': '1', 21:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:15 INFO - 'NO_EM_RESTART': '1', 21:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:15 INFO - 'PWD': '/builds/slave/test', 21:35:15 INFO - 'SHELL': '/bin/bash', 21:35:15 INFO - 'SHLVL': '1', 21:35:15 INFO - 'TERM': 'linux', 21:35:15 INFO - 'TMOUT': '86400', 21:35:15 INFO - 'USER': 'cltbld', 21:35:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:15 INFO - '_': '/tools/buildbot/bin/python'} 21:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:15 INFO - Downloading/unpacking psutil>=3.1.1 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:18 INFO - Installing collected packages: psutil 21:35:18 INFO - Running setup.py install for psutil 21:35:18 INFO - building 'psutil._psutil_linux' extension 21:35:18 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 21:35:18 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 21:35:18 INFO - building 'psutil._psutil_posix' extension 21:35:18 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 21:35:18 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 21:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:18 INFO - Successfully installed psutil 21:35:18 INFO - Cleaning up... 21:35:18 INFO - Return code: 0 21:35:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:18 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:18 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 21:35:18 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 21:35:18 INFO - Using env: {'DISPLAY': ':0', 21:35:18 INFO - 'HOME': '/home/cltbld', 21:35:18 INFO - 'LANG': 'en_US.UTF-8', 21:35:18 INFO - 'LANGUAGE': 'en_US:en', 21:35:18 INFO - 'LOGNAME': 'cltbld', 21:35:18 INFO - 'MAIL': '/var/mail/cltbld', 21:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:18 INFO - 'MOZ_NO_REMOTE': '1', 21:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:18 INFO - 'NO_EM_RESTART': '1', 21:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:18 INFO - 'PWD': '/builds/slave/test', 21:35:18 INFO - 'SHELL': '/bin/bash', 21:35:18 INFO - 'SHLVL': '1', 21:35:18 INFO - 'TERM': 'linux', 21:35:18 INFO - 'TMOUT': '86400', 21:35:18 INFO - 'USER': 'cltbld', 21:35:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:18 INFO - '_': '/tools/buildbot/bin/python'} 21:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:20 INFO - Installing collected packages: mozsystemmonitor 21:35:20 INFO - Running setup.py install for mozsystemmonitor 21:35:20 INFO - Successfully installed mozsystemmonitor 21:35:20 INFO - Cleaning up... 21:35:20 INFO - Return code: 0 21:35:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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', '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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35: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 jsonschema==2.5.1 21:35:20 INFO - Using env: {'DISPLAY': ':0', 21:35:20 INFO - 'HOME': '/home/cltbld', 21:35:20 INFO - 'LANG': 'en_US.UTF-8', 21:35:20 INFO - 'LANGUAGE': 'en_US:en', 21:35:20 INFO - 'LOGNAME': 'cltbld', 21:35:20 INFO - 'MAIL': '/var/mail/cltbld', 21:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:20 INFO - 'MOZ_NO_REMOTE': '1', 21:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:20 INFO - 'NO_EM_RESTART': '1', 21:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:20 INFO - 'PWD': '/builds/slave/test', 21:35:20 INFO - 'SHELL': '/bin/bash', 21:35:20 INFO - 'SHLVL': '1', 21:35:20 INFO - 'TERM': 'linux', 21:35:20 INFO - 'TMOUT': '86400', 21:35:20 INFO - 'USER': 'cltbld', 21:35:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:20 INFO - '_': '/tools/buildbot/bin/python'} 21:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:22 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 21:35:22 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 21:35:22 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 21:35:22 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 21:35:22 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 21:35:22 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 21:35:23 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:23 INFO - warning: no files found matching '*.txt' 21:35:23 INFO - no previously-included directories found matching 'build' 21:35:23 INFO - no previously-included directories found matching 'dist' 21:35:23 INFO - no previously-included directories found matching '.git*' 21:35:23 INFO - Installing collected packages: jsonschema, functools32 21:35:23 INFO - Running setup.py install for functools32 21:35:23 INFO - warning: no files found matching '*.txt' 21:35:23 INFO - no previously-included directories found matching 'build' 21:35:23 INFO - no previously-included directories found matching 'dist' 21:35:23 INFO - no previously-included directories found matching '.git*' 21:35:23 INFO - Successfully installed jsonschema functools32 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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', '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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:35: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 functools32==3.2.3-2 21:35:23 INFO - Using env: {'DISPLAY': ':0', 21:35:23 INFO - 'HOME': '/home/cltbld', 21:35:23 INFO - 'LANG': 'en_US.UTF-8', 21:35:23 INFO - 'LANGUAGE': 'en_US:en', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MAIL': '/var/mail/cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SHLVL': '1', 21:35:23 INFO - 'TERM': 'linux', 21:35:23 INFO - 'TMOUT': '86400', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - '_': '/tools/buildbot/bin/python'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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', '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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:35: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 blobuploader==1.2.4 21:35:23 INFO - Using env: {'DISPLAY': ':0', 21:35:23 INFO - 'HOME': '/home/cltbld', 21:35:23 INFO - 'LANG': 'en_US.UTF-8', 21:35:23 INFO - 'LANGUAGE': 'en_US:en', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MAIL': '/var/mail/cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SHLVL': '1', 21:35:23 INFO - 'TERM': 'linux', 21:35:23 INFO - 'TMOUT': '86400', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - '_': '/tools/buildbot/bin/python'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35: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 21:35:26 INFO - Downloading docopt-0.6.1.tar.gz 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:26 INFO - Running setup.py install for blobuploader 21:35:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:26 INFO - Running setup.py install for requests 21:35:27 INFO - Running setup.py install for docopt 21:35:27 INFO - Successfully installed blobuploader requests docopt 21:35:27 INFO - Cleaning up... 21:35:27 INFO - Return code: 0 21:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:27 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:27 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 21:35:27 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 21:35:27 INFO - Using env: {'DISPLAY': ':0', 21:35:27 INFO - 'HOME': '/home/cltbld', 21:35:27 INFO - 'LANG': 'en_US.UTF-8', 21:35:27 INFO - 'LANGUAGE': 'en_US:en', 21:35:27 INFO - 'LOGNAME': 'cltbld', 21:35:27 INFO - 'MAIL': '/var/mail/cltbld', 21:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:27 INFO - 'MOZ_NO_REMOTE': '1', 21:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:27 INFO - 'NO_EM_RESTART': '1', 21:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:27 INFO - 'PWD': '/builds/slave/test', 21:35:27 INFO - 'SHELL': '/bin/bash', 21:35:27 INFO - 'SHLVL': '1', 21:35:27 INFO - 'TERM': 'linux', 21:35:27 INFO - 'TMOUT': '86400', 21:35:27 INFO - 'USER': 'cltbld', 21:35:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:27 INFO - '_': '/tools/buildbot/bin/python'} 21:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Running setup.py (path:/tmp/pip-zrUFDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Running setup.py (path:/tmp/pip-r2h4r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Running setup.py (path:/tmp/pip-hM5L8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:27 INFO - Running setup.py (path:/tmp/pip-3qRQ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:27 INFO - Running setup.py (path:/tmp/pip-AzA9LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:27 INFO - Running setup.py (path:/tmp/pip-rAnwas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:27 INFO - Running setup.py (path:/tmp/pip-gqXVEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:27 INFO - Running setup.py (path:/tmp/pip-edGmE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:28 INFO - Running setup.py (path:/tmp/pip-rh6y0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:28 INFO - Running setup.py (path:/tmp/pip-XDRfG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:28 INFO - Running setup.py (path:/tmp/pip-JGyiR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:28 INFO - Running setup.py (path:/tmp/pip-vnbBfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:28 INFO - Running setup.py (path:/tmp/pip-UHJXb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:28 INFO - Running setup.py (path:/tmp/pip-Z275VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Running setup.py (path:/tmp/pip-5rDbhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Running setup.py (path:/tmp/pip-jtGPO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Running setup.py (path:/tmp/pip-tZ19FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:28 INFO - Running setup.py install for manifestparser 21:35:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozcrash 21:35:28 INFO - Running setup.py install for mozdebug 21:35:28 INFO - Running setup.py install for mozdevice 21:35:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozfile 21:35:29 INFO - Running setup.py install for mozhttpd 21:35:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozinfo 21:35:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozInstall 21:35:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozleak 21:35:29 INFO - Running setup.py install for mozlog 21:35:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for moznetwork 21:35:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozprocess 21:35:29 INFO - Running setup.py install for mozprofile 21:35:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Running setup.py install for mozrunner 21:35:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Running setup.py install for mozscreenshot 21:35:30 INFO - Running setup.py install for moztest 21:35:30 INFO - Running setup.py install for mozversion 21:35:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:30 INFO - Cleaning up... 21:35:30 INFO - Return code: 0 21:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:30 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:30 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 21:35:30 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 21:35:30 INFO - Using env: {'DISPLAY': ':0', 21:35:30 INFO - 'HOME': '/home/cltbld', 21:35:30 INFO - 'LANG': 'en_US.UTF-8', 21:35:30 INFO - 'LANGUAGE': 'en_US:en', 21:35:30 INFO - 'LOGNAME': 'cltbld', 21:35:30 INFO - 'MAIL': '/var/mail/cltbld', 21:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:30 INFO - 'MOZ_NO_REMOTE': '1', 21:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:30 INFO - 'NO_EM_RESTART': '1', 21:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:30 INFO - 'PWD': '/builds/slave/test', 21:35:30 INFO - 'SHELL': '/bin/bash', 21:35:30 INFO - 'SHLVL': '1', 21:35:30 INFO - 'TERM': 'linux', 21:35:30 INFO - 'TMOUT': '86400', 21:35:30 INFO - 'USER': 'cltbld', 21:35:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:30 INFO - '_': '/tools/buildbot/bin/python'} 21:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:30 INFO - Running setup.py (path:/tmp/pip-CGYaun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:30 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)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:30 INFO - Running setup.py (path:/tmp/pip-BGZ3vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:30 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)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:30 INFO - Running setup.py (path:/tmp/pip-vrBk7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:30 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)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:30 INFO - Running setup.py (path:/tmp/pip-um5FPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:30 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)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:30 INFO - Running setup.py (path:/tmp/pip-Sl_2Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:31 INFO - Running setup.py (path:/tmp/pip-xT3Bxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:31 INFO - Running setup.py (path:/tmp/pip-e16prq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:31 INFO - Running setup.py (path:/tmp/pip-UNmIGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:31 INFO - Running setup.py (path:/tmp/pip-IGY0HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:31 INFO - Running setup.py (path:/tmp/pip-L3aZzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:31 INFO - Running setup.py (path:/tmp/pip-aNqpl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:31 INFO - Running setup.py (path:/tmp/pip-r6R2dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 INFO - Running setup.py (path:/tmp/pip-_B30HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 INFO - Running setup.py (path:/tmp/pip-0uZt63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:31 INFO - Running setup.py (path:/tmp/pip-vio9rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:31 INFO - Running setup.py (path:/tmp/pip-qkmSt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:31 INFO - Running setup.py (path:/tmp/pip-X_um7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:31 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)) 21:35:31 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)) 21:35:31 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)) 21:35:31 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)) 21:35:31 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)) 21:35:31 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)) 21:35:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:33 INFO - Downloading blessings-1.6.tar.gz 21:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:33 INFO - Installing collected packages: blessings 21:35:33 INFO - Running setup.py install for blessings 21:35:34 INFO - Successfully installed blessings 21:35:34 INFO - Cleaning up... 21:35:34 INFO - Return code: 0 21:35:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:34 INFO - Reading from file tmpfile_stdout 21:35:34 INFO - Current package versions: 21:35:34 INFO - argparse == 1.2.1 21:35:34 INFO - blessings == 1.6 21:35:34 INFO - blobuploader == 1.2.4 21:35:34 INFO - docopt == 0.6.1 21:35:34 INFO - functools32 == 3.2.3-2 21:35:34 INFO - jsonschema == 2.5.1 21:35:34 INFO - manifestparser == 1.1 21:35:34 INFO - mozInstall == 1.12 21:35:34 INFO - mozcrash == 0.17 21:35:34 INFO - mozdebug == 0.1 21:35:34 INFO - mozdevice == 0.48 21:35:34 INFO - mozfile == 1.2 21:35:34 INFO - mozhttpd == 0.7 21:35:34 INFO - mozinfo == 0.9 21:35:34 INFO - mozleak == 0.1 21:35:34 INFO - mozlog == 3.4 21:35:34 INFO - moznetwork == 0.27 21:35:34 INFO - mozprocess == 0.23 21:35:34 INFO - mozprofile == 0.28 21:35:34 INFO - mozrunner == 6.12 21:35:34 INFO - mozscreenshot == 0.1 21:35:34 INFO - mozsystemmonitor == 0.3 21:35:34 INFO - moztest == 0.7 21:35:34 INFO - mozversion == 1.4 21:35:34 INFO - psutil == 3.1.1 21:35:34 INFO - requests == 1.2.3 21:35:34 INFO - wsgiref == 0.1.2 21:35:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:34 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 21:35:34 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 21:35:34 INFO - Using env: {'DISPLAY': ':0', 21:35:34 INFO - 'HOME': '/home/cltbld', 21:35:34 INFO - 'LANG': 'en_US.UTF-8', 21:35:34 INFO - 'LANGUAGE': 'en_US:en', 21:35:34 INFO - 'LOGNAME': 'cltbld', 21:35:34 INFO - 'MAIL': '/var/mail/cltbld', 21:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:34 INFO - 'MOZ_NO_REMOTE': '1', 21:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:34 INFO - 'NO_EM_RESTART': '1', 21:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:34 INFO - 'PWD': '/builds/slave/test', 21:35:34 INFO - 'SHELL': '/bin/bash', 21:35:34 INFO - 'SHLVL': '1', 21:35:34 INFO - 'TERM': 'linux', 21:35:34 INFO - 'TMOUT': '86400', 21:35:34 INFO - 'USER': 'cltbld', 21:35:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:34 INFO - '_': '/tools/buildbot/bin/python'} 21:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 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)) 21:35:34 INFO - Cleaning up... 21:35:34 INFO - Return code: 0 21:35:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 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 0x7f911d6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', '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 21:35:34 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 21:35:34 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 21:35:34 INFO - Using env: {'DISPLAY': ':0', 21:35:34 INFO - 'HOME': '/home/cltbld', 21:35:34 INFO - 'LANG': 'en_US.UTF-8', 21:35:34 INFO - 'LANGUAGE': 'en_US:en', 21:35:34 INFO - 'LOGNAME': 'cltbld', 21:35:34 INFO - 'MAIL': '/var/mail/cltbld', 21:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:34 INFO - 'MOZ_NO_REMOTE': '1', 21:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:34 INFO - 'NO_EM_RESTART': '1', 21:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:34 INFO - 'PWD': '/builds/slave/test', 21:35:34 INFO - 'SHELL': '/bin/bash', 21:35:34 INFO - 'SHLVL': '1', 21:35:34 INFO - 'TERM': 'linux', 21:35:34 INFO - 'TMOUT': '86400', 21:35:34 INFO - 'USER': 'cltbld', 21:35:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:34 INFO - '_': '/tools/buildbot/bin/python'} 21:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:34 INFO - Cleaning up... 21:35:34 INFO - Return code: 0 21:35:34 INFO - Running post-action listener: _resource_record_post_action 21:35:34 INFO - Running post-action listener: _start_resource_monitoring 21:35:34 INFO - Starting resource monitoring. 21:35:34 INFO - [mozharness: 2016-09-29 04:35:34.779221Z] Finished create-virtualenv step (success) 21:35:34 INFO - [mozharness: 2016-09-29 04:35:34.779762Z] Running install step. 21:35:34 INFO - Running pre-action listener: _resource_record_pre_action 21:35:34 INFO - Running main action method: install 21:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:34 INFO - Reading from file tmpfile_stdout 21:35:34 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:35 INFO - Reading from file tmpfile_stdout 21:35:35 INFO - Output received: 21:35:35 INFO - Usage: mozinstall [options] installer 21:35:35 INFO - Options: 21:35:35 INFO - -h, --help show this help message and exit 21:35:35 INFO - -d DEST, --destination=DEST 21:35:35 INFO - Directory to install application into. [default: 21:35:35 INFO - "/builds/slave/test"] 21:35:35 INFO - --app=APP Application being installed. [default: firefox] 21:35:35 INFO - mkdir: /builds/slave/test/build/application 21:35:35 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'] 21:35:35 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 21:35:52 INFO - Reading from file tmpfile_stdout 21:35:52 INFO - Output received: 21:35:52 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:52 INFO - Running post-action listener: _resource_record_post_action 21:35:52 INFO - [mozharness: 2016-09-29 04:35:52.372766Z] Finished install step (success) 21:35:52 INFO - [mozharness: 2016-09-29 04:35:52.373011Z] Running run-tests step. 21:35:52 INFO - Running pre-action listener: _resource_record_pre_action 21:35:52 INFO - Running main action method: run_tests 21:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:52 INFO - Python 2.7.3 21:35:52 INFO - Return code: 0 21:35:52 INFO - grabbing minidump binary from tooltool 21:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:52 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 0x205f930>, '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 0x2060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2060cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:52 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 21:35:52 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 21:35:52 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 21:35:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:52 INFO - Return code: 0 21:35:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:52 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:35:52 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 21:35:52 INFO - Using env: {'DISPLAY': ':0', 21:35:52 INFO - 'HOME': '/home/cltbld', 21:35:52 INFO - 'LANG': 'en_US.UTF-8', 21:35:52 INFO - 'LANGUAGE': 'en_US:en', 21:35:52 INFO - 'LOGNAME': 'cltbld', 21:35:52 INFO - 'MAIL': '/var/mail/cltbld', 21:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:52 INFO - 'MOZ_NO_REMOTE': '1', 21:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:52 INFO - 'NO_EM_RESTART': '1', 21:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:52 INFO - 'PWD': '/builds/slave/test', 21:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:52 INFO - 'SHELL': '/bin/bash', 21:35:52 INFO - 'SHLVL': '1', 21:35:52 INFO - 'TERM': 'linux', 21:35:52 INFO - 'TMOUT': '86400', 21:35:52 INFO - 'USER': 'cltbld', 21:35:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851', 21:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:52 INFO - '_': '/tools/buildbot/bin/python'} 21:35:52 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:35:52 INFO - mozversion application_buildid: 20160928183006 21:35:52 INFO - mozversion application_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 21:35:52 INFO - mozversion application_display_name: Nightly 21:35:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:52 INFO - mozversion application_name: Firefox 21:35:52 INFO - mozversion application_remotingname: firefox 21:35:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:35:52 INFO - mozversion application_vendor: Mozilla 21:35:52 INFO - mozversion application_version: 52.0a1 21:35:52 INFO - mozversion platform_buildid: 20160928183006 21:35:52 INFO - mozversion platform_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 21:35:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:35:52 INFO - mozversion platform_version: 52.0a1 21:35:52 INFO - using testdate: 1475123752 21:35:52 INFO - actual date: 1475123752 21:35:52 INFO - starting webserver on 'localhost:35769' 21:35:52 INFO - SUITE-START | Running 2 tests 21:35:52 INFO - TEST-START | dromaeo_css 21:35:52 INFO - operating with platform_type : linux_ 21:35:52 INFO - Initialising browser for dromaeo_css test... 21:35:52 INFO - TEST-INFO | started process 4800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzm7V7d/profile http://localhost:35769/getInfo.html) 21:35:57 INFO - PROCESS | 4800 | __metrics Screen width/height:1600/1200 21:35:57 INFO - PROCESS | 4800 | colorDepth:24 21:35:57 INFO - PROCESS | 4800 | Browser inner width/height: 1024/697 21:35:57 INFO - PROCESS | 4800 | __metrics 21:35:57 INFO - PROCESS | 4800 | 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" 21:35:57 INFO - PROCESS | 4800 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:58 INFO - PROCESS | 4800 | console.error: PushService: 21:35:58 INFO - PROCESS | 4800 | stateChangeProcessEnqueue: Error transitioning state 21:35:58 INFO - PROCESS | 4800 | UnknownError 21:35:59 INFO - TEST-INFO | 4800: exit 0 21:35:59 INFO - Browser initialized. 21:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:59 INFO - TEST-INFO | started process 4884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzm7V7d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:11 INFO - PROCESS | 4884 | RSS: Main: 173375488 21:36:11 INFO - PROCESS | 4884 | 21:37:02 INFO - PROCESS | 4884 | 1475123822676 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] 21:39:13 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35769/tests/dromaeo/cssquery-ext.html) 21:39:14 INFO - PROCESS | 4884 | RSS: Main: 293031936 21:39:14 INFO - PROCESS | 4884 | 21:42:16 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-ext.html (next: http://localhost:35769/tests/dromaeo/cssquery-jquery.html) 21:42:17 INFO - PROCESS | 4884 | RSS: Main: 271732736 21:42:17 INFO - PROCESS | 4884 | 21:45:19 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35769/tests/dromaeo/cssquery-mootools.html) 21:45:19 INFO - PROCESS | 4884 | RSS: Main: 271593472 21:45:19 INFO - PROCESS | 4884 | 21:48:21 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35769/tests/dromaeo/cssquery-prototype.html) 21:48:22 INFO - PROCESS | 4884 | RSS: Main: 258473984 21:48:22 INFO - PROCESS | 4884 | 21:51:25 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35769/tests/dromaeo/cssquery-yui.html) 21:51:25 INFO - PROCESS | 4884 | RSS: Main: 215281664 21:51:25 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-yui.html (next: http://localhost:35769/tests/dromaeo/cssquery-dojo.html) 21:54:28 INFO - PROCESS | 4884 | RSS: Main: 306208768 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | __start_tp_report 21:54:28 INFO - PROCESS | 4884 | _x_x_mozilla_page_load 21:54:28 INFO - PROCESS | 4884 | _x_x_mozilla_page_load_details 21:54:28 INFO - PROCESS | 4884 | |i|pagename|runs| 21:54:28 INFO - PROCESS | 4884 | |0;dojo.html;3036.40790045941;3045.573619693242;3068.69313068693;3070.6775788542204;3116.314410829617;5267.236250743649;5291.7883284668615;5347.572194224463;5419.051665958461;5425.593080518957;5250.107481728106;5344.866378340544;5407;5448.4006759256545;5465.836024919249;4887.120318342697;4913.091078150535;4933.703977761328;4945.23348880924;5022.673526220802;5054.797808087672;5056.089903817311;5058.721770302632;5066.873328166788;5067.847964561069;4825.831095911626;4876.634252431047;4894.119058569456;5021.874453138665;5038.244263360489;4923.483034281385;4925.975370123127;4936.136176169156;4944.3572335596145;4947.431045429786;4857.587105096071;4868.172410690191;4871.147549178915;4886.462489126193;4888.877778055541;5311.468853114697;5322.2548843161985;5339.385970613391;5372.946270537283;5455.918161227545;5763.971180144114;5774.653520788766;5778.133280007991;5783.739731712041;5787.826365209051;5609.1305847593685;5670.262865827457;5769.336526299488;5817.243758311435;5844.970775146139;5325.547328477084;5376.623636345457;5381.0583147948955;5393.7303134843105;5400.756965936543;5867.530597552186;5879.823605291848;5882.470577648032;5883.2057672213705;5885.440883116097;5507.531859791882;5573.5819813513335;5629.943700563023;5631.408702086222;5641.407652196543;5705.828825135252;5752.827415177551;5758.971205143947;5786.132080188006;5852.970735146297;5747.655140691572;5766.942330576724;5768.105943578752;5771.0477771168125;5771.307443106854;5570.275864137717;5776.480116789509;5787.768489260382;5791.536677065825;5791.812678401002;4351.042770590465;4398.076403955205;4437.245668236407;4450.421445212101;4490.910181796346;3942.8619998299923;3944;3952.407138929126;3968.6031396860085;3984.5019372578427;5482.80810171642;5489.149181876815;5493.807716729895;5494.80768173112;5556.027695153412;5646.096624540054;5720.628159169724;5728.312602487728;5757.85605359861;5785.0454674978155;5465.043617366945;5471.042567550663;5478.506934375925;5515.117581186991;5537.833864984057;5005.374328208974;5042.369703787027;5045.596352291808;5048.873778155502;5098.056859481007;5727.36998930109;5865;5912.349641539341;5971.223740913653;5990.460858522667;5727.198192253171;5777.075667893117;5801.796937107181;5803.9419605803405;5838.065909454467;5941.910871336847;5979.431953964367;5980.461758441761;5982.551308651956;5986.6707331097205;5511.696856672761;5528.91706624409;5675.347335056521;5679.574031947538;5680.630759000652;5685.60200785941;5748.856278592902;5765.048766953406;5782.074868021096;5857.150713146655;5578.972105139448;5634.464725851038;5635;5645.125005624135;5654.915176272277;5452.045891968969;5597.188407680945;5623.297087864017;5645.633033852787;5646.689432081275;5459.590530710292;5557.610967232255;5577.3028371453565;5583.776648933997;5644.068728659725;5633.155026746021;5642.463965923231;5650.124230744241;5651.519620832111;5653.830385088454;5410.729463526886;5475.4524547544925;5476.205950137288;5513.696746678971;5524.4199359066715 21:54:28 INFO - PROCESS | 4884 | |1;ext.html;581.2908251932644;582.7872826418359;585.6017907822682;607.1712112965797;633.0946746153;31664.525032124508;32751.344973100553;35233.82383088087;35295.2940941181;43158.56841431585;44529.99999999992;45029;45035.324470132895;45848.31227531582;49491.75254123724;8801.735947921572;8894.955525222365;8932;8940.927088749359;8942.910570894273;8052.396070294722;8270.462419942685;8836.116388361144;8944.418612790148;10449.634262800804;10545.841812372782;10921.890781092206;10928.125749940025;10933.453327333602;10940.617078402258;10770.676879693583;10840.891591084068;10846.29499082561;10851.403172825492;10855.67432977012;10403.479826008745;10515.369077855354;10524.210684198715;10538.947305263502;10540.947295263475;42954.140917181794;43325.13349733019;43405.78297108526;43412.78293608543;43457.78271108624;3339.9499007514905;3483.930321393583;3575.6960658344074;3682.779033257986;3929.2337994090876;32397.51403728946;32905.6709432905;32909.17727056819;32933.67066329354;32950.670493295;4237.131388065439;4279.935800962988;4322.416473776031;4452.465704115527;4539.137563862855;339451;343456;344221;488519;489412;60969.39030609726;61379.38620613826;61774;61863.381366185764;61885.38114618886;65026.67486662536;65962;65983.34016659771;66006.33993660098;66054;17376.826231737774;17656.735148972777;17663.55841103957;17786.110694465224;17859.374921877672;13750.112476379873;13864.861351386558;13870.861291386957;13874.514391996232;13877.306134693225;19341.709874351895;19457.416277511697;19566.902165489082;19586.8041319585;19642.803571964385;7067.22260551339;7126;7171.856562868714;7203.639818009184;7435.925640743523;926.7405126564573;998.6754304850953;1018.8879223285433;1093.1691914145306;1114.7993361195063;31952.360952780815;32965.83517082399;33067.83466082654;33269.50095748566;33826.154346141055;916.5692124701379;1030.9175265978704;1037.4086770540719;1109.1736656191028;1124.2186680257307;16254.268557914922;16827.91586042062;17082.231299591298;17095.743563846554;17123.400680976105;494113;494667;495078;497068;500114;59608;60286.698566506886;60337.69831150816;60354;60372.39627603756;1182.6806762174165;1242.6085782978332;1295.5724610878387;1327.9269640169884;1383.0456984680739;30122.849385752932;33333.66666333305;34257.657423425444;34667.30665386729;34814.02487641472;53309.466905332;54153.729231355166;54263;54271.18593221026;54338.728306358214;461393;462052;465924;466764;468077;42262.788686056374;42644.57355426406;43346.349804752324;45709;46530.271232631305;47970.28044579404;48712;48779.26831097465;49414.25878611895;49798;40565.39151912665;40832.79583602063;41133;41291.7935410321;42375;42252.78873605612;42692.35961460643;43085;43759;43817.78091109652;41518.79240603778;41570.79214603908;41583.58416415797;41992.37011444892;44203.557964419946;34078.148046299044;38103.047423813514;38157.85526434211;38394;39200;28814.423711525233;29095.7090429093;29391.265218368855;29404;29469 21:54:28 INFO - PROCESS | 4884 | |2;jquery.html;362.83672347443655;400.593397701333;404.3954288338933;408.65060373380766;425.41505430033703;13823.37794799234;15502.844971550296;19364.322248721313;19519.707204391947;20016.49958751032;17537.3861914833;17728.911355443237;18859.52851178718;19353.322633707823;19384.224631014742;4771.594414474774;5665.688387138716;5881.705914704269;5887.470127688507;5888.057910734284;4241.36379543068;4430.778461076933;5780.913286300688;5795.1017592273265;6284.717187726564;6635.469162466991;6635.900461493082;6641.535092543524;6650.434713049397;6653.135092437977;6379.681015949207;6473.058082575232;6504.089427480157;6512.706928188243;6514.283428822826;5576.86057848553;5718.542516598662;5754.338251101135;5763.221965034709;5767.480926716574;22968;23060.192893248823;23223.767762322328;23359.649605255934;23515.7648423517;2378.559966406203;2546.681664791901;2790.5778359148344;3085.753139748837;3126.8749250029973;9776;9938.850917236246;10355.79288414235;14060.156390616494;14370.712585748332;1902.915338257194;1969.3894892583203;1996.6306233346877;2010.939671809848;2013.4060452166646;83071;85958.14041859626;86078;86925;87973;10969.561217551369;11099.778004439866;11165.162612804072;11270.21108522412;11299.943500282447;15805;15836.683266334609;15866.60333491672;15869.444569440015;15869.761953570705;7559.622018899033;8316.708915187939;8423.410361274775;8532.104129066483;8621.09478504748;7963.48237364581;7975.042994840656;8113.148119447491;8287.668493260322;8295.917040829514;4700.694454860423;4777.976110119427;4840.661153719277;4849.466558678542;4925.310456536088;1791.0775950385562;1802.1797984036218;1880.3418803418695;1989.3136867780593;2029.3100345882472;919.3013309884536;952.4856577448239;960.5533426956359;980.593053882645;985.7338518599938;18109.63780724378;18268.63462730738;19080.71378929317;19125.808741912402;19201.32795352156;944.414463032924;948.6821914658528;977.8533220017055;981.5533932060895;988.9604415823286;9968.252381071448;10259.7435064124;10528.578856845794;10596.841047384296;10670.466476676134;461592;462365;464309;475102;477194;90473.54763226274;91345.54327228454;91836.54081729549;92469.53765231131;93592.53203734074;965.9372140810825;986.452518852044;995.5360482805144;996.7906739584769;998.3710262534702;16142.802871253794;16628.237492297718;16948.40680576174;17151.31394744246;17327.393541225996;40985.795071024455;41418;41742.79128604459;42906.78546607247;42927.785361074246;53666.46333536615;54690;54980.72509637586;54988.45011549993;55994;5623.8594035149445;5848.590598658053;8154.2253485918745;8199.385046121684;8863.069377715505;12088.576899808464;12330.260184388966;12926.612201633967;13046.934765326112;13400.597982060553;10439.164866810788;10986.780264394827;11162.107031437303;11506.76986460283;11598.94200528992;10840.078593319657;10976.12191024732;11083.612073577386;11332.886671133183;11537.942310288396;11058.834117488404;11084.778304434027;11308.264962777394;11343.716407089558;11536.307821530734;8108.3513318933165;8229.95885020571;8236.299914507093;8348.123447037973;8880;9042.321825863219;11184.496697648789;11268.887311127111;11337.546498140311;11359.432028398382 21:54:28 INFO - PROCESS | 4884 | |3;mootools.html;1471.1467348937615;1513.1223890143717;1635.6565121324522;1733.713937200362;1811.9456416307507;8632.179942905423;9294.767630809216;9303.534823258835;9309.72070837875;9310.534473276342;7920.603969801501;8201.753947381572;8594.312455003601;8888.511131887744;9063.093690630934;2314.132200424845;2362.1024010875844;2363.2555744940373;2365.148546523259;2366.124533922451;2319.663648770927;2321.6865723127416;2377.0254195779735;2378.0250097460043;2379.916702915398;2345.695059642244;2354.9411264718433;2357.3399448154546;2375.4536456614987;2381.0594815048044;2305.3660243433023;2313.4447732544236;2318.1654604342425;2322.0247496051697;2350.330155905576;2325.837191396603;2329.906803727849;2330.685357476736;2330.6970093887685;2332.7667233276707;8977.685780997634;9028.954855225747;9034.232090272335;9050.547472626407;9069.727908162766;5153.304303918961;5161.174212126042;5330.92003619946;5336.172893201521;5344.438833922421;3171.3023134910513;3301.7193538549254;3319.983400082984;3357.3956687796185;3363.9159021024425;972.7665360313474;1017.5065093429755;1021.2085633633919;1030.907218350352;1033.101201954297;12514.249145051235;12586.81119783204;12600.55898043564;12627.747445051047;12715.109942304043;4535.342375355621;4579.9084018319445;4786.712797232177;4791.616670666408;4808.591269742041;10714.142868570496;10735.83896241557;10738.194635402377;10759.193060520493;10770.24608277413;5338.8665283367445;5345.118055520796;5347.224652425377;5351.384590772111;5360.544353729977;4328.913421731548;4489.079738653568;4717.764111794397;4822.083804077284;4967.726775027409;3983.362661974128;3996.540397854226;4075.816588253536;4087.7956102195367;4124.8556300529335;1259.7480503899073;1260.357217818919;1262.6212136359056;1278.0989402471234;1286.4468278640275;920.3741455810114;934.63082082577;939.4800087393468;949.8765160529088;981.0728861226073;5943.881122377528;5982.670953097621;6052.757889684363;6120.816375508742;6242.968785156045;441.69523029110456;444.2691772035049;444.9844255451044;451.64545831522753;462.5952291744723;4194.8112334945;4219.599138081878;4234.682398820039;4241.724287921275;4242.915141697149;11045.282056666452;11297.152713546517;11382.430878456209;11399.088072954144;11402.486888090056;11276.267042642203;11279.94360028211;11283.266587671775;11287.887121128848;11294;7789.5715735635085;8177.345812334999;8189.853420521132;8425.95787021061;8438.156184381636;6155.47678447337;6157.353477884937;6298.590591611531;6340.682965851781;6474.579152355271;10104.69685909424;10351.896481035094;10366.585336586451;10418.218633602359;10660.733481663021;10603.628872989408;10604.628837990633;10719.624813131502;10727.302725322828;10740.570377185139;7604.315611594983;7742.574158421341;8041.919580804351;8152.959235203786;8180.222878826502;8656.220940115169;8693.47839129629;8708.869366959374;8717.476951382938;8730.912690873263;7753.147153813189;7908.881366779618;7934.801629959066;8140.226678465537;8189.303909167787;7244.963775181091;7830.765077047698;7950.165232650488;7956.880646790419;7964.522128672298;6427.292997770335;6606.174228221473;6610.041543976;6635.23694775107;6646.9335306648245;5093.108705976513;5132.281480592795;5153.639245252796;5207.583393328448;5362.919556206582;5271.71005594696;5279.419263881046;5332.786688532416;5377.059014672339;5506.174073888948 21:54:28 INFO - PROCESS | 4884 | |4;prototype.html;322.3858549463272;325.30871897218407;331.41670659639044;331.8997523210557;339.6654295518912;5140.2546630738525;5312.150055991033;5316.973415132924;5367.785288588457;5393.1370980643105;5077.822276220333;5186.818461353853;5216.26972223889;5227.555657769094;5233.712145831978;4147.523034850986;4152.314868046768;4154.439150714645;4162.604552567516;4179.6029377209115;3869.361555343365;3991.560928297885;4112.650424713888;4171.332586786115;4174.22776786294;4127.09203975125;4132.566080561543;4132.855350062749;4133.545310015896;4139.19285739281;4114;4122.42286079949;4124.175164967019;4130.277201489742;4152.854650087263;3572.624874388178;3703.518542589446;3708.554973403182;3713.57293911201;3725.031491812121;5135;5154.819581314636;5160.110338210614;5186.913786297147;5191.8182863599595;4766.73782941938;4772.451168115642;4778.593819525345;4809.519048095198;4843.854684359475;5217.660852044605;5384.165454354542;5386.767939236427;5550.555955523549;5560.36055853578;4057.878263652095;4066.2883995300704;4070.7761073140964;4078.286299897506;4079.4900637420324;5722.313322401338;5737.684427356452;5738.995675756726;5752.453516915886;5776.768929242825;3958.8614398495915;4143.627073563393;4145.854895078658;4183.6234738873645;4186.958130418718;4203.579642035833;4211.768352740629;4225.873223803291;4240.957590424056;4253.489581250208;4765.642576806753;4767.73777442237;4770.833020844254;4806.668765648657;4819.831305904277;5425.565954723613;5476.274973383372;5499.557125820843;5644.915326270109;5646.915296270559;1380.0201856681867;1407.2189934586402;1414.971700565983;1446.197360464952;1446.9710605787825;1019.4189312092185;1046.35126221743;1046.6493724602344;1048.6120135549743;1054.0776820282254;5350.224217488442;5375.81184658535;5377.327834020747;5407.486288802557;5417.51242388187;5452.182172674051;5626.887462250732;5680.261565996394;5685.5167310778215;5706.115552089433;5278.392984806719;5287.259783630295;5297.5232229099565;5315.441878602768;5324.148136298174;2612.9488351643868;2645.682518097841;2653.230563136669;2669.9332516687236;2677.451122519879;5103.795848166106;5474.509098360237;5839.824805255849;5840.970795145997;5874.353821079678;5796.203177015139;5821.243238378984;5826.48511387034;5835.153902684087;5847.26909136358;5709.51469125129;5886.234129760969;5890.204822349014;5928.9407105928385;5943.227380440515;5646.35066967304;5662.150677398423;5671.801486947937;5672.886542269049;5678.659280443187;5561.443855614406;5642.746076426489;5650.3219613646625;5655.377908429987;5692.886142277214;5675.7445914933105;5822.76708931655;5855.531557475477;5863.472287494146;5887.056471764118;4060.4315395845197;4067.349224124126;4073.735207211522;4078.4501889281883;4102.282100632317;5744.770209191585;5751.913721294268;5768.826935191951;5774.595778295479;5775.740091695968;5346.144616861284;5596.972015139898;5597.5521958242425;5611.915821262603;5621.325440947113;5242.501962313574;5579.2746942897165;5582.469665381782;5601.663900166003;5648.915266271091;5318.601104917224;5464.972675136599;5515.097291434448;5558.610897237317;5571.721413929368;5554.722263886871;5565.888682226252;5565.888682226252;5575.766055687773;5588.441155884379;5222.74654083025;5371.865703357291;5432.320959880015;5480.835574932758;5533.916991245054 21:54:28 INFO - PROCESS | 4884 | |5;yui.html;723.1358526560762;727.9708811647532;739.2792027772922;743.9888401673976;768.753998720409;13157.276349800757;13864.23746693934;13875.791863122036;13894.23581703006;13956.930215348923;14765.261736913166;14935.477258295961;14936;14939.701205975874;14945.252737363142;638.0142679560091;676;764.9617519124049;776.3711393771049;807.4025221336199;811.7280710961835;812.9918900563318;815.7226542975387;815.979600509989;817.2603793566832;848.9490630562186;850.2985037344216;850.9234168924795;851.1020872979004;851.1445996773265;682;700.870338987289;816.9468984515987;844.0546587821618;848;630.5271046714964;630.5554584018256;631.9982827218863;632.0172132334219;632.0519221168248;14433.566992990121;14461.78307325391;14499.782503262459;14530.854691453056;14614;13215.14101583394;13909;14083.507077252247;14242.359093840802;14242.572722818228;12416.503339866395;12681.239125652399;12785.360731963458;13156.934215328958;13171.209727416386;4360.367746676746;4447.243968525326;4475.619572336355;4629.652776041777;4644.8374306899095;77076;77487.61256193739;80149.59925200336;80566.59716701438;81650;10930.890691093146;11159.163062770325;11338.433078346216;11754;11757.529698811952;22133.89330533467;22190.445238868833;22195.33413997583;22198.445038873833;22228.11087556512;7889.132195458495;8118.066422361504;8127;8196.54918979462;8440.873386899078;3975.602439756059;3996.680265578747;4048;4094.6724262058965;4117.094239267356;3524.1718196223865;3643.107438677488;3644.599094099647;3648.744587878823;3806.2006978534264;636.8439732265624;657.7073202424875;672.9966350168218;674.9628770417675;679.3953381490477;693.8473535822111;696.314130581377;704.8836941904631;716.9964150179215;749.1235254751954;8808.20726134651;9112.681056163003;9183.173514383738;9355.578998945064;9626.711198664052;601.4166258729114;629.6820105846518;708.4580296073508;740.0638192686256;743.7248218159316;4374.3191551804;4498.302763071729;4513.368128462018;4538.52345503724;4597.126545956257;83148.58425707954;123906;125145;132488;132512.3374383141;109445;111692.44153779342;112700.43649781862;113863.43068284771;114239.42880285712;59057.40942590519;97560.51219743855;98101;100741.49629251807;101200.49399752954;8205;8482.830343393221;8542.40203185771;8611.268042216481;8730.56347182651;54411.45588544064;54563.17960254968;54991.45008550023;55912.720436397554;56058.439415605324;63843.680781595795;68349.65825170842;69762;72979.63510182415;74016.88974665277;12885.613431597067;13047;13149.73700525965;13153;13280.269585172908;14037.227952462712;14604.780928285873;14700.632484187554;15028.474003409829;15359.078455292718;13539.59381218565;13853.3328049459;14165.150090994573;14273.214973176575;14523.564293071226;13974.79037814454;14016.579502614937;14213;14348;14402.351894164578;12965.286909219707;12990.220586764446;13508.121972071784;13608;13863.722725545635;9786;9949.452780097165;10015.449150296803;10073.949630251802;10243.48782560884;11225.831612525655;11304.717382065186;11490.253133546294;11551.306921584732;11835.112366572714 21:54:28 INFO - PROCESS | 4884 | __end_tp_report 21:54:28 INFO - PROCESS | 4884 | __start_cc_report 21:54:28 INFO - PROCESS | 4884 | _x_x_mozilla_cycle_collect,907 21:54:28 INFO - PROCESS | 4884 | __end_cc_report 21:54:28 INFO - PROCESS | 4884 | __startTimestamp1475124868784__endTimestamp 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | ------- Summary: start ------- 21:54:28 INFO - PROCESS | 4884 | Number of tests: 6 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#0] dojo.html Cycles:165 Average:5353.51 Median:5528.92 stddev:599.30 (10.8%) stddev-sans-first:572.91 21:54:28 INFO - PROCESS | 4884 | Values: 3036.4 3045.6 3068.7 3070.7 3116.3 5267.2 5291.8 5347.6 5419.1 5425.6 5250.1 5344.9 5407.0 5448.4 5465.8 4887.1 4913.1 4933.7 4945.2 5022.7 5054.8 5056.1 5058.7 5066.9 5067.8 4825.8 4876.6 4894.1 5021.9 5038.2 4923.5 4926.0 4936.1 4944.4 4947.4 4857.6 4868.2 4871.1 4886.5 4888.9 5311.5 5322.3 5339.4 5372.9 5455.9 5764.0 5774.7 5778.1 5783.7 5787.8 5609.1 5670.3 5769.3 5817.2 5845.0 5325.5 5376.6 5381.1 5393.7 5400.8 5867.5 5879.8 5882.5 5883.2 5885.4 5507.5 5573.6 5629.9 5631.4 5641.4 5705.8 5752.8 5759.0 5786.1 5853.0 5747.7 5766.9 5768.1 5771.0 5771.3 5570.3 5776.5 5787.8 5791.5 5791.8 4351.0 4398.1 4437.2 4450.4 4490.9 3942.9 3944.0 3952.4 3968.6 3984.5 5482.8 5489.1 5493.8 5494.8 5556.0 5646.1 5720.6 5728.3 5757.9 5785.0 5465.0 5471.0 5478.5 5515.1 5537.8 5005.4 5042.4 5045.6 5048.9 5098.1 5727.4 5865.0 5912.3 5971.2 5990.5 5727.2 5777.1 5801.8 5803.9 5838.1 5941.9 5979.4 5980.5 5982.6 5986.7 5511.7 5528.9 5675.3 5679.6 5680.6 5685.6 5748.9 5765.0 5782.1 5857.2 5579.0 5634.5 5635.0 5645.1 5654.9 5452.0 5597.2 5623.3 5645.6 5646.7 5459.6 5557.6 5577.3 5583.8 5644.1 5633.2 5642.5 5650.1 5651.5 5653.8 5410.7 5475.5 5476.2 5513.7 5524.4 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#1] ext.html Cycles:180 Average:62536.92 Median:41577.19 stddev:121034.28 (291.1%) stddev-sans-first:121284.42 21:54:28 INFO - PROCESS | 4884 | Values: 581.3 582.8 585.6 607.2 633.1 31664.5 32751.3 35233.8 35295.3 43158.6 44530.0 45029.0 45035.3 45848.3 49491.8 8801.7 8895.0 8932.0 8940.9 8942.9 8052.4 8270.5 8836.1 8944.4 10449.6 10545.8 10921.9 10928.1 10933.5 10940.6 10770.7 10840.9 10846.3 10851.4 10855.7 10403.5 10515.4 10524.2 10538.9 10540.9 42954.1 43325.1 43405.8 43412.8 43457.8 3339.9 3483.9 3575.7 3682.8 3929.2 32397.5 32905.7 32909.2 32933.7 32950.7 4237.1 4279.9 4322.4 4452.5 4539.1 339451.0 343456.0 344221.0 488519.0 489412.0 60969.4 61379.4 61774.0 61863.4 61885.4 65026.7 65962.0 65983.3 66006.3 66054.0 17376.8 17656.7 17663.6 17786.1 17859.4 13750.1 13864.9 13870.9 13874.5 13877.3 19341.7 19457.4 19566.9 19586.8 19642.8 7067.2 7126.0 7171.9 7203.6 7435.9 926.7 998.7 1018.9 1093.2 1114.8 31952.4 32965.8 33067.8 33269.5 33826.2 916.6 1030.9 1037.4 1109.2 1124.2 16254.3 16827.9 17082.2 17095.7 17123.4 494113.0 494667.0 495078.0 497068.0 500114.0 59608.0 60286.7 60337.7 60354.0 60372.4 1182.7 1242.6 1295.6 1327.9 1383.0 30122.8 33333.7 34257.7 34667.3 34814.0 53309.5 54153.7 54263.0 54271.2 54338.7 461393.0 462052.0 465924.0 466764.0 468077.0 42262.8 42644.6 43346.3 45709.0 46530.3 47970.3 48712.0 48779.3 49414.3 49798.0 40565.4 40832.8 41133.0 41291.8 42375.0 42252.8 42692.4 43085.0 43759.0 43817.8 41518.8 41570.8 41583.6 41992.4 44203.6 34078.1 38103.0 38157.9 38394.0 39200.0 28814.4 29095.7 29391.3 29404.0 29469.0 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#2] jquery.html Cycles:180 Average:28358.49 Median:42917.29 stddev:77397.04 (180.3%) stddev-sans-first:77585.62 21:54:28 INFO - PROCESS | 4884 | Values: 362.8 400.6 404.4 408.7 425.4 13823.4 15502.8 19364.3 19519.7 20016.5 17537.4 17728.9 18859.5 19353.3 19384.2 4771.6 5665.7 5881.7 5887.5 5888.1 4241.4 4430.8 5780.9 5795.1 6284.7 6635.5 6635.9 6641.5 6650.4 6653.1 6379.7 6473.1 6504.1 6512.7 6514.3 5576.9 5718.5 5754.3 5763.2 5767.5 22968.0 23060.2 23223.8 23359.6 23515.8 2378.6 2546.7 2790.6 3085.8 3126.9 9776.0 9938.9 10355.8 14060.2 14370.7 1902.9 1969.4 1996.6 2010.9 2013.4 83071.0 85958.1 86078.0 86925.0 87973.0 10969.6 11099.8 11165.2 11270.2 11299.9 15805.0 15836.7 15866.6 15869.4 15869.8 7559.6 8316.7 8423.4 8532.1 8621.1 7963.5 7975.0 8113.1 8287.7 8295.9 4700.7 4778.0 4840.7 4849.5 4925.3 1791.1 1802.2 1880.3 1989.3 2029.3 919.3 952.5 960.6 980.6 985.7 18109.6 18268.6 19080.7 19125.8 19201.3 944.4 948.7 977.9 981.6 989.0 9968.3 10259.7 10528.6 10596.8 10670.5 461592.0 462365.0 464309.0 475102.0 477194.0 90473.5 91345.5 91836.5 92469.5 93592.5 965.9 986.5 995.5 996.8 998.4 16142.8 16628.2 16948.4 17151.3 17327.4 40985.8 41418.0 41742.8 42906.8 42927.8 53666.5 54690.0 54980.7 54988.5 55994.0 5623.9 5848.6 8154.2 8199.4 8863.1 12088.6 12330.3 12926.6 13046.9 13400.6 10439.2 10986.8 11162.1 11506.8 11598.9 10840.1 10976.1 11083.6 11332.9 11537.9 11058.8 11084.8 11308.3 11343.7 11536.3 8108.4 8230.0 8236.3 8348.1 8880.0 9042.3 11184.5 11268.9 11337.5 11359.4 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#3] mootools.html Cycles:180 Average:5901.20 Median:4557.63 stddev:3433.34 (75.3%) stddev-sans-first:3426.83 21:54:28 INFO - PROCESS | 4884 | Values: 1471.1 1513.1 1635.7 1733.7 1811.9 8632.2 9294.8 9303.5 9309.7 9310.5 7920.6 8201.8 8594.3 8888.5 9063.1 2314.1 2362.1 2363.3 2365.1 2366.1 2319.7 2321.7 2377.0 2378.0 2379.9 2345.7 2354.9 2357.3 2375.5 2381.1 2305.4 2313.4 2318.2 2322.0 2350.3 2325.8 2329.9 2330.7 2330.7 2332.8 8977.7 9029.0 9034.2 9050.5 9069.7 5153.3 5161.2 5330.9 5336.2 5344.4 3171.3 3301.7 3320.0 3357.4 3363.9 972.8 1017.5 1021.2 1030.9 1033.1 12514.2 12586.8 12600.6 12627.7 12715.1 4535.3 4579.9 4786.7 4791.6 4808.6 10714.1 10735.8 10738.2 10759.2 10770.2 5338.9 5345.1 5347.2 5351.4 5360.5 4328.9 4489.1 4717.8 4822.1 4967.7 3983.4 3996.5 4075.8 4087.8 4124.9 1259.7 1260.4 1262.6 1278.1 1286.4 920.4 934.6 939.5 949.9 981.1 5943.9 5982.7 6052.8 6120.8 6243.0 441.7 444.3 445.0 451.6 462.6 4194.8 4219.6 4234.7 4241.7 4242.9 11045.3 11297.2 11382.4 11399.1 11402.5 11276.3 11279.9 11283.3 11287.9 11294.0 7789.6 8177.3 8189.9 8426.0 8438.2 6155.5 6157.4 6298.6 6340.7 6474.6 10104.7 10351.9 10366.6 10418.2 10660.7 10603.6 10604.6 10719.6 10727.3 10740.6 7604.3 7742.6 8041.9 8153.0 8180.2 8656.2 8693.5 8708.9 8717.5 8730.9 7753.1 7908.9 7934.8 8140.2 8189.3 7245.0 7830.8 7950.2 7956.9 7964.5 6427.3 6606.2 6610.0 6635.2 6646.9 5093.1 5132.3 5153.6 5207.6 5362.9 5271.7 5279.4 5332.8 5377.1 5506.2 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#4] prototype.html Cycles:180 Average:4670.48 Median:5282.83 stddev:1370.02 (25.9%) stddev-sans-first:1334.43 21:54:28 INFO - PROCESS | 4884 | Values: 322.4 325.3 331.4 331.9 339.7 5140.3 5312.2 5317.0 5367.8 5393.1 5077.8 5186.8 5216.3 5227.6 5233.7 4147.5 4152.3 4154.4 4162.6 4179.6 3869.4 3991.6 4112.7 4171.3 4174.2 4127.1 4132.6 4132.9 4133.5 4139.2 4114.0 4122.4 4124.2 4130.3 4152.9 3572.6 3703.5 3708.6 3713.6 3725.0 5135.0 5154.8 5160.1 5186.9 5191.8 4766.7 4772.5 4778.6 4809.5 4843.9 5217.7 5384.2 5386.8 5550.6 5560.4 4057.9 4066.3 4070.8 4078.3 4079.5 5722.3 5737.7 5739.0 5752.5 5776.8 3958.9 4143.6 4145.9 4183.6 4187.0 4203.6 4211.8 4225.9 4241.0 4253.5 4765.6 4767.7 4770.8 4806.7 4819.8 5425.6 5476.3 5499.6 5644.9 5646.9 1380.0 1407.2 1415.0 1446.2 1447.0 1019.4 1046.4 1046.6 1048.6 1054.1 5350.2 5375.8 5377.3 5407.5 5417.5 5452.2 5626.9 5680.3 5685.5 5706.1 5278.4 5287.3 5297.5 5315.4 5324.1 2612.9 2645.7 2653.2 2669.9 2677.5 5103.8 5474.5 5839.8 5841.0 5874.4 5796.2 5821.2 5826.5 5835.2 5847.3 5709.5 5886.2 5890.2 5928.9 5943.2 5646.4 5662.2 5671.8 5672.9 5678.7 5561.4 5642.7 5650.3 5655.4 5692.9 5675.7 5822.8 5855.5 5863.5 5887.1 4060.4 4067.3 4073.7 4078.5 4102.3 5744.8 5751.9 5768.8 5774.6 5775.7 5346.1 5597.0 5597.6 5611.9 5621.3 5242.5 5579.3 5582.5 5601.7 5648.9 5318.6 5465.0 5515.1 5558.6 5571.7 5554.7 5565.9 5565.9 5575.8 5588.4 5222.7 5371.9 5432.3 5480.8 5533.9 21:54:28 INFO - PROCESS | 4884 | 21:54:28 INFO - PROCESS | 4884 | [#5] yui.html Cycles:180 Average:21423.57 Median:4410.78 stddev:32001.04 (725.5%) stddev-sans-first:32053.07 21:54:28 INFO - PROCESS | 4884 | Values: 723.1 728.0 739.3 744.0 768.8 13157.3 13864.2 13875.8 13894.2 13956.9 14765.3 14935.5 14936.0 14939.7 14945.3 638.0 676.0 765.0 776.4 807.4 811.7 813.0 815.7 816.0 817.3 848.9 850.3 850.9 851.1 851.1 682.0 700.9 816.9 844.1 848.0 630.5 630.6 632.0 632.0 632.1 14433.6 14461.8 14499.8 14530.9 14614.0 13215.1 13909.0 14083.5 14242.4 14242.6 12416.5 12681.2 12785.4 13156.9 13171.2 4360.4 4447.2 4475.6 4629.7 4644.8 77076.0 77487.6 80149.6 80566.6 81650.0 10930.9 11159.2 11338.4 11754.0 11757.5 22133.9 22190.4 22195.3 22198.4 22228.1 7889.1 8118.1 8127.0 8196.5 8440.9 3975.6 3996.7 4048.0 4094.7 4117.1 3524.2 3643.1 3644.6 3648.7 3806.2 636.8 657.7 673.0 675.0 679.4 693.8 696.3 704.9 717.0 749.1 8808.2 9112.7 9183.2 9355.6 9626.7 601.4 629.7 708.5 740.1 743.7 4374.3 4498.3 4513.4 4538.5 4597.1 83148.6 123906.0 125145.0 132488.0 132512.3 109445.0 111692.4 112700.4 113863.4 114239.4 59057.4 97560.5 98101.0 100741.5 101200.5 8205.0 8482.8 8542.4 8611.3 8730.6 54411.5 54563.2 54991.5 55912.7 56058.4 63843.7 68349.7 69762.0 72979.6 74016.9 12885.6 13047.0 13149.7 13153.0 13280.3 14037.2 14604.8 14700.6 15028.5 15359.1 13539.6 13853.3 14165.2 14273.2 14523.6 13974.8 14016.6 14213.0 14348.0 14402.4 12965.3 12990.2 13508.1 13608.0 13863.7 9786.0 9949.5 10015.4 10073.9 10243.5 11225.8 11304.7 11490.3 11551.3 11835.1 21:54:28 INFO - PROCESS | 4884 | -------- Summary: end -------- 21:54:28 INFO - PROCESS | 4884 | 21:54:29 INFO - TEST-INFO | 4884: exit 0 21:54:29 INFO - TEST-OK | dromaeo_css | took 1117157ms 21:54:29 INFO - TEST-START | kraken 21:54:29 INFO - operating with platform_type : linux_ 21:54:29 INFO - Initialising browser for kraken test... 21:54:29 INFO - TEST-INFO | started process 5190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdOIp3/profile http://localhost:35769/getInfo.html) 21:54:34 INFO - PROCESS | 5190 | __metrics Screen width/height:1600/1200 21:54:34 INFO - PROCESS | 5190 | colorDepth:24 21:54:34 INFO - PROCESS | 5190 | Browser inner width/height: 1024/697 21:54:34 INFO - PROCESS | 5190 | __metrics 21:54:34 INFO - PROCESS | 5190 | 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" 21:54:34 INFO - PROCESS | 5190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:35 INFO - PROCESS | 5190 | console.error: PushService: 21:54:35 INFO - PROCESS | 5190 | stateChangeProcessEnqueue: Error transitioning state 21:54:35 INFO - PROCESS | 5190 | UnknownError 21:54:36 INFO - TEST-INFO | 5190: exit 0 21:54:36 INFO - Browser initialized. 21:54:36 INFO - Running cycle 1/1 for kraken test... 21:54:36 INFO - TEST-INFO | started process 5273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdOIp3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:48 INFO - PROCESS | 5273 | RSS: Main: 173490176 21:54:48 INFO - PROCESS | 5273 | 21:54:50 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:51 INFO - PROCESS | 5273 | RSS: Main: 232837120 21:54:51 INFO - PROCESS | 5273 | 21:54:54 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-dft) 21:54:54 INFO - PROCESS | 5273 | RSS: Main: 217083904 21:54:54 INFO - PROCESS | 5273 | 21:54:57 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-fft) 21:54:58 INFO - PROCESS | 5273 | RSS: Main: 299196416 21:54:58 INFO - PROCESS | 5273 | 21:55:00 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-oscillator) 21:55:01 INFO - PROCESS | 5273 | RSS: Main: 208142336 21:55:01 INFO - PROCESS | 5273 | 21:55:03 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:55:03 INFO - PROCESS | 5273 | RSS: Main: 213004288 21:55:03 INFO - PROCESS | 5273 | 21:55:06 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:07 INFO - PROCESS | 5273 | RSS: Main: 249503744 21:55:07 INFO - PROCESS | 5273 | 21:55:10 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:11 INFO - PROCESS | 5273 | RSS: Main: 248610816 21:55:11 INFO - PROCESS | 5273 | 21:55:14 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35769/tests/kraken/driver.html?testName=json-parse-financial) 21:55:14 INFO - PROCESS | 5273 | RSS: Main: 248221696 21:55:14 INFO - PROCESS | 5273 | 21:55:16 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:16 INFO - PROCESS | 5273 | RSS: Main: 210743296 21:55:16 INFO - PROCESS | 5273 | 21:55:18 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:19 INFO - PROCESS | 5273 | RSS: Main: 217358336 21:55:19 INFO - PROCESS | 5273 | 21:55:21 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:21 INFO - PROCESS | 5273 | RSS: Main: 222121984 21:55:21 INFO - PROCESS | 5273 | 21:55:24 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:24 INFO - PROCESS | 5273 | RSS: Main: 223301632 21:55:24 INFO - PROCESS | 5273 | 21:55:27 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:28 INFO - PROCESS | 5273 | RSS: Main: 222130176 21:55:28 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35769/tests/kraken/driver.html?testName=ai-astar) 21:55:30 INFO - PROCESS | 5273 | RSS: Main: 272388096 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | __start_tp_report 21:55:30 INFO - PROCESS | 5273 | _x_x_mozilla_page_load 21:55:30 INFO - PROCESS | 5273 | _x_x_mozilla_page_load_details 21:55:30 INFO - PROCESS | 5273 | |i|pagename|runs| 21:55:30 INFO - PROCESS | 5273 | |0;ai-astar;110;113;110;111;112;111;111;111;111;112 21:55:30 INFO - PROCESS | 5273 | |1;audio-beat-detection;141;118;117;159;120;124;121;120;156;123 21:55:30 INFO - PROCESS | 5273 | |2;audio-dft;161;160;161;160;160;160;161;159;162;160 21:55:30 INFO - PROCESS | 5273 | |3;audio-fft;74;75;77;114;76;76;76;76;97;76 21:55:30 INFO - PROCESS | 5273 | |4;audio-oscillator;83;83;116;83;84;82;107;83;82;114 21:55:30 INFO - PROCESS | 5273 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;116 21:55:30 INFO - PROCESS | 5273 | |6;imaging-darkroom;145;146;146;145;145;146;145;145;145;145 21:55:30 INFO - PROCESS | 5273 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 21:55:30 INFO - PROCESS | 5273 | |8;json-parse-financial;52;51;51;51;52;53;52;51;53;53 21:55:30 INFO - PROCESS | 5273 | |9;json-stringify-tinderbox;59;59;60;59;60;60;59;59;59;60 21:55:30 INFO - PROCESS | 5273 | |10;stanford-crypto-aes;88;79;79;79;82;79;80;78;84;78 21:55:30 INFO - PROCESS | 5273 | |11;stanford-crypto-ccm;125;125;123;123;132;136;124;125;162;121 21:55:30 INFO - PROCESS | 5273 | |12;stanford-crypto-pbkdf2;169;165;166;163;164;167;170;171;168;165 21:55:30 INFO - PROCESS | 5273 | |13;stanford-crypto-sha256-iterative;66;68;66;65;70;65;66;65;63;75 21:55:30 INFO - PROCESS | 5273 | __end_tp_report 21:55:30 INFO - PROCESS | 5273 | __start_cc_report 21:55:30 INFO - PROCESS | 5273 | _x_x_mozilla_cycle_collect,1614 21:55:30 INFO - PROCESS | 5273 | __end_cc_report 21:55:30 INFO - PROCESS | 5273 | __startTimestamp1475124930292__endTimestamp 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | ------- Summary: start ------- 21:55:30 INFO - PROCESS | 5273 | Number of tests: 14 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 21:55:30 INFO - PROCESS | 5273 | Values: 110.0 113.0 110.0 111.0 112.0 111.0 111.0 111.0 111.0 112.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:123.50 stddev:16.04 (13.0%) stddev-sans-first:16.51 21:55:30 INFO - PROCESS | 5273 | Values: 141.0 118.0 117.0 159.0 120.0 124.0 121.0 120.0 156.0 123.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 21:55:30 INFO - PROCESS | 5273 | Values: 161.0 160.0 161.0 160.0 160.0 160.0 161.0 159.0 162.0 160.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:13.19 (17.4%) stddev-sans-first:13.69 21:55:30 INFO - PROCESS | 5273 | Values: 74.0 75.0 77.0 114.0 76.0 76.0 76.0 76.0 97.0 76.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.42 (17.4%) stddev-sans-first:14.95 21:55:30 INFO - PROCESS | 5273 | Values: 83.0 83.0 116.0 83.0 84.0 82.0 107.0 83.0 82.0 114.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 21:55:30 INFO - PROCESS | 5273 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:55:30 INFO - PROCESS | 5273 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:55:30 INFO - PROCESS | 5273 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 21:55:30 INFO - PROCESS | 5273 | Values: 52.0 51.0 51.0 51.0 52.0 53.0 52.0 51.0 53.0 53.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 21:55:30 INFO - PROCESS | 5273 | Values: 59.0 59.0 60.0 59.0 60.0 60.0 59.0 59.0 59.0 60.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.20 (4.0%) stddev-sans-first:1.99 21:55:30 INFO - PROCESS | 5273 | Values: 88.0 79.0 79.0 79.0 82.0 79.0 80.0 78.0 84.0 78.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:125.00 stddev:12.26 (9.8%) stddev-sans-first:12.89 21:55:30 INFO - PROCESS | 5273 | Values: 125.0 125.0 123.0 123.0 132.0 136.0 124.0 125.0 162.0 121.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:2.66 (1.6%) stddev-sans-first:2.70 21:55:30 INFO - PROCESS | 5273 | Values: 169.0 165.0 166.0 163.0 164.0 167.0 170.0 171.0 168.0 165.0 21:55:30 INFO - PROCESS | 5273 | 21:55:30 INFO - PROCESS | 5273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:3.41 (5.2%) stddev-sans-first:3.61 21:55:30 INFO - PROCESS | 5273 | Values: 66.0 68.0 66.0 65.0 70.0 65.0 66.0 65.0 63.0 75.0 21:55:30 INFO - PROCESS | 5273 | -------- Summary: end -------- 21:55:30 INFO - PROCESS | 5273 | 21:55:31 INFO - TEST-INFO | 5273: exit 0 21:55:31 INFO - TEST-OK | kraken | took 61771ms 21:55:31 INFO - SUITE-END | took 1178s 21:55:31 INFO - Completed test suite (00:19:39) 21:55:31 INFO - javascript benchmark 21:55:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.40790045941, 3045.573619693242, 3068.69313068693, 3070.6775788542204, 3116.314410829617, 5267.236250743649, 5291.7883284668615, 5347.572194224463, 5419.051665958461, 5425.593080518957, 5250.107481728106, 5344.866378340544, 5407.0, 5448.4006759256545, 5465.836024919249, 4887.120318342697, 4913.091078150535, 4933.703977761328, 4945.23348880924, 5022.673526220802, 5054.797808087672, 5056.089903817311, 5058.721770302632, 5066.873328166788, 5067.847964561069, 4825.831095911626, 4876.634252431047, 4894.119058569456, 5021.874453138665, 5038.244263360489, 4923.483034281385, 4925.975370123127, 4936.136176169156, 4944.3572335596145, 4947.431045429786, 4857.587105096071, 4868.172410690191, 4871.147549178915, 4886.462489126193, 4888.877778055541, 5311.468853114697, 5322.2548843161985, 5339.385970613391, 5372.946270537283, 5455.918161227545, 5763.971180144114, 5774.653520788766, 5778.133280007991, 5783.739731712041, 5787.826365209051, 5609.1305847593685, 5670.262865827457, 5769.336526299488, 5817.243758311435, 5844.970775146139, 5325.547328477084, 5376.623636345457, 5381.0583147948955, 5393.7303134843105, 5400.756965936543, 5867.530597552186, 5879.823605291848, 5882.470577648032, 5883.2057672213705, 5885.440883116097, 5507.531859791882, 5573.5819813513335, 5629.943700563023, 5631.408702086222, 5641.407652196543, 5705.828825135252, 5752.827415177551, 5758.971205143947, 5786.132080188006, 5852.970735146297, 5747.655140691572, 5766.942330576724, 5768.105943578752, 5771.0477771168125, 5771.307443106854, 5570.275864137717, 5776.480116789509, 5787.768489260382, 5791.536677065825, 5791.812678401002, 4351.042770590465, 4398.076403955205, 4437.245668236407, 4450.421445212101, 4490.910181796346, 3942.8619998299923, 3944.0, 3952.407138929126, 3968.6031396860085, 3984.5019372578427, 5482.80810171642, 5489.149181876815, 5493.807716729895, 5494.80768173112, 5556.027695153412, 5646.096624540054, 5720.628159169724, 5728.312602487728, 5757.85605359861, 5785.0454674978155, 5465.043617366945, 5471.042567550663, 5478.506934375925, 5515.117581186991, 5537.833864984057, 5005.374328208974, 5042.369703787027, 5045.596352291808, 5048.873778155502, 5098.056859481007, 5727.36998930109, 5865.0, 5912.349641539341, 5971.223740913653, 5990.460858522667, 5727.198192253171, 5777.075667893117, 5801.796937107181, 5803.9419605803405, 5838.065909454467, 5941.910871336847, 5979.431953964367, 5980.461758441761, 5982.551308651956, 5986.6707331097205, 5511.696856672761, 5528.91706624409, 5675.347335056521, 5679.574031947538, 5680.630759000652, 5685.60200785941, 5748.856278592902, 5765.048766953406, 5782.074868021096, 5857.150713146655, 5578.972105139448, 5634.464725851038, 5635.0, 5645.125005624135, 5654.915176272277, 5452.045891968969, 5597.188407680945, 5623.297087864017, 5645.633033852787, 5646.689432081275, 5459.590530710292, 5557.610967232255, 5577.3028371453565, 5583.776648933997, 5644.068728659725, 5633.155026746021, 5642.463965923231, 5650.124230744241, 5651.519620832111, 5653.830385088454, 5410.729463526886, 5475.4524547544925, 5476.205950137288, 5513.696746678971, 5524.4199359066715], "value": 5313.017279460292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2908251932644, 582.7872826418359, 585.6017907822682, 607.1712112965797, 633.0946746153, 31664.525032124508, 32751.344973100553, 35233.82383088087, 35295.2940941181, 43158.56841431585, 44529.99999999992, 45029.0, 45035.324470132895, 45848.31227531582, 49491.75254123724, 8801.735947921572, 8894.955525222365, 8932.0, 8940.927088749359, 8942.910570894273, 8052.396070294722, 8270.462419942685, 8836.116388361144, 8944.418612790148, 10449.634262800804, 10545.841812372782, 10921.890781092206, 10928.125749940025, 10933.453327333602, 10940.617078402258, 10770.676879693583, 10840.891591084068, 10846.29499082561, 10851.403172825492, 10855.67432977012, 10403.479826008745, 10515.369077855354, 10524.210684198715, 10538.947305263502, 10540.947295263475, 42954.140917181794, 43325.13349733019, 43405.78297108526, 43412.78293608543, 43457.78271108624, 3339.9499007514905, 3483.930321393583, 3575.6960658344074, 3682.779033257986, 3929.2337994090876, 32397.51403728946, 32905.6709432905, 32909.17727056819, 32933.67066329354, 32950.670493295, 4237.131388065439, 4279.935800962988, 4322.416473776031, 4452.465704115527, 4539.137563862855, 339451.0, 343456.0, 344221.0, 488519.0, 489412.0, 60969.39030609726, 61379.38620613826, 61774.0, 61863.381366185764, 61885.38114618886, 65026.67486662536, 65962.0, 65983.34016659771, 66006.33993660098, 66054.0, 17376.826231737774, 17656.735148972777, 17663.55841103957, 17786.110694465224, 17859.374921877672, 13750.112476379873, 13864.861351386558, 13870.861291386957, 13874.514391996232, 13877.306134693225, 19341.709874351895, 19457.416277511697, 19566.902165489082, 19586.8041319585, 19642.803571964385, 7067.22260551339, 7126.0, 7171.856562868714, 7203.639818009184, 7435.925640743523, 926.7405126564573, 998.6754304850953, 1018.8879223285433, 1093.1691914145306, 1114.7993361195063, 31952.360952780815, 32965.83517082399, 33067.83466082654, 33269.50095748566, 33826.154346141055, 916.5692124701379, 1030.9175265978704, 1037.4086770540719, 1109.1736656191028, 1124.2186680257307, 16254.268557914922, 16827.91586042062, 17082.231299591298, 17095.743563846554, 17123.400680976105, 494113.0, 494667.0, 495078.0, 497068.0, 500114.0, 59608.0, 60286.698566506886, 60337.69831150816, 60354.0, 60372.39627603756, 1182.6806762174165, 1242.6085782978332, 1295.5724610878387, 1327.9269640169884, 1383.0456984680739, 30122.849385752932, 33333.66666333305, 34257.657423425444, 34667.30665386729, 34814.02487641472, 53309.466905332, 54153.729231355166, 54263.0, 54271.18593221026, 54338.728306358214, 461393.0, 462052.0, 465924.0, 466764.0, 468077.0, 42262.788686056374, 42644.57355426406, 43346.349804752324, 45709.0, 46530.271232631305, 47970.28044579404, 48712.0, 48779.26831097465, 49414.25878611895, 49798.0, 40565.39151912665, 40832.79583602063, 41133.0, 41291.7935410321, 42375.0, 42252.78873605612, 42692.35961460643, 43085.0, 43759.0, 43817.78091109652, 41518.79240603778, 41570.79214603908, 41583.58416415797, 41992.37011444892, 44203.557964419946, 34078.148046299044, 38103.047423813514, 38157.85526434211, 38394.0, 39200.0, 28814.423711525233, 29095.7090429093, 29391.265218368855, 29404.0, 29469.0], "value": 21023.604099145363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.83672347443655, 400.593397701333, 404.3954288338933, 408.65060373380766, 425.41505430033703, 13823.37794799234, 15502.844971550296, 19364.322248721313, 19519.707204391947, 20016.49958751032, 17537.3861914833, 17728.911355443237, 18859.52851178718, 19353.322633707823, 19384.224631014742, 4771.594414474774, 5665.688387138716, 5881.705914704269, 5887.470127688507, 5888.057910734284, 4241.36379543068, 4430.778461076933, 5780.913286300688, 5795.1017592273265, 6284.717187726564, 6635.469162466991, 6635.900461493082, 6641.535092543524, 6650.434713049397, 6653.135092437977, 6379.681015949207, 6473.058082575232, 6504.089427480157, 6512.706928188243, 6514.283428822826, 5576.86057848553, 5718.542516598662, 5754.338251101135, 5763.221965034709, 5767.480926716574, 22968.0, 23060.192893248823, 23223.767762322328, 23359.649605255934, 23515.7648423517, 2378.559966406203, 2546.681664791901, 2790.5778359148344, 3085.753139748837, 3126.8749250029973, 9776.0, 9938.850917236246, 10355.79288414235, 14060.156390616494, 14370.712585748332, 1902.915338257194, 1969.3894892583203, 1996.6306233346877, 2010.939671809848, 2013.4060452166646, 83071.0, 85958.14041859626, 86078.0, 86925.0, 87973.0, 10969.561217551369, 11099.778004439866, 11165.162612804072, 11270.21108522412, 11299.943500282447, 15805.0, 15836.683266334609, 15866.60333491672, 15869.444569440015, 15869.761953570705, 7559.622018899033, 8316.708915187939, 8423.410361274775, 8532.104129066483, 8621.09478504748, 7963.48237364581, 7975.042994840656, 8113.148119447491, 8287.668493260322, 8295.917040829514, 4700.694454860423, 4777.976110119427, 4840.661153719277, 4849.466558678542, 4925.310456536088, 1791.0775950385562, 1802.1797984036218, 1880.3418803418695, 1989.3136867780593, 2029.3100345882472, 919.3013309884536, 952.4856577448239, 960.5533426956359, 980.593053882645, 985.7338518599938, 18109.63780724378, 18268.63462730738, 19080.71378929317, 19125.808741912402, 19201.32795352156, 944.414463032924, 948.6821914658528, 977.8533220017055, 981.5533932060895, 988.9604415823286, 9968.252381071448, 10259.7435064124, 10528.578856845794, 10596.841047384296, 10670.466476676134, 461592.0, 462365.0, 464309.0, 475102.0, 477194.0, 90473.54763226274, 91345.54327228454, 91836.54081729549, 92469.53765231131, 93592.53203734074, 965.9372140810825, 986.452518852044, 995.5360482805144, 996.7906739584769, 998.3710262534702, 16142.802871253794, 16628.237492297718, 16948.40680576174, 17151.31394744246, 17327.393541225996, 40985.795071024455, 41418.0, 41742.79128604459, 42906.78546607247, 42927.785361074246, 53666.46333536615, 54690.0, 54980.72509637586, 54988.45011549993, 55994.0, 5623.8594035149445, 5848.590598658053, 8154.2253485918745, 8199.385046121684, 8863.069377715505, 12088.576899808464, 12330.260184388966, 12926.612201633967, 13046.934765326112, 13400.597982060553, 10439.164866810788, 10986.780264394827, 11162.107031437303, 11506.76986460283, 11598.94200528992, 10840.078593319657, 10976.12191024732, 11083.612073577386, 11332.886671133183, 11537.942310288396, 11058.834117488404, 11084.778304434027, 11308.264962777394, 11343.716407089558, 11536.307821530734, 8108.3513318933165, 8229.95885020571, 8236.299914507093, 8348.123447037973, 8880.0, 9042.321825863219, 11184.496697648789, 11268.887311127111, 11337.546498140311, 11359.432028398382], "value": 9192.860870796136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.1467348937615, 1513.1223890143717, 1635.6565121324522, 1733.713937200362, 1811.9456416307507, 8632.179942905423, 9294.767630809216, 9303.534823258835, 9309.72070837875, 9310.534473276342, 7920.603969801501, 8201.753947381572, 8594.312455003601, 8888.511131887744, 9063.093690630934, 2314.132200424845, 2362.1024010875844, 2363.2555744940373, 2365.148546523259, 2366.124533922451, 2319.663648770927, 2321.6865723127416, 2377.0254195779735, 2378.0250097460043, 2379.916702915398, 2345.695059642244, 2354.9411264718433, 2357.3399448154546, 2375.4536456614987, 2381.0594815048044, 2305.3660243433023, 2313.4447732544236, 2318.1654604342425, 2322.0247496051697, 2350.330155905576, 2325.837191396603, 2329.906803727849, 2330.685357476736, 2330.6970093887685, 2332.7667233276707, 8977.685780997634, 9028.954855225747, 9034.232090272335, 9050.547472626407, 9069.727908162766, 5153.304303918961, 5161.174212126042, 5330.92003619946, 5336.172893201521, 5344.438833922421, 3171.3023134910513, 3301.7193538549254, 3319.983400082984, 3357.3956687796185, 3363.9159021024425, 972.7665360313474, 1017.5065093429755, 1021.2085633633919, 1030.907218350352, 1033.101201954297, 12514.249145051235, 12586.81119783204, 12600.55898043564, 12627.747445051047, 12715.109942304043, 4535.342375355621, 4579.9084018319445, 4786.712797232177, 4791.616670666408, 4808.591269742041, 10714.142868570496, 10735.83896241557, 10738.194635402377, 10759.193060520493, 10770.24608277413, 5338.8665283367445, 5345.118055520796, 5347.224652425377, 5351.384590772111, 5360.544353729977, 4328.913421731548, 4489.079738653568, 4717.764111794397, 4822.083804077284, 4967.726775027409, 3983.362661974128, 3996.540397854226, 4075.816588253536, 4087.7956102195367, 4124.8556300529335, 1259.7480503899073, 1260.357217818919, 1262.6212136359056, 1278.0989402471234, 1286.4468278640275, 920.3741455810114, 934.63082082577, 939.4800087393468, 949.8765160529088, 981.0728861226073, 5943.881122377528, 5982.670953097621, 6052.757889684363, 6120.816375508742, 6242.968785156045, 441.69523029110456, 444.2691772035049, 444.9844255451044, 451.64545831522753, 462.5952291744723, 4194.8112334945, 4219.599138081878, 4234.682398820039, 4241.724287921275, 4242.915141697149, 11045.282056666452, 11297.152713546517, 11382.430878456209, 11399.088072954144, 11402.486888090056, 11276.267042642203, 11279.94360028211, 11283.266587671775, 11287.887121128848, 11294.0, 7789.5715735635085, 8177.345812334999, 8189.853420521132, 8425.95787021061, 8438.156184381636, 6155.47678447337, 6157.353477884937, 6298.590591611531, 6340.682965851781, 6474.579152355271, 10104.69685909424, 10351.896481035094, 10366.585336586451, 10418.218633602359, 10660.733481663021, 10603.628872989408, 10604.628837990633, 10719.624813131502, 10727.302725322828, 10740.570377185139, 7604.315611594983, 7742.574158421341, 8041.919580804351, 8152.959235203786, 8180.222878826502, 8656.220940115169, 8693.47839129629, 8708.869366959374, 8717.476951382938, 8730.912690873263, 7753.147153813189, 7908.881366779618, 7934.801629959066, 8140.226678465537, 8189.303909167787, 7244.963775181091, 7830.765077047698, 7950.165232650488, 7956.880646790419, 7964.522128672298, 6427.292997770335, 6606.174228221473, 6610.041543976, 6635.23694775107, 6646.9335306648245, 5093.108705976513, 5132.281480592795, 5153.639245252796, 5207.583393328448, 5362.919556206582, 5271.71005594696, 5279.419263881046, 5332.786688532416, 5377.059014672339, 5506.174073888948], "value": 4602.978773968476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.3858549463272, 325.30871897218407, 331.41670659639044, 331.8997523210557, 339.6654295518912, 5140.2546630738525, 5312.150055991033, 5316.973415132924, 5367.785288588457, 5393.1370980643105, 5077.822276220333, 5186.818461353853, 5216.26972223889, 5227.555657769094, 5233.712145831978, 4147.523034850986, 4152.314868046768, 4154.439150714645, 4162.604552567516, 4179.6029377209115, 3869.361555343365, 3991.560928297885, 4112.650424713888, 4171.332586786115, 4174.22776786294, 4127.09203975125, 4132.566080561543, 4132.855350062749, 4133.545310015896, 4139.19285739281, 4114.0, 4122.42286079949, 4124.175164967019, 4130.277201489742, 4152.854650087263, 3572.624874388178, 3703.518542589446, 3708.554973403182, 3713.57293911201, 3725.031491812121, 5135.0, 5154.819581314636, 5160.110338210614, 5186.913786297147, 5191.8182863599595, 4766.73782941938, 4772.451168115642, 4778.593819525345, 4809.519048095198, 4843.854684359475, 5217.660852044605, 5384.165454354542, 5386.767939236427, 5550.555955523549, 5560.36055853578, 4057.878263652095, 4066.2883995300704, 4070.7761073140964, 4078.286299897506, 4079.4900637420324, 5722.313322401338, 5737.684427356452, 5738.995675756726, 5752.453516915886, 5776.768929242825, 3958.8614398495915, 4143.627073563393, 4145.854895078658, 4183.6234738873645, 4186.958130418718, 4203.579642035833, 4211.768352740629, 4225.873223803291, 4240.957590424056, 4253.489581250208, 4765.642576806753, 4767.73777442237, 4770.833020844254, 4806.668765648657, 4819.831305904277, 5425.565954723613, 5476.274973383372, 5499.557125820843, 5644.915326270109, 5646.915296270559, 1380.0201856681867, 1407.2189934586402, 1414.971700565983, 1446.197360464952, 1446.9710605787825, 1019.4189312092185, 1046.35126221743, 1046.6493724602344, 1048.6120135549743, 1054.0776820282254, 5350.224217488442, 5375.81184658535, 5377.327834020747, 5407.486288802557, 5417.51242388187, 5452.182172674051, 5626.887462250732, 5680.261565996394, 5685.5167310778215, 5706.115552089433, 5278.392984806719, 5287.259783630295, 5297.5232229099565, 5315.441878602768, 5324.148136298174, 2612.9488351643868, 2645.682518097841, 2653.230563136669, 2669.9332516687236, 2677.451122519879, 5103.795848166106, 5474.509098360237, 5839.824805255849, 5840.970795145997, 5874.353821079678, 5796.203177015139, 5821.243238378984, 5826.48511387034, 5835.153902684087, 5847.26909136358, 5709.51469125129, 5886.234129760969, 5890.204822349014, 5928.9407105928385, 5943.227380440515, 5646.35066967304, 5662.150677398423, 5671.801486947937, 5672.886542269049, 5678.659280443187, 5561.443855614406, 5642.746076426489, 5650.3219613646625, 5655.377908429987, 5692.886142277214, 5675.7445914933105, 5822.76708931655, 5855.531557475477, 5863.472287494146, 5887.056471764118, 4060.4315395845197, 4067.349224124126, 4073.735207211522, 4078.4501889281883, 4102.282100632317, 5744.770209191585, 5751.913721294268, 5768.826935191951, 5774.595778295479, 5775.740091695968, 5346.144616861284, 5596.972015139898, 5597.5521958242425, 5611.915821262603, 5621.325440947113, 5242.501962313574, 5579.2746942897165, 5582.469665381782, 5601.663900166003, 5648.915266271091, 5318.601104917224, 5464.972675136599, 5515.097291434448, 5558.610897237317, 5571.721413929368, 5554.722263886871, 5565.888682226252, 5565.888682226252, 5575.766055687773, 5588.441155884379, 5222.74654083025, 5371.865703357291, 5432.320959880015, 5480.835574932758, 5533.916991245054], "value": 4238.127634019853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.1358526560762, 727.9708811647532, 739.2792027772922, 743.9888401673976, 768.753998720409, 13157.276349800757, 13864.23746693934, 13875.791863122036, 13894.23581703006, 13956.930215348923, 14765.261736913166, 14935.477258295961, 14936.0, 14939.701205975874, 14945.252737363142, 638.0142679560091, 676.0, 764.9617519124049, 776.3711393771049, 807.4025221336199, 811.7280710961835, 812.9918900563318, 815.7226542975387, 815.979600509989, 817.2603793566832, 848.9490630562186, 850.2985037344216, 850.9234168924795, 851.1020872979004, 851.1445996773265, 682.0, 700.870338987289, 816.9468984515987, 844.0546587821618, 848.0, 630.5271046714964, 630.5554584018256, 631.9982827218863, 632.0172132334219, 632.0519221168248, 14433.566992990121, 14461.78307325391, 14499.782503262459, 14530.854691453056, 14614.0, 13215.14101583394, 13909.0, 14083.507077252247, 14242.359093840802, 14242.572722818228, 12416.503339866395, 12681.239125652399, 12785.360731963458, 13156.934215328958, 13171.209727416386, 4360.367746676746, 4447.243968525326, 4475.619572336355, 4629.652776041777, 4644.8374306899095, 77076.0, 77487.61256193739, 80149.59925200336, 80566.59716701438, 81650.0, 10930.890691093146, 11159.163062770325, 11338.433078346216, 11754.0, 11757.529698811952, 22133.89330533467, 22190.445238868833, 22195.33413997583, 22198.445038873833, 22228.11087556512, 7889.132195458495, 8118.066422361504, 8127.0, 8196.54918979462, 8440.873386899078, 3975.602439756059, 3996.680265578747, 4048.0, 4094.6724262058965, 4117.094239267356, 3524.1718196223865, 3643.107438677488, 3644.599094099647, 3648.744587878823, 3806.2006978534264, 636.8439732265624, 657.7073202424875, 672.9966350168218, 674.9628770417675, 679.3953381490477, 693.8473535822111, 696.314130581377, 704.8836941904631, 716.9964150179215, 749.1235254751954, 8808.20726134651, 9112.681056163003, 9183.173514383738, 9355.578998945064, 9626.711198664052, 601.4166258729114, 629.6820105846518, 708.4580296073508, 740.0638192686256, 743.7248218159316, 4374.3191551804, 4498.302763071729, 4513.368128462018, 4538.52345503724, 4597.126545956257, 83148.58425707954, 123906.0, 125145.0, 132488.0, 132512.3374383141, 109445.0, 111692.44153779342, 112700.43649781862, 113863.43068284771, 114239.42880285712, 59057.40942590519, 97560.51219743855, 98101.0, 100741.49629251807, 101200.49399752954, 8205.0, 8482.830343393221, 8542.40203185771, 8611.268042216481, 8730.56347182651, 54411.45588544064, 54563.17960254968, 54991.45008550023, 55912.720436397554, 56058.439415605324, 63843.680781595795, 68349.65825170842, 69762.0, 72979.63510182415, 74016.88974665277, 12885.613431597067, 13047.0, 13149.73700525965, 13153.0, 13280.269585172908, 14037.227952462712, 14604.780928285873, 14700.632484187554, 15028.474003409829, 15359.078455292718, 13539.59381218565, 13853.3328049459, 14165.150090994573, 14273.214973176575, 14523.564293071226, 13974.79037814454, 14016.579502614937, 14213.0, 14348.0, 14402.351894164578, 12965.286909219707, 12990.220586764446, 13508.121972071784, 13608.0, 13863.722725545635, 9786.0, 9949.452780097165, 10015.449150296803, 10073.949630251802, 10243.48782560884, 11225.831612525655, 11304.717382065186, 11490.253133546294, 11551.306921584732, 11835.112366572714], "value": 7518.896674233102, "unit": "score"}], "name": "dromaeo_css", "value": 7294.332084629026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 117.0, 159.0, 120.0, 124.0, 121.0, 120.0, 156.0, 123.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0, 162.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 114.0, 76.0, 76.0, 76.0, 76.0, 97.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 83.0, 84.0, 82.0, 107.0, 83.0, 82.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 53.0, 52.0, 51.0, 53.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 79.0, 79.0, 82.0, 79.0, 80.0, 78.0, 84.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 123.0, 123.0, 132.0, 136.0, 124.0, 125.0, 162.0, 121.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 166.0, 163.0, 164.0, 167.0, 170.0, 171.0, 168.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 70.0, 65.0, 66.0, 65.0, 63.0, 75.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1487.4999999999998, "alertThreshold": 2.0}]} 21:55:32 INFO - Return code: 0 21:55:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:32 INFO - # TBPL SUCCESS # 21:55:32 INFO - Running post-action listener: _resource_record_post_action 21:55:32 INFO - [mozharness: 2016-09-29 04:55:32.071657Z] Finished run-tests step (success) 21:55:32 INFO - Running post-run listener: _resource_record_post_run 21:55:32 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 200704; Write bytes: 393682944; Read time: 112; Write time: 491200 21:55:32 INFO - TinderboxPrint: CPU usage
13.0% 21:55:32 INFO - TinderboxPrint: I/O read bytes / time
200,704 / 112 21:55:32 INFO - TinderboxPrint: I/O write bytes / time
393,682,944 / 491,200 21:55:32 INFO - TinderboxPrint: CPU idle
8,307.9 (87.0%) 21:55:32 INFO - TinderboxPrint: CPU user
1,189.0 (12.4%) 21:55:32 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105705472; Read time: 0; Write time: 172132 21:55:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 196608; Write bytes: 287977472; Read time: 92; Write time: 319068 21:55:32 INFO - Running post-run listener: _upload_blobber_files 21:55:32 INFO - Blob upload gear active. 21:55:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55: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 21:55: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'] 21:55: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 21:55:33 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:37 INFO - (blobuploader) - INFO - Done attempting. 21:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:38 INFO - (blobuploader) - INFO - Done attempting. 21:55:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:55:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:38 INFO - (blobuploader) - INFO - Done attempting. 21:55:38 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:38 INFO - Return code: 0 21:55:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b4347ee49964145a4558a09cc584cc85e9243a1ac10bd9842c323fc39b3cf233aac8ae9011c00a1cda5c27294a553e93547bc6a6cc61a13cca071b8eca333d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82214102ddba0d11001e7b2780e4096a35859f7f9ad95e99f6faeeae517ef411a782559ca86671ccf12dd7b4b567a7f0c22a369fccec235e86991db0177eb8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3bd6d49dabb81c57169148369e0ddf94b4d8790be40f3ddcf3cc53431fb7716c53fa144abe91e68345d84422b2fdcd794f1e27b31cc7b08cc630e6946228db"} 21:55:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:38 INFO - Contents: 21:55:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72b4347ee49964145a4558a09cc584cc85e9243a1ac10bd9842c323fc39b3cf233aac8ae9011c00a1cda5c27294a553e93547bc6a6cc61a13cca071b8eca333d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82214102ddba0d11001e7b2780e4096a35859f7f9ad95e99f6faeeae517ef411a782559ca86671ccf12dd7b4b567a7f0c22a369fccec235e86991db0177eb8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3bd6d49dabb81c57169148369e0ddf94b4d8790be40f3ddcf3cc53431fb7716c53fa144abe91e68345d84422b2fdcd794f1e27b31cc7b08cc630e6946228db"} 21:55:38 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:38 INFO - Copying logs to upload dir... 21:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.270505 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-28 21:55:38.794675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:55:38.800062) ========= 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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 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/72b4347ee49964145a4558a09cc584cc85e9243a1ac10bd9842c323fc39b3cf233aac8ae9011c00a1cda5c27294a553e93547bc6a6cc61a13cca071b8eca333d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82214102ddba0d11001e7b2780e4096a35859f7f9ad95e99f6faeeae517ef411a782559ca86671ccf12dd7b4b567a7f0c22a369fccec235e86991db0177eb8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3bd6d49dabb81c57169148369e0ddf94b4d8790be40f3ddcf3cc53431fb7716c53fa144abe91e68345d84422b2fdcd794f1e27b31cc7b08cc630e6946228db"} build_url:https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/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/72b4347ee49964145a4558a09cc584cc85e9243a1ac10bd9842c323fc39b3cf233aac8ae9011c00a1cda5c27294a553e93547bc6a6cc61a13cca071b8eca333d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82214102ddba0d11001e7b2780e4096a35859f7f9ad95e99f6faeeae517ef411a782559ca86671ccf12dd7b4b567a7f0c22a369fccec235e86991db0177eb8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3bd6d49dabb81c57169148369e0ddf94b4d8790be40f3ddcf3cc53431fb7716c53fa144abe91e68345d84422b2fdcd794f1e27b31cc7b08cc630e6946228db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:55:38.825506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:55:38.825858) ========= 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=fa44defc139c4ba8574fe040000001db-1475123695.799706-1882221851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:55:38.910386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:55:38.910724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:55:38.911030) ========= ========= Total master_lag: 0.16 =========