builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1471601900.85 results: success (0) buildid: 20160819003004 builduid: 5eb8df980ef64359a083a59680df8d4b revision: 305892e22d9c7b46911ac04aa54423a64883eee1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:20.852183) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:20.852764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:20.853163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:20.868714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:20.869163) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 03:18:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-08-19 03:18:21 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:21.046887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:21.047287) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:21.097105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 03:18:21.097480) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 305892e22d9c7b46911ac04aa54423a64883eee1 --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 305892e22d9c7b46911ac04aa54423a64883eee1 --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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 03:18:21,274 truncating revision to first 12 chars 2016-08-19 03:18:21,274 Setting DEBUG logging. 2016-08-19 03:18:21,274 attempt 1/10 2016-08-19 03:18:21,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/305892e22d9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 03:18:22,386 unpacking tar archive at: autoland-305892e22d9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 03:18:22.604649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:22.605024) ========= script_repo_revision: 305892e22d9c7b46911ac04aa54423a64883eee1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:22.605418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:22.605690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 03:18:22.615159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-19 03:18:22.615549) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:22 INFO - MultiFileLogger online at 20160819 03:18:22 in /builds/slave/test 03:18:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:18:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:22 INFO - {'append_to_log': False, 03:18:22 INFO - 'base_work_dir': '/builds/slave/test', 03:18:22 INFO - 'blob_upload_branch': 'Autoland', 03:18:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:22 INFO - 'branch': 'Autoland', 03:18:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:22 INFO - 'config_files': ('talos/linux_config.py',), 03:18:22 INFO - 'default_actions': ('clobber', 03:18:22 INFO - 'read-buildbot-config', 03:18:22 INFO - 'download-and-extract', 03:18:22 INFO - 'populate-webroot', 03:18:22 INFO - 'create-virtualenv', 03:18:22 INFO - 'install', 03:18:22 INFO - 'run-tests'), 03:18:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:22 INFO - 'download_minidump_stackwalk': True, 03:18:22 INFO - 'download_symbols': 'ondemand', 03:18:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:22 INFO - 'installer_path': 'installer.exe', 03:18:22 INFO - 'log_level': 'info', 03:18:22 INFO - 'log_name': 'talos', 03:18:22 INFO - 'log_to_console': True, 03:18:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:22 INFO - 'opt_config_files': (), 03:18:22 INFO - 'pip_index': False, 03:18:22 INFO - 'sps_profile': False, 03:18:22 INFO - 'sps_profile_interval': 0, 03:18:22 INFO - 'suite': 'dromaeojs', 03:18:22 INFO - 'system_bits': '32', 03:18:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:22 INFO - 'title': 'talos-linux64-ix-006', 03:18:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:22 INFO - 'use_talos_json': True, 03:18:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:22 INFO - 'work_dir': 'build'} 03:18:22 INFO - [mozharness: 2016-08-19 10:18:22.886635Z] Running clobber step. 03:18:22 INFO - Running pre-action listener: _resource_record_pre_action 03:18:22 INFO - Running main action method: clobber 03:18:22 INFO - rmtree: /builds/slave/test/build 03:18:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:23 INFO - Running post-action listener: _resource_record_post_action 03:18:23 INFO - [mozharness: 2016-08-19 10:18:23.857228Z] Finished clobber step (success) 03:18:23 INFO - [mozharness: 2016-08-19 10:18:23.857349Z] Running read-buildbot-config step. 03:18:23 INFO - Running pre-action listener: _resource_record_pre_action 03:18:23 INFO - Running main action method: read_buildbot_config 03:18:23 INFO - Using buildbot properties: 03:18:23 INFO - { 03:18:23 INFO - "project": "", 03:18:23 INFO - "product": "firefox", 03:18:23 INFO - "script_repo_revision": "production", 03:18:23 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:18:23 INFO - "repository": "", 03:18:23 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:18:23 INFO - "buildid": "20160819003004", 03:18:23 INFO - "pgo_build": "True", 03:18:23 INFO - "basedir": "/builds/slave/test", 03:18:23 INFO - "buildnumber": 137, 03:18:23 INFO - "slavename": "talos-linux64-ix-006", 03:18:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:23 INFO - "platform": "ubuntu64_hw", 03:18:23 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:18:23 INFO - "branch": "autoland", 03:18:23 INFO - "repo_path": "integration/autoland", 03:18:23 INFO - "revision": "305892e22d9c7b46911ac04aa54423a64883eee1", 03:18:23 INFO - "stage_platform": "linux64-pgo", 03:18:23 INFO - "builduid": "5eb8df980ef64359a083a59680df8d4b", 03:18:23 INFO - "slavebuilddir": "test" 03:18:23 INFO - } 03:18:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:18:23 INFO - Running post-action listener: _resource_record_post_action 03:18:23 INFO - [mozharness: 2016-08-19 10:18:23.859767Z] Finished read-buildbot-config step (success) 03:18:23 INFO - [mozharness: 2016-08-19 10:18:23.859855Z] Running download-and-extract step. 03:18:23 INFO - Running pre-action listener: _resource_record_pre_action 03:18:23 INFO - Running main action method: download_and_extract 03:18:23 INFO - mkdir: /builds/slave/test/build/tests 03:18: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')]} 03:18:23 INFO - trying https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:23 INFO - Downloading https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:18:24 INFO - Downloaded 1361 bytes. 03:18:24 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:24 INFO - Using the following test package requirements: 03:18:24 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:24 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:24 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:18:24 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'jsshell-linux-x86_64.zip'], 03:18:24 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:24 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:24 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:18:24 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:18:24 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:24 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:24 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:24 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')]} 03:18:24 INFO - trying https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:24 INFO - Downloading https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:25 INFO - Downloaded 21907529 bytes. 03:18:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:18:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:29 INFO - trying https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:30 INFO - Downloaded 21907529 bytes. 03:18:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:18: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')]} 03:18:35 INFO - trying https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:35 INFO - Downloading https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:18:35 INFO - Downloaded 14413981 bytes. 03:18:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 03:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:36 INFO - trying https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:36 INFO - Downloading https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:18:37 INFO - Downloaded 59603851 bytes. 03:18:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:37 INFO - mkdir: /builds/slave/test/properties 03:18:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:37 INFO - Contents: 03:18:37 INFO - build_url:https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:37 INFO - Running post-action listener: _resource_record_post_action 03:18:37 INFO - Running post-action listener: set_extra_try_arguments 03:18:37 INFO - [mozharness: 2016-08-19 10:18:37.934891Z] Finished download-and-extract step (success) 03:18:37 INFO - [mozharness: 2016-08-19 10:18:37.935186Z] Running populate-webroot step. 03:18:37 INFO - Running pre-action listener: _resource_record_pre_action 03:18:37 INFO - Running main action method: populate_webroot 03:18:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:37 INFO - '--tppagecycles', 03:18:37 INFO - '7'], 03:18:37 INFO - 'tests': ['tsvgm']}}, 03:18:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['damp', 'tps']}, 03:18:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'tests': ['damp', 'tps']}, 03:18:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['dromaeo_dom']}, 03:18:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['basic_compositor_video']}, 03:18:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:18:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['a11yr', 03:18:37 INFO - 'ts_paint', 03:18:37 INFO - 'tpaint', 03:18:37 INFO - 'sessionrestore', 03:18:37 INFO - 'sessionrestore_no_auto_restore', 03:18:37 INFO - 'tabpaint']}, 03:18:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['tsvgx', 03:18:37 INFO - 'tsvgr_opacity', 03:18:37 INFO - 'tart', 03:18:37 INFO - 'tscrollx', 03:18:37 INFO - 'cart']}, 03:18:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:37 INFO - 'tsvgr_opacity', 03:18:37 INFO - 'tart', 03:18:37 INFO - 'tscrollx', 03:18:37 INFO - 'cart']}, 03:18:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'talos_options': ['--disable-e10s'], 03:18:37 INFO - 'tests': ['tp5o']}, 03:18:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'tests': ['tp5o']}, 03:18:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'talos_options': ['--disable-e10s', 03:18:37 INFO - '--xperf_path', 03:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:37 INFO - 'tests': ['tp5n']}, 03:18:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:37 INFO - 'talos_options': ['--xperf_path', 03:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:37 INFO - 'tests': ['tp5n']}}, 03:18:37 INFO - 'talos.zip': {'path': '', 03:18:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:37 INFO - Running post-action listener: _resource_record_post_action 03:18:37 INFO - [mozharness: 2016-08-19 10:18:37.956688Z] Finished populate-webroot step (success) 03:18:37 INFO - [mozharness: 2016-08-19 10:18:37.956781Z] Running create-virtualenv step. 03:18:37 INFO - Running pre-action listener: _resource_record_pre_action 03:18:37 INFO - Running main action method: create_virtualenv 03:18:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:37 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 03:18:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:38 INFO - Using real prefix '/usr' 03:18:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:40 INFO - Installing pip.................done. 03:18:40 INFO - Return code: 0 03:18:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:40 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')]} 03:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:40 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')]} 03:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:40 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:40 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 03:18:40 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 03:18:40 INFO - Using env: {'DISPLAY': ':0', 03:18:40 INFO - 'HOME': '/home/cltbld', 03:18:40 INFO - 'LANG': 'en_US.UTF-8', 03:18:40 INFO - 'LANGUAGE': 'en_US:en', 03:18:40 INFO - 'LOGNAME': 'cltbld', 03:18:40 INFO - 'MAIL': '/var/mail/cltbld', 03:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:40 INFO - 'MOZ_NO_REMOTE': '1', 03:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:40 INFO - 'NO_EM_RESTART': '1', 03:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:40 INFO - 'PWD': '/builds/slave/test', 03:18:40 INFO - 'SHELL': '/bin/bash', 03:18:40 INFO - 'SHLVL': '1', 03:18:40 INFO - 'TERM': 'linux', 03:18:40 INFO - 'TMOUT': '86400', 03:18:40 INFO - 'USER': 'cltbld', 03:18:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:40 INFO - '_': '/tools/buildbot/bin/python'} 03:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:40 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 03:18:40 INFO - Cleaning up... 03:18:40 INFO - Return code: 0 03:18:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:40 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')]} 03:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:40 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')]} 03:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:40 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:40 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 03:18:40 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 03:18:40 INFO - Using env: {'DISPLAY': ':0', 03:18:40 INFO - 'HOME': '/home/cltbld', 03:18:40 INFO - 'LANG': 'en_US.UTF-8', 03:18:40 INFO - 'LANGUAGE': 'en_US:en', 03:18:40 INFO - 'LOGNAME': 'cltbld', 03:18:40 INFO - 'MAIL': '/var/mail/cltbld', 03:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:40 INFO - 'MOZ_NO_REMOTE': '1', 03:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:40 INFO - 'NO_EM_RESTART': '1', 03:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:40 INFO - 'PWD': '/builds/slave/test', 03:18:40 INFO - 'SHELL': '/bin/bash', 03:18:40 INFO - 'SHLVL': '1', 03:18:40 INFO - 'TERM': 'linux', 03:18:40 INFO - 'TMOUT': '86400', 03:18:40 INFO - 'USER': 'cltbld', 03:18:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:40 INFO - '_': '/tools/buildbot/bin/python'} 03:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:40 INFO - Downloading/unpacking psutil>=3.1.1 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 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 03:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:42 INFO - Installing collected packages: psutil 03:18:42 INFO - Running setup.py install for psutil 03:18:43 INFO - building 'psutil._psutil_linux' extension 03:18:43 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 03:18:43 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 03:18:43 INFO - building 'psutil._psutil_posix' extension 03:18:43 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 03:18:43 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 03:18:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:43 INFO - Successfully installed psutil 03:18:43 INFO - Cleaning up... 03:18:43 INFO - Return code: 0 03:18:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:18:43 INFO - Using env: {'DISPLAY': ':0', 03:18:43 INFO - 'HOME': '/home/cltbld', 03:18:43 INFO - 'LANG': 'en_US.UTF-8', 03:18:43 INFO - 'LANGUAGE': 'en_US:en', 03:18:43 INFO - 'LOGNAME': 'cltbld', 03:18:43 INFO - 'MAIL': '/var/mail/cltbld', 03:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:43 INFO - 'MOZ_NO_REMOTE': '1', 03:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:43 INFO - 'NO_EM_RESTART': '1', 03:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:43 INFO - 'PWD': '/builds/slave/test', 03:18:43 INFO - 'SHELL': '/bin/bash', 03:18:43 INFO - 'SHLVL': '1', 03:18:43 INFO - 'TERM': 'linux', 03:18:43 INFO - 'TMOUT': '86400', 03:18:43 INFO - 'USER': 'cltbld', 03:18:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:43 INFO - '_': '/tools/buildbot/bin/python'} 03:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:45 INFO - Installing collected packages: mozsystemmonitor 03:18:45 INFO - Running setup.py install for mozsystemmonitor 03:18:45 INFO - Successfully installed mozsystemmonitor 03:18:45 INFO - Cleaning up... 03:18:45 INFO - Return code: 0 03:18:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:45 INFO - Using env: {'DISPLAY': ':0', 03:18:45 INFO - 'HOME': '/home/cltbld', 03:18:45 INFO - 'LANG': 'en_US.UTF-8', 03:18:45 INFO - 'LANGUAGE': 'en_US:en', 03:18:45 INFO - 'LOGNAME': 'cltbld', 03:18:45 INFO - 'MAIL': '/var/mail/cltbld', 03:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:45 INFO - 'MOZ_NO_REMOTE': '1', 03:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:45 INFO - 'NO_EM_RESTART': '1', 03:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:45 INFO - 'PWD': '/builds/slave/test', 03:18:45 INFO - 'SHELL': '/bin/bash', 03:18:45 INFO - 'SHLVL': '1', 03:18:45 INFO - 'TERM': 'linux', 03:18:45 INFO - 'TMOUT': '86400', 03:18:45 INFO - 'USER': 'cltbld', 03:18:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:45 INFO - '_': '/tools/buildbot/bin/python'} 03:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:45 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:45 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 03:18:45 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 03:18:45 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 03:18:45 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 03:18:45 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 03:18:45 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 03:18:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:47 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 03:18:47 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 03:18:47 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 03:18:47 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 03:18:47 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 03:18:47 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 03:18:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:48 INFO - warning: no files found matching '*.txt' 03:18:48 INFO - no previously-included directories found matching 'build' 03:18:48 INFO - no previously-included directories found matching 'dist' 03:18:48 INFO - no previously-included directories found matching '.git*' 03:18:48 INFO - Installing collected packages: jsonschema, functools32 03:18:48 INFO - Running setup.py install for functools32 03:18:48 INFO - warning: no files found matching '*.txt' 03:18:48 INFO - no previously-included directories found matching 'build' 03:18:48 INFO - no previously-included directories found matching 'dist' 03:18:48 INFO - no previously-included directories found matching '.git*' 03:18:48 INFO - Successfully installed jsonschema functools32 03:18:48 INFO - Cleaning up... 03:18:48 INFO - Return code: 0 03:18:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:48 INFO - Cleaning up... 03:18:48 INFO - Return code: 0 03:18:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - Downloading docopt-0.6.1.tar.gz 03:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:51 INFO - Running setup.py install for blobuploader 03:18:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:51 INFO - Running setup.py install for requests 03:18:51 INFO - Running setup.py install for docopt 03:18:51 INFO - Successfully installed blobuploader requests docopt 03:18:51 INFO - Cleaning up... 03:18:52 INFO - Return code: 0 03:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:52 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:52 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 03:18:52 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 03:18:52 INFO - Using env: {'DISPLAY': ':0', 03:18:52 INFO - 'HOME': '/home/cltbld', 03:18:52 INFO - 'LANG': 'en_US.UTF-8', 03:18:52 INFO - 'LANGUAGE': 'en_US:en', 03:18:52 INFO - 'LOGNAME': 'cltbld', 03:18:52 INFO - 'MAIL': '/var/mail/cltbld', 03:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:52 INFO - 'MOZ_NO_REMOTE': '1', 03:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:52 INFO - 'NO_EM_RESTART': '1', 03:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:52 INFO - 'PWD': '/builds/slave/test', 03:18:52 INFO - 'SHELL': '/bin/bash', 03:18:52 INFO - 'SHLVL': '1', 03:18:52 INFO - 'TERM': 'linux', 03:18:52 INFO - 'TMOUT': '86400', 03:18:52 INFO - 'USER': 'cltbld', 03:18:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:52 INFO - '_': '/tools/buildbot/bin/python'} 03:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:52 INFO - Running setup.py (path:/tmp/pip-4fFMtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:52 INFO - Running setup.py (path:/tmp/pip-9TkFvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:52 INFO - Running setup.py (path:/tmp/pip-Od6HfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:52 INFO - Running setup.py (path:/tmp/pip-rMwu5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:52 INFO - Running setup.py (path:/tmp/pip-Y8v264-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:52 INFO - Running setup.py (path:/tmp/pip-E53sMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:52 INFO - Running setup.py (path:/tmp/pip-KdCg5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:52 INFO - Running setup.py (path:/tmp/pip-cWu2uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:52 INFO - Running setup.py (path:/tmp/pip-r_UjKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:52 INFO - Running setup.py (path:/tmp/pip-fJ937U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:52 INFO - Running setup.py (path:/tmp/pip-0rq6ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:53 INFO - Running setup.py (path:/tmp/pip-1q9inE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:53 INFO - Running setup.py (path:/tmp/pip-_xR3KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:53 INFO - Running setup.py (path:/tmp/pip-peeX_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:53 INFO - Running setup.py (path:/tmp/pip-pUoSs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:53 INFO - Running setup.py (path:/tmp/pip-kxOGnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:53 INFO - Running setup.py (path:/tmp/pip-Kz156Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:53 INFO - Running setup.py install for manifestparser 03:18:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:53 INFO - Running setup.py install for mozcrash 03:18:53 INFO - Running setup.py install for mozdebug 03:18:53 INFO - Running setup.py install for mozdevice 03:18:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:53 INFO - Running setup.py install for mozfile 03:18:53 INFO - Running setup.py install for mozhttpd 03:18:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for mozinfo 03:18:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for mozInstall 03:18:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for mozleak 03:18:54 INFO - Running setup.py install for mozlog 03:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for moznetwork 03:18:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for mozprocess 03:18:54 INFO - Running setup.py install for mozprofile 03:18:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:54 INFO - Running setup.py install for mozrunner 03:18:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:55 INFO - Running setup.py install for mozscreenshot 03:18:55 INFO - Running setup.py install for moztest 03:18:55 INFO - Running setup.py install for mozversion 03:18:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:55 INFO - Cleaning up... 03:18:55 INFO - Return code: 0 03:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:55 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')]} 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:55 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')]} 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:55 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:55 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 03:18:55 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 03:18:55 INFO - Using env: {'DISPLAY': ':0', 03:18:55 INFO - 'HOME': '/home/cltbld', 03:18:55 INFO - 'LANG': 'en_US.UTF-8', 03:18:55 INFO - 'LANGUAGE': 'en_US:en', 03:18:55 INFO - 'LOGNAME': 'cltbld', 03:18:55 INFO - 'MAIL': '/var/mail/cltbld', 03:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:55 INFO - 'MOZ_NO_REMOTE': '1', 03:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:55 INFO - 'NO_EM_RESTART': '1', 03:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:55 INFO - 'PWD': '/builds/slave/test', 03:18:55 INFO - 'SHELL': '/bin/bash', 03:18:55 INFO - 'SHLVL': '1', 03:18:55 INFO - 'TERM': 'linux', 03:18:55 INFO - 'TMOUT': '86400', 03:18:55 INFO - 'USER': 'cltbld', 03:18:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:55 INFO - '_': '/tools/buildbot/bin/python'} 03:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:55 INFO - Running setup.py (path:/tmp/pip-m7TZBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:55 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)) 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:55 INFO - Running setup.py (path:/tmp/pip-sqGmay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:55 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)) 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:55 INFO - Running setup.py (path:/tmp/pip-mV7OvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:55 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)) 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:55 INFO - Running setup.py (path:/tmp/pip-a6HCRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:55 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)) 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:55 INFO - Running setup.py (path:/tmp/pip-o2ewnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:55 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)) 03:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:55 INFO - Running setup.py (path:/tmp/pip-4Dxf9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:56 INFO - Running setup.py (path:/tmp/pip-okudld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:56 INFO - Running setup.py (path:/tmp/pip-lDn8lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:56 INFO - Running setup.py (path:/tmp/pip-utRlC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:56 INFO - Running setup.py (path:/tmp/pip-FQLMdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:56 INFO - Running setup.py (path:/tmp/pip-eId1vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:56 INFO - Running setup.py (path:/tmp/pip-x9zRhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:56 INFO - Running setup.py (path:/tmp/pip-MuE0dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:56 INFO - Running setup.py (path:/tmp/pip-m5DLMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:56 INFO - Running setup.py (path:/tmp/pip-dPMAEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:56 INFO - Running setup.py (path:/tmp/pip-WLg3fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:56 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)) 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:56 INFO - Running setup.py (path:/tmp/pip-B2Zm6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:56 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)) 03:18:56 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)) 03:18:56 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)) 03:18:56 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)) 03:18:56 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)) 03:18:56 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)) 03:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:58 INFO - Downloading blessings-1.6.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:58 INFO - Installing collected packages: blessings 03:18:58 INFO - Running setup.py install for blessings 03:18:58 INFO - Successfully installed blessings 03:18:58 INFO - Cleaning up... 03:18:58 INFO - Return code: 0 03:18:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:59 INFO - Reading from file tmpfile_stdout 03:18:59 INFO - Current package versions: 03:18:59 INFO - argparse == 1.2.1 03:18:59 INFO - blessings == 1.6 03:18:59 INFO - blobuploader == 1.2.4 03:18:59 INFO - docopt == 0.6.1 03:18:59 INFO - functools32 == 3.2.3-2 03:18:59 INFO - jsonschema == 2.5.1 03:18:59 INFO - manifestparser == 1.1 03:18:59 INFO - mozInstall == 1.12 03:18:59 INFO - mozcrash == 0.17 03:18:59 INFO - mozdebug == 0.1 03:18:59 INFO - mozdevice == 0.48 03:18:59 INFO - mozfile == 1.2 03:18:59 INFO - mozhttpd == 0.7 03:18:59 INFO - mozinfo == 0.9 03:18:59 INFO - mozleak == 0.1 03:18:59 INFO - mozlog == 3.3 03:18:59 INFO - moznetwork == 0.27 03:18:59 INFO - mozprocess == 0.23 03:18:59 INFO - mozprofile == 0.28 03:18:59 INFO - mozrunner == 6.12 03:18:59 INFO - mozscreenshot == 0.1 03:18:59 INFO - mozsystemmonitor == 0.3 03:18:59 INFO - moztest == 0.7 03:18:59 INFO - mozversion == 1.4 03:18:59 INFO - psutil == 3.1.1 03:18:59 INFO - requests == 1.2.3 03:18:59 INFO - wsgiref == 0.1.2 03:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:59 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 03:18:59 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 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 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)) 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 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 0x7fbe95146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d38d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', '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 03:18:59 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 03:18:59 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 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Running post-action listener: _resource_record_post_action 03:18:59 INFO - Running post-action listener: _start_resource_monitoring 03:18:59 INFO - Starting resource monitoring. 03:18:59 INFO - [mozharness: 2016-08-19 10:18:59.654533Z] Finished create-virtualenv step (success) 03:18:59 INFO - [mozharness: 2016-08-19 10:18:59.655043Z] Running install step. 03:18:59 INFO - Running pre-action listener: _resource_record_pre_action 03:18:59 INFO - Running main action method: install 03:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:59 INFO - Reading from file tmpfile_stdout 03:18:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:59 INFO - Reading from file tmpfile_stdout 03:18:59 INFO - Output received: 03:18:59 INFO - Usage: mozinstall [options] installer 03:18:59 INFO - Options: 03:18:59 INFO - -h, --help show this help message and exit 03:18:59 INFO - -d DEST, --destination=DEST 03:18:59 INFO - Directory to install application into. [default: 03:18:59 INFO - "/builds/slave/test"] 03:18:59 INFO - --app=APP Application being installed. [default: firefox] 03:18:59 INFO - mkdir: /builds/slave/test/build/application 03:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:19:16 INFO - Reading from file tmpfile_stdout 03:19:16 INFO - Output received: 03:19:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:16 INFO - Running post-action listener: _resource_record_post_action 03:19:16 INFO - [mozharness: 2016-08-19 10:19:16.924688Z] Finished install step (success) 03:19:16 INFO - [mozharness: 2016-08-19 10:19:16.924934Z] Running run-tests step. 03:19:16 INFO - Running pre-action listener: _resource_record_pre_action 03:19:16 INFO - Running main action method: run_tests 03:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:16 INFO - Python 2.7.3 03:19:16 INFO - Return code: 0 03:19:16 INFO - grabbing minidump binary from tooltool 03:19:16 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')]} 03:19:16 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 0x2462760>, '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 0x2463660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2463af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:16 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 03:19:16 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 03:19:16 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 03:19:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:17 INFO - Return code: 0 03:19:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:19:17 INFO - Using env: {'DISPLAY': ':0', 03:19:17 INFO - 'HOME': '/home/cltbld', 03:19:17 INFO - 'LANG': 'en_US.UTF-8', 03:19:17 INFO - 'LANGUAGE': 'en_US:en', 03:19:17 INFO - 'LOGNAME': 'cltbld', 03:19:17 INFO - 'MAIL': '/var/mail/cltbld', 03:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:17 INFO - 'MOZ_NO_REMOTE': '1', 03:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:17 INFO - 'NO_EM_RESTART': '1', 03:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:17 INFO - 'PWD': '/builds/slave/test', 03:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:17 INFO - 'SHELL': '/bin/bash', 03:19:17 INFO - 'SHLVL': '1', 03:19:17 INFO - 'TERM': 'linux', 03:19:17 INFO - 'TMOUT': '86400', 03:19:17 INFO - 'USER': 'cltbld', 03:19:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169', 03:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:17 INFO - '_': '/tools/buildbot/bin/python'} 03:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:19:17 INFO - mozversion application_buildid: 20160819003004 03:19:17 INFO - mozversion application_changeset: 305892e22d9c7b46911ac04aa54423a64883eee1 03:19:17 INFO - mozversion application_display_name: Nightly 03:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:17 INFO - mozversion application_name: Firefox 03:19:17 INFO - mozversion application_remotingname: firefox 03:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:19:17 INFO - mozversion application_vendor: Mozilla 03:19:17 INFO - mozversion application_version: 51.0a1 03:19:17 INFO - mozversion platform_buildid: 20160819003004 03:19:17 INFO - mozversion platform_changeset: 305892e22d9c7b46911ac04aa54423a64883eee1 03:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:19:17 INFO - mozversion platform_version: 51.0a1 03:19:17 INFO - using testdate: 1471601957 03:19:17 INFO - actual date: 1471601957 03:19:17 INFO - starting webserver on 'localhost:45465' 03:19:17 INFO - SUITE-START | Running 2 tests 03:19:17 INFO - TEST-START | dromaeo_css 03:19:17 INFO - operating with platform_type : linux_ 03:19:17 INFO - Initialising browser for dromaeo_css test... 03:19:17 INFO - TEST-INFO | started process 5350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdruiL/profile http://localhost:45465/getInfo.html) 03:19:21 INFO - PROCESS | 5350 | __metrics Screen width/height:1600/1200 03:19:21 INFO - PROCESS | 5350 | colorDepth:24 03:19:21 INFO - PROCESS | 5350 | Browser inner width/height: 1024/697 03:19:21 INFO - PROCESS | 5350 | __metrics 03:19:21 INFO - PROCESS | 5350 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:19:21 INFO - PROCESS | 5350 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:22 INFO - PROCESS | 5350 | console.error: PushService: 03:19:22 INFO - PROCESS | 5350 | stateChangeProcessEnqueue: Error transitioning state 03:19:22 INFO - PROCESS | 5350 | UnknownError 03:19:22 INFO - TEST-INFO | 5350: exit 0 03:19:22 INFO - Browser initialized. 03:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:22 INFO - TEST-INFO | started process 5432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdruiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:34 INFO - PROCESS | 5432 | RSS: Main: 156217344 03:19:34 INFO - PROCESS | 5432 | 03:20:26 INFO - PROCESS | 5432 | 1471602026181 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] 03:22:35 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45465/tests/dromaeo/cssquery-ext.html) 03:22:36 INFO - PROCESS | 5432 | RSS: Main: 244187136 03:22:36 INFO - PROCESS | 5432 | 03:25:38 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-ext.html (next: http://localhost:45465/tests/dromaeo/cssquery-jquery.html) 03:25:39 INFO - PROCESS | 5432 | RSS: Main: 244215808 03:25:39 INFO - PROCESS | 5432 | 03:28:41 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45465/tests/dromaeo/cssquery-mootools.html) 03:28:41 INFO - PROCESS | 5432 | RSS: Main: 216125440 03:28:41 INFO - PROCESS | 5432 | 03:31:43 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45465/tests/dromaeo/cssquery-prototype.html) 03:31:44 INFO - PROCESS | 5432 | RSS: Main: 235376640 03:31:44 INFO - PROCESS | 5432 | 03:34:47 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45465/tests/dromaeo/cssquery-yui.html) 03:34:47 INFO - PROCESS | 5432 | RSS: Main: 186462208 03:34:47 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:45465/tests/dromaeo/cssquery-yui.html (next: http://localhost:45465/tests/dromaeo/cssquery-dojo.html) 03:37:51 INFO - PROCESS | 5432 | RSS: Main: 275116032 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | __start_tp_report 03:37:51 INFO - PROCESS | 5432 | _x_x_mozilla_page_load 03:37:51 INFO - PROCESS | 5432 | _x_x_mozilla_page_load_details 03:37:51 INFO - PROCESS | 5432 | |i|pagename|runs| 03:37:51 INFO - PROCESS | 5432 | |0;dojo.html;2987.2681193107687;3003.6395632524072;3022.48617734985;3032.7422169115625;3033.2871775132826;5112.105381558222;5162.303089082972;5223.71269580173;5343.652662576935;5392.056390131726;5211.5830733541325;5239.056969745444;5286.920696189561;5287.709175995319;5323.920141197885;4691.62467002639;4733.81064757411;4758.095961767253;4769.141554520185;4891.682040667363;4899.853004409873;4904.215325547913;4917.72952487613;4923.163062279421;4946.629002824785;4694.0611877624615;4720.339152518616;4846.442659094214;4887.535684110022;4892.437369702477;4679.555442233016;4684.836030738942;4686.859394218179;4710.788014539354;4720.811167553294;4654.394928659286;4668.486466488684;4681.719096854165;4760;4773.451053128865;5075.974620126913;5194.324737784102;5213.53078222958;5246.186841039645;5248.790048398059;5588.580856435784;5602.271704678406;5657.490825825655;5659.943400565983;5661.547076233891;5658.0381335173115;5659.518940889988;5699.202111704365;5705.315362156568;5712.371639119693;5143.61422893277;5251.054810134213;5311.070562651521;5314.60140489461;5320.095583750772;5770.278715160605;5879;5879.441453061952;5883.470487656132;5884.882302354014;5638.774449022075;5649.68926709035;5650.491455769001;5650.943490565041;5656.943430565724;5669.461401166883;5703.144528320785;5715.828525144252;5716.685582293014;5718.256626638594;5430.15832545956;5435.456454354533;5448.591355648263;5471.616986810965;5600.747966341524;5483.314585676791;5557.944420555824;5562.193481945176;5601.355844077902;5609.747561359749;4294.677899157576;4295.926018495376;4298.3552467130185;4303.354496825501;4311.310190369526;3810.9809450952566;3829.885103446901;3855.094052897567;3868.129670824042;3885.320068987916;5367.651102678314;5371.838844834661;5394.568434525228;5413.377461591888;5415.079436495806;5640.915386269209;5642.322921249476;5654.802081927113;5655.321361436571;5656.60403771732;5180.81867134656;5206.140986737146;5261.552768014685;5361.195820626937;5367.919481207785;4862.586680132228;4864.027194561102;4868.440129385095;4888.291197776302;4907.092187945242;5698.202251684685;5742.08126699726;5747.885042299131;5748.597598168088;5794.478496935296;5425.43032981547;5498.862528436821;5535.806246781343;5543.085390910454;5583.69289689071;5797.652140871562;5799;5805.448482394166;5838.12428135783;5858.970705146447;5485.670859748428;5501.174823776306;5505.449455054462;5505.944940550704;5511.972440137773;5448.509634132947;5479.205515200194;5523.6409633373705;5597.552195824405;5608.4111168326735;5424.728763561885;5435.891282174255;5440.42875498067;5467.781288748405;5487.807926722546;5431;5431.755570999394;5459.945400545944;5483.232347471437;5538.667679939216;5197.24639927216;5363.0614642438195;5404.594655400782;5428.945710542844;5430.592705547021;5536.889262214814;5540.307461567304;5550.55595552363;5577.52591029767;5591.6365436246515;5418.403975562606;5418.593605479684;5425.538829199562;5428.131498960148;5428.294321738149 03:37:51 INFO - PROCESS | 5432 | |1;ext.html;595.7646729541831;603.3453702732535;604.9655089796448;625.5183508698301;627.6014730646039;32488.350232995326;43020.784896075515;44059.11881762367;44171.558284417144;47644.28533571999;46541.534584654146;46938.642917472556;46996.765016174955;47006.529934700644;47054.76472617632;8076.313513351342;8871.11288871111;9004.549772511347;9006.504642244674;9015.36892417531;7987.440879138463;8211.507309561415;10610.20423468243;10881.83677244842;10903.29128606638;11037.282576632533;11101.500432480558;11112.611058612909;11112.833307500394;11114.777704445905;10895.782084358309;10941.945290273577;10948.562057517689;10961.99999999996;10968.451577421098;10756.139508839275;10774.437706532588;10826.566937322497;10848.511816968256;10849.077828384598;43409;43689.126217475474;43711.344329835076;43738.78130609327;43779.12441751147;3737.0657335666083;3752.624737526253;3876.612338766129;4076.5311989121333;4325.178216138955;32297.67702322994;32959.176020599436;33094.17264568381;33144.83427582871;33265.66734332674;4235.512916014667;4315.784210789448;4326.242907491176;4457.77711114443;4517.277235642281;390002;394880;394883;395057;395977.0201149005;60522;60869.69565152146;60876.69561652163;60897.95510224471;60925;64071;64460.35539644543;64690.35309646937;64846;64990.35009649937;15148;15310.923445382925;15314.310856011283;15332.770008449883;15354.769678454832;10819.621313253998;11746.941265293619;11758.470868810924;11806.94096529529;11807.645770626896;17735.379261726037;18053.909730451527;18186.818131818512;18652.533686657942;19070.713939290923;6259.217597800275;6368.554201205964;6406.782711284841;6532.183477065367;6580.440662543641;824.8556502612018;856.9657213711506;909.4316052467208;951.296040929707;961.4615815143542;25958.480830383665;26775.86612066927;27648.170554883385;27764.16707498778;27958.161255162377;923.9538023098818;949.8765160529088;973.2408721197336;1042.6559235452282;1064.7923654887377;14135.15189088658;14436.278186090654;14449.638759031108;14703.485378011717;14723.411063557338;486085;489737;490516;490594;494826;59296.40703592995;59395.703021484616;59453.702731486934;59463.108053379234;59504.40495594989;1224.8468941382328;1292.1084451728277;1296.4360503181147;1377.1461693749939;1377.9862201378057;23488;27322.5901611472;27814;29701.115523159868;29996.85001574978;56953.43046569647;58058;58162.709186453794;58250;58287.70856145692;466307;467687;468172;468315;468899;28334.71665283321;29355.266118347212;29358.55962160612;43027.784861075495;43406.34890476709;48953.75523122504;49960.500394995586;49967.75016125041;49988.250176246656;50351;40927.38608920928;41331.58668413277;41412.585874140874;41899.58100418957;43714.34428483512;40408.78773636796;40498.3708641654;41807.58192418037;41865.162696746505;42023.15953680848;33965.3206935855;35372.646273536935;35412.64587354093;35469.113272168404;35485.64514354823;33718;37383.626163738016;37547;37709.81145094257;38360.42459363167;22259.888700556392;22292.442688932908;22371;22543.323700289016;22632.773672263724 03:37:51 INFO - PROCESS | 5432 | |2;jquery.html;367.67644472863907;388.2429262937271;390.826082393335;396.67274498538706;419.3939757051061;16683.666326673458;19668.409947701573;19719.211231550722;19867.801321986793;20528.692069618966;17792.110394480256;18162.5459363516;18222;18378.264869405208;18579.535511612215;5250.842474725764;5741.253637027191;5963.4334738199805;5986.2517185351835;5990.011648078062;5907.379725128864;5943.227380440537;5970.73131709072;5979.85050373742;5986.341502434729;5691.686957217351;5858.648481091127;5896.351401345849;5956.076808094731;5957;5910.822675319747;5922.082077278007;5935.6141850779995;5943.197668314765;5947.048472244442;5073.162928116893;5146.794128234867;5186.740662966837;5192.55863251624;5197.558207552363;22318.43338016133;22868.31395058151;23012.309630711105;23725.762742372528;24005.15981940641;2365.3022358404314;2452.730199678034;2545.8217924745277;2757.986210068937;3121.7034381733697;14534.328552216524;14590.489332873298;15044.774328385083;15542.580632260884;15669.373225070984;1923.874533397964;1964.9312274070483;2046.549759053006;2072.6890966355018;2116.4179850541072;79550;81878.18121818764;83015;83453;85556.57221713914;10894.836577451344;10903.400312982703;11088.010395321977;11221.60724374643;11402.087832973342;15413.460528881435;15416.383344666312;15421.922890385476;15422.611964923211;15452.459163929208;7558.281963213486;7608.885866712004;7812.84374312522;7912.9208707912185;7922.088959769585;7134.607596582237;7221.927780722125;7235.602041887747;7390;7468.738594149178;6689.665516724144;6701.631410272482;6778.559393639398;6851.554648947902;6881.724731010803;1999.5501012272123;2006.8193862552441;2031.9288824891057;2036.2872994451823;2044;825.7894236969654;883.4037025008222;906.4425378392241;943.3679434778714;996.5565323431149;17641.38255161089;17912.820871791377;18428.723569146205;18650;18782.436526904214;890.4078787606298;917.7934964632905;924.9162321311687;977.154761131616;979.7648564344506;10073.546690398949;10210.387376757419;10335.638252661121;10417.114545263586;10421.843672344921;465216;472059;473567.80402449693;474924;477730;78991;79410;79583.60208199038;80175.59912200402;80828;1012.2003617142523;1026.5585798106886;1057.1965306367217;1064.3773392565436;1066.3228849680509;15738.685226295638;16246.756298655766;16582.25379857885;16790.916045419694;16917.238724257684;40129.598704013755;40137;40181;40885;41562.79218604009;50727.74636126796;53010.20484692656;53723;53937;55583.72208138934;6407.903881441689;8353.749387518385;8678.739637810875;8704.738857834274;8863.379563430499;13056.804147937979;13492.59522214335;13700.725985480036;14024.579262622137;14026.509072182425;10288.331258468175;10527.210459215743;10770.892291077302;11006.449677516252;11186.440677966231;11062.170337224901;11303.1522635801;11368.147388946027;11702.063834893017;11834.940825295818;10616.469176541297;10957.561697532328;11044.226904116635;11100.777984440427;11457.713557161138;8536.487810731376;8564.48613083217;8750.518721470125;8811.867821982547;8827.955860220658;5293.2589437479555;5937.762489500372;9728.9027109728;10675.09261712732;11051.557937682403 03:37:51 INFO - PROCESS | 5432 | |3;mootools.html;1335.5993202039385;1467.2956980649292;1524.7789070584765;1620.9270582823772;1760.9207585658637;7922.168172341908;8286.129956354587;8357.623906924195;8524.190201930822;8533.317334613232;8380.622871970761;8501.319894408449;8503.1921967413;8503.957480212606;8504.149585041492;1961.7155512450686;2267.841251112423;2332.5684748321573;2359.3983534198755;2363.019346971005;2380.071772008918;2406.915757948472;2409.8072154227707;2415.867127307997;2416.0577374823833;2348.4598542335275;2355.49356888269;2376.3227480168157;2379.5716770981217;2387.0809738250723;2261.9321420357414;2329.743728189898;2335.0543030072763;2335.8715270660277;2343.1447521654645;2304.4584522637165;2342.8711420871846;2344.15610380263;2347.8239132065164;2354.6350315701093;8515.19105684959;8555.187257210555;8558.229759321692;8571.400001999862;8573.485590864568;4972.5276098770555;5102.668326558762;5106.897862042739;5109.41241757199;5114.846554603368;3265.7224135948472;3290.400583539001;3431.0736101252523;3458.066322093046;3470.410030294856;1143.1255089856268;1201.9819702704467;1213.9575114871025;1238.8017917133307;1238.876112388763;10914.181436392222;11095.667129986114;11132.165087618461;11136.944315278453;11138.888611113865;4262.403263543107;4409.735415875058;4515.841945531891;4540.387047748578;4574.336721175478;9607.759806004766;9618.182454491307;9626;9632.662856799978;9636.084571965652;4942.851714448572;4943.036107958986;4943.209086546135;4944.90110197794;4951.851444456672;4026.6376026157786;4488.169688607618;4552.726836389827;4564.612007979359;4575.611073058761;3811.561670407883;3857.614238576176;3900.317444447267;3972.066564357374;3982.5264652078918;1258.993705031469;1267.9049071319687;1274.9362531873555;1280.8655091215473;1290.6579756364572;745.6495447139836;843.759673280277;881.0880738435816;897.264243320471;936.4334577580602;5426.593005524523;5451.618386712971;5475.4524547544925;5622.662640241599;5773.24947756789;937.9812403751887;975.6926568131016;980.0101897083854;991.2317953586029;994.4381424495137;3370.191154122993;3465.8440370183403;3521.524594179753;3555.839987200582;3570.5715314162467;10114.494275286206;10516.211284153718;10520.158387328995;10521.26351155427;10532.631357902437;10369.533370998171;10391.012853778879;10400.115990140923;10407.5836966522;10450.216233782498;7695.192004839523;7925;7927.762167134995;7935.682572697143;7936.365090792723;4906.362172917497;5574.27534420539;5635.295588051494;5646.830595082154;5706.343770466284;9127.406718563538;9198.26413886874;9273.629054837731;9315.254779617479;9398.718038458857;9313.534323283673;9347.813043739223;9496.572654230438;9593;9620;6840.692168852314;7650.540967541965;7854.842903142019;7915.366770658218;8269.173082691683;8043.959780201061;8078.071021832565;8136.22705842944;8141.5522146280155;8173.100958894398;7270.745523906638;7525.510841795266;7600.581967991813;7646.65590048438;7706.499077559941;7278.417726581966;7341.59621220838;7437.888431673421;7447.441441891771;7579.355754760686;6089.1779609753885;6203.8138855834395;6206.131141640084;6212.223472065992;6216.409441103088;4829.372181616367;4929.06347793918;4964.4539100698175;5015.3730783652045;5023.271625614192;4885.8289959852655;4886.120498310338;4900.754962251802;4934.753262336941;5198.714070726146 03:37:51 INFO - PROCESS | 5432 | |4;prototype.html;304.7318359843339;313.2419544701822;322.361723786902;322.77567090871827;327.7853006280887;4981.103401387749;5125.333706618144;5300.761465734042;5357.383900851403;5389.865253368668;5276.472352764722;5285.154375299952;5290.603204759639;5295.920561191576;5299.152135658295;4180.101278225181;4192.916141677165;4193.475815523059;4200.936985945198;4237.279662457389;3954.980225098885;3986.8604598839047;4222.746635201883;4235.941014746313;4237.555056719047;4074.736831582219;4104.322786740185;4104.343305071189;4120.134771697947;4151.273527132755;4081.632653061224;4117.114820313647;4118.567550407224;4135.483064616923;4142.544320124784;3626.220362622049;3637.4907512948207;3647.215848592565;3655.817209139559;3657.3416784978695;4941.752912354368;5135.74321283938;5166.9224961625605;5169.483051694838;5188.507091826271;4625.838095666635;4679.415073115861;4734.313524538957;4740.502247264022;4743.264793956942;5323.520883120499;5469.343678758534;5516.420775818561;5516.503514683698;5532.225488431623;3939.468171796828;3945.0926286953872;3952.7825969571663;3961.2372494240076;3996.8800935971967;5425.810096646638;5570.86072848178;5676.375598684142;5693.316801983747;5703.971480142573;4033.4756481657196;4034.515858097047;4037.7779222143063;4052.3111071117983;4052.7365721228025;4108.548059713429;4111.198316328347;4124.628783409507;4128.545859955402;4130.938035929464;4553;4686.179918514246;4687.554682305175;4690;4726.220173671374;5474.507294343528;5484.670919744828;5492.395836458067;5494.038543254915;5496.725163741797;1367.131871261756;1385.8129152564477;1386.9583912482642;1391.5268808605124;1401.5374926274305;851.9403641745018;884.2086332732168;890.3055616619048;892.9955350223207;901.8456375838806;4690.835820746258;4695.929561056587;4695.9668872847915;4698.882527936829;4701.858944231679;4893.608511319086;4918.48355922623;4937.963152661159;4940.517844646592;4948.752562371867;4397.450318710161;4638.698484598491;4671.818722243573;4679.204535229019;4688.218476978795;2620.296807075378;2625.960610590843;2629.593167655295;2630.355562887105;2649.9470010600066;5045.5459008689395;5089.821856235014;5091.516305950929;5094.337736094358;5121.487851214849;4687.29690546414;5001.0998020355955;5003.449620541737;5006.674566153189;5006.974965125151;5074.771635276422;5084.694918304914;5095.974520127375;5098.413682426569;5101.566366858784;4909.214525675875;4910.680805747615;4934.901301973869;4957.429895562056;4967.82612608557;4881.461639947137;4906.141425250638;4926.433460152129;5195.792168313225;5649.209110724584;5626.2967129108865;5784.8553786154;5878.882422351615;5887.735051922588;5912.5861189718025;4093.7134400592863;4107.979460102681;4120.505539335299;4161.625453709181;4171.624553790052;5800.723840755028;5804.390538993345;5811.389804070512;5811.738471768866;5812.593118481665;5539.307586551681;5567.498925096761;5567.638103523258;5570.769889560462;5575.77696892136;5584.385717570983;5587.8824235152315;5591.329040515164;5591.8881622368135;5593.272874526286;5213.921791173059;5518.503334699896;5523.861903452445;5525.530329922001;5591.245181900392;5621.128725047624;5623.2127502148915;5623.662580245198;5625.943740562542;5634.464725851038;5489.258950041693;5500.477454641803;5510.410107249586;5525.668459892258;5528.75120619565 03:37:51 INFO - PROCESS | 5432 | |5;yui.html;744.9441291903107;759.1838773318681;787.9960600196999;802.4302745051014;849.6598876063939;14543.27283635818;15472.303746331414;15475.69048619027;15478.69042619147;15486.612834679125;13904.443822247098;13911.304434778245;13983.021188516783;13987.790183147235;14016.22910739909;665.1685393258427;792.3859009267806;801.7234054251303;809.1503920883079;809.5345176523508;809.6397103289039;821.1214001018913;821.8972628421448;822.2476434062826;823.1685997142899;880.0319648386787;883.7746374674449;884.0805562215288;884.0893879304327;884.1732979664034;692.1140939597324;863.2791618998144;873.6068769053951;881.9250363719092;882.1443200095929;630.1964994631835;632.1560716443554;632.6646877155115;633.2590868683651;633.4837107757163;15704.214789260492;15720.135392553406;15723.606909827231;15740.92129539345;15798.131102789343;15697.686046279125;15972.920135399365;15999.760003599955;16016.599585010352;16092.356305747757;12535.874641253653;12629.684257893534;12733.554325598652;13503.932480337535;13610.115342502706;3923.292049540563;3956.980215098935;3972.086420123359;4059.147579008412;4061.370487574401;81995;82823;82936;83253;83758.99999999939;11522.193446458836;11533.711657208636;11555.826662600068;11786.764264714659;12237.571684990982;23928.521429571312;23940.88029559841;24031.158909438087;24141.62017317577;24149.396265093514;8775.297976161892;8809.779755506035;8837.337199709918;8857.512836794038;9037.50293733851;4650.976745116321;4814.085323788469;4834.371531700856;4947.604191664658;5141.434442211354;3647.835847386874;3733.5519737631116;3777.4522694209186;3782.3759079751535;3786.2238241160494;541.5072284221418;620.5811077522654;621.9036049412348;623.547927752385;653.9803805885831;605.5246631394423;685.7531288736051;718.9496735228483;747.6971826410313;781.7303030454484;9320.161185493338;9631.951840240754;9733.270004749673;9753.756156096155;9958.990048982643;604.724850193161;743.7616368746085;749.5727435361791;754.2721273970535;762.7902326860158;4358.3680366347335;4801.087793319258;4806.567408933143;4820.204666230033;4837.661363704507;124714;125915;125970;126005;131038;109447;113500;113601;114710.4264478689;116139.41930290294;74856.90004249234;83780.58109709412;87028;88823.55588222017;92434;9745.756356091155;9931.801363972825;9957.502124893872;10243.43661098617;10363.430011349448;52734.472655272955;53281.733591331795;53563.464365355845;53987.190192146365;54172.18741718956;70591.64704176446;78383.60808195923;79145.20854791379;80359.59820200861;80642;13657.521986730417;13705.177689338672;13801;13806;13947.651308717363;15390.384384624489;15580.532584022498;15615.21923903823;15984.200789960223;16047.277872495531;14382.568522944328;14541.27293635335;14707.55877323682;15185.544433667008;15224;14381.85618143847;14393.208373539555;15245.237738113272;15266.160361180242;15601.078808550856;13628.93185534066;13713.245771482265;14767.630809229855;15153.848461515243;15221.086734795948;11549.711257218636;11550.653480395602;11627.47676354583;11680.47437865281;11761.588344407905;10755.516001779783;11677.824832627348;12369.162790467388;12496.500139994298;12701.618951431472 03:37:51 INFO - PROCESS | 5432 | __end_tp_report 03:37:51 INFO - PROCESS | 5432 | __start_cc_report 03:37:51 INFO - PROCESS | 5432 | _x_x_mozilla_cycle_collect,890 03:37:51 INFO - PROCESS | 5432 | __end_cc_report 03:37:51 INFO - PROCESS | 5432 | __startTimestamp1471603071687__endTimestamp 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | ------- Summary: start ------- 03:37:51 INFO - PROCESS | 5432 | Number of tests: 6 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#0] dojo.html Cycles:165 Average:5218.25 Median:5425.54 stddev:594.44 (11.0%) stddev-sans-first:569.92 03:37:51 INFO - PROCESS | 5432 | Values: 2987.3 3003.6 3022.5 3032.7 3033.3 5112.1 5162.3 5223.7 5343.7 5392.1 5211.6 5239.1 5286.9 5287.7 5323.9 4691.6 4733.8 4758.1 4769.1 4891.7 4899.9 4904.2 4917.7 4923.2 4946.6 4694.1 4720.3 4846.4 4887.5 4892.4 4679.6 4684.8 4686.9 4710.8 4720.8 4654.4 4668.5 4681.7 4760.0 4773.5 5076.0 5194.3 5213.5 5246.2 5248.8 5588.6 5602.3 5657.5 5659.9 5661.5 5658.0 5659.5 5699.2 5705.3 5712.4 5143.6 5251.1 5311.1 5314.6 5320.1 5770.3 5879.0 5879.4 5883.5 5884.9 5638.8 5649.7 5650.5 5650.9 5656.9 5669.5 5703.1 5715.8 5716.7 5718.3 5430.2 5435.5 5448.6 5471.6 5600.7 5483.3 5557.9 5562.2 5601.4 5609.7 4294.7 4295.9 4298.4 4303.4 4311.3 3811.0 3829.9 3855.1 3868.1 3885.3 5367.7 5371.8 5394.6 5413.4 5415.1 5640.9 5642.3 5654.8 5655.3 5656.6 5180.8 5206.1 5261.6 5361.2 5367.9 4862.6 4864.0 4868.4 4888.3 4907.1 5698.2 5742.1 5747.9 5748.6 5794.5 5425.4 5498.9 5535.8 5543.1 5583.7 5797.7 5799.0 5805.4 5838.1 5859.0 5485.7 5501.2 5505.4 5505.9 5512.0 5448.5 5479.2 5523.6 5597.6 5608.4 5424.7 5435.9 5440.4 5467.8 5487.8 5431.0 5431.8 5459.9 5483.2 5538.7 5197.2 5363.1 5404.6 5428.9 5430.6 5536.9 5540.3 5550.6 5577.5 5591.6 5418.4 5418.6 5425.5 5428.1 5428.3 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#1] ext.html Cycles:180 Average:61326.03 Median:41129.49 stddev:119875.28 (291.5%) stddev-sans-first:120124.84 03:37:51 INFO - PROCESS | 5432 | Values: 595.8 603.3 605.0 625.5 627.6 32488.4 43020.8 44059.1 44171.6 47644.3 46541.5 46938.6 46996.8 47006.5 47054.8 8076.3 8871.1 9004.5 9006.5 9015.4 7987.4 8211.5 10610.2 10881.8 10903.3 11037.3 11101.5 11112.6 11112.8 11114.8 10895.8 10941.9 10948.6 10962.0 10968.5 10756.1 10774.4 10826.6 10848.5 10849.1 43409.0 43689.1 43711.3 43738.8 43779.1 3737.1 3752.6 3876.6 4076.5 4325.2 32297.7 32959.2 33094.2 33144.8 33265.7 4235.5 4315.8 4326.2 4457.8 4517.3 390002.0 394880.0 394883.0 395057.0 395977.0 60522.0 60869.7 60876.7 60898.0 60925.0 64071.0 64460.4 64690.4 64846.0 64990.4 15148.0 15310.9 15314.3 15332.8 15354.8 10819.6 11746.9 11758.5 11806.9 11807.6 17735.4 18053.9 18186.8 18652.5 19070.7 6259.2 6368.6 6406.8 6532.2 6580.4 824.9 857.0 909.4 951.3 961.5 25958.5 26775.9 27648.2 27764.2 27958.2 924.0 949.9 973.2 1042.7 1064.8 14135.2 14436.3 14449.6 14703.5 14723.4 486085.0 489737.0 490516.0 490594.0 494826.0 59296.4 59395.7 59453.7 59463.1 59504.4 1224.8 1292.1 1296.4 1377.1 1378.0 23488.0 27322.6 27814.0 29701.1 29996.9 56953.4 58058.0 58162.7 58250.0 58287.7 466307.0 467687.0 468172.0 468315.0 468899.0 28334.7 29355.3 29358.6 43027.8 43406.3 48953.8 49960.5 49967.8 49988.3 50351.0 40927.4 41331.6 41412.6 41899.6 43714.3 40408.8 40498.4 41807.6 41865.2 42023.2 33965.3 35372.6 35412.6 35469.1 35485.6 33718.0 37383.6 37547.0 37709.8 38360.4 22259.9 22292.4 22371.0 22543.3 22632.8 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#2] jquery.html Cycles:180 Average:28038.08 Median:20263.14 stddev:77772.29 (383.8%) stddev-sans-first:77962.71 03:37:51 INFO - PROCESS | 5432 | Values: 367.7 388.2 390.8 396.7 419.4 16683.7 19668.4 19719.2 19867.8 20528.7 17792.1 18162.5 18222.0 18378.3 18579.5 5250.8 5741.3 5963.4 5986.3 5990.0 5907.4 5943.2 5970.7 5979.9 5986.3 5691.7 5858.6 5896.4 5956.1 5957.0 5910.8 5922.1 5935.6 5943.2 5947.0 5073.2 5146.8 5186.7 5192.6 5197.6 22318.4 22868.3 23012.3 23725.8 24005.2 2365.3 2452.7 2545.8 2758.0 3121.7 14534.3 14590.5 15044.8 15542.6 15669.4 1923.9 1964.9 2046.5 2072.7 2116.4 79550.0 81878.2 83015.0 83453.0 85556.6 10894.8 10903.4 11088.0 11221.6 11402.1 15413.5 15416.4 15421.9 15422.6 15452.5 7558.3 7608.9 7812.8 7912.9 7922.1 7134.6 7221.9 7235.6 7390.0 7468.7 6689.7 6701.6 6778.6 6851.6 6881.7 1999.6 2006.8 2031.9 2036.3 2044.0 825.8 883.4 906.4 943.4 996.6 17641.4 17912.8 18428.7 18650.0 18782.4 890.4 917.8 924.9 977.2 979.8 10073.5 10210.4 10335.6 10417.1 10421.8 465216.0 472059.0 473567.8 474924.0 477730.0 78991.0 79410.0 79583.6 80175.6 80828.0 1012.2 1026.6 1057.2 1064.4 1066.3 15738.7 16246.8 16582.3 16790.9 16917.2 40129.6 40137.0 40181.0 40885.0 41562.8 50727.7 53010.2 53723.0 53937.0 55583.7 6407.9 8353.7 8678.7 8704.7 8863.4 13056.8 13492.6 13700.7 14024.6 14026.5 10288.3 10527.2 10770.9 11006.4 11186.4 11062.2 11303.2 11368.1 11702.1 11834.9 10616.5 10957.6 11044.2 11100.8 11457.7 8536.5 8564.5 8750.5 8811.9 8828.0 5293.3 5937.8 9728.9 10675.1 11051.6 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#3] mootools.html Cycles:180 Average:5520.21 Median:4948.38 stddev:3069.85 (62.0%) stddev-sans-first:3062.35 03:37:51 INFO - PROCESS | 5432 | Values: 1335.6 1467.3 1524.8 1620.9 1760.9 7922.2 8286.1 8357.6 8524.2 8533.3 8380.6 8501.3 8503.2 8504.0 8504.1 1961.7 2267.8 2332.6 2359.4 2363.0 2380.1 2406.9 2409.8 2415.9 2416.1 2348.5 2355.5 2376.3 2379.6 2387.1 2261.9 2329.7 2335.1 2335.9 2343.1 2304.5 2342.9 2344.2 2347.8 2354.6 8515.2 8555.2 8558.2 8571.4 8573.5 4972.5 5102.7 5106.9 5109.4 5114.8 3265.7 3290.4 3431.1 3458.1 3470.4 1143.1 1202.0 1214.0 1238.8 1238.9 10914.2 11095.7 11132.2 11136.9 11138.9 4262.4 4409.7 4515.8 4540.4 4574.3 9607.8 9618.2 9626.0 9632.7 9636.1 4942.9 4943.0 4943.2 4944.9 4951.9 4026.6 4488.2 4552.7 4564.6 4575.6 3811.6 3857.6 3900.3 3972.1 3982.5 1259.0 1267.9 1274.9 1280.9 1290.7 745.6 843.8 881.1 897.3 936.4 5426.6 5451.6 5475.5 5622.7 5773.2 938.0 975.7 980.0 991.2 994.4 3370.2 3465.8 3521.5 3555.8 3570.6 10114.5 10516.2 10520.2 10521.3 10532.6 10369.5 10391.0 10400.1 10407.6 10450.2 7695.2 7925.0 7927.8 7935.7 7936.4 4906.4 5574.3 5635.3 5646.8 5706.3 9127.4 9198.3 9273.6 9315.3 9398.7 9313.5 9347.8 9496.6 9593.0 9620.0 6840.7 7650.5 7854.8 7915.4 8269.2 8044.0 8078.1 8136.2 8141.6 8173.1 7270.7 7525.5 7600.6 7646.7 7706.5 7278.4 7341.6 7437.9 7447.4 7579.4 6089.2 6203.8 6206.1 6212.2 6216.4 4829.4 4929.1 4964.5 5015.4 5023.3 4885.8 4886.1 4900.8 4934.8 5198.7 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#4] prototype.html Cycles:180 Average:4501.79 Median:4941.14 stddev:1310.43 (26.5%) stddev-sans-first:1275.68 03:37:51 INFO - PROCESS | 5432 | Values: 304.7 313.2 322.4 322.8 327.8 4981.1 5125.3 5300.8 5357.4 5389.9 5276.5 5285.2 5290.6 5295.9 5299.2 4180.1 4192.9 4193.5 4200.9 4237.3 3955.0 3986.9 4222.7 4235.9 4237.6 4074.7 4104.3 4104.3 4120.1 4151.3 4081.6 4117.1 4118.6 4135.5 4142.5 3626.2 3637.5 3647.2 3655.8 3657.3 4941.8 5135.7 5166.9 5169.5 5188.5 4625.8 4679.4 4734.3 4740.5 4743.3 5323.5 5469.3 5516.4 5516.5 5532.2 3939.5 3945.1 3952.8 3961.2 3996.9 5425.8 5570.9 5676.4 5693.3 5704.0 4033.5 4034.5 4037.8 4052.3 4052.7 4108.5 4111.2 4124.6 4128.5 4130.9 4553.0 4686.2 4687.6 4690.0 4726.2 5474.5 5484.7 5492.4 5494.0 5496.7 1367.1 1385.8 1387.0 1391.5 1401.5 851.9 884.2 890.3 893.0 901.8 4690.8 4695.9 4696.0 4698.9 4701.9 4893.6 4918.5 4938.0 4940.5 4948.8 4397.5 4638.7 4671.8 4679.2 4688.2 2620.3 2626.0 2629.6 2630.4 2649.9 5045.5 5089.8 5091.5 5094.3 5121.5 4687.3 5001.1 5003.4 5006.7 5007.0 5074.8 5084.7 5096.0 5098.4 5101.6 4909.2 4910.7 4934.9 4957.4 4967.8 4881.5 4906.1 4926.4 5195.8 5649.2 5626.3 5784.9 5878.9 5887.7 5912.6 4093.7 4108.0 4120.5 4161.6 4171.6 5800.7 5804.4 5811.4 5811.7 5812.6 5539.3 5567.5 5567.6 5570.8 5575.8 5584.4 5587.9 5591.3 5591.9 5593.3 5213.9 5518.5 5523.9 5525.5 5591.2 5621.1 5623.2 5623.7 5625.9 5634.5 5489.3 5500.5 5510.4 5525.7 5528.8 03:37:51 INFO - PROCESS | 5432 | 03:37:51 INFO - PROCESS | 5432 | [#5] yui.html Cycles:180 Average:22215.85 Median:4060.26 stddev:32523.28 (801.0%) stddev-sans-first:32574.56 03:37:51 INFO - PROCESS | 5432 | Values: 744.9 759.2 788.0 802.4 849.7 14543.3 15472.3 15475.7 15478.7 15486.6 13904.4 13911.3 13983.0 13987.8 14016.2 665.2 792.4 801.7 809.2 809.5 809.6 821.1 821.9 822.2 823.2 880.0 883.8 884.1 884.1 884.2 692.1 863.3 873.6 881.9 882.1 630.2 632.2 632.7 633.3 633.5 15704.2 15720.1 15723.6 15740.9 15798.1 15697.7 15972.9 15999.8 16016.6 16092.4 12535.9 12629.7 12733.6 13503.9 13610.1 3923.3 3957.0 3972.1 4059.1 4061.4 81995.0 82823.0 82936.0 83253.0 83759.0 11522.2 11533.7 11555.8 11786.8 12237.6 23928.5 23940.9 24031.2 24141.6 24149.4 8775.3 8809.8 8837.3 8857.5 9037.5 4651.0 4814.1 4834.4 4947.6 5141.4 3647.8 3733.6 3777.5 3782.4 3786.2 541.5 620.6 621.9 623.5 654.0 605.5 685.8 718.9 747.7 781.7 9320.2 9632.0 9733.3 9753.8 9959.0 604.7 743.8 749.6 754.3 762.8 4358.4 4801.1 4806.6 4820.2 4837.7 124714.0 125915.0 125970.0 126005.0 131038.0 109447.0 113500.0 113601.0 114710.4 116139.4 74856.9 83780.6 87028.0 88823.6 92434.0 9745.8 9931.8 9957.5 10243.4 10363.4 52734.5 53281.7 53563.5 53987.2 54172.2 70591.6 78383.6 79145.2 80359.6 80642.0 13657.5 13705.2 13801.0 13806.0 13947.7 15390.4 15580.5 15615.2 15984.2 16047.3 14382.6 14541.3 14707.6 15185.5 15224.0 14381.9 14393.2 15245.2 15266.2 15601.1 13628.9 13713.2 14767.6 15153.8 15221.1 11549.7 11550.7 11627.5 11680.5 11761.6 10755.5 11677.8 12369.2 12496.5 12701.6 03:37:51 INFO - PROCESS | 5432 | -------- Summary: end -------- 03:37:51 INFO - PROCESS | 5432 | 03:37:52 INFO - TEST-INFO | 5432: exit 0 03:37:52 INFO - TEST-OK | dromaeo_css | took 1115253ms 03:37:52 INFO - TEST-START | kraken 03:37:52 INFO - operating with platform_type : linux_ 03:37:52 INFO - Initialising browser for kraken test... 03:37:52 INFO - TEST-INFO | started process 5738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqgZPqT/profile http://localhost:45465/getInfo.html) 03:37:56 INFO - PROCESS | 5738 | __metrics Screen width/height:1600/1200 03:37:56 INFO - PROCESS | 5738 | colorDepth:24 03:37:56 INFO - PROCESS | 5738 | Browser inner width/height: 1024/697 03:37:56 INFO - PROCESS | 5738 | __metrics 03:37:57 INFO - PROCESS | 5738 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:37:57 INFO - PROCESS | 5738 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:58 INFO - TEST-INFO | 5738: exit 0 03:37:58 INFO - Browser initialized. 03:37:58 INFO - Running cycle 1/1 for kraken test... 03:37:58 INFO - TEST-INFO | started process 5821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqgZPqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:09 INFO - PROCESS | 5821 | RSS: Main: 155590656 03:38:09 INFO - PROCESS | 5821 | 03:38:12 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45465/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:13 INFO - PROCESS | 5821 | RSS: Main: 204730368 03:38:13 INFO - PROCESS | 5821 | 03:38:15 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45465/tests/kraken/driver.html?testName=audio-dft) 03:38:16 INFO - PROCESS | 5821 | RSS: Main: 191410176 03:38:16 INFO - PROCESS | 5821 | 03:38:19 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45465/tests/kraken/driver.html?testName=audio-fft) 03:38:20 INFO - PROCESS | 5821 | RSS: Main: 275836928 03:38:20 INFO - PROCESS | 5821 | 03:38:22 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45465/tests/kraken/driver.html?testName=audio-oscillator) 03:38:22 INFO - PROCESS | 5821 | RSS: Main: 185929728 03:38:22 INFO - PROCESS | 5821 | 03:38:25 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:25 INFO - PROCESS | 5821 | RSS: Main: 191094784 03:38:25 INFO - PROCESS | 5821 | 03:38:28 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45465/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:29 INFO - PROCESS | 5821 | RSS: Main: 226230272 03:38:29 INFO - PROCESS | 5821 | 03:38:32 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45465/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:33 INFO - PROCESS | 5821 | RSS: Main: 226893824 03:38:33 INFO - PROCESS | 5821 | 03:38:36 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45465/tests/kraken/driver.html?testName=json-parse-financial) 03:38:36 INFO - PROCESS | 5821 | RSS: Main: 226250752 03:38:36 INFO - PROCESS | 5821 | 03:38:38 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:38 INFO - PROCESS | 5821 | RSS: Main: 188792832 03:38:38 INFO - PROCESS | 5821 | 03:38:40 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:41 INFO - PROCESS | 5821 | RSS: Main: 195620864 03:38:41 INFO - PROCESS | 5821 | 03:38:43 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:43 INFO - PROCESS | 5821 | RSS: Main: 193302528 03:38:43 INFO - PROCESS | 5821 | 03:38:46 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:46 INFO - PROCESS | 5821 | RSS: Main: 187318272 03:38:46 INFO - PROCESS | 5821 | 03:38:49 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:50 INFO - PROCESS | 5821 | RSS: Main: 191889408 03:38:50 INFO - PROCESS | 5821 | 03:38:51 INFO - PROCESS | 5821 | Cycle 1(1): loaded http://localhost:45465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45465/tests/kraken/driver.html?testName=ai-astar) 03:38:52 INFO - PROCESS | 5821 | RSS: Main: 243286016 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | __start_tp_report 03:38:52 INFO - PROCESS | 5821 | _x_x_mozilla_page_load 03:38:52 INFO - PROCESS | 5821 | _x_x_mozilla_page_load_details 03:38:52 INFO - PROCESS | 5821 | |i|pagename|runs| 03:38:52 INFO - PROCESS | 5821 | |0;ai-astar;104;113;111;112;108;113;113;112;112;111 03:38:52 INFO - PROCESS | 5821 | |1;audio-beat-detection;149;122;122;188;118;119;155;118;161;119 03:38:52 INFO - PROCESS | 5821 | |2;audio-dft;160;162;160;161;161;161;161;161;161;160 03:38:52 INFO - PROCESS | 5821 | |3;audio-fft;76;76;76;107;74;75;74;74;112;75 03:38:52 INFO - PROCESS | 5821 | |4;audio-oscillator;86;86;110;85;85;85;116;85;85;124 03:38:52 INFO - PROCESS | 5821 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;116;118;116 03:38:52 INFO - PROCESS | 5821 | |6;imaging-darkroom;146;147;145;145;146;146;145;146;145;145 03:38:52 INFO - PROCESS | 5821 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;97;96 03:38:52 INFO - PROCESS | 5821 | |8;json-parse-financial;56;50;52;50;51;53;51;49;51;49 03:38:52 INFO - PROCESS | 5821 | |9;json-stringify-tinderbox;62;62;62;61;63;62;62;62;63;63 03:38:52 INFO - PROCESS | 5821 | |10;stanford-crypto-aes;79;78;78;77;77;78;78;79;78;77 03:38:52 INFO - PROCESS | 5821 | |11;stanford-crypto-ccm;125;125;129;120;131;124;123;121;137;123 03:38:52 INFO - PROCESS | 5821 | |12;stanford-crypto-pbkdf2;166;164;168;163;162;167;165;162;159;162 03:38:52 INFO - PROCESS | 5821 | |13;stanford-crypto-sha256-iterative;67;63;68;63;62;64;63;63;65;62 03:38:52 INFO - PROCESS | 5821 | __end_tp_report 03:38:52 INFO - PROCESS | 5821 | __start_cc_report 03:38:52 INFO - PROCESS | 5821 | _x_x_mozilla_cycle_collect,1648 03:38:52 INFO - PROCESS | 5821 | __end_cc_report 03:38:52 INFO - PROCESS | 5821 | __startTimestamp1471603132200__endTimestamp 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | ------- Summary: start ------- 03:38:52 INFO - PROCESS | 5821 | Number of tests: 14 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.85 (2.5%) stddev-sans-first:1.58 03:38:52 INFO - PROCESS | 5821 | Values: 104.0 113.0 111.0 112.0 108.0 113.0 113.0 112.0 112.0 111.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:135.50 stddev:24.64 (18.2%) stddev-sans-first:25.76 03:38:52 INFO - PROCESS | 5821 | Values: 149.0 122.0 122.0 188.0 118.0 119.0 155.0 118.0 161.0 119.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:38:52 INFO - PROCESS | 5821 | Values: 160.0 162.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 160.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.62 (19.5%) stddev-sans-first:15.35 03:38:52 INFO - PROCESS | 5821 | Values: 76.0 76.0 76.0 107.0 74.0 75.0 74.0 74.0 112.0 75.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:85.00 stddev:15.52 (18.3%) stddev-sans-first:16.14 03:38:52 INFO - PROCESS | 5821 | Values: 86.0 86.0 110.0 85.0 85.0 85.0 116.0 85.0 85.0 124.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:38:52 INFO - PROCESS | 5821 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 118.0 116.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:38:52 INFO - PROCESS | 5821 | Values: 146.0 147.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:38:52 INFO - PROCESS | 5821 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 97.0 96.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:2.10 (4.1%) stddev-sans-first:1.32 03:38:52 INFO - PROCESS | 5821 | Values: 56.0 50.0 52.0 50.0 51.0 53.0 51.0 49.0 51.0 49.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 03:38:52 INFO - PROCESS | 5821 | Values: 62.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 63.0 63.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 03:38:52 INFO - PROCESS | 5821 | Values: 79.0 78.0 78.0 77.0 77.0 78.0 78.0 79.0 78.0 77.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.00 stddev:5.16 (4.1%) stddev-sans-first:5.46 03:38:52 INFO - PROCESS | 5821 | Values: 125.0 125.0 129.0 120.0 131.0 124.0 123.0 121.0 137.0 123.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.50 stddev:2.74 (1.7%) stddev-sans-first:2.79 03:38:52 INFO - PROCESS | 5821 | Values: 166.0 164.0 168.0 163.0 162.0 167.0 165.0 162.0 159.0 162.0 03:38:52 INFO - PROCESS | 5821 | 03:38:52 INFO - PROCESS | 5821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.50 stddev:2.05 (3.2%) stddev-sans-first:1.87 03:38:52 INFO - PROCESS | 5821 | Values: 67.0 63.0 68.0 63.0 62.0 64.0 63.0 63.0 65.0 62.0 03:38:52 INFO - PROCESS | 5821 | -------- Summary: end -------- 03:38:52 INFO - PROCESS | 5821 | 03:38:53 INFO - TEST-INFO | 5821: exit 0 03:38:53 INFO - TEST-OK | kraken | took 60815ms 03:38:53 INFO - SUITE-END | took 1176s 03:38:53 INFO - Completed test suite (00:19:36) 03:38:53 INFO - javascript benchmark 03:38:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.2681193107687, 3003.6395632524072, 3022.48617734985, 3032.7422169115625, 3033.2871775132826, 5112.105381558222, 5162.303089082972, 5223.71269580173, 5343.652662576935, 5392.056390131726, 5211.5830733541325, 5239.056969745444, 5286.920696189561, 5287.709175995319, 5323.920141197885, 4691.62467002639, 4733.81064757411, 4758.095961767253, 4769.141554520185, 4891.682040667363, 4899.853004409873, 4904.215325547913, 4917.72952487613, 4923.163062279421, 4946.629002824785, 4694.0611877624615, 4720.339152518616, 4846.442659094214, 4887.535684110022, 4892.437369702477, 4679.555442233016, 4684.836030738942, 4686.859394218179, 4710.788014539354, 4720.811167553294, 4654.394928659286, 4668.486466488684, 4681.719096854165, 4760.0, 4773.451053128865, 5075.974620126913, 5194.324737784102, 5213.53078222958, 5246.186841039645, 5248.790048398059, 5588.580856435784, 5602.271704678406, 5657.490825825655, 5659.943400565983, 5661.547076233891, 5658.0381335173115, 5659.518940889988, 5699.202111704365, 5705.315362156568, 5712.371639119693, 5143.61422893277, 5251.054810134213, 5311.070562651521, 5314.60140489461, 5320.095583750772, 5770.278715160605, 5879.0, 5879.441453061952, 5883.470487656132, 5884.882302354014, 5638.774449022075, 5649.68926709035, 5650.491455769001, 5650.943490565041, 5656.943430565724, 5669.461401166883, 5703.144528320785, 5715.828525144252, 5716.685582293014, 5718.256626638594, 5430.15832545956, 5435.456454354533, 5448.591355648263, 5471.616986810965, 5600.747966341524, 5483.314585676791, 5557.944420555824, 5562.193481945176, 5601.355844077902, 5609.747561359749, 4294.677899157576, 4295.926018495376, 4298.3552467130185, 4303.354496825501, 4311.310190369526, 3810.9809450952566, 3829.885103446901, 3855.094052897567, 3868.129670824042, 3885.320068987916, 5367.651102678314, 5371.838844834661, 5394.568434525228, 5413.377461591888, 5415.079436495806, 5640.915386269209, 5642.322921249476, 5654.802081927113, 5655.321361436571, 5656.60403771732, 5180.81867134656, 5206.140986737146, 5261.552768014685, 5361.195820626937, 5367.919481207785, 4862.586680132228, 4864.027194561102, 4868.440129385095, 4888.291197776302, 4907.092187945242, 5698.202251684685, 5742.08126699726, 5747.885042299131, 5748.597598168088, 5794.478496935296, 5425.43032981547, 5498.862528436821, 5535.806246781343, 5543.085390910454, 5583.69289689071, 5797.652140871562, 5799.0, 5805.448482394166, 5838.12428135783, 5858.970705146447, 5485.670859748428, 5501.174823776306, 5505.449455054462, 5505.944940550704, 5511.972440137773, 5448.509634132947, 5479.205515200194, 5523.6409633373705, 5597.552195824405, 5608.4111168326735, 5424.728763561885, 5435.891282174255, 5440.42875498067, 5467.781288748405, 5487.807926722546, 5431.0, 5431.755570999394, 5459.945400545944, 5483.232347471437, 5538.667679939216, 5197.24639927216, 5363.0614642438195, 5404.594655400782, 5428.945710542844, 5430.592705547021, 5536.889262214814, 5540.307461567304, 5550.55595552363, 5577.52591029767, 5591.6365436246515, 5418.403975562606, 5418.593605479684, 5425.538829199562, 5428.131498960148, 5428.294321738149], "value": 5177.837628090688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7646729541831, 603.3453702732535, 604.9655089796448, 625.5183508698301, 627.6014730646039, 32488.350232995326, 43020.784896075515, 44059.11881762367, 44171.558284417144, 47644.28533571999, 46541.534584654146, 46938.642917472556, 46996.765016174955, 47006.529934700644, 47054.76472617632, 8076.313513351342, 8871.11288871111, 9004.549772511347, 9006.504642244674, 9015.36892417531, 7987.440879138463, 8211.507309561415, 10610.20423468243, 10881.83677244842, 10903.29128606638, 11037.282576632533, 11101.500432480558, 11112.611058612909, 11112.833307500394, 11114.777704445905, 10895.782084358309, 10941.945290273577, 10948.562057517689, 10961.99999999996, 10968.451577421098, 10756.139508839275, 10774.437706532588, 10826.566937322497, 10848.511816968256, 10849.077828384598, 43409.0, 43689.126217475474, 43711.344329835076, 43738.78130609327, 43779.12441751147, 3737.0657335666083, 3752.624737526253, 3876.612338766129, 4076.5311989121333, 4325.178216138955, 32297.67702322994, 32959.176020599436, 33094.17264568381, 33144.83427582871, 33265.66734332674, 4235.512916014667, 4315.784210789448, 4326.242907491176, 4457.77711114443, 4517.277235642281, 390002.0, 394880.0, 394883.0, 395057.0, 395977.0201149005, 60522.0, 60869.69565152146, 60876.69561652163, 60897.95510224471, 60925.0, 64071.0, 64460.35539644543, 64690.35309646937, 64846.0, 64990.35009649937, 15148.0, 15310.923445382925, 15314.310856011283, 15332.770008449883, 15354.769678454832, 10819.621313253998, 11746.941265293619, 11758.470868810924, 11806.94096529529, 11807.645770626896, 17735.379261726037, 18053.909730451527, 18186.818131818512, 18652.533686657942, 19070.713939290923, 6259.217597800275, 6368.554201205964, 6406.782711284841, 6532.183477065367, 6580.440662543641, 824.8556502612018, 856.9657213711506, 909.4316052467208, 951.296040929707, 961.4615815143542, 25958.480830383665, 26775.86612066927, 27648.170554883385, 27764.16707498778, 27958.161255162377, 923.9538023098818, 949.8765160529088, 973.2408721197336, 1042.6559235452282, 1064.7923654887377, 14135.15189088658, 14436.278186090654, 14449.638759031108, 14703.485378011717, 14723.411063557338, 486085.0, 489737.0, 490516.0, 490594.0, 494826.0, 59296.40703592995, 59395.703021484616, 59453.702731486934, 59463.108053379234, 59504.40495594989, 1224.8468941382328, 1292.1084451728277, 1296.4360503181147, 1377.1461693749939, 1377.9862201378057, 23488.0, 27322.5901611472, 27814.0, 29701.115523159868, 29996.85001574978, 56953.43046569647, 58058.0, 58162.709186453794, 58250.0, 58287.70856145692, 466307.0, 467687.0, 468172.0, 468315.0, 468899.0, 28334.71665283321, 29355.266118347212, 29358.55962160612, 43027.784861075495, 43406.34890476709, 48953.75523122504, 49960.500394995586, 49967.75016125041, 49988.250176246656, 50351.0, 40927.38608920928, 41331.58668413277, 41412.585874140874, 41899.58100418957, 43714.34428483512, 40408.78773636796, 40498.3708641654, 41807.58192418037, 41865.162696746505, 42023.15953680848, 33965.3206935855, 35372.646273536935, 35412.64587354093, 35469.113272168404, 35485.64514354823, 33718.0, 37383.626163738016, 37547.0, 37709.81145094257, 38360.42459363167, 22259.888700556392, 22292.442688932908, 22371.0, 22543.323700289016, 22632.773672263724], "value": 20191.10521893345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.67644472863907, 388.2429262937271, 390.826082393335, 396.67274498538706, 419.3939757051061, 16683.666326673458, 19668.409947701573, 19719.211231550722, 19867.801321986793, 20528.692069618966, 17792.110394480256, 18162.5459363516, 18222.0, 18378.264869405208, 18579.535511612215, 5250.842474725764, 5741.253637027191, 5963.4334738199805, 5986.2517185351835, 5990.011648078062, 5907.379725128864, 5943.227380440537, 5970.73131709072, 5979.85050373742, 5986.341502434729, 5691.686957217351, 5858.648481091127, 5896.351401345849, 5956.076808094731, 5957.0, 5910.822675319747, 5922.082077278007, 5935.6141850779995, 5943.197668314765, 5947.048472244442, 5073.162928116893, 5146.794128234867, 5186.740662966837, 5192.55863251624, 5197.558207552363, 22318.43338016133, 22868.31395058151, 23012.309630711105, 23725.762742372528, 24005.15981940641, 2365.3022358404314, 2452.730199678034, 2545.8217924745277, 2757.986210068937, 3121.7034381733697, 14534.328552216524, 14590.489332873298, 15044.774328385083, 15542.580632260884, 15669.373225070984, 1923.874533397964, 1964.9312274070483, 2046.549759053006, 2072.6890966355018, 2116.4179850541072, 79550.0, 81878.18121818764, 83015.0, 83453.0, 85556.57221713914, 10894.836577451344, 10903.400312982703, 11088.010395321977, 11221.60724374643, 11402.087832973342, 15413.460528881435, 15416.383344666312, 15421.922890385476, 15422.611964923211, 15452.459163929208, 7558.281963213486, 7608.885866712004, 7812.84374312522, 7912.9208707912185, 7922.088959769585, 7134.607596582237, 7221.927780722125, 7235.602041887747, 7390.0, 7468.738594149178, 6689.665516724144, 6701.631410272482, 6778.559393639398, 6851.554648947902, 6881.724731010803, 1999.5501012272123, 2006.8193862552441, 2031.9288824891057, 2036.2872994451823, 2044.0, 825.7894236969654, 883.4037025008222, 906.4425378392241, 943.3679434778714, 996.5565323431149, 17641.38255161089, 17912.820871791377, 18428.723569146205, 18650.0, 18782.436526904214, 890.4078787606298, 917.7934964632905, 924.9162321311687, 977.154761131616, 979.7648564344506, 10073.546690398949, 10210.387376757419, 10335.638252661121, 10417.114545263586, 10421.843672344921, 465216.0, 472059.0, 473567.80402449693, 474924.0, 477730.0, 78991.0, 79410.0, 79583.60208199038, 80175.59912200402, 80828.0, 1012.2003617142523, 1026.5585798106886, 1057.1965306367217, 1064.3773392565436, 1066.3228849680509, 15738.685226295638, 16246.756298655766, 16582.25379857885, 16790.916045419694, 16917.238724257684, 40129.598704013755, 40137.0, 40181.0, 40885.0, 41562.79218604009, 50727.74636126796, 53010.20484692656, 53723.0, 53937.0, 55583.72208138934, 6407.903881441689, 8353.749387518385, 8678.739637810875, 8704.738857834274, 8863.379563430499, 13056.804147937979, 13492.59522214335, 13700.725985480036, 14024.579262622137, 14026.509072182425, 10288.331258468175, 10527.210459215743, 10770.892291077302, 11006.449677516252, 11186.440677966231, 11062.170337224901, 11303.1522635801, 11368.147388946027, 11702.063834893017, 11834.940825295818, 10616.469176541297, 10957.561697532328, 11044.226904116635, 11100.777984440427, 11457.713557161138, 8536.487810731376, 8564.48613083217, 8750.518721470125, 8811.867821982547, 8827.955860220658, 5293.2589437479555, 5937.762489500372, 9728.9027109728, 10675.09261712732, 11051.557937682403], "value": 9176.611438310993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.5993202039385, 1467.2956980649292, 1524.7789070584765, 1620.9270582823772, 1760.9207585658637, 7922.168172341908, 8286.129956354587, 8357.623906924195, 8524.190201930822, 8533.317334613232, 8380.622871970761, 8501.319894408449, 8503.1921967413, 8503.957480212606, 8504.149585041492, 1961.7155512450686, 2267.841251112423, 2332.5684748321573, 2359.3983534198755, 2363.019346971005, 2380.071772008918, 2406.915757948472, 2409.8072154227707, 2415.867127307997, 2416.0577374823833, 2348.4598542335275, 2355.49356888269, 2376.3227480168157, 2379.5716770981217, 2387.0809738250723, 2261.9321420357414, 2329.743728189898, 2335.0543030072763, 2335.8715270660277, 2343.1447521654645, 2304.4584522637165, 2342.8711420871846, 2344.15610380263, 2347.8239132065164, 2354.6350315701093, 8515.19105684959, 8555.187257210555, 8558.229759321692, 8571.400001999862, 8573.485590864568, 4972.5276098770555, 5102.668326558762, 5106.897862042739, 5109.41241757199, 5114.846554603368, 3265.7224135948472, 3290.400583539001, 3431.0736101252523, 3458.066322093046, 3470.410030294856, 1143.1255089856268, 1201.9819702704467, 1213.9575114871025, 1238.8017917133307, 1238.876112388763, 10914.181436392222, 11095.667129986114, 11132.165087618461, 11136.944315278453, 11138.888611113865, 4262.403263543107, 4409.735415875058, 4515.841945531891, 4540.387047748578, 4574.336721175478, 9607.759806004766, 9618.182454491307, 9626.0, 9632.662856799978, 9636.084571965652, 4942.851714448572, 4943.036107958986, 4943.209086546135, 4944.90110197794, 4951.851444456672, 4026.6376026157786, 4488.169688607618, 4552.726836389827, 4564.612007979359, 4575.611073058761, 3811.561670407883, 3857.614238576176, 3900.317444447267, 3972.066564357374, 3982.5264652078918, 1258.993705031469, 1267.9049071319687, 1274.9362531873555, 1280.8655091215473, 1290.6579756364572, 745.6495447139836, 843.759673280277, 881.0880738435816, 897.264243320471, 936.4334577580602, 5426.593005524523, 5451.618386712971, 5475.4524547544925, 5622.662640241599, 5773.24947756789, 937.9812403751887, 975.6926568131016, 980.0101897083854, 991.2317953586029, 994.4381424495137, 3370.191154122993, 3465.8440370183403, 3521.524594179753, 3555.839987200582, 3570.5715314162467, 10114.494275286206, 10516.211284153718, 10520.158387328995, 10521.26351155427, 10532.631357902437, 10369.533370998171, 10391.012853778879, 10400.115990140923, 10407.5836966522, 10450.216233782498, 7695.192004839523, 7925.0, 7927.762167134995, 7935.682572697143, 7936.365090792723, 4906.362172917497, 5574.27534420539, 5635.295588051494, 5646.830595082154, 5706.343770466284, 9127.406718563538, 9198.26413886874, 9273.629054837731, 9315.254779617479, 9398.718038458857, 9313.534323283673, 9347.813043739223, 9496.572654230438, 9593.0, 9620.0, 6840.692168852314, 7650.540967541965, 7854.842903142019, 7915.366770658218, 8269.173082691683, 8043.959780201061, 8078.071021832565, 8136.22705842944, 8141.5522146280155, 8173.100958894398, 7270.745523906638, 7525.510841795266, 7600.581967991813, 7646.65590048438, 7706.499077559941, 7278.417726581966, 7341.59621220838, 7437.888431673421, 7447.441441891771, 7579.355754760686, 6089.1779609753885, 6203.8138855834395, 6206.131141640084, 6212.223472065992, 6216.409441103088, 4829.372181616367, 4929.06347793918, 4964.4539100698175, 5015.3730783652045, 5023.271625614192, 4885.8289959852655, 4886.120498310338, 4900.754962251802, 4934.753262336941, 5198.714070726146], "value": 4467.308741779257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7318359843339, 313.2419544701822, 322.361723786902, 322.77567090871827, 327.7853006280887, 4981.103401387749, 5125.333706618144, 5300.761465734042, 5357.383900851403, 5389.865253368668, 5276.472352764722, 5285.154375299952, 5290.603204759639, 5295.920561191576, 5299.152135658295, 4180.101278225181, 4192.916141677165, 4193.475815523059, 4200.936985945198, 4237.279662457389, 3954.980225098885, 3986.8604598839047, 4222.746635201883, 4235.941014746313, 4237.555056719047, 4074.736831582219, 4104.322786740185, 4104.343305071189, 4120.134771697947, 4151.273527132755, 4081.632653061224, 4117.114820313647, 4118.567550407224, 4135.483064616923, 4142.544320124784, 3626.220362622049, 3637.4907512948207, 3647.215848592565, 3655.817209139559, 3657.3416784978695, 4941.752912354368, 5135.74321283938, 5166.9224961625605, 5169.483051694838, 5188.507091826271, 4625.838095666635, 4679.415073115861, 4734.313524538957, 4740.502247264022, 4743.264793956942, 5323.520883120499, 5469.343678758534, 5516.420775818561, 5516.503514683698, 5532.225488431623, 3939.468171796828, 3945.0926286953872, 3952.7825969571663, 3961.2372494240076, 3996.8800935971967, 5425.810096646638, 5570.86072848178, 5676.375598684142, 5693.316801983747, 5703.971480142573, 4033.4756481657196, 4034.515858097047, 4037.7779222143063, 4052.3111071117983, 4052.7365721228025, 4108.548059713429, 4111.198316328347, 4124.628783409507, 4128.545859955402, 4130.938035929464, 4553.0, 4686.179918514246, 4687.554682305175, 4690.0, 4726.220173671374, 5474.507294343528, 5484.670919744828, 5492.395836458067, 5494.038543254915, 5496.725163741797, 1367.131871261756, 1385.8129152564477, 1386.9583912482642, 1391.5268808605124, 1401.5374926274305, 851.9403641745018, 884.2086332732168, 890.3055616619048, 892.9955350223207, 901.8456375838806, 4690.835820746258, 4695.929561056587, 4695.9668872847915, 4698.882527936829, 4701.858944231679, 4893.608511319086, 4918.48355922623, 4937.963152661159, 4940.517844646592, 4948.752562371867, 4397.450318710161, 4638.698484598491, 4671.818722243573, 4679.204535229019, 4688.218476978795, 2620.296807075378, 2625.960610590843, 2629.593167655295, 2630.355562887105, 2649.9470010600066, 5045.5459008689395, 5089.821856235014, 5091.516305950929, 5094.337736094358, 5121.487851214849, 4687.29690546414, 5001.0998020355955, 5003.449620541737, 5006.674566153189, 5006.974965125151, 5074.771635276422, 5084.694918304914, 5095.974520127375, 5098.413682426569, 5101.566366858784, 4909.214525675875, 4910.680805747615, 4934.901301973869, 4957.429895562056, 4967.82612608557, 4881.461639947137, 4906.141425250638, 4926.433460152129, 5195.792168313225, 5649.209110724584, 5626.2967129108865, 5784.8553786154, 5878.882422351615, 5887.735051922588, 5912.5861189718025, 4093.7134400592863, 4107.979460102681, 4120.505539335299, 4161.625453709181, 4171.624553790052, 5800.723840755028, 5804.390538993345, 5811.389804070512, 5811.738471768866, 5812.593118481665, 5539.307586551681, 5567.498925096761, 5567.638103523258, 5570.769889560462, 5575.77696892136, 5584.385717570983, 5587.8824235152315, 5591.329040515164, 5591.8881622368135, 5593.272874526286, 5213.921791173059, 5518.503334699896, 5523.861903452445, 5525.530329922001, 5591.245181900392, 5621.128725047624, 5623.2127502148915, 5623.662580245198, 5625.943740562542, 5634.464725851038, 5489.258950041693, 5500.477454641803, 5510.410107249586, 5525.668459892258, 5528.75120619565], "value": 4080.7110911070945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9441291903107, 759.1838773318681, 787.9960600196999, 802.4302745051014, 849.6598876063939, 14543.27283635818, 15472.303746331414, 15475.69048619027, 15478.69042619147, 15486.612834679125, 13904.443822247098, 13911.304434778245, 13983.021188516783, 13987.790183147235, 14016.22910739909, 665.1685393258427, 792.3859009267806, 801.7234054251303, 809.1503920883079, 809.5345176523508, 809.6397103289039, 821.1214001018913, 821.8972628421448, 822.2476434062826, 823.1685997142899, 880.0319648386787, 883.7746374674449, 884.0805562215288, 884.0893879304327, 884.1732979664034, 692.1140939597324, 863.2791618998144, 873.6068769053951, 881.9250363719092, 882.1443200095929, 630.1964994631835, 632.1560716443554, 632.6646877155115, 633.2590868683651, 633.4837107757163, 15704.214789260492, 15720.135392553406, 15723.606909827231, 15740.92129539345, 15798.131102789343, 15697.686046279125, 15972.920135399365, 15999.760003599955, 16016.599585010352, 16092.356305747757, 12535.874641253653, 12629.684257893534, 12733.554325598652, 13503.932480337535, 13610.115342502706, 3923.292049540563, 3956.980215098935, 3972.086420123359, 4059.147579008412, 4061.370487574401, 81995.0, 82823.0, 82936.0, 83253.0, 83758.99999999939, 11522.193446458836, 11533.711657208636, 11555.826662600068, 11786.764264714659, 12237.571684990982, 23928.521429571312, 23940.88029559841, 24031.158909438087, 24141.62017317577, 24149.396265093514, 8775.297976161892, 8809.779755506035, 8837.337199709918, 8857.512836794038, 9037.50293733851, 4650.976745116321, 4814.085323788469, 4834.371531700856, 4947.604191664658, 5141.434442211354, 3647.835847386874, 3733.5519737631116, 3777.4522694209186, 3782.3759079751535, 3786.2238241160494, 541.5072284221418, 620.5811077522654, 621.9036049412348, 623.547927752385, 653.9803805885831, 605.5246631394423, 685.7531288736051, 718.9496735228483, 747.6971826410313, 781.7303030454484, 9320.161185493338, 9631.951840240754, 9733.270004749673, 9753.756156096155, 9958.990048982643, 604.724850193161, 743.7616368746085, 749.5727435361791, 754.2721273970535, 762.7902326860158, 4358.3680366347335, 4801.087793319258, 4806.567408933143, 4820.204666230033, 4837.661363704507, 124714.0, 125915.0, 125970.0, 126005.0, 131038.0, 109447.0, 113500.0, 113601.0, 114710.4264478689, 116139.41930290294, 74856.90004249234, 83780.58109709412, 87028.0, 88823.55588222017, 92434.0, 9745.756356091155, 9931.801363972825, 9957.502124893872, 10243.43661098617, 10363.430011349448, 52734.472655272955, 53281.733591331795, 53563.464365355845, 53987.190192146365, 54172.18741718956, 70591.64704176446, 78383.60808195923, 79145.20854791379, 80359.59820200861, 80642.0, 13657.521986730417, 13705.177689338672, 13801.0, 13806.0, 13947.651308717363, 15390.384384624489, 15580.532584022498, 15615.21923903823, 15984.200789960223, 16047.277872495531, 14382.568522944328, 14541.27293635335, 14707.55877323682, 15185.544433667008, 15224.0, 14381.85618143847, 14393.208373539555, 15245.237738113272, 15266.160361180242, 15601.078808550856, 13628.93185534066, 13713.245771482265, 14767.630809229855, 15153.848461515243, 15221.086734795948, 11549.711257218636, 11550.653480395602, 11627.47676354583, 11680.47437865281, 11761.588344407905, 10755.516001779783, 11677.824832627348, 12369.162790467388, 12496.500139994298, 12701.618951431472], "value": 7869.237423547009, "unit": "score"}], "name": "dromaeo_css", "value": 7185.533788922993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 112.0, 108.0, 113.0, 113.0, 112.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 122.0, 188.0, 118.0, 119.0, 155.0, 118.0, 161.0, 119.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 74.0, 75.0, 74.0, 74.0, 112.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 110.0, 85.0, 85.0, 85.0, 116.0, 85.0, 85.0, 124.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 50.0, 52.0, 50.0, 51.0, 53.0, 51.0, 49.0, 51.0, 49.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 79.0, 78.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 129.0, 120.0, 131.0, 124.0, 123.0, 121.0, 137.0, 123.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 168.0, 163.0, 162.0, 167.0, 165.0, 162.0, 159.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 68.0, 63.0, 62.0, 64.0, 63.0, 63.0, 65.0, 62.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1488.4, "alertThreshold": 2.0}]} 03:38:53 INFO - Return code: 0 03:38:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:53 INFO - # TBPL SUCCESS # 03:38:53 INFO - Running post-action listener: _resource_record_post_action 03:38:53 INFO - [mozharness: 2016-08-19 10:38:53.511319Z] Finished run-tests step (success) 03:38:53 INFO - Running post-run listener: _resource_record_post_run 03:38:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408723456; Read time: 20; Write time: 320576 03:38:53 INFO - TinderboxPrint: CPU usage
13.0% 03:38:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 03:38:53 INFO - TinderboxPrint: I/O write bytes / time
408,723,456 / 320,576 03:38:53 INFO - TinderboxPrint: CPU idle
8,279.8 (87.0%) 03:38:53 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 03:38:53 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118018048; Read time: 0; Write time: 117708 03:38:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290705408; Read time: 12; Write time: 202868 03:38:54 INFO - Running post-run listener: _upload_blobber_files 03:38:54 INFO - Blob upload gear active. 03:38:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:54 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 03:38:54 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:38:54 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:38:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:58 INFO - (blobuploader) - INFO - Done attempting. 03:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:58 INFO - (blobuploader) - INFO - Done attempting. 03:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:59 INFO - (blobuploader) - INFO - Done attempting. 03:38:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:59 INFO - Return code: 0 03:38:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a165239edd70af5729d2804eb1228049bb2eae0c7c3830e7d1119b94c6f90247670966a32a6ed55a43a09620028d771d94a104a162eb7610428c294819615a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c9edfcdb494433b086f47e7f8c4f0bda9b7966094626466f0f92794504a70b8343d89947d6492bc58e2cdb656e18d88f1a3450df58e5516a225178c75981a97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b3d1455790f91b301f964462595be9281a1acf6673f95bcb88c5863bcf90cda38b98087d8851958603f0b1730acc10ca356690c4db3f936faeb9a08faa17ca0"} 03:38:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:59 INFO - Contents: 03:38:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a165239edd70af5729d2804eb1228049bb2eae0c7c3830e7d1119b94c6f90247670966a32a6ed55a43a09620028d771d94a104a162eb7610428c294819615a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c9edfcdb494433b086f47e7f8c4f0bda9b7966094626466f0f92794504a70b8343d89947d6492bc58e2cdb656e18d88f1a3450df58e5516a225178c75981a97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b3d1455790f91b301f964462595be9281a1acf6673f95bcb88c5863bcf90cda38b98087d8851958603f0b1730acc10ca356690c4db3f936faeb9a08faa17ca0"} 03:38:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:59 INFO - Copying logs to upload dir... 03:38:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.906323 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-19 03:38:59.533452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 03:38:59.537461) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a165239edd70af5729d2804eb1228049bb2eae0c7c3830e7d1119b94c6f90247670966a32a6ed55a43a09620028d771d94a104a162eb7610428c294819615a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c9edfcdb494433b086f47e7f8c4f0bda9b7966094626466f0f92794504a70b8343d89947d6492bc58e2cdb656e18d88f1a3450df58e5516a225178c75981a97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b3d1455790f91b301f964462595be9281a1acf6673f95bcb88c5863bcf90cda38b98087d8851958603f0b1730acc10ca356690c4db3f936faeb9a08faa17ca0"} build_url:https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011074 build_url: 'https://queue.taskcluster.net/v1/task/EWiorZDxSB-WjjgSUdyDDQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a165239edd70af5729d2804eb1228049bb2eae0c7c3830e7d1119b94c6f90247670966a32a6ed55a43a09620028d771d94a104a162eb7610428c294819615a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c9edfcdb494433b086f47e7f8c4f0bda9b7966094626466f0f92794504a70b8343d89947d6492bc58e2cdb656e18d88f1a3450df58e5516a225178c75981a97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b3d1455790f91b301f964462595be9281a1acf6673f95bcb88c5863bcf90cda38b98087d8851958603f0b1730acc10ca356690c4db3f936faeb9a08faa17ca0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 03:38:59.562763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:38:59.563125) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1471601899.871150-2129438169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:38:59.649386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 03:38:59.649705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 03:38:59.650066) ========= ========= Total master_lag: 0.17 =========