builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1472295922.77 results: success (0) buildid: 20160827025112 builduid: 69210e0e105b4ea9a6be984d78fd8e33 revision: 3cd14570a06e66feea8f2e341b972d442c3494ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.767716) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.768230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.768560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.822453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.822768) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 04:05:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-08-27 04:05:23 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.957248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:22.957869) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015082 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.009112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.009705) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3cd14570a06e66feea8f2e341b972d442c3494ad --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 3cd14570a06e66feea8f2e341b972d442c3494ad --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=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 04:05:23,548 truncating revision to first 12 chars 2016-08-27 04:05:23,548 Setting DEBUG logging. 2016-08-27 04:05:23,548 attempt 1/10 2016-08-27 04:05:23,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3cd14570a06e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 04:05:23,812 unpacking tar archive at: autoland-3cd14570a06e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.636469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.636867) ========= script_repo_revision: 3cd14570a06e66feea8f2e341b972d442c3494ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.637460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.637821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 04:05:23.657579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-27 04:05:23.657894) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:24 INFO - MultiFileLogger online at 20160827 04:05:24 in /builds/slave/test 04:05:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 04:05:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:24 INFO - {'append_to_log': False, 04:05:24 INFO - 'base_work_dir': '/builds/slave/test', 04:05:24 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 04:05:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:24 INFO - 'branch': 'Autoland-Non-PGO', 04:05:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:24 INFO - 'config_files': ('talos/linux_config.py',), 04:05:24 INFO - 'default_actions': ('clobber', 04:05:24 INFO - 'read-buildbot-config', 04:05:24 INFO - 'download-and-extract', 04:05:24 INFO - 'populate-webroot', 04:05:24 INFO - 'create-virtualenv', 04:05:24 INFO - 'install', 04:05:24 INFO - 'run-tests'), 04:05:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:24 INFO - 'download_minidump_stackwalk': True, 04:05:24 INFO - 'download_symbols': 'ondemand', 04:05:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:24 INFO - 'installer_path': 'installer.exe', 04:05:24 INFO - 'log_level': 'info', 04:05:24 INFO - 'log_name': 'talos', 04:05:24 INFO - 'log_to_console': True, 04:05:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:24 INFO - 'opt_config_files': (), 04:05:24 INFO - 'pip_index': False, 04:05:24 INFO - 'sps_profile': False, 04:05:24 INFO - 'sps_profile_interval': 0, 04:05:24 INFO - 'suite': 'dromaeojs', 04:05:24 INFO - 'system_bits': '32', 04:05:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:24 INFO - 'title': 'talos-linux64-ix-040', 04:05:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:24 INFO - 'use_talos_json': True, 04:05:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:24 INFO - 'work_dir': 'build'} 04:05:24 INFO - [mozharness: 2016-08-27 11:05:24.286005Z] Running clobber step. 04:05:24 INFO - Running pre-action listener: _resource_record_pre_action 04:05:24 INFO - Running main action method: clobber 04:05:24 INFO - rmtree: /builds/slave/test/build 04:05:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:24 INFO - Running post-action listener: _resource_record_post_action 04:05:24 INFO - [mozharness: 2016-08-27 11:05:24.752588Z] Finished clobber step (success) 04:05:24 INFO - [mozharness: 2016-08-27 11:05:24.752691Z] Running read-buildbot-config step. 04:05:24 INFO - Running pre-action listener: _resource_record_pre_action 04:05:24 INFO - Running main action method: read_buildbot_config 04:05:24 INFO - Using buildbot properties: 04:05:24 INFO - { 04:05:24 INFO - "project": "", 04:05:24 INFO - "product": "firefox", 04:05:24 INFO - "script_repo_revision": "production", 04:05:24 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 04:05:24 INFO - "repository": "", 04:05:24 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 04:05:24 INFO - "buildid": "20160827025112", 04:05:24 INFO - "pgo_build": "False", 04:05:24 INFO - "basedir": "/builds/slave/test", 04:05:24 INFO - "buildnumber": 335, 04:05:24 INFO - "slavename": "talos-linux64-ix-040", 04:05:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:24 INFO - "platform": "ubuntu64_hw", 04:05:24 INFO - "scheduler": "tests-autoland-linux64-talos", 04:05:24 INFO - "branch": "autoland", 04:05:24 INFO - "repo_path": "integration/autoland", 04:05:24 INFO - "revision": "3cd14570a06e66feea8f2e341b972d442c3494ad", 04:05:24 INFO - "stage_platform": "linux64", 04:05:24 INFO - "builduid": "69210e0e105b4ea9a6be984d78fd8e33", 04:05:24 INFO - "slavebuilddir": "test" 04:05:24 INFO - } 04:05:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:05:24 INFO - Running post-action listener: _resource_record_post_action 04:05:24 INFO - [mozharness: 2016-08-27 11:05:24.755157Z] Finished read-buildbot-config step (success) 04:05:24 INFO - [mozharness: 2016-08-27 11:05:24.755247Z] Running download-and-extract step. 04:05:24 INFO - Running pre-action listener: _resource_record_pre_action 04:05:24 INFO - Running main action method: download_and_extract 04:05:24 INFO - mkdir: /builds/slave/test/build/tests 04:05: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')]} 04:05:24 INFO - trying https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:05:24 INFO - Downloading https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:25 INFO - Downloaded 1361 bytes. 04:05:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:05:25 INFO - Using the following test package requirements: 04:05:25 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:05:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'jsshell-linux-x86_64.zip'], 04:05:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:25 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:25 INFO - trying https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:26 INFO - Downloaded 20305438 bytes. 04:05:26 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 04:05:30 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 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:30 INFO - trying https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:31 INFO - Downloaded 20305438 bytes. 04:05:31 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 04:05: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')]} 04:05:36 INFO - trying https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:36 INFO - Downloading https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:37 INFO - Downloaded 14413998 bytes. 04:05:37 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 04:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:38 INFO - trying https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:38 INFO - Downloading https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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 04:05:40 INFO - Downloaded 55858802 bytes. 04:05:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:40 INFO - mkdir: /builds/slave/test/properties 04:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:40 INFO - Contents: 04:05:40 INFO - build_url:https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:40 INFO - Running post-action listener: _resource_record_post_action 04:05:40 INFO - Running post-action listener: set_extra_try_arguments 04:05:40 INFO - [mozharness: 2016-08-27 11:05:40.783616Z] Finished download-and-extract step (success) 04:05:40 INFO - [mozharness: 2016-08-27 11:05:40.783843Z] Running populate-webroot step. 04:05:40 INFO - Running pre-action listener: _resource_record_pre_action 04:05:40 INFO - Running main action method: populate_webroot 04:05:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:40 INFO - '--tppagecycles', 04:05:40 INFO - '7'], 04:05:40 INFO - 'tests': ['tsvgm']}}, 04:05:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['damp', 'tps']}, 04:05:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'tests': ['damp', 'tps']}, 04:05:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['dromaeo_dom']}, 04:05:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['basic_compositor_video']}, 04:05:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:05:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['a11yr', 04:05:40 INFO - 'ts_paint', 04:05:40 INFO - 'tpaint', 04:05:40 INFO - 'sessionrestore', 04:05:40 INFO - 'sessionrestore_no_auto_restore', 04:05:40 INFO - 'tabpaint']}, 04:05:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['tsvgx', 04:05:40 INFO - 'tsvgr_opacity', 04:05:40 INFO - 'tart', 04:05:40 INFO - 'tscrollx', 04:05:40 INFO - 'cart']}, 04:05:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:40 INFO - 'tsvgr_opacity', 04:05:40 INFO - 'tart', 04:05:40 INFO - 'tscrollx', 04:05:40 INFO - 'cart']}, 04:05:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'talos_options': ['--disable-e10s'], 04:05:40 INFO - 'tests': ['tp5o']}, 04:05:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'tests': ['tp5o']}, 04:05:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'talos_options': ['--disable-e10s', 04:05:40 INFO - '--xperf_path', 04:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:40 INFO - 'tests': ['tp5n']}, 04:05:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:40 INFO - 'talos_options': ['--xperf_path', 04:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:40 INFO - 'tests': ['tp5n']}}, 04:05:40 INFO - 'talos.zip': {'path': '', 04:05:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:40 INFO - Running post-action listener: _resource_record_post_action 04:05:40 INFO - [mozharness: 2016-08-27 11:05:40.805664Z] Finished populate-webroot step (success) 04:05:40 INFO - [mozharness: 2016-08-27 11:05:40.805754Z] Running create-virtualenv step. 04:05:40 INFO - Running pre-action listener: _resource_record_pre_action 04:05:40 INFO - Running main action method: create_virtualenv 04:05:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:40 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 04:05:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:40 INFO - Using real prefix '/usr' 04:05:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:43 INFO - Installing pip.................done. 04:05:43 INFO - Return code: 0 04:05:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05: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', 'pip>=1.5'] in /builds/slave/test/build 04:05: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 pip>=1.5 04:05:43 INFO - Using env: {'DISPLAY': ':0', 04:05:43 INFO - 'HOME': '/home/cltbld', 04:05:43 INFO - 'LANG': 'en_US.UTF-8', 04:05:43 INFO - 'LANGUAGE': 'en_US:en', 04:05:43 INFO - 'LOGNAME': 'cltbld', 04:05:43 INFO - 'MAIL': '/var/mail/cltbld', 04:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:43 INFO - 'MOZ_NO_REMOTE': '1', 04:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:43 INFO - 'NO_EM_RESTART': '1', 04:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:43 INFO - 'PWD': '/builds/slave/test', 04:05:43 INFO - 'SHELL': '/bin/bash', 04:05:43 INFO - 'SHLVL': '1', 04:05:43 INFO - 'TERM': 'linux', 04:05:43 INFO - 'TMOUT': '86400', 04:05:43 INFO - 'USER': 'cltbld', 04:05:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:43 INFO - '_': '/tools/buildbot/bin/python'} 04:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:43 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 04:05:43 INFO - Cleaning up... 04:05:43 INFO - Return code: 0 04:05:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', '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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:05: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 psutil>=3.1.1 04:05:43 INFO - Using env: {'DISPLAY': ':0', 04:05:43 INFO - 'HOME': '/home/cltbld', 04:05:43 INFO - 'LANG': 'en_US.UTF-8', 04:05:43 INFO - 'LANGUAGE': 'en_US:en', 04:05:43 INFO - 'LOGNAME': 'cltbld', 04:05:43 INFO - 'MAIL': '/var/mail/cltbld', 04:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:43 INFO - 'MOZ_NO_REMOTE': '1', 04:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:43 INFO - 'NO_EM_RESTART': '1', 04:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:43 INFO - 'PWD': '/builds/slave/test', 04:05:43 INFO - 'SHELL': '/bin/bash', 04:05:43 INFO - 'SHLVL': '1', 04:05:43 INFO - 'TERM': 'linux', 04:05:43 INFO - 'TMOUT': '86400', 04:05:43 INFO - 'USER': 'cltbld', 04:05:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:43 INFO - '_': '/tools/buildbot/bin/python'} 04:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:43 INFO - Downloading/unpacking psutil>=3.1.1 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:45 INFO - Installing collected packages: psutil 04:05:45 INFO - Running setup.py install for psutil 04:05:45 INFO - building 'psutil._psutil_linux' extension 04:05:45 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 04:05:46 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 04:05:46 INFO - building 'psutil._psutil_posix' extension 04:05:46 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 04:05:46 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 04:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:46 INFO - Successfully installed psutil 04:05:46 INFO - Cleaning up... 04:05:46 INFO - Return code: 0 04:05:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:46 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')]} 04:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:46 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')]} 04:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:46 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05:46 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 04:05:46 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 04:05:46 INFO - Using env: {'DISPLAY': ':0', 04:05:46 INFO - 'HOME': '/home/cltbld', 04:05:46 INFO - 'LANG': 'en_US.UTF-8', 04:05:46 INFO - 'LANGUAGE': 'en_US:en', 04:05:46 INFO - 'LOGNAME': 'cltbld', 04:05:46 INFO - 'MAIL': '/var/mail/cltbld', 04:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:46 INFO - 'MOZ_NO_REMOTE': '1', 04:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:46 INFO - 'NO_EM_RESTART': '1', 04:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:46 INFO - 'PWD': '/builds/slave/test', 04:05:46 INFO - 'SHELL': '/bin/bash', 04:05:46 INFO - 'SHLVL': '1', 04:05:46 INFO - 'TERM': 'linux', 04:05:46 INFO - 'TMOUT': '86400', 04:05:46 INFO - 'USER': 'cltbld', 04:05:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:46 INFO - '_': '/tools/buildbot/bin/python'} 04:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05:46 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 04:05:46 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 04:05:46 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 04:05:46 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 04:05:46 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 04:05:46 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 04:05:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:48 INFO - Installing collected packages: mozsystemmonitor 04:05:48 INFO - Running setup.py install for mozsystemmonitor 04:05:48 INFO - Successfully installed mozsystemmonitor 04:05:48 INFO - Cleaning up... 04:05:48 INFO - Return code: 0 04:05:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', '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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:05: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 jsonschema==2.5.1 04:05:48 INFO - Using env: {'DISPLAY': ':0', 04:05:48 INFO - 'HOME': '/home/cltbld', 04:05:48 INFO - 'LANG': 'en_US.UTF-8', 04:05:48 INFO - 'LANGUAGE': 'en_US:en', 04:05:48 INFO - 'LOGNAME': 'cltbld', 04:05:48 INFO - 'MAIL': '/var/mail/cltbld', 04:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:48 INFO - 'MOZ_NO_REMOTE': '1', 04:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:48 INFO - 'NO_EM_RESTART': '1', 04:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:48 INFO - 'PWD': '/builds/slave/test', 04:05:48 INFO - 'SHELL': '/bin/bash', 04:05:48 INFO - 'SHLVL': '1', 04:05:48 INFO - 'TERM': 'linux', 04:05:48 INFO - 'TMOUT': '86400', 04:05:48 INFO - 'USER': 'cltbld', 04:05:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:48 INFO - '_': '/tools/buildbot/bin/python'} 04:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:48 INFO - Downloading/unpacking jsonschema==2.5.1 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:50 INFO - warning: no files found matching '*.txt' 04:05:50 INFO - no previously-included directories found matching 'build' 04:05:50 INFO - no previously-included directories found matching 'dist' 04:05:50 INFO - no previously-included directories found matching '.git*' 04:05:50 INFO - Installing collected packages: jsonschema, functools32 04:05:51 INFO - Running setup.py install for functools32 04:05:51 INFO - warning: no files found matching '*.txt' 04:05:51 INFO - no previously-included directories found matching 'build' 04:05:51 INFO - no previously-included directories found matching 'dist' 04:05:51 INFO - no previously-included directories found matching '.git*' 04:05:51 INFO - Successfully installed jsonschema functools32 04:05:51 INFO - Cleaning up... 04:05:51 INFO - Return code: 0 04:05:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:05:51 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')]} 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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')]} 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05:51 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 04:05:51 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 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:05:51 INFO - Cleaning up... 04:05:51 INFO - Return code: 0 04:05:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05:51 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')]} 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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')]} 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05:51 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 04:05:51 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 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:53 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 04:05:54 INFO - Downloading docopt-0.6.1.tar.gz 04:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:54 INFO - Running setup.py install for blobuploader 04:05:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:05:54 INFO - Running setup.py install for requests 04:05:54 INFO - Running setup.py install for docopt 04:05:54 INFO - Successfully installed blobuploader requests docopt 04:05:54 INFO - Cleaning up... 04:05:54 INFO - Return code: 0 04:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:54 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05:54 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 04:05:54 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 04:05:54 INFO - Using env: {'DISPLAY': ':0', 04:05:54 INFO - 'HOME': '/home/cltbld', 04:05:54 INFO - 'LANG': 'en_US.UTF-8', 04:05:54 INFO - 'LANGUAGE': 'en_US:en', 04:05:54 INFO - 'LOGNAME': 'cltbld', 04:05:54 INFO - 'MAIL': '/var/mail/cltbld', 04:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:54 INFO - 'MOZ_NO_REMOTE': '1', 04:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:54 INFO - 'NO_EM_RESTART': '1', 04:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:54 INFO - 'PWD': '/builds/slave/test', 04:05:54 INFO - 'SHELL': '/bin/bash', 04:05:54 INFO - 'SHLVL': '1', 04:05:54 INFO - 'TERM': 'linux', 04:05:54 INFO - 'TMOUT': '86400', 04:05:54 INFO - 'USER': 'cltbld', 04:05:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:54 INFO - '_': '/tools/buildbot/bin/python'} 04:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:55 INFO - Running setup.py (path:/tmp/pip-pt9Zi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:55 INFO - Running setup.py (path:/tmp/pip-f8h7JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:55 INFO - Running setup.py (path:/tmp/pip-AI9QLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:55 INFO - Running setup.py (path:/tmp/pip-XehDhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:55 INFO - Running setup.py (path:/tmp/pip-hpK0KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:55 INFO - Running setup.py (path:/tmp/pip-EGNWHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:55 INFO - Running setup.py (path:/tmp/pip-gytoMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:55 INFO - Running setup.py (path:/tmp/pip-b3Pn1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:55 INFO - Running setup.py (path:/tmp/pip-ueVdCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:55 INFO - Running setup.py (path:/tmp/pip-wZ7SHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:55 INFO - Running setup.py (path:/tmp/pip-fpC7qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:55 INFO - Running setup.py (path:/tmp/pip-IEZmat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:55 INFO - Running setup.py (path:/tmp/pip-lexQK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:56 INFO - Running setup.py (path:/tmp/pip-cfGqs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:56 INFO - Running setup.py (path:/tmp/pip-iX3N0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:56 INFO - Running setup.py (path:/tmp/pip-1NVE1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:56 INFO - Running setup.py (path:/tmp/pip-Cv1zcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:56 INFO - Running setup.py install for manifestparser 04:05:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:05:56 INFO - Running setup.py install for mozcrash 04:05:56 INFO - Running setup.py install for mozdebug 04:05:56 INFO - Running setup.py install for mozdevice 04:05:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:56 INFO - Running setup.py install for mozfile 04:05:56 INFO - Running setup.py install for mozhttpd 04:05:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:56 INFO - Running setup.py install for mozinfo 04:05:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:56 INFO - Running setup.py install for mozInstall 04:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Running setup.py install for mozleak 04:05:57 INFO - Running setup.py install for mozlog 04:05:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Running setup.py install for moznetwork 04:05:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Running setup.py install for mozprocess 04:05:57 INFO - Running setup.py install for mozprofile 04:05:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Running setup.py install for mozrunner 04:05:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:57 INFO - Running setup.py install for mozscreenshot 04:05:57 INFO - Running setup.py install for moztest 04:05:57 INFO - Running setup.py install for mozversion 04:05:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:05:58 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 04:05:58 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 04:05:58 INFO - Using env: {'DISPLAY': ':0', 04:05:58 INFO - 'HOME': '/home/cltbld', 04:05:58 INFO - 'LANG': 'en_US.UTF-8', 04:05:58 INFO - 'LANGUAGE': 'en_US:en', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MAIL': '/var/mail/cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SHLVL': '1', 04:05:58 INFO - 'TERM': 'linux', 04:05:58 INFO - 'TMOUT': '86400', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:58 INFO - Running setup.py (path:/tmp/pip-3LzWCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:58 INFO - Running setup.py (path:/tmp/pip-Io3U5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:58 INFO - Running setup.py (path:/tmp/pip-ZJyMdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:58 INFO - Running setup.py (path:/tmp/pip-v0iCwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:58 INFO - Running setup.py (path:/tmp/pip-vnZGZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:58 INFO - Running setup.py (path:/tmp/pip-s87rGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:58 INFO - Running setup.py (path:/tmp/pip-fIAaWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:58 INFO - Running setup.py (path:/tmp/pip-jYTmSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:58 INFO - Running setup.py (path:/tmp/pip-g6Yqdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:58 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)) 04:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:58 INFO - Running setup.py (path:/tmp/pip-tCR0cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:59 INFO - Running setup.py (path:/tmp/pip-hpRH2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:59 INFO - Running setup.py (path:/tmp/pip-G7CnoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:59 INFO - Running setup.py (path:/tmp/pip-LNxty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:59 INFO - Running setup.py (path:/tmp/pip-Rx_NW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:59 INFO - Running setup.py (path:/tmp/pip-HO9Yev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:59 INFO - Running setup.py (path:/tmp/pip-lx85OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:59 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)) 04:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:59 INFO - Running setup.py (path:/tmp/pip-hY3sQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:59 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)) 04:05:59 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)) 04:05:59 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)) 04:05:59 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)) 04:05:59 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)) 04:05:59 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)) 04:05:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:06:01 INFO - Downloading blessings-1.6.tar.gz 04:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:01 INFO - Installing collected packages: blessings 04:06:01 INFO - Running setup.py install for blessings 04:06:01 INFO - Successfully installed blessings 04:06:01 INFO - Cleaning up... 04:06:01 INFO - Return code: 0 04:06:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:01 INFO - Reading from file tmpfile_stdout 04:06:01 INFO - Current package versions: 04:06:01 INFO - argparse == 1.2.1 04:06:01 INFO - blessings == 1.6 04:06:01 INFO - blobuploader == 1.2.4 04:06:01 INFO - docopt == 0.6.1 04:06:01 INFO - functools32 == 3.2.3-2 04:06:01 INFO - jsonschema == 2.5.1 04:06:01 INFO - manifestparser == 1.1 04:06:01 INFO - mozInstall == 1.12 04:06:01 INFO - mozcrash == 0.17 04:06:01 INFO - mozdebug == 0.1 04:06:01 INFO - mozdevice == 0.48 04:06:01 INFO - mozfile == 1.2 04:06:01 INFO - mozhttpd == 0.7 04:06:01 INFO - mozinfo == 0.9 04:06:01 INFO - mozleak == 0.1 04:06:01 INFO - mozlog == 3.3 04:06:01 INFO - moznetwork == 0.27 04:06:01 INFO - mozprocess == 0.23 04:06:01 INFO - mozprofile == 0.28 04:06:01 INFO - mozrunner == 6.12 04:06:01 INFO - mozscreenshot == 0.1 04:06:01 INFO - mozsystemmonitor == 0.3 04:06:01 INFO - moztest == 0.7 04:06:01 INFO - mozversion == 1.4 04:06:01 INFO - psutil == 3.1.1 04:06:01 INFO - requests == 1.2.3 04:06:01 INFO - wsgiref == 0.1.2 04:06:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:06:01 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 04:06:01 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 04:06:01 INFO - Using env: {'DISPLAY': ':0', 04:06:01 INFO - 'HOME': '/home/cltbld', 04:06:01 INFO - 'LANG': 'en_US.UTF-8', 04:06:01 INFO - 'LANGUAGE': 'en_US:en', 04:06:01 INFO - 'LOGNAME': 'cltbld', 04:06:01 INFO - 'MAIL': '/var/mail/cltbld', 04:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:01 INFO - 'MOZ_NO_REMOTE': '1', 04:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:01 INFO - 'NO_EM_RESTART': '1', 04:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:01 INFO - 'PWD': '/builds/slave/test', 04:06:01 INFO - 'SHELL': '/bin/bash', 04:06:01 INFO - 'SHLVL': '1', 04:06:01 INFO - 'TERM': 'linux', 04:06:01 INFO - 'TMOUT': '86400', 04:06:01 INFO - 'USER': 'cltbld', 04:06:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:01 INFO - '_': '/tools/buildbot/bin/python'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 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)) 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:02 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')]} 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 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')]} 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 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 0x7f9d3a87ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, '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': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', '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 04:06:02 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 04:06:02 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 04:06:02 INFO - Using env: {'DISPLAY': ':0', 04:06:02 INFO - 'HOME': '/home/cltbld', 04:06:02 INFO - 'LANG': 'en_US.UTF-8', 04:06:02 INFO - 'LANGUAGE': 'en_US:en', 04:06:02 INFO - 'LOGNAME': 'cltbld', 04:06:02 INFO - 'MAIL': '/var/mail/cltbld', 04:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:02 INFO - 'MOZ_NO_REMOTE': '1', 04:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:02 INFO - 'NO_EM_RESTART': '1', 04:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:02 INFO - 'PWD': '/builds/slave/test', 04:06:02 INFO - 'SHELL': '/bin/bash', 04:06:02 INFO - 'SHLVL': '1', 04:06:02 INFO - 'TERM': 'linux', 04:06:02 INFO - 'TMOUT': '86400', 04:06:02 INFO - 'USER': 'cltbld', 04:06:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:02 INFO - '_': '/tools/buildbot/bin/python'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Running post-action listener: _resource_record_post_action 04:06:02 INFO - Running post-action listener: _start_resource_monitoring 04:06:02 INFO - Starting resource monitoring. 04:06:02 INFO - [mozharness: 2016-08-27 11:06:02.402306Z] Finished create-virtualenv step (success) 04:06:02 INFO - [mozharness: 2016-08-27 11:06:02.402780Z] Running install step. 04:06:02 INFO - Running pre-action listener: _resource_record_pre_action 04:06:02 INFO - Running main action method: install 04:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:02 INFO - Reading from file tmpfile_stdout 04:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:02 INFO - Reading from file tmpfile_stdout 04:06:02 INFO - Output received: 04:06:02 INFO - Usage: mozinstall [options] installer 04:06:02 INFO - Options: 04:06:02 INFO - -h, --help show this help message and exit 04:06:02 INFO - -d DEST, --destination=DEST 04:06:02 INFO - Directory to install application into. [default: 04:06:02 INFO - "/builds/slave/test"] 04:06:02 INFO - --app=APP Application being installed. [default: firefox] 04:06:02 INFO - mkdir: /builds/slave/test/build/application 04:06:02 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'] 04:06:02 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 04:06:19 INFO - Reading from file tmpfile_stdout 04:06:19 INFO - Output received: 04:06:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:19 INFO - Running post-action listener: _resource_record_post_action 04:06:19 INFO - [mozharness: 2016-08-27 11:06:19.393957Z] Finished install step (success) 04:06:19 INFO - [mozharness: 2016-08-27 11:06:19.394238Z] Running run-tests step. 04:06:19 INFO - Running pre-action listener: _resource_record_pre_action 04:06:19 INFO - Running main action method: run_tests 04:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:19 INFO - Python 2.7.3 04:06:19 INFO - Return code: 0 04:06:19 INFO - grabbing minidump binary from tooltool 04:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:19 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 0x27de090>, '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 0x27e19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:19 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 04:06:19 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 04:06:19 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 04:06:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:19 INFO - Return code: 0 04:06:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 04:06:19 INFO - Using env: {'DISPLAY': ':0', 04:06:19 INFO - 'HOME': '/home/cltbld', 04:06:19 INFO - 'LANG': 'en_US.UTF-8', 04:06:19 INFO - 'LANGUAGE': 'en_US:en', 04:06:19 INFO - 'LOGNAME': 'cltbld', 04:06:19 INFO - 'MAIL': '/var/mail/cltbld', 04:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:19 INFO - 'MOZ_NO_REMOTE': '1', 04:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:19 INFO - 'NO_EM_RESTART': '1', 04:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:19 INFO - 'PWD': '/builds/slave/test', 04:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:19 INFO - 'SHELL': '/bin/bash', 04:06:19 INFO - 'SHLVL': '1', 04:06:19 INFO - 'TERM': 'linux', 04:06:19 INFO - 'TMOUT': '86400', 04:06:19 INFO - 'USER': 'cltbld', 04:06:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425', 04:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:19 INFO - '_': '/tools/buildbot/bin/python'} 04:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:06:19 INFO - mozversion application_buildid: 20160827025112 04:06:19 INFO - mozversion application_changeset: 3cd14570a06e66feea8f2e341b972d442c3494ad 04:06:19 INFO - mozversion application_display_name: Nightly 04:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:19 INFO - mozversion application_name: Firefox 04:06:19 INFO - mozversion application_remotingname: firefox 04:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:06:19 INFO - mozversion application_vendor: Mozilla 04:06:19 INFO - mozversion application_version: 51.0a1 04:06:19 INFO - mozversion platform_buildid: 20160827025112 04:06:19 INFO - mozversion platform_changeset: 3cd14570a06e66feea8f2e341b972d442c3494ad 04:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:06:19 INFO - mozversion platform_version: 51.0a1 04:06:19 INFO - using testdate: 1472295979 04:06:19 INFO - actual date: 1472295979 04:06:19 INFO - starting webserver on 'localhost:35007' 04:06:19 INFO - SUITE-START | Running 2 tests 04:06:19 INFO - TEST-START | dromaeo_css 04:06:19 INFO - operating with platform_type : linux_ 04:06:19 INFO - Initialising browser for dromaeo_css test... 04:06:19 INFO - TEST-INFO | started process 3928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNtFLn/profile http://localhost:35007/getInfo.html) 04:06:24 INFO - PROCESS | 3928 | __metrics Screen width/height:1600/1200 04:06:24 INFO - PROCESS | 3928 | colorDepth:24 04:06:24 INFO - PROCESS | 3928 | Browser inner width/height: 1024/697 04:06:24 INFO - PROCESS | 3928 | __metrics 04:06:24 INFO - PROCESS | 3928 | 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" 04:06:24 INFO - PROCESS | 3928 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:25 INFO - PROCESS | 3928 | console.error: PushService: 04:06:25 INFO - PROCESS | 3928 | stateChangeProcessEnqueue: Error transitioning state 04:06:25 INFO - PROCESS | 3928 | UnknownError 04:06:26 INFO - TEST-INFO | 3928: exit 0 04:06:26 INFO - Browser initialized. 04:06:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:26 INFO - TEST-INFO | started process 4008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNtFLn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:38 INFO - PROCESS | 4008 | RSS: Main: 180318208 04:06:38 INFO - PROCESS | 4008 | 04:07:29 INFO - PROCESS | 4008 | 1472296049191 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] 04:09:42 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35007/tests/dromaeo/cssquery-ext.html) 04:09:43 INFO - PROCESS | 4008 | RSS: Main: 271405056 04:09:43 INFO - PROCESS | 4008 | 04:12:46 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-ext.html (next: http://localhost:35007/tests/dromaeo/cssquery-jquery.html) 04:12:47 INFO - PROCESS | 4008 | RSS: Main: 278200320 04:12:47 INFO - PROCESS | 4008 | 04:15:49 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35007/tests/dromaeo/cssquery-mootools.html) 04:15:49 INFO - PROCESS | 4008 | RSS: Main: 250064896 04:15:49 INFO - PROCESS | 4008 | 04:18:52 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35007/tests/dromaeo/cssquery-prototype.html) 04:18:52 INFO - PROCESS | 4008 | RSS: Main: 217157632 04:18:52 INFO - PROCESS | 4008 | 04:21:55 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35007/tests/dromaeo/cssquery-yui.html) 04:21:56 INFO - PROCESS | 4008 | RSS: Main: 220327936 04:21:56 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | Cycle 1(1): loaded http://localhost:35007/tests/dromaeo/cssquery-yui.html (next: http://localhost:35007/tests/dromaeo/cssquery-dojo.html) 04:24:59 INFO - PROCESS | 4008 | RSS: Main: 309219328 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | __start_tp_report 04:24:59 INFO - PROCESS | 4008 | _x_x_mozilla_page_load 04:24:59 INFO - PROCESS | 4008 | _x_x_mozilla_page_load_details 04:24:59 INFO - PROCESS | 4008 | |i|pagename|runs| 04:24:59 INFO - PROCESS | 4008 | |0;dojo.html;2599.6880374355073;2621.3315604520844;2622.567276399394;2659.627652128701;2665.147152911068;4556.248219043862;4632.119897219526;4685.718856868591;4796.928046079307;4856.8785780355465;4688.6249100072;4741.644376671747;4766.475687674361;4768.78540465679;4823.155947709154;4274.871753847389;4300.784960751966;4324.84863029794;4387.034852332482;4523.909521809562;4430.844920427786;4458.1306645204195;4473.865784026484;4497.392851964975;4522.909541809162;4266.082792199661;4307.353896915456;4311.202427550882;4343.804528796211;4404.163208990281;4300.6989510734265;4340.305551111807;4355.912881742379;4390.846320378803;4444.11117776446;4311.310190369526;4322.113966636864;4333.133373325348;4346.261135606955;4412.05140894706;4730.929036064427;4797.760111994421;4799.664023518355;4810.39870016248;4861.343718597979;4925.679830810986;5046.697198168122;5071.619628527875;5090.38915330159;5125.359330083739;5101.387833459971;5108.361454818148;5116.590672746172;5125.256837758541;5127.307813445212;4791;4791.089692958397;4796.424429068534;4815.686980346266;4850.53919877611;5039.672421292677;5172.586193104543;5231.346081739783;5237.423883372826;5301.628885978022;4993.051320249141;5013.623978201649;5015.27278544609;5020.246962955513;5025.6482046256415;5105.489451054939;5105.923411148836;5109.054824857413;5110.4634013428795;5168.638195326291;4885.1206782779445;4962.851114466572;5027.472115427828;5067.341245638044;5142.485751424828;4998.525140111684;5018.698878067327;5019.84940451787;5020.3724534433195;5072.442031376546;4296.140771845581;4301.247281725686;4302.9569704303185;4303.548127446636;4357.975875669215;3716.4239542870896;3721.348763966295;3746.7377283589885;3759.0978165240144;3797.886063418102;4356.28121359972;4368.956310436918;4371.978140109279;4414.4702635683925;4427.955720442755;5080.085584594734;5085.466026067284;5085.949140508547;5087.465816089331;5146.948530514647;4258.616724494748;4339.479262488521;4356.869293921188;4362.912741745211;4390.165868485042;4586.059857729158;4604.562566556172;4637.072585482917;4649.325847752057;4657.604103651228;4789.616830653539;4800.5199480051715;4812.205986012409;4813.446453657874;4857.6599638025;4954.925676114789;5002.149634562061;5112.216959450055;5123.38519377677;5138;4721.787519561697;4750.7862146202815;4766.928496072631;4799.064182484382;4810.63920205979;4957.677750946177;4957.876053098701;4965.677230979974;4973.278874563096;5036;4958.45456999737;4998.550130488274;5020.723860187579;5038.949610503848;5094.15946368845;4889.951100489092;4892.143874821963;4894.828680996148;4942.233953737176;4957.157283261926;4890.682105663121;4895.8041678332465;4897.216445368724;4900.558949694545;4950.084234416644;4733.242681170997;4826.903461930812;4851.58761505276;4913.263010548446;4917.385326834145;4951.232558953368;4964.131277026434;4987.401511818605;5008.69947803133;5028.321176641107;4830.372051633265;4837.975810120927;4841.975790121027;4843.709377437365;4898.4121905371585 04:24:59 INFO - PROCESS | 4008 | |1;ext.html;560.7420586530196;567.9630823996438;574.9851512081175;587.2014060877209;587.8177764892883;38105.80947095264;39954.200915981666;39984.400233996515;40041.3993790093;43353.7832310838;39723.20553588927;40201.798991005;40242.79878600603;40274.59725402745;40339.394909076385;7159.964200179018;7557.206493318205;7666.961665191694;7692.807679807994;7694.615269236544;9661.227101831837;9942.55258513365;9961.103500684936;10280.948595257014;10289.845652315222;10102.14131798798;10182.083612474877;10183.236257280734;10185.745356366077;10185.949070254675;9999.55002024907;10058.798824023552;10066.899331006669;10073.244506661993;10077.09306162449;9847.753806154831;9944.055314745088;9946.90053099467;9947.452890091043;9947.90052099477;37121.44317835235;37424;37438.43842342367;37462.43806342907;37468.437973430424;2841.801073924826;2848.9002884899137;2889.754370878478;2901.7388435040734;2932.5307950727993;27848.721512785018;28184.295392615142;28258.717412825816;28544.429111417656;29047.854760726274;3322.501624756306;3437.157896315394;3448.8792892248903;3462.4633181856852;3560.0565850049757;247884;248633;249456;249483;249523;51970.48029519732;52298.47701523012;52317.7384113077;52347;52374.47625523772;32072.358552828813;32860.83569582184;32892.3421531568;34872.47691284633;55031.72484137554;13387.330633468287;13419.463221471227;13424.865751342557;13434.664133396547;13446.798298025538;10310.948445257725;11156.107511399068;11430.542778288775;11487.655370338904;11584.884151158549;17374.218160182823;17559.912200438917;17573.20920558578;17591.03249321274;17776.377826776;6623.271440141581;6753.594784312957;6754.628495432798;6760.459163267025;6779.898301525481;744.4230721191012;832.9416940814085;845.780097174739;932.1238036246043;951.8429459139303;25131.37171570689;27283.590746138823;27383.726162738516;27443.86278068637;27867.860660696973;873.7553485024204;912.1562554637067;927.5779520318239;963.2534785541121;980.2403137568299;14434.639134021523;14733;14815.185164815823;14917.701645967238;15120.202762488974;377128;380159;382015;382416;383070;48726.26910596273;49363.753181233864;49383.012339753725;49447.25829112566;49459.258111128365;1042.3954106618296;1064.1327318235612;1110.428129513285;1131.0668698323752;1150.666306771027;25202;26960;28039.43921121607;28599.42801144007;29326.266843328234;45743.77128114338;46478.76760616175;46567;46607;46664.76667616776;345089;345143;345316;345587;346613;24279.635805462578;24607.261782146565;24833.503329932937;26014.34964125912;38367.808160959015;40655.59344406636;40674.38988415117;40767.38848917328;41048.79475602603;41284.1743165141;35114.64885351216;35402.64597353993;35437.64562354344;35627.82186089053;35917.82041089778;35358.292834143685;35477.822610887815;36052.27895442129;36197.63802361942;36310.8184459076;34658.306833862676;35146.64853351434;35576.822115889256;35801.82099089488;36139.09652258715;29935.4012919736;32185.517217241293;32769.34461310808;32849.178770530925;32958.835205823816;24293.392665183514;24718.505629887663;24837.50324993526;25355;25375.746242537338 04:24:59 INFO - PROCESS | 4008 | |2;jquery.html;341.4036254286152;360.19855820798745;364.20421379286256;369.3278233614821;383.3483078766097;12517.123801333899;15844.76232856508;16338.673226535477;16715.665686686258;17765;14929.850701492982;15141.936993215511;16643.25105370258;16698.58253543662;16918.915405422955;4945.505449455052;5074.340335756347;5183.092958732225;5287.762050707708;5339.9733001335135;3454.309138172363;5117.795288188468;5143.948560514403;5144.25095467541;5145.511176438233;4961.553460188582;5177.741112944338;5199.818006369778;5249.26510288558;5249.396319423277;5045.621578381636;5159.303494028296;5235.947640523603;5247.921281180786;5257.447967963385;5044.495550444963;5046.419661738911;5047.318611987372;5047.772850221749;5048.091343558158;12214.755704885853;12320.815187772101;12412.441440135126;12429.824780663348;12489;1700.2094026277716;1708.2910592104263;1736.2187015842794;1865.7947625761155;2277.87471689057;8683;8767.123287671246;9154.221891139261;9386.779718636533;9555.23558115349;1625.9593510162222;1663.9001659900446;1669.858062064726;1703.378266932573;1718.9720068798713;63130;72183;72908;73898;74457.25542744504;9297.349185557081;9364.050324147871;9528.90471095294;9571.808563828685;10049.849252261221;12294.569690060805;12363.505459781687;12420.192687475466;12422.937885310515;12633.747325053448;6865.347791959756;7143.357097861218;7187.425005999507;7278.454115941326;7295.270472952769;6681.5656982296;6767.526273160832;6838.829029274209;6980.93019069813;7039.964800176069;3900.7269491135917;3903.863364782219;3914.236723838824;4006.9198616027516;4055.5538890721996;1613.7660039294237;1613.846684564988;1640;1654.9007059576463;1657.1051632118763;778.5056489129444;799;816.2042009041137;850.7022542110336;884.1777147253116;16025.278862451218;16551.08969006692;16958.06730629827;17993.2802687891;18700.438986830417;803.1566854802434;812.244612510371;841.1420351241699;863.330918538138;870.260278763059;9105.356268303212;9667.758306042406;9720.756981075388;9765.755856103655;9986;283156;289979;402378;403106;406728;78225.60887195528;81309;81485.59257203677;81777.18222817696;82497;865.8657908024267;885.1900511032462;913.2191975860676;919.6367434863191;926.1479438916078;15288;15305.31126099306;15964.361425543313;16168.514944551682;16243.269052892885;37677.4348384769;38514;38574.42138367871;38625.42061869018;39413.99999999885;51593.484065160366;51879.74060129826;53098.73450632722;53582.464175357745;54781.72609136929;7705.768826935201;7761.665226361035;7837.725679601187;7924.326432253092;8147.063087744985;10881.782364352826;11878.524859005543;11936.641900742992;11938.343391113573;12402.13185077036;10339.638112666322;10374.636887708893;10388.532516036645;10540.156787456832;10738.73153171177;4482.910341793211;6871.896921546081;9391.20174785151;10348;10473;10693.608469513454;10753.301035432673;10791.070622267896;10948.671539853498;11025.338479691245;7500.437467189873;7741.845163096594;7977.641006154853;8011.719589814328;8056.234657707509;9320.906790932275;10609.787804243717;10654.89345106539;10796.244262901522;10839.187060970302 04:24:59 INFO - PROCESS | 4008 | |3;mootools.html;1221.2184202110645;1327.5619045714916;1375.3260902157942;1436.1885534672908;1676.9832301676988;7391.297826706461;7758;7856.135825059246;8010.91989080109;8091;7885.1326354101;7983.32141767949;7997.320227780631;8004.59977001149;8007.439479236456;2159.287435146398;2186.5954798362272;2188.8686678799245;2191.3535507025385;2195.0451553574167;2159.74083110027;2184.8252139828855;2191.2221161487682;2193.462601662595;2208.2602328220064;2126.8830214338204;2158.8165005974433;2172.196287373674;2177.3467959612053;2182.792634699701;2139.3261122746285;2145.774693657167;2145.9356219313445;2148.7421509418814;2149.8065174134244;2117.894105294729;2160.12514931453;2165.1664109317867;2167.2631305356254;2167.8590891592153;7567.167611562723;7793.298603125746;7932.682692692285;7953.721619743281;7957.283844453969;4449.243628583116;4657.254839225708;4665.463471700764;4665.626749860037;4671.48613652498;2737.9178624641295;2888.2201805512605;2914.8688309025933;2948.5429758387486;2954.4681957247685;990.7374545745383;990.8117457683089;1002.8896821349646;1006.6577363696305;1016.425719468498;10703.411312377817;10859.565617375296;10917.617883374123;10935.726606834893;10948.45257737118;3955.7428767130045;3968.722189446769;4192.0777428965575;4231.894202644959;4333.696641235083;8190.5904704764525;8197.34421246299;8209.712660056988;8220.917790822015;8233;4557.384753058361;4560.407147070926;4562.133194692998;4563.931541026887;4569.497355290915;3689.2068205335445;3731.7201209909367;4183.205191013698;4212.936805947913;4231.746095234295;3396.8301584920655;3419.452887537982;3481.9825900870333;3511.9122021949656;3532.1346270163976;1003.40798928631;1016.9949150254201;1029.480112543176;1035.9741006474899;1042.7341028037802;748.3265061444744;776.4021703288437;791.8337149198618;804.2399932064143;821.4414198345063;5024.924626130611;5160.48395160481;5220.347456567929;5238.842834714965;5346.465353464622;409.2463792648487;424.2511966379343;425.47028948958126;425.80838622619945;430.3673599808277;3297.274599588087;3330.7834990725523;3351.4470112431177;3419.863205471803;3462.6364231755806;9112.908870911338;9563.09150630689;9570.425774453415;9584.76038099053;9598.712038638852;9506.90493095074;9540.14138727504;9557.23542116629;9561.569729362196;9573.473458959685;6835.316468353224;7099.680514376865;7125.287471252833;7139.214686384494;7141.857162856818;5033.773480193327;5226.398964119023;5338.786448542015;5365.785368585213;5480.451954804487;8365.24712775853;8719.258862996463;9000.36997410175;9045.276377889884;9057.864132037894;8615.353848461265;8910.59902304385;8965.596548155218;9006.684766033157;9139.177474027369;6865.244823069358;7012.509124361246;7015.438764898694;7021.859562808613;7022.12223472066;7152.785416437515;7483.027206463125;7483.663235154322;7487.064116985377;7515.736949206752;6892.379685828099;6913.861722765617;6936.4797640176175;6939;6981.057557229912;6673.59958402478;6708.83227919306;6733;6748.865022699617;6817.659117044227;6203.751849925952;6272.09054687077;6287;6287.874242515216;6288.591241569284;4550.499445061107;4635.420572428447;4717.245240761462;4722.1972264714395;4725.952740472551;4523.11799199153;4531.56950089741;4533.569310915458;4670.64970127235;4734.21885388907 04:24:59 INFO - PROCESS | 4008 | |4;prototype.html;278.5584848015895;284.7024859022321;297.2346208513079;297.2390679859559;299.116111889367;4564.657650676196;4802.847316644006;4855.781489832957;4895.21676531755;4924.409070911487;4619.653525985556;4817.277408388734;4822.84251779573;4828.203346447832;4833.130036593412;3766.1337892284723;3785.299719551878;3789.109559253587;3801.3727734923705;3807.3717836556934;3589.0489020409614;3704.5369328833895;3803.695704343646;3806.543214814212;3822.3693090640013;3764.3036038333;3770.170562476251;3770.302494038598;3770.472133901256;3773.584905660375;3764.623537646241;3765.0963768695588;3767.9261410497875;3770;3777.7166712496673;3271.378438096754;3358.378699940519;3360.075979105741;3360.83195840207;3375.7130643895052;4611.723296602215;4630.58324750774;4645.88385290367;4661.976690116561;4687.695299805536;4229.540808421089;4290.099079193373;4295.78521073945;4296.548862369437;4313.15893400787;4967.925481117786;4977.875553111165;4983.401991760976;5004.149294619923;5040.722760248185;3369.393509168349;3545.468179773029;3561.71506279497;3590.407582748843;3669.8165091745573;5206.114960456694;5217.399999000126;5235.188545775411;5245.396779370383;5263.526282634543;3631.364511210528;3641.1443310821937;3643.4534819776713;3643.617420170897;3650.941227044181;3496.6328535503408;3679.025058359537;3693.649103335179;3697.759645623026;3700.4449332600325;4177.540470548237;4203.222403855297;4205.222033923734;4220.134872351161;4227.492700875914;5000.2499625056535;5001.524855138756;5011;5014.924776128361;5025.899482010339;1271.097520760252;1282.313962030328;1283.3583208395803;1286.9742605147844;1287.073307218801;803.8633432316403;820.3888103363033;830.8421399933993;831.4055450352906;836.5984327522701;4036.1837173272147;4039.93940090893;4040.212158629039;4046.959530404717;4053.635172834459;4609.331646911179;4621.260598304322;4627;4631.614718420016;4642.373279607277;4020.8190631421658;4023.9195216095513;4040.696947728932;4049.6152865477734;4057.7159598827798;2306.9077236910334;2460.118009722564;2466.3094333586623;2468.395243165436;2474.2948259745885;4368;4368.868933931987;4377.621049369439;4392.2752745797225;4396.3625274335045;4703.95296047042;4707.435107787019;4710.315120381419;4719.9292010619865;4727.503612120747;4389;4551.931721024187;4892.581151466106;4936.703797772145;4950.331705219749;5220.477952204749;5231.136862417658;5235.240890070994;5236.240745092016;5237.607179461479;4888.264666043646;5010.148274793221;5141.305923700253;5174.275601415729;5176.352955880515;4884.438289596742;4899.4365647950945;4902.460729319843;4912.45962944083;4915.975420122876;3642.7450078494253;3661;3678.7057035436565;3680.3559377109436;3691.427828686558;5027.824026159067;5193.68837869729;5194.3766747990485;5201.947980520146;5243.423223445494;5052.216906379517;5053.823116190915;5055.469175736494;5056.873578160576;5057.216131499624;4973.925391119208;4984.32711583946;4992.750362481934;5043.839916819079;5065.468125846881;4766.809327626856;4973.502649734997;4975.303457516023;4983.5763960063805;4985.252212168204;5026.52248036436;5039.269305950544;5039.823606173766;5040.722760248222;5067.847964561069;4829.56107165893;4870.829520966749;4886.87601851569;4908.263760435963;4910.45984941649 04:24:59 INFO - PROCESS | 4008 | |5;yui.html;606.1059936593524;669.691941706815;677.2279601254568;684.715842925186;713.1584730018576;11602.767944641102;12230.14388992771;12237.877621223784;12297.69255768605;12302.81545776814;12561.371931403417;12732.745345093093;12739.490420383197;12750.872491275084;12758;600.8197540737762;721.4480922094601;735.0701362776092;736.6611358774943;747.4468893019181;754.5472716370161;756.3004221095492;757.6022588141215;757.8597959377505;757.9545227286353;802.2779498451412;802.5786462107382;803.5821372886096;804.4248362420868;804.569555287921;634.5082561015228;772.791346336486;779.7309928074806;786.0174781523096;790.1032328307355;580.2138102870592;580.2398857496651;580.532671199684;581.2588949089902;581.282116586016;11868.406579670982;11907.94046029773;11913.583024594098;11920.940395298056;11924;10473.109785668152;10548.261621686408;10575.894241057567;10945.124390048857;11138.443077846076;9705.320627556073;9984.700458986243;10020.34867733595;10039.799204015879;10097.848532272023;3827.27281816454;3891.76649401034;3895.18201177753;3912.1979994101425;4034.9596504034876;61679.69160154171;62231;62441;63298.68350658263;64981;8919.152680495343;9134;9164.175224229852;9187.26501879848;9299.721008369625;18326.450206493828;18334.174962126737;18341.63316733658;18352;18364;6534.673266336664;6550.901736473957;6698.631575263407;6729.360710732472;6773.322667733188;3572.481990111471;3611.63883611642;3675.503806986076;3700.4449332600325;3744.213715119801;2648.47030593882;2733.876975536066;2740.5615101583653;2742.9862850685618;2749.3264150282907;493.31182999715196;494.695762106302;502.2140350351688;510.02585062530386;517.2706483857743;384.7768294389248;463.45543985817204;474.4238783406138;488.67747286790546;495.45499950054653;5718.1708652246025;6194.442500174916;6588.993554784333;6655.101561289261;6797.966010169917;439.50555624921964;442.8782084926671;476.73779421318136;499.7551199912017;513.6661170239374;2919.3431477917297;3196.7602429817393;3266.6991711360142;3363.6713498168087;3410.1645096951406;87640.5617971906;87924;89545;91832;93449;69006.30993690099;71318;71737.2826271741;72685.2731472689;73991.63004185053;56976.71511642415;66221.33778662248;68448.65775671089;69962;72042.63978680073;7252.673629686782;7298.4891057625455;7459.291367320096;7548.886766698394;7674.61626918663;32376.676233237366;40084.79957600193;40526.79736601416;41706.582934171485;41859.58140418557;34886.82556587201;38643;46831.53168468408;50783.159936607764;53123.46876531185;8192.959035204785;8251.33989280868;8342.624581893708;8687.174718401742;10339.483025848827;9532.713083733608;9646.710598682052;9723;9732.951335243279;9767.413955162712;9115.954420227856;9297.814043718952;9427.292953028413;9466.337356384987;11328.546858125912;9940.701778946643;10090.2432317575;10591.576336946437;10618.256722029384;10926.235163538477;9605.615775368908;9969.40183588987;10175.7456063599;10227.948860255949;10582.735431614272;8397.790055248668;8417.789555261168;8587.441816281922;8611.268042216481;8670.956645216733;8752.387332886638;8768;8780.824383512421;8855.3801233913;9065.18413342776 04:24:59 INFO - PROCESS | 4008 | __end_tp_report 04:24:59 INFO - PROCESS | 4008 | __start_cc_report 04:24:59 INFO - PROCESS | 4008 | _x_x_mozilla_cycle_collect,1005 04:24:59 INFO - PROCESS | 4008 | __end_cc_report 04:24:59 INFO - PROCESS | 4008 | __startTimestamp1472297099721__endTimestamp 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | ------- Summary: start ------- 04:24:59 INFO - PROCESS | 4008 | Number of tests: 6 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#0] dojo.html Cycles:165 Average:4690.84 Median:4826.90 stddev:491.64 (10.2%) stddev-sans-first:464.97 04:24:59 INFO - PROCESS | 4008 | Values: 2599.7 2621.3 2622.6 2659.6 2665.1 4556.2 4632.1 4685.7 4796.9 4856.9 4688.6 4741.6 4766.5 4768.8 4823.2 4274.9 4300.8 4324.8 4387.0 4523.9 4430.8 4458.1 4473.9 4497.4 4522.9 4266.1 4307.4 4311.2 4343.8 4404.2 4300.7 4340.3 4355.9 4390.8 4444.1 4311.3 4322.1 4333.1 4346.3 4412.1 4730.9 4797.8 4799.7 4810.4 4861.3 4925.7 5046.7 5071.6 5090.4 5125.4 5101.4 5108.4 5116.6 5125.3 5127.3 4791.0 4791.1 4796.4 4815.7 4850.5 5039.7 5172.6 5231.3 5237.4 5301.6 4993.1 5013.6 5015.3 5020.2 5025.6 5105.5 5105.9 5109.1 5110.5 5168.6 4885.1 4962.9 5027.5 5067.3 5142.5 4998.5 5018.7 5019.8 5020.4 5072.4 4296.1 4301.2 4303.0 4303.5 4358.0 3716.4 3721.3 3746.7 3759.1 3797.9 4356.3 4369.0 4372.0 4414.5 4428.0 5080.1 5085.5 5085.9 5087.5 5146.9 4258.6 4339.5 4356.9 4362.9 4390.2 4586.1 4604.6 4637.1 4649.3 4657.6 4789.6 4800.5 4812.2 4813.4 4857.7 4954.9 5002.1 5112.2 5123.4 5138.0 4721.8 4750.8 4766.9 4799.1 4810.6 4957.7 4957.9 4965.7 4973.3 5036.0 4958.5 4998.6 5020.7 5038.9 5094.2 4890.0 4892.1 4894.8 4942.2 4957.2 4890.7 4895.8 4897.2 4900.6 4950.1 4733.2 4826.9 4851.6 4913.3 4917.4 4951.2 4964.1 4987.4 5008.7 5028.3 4830.4 4838.0 4842.0 4843.7 4898.4 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#1] ext.html Cycles:180 Average:47653.20 Median:35252.47 stddev:86814.24 (246.3%) stddev-sans-first:86985.78 04:24:59 INFO - PROCESS | 4008 | Values: 560.7 568.0 575.0 587.2 587.8 38105.8 39954.2 39984.4 40041.4 43353.8 39723.2 40201.8 40242.8 40274.6 40339.4 7160.0 7557.2 7667.0 7692.8 7694.6 9661.2 9942.6 9961.1 10280.9 10289.8 10102.1 10182.1 10183.2 10185.7 10185.9 9999.6 10058.8 10066.9 10073.2 10077.1 9847.8 9944.1 9946.9 9947.5 9947.9 37121.4 37424.0 37438.4 37462.4 37468.4 2841.8 2848.9 2889.8 2901.7 2932.5 27848.7 28184.3 28258.7 28544.4 29047.9 3322.5 3437.2 3448.9 3462.5 3560.1 247884.0 248633.0 249456.0 249483.0 249523.0 51970.5 52298.5 52317.7 52347.0 52374.5 32072.4 32860.8 32892.3 34872.5 55031.7 13387.3 13419.5 13424.9 13434.7 13446.8 10310.9 11156.1 11430.5 11487.7 11584.9 17374.2 17559.9 17573.2 17591.0 17776.4 6623.3 6753.6 6754.6 6760.5 6779.9 744.4 832.9 845.8 932.1 951.8 25131.4 27283.6 27383.7 27443.9 27867.9 873.8 912.2 927.6 963.3 980.2 14434.6 14733.0 14815.2 14917.7 15120.2 377128.0 380159.0 382015.0 382416.0 383070.0 48726.3 49363.8 49383.0 49447.3 49459.3 1042.4 1064.1 1110.4 1131.1 1150.7 25202.0 26960.0 28039.4 28599.4 29326.3 45743.8 46478.8 46567.0 46607.0 46664.8 345089.0 345143.0 345316.0 345587.0 346613.0 24279.6 24607.3 24833.5 26014.3 38367.8 40655.6 40674.4 40767.4 41048.8 41284.2 35114.6 35402.6 35437.6 35627.8 35917.8 35358.3 35477.8 36052.3 36197.6 36310.8 34658.3 35146.6 35576.8 35801.8 36139.1 29935.4 32185.5 32769.3 32849.2 32958.8 24293.4 24718.5 24837.5 25355.0 25375.7 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#2] jquery.html Cycles:180 Average:23280.95 Median:5003.02 stddev:60224.12 (1203.8%) stddev-sans-first:60368.43 04:24:59 INFO - PROCESS | 4008 | Values: 341.4 360.2 364.2 369.3 383.3 12517.1 15844.8 16338.7 16715.7 17765.0 14929.9 15141.9 16643.3 16698.6 16918.9 4945.5 5074.3 5183.1 5287.8 5340.0 3454.3 5117.8 5143.9 5144.3 5145.5 4961.6 5177.7 5199.8 5249.3 5249.4 5045.6 5159.3 5235.9 5247.9 5257.4 5044.5 5046.4 5047.3 5047.8 5048.1 12214.8 12320.8 12412.4 12429.8 12489.0 1700.2 1708.3 1736.2 1865.8 2277.9 8683.0 8767.1 9154.2 9386.8 9555.2 1626.0 1663.9 1669.9 1703.4 1719.0 63130.0 72183.0 72908.0 73898.0 74457.3 9297.3 9364.1 9528.9 9571.8 10049.8 12294.6 12363.5 12420.2 12422.9 12633.7 6865.3 7143.4 7187.4 7278.5 7295.3 6681.6 6767.5 6838.8 6980.9 7040.0 3900.7 3903.9 3914.2 4006.9 4055.6 1613.8 1613.8 1640.0 1654.9 1657.1 778.5 799.0 816.2 850.7 884.2 16025.3 16551.1 16958.1 17993.3 18700.4 803.2 812.2 841.1 863.3 870.3 9105.4 9667.8 9720.8 9765.8 9986.0 283156.0 289979.0 402378.0 403106.0 406728.0 78225.6 81309.0 81485.6 81777.2 82497.0 865.9 885.2 913.2 919.6 926.1 15288.0 15305.3 15964.4 16168.5 16243.3 37677.4 38514.0 38574.4 38625.4 39414.0 51593.5 51879.7 53098.7 53582.5 54781.7 7705.8 7761.7 7837.7 7924.3 8147.1 10881.8 11878.5 11936.6 11938.3 12402.1 10339.6 10374.6 10388.5 10540.2 10738.7 4482.9 6871.9 9391.2 10348.0 10473.0 10693.6 10753.3 10791.1 10948.7 11025.3 7500.4 7741.8 7977.6 8011.7 8056.2 9320.9 10609.8 10654.9 10796.2 10839.2 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#3] mootools.html Cycles:180 Average:5089.91 Median:4724.07 stddev:2888.32 (61.1%) stddev-sans-first:2881.79 04:24:59 INFO - PROCESS | 4008 | Values: 1221.2 1327.6 1375.3 1436.2 1677.0 7391.3 7758.0 7856.1 8010.9 8091.0 7885.1 7983.3 7997.3 8004.6 8007.4 2159.3 2186.6 2188.9 2191.4 2195.0 2159.7 2184.8 2191.2 2193.5 2208.3 2126.9 2158.8 2172.2 2177.3 2182.8 2139.3 2145.8 2145.9 2148.7 2149.8 2117.9 2160.1 2165.2 2167.3 2167.9 7567.2 7793.3 7932.7 7953.7 7957.3 4449.2 4657.3 4665.5 4665.6 4671.5 2737.9 2888.2 2914.9 2948.5 2954.5 990.7 990.8 1002.9 1006.7 1016.4 10703.4 10859.6 10917.6 10935.7 10948.5 3955.7 3968.7 4192.1 4231.9 4333.7 8190.6 8197.3 8209.7 8220.9 8233.0 4557.4 4560.4 4562.1 4563.9 4569.5 3689.2 3731.7 4183.2 4212.9 4231.7 3396.8 3419.5 3482.0 3511.9 3532.1 1003.4 1017.0 1029.5 1036.0 1042.7 748.3 776.4 791.8 804.2 821.4 5024.9 5160.5 5220.3 5238.8 5346.5 409.2 424.3 425.5 425.8 430.4 3297.3 3330.8 3351.4 3419.9 3462.6 9112.9 9563.1 9570.4 9584.8 9598.7 9506.9 9540.1 9557.2 9561.6 9573.5 6835.3 7099.7 7125.3 7139.2 7141.9 5033.8 5226.4 5338.8 5365.8 5480.5 8365.2 8719.3 9000.4 9045.3 9057.9 8615.4 8910.6 8965.6 9006.7 9139.2 6865.2 7012.5 7015.4 7021.9 7022.1 7152.8 7483.0 7483.7 7487.1 7515.7 6892.4 6913.9 6936.5 6939.0 6981.1 6673.6 6708.8 6733.0 6748.9 6817.7 6203.8 6272.1 6287.0 6287.9 6288.6 4550.5 4635.4 4717.2 4722.2 4726.0 4523.1 4531.6 4533.6 4670.6 4734.2 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#4] prototype.html Cycles:180 Average:4099.94 Median:4620.46 stddev:1197.69 (25.9%) stddev-sans-first:1166.20 04:24:59 INFO - PROCESS | 4008 | Values: 278.6 284.7 297.2 297.2 299.1 4564.7 4802.8 4855.8 4895.2 4924.4 4619.7 4817.3 4822.8 4828.2 4833.1 3766.1 3785.3 3789.1 3801.4 3807.4 3589.0 3704.5 3803.7 3806.5 3822.4 3764.3 3770.2 3770.3 3770.5 3773.6 3764.6 3765.1 3767.9 3770.0 3777.7 3271.4 3358.4 3360.1 3360.8 3375.7 4611.7 4630.6 4645.9 4662.0 4687.7 4229.5 4290.1 4295.8 4296.5 4313.2 4967.9 4977.9 4983.4 5004.1 5040.7 3369.4 3545.5 3561.7 3590.4 3669.8 5206.1 5217.4 5235.2 5245.4 5263.5 3631.4 3641.1 3643.5 3643.6 3650.9 3496.6 3679.0 3693.6 3697.8 3700.4 4177.5 4203.2 4205.2 4220.1 4227.5 5000.2 5001.5 5011.0 5014.9 5025.9 1271.1 1282.3 1283.4 1287.0 1287.1 803.9 820.4 830.8 831.4 836.6 4036.2 4039.9 4040.2 4047.0 4053.6 4609.3 4621.3 4627.0 4631.6 4642.4 4020.8 4023.9 4040.7 4049.6 4057.7 2306.9 2460.1 2466.3 2468.4 2474.3 4368.0 4368.9 4377.6 4392.3 4396.4 4704.0 4707.4 4710.3 4719.9 4727.5 4389.0 4551.9 4892.6 4936.7 4950.3 5220.5 5231.1 5235.2 5236.2 5237.6 4888.3 5010.1 5141.3 5174.3 5176.4 4884.4 4899.4 4902.5 4912.5 4916.0 3642.7 3661.0 3678.7 3680.4 3691.4 5027.8 5193.7 5194.4 5201.9 5243.4 5052.2 5053.8 5055.5 5056.9 5057.2 4973.9 4984.3 4992.8 5043.8 5065.5 4766.8 4973.5 4975.3 4983.6 4985.3 5026.5 5039.3 5039.8 5040.7 5067.8 4829.6 4870.8 4886.9 4908.3 4910.5 04:24:59 INFO - PROCESS | 4008 | 04:24:59 INFO - PROCESS | 4008 | [#5] yui.html Cycles:180 Average:15733.85 Median:31142.90 stddev:22623.50 (72.6%) stddev-sans-first:22658.45 04:24:59 INFO - PROCESS | 4008 | Values: 606.1 669.7 677.2 684.7 713.2 11602.8 12230.1 12237.9 12297.7 12302.8 12561.4 12732.7 12739.5 12750.9 12758.0 600.8 721.4 735.1 736.7 747.4 754.5 756.3 757.6 757.9 758.0 802.3 802.6 803.6 804.4 804.6 634.5 772.8 779.7 786.0 790.1 580.2 580.2 580.5 581.3 581.3 11868.4 11907.9 11913.6 11920.9 11924.0 10473.1 10548.3 10575.9 10945.1 11138.4 9705.3 9984.7 10020.3 10039.8 10097.8 3827.3 3891.8 3895.2 3912.2 4035.0 61679.7 62231.0 62441.0 63298.7 64981.0 8919.2 9134.0 9164.2 9187.3 9299.7 18326.5 18334.2 18341.6 18352.0 18364.0 6534.7 6550.9 6698.6 6729.4 6773.3 3572.5 3611.6 3675.5 3700.4 3744.2 2648.5 2733.9 2740.6 2743.0 2749.3 493.3 494.7 502.2 510.0 517.3 384.8 463.5 474.4 488.7 495.5 5718.2 6194.4 6589.0 6655.1 6798.0 439.5 442.9 476.7 499.8 513.7 2919.3 3196.8 3266.7 3363.7 3410.2 87640.6 87924.0 89545.0 91832.0 93449.0 69006.3 71318.0 71737.3 72685.3 73991.6 56976.7 66221.3 68448.7 69962.0 72042.6 7252.7 7298.5 7459.3 7548.9 7674.6 32376.7 40084.8 40526.8 41706.6 41859.6 34886.8 38643.0 46831.5 50783.2 53123.5 8193.0 8251.3 8342.6 8687.2 10339.5 9532.7 9646.7 9723.0 9733.0 9767.4 9116.0 9297.8 9427.3 9466.3 11328.5 9940.7 10090.2 10591.6 10618.3 10926.2 9605.6 9969.4 10175.7 10227.9 10582.7 8397.8 8417.8 8587.4 8611.3 8671.0 8752.4 8768.0 8780.8 8855.4 9065.2 04:24:59 INFO - PROCESS | 4008 | -------- Summary: end -------- 04:24:59 INFO - PROCESS | 4008 | 04:25:00 INFO - TEST-INFO | 4008: exit 0 04:25:00 INFO - TEST-OK | dromaeo_css | took 1121084ms 04:25:00 INFO - TEST-START | kraken 04:25:00 INFO - operating with platform_type : linux_ 04:25:00 INFO - Initialising browser for kraken test... 04:25:00 INFO - TEST-INFO | started process 4317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT7dUQE/profile http://localhost:35007/getInfo.html) 04:25:05 INFO - PROCESS | 4317 | __metrics Screen width/height:1600/1200 04:25:05 INFO - PROCESS | 4317 | colorDepth:24 04:25:05 INFO - PROCESS | 4317 | Browser inner width/height: 1024/697 04:25:05 INFO - PROCESS | 4317 | __metrics 04:25:05 INFO - PROCESS | 4317 | 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" 04:25:05 INFO - PROCESS | 4317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:06 INFO - PROCESS | 4317 | console.error: PushService: 04:25:06 INFO - PROCESS | 4317 | stateChangeProcessEnqueue: Error transitioning state 04:25:06 INFO - PROCESS | 4317 | UnknownError 04:25:07 INFO - TEST-INFO | 4317: exit 0 04:25:07 INFO - Browser initialized. 04:25:07 INFO - Running cycle 1/1 for kraken test... 04:25:07 INFO - TEST-INFO | started process 4397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT7dUQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:19 INFO - PROCESS | 4397 | RSS: Main: 180899840 04:25:19 INFO - PROCESS | 4397 | 04:25:22 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35007/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:23 INFO - PROCESS | 4397 | RSS: Main: 234266624 04:25:23 INFO - PROCESS | 4397 | 04:25:25 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35007/tests/kraken/driver.html?testName=audio-dft) 04:25:26 INFO - PROCESS | 4397 | RSS: Main: 224731136 04:25:26 INFO - PROCESS | 4397 | 04:25:29 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35007/tests/kraken/driver.html?testName=audio-fft) 04:25:30 INFO - PROCESS | 4397 | RSS: Main: 302194688 04:25:30 INFO - PROCESS | 4397 | 04:25:32 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35007/tests/kraken/driver.html?testName=audio-oscillator) 04:25:32 INFO - PROCESS | 4397 | RSS: Main: 213225472 04:25:32 INFO - PROCESS | 4397 | 04:25:35 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:35 INFO - PROCESS | 4397 | RSS: Main: 215785472 04:25:35 INFO - PROCESS | 4397 | 04:25:39 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35007/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:39 INFO - PROCESS | 4397 | RSS: Main: 253571072 04:25:39 INFO - PROCESS | 4397 | 04:25:43 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35007/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:43 INFO - PROCESS | 4397 | RSS: Main: 253452288 04:25:43 INFO - PROCESS | 4397 | 04:25:46 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35007/tests/kraken/driver.html?testName=json-parse-financial) 04:25:47 INFO - PROCESS | 4397 | RSS: Main: 251957248 04:25:47 INFO - PROCESS | 4397 | 04:25:48 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:49 INFO - PROCESS | 4397 | RSS: Main: 215019520 04:25:49 INFO - PROCESS | 4397 | 04:25:51 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:52 INFO - PROCESS | 4397 | RSS: Main: 222248960 04:25:52 INFO - PROCESS | 4397 | 04:25:54 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:55 INFO - PROCESS | 4397 | RSS: Main: 224194560 04:25:55 INFO - PROCESS | 4397 | 04:25:57 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:58 INFO - PROCESS | 4397 | RSS: Main: 224141312 04:25:58 INFO - PROCESS | 4397 | 04:26:01 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:01 INFO - PROCESS | 4397 | RSS: Main: 222507008 04:26:01 INFO - PROCESS | 4397 | 04:26:03 INFO - PROCESS | 4397 | Cycle 1(1): loaded http://localhost:35007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35007/tests/kraken/driver.html?testName=ai-astar) 04:26:04 INFO - PROCESS | 4397 | RSS: Main: 272932864 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | __start_tp_report 04:26:04 INFO - PROCESS | 4397 | _x_x_mozilla_page_load 04:26:04 INFO - PROCESS | 4397 | _x_x_mozilla_page_load_details 04:26:04 INFO - PROCESS | 4397 | |i|pagename|runs| 04:26:04 INFO - PROCESS | 4397 | |0;ai-astar;114;115;132;115;116;112;113;113;115;116 04:26:04 INFO - PROCESS | 4397 | |1;audio-beat-detection;148;126;147;192;122;152;149;125;187;129 04:26:04 INFO - PROCESS | 4397 | |2;audio-dft;162;163;163;162;161;162;162;164;163;163 04:26:04 INFO - PROCESS | 4397 | |3;audio-fft;75;77;77;175;77;77;75;77;169;78 04:26:04 INFO - PROCESS | 4397 | |4;audio-oscillator;84;83;149;84;85;86;148;83;84;140 04:26:04 INFO - PROCESS | 4397 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;117 04:26:04 INFO - PROCESS | 4397 | |6;imaging-darkroom;147;148;147;147;147;147;147;147;147;147 04:26:04 INFO - PROCESS | 4397 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;94 04:26:04 INFO - PROCESS | 4397 | |8;json-parse-financial;64;65;65;65;65;67;65;65;64;64 04:26:04 INFO - PROCESS | 4397 | |9;json-stringify-tinderbox;65;66;65;65;66;64;67;66;66;66 04:26:04 INFO - PROCESS | 4397 | |10;stanford-crypto-aes;83;80;82;81;83;87;81;90;87;82 04:26:04 INFO - PROCESS | 4397 | |11;stanford-crypto-ccm;132;132;131;132;137;133;133;133;171;141 04:26:04 INFO - PROCESS | 4397 | |12;stanford-crypto-pbkdf2;174;181;172;173;185;179;176;176;176;170 04:26:04 INFO - PROCESS | 4397 | |13;stanford-crypto-sha256-iterative;75;72;70;70;67;69;69;70;71;70 04:26:04 INFO - PROCESS | 4397 | __end_tp_report 04:26:04 INFO - PROCESS | 4397 | __start_cc_report 04:26:04 INFO - PROCESS | 4397 | _x_x_mozilla_cycle_collect,1984 04:26:04 INFO - PROCESS | 4397 | __end_cc_report 04:26:04 INFO - PROCESS | 4397 | __startTimestamp1472297164006__endTimestamp 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | ------- Summary: start ------- 04:26:04 INFO - PROCESS | 4397 | Number of tests: 14 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#0] ai-astar Cycles:10 Average:116.10 Median:115.00 stddev:5.74 (5.0%) stddev-sans-first:6.04 04:26:04 INFO - PROCESS | 4397 | Values: 114.0 115.0 132.0 115.0 116.0 112.0 113.0 113.0 115.0 116.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:148.50 stddev:24.77 (16.7%) stddev-sans-first:26.28 04:26:04 INFO - PROCESS | 4397 | Values: 148.0 126.0 147.0 192.0 122.0 152.0 149.0 125.0 187.0 129.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:26:04 INFO - PROCESS | 4397 | Values: 162.0 163.0 163.0 162.0 161.0 162.0 162.0 164.0 163.0 163.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#3] audio-fft Cycles:10 Average:95.70 Median:77.00 stddev:40.25 (52.3%) stddev-sans-first:41.99 04:26:04 INFO - PROCESS | 4397 | Values: 75.0 77.0 77.0 175.0 77.0 77.0 75.0 77.0 169.0 78.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:29.82 (35.5%) stddev-sans-first:30.86 04:26:04 INFO - PROCESS | 4397 | Values: 84.0 83.0 149.0 84.0 85.0 86.0 148.0 83.0 84.0 140.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:26:04 INFO - PROCESS | 4397 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:26:04 INFO - PROCESS | 4397 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:26:04 INFO - PROCESS | 4397 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 04:26:04 INFO - PROCESS | 4397 | Values: 64.0 65.0 65.0 65.0 65.0 67.0 65.0 65.0 64.0 64.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 04:26:04 INFO - PROCESS | 4397 | Values: 65.0 66.0 65.0 65.0 66.0 64.0 67.0 66.0 66.0 66.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.27 (3.9%) stddev-sans-first:3.46 04:26:04 INFO - PROCESS | 4397 | Values: 83.0 80.0 82.0 81.0 83.0 87.0 81.0 90.0 87.0 82.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:133.00 stddev:12.15 (9.1%) stddev-sans-first:12.72 04:26:04 INFO - PROCESS | 4397 | Values: 132.0 132.0 131.0 132.0 137.0 133.0 133.0 133.0 171.0 141.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.00 stddev:4.47 (2.5%) stddev-sans-first:4.67 04:26:04 INFO - PROCESS | 4397 | Values: 174.0 181.0 172.0 173.0 185.0 179.0 176.0 176.0 176.0 170.0 04:26:04 INFO - PROCESS | 4397 | 04:26:04 INFO - PROCESS | 4397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:1.39 04:26:04 INFO - PROCESS | 4397 | Values: 75.0 72.0 70.0 70.0 67.0 69.0 69.0 70.0 71.0 70.0 04:26:04 INFO - PROCESS | 4397 | -------- Summary: end -------- 04:26:04 INFO - PROCESS | 4397 | 04:26:05 INFO - TEST-INFO | 4397: exit 0 04:26:05 INFO - TEST-OK | kraken | took 64711ms 04:26:05 INFO - SUITE-END | took 1185s 04:26:05 INFO - Completed test suite (00:19:45) 04:26:05 INFO - javascript benchmark 04:26:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.6880374355073, 2621.3315604520844, 2622.567276399394, 2659.627652128701, 2665.147152911068, 4556.248219043862, 4632.119897219526, 4685.718856868591, 4796.928046079307, 4856.8785780355465, 4688.6249100072, 4741.644376671747, 4766.475687674361, 4768.78540465679, 4823.155947709154, 4274.871753847389, 4300.784960751966, 4324.84863029794, 4387.034852332482, 4523.909521809562, 4430.844920427786, 4458.1306645204195, 4473.865784026484, 4497.392851964975, 4522.909541809162, 4266.082792199661, 4307.353896915456, 4311.202427550882, 4343.804528796211, 4404.163208990281, 4300.6989510734265, 4340.305551111807, 4355.912881742379, 4390.846320378803, 4444.11117776446, 4311.310190369526, 4322.113966636864, 4333.133373325348, 4346.261135606955, 4412.05140894706, 4730.929036064427, 4797.760111994421, 4799.664023518355, 4810.39870016248, 4861.343718597979, 4925.679830810986, 5046.697198168122, 5071.619628527875, 5090.38915330159, 5125.359330083739, 5101.387833459971, 5108.361454818148, 5116.590672746172, 5125.256837758541, 5127.307813445212, 4791.0, 4791.089692958397, 4796.424429068534, 4815.686980346266, 4850.53919877611, 5039.672421292677, 5172.586193104543, 5231.346081739783, 5237.423883372826, 5301.628885978022, 4993.051320249141, 5013.623978201649, 5015.27278544609, 5020.246962955513, 5025.6482046256415, 5105.489451054939, 5105.923411148836, 5109.054824857413, 5110.4634013428795, 5168.638195326291, 4885.1206782779445, 4962.851114466572, 5027.472115427828, 5067.341245638044, 5142.485751424828, 4998.525140111684, 5018.698878067327, 5019.84940451787, 5020.3724534433195, 5072.442031376546, 4296.140771845581, 4301.247281725686, 4302.9569704303185, 4303.548127446636, 4357.975875669215, 3716.4239542870896, 3721.348763966295, 3746.7377283589885, 3759.0978165240144, 3797.886063418102, 4356.28121359972, 4368.956310436918, 4371.978140109279, 4414.4702635683925, 4427.955720442755, 5080.085584594734, 5085.466026067284, 5085.949140508547, 5087.465816089331, 5146.948530514647, 4258.616724494748, 4339.479262488521, 4356.869293921188, 4362.912741745211, 4390.165868485042, 4586.059857729158, 4604.562566556172, 4637.072585482917, 4649.325847752057, 4657.604103651228, 4789.616830653539, 4800.5199480051715, 4812.205986012409, 4813.446453657874, 4857.6599638025, 4954.925676114789, 5002.149634562061, 5112.216959450055, 5123.38519377677, 5138.0, 4721.787519561697, 4750.7862146202815, 4766.928496072631, 4799.064182484382, 4810.63920205979, 4957.677750946177, 4957.876053098701, 4965.677230979974, 4973.278874563096, 5036.0, 4958.45456999737, 4998.550130488274, 5020.723860187579, 5038.949610503848, 5094.15946368845, 4889.951100489092, 4892.143874821963, 4894.828680996148, 4942.233953737176, 4957.157283261926, 4890.682105663121, 4895.8041678332465, 4897.216445368724, 4900.558949694545, 4950.084234416644, 4733.242681170997, 4826.903461930812, 4851.58761505276, 4913.263010548446, 4917.385326834145, 4951.232558953368, 4964.131277026434, 4987.401511818605, 5008.69947803133, 5028.321176641107, 4830.372051633265, 4837.975810120927, 4841.975790121027, 4843.709377437365, 4898.4121905371585], "value": 4659.248408571775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.7420586530196, 567.9630823996438, 574.9851512081175, 587.2014060877209, 587.8177764892883, 38105.80947095264, 39954.200915981666, 39984.400233996515, 40041.3993790093, 43353.7832310838, 39723.20553588927, 40201.798991005, 40242.79878600603, 40274.59725402745, 40339.394909076385, 7159.964200179018, 7557.206493318205, 7666.961665191694, 7692.807679807994, 7694.615269236544, 9661.227101831837, 9942.55258513365, 9961.103500684936, 10280.948595257014, 10289.845652315222, 10102.14131798798, 10182.083612474877, 10183.236257280734, 10185.745356366077, 10185.949070254675, 9999.55002024907, 10058.798824023552, 10066.899331006669, 10073.244506661993, 10077.09306162449, 9847.753806154831, 9944.055314745088, 9946.90053099467, 9947.452890091043, 9947.90052099477, 37121.44317835235, 37424.0, 37438.43842342367, 37462.43806342907, 37468.437973430424, 2841.801073924826, 2848.9002884899137, 2889.754370878478, 2901.7388435040734, 2932.5307950727993, 27848.721512785018, 28184.295392615142, 28258.717412825816, 28544.429111417656, 29047.854760726274, 3322.501624756306, 3437.157896315394, 3448.8792892248903, 3462.4633181856852, 3560.0565850049757, 247884.0, 248633.0, 249456.0, 249483.0, 249523.0, 51970.48029519732, 52298.47701523012, 52317.7384113077, 52347.0, 52374.47625523772, 32072.358552828813, 32860.83569582184, 32892.3421531568, 34872.47691284633, 55031.72484137554, 13387.330633468287, 13419.463221471227, 13424.865751342557, 13434.664133396547, 13446.798298025538, 10310.948445257725, 11156.107511399068, 11430.542778288775, 11487.655370338904, 11584.884151158549, 17374.218160182823, 17559.912200438917, 17573.20920558578, 17591.03249321274, 17776.377826776, 6623.271440141581, 6753.594784312957, 6754.628495432798, 6760.459163267025, 6779.898301525481, 744.4230721191012, 832.9416940814085, 845.780097174739, 932.1238036246043, 951.8429459139303, 25131.37171570689, 27283.590746138823, 27383.726162738516, 27443.86278068637, 27867.860660696973, 873.7553485024204, 912.1562554637067, 927.5779520318239, 963.2534785541121, 980.2403137568299, 14434.639134021523, 14733.0, 14815.185164815823, 14917.701645967238, 15120.202762488974, 377128.0, 380159.0, 382015.0, 382416.0, 383070.0, 48726.26910596273, 49363.753181233864, 49383.012339753725, 49447.25829112566, 49459.258111128365, 1042.3954106618296, 1064.1327318235612, 1110.428129513285, 1131.0668698323752, 1150.666306771027, 25202.0, 26960.0, 28039.43921121607, 28599.42801144007, 29326.266843328234, 45743.77128114338, 46478.76760616175, 46567.0, 46607.0, 46664.76667616776, 345089.0, 345143.0, 345316.0, 345587.0, 346613.0, 24279.635805462578, 24607.261782146565, 24833.503329932937, 26014.34964125912, 38367.808160959015, 40655.59344406636, 40674.38988415117, 40767.38848917328, 41048.79475602603, 41284.1743165141, 35114.64885351216, 35402.64597353993, 35437.64562354344, 35627.82186089053, 35917.82041089778, 35358.292834143685, 35477.822610887815, 36052.27895442129, 36197.63802361942, 36310.8184459076, 34658.306833862676, 35146.64853351434, 35576.822115889256, 35801.82099089488, 36139.09652258715, 29935.4012919736, 32185.517217241293, 32769.34461310808, 32849.178770530925, 32958.835205823816, 24293.392665183514, 24718.505629887663, 24837.50324993526, 25355.0, 25375.746242537338], "value": 17666.897561173853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.4036254286152, 360.19855820798745, 364.20421379286256, 369.3278233614821, 383.3483078766097, 12517.123801333899, 15844.76232856508, 16338.673226535477, 16715.665686686258, 17765.0, 14929.850701492982, 15141.936993215511, 16643.25105370258, 16698.58253543662, 16918.915405422955, 4945.505449455052, 5074.340335756347, 5183.092958732225, 5287.762050707708, 5339.9733001335135, 3454.309138172363, 5117.795288188468, 5143.948560514403, 5144.25095467541, 5145.511176438233, 4961.553460188582, 5177.741112944338, 5199.818006369778, 5249.26510288558, 5249.396319423277, 5045.621578381636, 5159.303494028296, 5235.947640523603, 5247.921281180786, 5257.447967963385, 5044.495550444963, 5046.419661738911, 5047.318611987372, 5047.772850221749, 5048.091343558158, 12214.755704885853, 12320.815187772101, 12412.441440135126, 12429.824780663348, 12489.0, 1700.2094026277716, 1708.2910592104263, 1736.2187015842794, 1865.7947625761155, 2277.87471689057, 8683.0, 8767.123287671246, 9154.221891139261, 9386.779718636533, 9555.23558115349, 1625.9593510162222, 1663.9001659900446, 1669.858062064726, 1703.378266932573, 1718.9720068798713, 63130.0, 72183.0, 72908.0, 73898.0, 74457.25542744504, 9297.349185557081, 9364.050324147871, 9528.90471095294, 9571.808563828685, 10049.849252261221, 12294.569690060805, 12363.505459781687, 12420.192687475466, 12422.937885310515, 12633.747325053448, 6865.347791959756, 7143.357097861218, 7187.425005999507, 7278.454115941326, 7295.270472952769, 6681.5656982296, 6767.526273160832, 6838.829029274209, 6980.93019069813, 7039.964800176069, 3900.7269491135917, 3903.863364782219, 3914.236723838824, 4006.9198616027516, 4055.5538890721996, 1613.7660039294237, 1613.846684564988, 1640.0, 1654.9007059576463, 1657.1051632118763, 778.5056489129444, 799.0, 816.2042009041137, 850.7022542110336, 884.1777147253116, 16025.278862451218, 16551.08969006692, 16958.06730629827, 17993.2802687891, 18700.438986830417, 803.1566854802434, 812.244612510371, 841.1420351241699, 863.330918538138, 870.260278763059, 9105.356268303212, 9667.758306042406, 9720.756981075388, 9765.755856103655, 9986.0, 283156.0, 289979.0, 402378.0, 403106.0, 406728.0, 78225.60887195528, 81309.0, 81485.59257203677, 81777.18222817696, 82497.0, 865.8657908024267, 885.1900511032462, 913.2191975860676, 919.6367434863191, 926.1479438916078, 15288.0, 15305.31126099306, 15964.361425543313, 16168.514944551682, 16243.269052892885, 37677.4348384769, 38514.0, 38574.42138367871, 38625.42061869018, 39413.99999999885, 51593.484065160366, 51879.74060129826, 53098.73450632722, 53582.464175357745, 54781.72609136929, 7705.768826935201, 7761.665226361035, 7837.725679601187, 7924.326432253092, 8147.063087744985, 10881.782364352826, 11878.524859005543, 11936.641900742992, 11938.343391113573, 12402.13185077036, 10339.638112666322, 10374.636887708893, 10388.532516036645, 10540.156787456832, 10738.73153171177, 4482.910341793211, 6871.896921546081, 9391.20174785151, 10348.0, 10473.0, 10693.608469513454, 10753.301035432673, 10791.070622267896, 10948.671539853498, 11025.338479691245, 7500.437467189873, 7741.845163096594, 7977.641006154853, 8011.719589814328, 8056.234657707509, 9320.906790932275, 10609.787804243717, 10654.89345106539, 10796.244262901522, 10839.187060970302], "value": 7900.246807843366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.2184202110645, 1327.5619045714916, 1375.3260902157942, 1436.1885534672908, 1676.9832301676988, 7391.297826706461, 7758.0, 7856.135825059246, 8010.91989080109, 8091.0, 7885.1326354101, 7983.32141767949, 7997.320227780631, 8004.59977001149, 8007.439479236456, 2159.287435146398, 2186.5954798362272, 2188.8686678799245, 2191.3535507025385, 2195.0451553574167, 2159.74083110027, 2184.8252139828855, 2191.2221161487682, 2193.462601662595, 2208.2602328220064, 2126.8830214338204, 2158.8165005974433, 2172.196287373674, 2177.3467959612053, 2182.792634699701, 2139.3261122746285, 2145.774693657167, 2145.9356219313445, 2148.7421509418814, 2149.8065174134244, 2117.894105294729, 2160.12514931453, 2165.1664109317867, 2167.2631305356254, 2167.8590891592153, 7567.167611562723, 7793.298603125746, 7932.682692692285, 7953.721619743281, 7957.283844453969, 4449.243628583116, 4657.254839225708, 4665.463471700764, 4665.626749860037, 4671.48613652498, 2737.9178624641295, 2888.2201805512605, 2914.8688309025933, 2948.5429758387486, 2954.4681957247685, 990.7374545745383, 990.8117457683089, 1002.8896821349646, 1006.6577363696305, 1016.425719468498, 10703.411312377817, 10859.565617375296, 10917.617883374123, 10935.726606834893, 10948.45257737118, 3955.7428767130045, 3968.722189446769, 4192.0777428965575, 4231.894202644959, 4333.696641235083, 8190.5904704764525, 8197.34421246299, 8209.712660056988, 8220.917790822015, 8233.0, 4557.384753058361, 4560.407147070926, 4562.133194692998, 4563.931541026887, 4569.497355290915, 3689.2068205335445, 3731.7201209909367, 4183.205191013698, 4212.936805947913, 4231.746095234295, 3396.8301584920655, 3419.452887537982, 3481.9825900870333, 3511.9122021949656, 3532.1346270163976, 1003.40798928631, 1016.9949150254201, 1029.480112543176, 1035.9741006474899, 1042.7341028037802, 748.3265061444744, 776.4021703288437, 791.8337149198618, 804.2399932064143, 821.4414198345063, 5024.924626130611, 5160.48395160481, 5220.347456567929, 5238.842834714965, 5346.465353464622, 409.2463792648487, 424.2511966379343, 425.47028948958126, 425.80838622619945, 430.3673599808277, 3297.274599588087, 3330.7834990725523, 3351.4470112431177, 3419.863205471803, 3462.6364231755806, 9112.908870911338, 9563.09150630689, 9570.425774453415, 9584.76038099053, 9598.712038638852, 9506.90493095074, 9540.14138727504, 9557.23542116629, 9561.569729362196, 9573.473458959685, 6835.316468353224, 7099.680514376865, 7125.287471252833, 7139.214686384494, 7141.857162856818, 5033.773480193327, 5226.398964119023, 5338.786448542015, 5365.785368585213, 5480.451954804487, 8365.24712775853, 8719.258862996463, 9000.36997410175, 9045.276377889884, 9057.864132037894, 8615.353848461265, 8910.59902304385, 8965.596548155218, 9006.684766033157, 9139.177474027369, 6865.244823069358, 7012.509124361246, 7015.438764898694, 7021.859562808613, 7022.12223472066, 7152.785416437515, 7483.027206463125, 7483.663235154322, 7487.064116985377, 7515.736949206752, 6892.379685828099, 6913.861722765617, 6936.4797640176175, 6939.0, 6981.057557229912, 6673.59958402478, 6708.83227919306, 6733.0, 6748.865022699617, 6817.659117044227, 6203.751849925952, 6272.09054687077, 6287.0, 6287.874242515216, 6288.591241569284, 4550.499445061107, 4635.420572428447, 4717.245240761462, 4722.1972264714395, 4725.952740472551, 4523.11799199153, 4531.56950089741, 4533.569310915458, 4670.64970127235, 4734.21885388907], "value": 4015.182240005181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.5584848015895, 284.7024859022321, 297.2346208513079, 297.2390679859559, 299.116111889367, 4564.657650676196, 4802.847316644006, 4855.781489832957, 4895.21676531755, 4924.409070911487, 4619.653525985556, 4817.277408388734, 4822.84251779573, 4828.203346447832, 4833.130036593412, 3766.1337892284723, 3785.299719551878, 3789.109559253587, 3801.3727734923705, 3807.3717836556934, 3589.0489020409614, 3704.5369328833895, 3803.695704343646, 3806.543214814212, 3822.3693090640013, 3764.3036038333, 3770.170562476251, 3770.302494038598, 3770.472133901256, 3773.584905660375, 3764.623537646241, 3765.0963768695588, 3767.9261410497875, 3770.0, 3777.7166712496673, 3271.378438096754, 3358.378699940519, 3360.075979105741, 3360.83195840207, 3375.7130643895052, 4611.723296602215, 4630.58324750774, 4645.88385290367, 4661.976690116561, 4687.695299805536, 4229.540808421089, 4290.099079193373, 4295.78521073945, 4296.548862369437, 4313.15893400787, 4967.925481117786, 4977.875553111165, 4983.401991760976, 5004.149294619923, 5040.722760248185, 3369.393509168349, 3545.468179773029, 3561.71506279497, 3590.407582748843, 3669.8165091745573, 5206.114960456694, 5217.399999000126, 5235.188545775411, 5245.396779370383, 5263.526282634543, 3631.364511210528, 3641.1443310821937, 3643.4534819776713, 3643.617420170897, 3650.941227044181, 3496.6328535503408, 3679.025058359537, 3693.649103335179, 3697.759645623026, 3700.4449332600325, 4177.540470548237, 4203.222403855297, 4205.222033923734, 4220.134872351161, 4227.492700875914, 5000.2499625056535, 5001.524855138756, 5011.0, 5014.924776128361, 5025.899482010339, 1271.097520760252, 1282.313962030328, 1283.3583208395803, 1286.9742605147844, 1287.073307218801, 803.8633432316403, 820.3888103363033, 830.8421399933993, 831.4055450352906, 836.5984327522701, 4036.1837173272147, 4039.93940090893, 4040.212158629039, 4046.959530404717, 4053.635172834459, 4609.331646911179, 4621.260598304322, 4627.0, 4631.614718420016, 4642.373279607277, 4020.8190631421658, 4023.9195216095513, 4040.696947728932, 4049.6152865477734, 4057.7159598827798, 2306.9077236910334, 2460.118009722564, 2466.3094333586623, 2468.395243165436, 2474.2948259745885, 4368.0, 4368.868933931987, 4377.621049369439, 4392.2752745797225, 4396.3625274335045, 4703.95296047042, 4707.435107787019, 4710.315120381419, 4719.9292010619865, 4727.503612120747, 4389.0, 4551.931721024187, 4892.581151466106, 4936.703797772145, 4950.331705219749, 5220.477952204749, 5231.136862417658, 5235.240890070994, 5236.240745092016, 5237.607179461479, 4888.264666043646, 5010.148274793221, 5141.305923700253, 5174.275601415729, 5176.352955880515, 4884.438289596742, 4899.4365647950945, 4902.460729319843, 4912.45962944083, 4915.975420122876, 3642.7450078494253, 3661.0, 3678.7057035436565, 3680.3559377109436, 3691.427828686558, 5027.824026159067, 5193.68837869729, 5194.3766747990485, 5201.947980520146, 5243.423223445494, 5052.216906379517, 5053.823116190915, 5055.469175736494, 5056.873578160576, 5057.216131499624, 4973.925391119208, 4984.32711583946, 4992.750362481934, 5043.839916819079, 5065.468125846881, 4766.809327626856, 4973.502649734997, 4975.303457516023, 4983.5763960063805, 4985.252212168204, 5026.52248036436, 5039.269305950544, 5039.823606173766, 5040.722760248222, 5067.847964561069, 4829.56107165893, 4870.829520966749, 4886.87601851569, 4908.263760435963, 4910.45984941649], "value": 3718.4070620598736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1059936593524, 669.691941706815, 677.2279601254568, 684.715842925186, 713.1584730018576, 11602.767944641102, 12230.14388992771, 12237.877621223784, 12297.69255768605, 12302.81545776814, 12561.371931403417, 12732.745345093093, 12739.490420383197, 12750.872491275084, 12758.0, 600.8197540737762, 721.4480922094601, 735.0701362776092, 736.6611358774943, 747.4468893019181, 754.5472716370161, 756.3004221095492, 757.6022588141215, 757.8597959377505, 757.9545227286353, 802.2779498451412, 802.5786462107382, 803.5821372886096, 804.4248362420868, 804.569555287921, 634.5082561015228, 772.791346336486, 779.7309928074806, 786.0174781523096, 790.1032328307355, 580.2138102870592, 580.2398857496651, 580.532671199684, 581.2588949089902, 581.282116586016, 11868.406579670982, 11907.94046029773, 11913.583024594098, 11920.940395298056, 11924.0, 10473.109785668152, 10548.261621686408, 10575.894241057567, 10945.124390048857, 11138.443077846076, 9705.320627556073, 9984.700458986243, 10020.34867733595, 10039.799204015879, 10097.848532272023, 3827.27281816454, 3891.76649401034, 3895.18201177753, 3912.1979994101425, 4034.9596504034876, 61679.69160154171, 62231.0, 62441.0, 63298.68350658263, 64981.0, 8919.152680495343, 9134.0, 9164.175224229852, 9187.26501879848, 9299.721008369625, 18326.450206493828, 18334.174962126737, 18341.63316733658, 18352.0, 18364.0, 6534.673266336664, 6550.901736473957, 6698.631575263407, 6729.360710732472, 6773.322667733188, 3572.481990111471, 3611.63883611642, 3675.503806986076, 3700.4449332600325, 3744.213715119801, 2648.47030593882, 2733.876975536066, 2740.5615101583653, 2742.9862850685618, 2749.3264150282907, 493.31182999715196, 494.695762106302, 502.2140350351688, 510.02585062530386, 517.2706483857743, 384.7768294389248, 463.45543985817204, 474.4238783406138, 488.67747286790546, 495.45499950054653, 5718.1708652246025, 6194.442500174916, 6588.993554784333, 6655.101561289261, 6797.966010169917, 439.50555624921964, 442.8782084926671, 476.73779421318136, 499.7551199912017, 513.6661170239374, 2919.3431477917297, 3196.7602429817393, 3266.6991711360142, 3363.6713498168087, 3410.1645096951406, 87640.5617971906, 87924.0, 89545.0, 91832.0, 93449.0, 69006.30993690099, 71318.0, 71737.2826271741, 72685.2731472689, 73991.63004185053, 56976.71511642415, 66221.33778662248, 68448.65775671089, 69962.0, 72042.63978680073, 7252.673629686782, 7298.4891057625455, 7459.291367320096, 7548.886766698394, 7674.61626918663, 32376.676233237366, 40084.79957600193, 40526.79736601416, 41706.582934171485, 41859.58140418557, 34886.82556587201, 38643.0, 46831.53168468408, 50783.159936607764, 53123.46876531185, 8192.959035204785, 8251.33989280868, 8342.624581893708, 8687.174718401742, 10339.483025848827, 9532.713083733608, 9646.710598682052, 9723.0, 9732.951335243279, 9767.413955162712, 9115.954420227856, 9297.814043718952, 9427.292953028413, 9466.337356384987, 11328.546858125912, 9940.701778946643, 10090.2432317575, 10591.576336946437, 10618.256722029384, 10926.235163538477, 9605.615775368908, 9969.40183588987, 10175.7456063599, 10227.948860255949, 10582.735431614272, 8397.790055248668, 8417.789555261168, 8587.441816281922, 8611.268042216481, 8670.956645216733, 8752.387332886638, 8768.0, 8780.824383512421, 8855.3801233913, 9065.18413342776], "value": 5905.480308204638, "unit": "score"}], "name": "dromaeo_css", "value": 6209.84810909151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 132.0, 115.0, 116.0, 112.0, 113.0, 113.0, 115.0, 116.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 147.0, 192.0, 122.0, 152.0, 149.0, 125.0, 187.0, 129.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 161.0, 162.0, 162.0, 164.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 175.0, 77.0, 77.0, 75.0, 77.0, 169.0, 78.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 149.0, 84.0, 85.0, 86.0, 148.0, 83.0, 84.0, 140.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 67.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 81.0, 83.0, 87.0, 81.0, 90.0, 87.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 131.0, 132.0, 137.0, 133.0, 133.0, 133.0, 171.0, 141.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 172.0, 173.0, 185.0, 179.0, 176.0, 176.0, 176.0, 170.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 70.0, 70.0, 67.0, 69.0, 69.0, 70.0, 71.0, 70.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1582.0, "alertThreshold": 2.0}]} 04:26:05 INFO - Return code: 0 04:26:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:05 INFO - # TBPL SUCCESS # 04:26:05 INFO - Running post-action listener: _resource_record_post_action 04:26:05 INFO - [mozharness: 2016-08-27 11:26:05.789362Z] Finished run-tests step (success) 04:26:05 INFO - Running post-run listener: _resource_record_post_run 04:26:05 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406671360; Read time: 4; Write time: 275940 04:26:05 INFO - TinderboxPrint: CPU usage
13.0% 04:26:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 04:26:05 INFO - TinderboxPrint: I/O write bytes / time
406,671,360 / 275,940 04:26:05 INFO - TinderboxPrint: CPU idle
8,345.6 (86.9%) 04:26:05 INFO - TinderboxPrint: CPU user
1,201.6 (12.5%) 04:26:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:26:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113889280; Read time: 0; Write time: 85704 04:26:05 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292245504; Read time: 4; Write time: 190236 04:26:06 INFO - Running post-run listener: _upload_blobber_files 04:26:06 INFO - Blob upload gear active. 04:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:06 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 04:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:10 INFO - (blobuploader) - INFO - Done attempting. 04:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:11 INFO - (blobuploader) - INFO - Done attempting. 04:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:11 INFO - (blobuploader) - INFO - Done attempting. 04:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:11 INFO - Return code: 0 04:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aafdb0080d247c99f38c5fb9c2248ffcb416514c5fc7efb66eb31f59ec869f311aaa5ef844b75ec5bc139cfc410d282c1cea7e48f48bc9174c1a72d93a94301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4e97293b6aa4ec277c158d215c8f1ad0563a5aca0ac7f729e1a0bcd9d9d40cf7730017f4632145ac709960acc68bea8979a14a27c39f8764a7009d3844a8953", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fea5f4ea6169a0c7abdacc1cb653aa9ce993312e4dc8820fa54e3e0a17b1e4187d55fc7954fe83cb9cc65c8ad1cb70bf71b4776d5e8ea9c54a0b7f3afc1ea797"} 04:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:11 INFO - Contents: 04:26:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aafdb0080d247c99f38c5fb9c2248ffcb416514c5fc7efb66eb31f59ec869f311aaa5ef844b75ec5bc139cfc410d282c1cea7e48f48bc9174c1a72d93a94301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4e97293b6aa4ec277c158d215c8f1ad0563a5aca0ac7f729e1a0bcd9d9d40cf7730017f4632145ac709960acc68bea8979a14a27c39f8764a7009d3844a8953", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fea5f4ea6169a0c7abdacc1cb653aa9ce993312e4dc8820fa54e3e0a17b1e4187d55fc7954fe83cb9cc65c8ad1cb70bf71b4776d5e8ea9c54a0b7f3afc1ea797"} 04:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:11 INFO - Copying logs to upload dir... 04:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.848675 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-27 04:26:11.542574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 04:26:11.546948) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 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-Non-PGO/sha512/aafdb0080d247c99f38c5fb9c2248ffcb416514c5fc7efb66eb31f59ec869f311aaa5ef844b75ec5bc139cfc410d282c1cea7e48f48bc9174c1a72d93a94301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4e97293b6aa4ec277c158d215c8f1ad0563a5aca0ac7f729e1a0bcd9d9d40cf7730017f4632145ac709960acc68bea8979a14a27c39f8764a7009d3844a8953", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fea5f4ea6169a0c7abdacc1cb653aa9ce993312e4dc8820fa54e3e0a17b1e4187d55fc7954fe83cb9cc65c8ad1cb70bf71b4776d5e8ea9c54a0b7f3afc1ea797"} build_url:https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/VmDjhzaaTAurxKFiEzldKw/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-Non-PGO/sha512/aafdb0080d247c99f38c5fb9c2248ffcb416514c5fc7efb66eb31f59ec869f311aaa5ef844b75ec5bc139cfc410d282c1cea7e48f48bc9174c1a72d93a94301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f4e97293b6aa4ec277c158d215c8f1ad0563a5aca0ac7f729e1a0bcd9d9d40cf7730017f4632145ac709960acc68bea8979a14a27c39f8764a7009d3844a8953", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fea5f4ea6169a0c7abdacc1cb653aa9ce993312e4dc8820fa54e3e0a17b1e4187d55fc7954fe83cb9cc65c8ad1cb70bf71b4776d5e8ea9c54a0b7f3afc1ea797"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 04:26:11.578062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:26:11.578674) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1472294509.97072-1554267425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:26:11.659991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 04:26:11.660329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 04:26:11.660637) ========= ========= Total master_lag: 0.20 =========