builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1475038324.76 results: success (0) buildid: 20160927201220 builduid: a6481579eed7486fb587fcf830ac162b revision: 67109e311e4c1e899eea01a5568af882ba9decc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:04.760522) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:04.761119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:04.761389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:04.951494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:04.954782) ========= 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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 21:52:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-09-27 21:52:05 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122228 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:05.103282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:05.103559) ========= 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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:05.154996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 21:52:05.155336) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 67109e311e4c1e899eea01a5568af882ba9decc9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 67109e311e4c1e899eea01a5568af882ba9decc9 --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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 21:52:05,437 truncating revision to first 12 chars 2016-09-27 21:52:05,437 Setting DEBUG logging. 2016-09-27 21:52:05,437 attempt 1/10 2016-09-27 21:52:05,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/67109e311e4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 21:52:06,422 unpacking tar archive at: autoland-67109e311e4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 21:52:06.490412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:06.490742) ========= script_repo_revision: 67109e311e4c1e899eea01a5568af882ba9decc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:06.491144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:06.491485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 21:52:06.502524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-27 21:52:06.503271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:52:06 INFO - MultiFileLogger online at 20160927 21:52:06 in /builds/slave/test 21:52:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 21:52:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:52:06 INFO - {'append_to_log': False, 21:52:06 INFO - 'base_work_dir': '/builds/slave/test', 21:52:06 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:52:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:52:06 INFO - 'branch': 'Autoland-Non-PGO', 21:52:06 INFO - 'buildbot_json_path': 'buildprops.json', 21:52:06 INFO - 'config_files': ('talos/linux_config.py',), 21:52:06 INFO - 'default_actions': ('clobber', 21:52:06 INFO - 'read-buildbot-config', 21:52:06 INFO - 'download-and-extract', 21:52:06 INFO - 'populate-webroot', 21:52:06 INFO - 'create-virtualenv', 21:52:06 INFO - 'install', 21:52:06 INFO - 'run-tests'), 21:52:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:52:06 INFO - 'download_minidump_stackwalk': True, 21:52:06 INFO - 'download_symbols': 'ondemand', 21:52:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:52:06 INFO - 'tooltool.py': '/tools/tooltool.py', 21:52:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:52:06 INFO - '/tools/misc-python/virtualenv.py')}, 21:52:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:52:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:52:06 INFO - 'installer_path': 'installer.exe', 21:52:06 INFO - 'log_level': 'info', 21:52:06 INFO - 'log_name': 'talos', 21:52:06 INFO - 'log_to_console': True, 21:52:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:52:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:52:06 INFO - 'opt_config_files': (), 21:52:06 INFO - 'pip_index': False, 21:52:06 INFO - 'sps_profile': False, 21:52:06 INFO - 'sps_profile_interval': 0, 21:52:06 INFO - 'suite': 'dromaeojs-e10s', 21:52:06 INFO - 'system_bits': '32', 21:52:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:52:06 INFO - 'title': 'talos-linux64-ix-048', 21:52:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:52:06 INFO - 'use_talos_json': True, 21:52:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:52:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:52:06 INFO - 'work_dir': 'build'} 21:52:06 INFO - [mozharness: 2016-09-28 04:52:06.882116Z] Running clobber step. 21:52:06 INFO - Running pre-action listener: _resource_record_pre_action 21:52:06 INFO - Running main action method: clobber 21:52:06 INFO - rmtree: /builds/slave/test/build 21:52:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:52:07 INFO - Running post-action listener: _resource_record_post_action 21:52:07 INFO - [mozharness: 2016-09-28 04:52:07.340171Z] Finished clobber step (success) 21:52:07 INFO - [mozharness: 2016-09-28 04:52:07.340271Z] Running read-buildbot-config step. 21:52:07 INFO - Running pre-action listener: _resource_record_pre_action 21:52:07 INFO - Running main action method: read_buildbot_config 21:52:07 INFO - Using buildbot properties: 21:52:07 INFO - { 21:52:07 INFO - "project": "", 21:52:07 INFO - "product": "firefox", 21:52:07 INFO - "script_repo_revision": "production", 21:52:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:52:07 INFO - "repository": "", 21:52:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 21:52:07 INFO - "buildid": "20160927201220", 21:52:07 INFO - "pgo_build": "False", 21:52:07 INFO - "basedir": "/builds/slave/test", 21:52:07 INFO - "buildnumber": 471, 21:52:07 INFO - "slavename": "talos-linux64-ix-048", 21:52:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:52:07 INFO - "platform": "ubuntu64_hw", 21:52:07 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 21:52:07 INFO - "branch": "autoland", 21:52:07 INFO - "repo_path": "integration/autoland", 21:52:07 INFO - "revision": "67109e311e4c1e899eea01a5568af882ba9decc9", 21:52:07 INFO - "stage_platform": "linux64", 21:52:07 INFO - "builduid": "a6481579eed7486fb587fcf830ac162b", 21:52:07 INFO - "slavebuilddir": "test" 21:52:07 INFO - } 21:52:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:52:07 INFO - Running post-action listener: _resource_record_post_action 21:52:07 INFO - [mozharness: 2016-09-28 04:52:07.342776Z] Finished read-buildbot-config step (success) 21:52:07 INFO - [mozharness: 2016-09-28 04:52:07.342862Z] Running download-and-extract step. 21:52:07 INFO - Running pre-action listener: _resource_record_pre_action 21:52:07 INFO - Running main action method: download_and_extract 21:52:07 INFO - mkdir: /builds/slave/test/build/tests 21:52:07 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:52:07 INFO - trying https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:52:07 INFO - Downloading https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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:52:07 INFO - Downloaded 1361 bytes. 21:52:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:52:07 INFO - Using the following test package requirements: 21:52:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:52:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:52:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'jsshell-linux-x86_64.zip'], 21:52:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:52:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:52:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:52:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:52:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:52:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:52:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:52:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:52:07 INFO - Fetch https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:52:08 INFO - Expected file size: 20413451 21:52:08 INFO - Content-Encoding None 21:52:08 INFO - Content-Type application/zip 21:52:08 INFO - Http code 200 21:52:12 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:52:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:52:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:52:12 INFO - Fetch https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:52:13 INFO - Expected file size: 20413451 21:52:13 INFO - Content-Encoding None 21:52:13 INFO - Content-Type application/zip 21:52:13 INFO - Http code 200 21:52:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:52:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:52:18 INFO - Expected file size: 14414057 21:52:18 INFO - Content-Encoding None 21:52:18 INFO - Content-Type application/zip 21:52:18 INFO - Http code 200 21:52:19 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:52:19 INFO - trying https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:52:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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:52:20 INFO - Downloaded 55734655 bytes. 21:52:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:52:20 INFO - mkdir: /builds/slave/test/properties 21:52:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:52:20 INFO - Writing to file /builds/slave/test/properties/build_url 21:52:20 INFO - Contents: 21:52:20 INFO - build_url:https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:52:20 INFO - Running post-action listener: _resource_record_post_action 21:52:20 INFO - Running post-action listener: set_extra_try_arguments 21:52:20 INFO - [mozharness: 2016-09-28 04:52:20.814496Z] Finished download-and-extract step (success) 21:52:20 INFO - [mozharness: 2016-09-28 04:52:20.814722Z] Running populate-webroot step. 21:52:20 INFO - Running pre-action listener: _resource_record_pre_action 21:52:20 INFO - Running main action method: populate_webroot 21:52:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:52:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:52:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:52:20 INFO - '--tppagecycles', 21:52:20 INFO - '7'], 21:52:20 INFO - 'tests': ['tsvgm']}}, 21:52:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:52:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:52:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:52:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:52:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['damp', 'tps']}, 21:52:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'tests': ['damp', 'tps']}, 21:52:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['dromaeo_dom']}, 21:52:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:52:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['basic_compositor_video']}, 21:52:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:52:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'other-e10s': {'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['a11yr', 21:52:20 INFO - 'ts_paint', 21:52:20 INFO - 'tpaint', 21:52:20 INFO - 'sessionrestore', 21:52:20 INFO - 'sessionrestore_no_auto_restore', 21:52:20 INFO - 'tabpaint']}, 21:52:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['tsvgx', 21:52:20 INFO - 'tsvgr_opacity', 21:52:20 INFO - 'tart', 21:52:20 INFO - 'tscrollx', 21:52:20 INFO - 'cart']}, 21:52:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:52:20 INFO - 'tsvgr_opacity', 21:52:20 INFO - 'tart', 21:52:20 INFO - 'tscrollx', 21:52:20 INFO - 'cart']}, 21:52:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'talos_options': ['--disable-e10s'], 21:52:20 INFO - 'tests': ['tp5o']}, 21:52:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'tests': ['tp5o']}, 21:52:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'talos_options': ['--disable-e10s', 21:52:20 INFO - '--xperf_path', 21:52:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:20 INFO - 'tests': ['tp5n']}, 21:52:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:20 INFO - 'talos_options': ['--xperf_path', 21:52:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:20 INFO - 'tests': ['tp5n']}}, 21:52:20 INFO - 'talos.zip': {'path': '', 21:52:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:52:20 INFO - Running post-action listener: _resource_record_post_action 21:52:20 INFO - [mozharness: 2016-09-28 04:52:20.832611Z] Finished populate-webroot step (success) 21:52:20 INFO - [mozharness: 2016-09-28 04:52:20.832698Z] Running create-virtualenv step. 21:52:20 INFO - Running pre-action listener: _resource_record_pre_action 21:52:20 INFO - Running main action method: create_virtualenv 21:52:20 INFO - Creating virtualenv /builds/slave/test/build/venv 21:52:20 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:52:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:52:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:52:20 INFO - Using real prefix '/usr' 21:52:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:52:21 INFO - Installing distribute.............................................................................................................................................................................................done. 21:52:23 INFO - Installing pip.................done. 21:52:23 INFO - Return code: 0 21:52:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:52:23 INFO - Reading from file tmpfile_stdout 21:52:23 INFO - Output received: 21:52:23 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:52:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:52: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:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52: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', 'pip>=1.5'] in /builds/slave/test/build 21:52: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 pip>=1.5 21:52:23 INFO - Using env: {'DISPLAY': ':0', 21:52:23 INFO - 'HOME': '/home/cltbld', 21:52:23 INFO - 'LANG': 'en_US.UTF-8', 21:52:23 INFO - 'LANGUAGE': 'en_US:en', 21:52:23 INFO - 'LOGNAME': 'cltbld', 21:52:23 INFO - 'MAIL': '/var/mail/cltbld', 21:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:23 INFO - 'MOZ_NO_REMOTE': '1', 21:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:23 INFO - 'NO_EM_RESTART': '1', 21:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:23 INFO - 'PWD': '/builds/slave/test', 21:52:23 INFO - 'SHELL': '/bin/bash', 21:52:23 INFO - 'SHLVL': '1', 21:52:23 INFO - 'TERM': 'linux', 21:52:23 INFO - 'TMOUT': '86400', 21:52:23 INFO - 'USER': 'cltbld', 21:52:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:23 INFO - '_': '/tools/buildbot/bin/python'} 21:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:23 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:52:23 INFO - Cleaning up... 21:52:23 INFO - Return code: 0 21:52:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:52: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:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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', '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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:52: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 psutil>=3.1.1 21:52:23 INFO - Using env: {'DISPLAY': ':0', 21:52:23 INFO - 'HOME': '/home/cltbld', 21:52:23 INFO - 'LANG': 'en_US.UTF-8', 21:52:23 INFO - 'LANGUAGE': 'en_US:en', 21:52:23 INFO - 'LOGNAME': 'cltbld', 21:52:23 INFO - 'MAIL': '/var/mail/cltbld', 21:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:23 INFO - 'MOZ_NO_REMOTE': '1', 21:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:23 INFO - 'NO_EM_RESTART': '1', 21:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:23 INFO - 'PWD': '/builds/slave/test', 21:52:23 INFO - 'SHELL': '/bin/bash', 21:52:23 INFO - 'SHLVL': '1', 21:52:23 INFO - 'TERM': 'linux', 21:52:23 INFO - 'TMOUT': '86400', 21:52:23 INFO - 'USER': 'cltbld', 21:52:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:23 INFO - '_': '/tools/buildbot/bin/python'} 21:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:24 INFO - Downloading/unpacking psutil>=3.1.1 21:52:24 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:52:24 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:52:24 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:52:24 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:52:24 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:52:24 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:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:52:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:26 INFO - Installing collected packages: psutil 21:52:26 INFO - Running setup.py install for psutil 21:52:26 INFO - building 'psutil._psutil_linux' extension 21:52:26 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:52:26 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:52:26 INFO - building 'psutil._psutil_posix' extension 21:52:26 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:52:26 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:52:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:26 INFO - Successfully installed psutil 21:52:26 INFO - Cleaning up... 21:52:26 INFO - Return code: 0 21:52:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:26 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:26 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:52:26 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:52:26 INFO - Using env: {'DISPLAY': ':0', 21:52:26 INFO - 'HOME': '/home/cltbld', 21:52:26 INFO - 'LANG': 'en_US.UTF-8', 21:52:26 INFO - 'LANGUAGE': 'en_US:en', 21:52:26 INFO - 'LOGNAME': 'cltbld', 21:52:26 INFO - 'MAIL': '/var/mail/cltbld', 21:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:26 INFO - 'MOZ_NO_REMOTE': '1', 21:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:26 INFO - 'NO_EM_RESTART': '1', 21:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:26 INFO - 'PWD': '/builds/slave/test', 21:52:26 INFO - 'SHELL': '/bin/bash', 21:52:26 INFO - 'SHLVL': '1', 21:52:26 INFO - 'TERM': 'linux', 21:52:26 INFO - 'TMOUT': '86400', 21:52:26 INFO - 'USER': 'cltbld', 21:52:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:26 INFO - '_': '/tools/buildbot/bin/python'} 21:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:52: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:52: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:52: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:52: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:52: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:52: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:52:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:52:28 INFO - Installing collected packages: mozsystemmonitor 21:52:28 INFO - Running setup.py install for mozsystemmonitor 21:52:28 INFO - Successfully installed mozsystemmonitor 21:52:28 INFO - Cleaning up... 21:52:28 INFO - Return code: 0 21:52:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:28 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:28 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:52:28 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:52:28 INFO - Using env: {'DISPLAY': ':0', 21:52:28 INFO - 'HOME': '/home/cltbld', 21:52:28 INFO - 'LANG': 'en_US.UTF-8', 21:52:28 INFO - 'LANGUAGE': 'en_US:en', 21:52:28 INFO - 'LOGNAME': 'cltbld', 21:52:28 INFO - 'MAIL': '/var/mail/cltbld', 21:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:28 INFO - 'MOZ_NO_REMOTE': '1', 21:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:28 INFO - 'NO_EM_RESTART': '1', 21:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:28 INFO - 'PWD': '/builds/slave/test', 21:52:28 INFO - 'SHELL': '/bin/bash', 21:52:28 INFO - 'SHLVL': '1', 21:52:28 INFO - 'TERM': 'linux', 21:52:28 INFO - 'TMOUT': '86400', 21:52:28 INFO - 'USER': 'cltbld', 21:52:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:28 INFO - '_': '/tools/buildbot/bin/python'} 21:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:29 INFO - Downloading/unpacking jsonschema==2.5.1 21:52:29 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:52:29 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:52:29 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:52:29 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:52:29 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:52:29 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:52:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:52:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:31 INFO - Downloading functools32-3.2.3-2.tar.gz 21:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:52:31 INFO - warning: no files found matching '*.txt' 21:52:31 INFO - no previously-included directories found matching 'build' 21:52:31 INFO - no previously-included directories found matching 'dist' 21:52:31 INFO - no previously-included directories found matching '.git*' 21:52:31 INFO - Installing collected packages: jsonschema, functools32 21:52:31 INFO - Running setup.py install for functools32 21:52:31 INFO - warning: no files found matching '*.txt' 21:52:31 INFO - no previously-included directories found matching 'build' 21:52:31 INFO - no previously-included directories found matching 'dist' 21:52:31 INFO - no previously-included directories found matching '.git*' 21:52:31 INFO - Successfully installed jsonschema functools32 21:52:31 INFO - Cleaning up... 21:52:31 INFO - Return code: 0 21:52:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:52:31 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:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:31 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:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:31 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:31 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:52:31 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:52:31 INFO - Using env: {'DISPLAY': ':0', 21:52:31 INFO - 'HOME': '/home/cltbld', 21:52:31 INFO - 'LANG': 'en_US.UTF-8', 21:52:31 INFO - 'LANGUAGE': 'en_US:en', 21:52:31 INFO - 'LOGNAME': 'cltbld', 21:52:31 INFO - 'MAIL': '/var/mail/cltbld', 21:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:31 INFO - 'MOZ_NO_REMOTE': '1', 21:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:31 INFO - 'NO_EM_RESTART': '1', 21:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:31 INFO - 'PWD': '/builds/slave/test', 21:52:31 INFO - 'SHELL': '/bin/bash', 21:52:31 INFO - 'SHLVL': '1', 21:52:31 INFO - 'TERM': 'linux', 21:52:31 INFO - 'TMOUT': '86400', 21:52:31 INFO - 'USER': 'cltbld', 21:52:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:31 INFO - '_': '/tools/buildbot/bin/python'} 21:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:52:31 INFO - Cleaning up... 21:52:31 INFO - Return code: 0 21:52:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:52:31 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:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:31 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:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:31 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:31 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:52:31 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:52:31 INFO - Using env: {'DISPLAY': ':0', 21:52:31 INFO - 'HOME': '/home/cltbld', 21:52:31 INFO - 'LANG': 'en_US.UTF-8', 21:52:31 INFO - 'LANGUAGE': 'en_US:en', 21:52:31 INFO - 'LOGNAME': 'cltbld', 21:52:31 INFO - 'MAIL': '/var/mail/cltbld', 21:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:31 INFO - 'MOZ_NO_REMOTE': '1', 21:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:31 INFO - 'NO_EM_RESTART': '1', 21:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:31 INFO - 'PWD': '/builds/slave/test', 21:52:31 INFO - 'SHELL': '/bin/bash', 21:52:31 INFO - 'SHLVL': '1', 21:52:31 INFO - 'TERM': 'linux', 21:52:31 INFO - 'TMOUT': '86400', 21:52:31 INFO - 'USER': 'cltbld', 21:52:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:31 INFO - '_': '/tools/buildbot/bin/python'} 21:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:31 INFO - Downloading/unpacking blobuploader==1.2.4 21:52: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:52: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:52: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:52: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:52: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:52: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:52:33 INFO - Downloading blobuploader-1.2.4.tar.gz 21:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:52:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:52:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:52:34 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:52:34 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:52:34 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:52:34 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:52:34 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:52:34 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:52:34 INFO - Downloading docopt-0.6.1.tar.gz 21:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:52:34 INFO - Installing collected packages: blobuploader, requests, docopt 21:52:34 INFO - Running setup.py install for blobuploader 21:52:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:52:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:52:34 INFO - Running setup.py install for requests 21:52:34 INFO - Running setup.py install for docopt 21:52:35 INFO - Successfully installed blobuploader requests docopt 21:52:35 INFO - Cleaning up... 21:52:35 INFO - Return code: 0 21:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:52:35 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:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:35 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:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:35 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:35 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:52:35 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:52:35 INFO - Using env: {'DISPLAY': ':0', 21:52:35 INFO - 'HOME': '/home/cltbld', 21:52:35 INFO - 'LANG': 'en_US.UTF-8', 21:52:35 INFO - 'LANGUAGE': 'en_US:en', 21:52:35 INFO - 'LOGNAME': 'cltbld', 21:52:35 INFO - 'MAIL': '/var/mail/cltbld', 21:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:35 INFO - 'MOZ_NO_REMOTE': '1', 21:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:35 INFO - 'NO_EM_RESTART': '1', 21:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:35 INFO - 'PWD': '/builds/slave/test', 21:52:35 INFO - 'SHELL': '/bin/bash', 21:52:35 INFO - 'SHLVL': '1', 21:52:35 INFO - 'TERM': 'linux', 21:52:35 INFO - 'TMOUT': '86400', 21:52:35 INFO - 'USER': 'cltbld', 21:52:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:35 INFO - '_': '/tools/buildbot/bin/python'} 21:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:52:35 INFO - Running setup.py (path:/tmp/pip-58OsPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:52:35 INFO - Running setup.py (path:/tmp/pip-rfQhKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:52:35 INFO - Running setup.py (path:/tmp/pip-H0Sgel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:52:35 INFO - Running setup.py (path:/tmp/pip-yE5VPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:52:35 INFO - Running setup.py (path:/tmp/pip-SbQJVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:52:35 INFO - Running setup.py (path:/tmp/pip-FaLkhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:52:35 INFO - Running setup.py (path:/tmp/pip-q_eSA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:52:35 INFO - Running setup.py (path:/tmp/pip-xfFzve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:52:35 INFO - Running setup.py (path:/tmp/pip-O7LZBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:52:35 INFO - Running setup.py (path:/tmp/pip-adHJyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:52:36 INFO - Running setup.py (path:/tmp/pip-zVf0DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:52:36 INFO - Running setup.py (path:/tmp/pip-qU6ncQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:52:36 INFO - Running setup.py (path:/tmp/pip-Zwjq3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:52:36 INFO - Running setup.py (path:/tmp/pip-Wkzbuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:36 INFO - Running setup.py (path:/tmp/pip-stToLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:52:36 INFO - Running setup.py (path:/tmp/pip-FqutQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:52:36 INFO - Running setup.py (path:/tmp/pip-0B2wvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:52:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:52:36 INFO - Running setup.py install for manifestparser 21:52:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:52:36 INFO - Running setup.py install for mozcrash 21:52:36 INFO - Running setup.py install for mozdebug 21:52:36 INFO - Running setup.py install for mozdevice 21:52:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:52:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:52:36 INFO - Running setup.py install for mozfile 21:52:37 INFO - Running setup.py install for mozhttpd 21:52:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for mozinfo 21:52:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for mozInstall 21:52:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for mozleak 21:52:37 INFO - Running setup.py install for mozlog 21:52:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for moznetwork 21:52:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for mozprocess 21:52:37 INFO - Running setup.py install for mozprofile 21:52:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:52:37 INFO - Running setup.py install for mozrunner 21:52:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:52:38 INFO - Running setup.py install for mozscreenshot 21:52:38 INFO - Running setup.py install for moztest 21:52:38 INFO - Running setup.py install for mozversion 21:52:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:52:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:52:38 INFO - Cleaning up... 21:52:38 INFO - Return code: 0 21:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:38 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:38 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:52:38 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:52:38 INFO - Using env: {'DISPLAY': ':0', 21:52:38 INFO - 'HOME': '/home/cltbld', 21:52:38 INFO - 'LANG': 'en_US.UTF-8', 21:52:38 INFO - 'LANGUAGE': 'en_US:en', 21:52:38 INFO - 'LOGNAME': 'cltbld', 21:52:38 INFO - 'MAIL': '/var/mail/cltbld', 21:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:38 INFO - 'MOZ_NO_REMOTE': '1', 21:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:38 INFO - 'NO_EM_RESTART': '1', 21:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:38 INFO - 'PWD': '/builds/slave/test', 21:52:38 INFO - 'SHELL': '/bin/bash', 21:52:38 INFO - 'SHLVL': '1', 21:52:38 INFO - 'TERM': 'linux', 21:52:38 INFO - 'TMOUT': '86400', 21:52:38 INFO - 'USER': 'cltbld', 21:52:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:38 INFO - '_': '/tools/buildbot/bin/python'} 21:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:52:38 INFO - Running setup.py (path:/tmp/pip-cS2_J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:52:38 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:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:52:38 INFO - Running setup.py (path:/tmp/pip-L6xYFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:52:38 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:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:52:38 INFO - Running setup.py (path:/tmp/pip-AxcGOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:52:38 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:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:52:38 INFO - Running setup.py (path:/tmp/pip-cmKg6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:52:38 INFO - Running setup.py (path:/tmp/pip-lDPdUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:52:38 INFO - Running setup.py (path:/tmp/pip-Quf83o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:52:39 INFO - Running setup.py (path:/tmp/pip-WkLSt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:52:39 INFO - Running setup.py (path:/tmp/pip-TU8Rls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:52:39 INFO - Running setup.py (path:/tmp/pip-enFIbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:52:39 INFO - Running setup.py (path:/tmp/pip-FEzil7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:52:39 INFO - Running setup.py (path:/tmp/pip-gz2Thq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:52:39 INFO - Running setup.py (path:/tmp/pip-D0CgDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:52:39 INFO - Running setup.py (path:/tmp/pip-sChejZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:52:39 INFO - Running setup.py (path:/tmp/pip-Yi5i2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:39 INFO - Running setup.py (path:/tmp/pip-4mKcdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:52:39 INFO - Running setup.py (path:/tmp/pip-a5SBrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:52:39 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:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:52:39 INFO - Running setup.py (path:/tmp/pip-uZNK6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:41 INFO - Downloading blessings-1.6.tar.gz 21:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:52:41 INFO - Installing collected packages: blessings 21:52:41 INFO - Running setup.py install for blessings 21:52:41 INFO - Successfully installed blessings 21:52:41 INFO - Cleaning up... 21:52:41 INFO - Return code: 0 21:52:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:52:42 INFO - Reading from file tmpfile_stdout 21:52:42 INFO - Current package versions: 21:52:42 INFO - argparse == 1.2.1 21:52:42 INFO - blessings == 1.6 21:52:42 INFO - blobuploader == 1.2.4 21:52:42 INFO - docopt == 0.6.1 21:52:42 INFO - functools32 == 3.2.3-2 21:52:42 INFO - jsonschema == 2.5.1 21:52:42 INFO - manifestparser == 1.1 21:52:42 INFO - mozInstall == 1.12 21:52:42 INFO - mozcrash == 0.17 21:52:42 INFO - mozdebug == 0.1 21:52:42 INFO - mozdevice == 0.48 21:52:42 INFO - mozfile == 1.2 21:52:42 INFO - mozhttpd == 0.7 21:52:42 INFO - mozinfo == 0.9 21:52:42 INFO - mozleak == 0.1 21:52:42 INFO - mozlog == 3.4 21:52:42 INFO - moznetwork == 0.27 21:52:42 INFO - mozprocess == 0.23 21:52:42 INFO - mozprofile == 0.28 21:52:42 INFO - mozrunner == 6.12 21:52:42 INFO - mozscreenshot == 0.1 21:52:42 INFO - mozsystemmonitor == 0.3 21:52:42 INFO - moztest == 0.7 21:52:42 INFO - mozversion == 1.4 21:52:42 INFO - psutil == 3.1.1 21:52:42 INFO - requests == 1.2.3 21:52:42 INFO - wsgiref == 0.1.2 21:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:42 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 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:42 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:52:42 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:52:42 INFO - Using env: {'DISPLAY': ':0', 21:52:42 INFO - 'HOME': '/home/cltbld', 21:52:42 INFO - 'LANG': 'en_US.UTF-8', 21:52:42 INFO - 'LANGUAGE': 'en_US:en', 21:52:42 INFO - 'LOGNAME': 'cltbld', 21:52:42 INFO - 'MAIL': '/var/mail/cltbld', 21:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:42 INFO - 'MOZ_NO_REMOTE': '1', 21:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:42 INFO - 'NO_EM_RESTART': '1', 21:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:42 INFO - 'PWD': '/builds/slave/test', 21:52:42 INFO - 'SHELL': '/bin/bash', 21:52:42 INFO - 'SHLVL': '1', 21:52:42 INFO - 'TERM': 'linux', 21:52:42 INFO - 'TMOUT': '86400', 21:52:42 INFO - 'USER': 'cltbld', 21:52:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:42 INFO - '_': '/tools/buildbot/bin/python'} 21:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 INFO - Cleaning up... 21:52:42 INFO - Return code: 0 21:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fd3bdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, '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-1475037675.784839-285673979', '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:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:52:42 INFO - Using env: {'DISPLAY': ':0', 21:52:42 INFO - 'HOME': '/home/cltbld', 21:52:42 INFO - 'LANG': 'en_US.UTF-8', 21:52:42 INFO - 'LANGUAGE': 'en_US:en', 21:52:42 INFO - 'LOGNAME': 'cltbld', 21:52:42 INFO - 'MAIL': '/var/mail/cltbld', 21:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:42 INFO - 'MOZ_NO_REMOTE': '1', 21:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:42 INFO - 'NO_EM_RESTART': '1', 21:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:42 INFO - 'PWD': '/builds/slave/test', 21:52:42 INFO - 'SHELL': '/bin/bash', 21:52:42 INFO - 'SHLVL': '1', 21:52:42 INFO - 'TERM': 'linux', 21:52:42 INFO - 'TMOUT': '86400', 21:52:42 INFO - 'USER': 'cltbld', 21:52:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:42 INFO - '_': '/tools/buildbot/bin/python'} 21:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:52:42 INFO - Cleaning up... 21:52:42 INFO - Return code: 0 21:52:42 INFO - Running post-action listener: _resource_record_post_action 21:52:42 INFO - Running post-action listener: _start_resource_monitoring 21:52:42 INFO - Starting resource monitoring. 21:52:42 INFO - [mozharness: 2016-09-28 04:52:42.681139Z] Finished create-virtualenv step (success) 21:52:42 INFO - [mozharness: 2016-09-28 04:52:42.681634Z] Running install step. 21:52:42 INFO - Running pre-action listener: _resource_record_pre_action 21:52:42 INFO - Running main action method: install 21:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:52:42 INFO - Reading from file tmpfile_stdout 21:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:52:42 INFO - Reading from file tmpfile_stdout 21:52:42 INFO - Output received: 21:52:42 INFO - Usage: mozinstall [options] installer 21:52:42 INFO - Options: 21:52:42 INFO - -h, --help show this help message and exit 21:52:42 INFO - -d DEST, --destination=DEST 21:52:42 INFO - Directory to install application into. [default: 21:52:42 INFO - "/builds/slave/test"] 21:52:42 INFO - --app=APP Application being installed. [default: firefox] 21:52:42 INFO - mkdir: /builds/slave/test/build/application 21:52:42 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:52:42 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:52:59 INFO - Reading from file tmpfile_stdout 21:52:59 INFO - Output received: 21:52:59 INFO - /builds/slave/test/build/application/firefox/firefox 21:52:59 INFO - Running post-action listener: _resource_record_post_action 21:52:59 INFO - [mozharness: 2016-09-28 04:52:59.065576Z] Finished install step (success) 21:52:59 INFO - [mozharness: 2016-09-28 04:52:59.065821Z] Running run-tests step. 21:52:59 INFO - Running pre-action listener: _resource_record_pre_action 21:52:59 INFO - Running main action method: run_tests 21:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:52:59 INFO - Python 2.7.3 21:52:59 INFO - Return code: 0 21:52:59 INFO - grabbing minidump binary from tooltool 21:52: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:52:59 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 0x1c56f60>, '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 0x1c57d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c581d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:52:59 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:52:59 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:52:59 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:52:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:52:59 INFO - Return code: 0 21:52:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:52:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:52:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:52:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:52:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:52:59 INFO - Using env: {'DISPLAY': ':0', 21:52:59 INFO - 'HOME': '/home/cltbld', 21:52:59 INFO - 'LANG': 'en_US.UTF-8', 21:52:59 INFO - 'LANGUAGE': 'en_US:en', 21:52:59 INFO - 'LOGNAME': 'cltbld', 21:52:59 INFO - 'MAIL': '/var/mail/cltbld', 21:52:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:52:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:59 INFO - 'MOZ_NO_REMOTE': '1', 21:52:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:59 INFO - 'NO_EM_RESTART': '1', 21:52:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:59 INFO - 'PWD': '/builds/slave/test', 21:52:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:52:59 INFO - 'SHELL': '/bin/bash', 21:52:59 INFO - 'SHLVL': '1', 21:52:59 INFO - 'TERM': 'linux', 21:52:59 INFO - 'TMOUT': '86400', 21:52:59 INFO - 'USER': 'cltbld', 21:52:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475037675.784839-285673979', 21:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:59 INFO - '_': '/tools/buildbot/bin/python'} 21:52:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:52:59 INFO - mozversion application_buildid: 20160927201220 21:52:59 INFO - mozversion application_changeset: 67109e311e4c1e899eea01a5568af882ba9decc9 21:52:59 INFO - mozversion application_display_name: Nightly 21:52:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:52:59 INFO - mozversion application_name: Firefox 21:52:59 INFO - mozversion application_remotingname: firefox 21:52:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:52:59 INFO - mozversion application_vendor: Mozilla 21:52:59 INFO - mozversion application_version: 52.0a1 21:52:59 INFO - mozversion platform_buildid: 20160927201220 21:52:59 INFO - mozversion platform_changeset: 67109e311e4c1e899eea01a5568af882ba9decc9 21:52:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:52:59 INFO - mozversion platform_version: 52.0a1 21:52:59 INFO - using testdate: 1475038379 21:52:59 INFO - actual date: 1475038379 21:52:59 INFO - starting webserver on 'localhost:34924' 21:52:59 INFO - SUITE-START | Running 2 tests 21:52:59 INFO - TEST-START | dromaeo_css 21:52:59 INFO - operating with platform_type : linux_ 21:52:59 INFO - Initialising browser for dromaeo_css test... 21:52:59 INFO - TEST-INFO | started process 2360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWkMbY/profile http://localhost:34924/getInfo.html) 21:53:04 INFO - PROCESS | 2360 | __metrics Screen width/height:1600/1200 21:53:04 INFO - PROCESS | 2360 | colorDepth:24 21:53:04 INFO - PROCESS | 2360 | Browser inner width/height: 1024/697 21:53:04 INFO - PROCESS | 2360 | __metrics 21:53:05 ERROR - PROCESS | 2360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 21:53:06 INFO - TEST-INFO | 2360: exit 0 21:53:06 INFO - Browser initialized. 21:53:06 INFO - Running cycle 1/1 for dromaeo_css test... 21:53:06 INFO - TEST-INFO | started process 2576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWkMbY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:18 INFO - PROCESS | 2576 | RSS: Main: 186216448 21:53:18 INFO - PROCESS | 2576 | 21:54:08 INFO - PROCESS | 2576 | 1475038448304 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:56:21 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34924/tests/dromaeo/cssquery-ext.html) 21:56:22 INFO - PROCESS | 2576 | RSS: Main: 198103040 21:56:22 INFO - PROCESS | 2576 | 21:59:24 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-ext.html (next: http://localhost:34924/tests/dromaeo/cssquery-jquery.html) 21:59:25 INFO - PROCESS | 2576 | RSS: Main: 200142848 21:59:25 INFO - PROCESS | 2576 | 22:02:27 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34924/tests/dromaeo/cssquery-mootools.html) 22:02:28 INFO - PROCESS | 2576 | RSS: Main: 198852608 22:02:28 INFO - PROCESS | 2576 | 22:05:30 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34924/tests/dromaeo/cssquery-prototype.html) 22:05:30 INFO - PROCESS | 2576 | RSS: Main: 195272704 22:05:30 INFO - PROCESS | 2576 | 22:08:33 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34924/tests/dromaeo/cssquery-yui.html) 22:08:34 INFO - PROCESS | 2576 | RSS: Main: 198676480 22:08:34 INFO - PROCESS | 2576 | 22:11:36 INFO - PROCESS | 2576 | Cycle 1(1): loaded http://localhost:34924/tests/dromaeo/cssquery-yui.html (next: http://localhost:34924/tests/dromaeo/cssquery-dojo.html) 22:11:37 INFO - PROCESS | 2576 | RSS: Main: 199786496 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | __start_tp_report 22:11:37 INFO - PROCESS | 2576 | _x_x_mozilla_page_load 22:11:37 INFO - PROCESS | 2576 | _x_x_mozilla_page_load_details 22:11:37 INFO - PROCESS | 2576 | |i|pagename|runs| 22:11:37 INFO - PROCESS | 2576 | |0;dojo.html;2641.709411964685;2653.8540380279087;2656.375751698352;2679.1962411276613;2682.5841994490847;4771.713697178172;4813.90372192556;4842.370491836061;4843.5882949949255;4870.147724148269;4809.158397280471;4830.251311046784;4868.4401293851215;4874.171390863553;4911.361523002014;4410.889727756808;4482.305242687373;4492.10157968406;4493.68544201906;4555.430571178603;4460.821567137311;4505.279155335147;4515.706479078865;4546.38623785788;4561.7491037992895;4429.180601588717;4498.50516443191;4535.63714902807;4577.771111444431;4604.056168485469;4439.422875026258;4468.128714900596;4474.306482495218;4511.684182107254;4532.637389008904;4450.421445212134;4457.598816106533;4459.152760975404;4465.397171381855;4472.239719247736;4672.696274742131;4737.881552961204;4886;4889.853304400874;4908.680935739201;5108.846734597968;5138.3833939927445;5138.794448222066;5171.482851714798;5181.171012637959;5193.195054766517;5202.115640341113;5239.973800130975;5304.787808487656;5308;4776.952230477686;4827.589654879304;4832.395950506187;4846.733429661367;4886.218205087169;5212.270282160501;5263.18420644793;5271.103912334912;5287.365516138088;5323.52088312046;5097.949020509747;5127.2052831811125;5174.482551744795;5197.038547868657;5200.297959775382;5210.452902445264;5216.791328346823;5219.765110570033;5223.2948551945765;5286.444923283;4998.475160108209;5023.974880125576;5033.144365457881;5136.820211292662;5145.76844042019;5130.230465430141;5146.099432599281;5176.197689358156;5185.533302002837;5230.581553475713;4411.338299255138;4415.51429342772;4423.447069116361;4428.7121337112985;4494;3827.8468861245797;3835.463035175078;3840.30874442603;3866.091468504955;3875.651191392732;4299.269124248823;4389.890252743643;4402.669799764966;4463.397441345442;4497.6851620386915;5303.840884773463;5307.3896501902;5354.732263386893;5355.571554275649;5364.865878353073;4493.438320209973;4507.842225522091;4508.962938524158;4515.322701594787;4562.498125206224;4455.977720111378;4575.3823233863;4723.338732577442;4736.526347365236;4799.472058073609;4889.706617602955;4914.827981020647;4943.678660887031;4955.900881982268;5010.799568017239;5291.9206211906085;5301.628885978099;5308.283381743415;5311.097113490793;5372.4627537247525;4657.347971284091;4925.9014819704125;4930.975345123395;4936.975315123402;4943.925841112458;4929.359183306147;5085.237214417719;5094.9490505095955;5136.5377116059735;5202.479752024768;5219.08665983459;5223.7910483580235;5228.555572776357;5237.6333656643665;5237.6333656643665;5026.246063090565;5026.673266237683;5027.572656324253;5028.145215313332;5074.771635276347;4893.632977526629;4940.431850337257;5018.322526459027;5052.621053420935;5071.315372424823;4924.975375123245;4982.501749824988;5008.373953255843;5012.77442515095;5050.191969284897;4863.440704318907;5078.822241221539;5079.136546786981;5086.567641750345;5116.616253780907;4829.7585120743115;4910.091633047898;4933.531314525115;4936.605071594336;5032.320636714143 22:11:37 INFO - PROCESS | 2576 | |1;ext.html;544.2815483561695;550.9999351177615;553.1509133480107;555.2226882364689;568.0967262053334;37034.62965370349;38771.22457550847;38776.80611596942;42712.145757084836;42729.7863510682;39642.801785991105;40102.39846402299;40118.39822402666;40141.799291003575;40196.59803401965;7643.770686879388;7823.3350165236025;7823.452358334919;7824.256695613907;7834.138244793096;7605.353544948686;7617.80955476112;7635.694572217105;7641;7651.732189373373;7633.923660763405;7640.770776876675;7667;7670.232976702341;7698.6150692465435;7600.4299677524405;7642.885356719626;7653.464257501977;7670.7698769037015;7690.461667683265;7676.155622881479;7691.077070751489;7731.536107833548;7743.651535680908;7748.806279842993;37734.81132594347;37798.43302350467;37916.24167516634;37946.430803537965;38094.61905380939;3170.556122142902;3376.763626546143;3493.99095520077;3678.1540245743363;3726.8819354193906;27988;28204.717952820414;28216.43567128646;29239.2690182745;29412.26469338262;3445.896623101286;3447.6897079262985;3496.7901925884275;3500.4749287607065;3651.525301710787;248237;250549;250600;250904;251122;49577.50422495801;49908.750456247486;49935.75032124816;49973;50006.24990625143;32386.676133238838;33430.498542521884;33443;35100.473492897625;53659.463405365444;12508.3745812709;12596.622101336974;12638.55765048219;12640.241585504898;12655.240685558896;9327.813443731087;9480.099390557885;9483.193928516015;9483.90516094844;9485.193758530602;17633.206505707272;17675.381361652537;17716.645667086843;17778.46664600064;17823.554411139565;6539.247986481616;6620.768273110418;6895.827604309832;6995.740766661948;7047.89428158578;779.6335722210551;882.9249513791272;901.7204666553389;920.8572671235969;949.8670186173941;26934.865325673247;27753.444931101265;27761.72238277632;28306.15081547557;28376.716232837407;923.1645360948353;953.3898305084751;967.6951760195516;989.3569180032893;1006.9144122749502;13799.379027943767;14753.33609987553;14813.481528146463;15058.247087645574;15099.074240697497;380333;384253;385027.09620653134;385048;386432;48770;48921.75539122282;49110.75444622754;49312.75343623259;49320.260196097086;1108.5953626926114;1128.995194277094;1160.825876118589;1167.4571324334224;1176.2824676946884;25309.62035569431;26431.603525946743;27161.320966975985;27192.864035679693;27257.59113613337;40508;40937.795311023256;41360.1727965433;41404.58595414007;41408;302803;305625;305718;305781;306148;24597.139100132124;24869.626955596043;24986;25045.12342068019;25209.621855671812;36764;40546.18907621772;40565.39151912783;40910.18179636331;41617.37573936333;34662.48006279958;35153.64846351606;35217.47173792344;35222.8238858804;35248.295034098664;34732.65267347395;35259.64740352564;35346.11634709153;35458.11354716153;35491.29017419689;29223.415531689672;33983.660163398046;34736.131596709274;35332.29335413329;37751;29824.552631710107;32481.837590811894;32656;32686.673133269313;32862.507062393604;24522;24913;24971.875140624907;25177.87411062933;25493 22:11:37 INFO - PROCESS | 2576 | |2;jquery.html;361.4217252396165;366.60589865894167;372.458073503053;378.782200234865;390.55866870436404;15285.617859553502;15425.691486170284;16722.414715484945;16909.23908424121;17053.658926821456;16145.677086458263;16315.428959986373;16448.42430514932;16826.495205143867;16880.240389182487;4871.878203044926;5144.151215049513;5144.717040562768;5146.691198528081;5153.81961631343;4812.446568644616;4962.106820772259;5027.597792176635;5041.218611115283;5046.495350464943;5062.848114556569;5090.541851233388;5094.235864620318;5102.311187989611;5105.642605017651;4831.275308703687;5065.797368105272;5068.670536415121;5074.4925507449325;5074.594032477411;4399.274119770234;4414.713043652185;4426.380306757057;4427.623651989585;4460.264056430685;19625.926221018355;20161.697574536392;20231.5953680927;20234.595308093903;20337.18651253948;1734.6097128146066;1799.631075629493;1958.343954775152;2193.3529608765452;2294;5920.5559583031445;6400.007998760199;7471.589062601554;13432.932835335761;13794.448222071105;1693.805212400565;1695.983040169595;1723.4484964811265;1751.0281793604545;1829.6615126201696;68670.3132968669;68746;68753.65623171903;69568.6521567394;69697.30302696959;8108.675652973933;8699.565021748887;8765.609150372602;8767;9146.81706365869;11703.2978021319;11771.587994420153;11773.823392649118;11861.229020113838;11866.525338986516;6066.363031881677;6320.273168585672;6494.9350506495275;6519.511036672268;6522.15212022434;5974.2830860297045;6016.909746353808;6070.605410648293;6115.602485838406;6282.057691346243;3632.654897784706;3678.70570354371;3725.8509659613856;3753.0617345663586;3793.886183414502;1756.7979682336438;1868.1033104110104;1873.175802646831;1879.539512819368;1886.9528261793564;759.7454852624322;780.4068907630242;828.3787159630277;845.4251109245649;857.3141486810526;15938.442154524537;16672.74990875138;16704.164791760362;17298.82701172972;17410.39063632767;811.350919264586;838.266516797802;847.8897743293332;919.9604446974876;933.4679232837353;9113;9196.540172991457;9763.658271960447;9834.311598188058;9839.950800246095;359272;364126;364416;367081;369009;74101.62949185328;76824.61587692138;78700;79809.20190798018;79993;862.9289221620811;880.361737740146;896.121800635381;897.0849733272026;900.9054049324858;13882.722345552831;14939.17834519112;15146.469873554373;15180.620484487976;15263.618409539851;35093.29813403667;35781.64218357783;35786.64213357937;35853.28293434169;36706.8164659175;47857.5214247867;48003;48214.75892620515;49744.50255497399;49788;7190.496665233383;7281.453890958093;7575.393968482398;7609.162992070978;8106.689593465834;9677.225821934087;10766.946165269124;10969.286996345212;11198.216124871507;11251;10080.243981701255;10086.6469673564;10230.795384092426;10440.112590429595;10554.736131596772;9927.652532161339;10045.447500387549;10158.949205253926;10468.528916198942;10507.684769456928;10048.547815348473;10167.135793457639;10384.117350025332;10529.57881684724;10846.67459976202;7377.446691498052;7395.8151046224275;7453.440991925519;7635.885461717968;7718.729844455417;9299.907000929905;10195.949020254851;10306.690799276033;10361.792764144524;10440.42577658236 22:11:37 INFO - PROCESS | 2576 | |3;mootools.html;1338.237204793268;1369.2195448594302;1474.2776039740525;1654.6773379191063;1678.773365595645;7056.929430705704;7304.634768261579;7522.736704215354;8191.139930307314;8197.221263979927;7331.413486921047;7553.055868016498;7561.62191890406;7756.301932826044;7789.454738168331;2120.8197303229203;2145.9248926287582;2148.6347320955474;2152.0961196297594;2152.311260396666;2071.347525529461;2102.726645536086;2198.7251593550805;2199.087378737822;2200.3948914048683;2143.2820005298167;2156.924507642233;2159.157928407922;2159.406163305096;2180.8582442141287;2124.107874692625;2130.360891732474;2131.424515380854;2134.3916983659738;2143.496278374581;2024.5039965208618;2054.1885955047824;2055.496403381166;2057.094878253564;2061.5670709151095;7878.4485086044;8074.111847696749;8091.109977902426;8102.837943241161;8114.310283625899;4319.244132276839;4448.1770872388715;4453.242948698729;4453.688241823073;4459.531749166355;2877.13685894233;2940.838368844316;2992.3716019635904;2999.475091858916;3012.7137921897383;930.7486978515763;982.9459379734112;991.1525645573004;1011.9595216191343;1014.4623349624711;10777.4611269437;10873.891261087447;10881.401522916236;10905.83641245382;10938.070264027567;3961.425593288957;4108.958910410857;4234.470691163605;4268.210381079511;4300.376445415397;9324.300677449219;9344.719658410258;9352.579133938989;9370.90629093714;9376.765580860396;4547.636189104864;4595.012072404449;4606.976965115153;4618.815247390134;4631.0506346198945;3558.2349794794245;3647.379945409287;3990.082281075369;4163.542010378856;4169.520505141947;3602.2075143468396;3604.873829415958;3751.174741556853;3758.586555478895;3784.9432258516144;1207.812789017686;1224.185916365607;1225.6568160914958;1229.5757963502576;1233.9568115115928;806.1817255485687;842.6081871929459;848.4909054567211;885.6900084970338;904.7511934218011;5212.635115541952;5471.343438787371;5511.421300763443;5514.558835293167;5597.832065038056;397.5626810508475;404.98785036448953;406.23222110211725;409.4697366909859;409.7500524679943;3563.394222982099;3588.3540962626976;3675.3016926783826;3703.425968974759;3705.27747089315;9464.100910413637;9798.510074496247;9854.802903941882;9885.50572471388;9909.75225619351;8959.5968181432;9802.50987450639;9829.950850245703;9852.950735246279;9872.45701486425;7049.89425158623;7406.074240720018;7441.069866266716;7444.330010299099;7452.180260171377;5525.171224316224;5655.604107712586;5688.800891968761;5731.828045158652;5789.652620842763;9089.818203635758;9118.863217051618;9136;9168.679096231599;9169.312301577274;9118.544072796467;9185.081491850762;9206.217471514996;9384;9386.624535018524;6829.52193346461;6928.272531384334;6978.651067446709;6997.4052205561065;7041.647917603997;7439.55362678241;7588.051493563305;7606.429517786078;7608;7618.238176182337;6748.257691654012;6878.518503704692;6936.306369363023;7135.393491553276;7182.784516464514;6603.273639899703;6636.13730215069;6758.2903795102775;6800.591964482147;6825.795226143224;6091.756329746938;6210.937890621217;6217.129601855834;6223.96888015557;6240.344763799736;4321.827126914888;4356.934645980249;4643.2802915548145;4665.5567721066445;4688.132695451352;4376.081022985209;4442.3558584004495;4563.931541026821;4591.954080459286;4725.574698277172 22:11:37 INFO - PROCESS | 2576 | |4;prototype.html;287.20444369097595;296.3465558443632;297.7454276593512;303.77975967423623;304.3107361825464;5005.974970125153;5006.498050584828;5007.223880298555;5034.446210916801;5079.085764562377;4936.185529387647;4946.332245146904;4947.628927830409;4957.40511138663;4978.975105124478;3608.873689420864;3744;3754.718396120288;3825.3688141456764;3926.725129240954;3885.9028524286978;3886.475325831019;3887.300285948528;3902.439024390238;3926.3521518949483;3824.6557809797114;3845.788481633509;3867.864624738135;3877.941830872539;3884.7086468514976;3816.141368192162;3819.8472061117523;3873.1285460771383;3881.359575670011;3918.1380096378894;3390.1863552747163;3394.353738436856;3412.8634854605784;3423.7945723256435;3429.228423604694;4850.927236091461;4870.707757534559;4873.415190177166;4900.142475066849;4908.754562271872;4458.821647134111;4460.5316441773475;4466.70966387187;4468.597826195658;4484.596386325214;4926.310316555685;5137.74311284438;5191.32512773337;5212.452692467275;5246.606504512139;3681.834317455721;3684.5946945836204;3687.3731465650903;3691.667749902522;3699.907502312437;5476.452354764531;5491.835244942618;5537.529310008654;5550.917571073643;5556.805511807067;3642.453631955175;3731.272401881607;3747.5877653458097;3750.493683352767;3782.319182547168;3792.58281589025;3808.21931504041;3819.236152769457;3821.6942644588366;3828.9617103828605;4405.229084910128;4416.38170656102;4425.690201685851;4430.313301438217;4437.556244375537;5137.8201762938115;5240.929832716132;5276.498732620395;5276.788928442896;5289.841304760864;1305.6605282626394;1312.6390242683337;1315.276597871167;1319.182107093608;1324.4635922451423;809.1746418652941;823.7446391618618;828.5318794880873;844.3920377328313;845.3786466946789;4329.878359603771;4405;4470.329450582439;4526.502084770673;4535.9773201133785;5335.653182543122;5353.277307563507;5365.812196573179;5392.73036348181;5395.541378982831;4514.277715565494;4563.155816174019;4565.698775848867;4569.840055598038;4572.497025327211;2649.284693132843;2781.1934538983874;2800.957985630217;2805.410863718601;2820.450012247633;4964.404271487445;4969.428515720666;4975.5522003019905;4978.8257410990445;4994.70031798086;5193.974030129901;5435.701036442954;5460.399356070829;5460.726963651801;5469.398366179717;4975.726335051607;5044.596432285409;5055.393352797688;5055.570276526537;5068.569171620454;5403.189521571796;5410.404855465817;5410.513053825174;5433.619646624698;5452.509274165344;5230.607704422259;5276.577873770012;5297.788088476572;5347.224652425454;5364.9731751341;5061.519155680205;5061.898762024813;5077.263796749525;5080.847574572768;5097.847064588068;3743.288775132716;3794.1842503861803;3797.411401232813;3804.1060350816983;3817.5991520889906;5333.493318134926;5387.868547605047;5421.05131601976;5495.203195536705;5504.944950550604;5165.173572228426;5180.663256888291;5196.220566914993;5197.24639927216;5221.843344699665;5103.87240318995;5118.97440512795;5143.7428128594165;5185.766640501111;5194.194899790538;4789.8504358952905;5060.645754797129;5086.923696144635;5094.719790411563;5106.770195341144;5008.84973450797;5189.429162792015;5195.76619052136;5227.843164705065;5243.973780131075;5135.435102138687;5136.563392111712;5137.229415587692;5140.254663073908;5144.30551875492 22:11:37 INFO - PROCESS | 2576 | |5;yui.html;636.3668150190559;701.0675801184425;732.8021434212762;747.3050063440998;758.4501236603467;12734.617961461148;13434.193948363105;13935.860641393583;14000.229987350704;14064.929675351608;12807.359632018384;12991;13017.218966861996;13039.21764694119;13071.08502404832;708.8298808286025;730.4229658569724;760.828813516957;761.1399118995555;761.2958013837206;732.5421611492817;748.188215785873;753.1263734068482;753.8944547763317;755.9773206803804;802.2218448105358;807.8222790986003;811.736185739634;812.8740045292959;813.1015228172872;793.0919097633235;794.4756460735945;797.4856217739525;804.8229389534293;805.4603415711458;583.1340459417761;583.8277708076085;584.3513699793226;584.657975084576;584.7047241143196;13755.31223438824;13845.723085538333;13925.442982280798;13931.721365572632;14011.089279196922;12999.61001169957;13408.128471649312;13411.262380569065;13479.258640774753;13491.190528568219;10569.207309451822;10597.788044239149;10630.299152135698;10718.785624287471;10738.302010369302;3281.425750493654;3293.0943990402593;3317.6848199421015;3332.0670212340583;3425.1094715374184;67407.3259267406;67504.6624766873;68349;68489.31510684929;68846.65576672135;10264.230182736324;10338.638147664795;10354.482275886327;10447.373157610567;10462.947685261524;19073.904630476758;19204.327848525234;19219.711704324447;19270.22919083221;19300.90349548243;6367.172267605181;6632.966835165793;6667.299933507009;6698.095757072831;6827.214870289881;3643.7267204959203;3678.3746763050344;3717.4795528626014;3789.5263092113487;3826.6364695353896;2874.5113330733825;2993.925151871177;3011.7741169411943;3019.3206528530905;3019.788614796943;532.7229840482927;549.2557584473061;557.4509108528097;570.0650932470751;571.6998575747766;547.3759913698308;570.1618620627753;572.8542914171657;587.4566026425539;602.9538750268281;8010.439269251213;8369.3304535637;8532.189442003;8684.739457816275;9180.449173049505;611.0833749375936;620.3238470067648;620.5563022438978;637.1844039629282;638.741309769544;3972.4239985201984;4138.482689663792;4183.937240941388;4289.849855255114;4438;103226;104351;106212.46893765482;110680;110863;66964.6651766738;67502.66248668726;67669.66165169142;84400;99561.50219248858;72176.63911680409;72799.27200727924;72935.63532182305;73466.63266683632;73683.63158184283;8416;9188.586513607037;9312.906870931474;9346.970109705113;9485.992278146621;38555.80722096372;40480.98797530085;43117.55059595162;45449.318260226784;50292.49707502878;59447.70276148592;67380;72687.63656181685;74778.62610686912;78433.60783196047;11127.72180695489;11206.887931120584;11385.544578216779;11493.12671832042;11993.460294286953;11946;12872.22766634005;12883.549075782303;13151.408186631434;13339.333033348099;10724.678259652223;10973.890261097606;11085.168612354268;11094;12389.256644600991;11109.722256943642;11547.595834145764;11634.6509604712;12968.416421261254;13032.413541390471;9708.85436718464;10201.109293324265;10276.537555810157;11256.718582035515;11717.707057323634;9431.849986006135;9681.70954871355;9863.901360986585;10069.69790906274;10557.313774604627;10899.891001090205;11106.944465277946;11190.21577011024;11216.495257713586;11545 22:11:37 INFO - PROCESS | 2576 | __end_tp_report 22:11:37 INFO - PROCESS | 2576 | __start_cc_report 22:11:37 INFO - PROCESS | 2576 | _x_x_mozilla_cycle_collect,342 22:11:37 INFO - PROCESS | 2576 | __end_cc_report 22:11:37 INFO - PROCESS | 2576 | __startTimestamp1475039497181__endTimestamp 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | ------- Summary: start ------- 22:11:37 INFO - PROCESS | 2576 | Number of tests: 6 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#0] dojo.html Cycles:165 Average:4801.53 Median:4924.98 stddev:510.79 (10.4%) stddev-sans-first:483.44 22:11:37 INFO - PROCESS | 2576 | Values: 2641.7 2653.9 2656.4 2679.2 2682.6 4771.7 4813.9 4842.4 4843.6 4870.1 4809.2 4830.3 4868.4 4874.2 4911.4 4410.9 4482.3 4492.1 4493.7 4555.4 4460.8 4505.3 4515.7 4546.4 4561.7 4429.2 4498.5 4535.6 4577.8 4604.1 4439.4 4468.1 4474.3 4511.7 4532.6 4450.4 4457.6 4459.2 4465.4 4472.2 4672.7 4737.9 4886.0 4889.9 4908.7 5108.8 5138.4 5138.8 5171.5 5181.2 5193.2 5202.1 5240.0 5304.8 5308.0 4777.0 4827.6 4832.4 4846.7 4886.2 5212.3 5263.2 5271.1 5287.4 5323.5 5097.9 5127.2 5174.5 5197.0 5200.3 5210.5 5216.8 5219.8 5223.3 5286.4 4998.5 5024.0 5033.1 5136.8 5145.8 5130.2 5146.1 5176.2 5185.5 5230.6 4411.3 4415.5 4423.4 4428.7 4494.0 3827.8 3835.5 3840.3 3866.1 3875.7 4299.3 4389.9 4402.7 4463.4 4497.7 5303.8 5307.4 5354.7 5355.6 5364.9 4493.4 4507.8 4509.0 4515.3 4562.5 4456.0 4575.4 4723.3 4736.5 4799.5 4889.7 4914.8 4943.7 4955.9 5010.8 5291.9 5301.6 5308.3 5311.1 5372.5 4657.3 4925.9 4931.0 4937.0 4943.9 4929.4 5085.2 5094.9 5136.5 5202.5 5219.1 5223.8 5228.6 5237.6 5237.6 5026.2 5026.7 5027.6 5028.1 5074.8 4893.6 4940.4 5018.3 5052.6 5071.3 4925.0 4982.5 5008.4 5012.8 5050.2 4863.4 5078.8 5079.1 5086.6 5116.6 4829.8 4910.1 4933.5 4936.6 5032.3 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#1] ext.html Cycles:180 Average:45985.70 Median:20730.85 stddev:83734.42 (403.9%) stddev-sans-first:83899.81 22:11:37 INFO - PROCESS | 2576 | Values: 544.3 551.0 553.2 555.2 568.1 37034.6 38771.2 38776.8 42712.1 42729.8 39642.8 40102.4 40118.4 40141.8 40196.6 7643.8 7823.3 7823.5 7824.3 7834.1 7605.4 7617.8 7635.7 7641.0 7651.7 7633.9 7640.8 7667.0 7670.2 7698.6 7600.4 7642.9 7653.5 7670.8 7690.5 7676.2 7691.1 7731.5 7743.7 7748.8 37734.8 37798.4 37916.2 37946.4 38094.6 3170.6 3376.8 3494.0 3678.2 3726.9 27988.0 28204.7 28216.4 29239.3 29412.3 3445.9 3447.7 3496.8 3500.5 3651.5 248237.0 250549.0 250600.0 250904.0 251122.0 49577.5 49908.8 49935.8 49973.0 50006.2 32386.7 33430.5 33443.0 35100.5 53659.5 12508.4 12596.6 12638.6 12640.2 12655.2 9327.8 9480.1 9483.2 9483.9 9485.2 17633.2 17675.4 17716.6 17778.5 17823.6 6539.2 6620.8 6895.8 6995.7 7047.9 779.6 882.9 901.7 920.9 949.9 26934.9 27753.4 27761.7 28306.2 28376.7 923.2 953.4 967.7 989.4 1006.9 13799.4 14753.3 14813.5 15058.2 15099.1 380333.0 384253.0 385027.1 385048.0 386432.0 48770.0 48921.8 49110.8 49312.8 49320.3 1108.6 1129.0 1160.8 1167.5 1176.3 25309.6 26431.6 27161.3 27192.9 27257.6 40508.0 40937.8 41360.2 41404.6 41408.0 302803.0 305625.0 305718.0 305781.0 306148.0 24597.1 24869.6 24986.0 25045.1 25209.6 36764.0 40546.2 40565.4 40910.2 41617.4 34662.5 35153.6 35217.5 35222.8 35248.3 34732.7 35259.6 35346.1 35458.1 35491.3 29223.4 33983.7 34736.1 35332.3 37751.0 29824.6 32481.8 32656.0 32686.7 32862.5 24522.0 24913.0 24971.9 25177.9 25493.0 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#2] jquery.html Cycles:180 Average:23238.02 Median:4420.55 stddev:60461.73 (1367.7%) stddev-sans-first:60606.94 22:11:37 INFO - PROCESS | 2576 | Values: 361.4 366.6 372.5 378.8 390.6 15285.6 15425.7 16722.4 16909.2 17053.7 16145.7 16315.4 16448.4 16826.5 16880.2 4871.9 5144.2 5144.7 5146.7 5153.8 4812.4 4962.1 5027.6 5041.2 5046.5 5062.8 5090.5 5094.2 5102.3 5105.6 4831.3 5065.8 5068.7 5074.5 5074.6 4399.3 4414.7 4426.4 4427.6 4460.3 19625.9 20161.7 20231.6 20234.6 20337.2 1734.6 1799.6 1958.3 2193.4 2294.0 5920.6 6400.0 7471.6 13432.9 13794.4 1693.8 1696.0 1723.4 1751.0 1829.7 68670.3 68746.0 68753.7 69568.7 69697.3 8108.7 8699.6 8765.6 8767.0 9146.8 11703.3 11771.6 11773.8 11861.2 11866.5 6066.4 6320.3 6494.9 6519.5 6522.2 5974.3 6016.9 6070.6 6115.6 6282.1 3632.7 3678.7 3725.9 3753.1 3793.9 1756.8 1868.1 1873.2 1879.5 1887.0 759.7 780.4 828.4 845.4 857.3 15938.4 16672.7 16704.2 17298.8 17410.4 811.4 838.3 847.9 920.0 933.5 9113.0 9196.5 9763.7 9834.3 9840.0 359272.0 364126.0 364416.0 367081.0 369009.0 74101.6 76824.6 78700.0 79809.2 79993.0 862.9 880.4 896.1 897.1 900.9 13882.7 14939.2 15146.5 15180.6 15263.6 35093.3 35781.6 35786.6 35853.3 36706.8 47857.5 48003.0 48214.8 49744.5 49788.0 7190.5 7281.5 7575.4 7609.2 8106.7 9677.2 10766.9 10969.3 11198.2 11251.0 10080.2 10086.6 10230.8 10440.1 10554.7 9927.7 10045.4 10158.9 10468.5 10507.7 10048.5 10167.1 10384.1 10529.6 10846.7 7377.4 7395.8 7453.4 7635.9 7718.7 9299.9 10195.9 10306.7 10361.8 10440.4 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#3] mootools.html Cycles:180 Average:5178.03 Median:4706.85 stddev:2959.32 (62.9%) stddev-sans-first:2953.56 22:11:37 INFO - PROCESS | 2576 | Values: 1338.2 1369.2 1474.3 1654.7 1678.8 7056.9 7304.6 7522.7 8191.1 8197.2 7331.4 7553.1 7561.6 7756.3 7789.5 2120.8 2145.9 2148.6 2152.1 2152.3 2071.3 2102.7 2198.7 2199.1 2200.4 2143.3 2156.9 2159.2 2159.4 2180.9 2124.1 2130.4 2131.4 2134.4 2143.5 2024.5 2054.2 2055.5 2057.1 2061.6 7878.4 8074.1 8091.1 8102.8 8114.3 4319.2 4448.2 4453.2 4453.7 4459.5 2877.1 2940.8 2992.4 2999.5 3012.7 930.7 982.9 991.2 1012.0 1014.5 10777.5 10873.9 10881.4 10905.8 10938.1 3961.4 4109.0 4234.5 4268.2 4300.4 9324.3 9344.7 9352.6 9370.9 9376.8 4547.6 4595.0 4607.0 4618.8 4631.1 3558.2 3647.4 3990.1 4163.5 4169.5 3602.2 3604.9 3751.2 3758.6 3784.9 1207.8 1224.2 1225.7 1229.6 1234.0 806.2 842.6 848.5 885.7 904.8 5212.6 5471.3 5511.4 5514.6 5597.8 397.6 405.0 406.2 409.5 409.8 3563.4 3588.4 3675.3 3703.4 3705.3 9464.1 9798.5 9854.8 9885.5 9909.8 8959.6 9802.5 9830.0 9853.0 9872.5 7049.9 7406.1 7441.1 7444.3 7452.2 5525.2 5655.6 5688.8 5731.8 5789.7 9089.8 9118.9 9136.0 9168.7 9169.3 9118.5 9185.1 9206.2 9384.0 9386.6 6829.5 6928.3 6978.7 6997.4 7041.6 7439.6 7588.1 7606.4 7608.0 7618.2 6748.3 6878.5 6936.3 7135.4 7182.8 6603.3 6636.1 6758.3 6800.6 6825.8 6091.8 6210.9 6217.1 6224.0 6240.3 4321.8 4356.9 4643.3 4665.6 4688.1 4376.1 4442.4 4563.9 4592.0 4725.6 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#4] prototype.html Cycles:180 Average:4317.07 Median:4960.90 stddev:1269.89 (25.6%) stddev-sans-first:1236.91 22:11:37 INFO - PROCESS | 2576 | Values: 287.2 296.3 297.7 303.8 304.3 5006.0 5006.5 5007.2 5034.4 5079.1 4936.2 4946.3 4947.6 4957.4 4979.0 3608.9 3744.0 3754.7 3825.4 3926.7 3885.9 3886.5 3887.3 3902.4 3926.4 3824.7 3845.8 3867.9 3877.9 3884.7 3816.1 3819.8 3873.1 3881.4 3918.1 3390.2 3394.4 3412.9 3423.8 3429.2 4850.9 4870.7 4873.4 4900.1 4908.8 4458.8 4460.5 4466.7 4468.6 4484.6 4926.3 5137.7 5191.3 5212.5 5246.6 3681.8 3684.6 3687.4 3691.7 3699.9 5476.5 5491.8 5537.5 5550.9 5556.8 3642.5 3731.3 3747.6 3750.5 3782.3 3792.6 3808.2 3819.2 3821.7 3829.0 4405.2 4416.4 4425.7 4430.3 4437.6 5137.8 5240.9 5276.5 5276.8 5289.8 1305.7 1312.6 1315.3 1319.2 1324.5 809.2 823.7 828.5 844.4 845.4 4329.9 4405.0 4470.3 4526.5 4536.0 5335.7 5353.3 5365.8 5392.7 5395.5 4514.3 4563.2 4565.7 4569.8 4572.5 2649.3 2781.2 2801.0 2805.4 2820.5 4964.4 4969.4 4975.6 4978.8 4994.7 5194.0 5435.7 5460.4 5460.7 5469.4 4975.7 5044.6 5055.4 5055.6 5068.6 5403.2 5410.4 5410.5 5433.6 5452.5 5230.6 5276.6 5297.8 5347.2 5365.0 5061.5 5061.9 5077.3 5080.8 5097.8 3743.3 3794.2 3797.4 3804.1 3817.6 5333.5 5387.9 5421.1 5495.2 5504.9 5165.2 5180.7 5196.2 5197.2 5221.8 5103.9 5119.0 5143.7 5185.8 5194.2 4789.9 5060.6 5086.9 5094.7 5106.8 5008.8 5189.4 5195.8 5227.8 5244.0 5135.4 5136.6 5137.2 5140.3 5144.3 22:11:37 INFO - PROCESS | 2576 | 22:11:37 INFO - PROCESS | 2576 | [#5] yui.html Cycles:180 Average:18270.59 Median:4236.89 stddev:26412.72 (623.4%) stddev-sans-first:26453.62 22:11:37 INFO - PROCESS | 2576 | Values: 636.4 701.1 732.8 747.3 758.5 12734.6 13434.2 13935.9 14000.2 14064.9 12807.4 12991.0 13017.2 13039.2 13071.1 708.8 730.4 760.8 761.1 761.3 732.5 748.2 753.1 753.9 756.0 802.2 807.8 811.7 812.9 813.1 793.1 794.5 797.5 804.8 805.5 583.1 583.8 584.4 584.7 584.7 13755.3 13845.7 13925.4 13931.7 14011.1 12999.6 13408.1 13411.3 13479.3 13491.2 10569.2 10597.8 10630.3 10718.8 10738.3 3281.4 3293.1 3317.7 3332.1 3425.1 67407.3 67504.7 68349.0 68489.3 68846.7 10264.2 10338.6 10354.5 10447.4 10462.9 19073.9 19204.3 19219.7 19270.2 19300.9 6367.2 6633.0 6667.3 6698.1 6827.2 3643.7 3678.4 3717.5 3789.5 3826.6 2874.5 2993.9 3011.8 3019.3 3019.8 532.7 549.3 557.5 570.1 571.7 547.4 570.2 572.9 587.5 603.0 8010.4 8369.3 8532.2 8684.7 9180.4 611.1 620.3 620.6 637.2 638.7 3972.4 4138.5 4183.9 4289.8 4438.0 103226.0 104351.0 106212.5 110680.0 110863.0 66964.7 67502.7 67669.7 84400.0 99561.5 72176.6 72799.3 72935.6 73466.6 73683.6 8416.0 9188.6 9312.9 9347.0 9486.0 38555.8 40481.0 43117.6 45449.3 50292.5 59447.7 67380.0 72687.6 74778.6 78433.6 11127.7 11206.9 11385.5 11493.1 11993.5 11946.0 12872.2 12883.5 13151.4 13339.3 10724.7 10973.9 11085.2 11094.0 12389.3 11109.7 11547.6 11634.7 12968.4 13032.4 9708.9 10201.1 10276.5 11256.7 11717.7 9431.8 9681.7 9863.9 10069.7 10557.3 10899.9 11106.9 11190.2 11216.5 11545.0 22:11:37 INFO - PROCESS | 2576 | -------- Summary: end -------- 22:11:37 INFO - PROCESS | 2576 | 22:11:38 INFO - TEST-INFO | 2576: exit 0 22:11:38 INFO - TEST-OK | dromaeo_css | took 1118980ms 22:11:38 INFO - TEST-START | kraken 22:11:38 INFO - operating with platform_type : linux_ 22:11:38 INFO - Initialising browser for kraken test... 22:11:38 INFO - TEST-INFO | started process 3039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDqWtu/profile http://localhost:34924/getInfo.html) 22:11:43 INFO - PROCESS | 3039 | __metrics Screen width/height:1600/1200 22:11:43 INFO - PROCESS | 3039 | colorDepth:24 22:11:43 INFO - PROCESS | 3039 | Browser inner width/height: 1024/697 22:11:43 INFO - PROCESS | 3039 | __metrics 22:11:44 ERROR - PROCESS | 3039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:11:45 INFO - TEST-INFO | 3039: exit 0 22:11:45 INFO - Browser initialized. 22:11:45 INFO - Running cycle 1/1 for kraken test... 22:11:45 INFO - TEST-INFO | started process 3161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDqWtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:57 INFO - PROCESS | 3161 | RSS: Main: 186265600 22:11:57 INFO - PROCESS | 3161 | 22:12:00 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34924/tests/kraken/driver.html?testName=audio-beat-detection) 22:12:01 INFO - PROCESS | 3161 | RSS: Main: 195334144 22:12:01 INFO - PROCESS | 3161 | 22:12:04 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34924/tests/kraken/driver.html?testName=audio-dft) 22:12:04 INFO - PROCESS | 3161 | RSS: Main: 197869568 22:12:04 INFO - PROCESS | 3161 | 22:12:07 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34924/tests/kraken/driver.html?testName=audio-fft) 22:12:08 INFO - PROCESS | 3161 | RSS: Main: 193728512 22:12:08 INFO - PROCESS | 3161 | 22:12:10 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34924/tests/kraken/driver.html?testName=audio-oscillator) 22:12:11 INFO - PROCESS | 3161 | RSS: Main: 194195456 22:12:11 INFO - PROCESS | 3161 | 22:12:13 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:12:14 INFO - PROCESS | 3161 | RSS: Main: 194592768 22:12:14 INFO - PROCESS | 3161 | 22:12:17 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34924/tests/kraken/driver.html?testName=imaging-darkroom) 22:12:17 INFO - PROCESS | 3161 | RSS: Main: 194191360 22:12:17 INFO - PROCESS | 3161 | 22:12:21 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34924/tests/kraken/driver.html?testName=imaging-desaturate) 22:12:22 INFO - PROCESS | 3161 | RSS: Main: 192159744 22:12:22 INFO - PROCESS | 3161 | 22:12:25 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34924/tests/kraken/driver.html?testName=json-parse-financial) 22:12:25 INFO - PROCESS | 3161 | RSS: Main: 193781760 22:12:25 INFO - PROCESS | 3161 | 22:12:27 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:12:28 INFO - PROCESS | 3161 | RSS: Main: 193933312 22:12:28 INFO - PROCESS | 3161 | 22:12:29 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:12:30 INFO - PROCESS | 3161 | RSS: Main: 193859584 22:12:30 INFO - PROCESS | 3161 | 22:12:32 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:12:33 INFO - PROCESS | 3161 | RSS: Main: 194359296 22:12:33 INFO - PROCESS | 3161 | 22:12:36 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:12:37 INFO - PROCESS | 3161 | RSS: Main: 194236416 22:12:37 INFO - PROCESS | 3161 | 22:12:39 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:12:40 INFO - PROCESS | 3161 | RSS: Main: 194347008 22:12:40 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:34924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34924/tests/kraken/driver.html?testName=ai-astar) 22:12:42 INFO - PROCESS | 3161 | RSS: Main: 197033984 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | __start_tp_report 22:12:42 INFO - PROCESS | 3161 | _x_x_mozilla_page_load 22:12:42 INFO - PROCESS | 3161 | _x_x_mozilla_page_load_details 22:12:42 INFO - PROCESS | 3161 | |i|pagename|runs| 22:12:42 INFO - PROCESS | 3161 | |0;ai-astar;107;114;114;114;114;114;114;116;115;115 22:12:42 INFO - PROCESS | 3161 | |1;audio-beat-detection;156;123;130;190;125;126;130;127;159;128 22:12:42 INFO - PROCESS | 3161 | |2;audio-dft;166;176;165;164;162;163;164;162;164;165 22:12:42 INFO - PROCESS | 3161 | |3;audio-fft;77;77;78;110;77;76;76;77;96;76 22:12:42 INFO - PROCESS | 3161 | |4;audio-oscillator;83;84;104;84;82;85;118;84;84;111 22:12:42 INFO - PROCESS | 3161 | |5;imaging-gaussian-blur;119;117;118;119;120;118;119;118;120;118 22:12:42 INFO - PROCESS | 3161 | |6;imaging-darkroom;148;147;148;148;148;149;148;150;147;149 22:12:42 INFO - PROCESS | 3161 | |7;imaging-desaturate;98;95;96;97;96;96;96;96;96;95 22:12:42 INFO - PROCESS | 3161 | |8;json-parse-financial;64;65;64;64;65;65;67;65;65;64 22:12:42 INFO - PROCESS | 3161 | |9;json-stringify-tinderbox;65;67;67;66;67;65;66;67;67;67 22:12:42 INFO - PROCESS | 3161 | |10;stanford-crypto-aes;83;83;93;83;87;84;87;82;82;93 22:12:42 INFO - PROCESS | 3161 | |11;stanford-crypto-ccm;140;141;136;149;139;137;138;150;178;136 22:12:42 INFO - PROCESS | 3161 | |12;stanford-crypto-pbkdf2;175;176;171;181;178;174;175;173;173;175 22:12:42 INFO - PROCESS | 3161 | |13;stanford-crypto-sha256-iterative;75;72;70;70;70;73;69;72;69;73 22:12:42 INFO - PROCESS | 3161 | __end_tp_report 22:12:42 INFO - PROCESS | 3161 | __start_cc_report 22:12:42 INFO - PROCESS | 3161 | _x_x_mozilla_cycle_collect,832 22:12:42 INFO - PROCESS | 3161 | __end_cc_report 22:12:42 INFO - PROCESS | 3161 | __startTimestamp1475039562657__endTimestamp 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | ------- Summary: start ------- 22:12:42 INFO - PROCESS | 3161 | Number of tests: 14 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.45 (2.2%) stddev-sans-first:0.73 22:12:42 INFO - PROCESS | 3161 | Values: 107.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 115.0 115.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:130.00 stddev:21.95 (16.9%) stddev-sans-first:22.44 22:12:42 INFO - PROCESS | 3161 | Values: 156.0 123.0 130.0 190.0 125.0 126.0 130.0 127.0 159.0 128.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:4.04 (2.5%) stddev-sans-first:4.27 22:12:42 INFO - PROCESS | 3161 | Values: 166.0 176.0 165.0 164.0 162.0 163.0 164.0 162.0 164.0 165.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:11.57 (15.0%) stddev-sans-first:12.13 22:12:42 INFO - PROCESS | 3161 | Values: 77.0 77.0 78.0 110.0 77.0 76.0 76.0 77.0 96.0 76.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:84.00 stddev:13.61 (16.2%) stddev-sans-first:14.05 22:12:42 INFO - PROCESS | 3161 | Values: 83.0 84.0 104.0 84.0 82.0 85.0 118.0 84.0 84.0 111.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 22:12:42 INFO - PROCESS | 3161 | Values: 119.0 117.0 118.0 119.0 120.0 118.0 119.0 118.0 120.0 118.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:12:42 INFO - PROCESS | 3161 | Values: 148.0 147.0 148.0 148.0 148.0 149.0 148.0 150.0 147.0 149.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.60 22:12:42 INFO - PROCESS | 3161 | Values: 98.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 22:12:42 INFO - PROCESS | 3161 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 67.0 65.0 65.0 64.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 22:12:42 INFO - PROCESS | 3161 | Values: 65.0 67.0 67.0 66.0 67.0 65.0 66.0 67.0 67.0 67.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:4.24 (5.0%) stddev-sans-first:4.39 22:12:42 INFO - PROCESS | 3161 | Values: 83.0 83.0 93.0 83.0 87.0 84.0 87.0 82.0 82.0 93.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:140.50 stddev:12.82 (9.1%) stddev-sans-first:13.49 22:12:42 INFO - PROCESS | 3161 | Values: 140.0 141.0 136.0 149.0 139.0 137.0 138.0 150.0 178.0 136.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:175.00 stddev:2.81 (1.6%) stddev-sans-first:2.98 22:12:42 INFO - PROCESS | 3161 | Values: 175.0 176.0 171.0 181.0 178.0 174.0 175.0 173.0 173.0 175.0 22:12:42 INFO - PROCESS | 3161 | 22:12:42 INFO - PROCESS | 3161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:2.00 (2.8%) stddev-sans-first:1.62 22:12:42 INFO - PROCESS | 3161 | Values: 75.0 72.0 70.0 70.0 70.0 73.0 69.0 72.0 69.0 73.0 22:12:42 INFO - PROCESS | 3161 | -------- Summary: end -------- 22:12:42 INFO - PROCESS | 3161 | 22:12:43 INFO - TEST-INFO | 3161: exit 0 22:12:43 INFO - TEST-OK | kraken | took 65600ms 22:12:43 INFO - SUITE-END | took 1184s 22:12:44 INFO - Completed test suite (00:19:44) 22:12:44 INFO - javascript benchmark 22:12:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6388.833511217841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.709411964685, 2653.8540380279087, 2656.375751698352, 2679.1962411276613, 2682.5841994490847, 4771.713697178172, 4813.90372192556, 4842.370491836061, 4843.5882949949255, 4870.147724148269, 4809.158397280471, 4830.251311046784, 4868.4401293851215, 4874.171390863553, 4911.361523002014, 4410.889727756808, 4482.305242687373, 4492.10157968406, 4493.68544201906, 4555.430571178603, 4460.821567137311, 4505.279155335147, 4515.706479078865, 4546.38623785788, 4561.7491037992895, 4429.180601588717, 4498.50516443191, 4535.63714902807, 4577.771111444431, 4604.056168485469, 4439.422875026258, 4468.128714900596, 4474.306482495218, 4511.684182107254, 4532.637389008904, 4450.421445212134, 4457.598816106533, 4459.152760975404, 4465.397171381855, 4472.239719247736, 4672.696274742131, 4737.881552961204, 4886.0, 4889.853304400874, 4908.680935739201, 5108.846734597968, 5138.3833939927445, 5138.794448222066, 5171.482851714798, 5181.171012637959, 5193.195054766517, 5202.115640341113, 5239.973800130975, 5304.787808487656, 5308.0, 4776.952230477686, 4827.589654879304, 4832.395950506187, 4846.733429661367, 4886.218205087169, 5212.270282160501, 5263.18420644793, 5271.103912334912, 5287.365516138088, 5323.52088312046, 5097.949020509747, 5127.2052831811125, 5174.482551744795, 5197.038547868657, 5200.297959775382, 5210.452902445264, 5216.791328346823, 5219.765110570033, 5223.2948551945765, 5286.444923283, 4998.475160108209, 5023.974880125576, 5033.144365457881, 5136.820211292662, 5145.76844042019, 5130.230465430141, 5146.099432599281, 5176.197689358156, 5185.533302002837, 5230.581553475713, 4411.338299255138, 4415.51429342772, 4423.447069116361, 4428.7121337112985, 4494.0, 3827.8468861245797, 3835.463035175078, 3840.30874442603, 3866.091468504955, 3875.651191392732, 4299.269124248823, 4389.890252743643, 4402.669799764966, 4463.397441345442, 4497.6851620386915, 5303.840884773463, 5307.3896501902, 5354.732263386893, 5355.571554275649, 5364.865878353073, 4493.438320209973, 4507.842225522091, 4508.962938524158, 4515.322701594787, 4562.498125206224, 4455.977720111378, 4575.3823233863, 4723.338732577442, 4736.526347365236, 4799.472058073609, 4889.706617602955, 4914.827981020647, 4943.678660887031, 4955.900881982268, 5010.799568017239, 5291.9206211906085, 5301.628885978099, 5308.283381743415, 5311.097113490793, 5372.4627537247525, 4657.347971284091, 4925.9014819704125, 4930.975345123395, 4936.975315123402, 4943.925841112458, 4929.359183306147, 5085.237214417719, 5094.9490505095955, 5136.5377116059735, 5202.479752024768, 5219.08665983459, 5223.7910483580235, 5228.555572776357, 5237.6333656643665, 5237.6333656643665, 5026.246063090565, 5026.673266237683, 5027.572656324253, 5028.145215313332, 5074.771635276347, 4893.632977526629, 4940.431850337257, 5018.322526459027, 5052.621053420935, 5071.315372424823, 4924.975375123245, 4982.501749824988, 5008.373953255843, 5012.77442515095, 5050.191969284897, 4863.440704318907, 5078.822241221539, 5079.136546786981, 5086.567641750345, 5116.616253780907, 4829.7585120743115, 4910.091633047898, 4933.531314525115, 4936.605071594336, 5032.320636714143], "value": 4768.200125238263, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2815483561695, 550.9999351177615, 553.1509133480107, 555.2226882364689, 568.0967262053334, 37034.62965370349, 38771.22457550847, 38776.80611596942, 42712.145757084836, 42729.7863510682, 39642.801785991105, 40102.39846402299, 40118.39822402666, 40141.799291003575, 40196.59803401965, 7643.770686879388, 7823.3350165236025, 7823.452358334919, 7824.256695613907, 7834.138244793096, 7605.353544948686, 7617.80955476112, 7635.694572217105, 7641.0, 7651.732189373373, 7633.923660763405, 7640.770776876675, 7667.0, 7670.232976702341, 7698.6150692465435, 7600.4299677524405, 7642.885356719626, 7653.464257501977, 7670.7698769037015, 7690.461667683265, 7676.155622881479, 7691.077070751489, 7731.536107833548, 7743.651535680908, 7748.806279842993, 37734.81132594347, 37798.43302350467, 37916.24167516634, 37946.430803537965, 38094.61905380939, 3170.556122142902, 3376.763626546143, 3493.99095520077, 3678.1540245743363, 3726.8819354193906, 27988.0, 28204.717952820414, 28216.43567128646, 29239.2690182745, 29412.26469338262, 3445.896623101286, 3447.6897079262985, 3496.7901925884275, 3500.4749287607065, 3651.525301710787, 248237.0, 250549.0, 250600.0, 250904.0, 251122.0, 49577.50422495801, 49908.750456247486, 49935.75032124816, 49973.0, 50006.24990625143, 32386.676133238838, 33430.498542521884, 33443.0, 35100.473492897625, 53659.463405365444, 12508.3745812709, 12596.622101336974, 12638.55765048219, 12640.241585504898, 12655.240685558896, 9327.813443731087, 9480.099390557885, 9483.193928516015, 9483.90516094844, 9485.193758530602, 17633.206505707272, 17675.381361652537, 17716.645667086843, 17778.46664600064, 17823.554411139565, 6539.247986481616, 6620.768273110418, 6895.827604309832, 6995.740766661948, 7047.89428158578, 779.6335722210551, 882.9249513791272, 901.7204666553389, 920.8572671235969, 949.8670186173941, 26934.865325673247, 27753.444931101265, 27761.72238277632, 28306.15081547557, 28376.716232837407, 923.1645360948353, 953.3898305084751, 967.6951760195516, 989.3569180032893, 1006.9144122749502, 13799.379027943767, 14753.33609987553, 14813.481528146463, 15058.247087645574, 15099.074240697497, 380333.0, 384253.0, 385027.09620653134, 385048.0, 386432.0, 48770.0, 48921.75539122282, 49110.75444622754, 49312.75343623259, 49320.260196097086, 1108.5953626926114, 1128.995194277094, 1160.825876118589, 1167.4571324334224, 1176.2824676946884, 25309.62035569431, 26431.603525946743, 27161.320966975985, 27192.864035679693, 27257.59113613337, 40508.0, 40937.795311023256, 41360.1727965433, 41404.58595414007, 41408.0, 302803.0, 305625.0, 305718.0, 305781.0, 306148.0, 24597.139100132124, 24869.626955596043, 24986.0, 25045.12342068019, 25209.621855671812, 36764.0, 40546.18907621772, 40565.39151912783, 40910.18179636331, 41617.37573936333, 34662.48006279958, 35153.64846351606, 35217.47173792344, 35222.8238858804, 35248.295034098664, 34732.65267347395, 35259.64740352564, 35346.11634709153, 35458.11354716153, 35491.29017419689, 29223.415531689672, 33983.660163398046, 34736.131596709274, 35332.29335413329, 37751.0, 29824.552631710107, 32481.837590811894, 32656.0, 32686.673133269313, 32862.507062393604, 24522.0, 24913.0, 24971.875140624907, 25177.87411062933, 25493.0], "value": 16972.420921853445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.4217252396165, 366.60589865894167, 372.458073503053, 378.782200234865, 390.55866870436404, 15285.617859553502, 15425.691486170284, 16722.414715484945, 16909.23908424121, 17053.658926821456, 16145.677086458263, 16315.428959986373, 16448.42430514932, 16826.495205143867, 16880.240389182487, 4871.878203044926, 5144.151215049513, 5144.717040562768, 5146.691198528081, 5153.81961631343, 4812.446568644616, 4962.106820772259, 5027.597792176635, 5041.218611115283, 5046.495350464943, 5062.848114556569, 5090.541851233388, 5094.235864620318, 5102.311187989611, 5105.642605017651, 4831.275308703687, 5065.797368105272, 5068.670536415121, 5074.4925507449325, 5074.594032477411, 4399.274119770234, 4414.713043652185, 4426.380306757057, 4427.623651989585, 4460.264056430685, 19625.926221018355, 20161.697574536392, 20231.5953680927, 20234.595308093903, 20337.18651253948, 1734.6097128146066, 1799.631075629493, 1958.343954775152, 2193.3529608765452, 2294.0, 5920.5559583031445, 6400.007998760199, 7471.589062601554, 13432.932835335761, 13794.448222071105, 1693.805212400565, 1695.983040169595, 1723.4484964811265, 1751.0281793604545, 1829.6615126201696, 68670.3132968669, 68746.0, 68753.65623171903, 69568.6521567394, 69697.30302696959, 8108.675652973933, 8699.565021748887, 8765.609150372602, 8767.0, 9146.81706365869, 11703.2978021319, 11771.587994420153, 11773.823392649118, 11861.229020113838, 11866.525338986516, 6066.363031881677, 6320.273168585672, 6494.9350506495275, 6519.511036672268, 6522.15212022434, 5974.2830860297045, 6016.909746353808, 6070.605410648293, 6115.602485838406, 6282.057691346243, 3632.654897784706, 3678.70570354371, 3725.8509659613856, 3753.0617345663586, 3793.886183414502, 1756.7979682336438, 1868.1033104110104, 1873.175802646831, 1879.539512819368, 1886.9528261793564, 759.7454852624322, 780.4068907630242, 828.3787159630277, 845.4251109245649, 857.3141486810526, 15938.442154524537, 16672.74990875138, 16704.164791760362, 17298.82701172972, 17410.39063632767, 811.350919264586, 838.266516797802, 847.8897743293332, 919.9604446974876, 933.4679232837353, 9113.0, 9196.540172991457, 9763.658271960447, 9834.311598188058, 9839.950800246095, 359272.0, 364126.0, 364416.0, 367081.0, 369009.0, 74101.62949185328, 76824.61587692138, 78700.0, 79809.20190798018, 79993.0, 862.9289221620811, 880.361737740146, 896.121800635381, 897.0849733272026, 900.9054049324858, 13882.722345552831, 14939.17834519112, 15146.469873554373, 15180.620484487976, 15263.618409539851, 35093.29813403667, 35781.64218357783, 35786.64213357937, 35853.28293434169, 36706.8164659175, 47857.5214247867, 48003.0, 48214.75892620515, 49744.50255497399, 49788.0, 7190.496665233383, 7281.453890958093, 7575.393968482398, 7609.162992070978, 8106.689593465834, 9677.225821934087, 10766.946165269124, 10969.286996345212, 11198.216124871507, 11251.0, 10080.243981701255, 10086.6469673564, 10230.795384092426, 10440.112590429595, 10554.736131596772, 9927.652532161339, 10045.447500387549, 10158.949205253926, 10468.528916198942, 10507.684769456928, 10048.547815348473, 10167.135793457639, 10384.117350025332, 10529.57881684724, 10846.67459976202, 7377.446691498052, 7395.8151046224275, 7453.440991925519, 7635.885461717968, 7718.729844455417, 9299.907000929905, 10195.949020254851, 10306.690799276033, 10361.792764144524, 10440.42577658236], "value": 7872.944731952011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.237204793268, 1369.2195448594302, 1474.2776039740525, 1654.6773379191063, 1678.773365595645, 7056.929430705704, 7304.634768261579, 7522.736704215354, 8191.139930307314, 8197.221263979927, 7331.413486921047, 7553.055868016498, 7561.62191890406, 7756.301932826044, 7789.454738168331, 2120.8197303229203, 2145.9248926287582, 2148.6347320955474, 2152.0961196297594, 2152.311260396666, 2071.347525529461, 2102.726645536086, 2198.7251593550805, 2199.087378737822, 2200.3948914048683, 2143.2820005298167, 2156.924507642233, 2159.157928407922, 2159.406163305096, 2180.8582442141287, 2124.107874692625, 2130.360891732474, 2131.424515380854, 2134.3916983659738, 2143.496278374581, 2024.5039965208618, 2054.1885955047824, 2055.496403381166, 2057.094878253564, 2061.5670709151095, 7878.4485086044, 8074.111847696749, 8091.109977902426, 8102.837943241161, 8114.310283625899, 4319.244132276839, 4448.1770872388715, 4453.242948698729, 4453.688241823073, 4459.531749166355, 2877.13685894233, 2940.838368844316, 2992.3716019635904, 2999.475091858916, 3012.7137921897383, 930.7486978515763, 982.9459379734112, 991.1525645573004, 1011.9595216191343, 1014.4623349624711, 10777.4611269437, 10873.891261087447, 10881.401522916236, 10905.83641245382, 10938.070264027567, 3961.425593288957, 4108.958910410857, 4234.470691163605, 4268.210381079511, 4300.376445415397, 9324.300677449219, 9344.719658410258, 9352.579133938989, 9370.90629093714, 9376.765580860396, 4547.636189104864, 4595.012072404449, 4606.976965115153, 4618.815247390134, 4631.0506346198945, 3558.2349794794245, 3647.379945409287, 3990.082281075369, 4163.542010378856, 4169.520505141947, 3602.2075143468396, 3604.873829415958, 3751.174741556853, 3758.586555478895, 3784.9432258516144, 1207.812789017686, 1224.185916365607, 1225.6568160914958, 1229.5757963502576, 1233.9568115115928, 806.1817255485687, 842.6081871929459, 848.4909054567211, 885.6900084970338, 904.7511934218011, 5212.635115541952, 5471.343438787371, 5511.421300763443, 5514.558835293167, 5597.832065038056, 397.5626810508475, 404.98785036448953, 406.23222110211725, 409.4697366909859, 409.7500524679943, 3563.394222982099, 3588.3540962626976, 3675.3016926783826, 3703.425968974759, 3705.27747089315, 9464.100910413637, 9798.510074496247, 9854.802903941882, 9885.50572471388, 9909.75225619351, 8959.5968181432, 9802.50987450639, 9829.950850245703, 9852.950735246279, 9872.45701486425, 7049.89425158623, 7406.074240720018, 7441.069866266716, 7444.330010299099, 7452.180260171377, 5525.171224316224, 5655.604107712586, 5688.800891968761, 5731.828045158652, 5789.652620842763, 9089.818203635758, 9118.863217051618, 9136.0, 9168.679096231599, 9169.312301577274, 9118.544072796467, 9185.081491850762, 9206.217471514996, 9384.0, 9386.624535018524, 6829.52193346461, 6928.272531384334, 6978.651067446709, 6997.4052205561065, 7041.647917603997, 7439.55362678241, 7588.051493563305, 7606.429517786078, 7608.0, 7618.238176182337, 6748.257691654012, 6878.518503704692, 6936.306369363023, 7135.393491553276, 7182.784516464514, 6603.273639899703, 6636.13730215069, 6758.2903795102775, 6800.591964482147, 6825.795226143224, 6091.756329746938, 6210.937890621217, 6217.129601855834, 6223.96888015557, 6240.344763799736, 4321.827126914888, 4356.934645980249, 4643.2802915548145, 4665.5567721066445, 4688.132695451352, 4376.081022985209, 4442.3558584004495, 4563.931541026821, 4591.954080459286, 4725.574698277172], "value": 4084.9832775550212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.20444369097595, 296.3465558443632, 297.7454276593512, 303.77975967423623, 304.3107361825464, 5005.974970125153, 5006.498050584828, 5007.223880298555, 5034.446210916801, 5079.085764562377, 4936.185529387647, 4946.332245146904, 4947.628927830409, 4957.40511138663, 4978.975105124478, 3608.873689420864, 3744.0, 3754.718396120288, 3825.3688141456764, 3926.725129240954, 3885.9028524286978, 3886.475325831019, 3887.300285948528, 3902.439024390238, 3926.3521518949483, 3824.6557809797114, 3845.788481633509, 3867.864624738135, 3877.941830872539, 3884.7086468514976, 3816.141368192162, 3819.8472061117523, 3873.1285460771383, 3881.359575670011, 3918.1380096378894, 3390.1863552747163, 3394.353738436856, 3412.8634854605784, 3423.7945723256435, 3429.228423604694, 4850.927236091461, 4870.707757534559, 4873.415190177166, 4900.142475066849, 4908.754562271872, 4458.821647134111, 4460.5316441773475, 4466.70966387187, 4468.597826195658, 4484.596386325214, 4926.310316555685, 5137.74311284438, 5191.32512773337, 5212.452692467275, 5246.606504512139, 3681.834317455721, 3684.5946945836204, 3687.3731465650903, 3691.667749902522, 3699.907502312437, 5476.452354764531, 5491.835244942618, 5537.529310008654, 5550.917571073643, 5556.805511807067, 3642.453631955175, 3731.272401881607, 3747.5877653458097, 3750.493683352767, 3782.319182547168, 3792.58281589025, 3808.21931504041, 3819.236152769457, 3821.6942644588366, 3828.9617103828605, 4405.229084910128, 4416.38170656102, 4425.690201685851, 4430.313301438217, 4437.556244375537, 5137.8201762938115, 5240.929832716132, 5276.498732620395, 5276.788928442896, 5289.841304760864, 1305.6605282626394, 1312.6390242683337, 1315.276597871167, 1319.182107093608, 1324.4635922451423, 809.1746418652941, 823.7446391618618, 828.5318794880873, 844.3920377328313, 845.3786466946789, 4329.878359603771, 4405.0, 4470.329450582439, 4526.502084770673, 4535.9773201133785, 5335.653182543122, 5353.277307563507, 5365.812196573179, 5392.73036348181, 5395.541378982831, 4514.277715565494, 4563.155816174019, 4565.698775848867, 4569.840055598038, 4572.497025327211, 2649.284693132843, 2781.1934538983874, 2800.957985630217, 2805.410863718601, 2820.450012247633, 4964.404271487445, 4969.428515720666, 4975.5522003019905, 4978.8257410990445, 4994.70031798086, 5193.974030129901, 5435.701036442954, 5460.399356070829, 5460.726963651801, 5469.398366179717, 4975.726335051607, 5044.596432285409, 5055.393352797688, 5055.570276526537, 5068.569171620454, 5403.189521571796, 5410.404855465817, 5410.513053825174, 5433.619646624698, 5452.509274165344, 5230.607704422259, 5276.577873770012, 5297.788088476572, 5347.224652425454, 5364.9731751341, 5061.519155680205, 5061.898762024813, 5077.263796749525, 5080.847574572768, 5097.847064588068, 3743.288775132716, 3794.1842503861803, 3797.411401232813, 3804.1060350816983, 3817.5991520889906, 5333.493318134926, 5387.868547605047, 5421.05131601976, 5495.203195536705, 5504.944950550604, 5165.173572228426, 5180.663256888291, 5196.220566914993, 5197.24639927216, 5221.843344699665, 5103.87240318995, 5118.97440512795, 5143.7428128594165, 5185.766640501111, 5194.194899790538, 4789.8504358952905, 5060.645754797129, 5086.923696144635, 5094.719790411563, 5106.770195341144, 5008.84973450797, 5189.429162792015, 5195.76619052136, 5227.843164705065, 5243.973780131075, 5135.435102138687, 5136.563392111712, 5137.229415587692, 5140.254663073908, 5144.30551875492], "value": 3906.3650738463803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.3668150190559, 701.0675801184425, 732.8021434212762, 747.3050063440998, 758.4501236603467, 12734.617961461148, 13434.193948363105, 13935.860641393583, 14000.229987350704, 14064.929675351608, 12807.359632018384, 12991.0, 13017.218966861996, 13039.21764694119, 13071.08502404832, 708.8298808286025, 730.4229658569724, 760.828813516957, 761.1399118995555, 761.2958013837206, 732.5421611492817, 748.188215785873, 753.1263734068482, 753.8944547763317, 755.9773206803804, 802.2218448105358, 807.8222790986003, 811.736185739634, 812.8740045292959, 813.1015228172872, 793.0919097633235, 794.4756460735945, 797.4856217739525, 804.8229389534293, 805.4603415711458, 583.1340459417761, 583.8277708076085, 584.3513699793226, 584.657975084576, 584.7047241143196, 13755.31223438824, 13845.723085538333, 13925.442982280798, 13931.721365572632, 14011.089279196922, 12999.61001169957, 13408.128471649312, 13411.262380569065, 13479.258640774753, 13491.190528568219, 10569.207309451822, 10597.788044239149, 10630.299152135698, 10718.785624287471, 10738.302010369302, 3281.425750493654, 3293.0943990402593, 3317.6848199421015, 3332.0670212340583, 3425.1094715374184, 67407.3259267406, 67504.6624766873, 68349.0, 68489.31510684929, 68846.65576672135, 10264.230182736324, 10338.638147664795, 10354.482275886327, 10447.373157610567, 10462.947685261524, 19073.904630476758, 19204.327848525234, 19219.711704324447, 19270.22919083221, 19300.90349548243, 6367.172267605181, 6632.966835165793, 6667.299933507009, 6698.095757072831, 6827.214870289881, 3643.7267204959203, 3678.3746763050344, 3717.4795528626014, 3789.5263092113487, 3826.6364695353896, 2874.5113330733825, 2993.925151871177, 3011.7741169411943, 3019.3206528530905, 3019.788614796943, 532.7229840482927, 549.2557584473061, 557.4509108528097, 570.0650932470751, 571.6998575747766, 547.3759913698308, 570.1618620627753, 572.8542914171657, 587.4566026425539, 602.9538750268281, 8010.439269251213, 8369.3304535637, 8532.189442003, 8684.739457816275, 9180.449173049505, 611.0833749375936, 620.3238470067648, 620.5563022438978, 637.1844039629282, 638.741309769544, 3972.4239985201984, 4138.482689663792, 4183.937240941388, 4289.849855255114, 4438.0, 103226.0, 104351.0, 106212.46893765482, 110680.0, 110863.0, 66964.6651766738, 67502.66248668726, 67669.66165169142, 84400.0, 99561.50219248858, 72176.63911680409, 72799.27200727924, 72935.63532182305, 73466.63266683632, 73683.63158184283, 8416.0, 9188.586513607037, 9312.906870931474, 9346.970109705113, 9485.992278146621, 38555.80722096372, 40480.98797530085, 43117.55059595162, 45449.318260226784, 50292.49707502878, 59447.70276148592, 67380.0, 72687.63656181685, 74778.62610686912, 78433.60783196047, 11127.72180695489, 11206.887931120584, 11385.544578216779, 11493.12671832042, 11993.460294286953, 11946.0, 12872.22766634005, 12883.549075782303, 13151.408186631434, 13339.333033348099, 10724.678259652223, 10973.890261097606, 11085.168612354268, 11094.0, 12389.256644600991, 11109.722256943642, 11547.595834145764, 11634.6509604712, 12968.416421261254, 13032.413541390471, 9708.85436718464, 10201.109293324265, 10276.537555810157, 11256.718582035515, 11717.707057323634, 9431.849986006135, 9681.70954871355, 9863.901360986585, 10069.69790906274, 10557.313774604627, 10899.891001090205, 11106.944465277946, 11190.21577011024, 11216.495257713586, 11545.0], "value": 6687.818176797786, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 115.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 130.0, 190.0, 125.0, 126.0, 130.0, 127.0, 159.0, 128.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 176.0, 165.0, 164.0, 162.0, 163.0, 164.0, 162.0, 164.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 110.0, 77.0, 76.0, 76.0, 77.0, 96.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 104.0, 84.0, 82.0, 85.0, 118.0, 84.0, 84.0, 111.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 119.0, 120.0, 118.0, 119.0, 118.0, 120.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 150.0, 147.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 67.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 93.0, 83.0, 87.0, 84.0, 87.0, 82.0, 82.0, 93.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 136.0, 149.0, 139.0, 137.0, 138.0, 150.0, 178.0, 136.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 171.0, 181.0, 178.0, 174.0, 175.0, 173.0, 173.0, 175.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 70.0, 70.0, 70.0, 73.0, 69.0, 72.0, 69.0, 73.0], "value": 71.3, "unit": "score"}]}]} 22:12:44 INFO - Return code: 0 22:12:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:12:44 ERROR - # TBPL SUCCESS # 22:12:44 INFO - Running post-action listener: _resource_record_post_action 22:12:44 INFO - [mozharness: 2016-09-28 05:12:44.470205Z] Finished run-tests step (success) 22:12:44 INFO - Running post-run listener: _resource_record_post_run 22:12:44 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400900096; Read time: 12; Write time: 388124 22:12:44 INFO - TinderboxPrint: CPU usage
13.4% 22:12:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:12:44 INFO - TinderboxPrint: I/O write bytes / time
400,900,096 / 388,124 22:12:44 INFO - TinderboxPrint: CPU idle
8,297.3 (86.6%) 22:12:44 INFO - TinderboxPrint: CPU user
1,217.6 (12.7%) 22:12:44 INFO - TinderboxPrint: Swap in / out
0 / 0 22:12:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110473216; Read time: 0; Write time: 83192 22:12:44 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 290426880; Read time: 0; Write time: 304932 22:12:45 INFO - Running post-run listener: _upload_blobber_files 22:12:45 INFO - Blob upload gear active. 22:12:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:12:45 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 22:12:45 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:12:45 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:12:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:46 INFO - (blobuploader) - INFO - Done attempting. 22:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:47 INFO - (blobuploader) - INFO - Done attempting. 22:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:50 INFO - (blobuploader) - INFO - Done attempting. 22:12:50 INFO - (blobuploader) - INFO - Iteration through files over. 22:12:50 INFO - Return code: 0 22:12:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:12:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:12:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d24b282780ddd3c972107efeba37c7ce69e5091c1a6f08c8eabb9b531e46f5f7d0726412d3cd80b0a466cbfaa1919fda76428f4181de9b0e85ce301546d62e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb4d14ec72fe0de482d3eb9b85ae1c323e04f4e8bc3cd43ff487228fb66a8b40048dea54aaf553e20f7946518af11940837c3427a3bca934198ea34c07b4ced8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb2b0fe20e936a8979f5e767a527fb703b5de6df90ae7873e81967f6aadf4f6446d38ceeb4b7200ebe3961af9977aba337a72c4b48b822d759a7053042268c69"} 22:12:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:12:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:12:50 INFO - Contents: 22:12:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d24b282780ddd3c972107efeba37c7ce69e5091c1a6f08c8eabb9b531e46f5f7d0726412d3cd80b0a466cbfaa1919fda76428f4181de9b0e85ce301546d62e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb4d14ec72fe0de482d3eb9b85ae1c323e04f4e8bc3cd43ff487228fb66a8b40048dea54aaf553e20f7946518af11940837c3427a3bca934198ea34c07b4ced8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb2b0fe20e936a8979f5e767a527fb703b5de6df90ae7873e81967f6aadf4f6446d38ceeb4b7200ebe3961af9977aba337a72c4b48b822d759a7053042268c69"} 22:12:50 INFO - Running post-run listener: copy_logs_to_upload_dir 22:12:50 INFO - Copying logs to upload dir... 22:12:50 INFO - mkdir: /builds/slave/test/build/upload/logs 22:12:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.898165 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-27 22:12:50.427153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 22:12:50.431158) ========= 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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d24b282780ddd3c972107efeba37c7ce69e5091c1a6f08c8eabb9b531e46f5f7d0726412d3cd80b0a466cbfaa1919fda76428f4181de9b0e85ce301546d62e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb4d14ec72fe0de482d3eb9b85ae1c323e04f4e8bc3cd43ff487228fb66a8b40048dea54aaf553e20f7946518af11940837c3427a3bca934198ea34c07b4ced8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb2b0fe20e936a8979f5e767a527fb703b5de6df90ae7873e81967f6aadf4f6446d38ceeb4b7200ebe3961af9977aba337a72c4b48b822d759a7053042268c69"} build_url:https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/bLVBCMmMQNWN2CcvI_LAkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d24b282780ddd3c972107efeba37c7ce69e5091c1a6f08c8eabb9b531e46f5f7d0726412d3cd80b0a466cbfaa1919fda76428f4181de9b0e85ce301546d62e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb4d14ec72fe0de482d3eb9b85ae1c323e04f4e8bc3cd43ff487228fb66a8b40048dea54aaf553e20f7946518af11940837c3427a3bca934198ea34c07b4ced8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb2b0fe20e936a8979f5e767a527fb703b5de6df90ae7873e81967f6aadf4f6446d38ceeb4b7200ebe3961af9977aba337a72c4b48b822d759a7053042268c69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 22:12:50.461902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 22:12:50.462433) ========= 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-1475037675.784839-285673979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 22:12:50.549223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 22:12:50.550165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 22:12:50.550884) ========= ========= Total master_lag: 0.20 =========