builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1472231964.49 results: success (0) buildid: 20160826073014 builduid: ebdeb4b4ede04b5fb2a53db84c21e4b3 revision: a65b35c8e5b17c2585968974aef1da67a8c56642 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.489173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.489695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.490028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.505468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.505901) ========= 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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 10:19:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.6M=0s 2016-08-26 10:19:24 (56.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.611575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.612007) ========= 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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.662421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:24.662782) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a65b35c8e5b17c2585968974aef1da67a8c56642 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a65b35c8e5b17c2585968974aef1da67a8c56642 --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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 10:19:25,010 truncating revision to first 12 chars 2016-08-26 10:19:25,010 Setting DEBUG logging. 2016-08-26 10:19:25,010 attempt 1/10 2016-08-26 10:19:25,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a65b35c8e5b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 10:19:25,314 unpacking tar archive at: mozilla-central-a65b35c8e5b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:25.311177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:25.311541) ========= script_repo_revision: a65b35c8e5b17c2585968974aef1da67a8c56642 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:25.311978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:25.312360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 10:19:25.571387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 10:19:25.571995) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:26 INFO - MultiFileLogger online at 20160826 10:19:26 in /builds/slave/test 10:19:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:19:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:19:26 INFO - {'append_to_log': False, 10:19:26 INFO - 'base_work_dir': '/builds/slave/test', 10:19:26 INFO - 'blob_upload_branch': 'Firefox', 10:19:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:19:26 INFO - 'branch': 'Firefox', 10:19:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:26 INFO - 'config_files': ('talos/linux_config.py',), 10:19:26 INFO - 'default_actions': ('clobber', 10:19:26 INFO - 'read-buildbot-config', 10:19:26 INFO - 'download-and-extract', 10:19:26 INFO - 'populate-webroot', 10:19:26 INFO - 'create-virtualenv', 10:19:26 INFO - 'install', 10:19:26 INFO - 'run-tests'), 10:19:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:26 INFO - 'download_minidump_stackwalk': True, 10:19:26 INFO - 'download_symbols': 'ondemand', 10:19:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:26 INFO - 'installer_path': 'installer.exe', 10:19:26 INFO - 'log_level': 'info', 10:19:26 INFO - 'log_name': 'talos', 10:19:26 INFO - 'log_to_console': True, 10:19:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:26 INFO - 'opt_config_files': (), 10:19:26 INFO - 'pip_index': False, 10:19:26 INFO - 'sps_profile': False, 10:19:26 INFO - 'sps_profile_interval': 0, 10:19:26 INFO - 'suite': 'dromaeojs', 10:19:26 INFO - 'system_bits': '32', 10:19:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:26 INFO - 'title': 'talos-linux64-ix-032', 10:19:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:26 INFO - 'use_talos_json': True, 10:19:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:19:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:26 INFO - 'work_dir': 'build'} 10:19:26 INFO - [mozharness: 2016-08-26 17:19:26.014203Z] Running clobber step. 10:19:26 INFO - Running pre-action listener: _resource_record_pre_action 10:19:26 INFO - Running main action method: clobber 10:19:26 INFO - rmtree: /builds/slave/test/build 10:19:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:26 INFO - Running post-action listener: _resource_record_post_action 10:19:26 INFO - [mozharness: 2016-08-26 17:19:26.479492Z] Finished clobber step (success) 10:19:26 INFO - [mozharness: 2016-08-26 17:19:26.479595Z] Running read-buildbot-config step. 10:19:26 INFO - Running pre-action listener: _resource_record_pre_action 10:19:26 INFO - Running main action method: read_buildbot_config 10:19:26 INFO - Using buildbot properties: 10:19:26 INFO - { 10:19:26 INFO - "project": "", 10:19:26 INFO - "product": "firefox", 10:19:26 INFO - "script_repo_revision": "production", 10:19:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:19:26 INFO - "repository": "", 10:19:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:19:26 INFO - "buildid": "20160826073014", 10:19:26 INFO - "pgo_build": "True", 10:19:26 INFO - "basedir": "/builds/slave/test", 10:19:26 INFO - "buildnumber": 431, 10:19:26 INFO - "slavename": "talos-linux64-ix-032", 10:19:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:19:26 INFO - "platform": "ubuntu64_hw", 10:19:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:19:26 INFO - "branch": "mozilla-central", 10:19:26 INFO - "repo_path": "mozilla-central", 10:19:26 INFO - "revision": "a65b35c8e5b17c2585968974aef1da67a8c56642", 10:19:26 INFO - "stage_platform": "linux64-pgo", 10:19:26 INFO - "builduid": "ebdeb4b4ede04b5fb2a53db84c21e4b3", 10:19:26 INFO - "slavebuilddir": "test" 10:19:26 INFO - } 10:19:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:19:26 INFO - Running post-action listener: _resource_record_post_action 10:19:26 INFO - [mozharness: 2016-08-26 17:19:26.482065Z] Finished read-buildbot-config step (success) 10:19:26 INFO - [mozharness: 2016-08-26 17:19:26.482155Z] Running download-and-extract step. 10:19:26 INFO - Running pre-action listener: _resource_record_pre_action 10:19:26 INFO - Running main action method: download_and_extract 10:19:26 INFO - mkdir: /builds/slave/test/build/tests 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:26 INFO - trying https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:27 INFO - Downloaded 1361 bytes. 10:19:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:19:27 INFO - Using the following test package requirements: 10:19:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:19:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'jsshell-linux-x86_64.zip'], 10:19:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:19:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:19:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:27 INFO - trying https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:19:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:28 INFO - Downloaded 21875131 bytes. 10:19:28 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 10:19:32 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 10:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:32 INFO - trying https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:19:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:33 INFO - Downloaded 21875131 bytes. 10:19:33 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 10:19:37 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')]} 10:19:37 INFO - trying https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:38 INFO - Downloaded 14413998 bytes. 10:19:38 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 10:19: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')]} 10:19:38 INFO - trying https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:19:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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 10:19:40 INFO - Downloaded 59679393 bytes. 10:19:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:19:40 INFO - mkdir: /builds/slave/test/properties 10:19:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:40 INFO - Contents: 10:19:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:19:40 INFO - Running post-action listener: _resource_record_post_action 10:19:40 INFO - Running post-action listener: set_extra_try_arguments 10:19:40 INFO - [mozharness: 2016-08-26 17:19:40.972628Z] Finished download-and-extract step (success) 10:19:40 INFO - [mozharness: 2016-08-26 17:19:40.972855Z] Running populate-webroot step. 10:19:40 INFO - Running pre-action listener: _resource_record_pre_action 10:19:40 INFO - Running main action method: populate_webroot 10:19:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:40 INFO - '--tppagecycles', 10:19:40 INFO - '7'], 10:19:40 INFO - 'tests': ['tsvgm']}}, 10:19:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['damp', 'tps']}, 10:19:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['damp', 'tps']}, 10:19:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['dromaeo_dom']}, 10:19:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['basic_compositor_video']}, 10:19:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tsvgx', 10:19:40 INFO - 'tsvgr_opacity', 10:19:40 INFO - 'tart', 10:19:40 INFO - 'tscrollx', 10:19:40 INFO - 'cart']}, 10:19:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:40 INFO - 'tsvgr_opacity', 10:19:40 INFO - 'tart', 10:19:40 INFO - 'tscrollx', 10:19:40 INFO - 'cart']}, 10:19:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tp5o']}, 10:19:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['tp5o']}, 10:19:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s', 10:19:40 INFO - '--xperf_path', 10:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:40 INFO - 'tests': ['tp5n']}, 10:19:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--xperf_path', 10:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:40 INFO - 'tests': ['tp5n']}}, 10:19:40 INFO - 'talos.zip': {'path': '', 10:19:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:40 INFO - Running post-action listener: _resource_record_post_action 10:19:40 INFO - [mozharness: 2016-08-26 17:19:40.996564Z] Finished populate-webroot step (success) 10:19:40 INFO - [mozharness: 2016-08-26 17:19:40.996654Z] Running create-virtualenv step. 10:19:40 INFO - Running pre-action listener: _resource_record_pre_action 10:19:40 INFO - Running main action method: create_virtualenv 10:19:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19: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 10:19:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:41 INFO - Using real prefix '/usr' 10:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:43 INFO - Installing pip.................done. 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:43 INFO - Using env: {'DISPLAY': ':0', 10:19:43 INFO - 'HOME': '/home/cltbld', 10:19:43 INFO - 'LANG': 'en_US.UTF-8', 10:19:43 INFO - 'LANGUAGE': 'en_US:en', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MAIL': '/var/mail/cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SHLVL': '1', 10:19:43 INFO - 'TERM': 'linux', 10:19:43 INFO - 'TMOUT': '86400', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - '_': '/tools/buildbot/bin/python'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19: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 10:19:43 INFO - Cleaning up... 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:43 INFO - Using env: {'DISPLAY': ':0', 10:19:43 INFO - 'HOME': '/home/cltbld', 10:19:43 INFO - 'LANG': 'en_US.UTF-8', 10:19:43 INFO - 'LANGUAGE': 'en_US:en', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MAIL': '/var/mail/cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SHLVL': '1', 10:19:43 INFO - 'TERM': 'linux', 10:19:43 INFO - 'TMOUT': '86400', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - '_': '/tools/buildbot/bin/python'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:43 INFO - Downloading/unpacking psutil>=3.1.1 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:44 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 10:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:46 INFO - Installing collected packages: psutil 10:19:46 INFO - Running setup.py install for psutil 10:19:46 INFO - building 'psutil._psutil_linux' extension 10:19:46 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 10:19: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 10:19:46 INFO - building 'psutil._psutil_posix' extension 10:19: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 10:19: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 10:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:46 INFO - Successfully installed psutil 10:19:46 INFO - Cleaning up... 10:19:46 INFO - Return code: 0 10:19:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:46 INFO - Using env: {'DISPLAY': ':0', 10:19:46 INFO - 'HOME': '/home/cltbld', 10:19:46 INFO - 'LANG': 'en_US.UTF-8', 10:19:46 INFO - 'LANGUAGE': 'en_US:en', 10:19:46 INFO - 'LOGNAME': 'cltbld', 10:19:46 INFO - 'MAIL': '/var/mail/cltbld', 10:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:46 INFO - 'MOZ_NO_REMOTE': '1', 10:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:46 INFO - 'NO_EM_RESTART': '1', 10:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:46 INFO - 'PWD': '/builds/slave/test', 10:19:46 INFO - 'SHELL': '/bin/bash', 10:19:46 INFO - 'SHLVL': '1', 10:19:46 INFO - 'TERM': 'linux', 10:19:46 INFO - 'TMOUT': '86400', 10:19:46 INFO - 'USER': 'cltbld', 10:19:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:46 INFO - '_': '/tools/buildbot/bin/python'} 10:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:48 INFO - Installing collected packages: mozsystemmonitor 10:19:48 INFO - Running setup.py install for mozsystemmonitor 10:19:48 INFO - Successfully installed mozsystemmonitor 10:19:48 INFO - Cleaning up... 10:19:48 INFO - Return code: 0 10:19:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:48 INFO - Using env: {'DISPLAY': ':0', 10:19:48 INFO - 'HOME': '/home/cltbld', 10:19:48 INFO - 'LANG': 'en_US.UTF-8', 10:19:48 INFO - 'LANGUAGE': 'en_US:en', 10:19:48 INFO - 'LOGNAME': 'cltbld', 10:19:48 INFO - 'MAIL': '/var/mail/cltbld', 10:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:48 INFO - 'MOZ_NO_REMOTE': '1', 10:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:48 INFO - 'NO_EM_RESTART': '1', 10:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:48 INFO - 'PWD': '/builds/slave/test', 10:19:48 INFO - 'SHELL': '/bin/bash', 10:19:48 INFO - 'SHLVL': '1', 10:19:48 INFO - 'TERM': 'linux', 10:19:48 INFO - 'TMOUT': '86400', 10:19:48 INFO - 'USER': 'cltbld', 10:19:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:48 INFO - '_': '/tools/buildbot/bin/python'} 10:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:51 INFO - warning: no files found matching '*.txt' 10:19:51 INFO - no previously-included directories found matching 'build' 10:19:51 INFO - no previously-included directories found matching 'dist' 10:19:51 INFO - no previously-included directories found matching '.git*' 10:19:51 INFO - Installing collected packages: jsonschema, functools32 10:19:51 INFO - Running setup.py install for functools32 10:19:51 INFO - warning: no files found matching '*.txt' 10:19:51 INFO - no previously-included directories found matching 'build' 10:19:51 INFO - no previously-included directories found matching 'dist' 10:19:51 INFO - no previously-included directories found matching '.git*' 10:19:51 INFO - Successfully installed jsonschema functools32 10:19:51 INFO - Cleaning up... 10:19:51 INFO - Return code: 0 10:19:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:51 INFO - Using env: {'DISPLAY': ':0', 10:19:51 INFO - 'HOME': '/home/cltbld', 10:19:51 INFO - 'LANG': 'en_US.UTF-8', 10:19:51 INFO - 'LANGUAGE': 'en_US:en', 10:19:51 INFO - 'LOGNAME': 'cltbld', 10:19:51 INFO - 'MAIL': '/var/mail/cltbld', 10:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:51 INFO - 'MOZ_NO_REMOTE': '1', 10:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:51 INFO - 'NO_EM_RESTART': '1', 10:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:51 INFO - 'PWD': '/builds/slave/test', 10:19:51 INFO - 'SHELL': '/bin/bash', 10:19:51 INFO - 'SHLVL': '1', 10:19:51 INFO - 'TERM': 'linux', 10:19:51 INFO - 'TMOUT': '86400', 10:19:51 INFO - 'USER': 'cltbld', 10:19:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:51 INFO - '_': '/tools/buildbot/bin/python'} 10:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:51 INFO - Cleaning up... 10:19:51 INFO - Return code: 0 10:19:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:51 INFO - Using env: {'DISPLAY': ':0', 10:19:51 INFO - 'HOME': '/home/cltbld', 10:19:51 INFO - 'LANG': 'en_US.UTF-8', 10:19:51 INFO - 'LANGUAGE': 'en_US:en', 10:19:51 INFO - 'LOGNAME': 'cltbld', 10:19:51 INFO - 'MAIL': '/var/mail/cltbld', 10:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:51 INFO - 'MOZ_NO_REMOTE': '1', 10:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:51 INFO - 'NO_EM_RESTART': '1', 10:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:51 INFO - 'PWD': '/builds/slave/test', 10:19:51 INFO - 'SHELL': '/bin/bash', 10:19:51 INFO - 'SHLVL': '1', 10:19:51 INFO - 'TERM': 'linux', 10:19:51 INFO - 'TMOUT': '86400', 10:19:51 INFO - 'USER': 'cltbld', 10:19:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:51 INFO - '_': '/tools/buildbot/bin/python'} 10:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:54 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 10:19:54 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 10:19:54 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 10:19:54 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 10:19:54 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 10:19:54 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 10:19:54 INFO - Downloading docopt-0.6.1.tar.gz 10:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:54 INFO - Running setup.py install for blobuploader 10:19:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:54 INFO - Running setup.py install for requests 10:19:54 INFO - Running setup.py install for docopt 10:19:54 INFO - Successfully installed blobuploader requests docopt 10:19:54 INFO - Cleaning up... 10:19:55 INFO - Return code: 0 10:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:55 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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19:55 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 10:19:55 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 10:19:55 INFO - Using env: {'DISPLAY': ':0', 10:19:55 INFO - 'HOME': '/home/cltbld', 10:19:55 INFO - 'LANG': 'en_US.UTF-8', 10:19:55 INFO - 'LANGUAGE': 'en_US:en', 10:19:55 INFO - 'LOGNAME': 'cltbld', 10:19:55 INFO - 'MAIL': '/var/mail/cltbld', 10:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:55 INFO - 'MOZ_NO_REMOTE': '1', 10:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:55 INFO - 'NO_EM_RESTART': '1', 10:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:55 INFO - 'PWD': '/builds/slave/test', 10:19:55 INFO - 'SHELL': '/bin/bash', 10:19:55 INFO - 'SHLVL': '1', 10:19:55 INFO - 'TERM': 'linux', 10:19:55 INFO - 'TMOUT': '86400', 10:19:55 INFO - 'USER': 'cltbld', 10:19:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:55 INFO - '_': '/tools/buildbot/bin/python'} 10:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:55 INFO - Running setup.py (path:/tmp/pip-V3BnVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:55 INFO - Running setup.py (path:/tmp/pip-0l0Y_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:55 INFO - Running setup.py (path:/tmp/pip-Csv1Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:55 INFO - Running setup.py (path:/tmp/pip-s3hJUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:55 INFO - Running setup.py (path:/tmp/pip-Y9Vfmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:55 INFO - Running setup.py (path:/tmp/pip-YlvCNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:55 INFO - Running setup.py (path:/tmp/pip-n_5SEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:55 INFO - Running setup.py (path:/tmp/pip-Hr8Q9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:55 INFO - Running setup.py (path:/tmp/pip-O8Kigz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:55 INFO - Running setup.py (path:/tmp/pip-KbkaF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:55 INFO - Running setup.py (path:/tmp/pip-JAKuBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:56 INFO - Running setup.py (path:/tmp/pip-YS1dEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:56 INFO - Running setup.py (path:/tmp/pip-ChwNqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:56 INFO - Running setup.py (path:/tmp/pip-Pg50oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:56 INFO - Running setup.py (path:/tmp/pip-O_Q3KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:56 INFO - Running setup.py (path:/tmp/pip-FiMVg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:56 INFO - Running setup.py (path:/tmp/pip-uoe7xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:56 INFO - Running setup.py install for manifestparser 10:19:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:56 INFO - Running setup.py install for mozcrash 10:19:56 INFO - Running setup.py install for mozdebug 10:19:56 INFO - Running setup.py install for mozdevice 10:19:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:56 INFO - Running setup.py install for mozfile 10:19:56 INFO - Running setup.py install for mozhttpd 10:19:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozinfo 10:19:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozInstall 10:19:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozleak 10:19:57 INFO - Running setup.py install for mozlog 10:19:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for moznetwork 10:19:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozprocess 10:19:57 INFO - Running setup.py install for mozprofile 10:19:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozrunner 10:19:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:57 INFO - Running setup.py install for mozscreenshot 10:19:58 INFO - Running setup.py install for moztest 10:19:58 INFO - Running setup.py install for mozversion 10:19:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:58 INFO - Cleaning up... 10:19:58 INFO - Return code: 0 10:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:19: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 10:19: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 10:19:58 INFO - Using env: {'DISPLAY': ':0', 10:19:58 INFO - 'HOME': '/home/cltbld', 10:19:58 INFO - 'LANG': 'en_US.UTF-8', 10:19:58 INFO - 'LANGUAGE': 'en_US:en', 10:19:58 INFO - 'LOGNAME': 'cltbld', 10:19:58 INFO - 'MAIL': '/var/mail/cltbld', 10:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:58 INFO - 'MOZ_NO_REMOTE': '1', 10:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:58 INFO - 'NO_EM_RESTART': '1', 10:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:58 INFO - 'PWD': '/builds/slave/test', 10:19:58 INFO - 'SHELL': '/bin/bash', 10:19:58 INFO - 'SHLVL': '1', 10:19:58 INFO - 'TERM': 'linux', 10:19:58 INFO - 'TMOUT': '86400', 10:19:58 INFO - 'USER': 'cltbld', 10:19:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:58 INFO - '_': '/tools/buildbot/bin/python'} 10:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:58 INFO - Running setup.py (path:/tmp/pip-6pkjwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:58 INFO - Running setup.py (path:/tmp/pip-Btul4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:58 INFO - Running setup.py (path:/tmp/pip-pS0qfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:58 INFO - Running setup.py (path:/tmp/pip-HB3dyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:58 INFO - Running setup.py (path:/tmp/pip-uNJpV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:58 INFO - Running setup.py (path:/tmp/pip-zzcmSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:58 INFO - Running setup.py (path:/tmp/pip-vo4KeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19: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)) 10:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:58 INFO - Running setup.py (path:/tmp/pip-5jpNSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:59 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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:59 INFO - Running setup.py (path:/tmp/pip-7L8RR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:59 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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:59 INFO - Running setup.py (path:/tmp/pip-2Od4uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:59 INFO - Running setup.py (path:/tmp/pip-dr6zT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:59 INFO - Running setup.py (path:/tmp/pip-2l6Vk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:59 INFO - Running setup.py (path:/tmp/pip-ZqHZ3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:59 INFO - Running setup.py (path:/tmp/pip-YWquSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:59 INFO - Running setup.py (path:/tmp/pip-_2Ij1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:59 INFO - Running setup.py (path:/tmp/pip-1doKgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19: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)) 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:59 INFO - Running setup.py (path:/tmp/pip-lgjam4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19: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)) 10:19: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)) 10:19: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)) 10:19: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)) 10:19: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)) 10:19: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)) 10:19:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:20:01 INFO - Downloading blessings-1.6.tar.gz 10:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:01 INFO - Installing collected packages: blessings 10:20:01 INFO - Running setup.py install for blessings 10:20:01 INFO - Successfully installed blessings 10:20:01 INFO - Cleaning up... 10:20:01 INFO - Return code: 0 10:20:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:02 INFO - Reading from file tmpfile_stdout 10:20:02 INFO - Current package versions: 10:20:02 INFO - argparse == 1.2.1 10:20:02 INFO - blessings == 1.6 10:20:02 INFO - blobuploader == 1.2.4 10:20:02 INFO - docopt == 0.6.1 10:20:02 INFO - functools32 == 3.2.3-2 10:20:02 INFO - jsonschema == 2.5.1 10:20:02 INFO - manifestparser == 1.1 10:20:02 INFO - mozInstall == 1.12 10:20:02 INFO - mozcrash == 0.17 10:20:02 INFO - mozdebug == 0.1 10:20:02 INFO - mozdevice == 0.48 10:20:02 INFO - mozfile == 1.2 10:20:02 INFO - mozhttpd == 0.7 10:20:02 INFO - mozinfo == 0.9 10:20:02 INFO - mozleak == 0.1 10:20:02 INFO - mozlog == 3.3 10:20:02 INFO - moznetwork == 0.27 10:20:02 INFO - mozprocess == 0.23 10:20:02 INFO - mozprofile == 0.28 10:20:02 INFO - mozrunner == 6.12 10:20:02 INFO - mozscreenshot == 0.1 10:20:02 INFO - mozsystemmonitor == 0.3 10:20:02 INFO - moztest == 0.7 10:20:02 INFO - mozversion == 1.4 10:20:02 INFO - psutil == 3.1.1 10:20:02 INFO - requests == 1.2.3 10:20:02 INFO - wsgiref == 0.1.2 10:20:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:02 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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:20:02 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 10:20:02 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 10:20:02 INFO - Using env: {'DISPLAY': ':0', 10:20:02 INFO - 'HOME': '/home/cltbld', 10:20:02 INFO - 'LANG': 'en_US.UTF-8', 10:20:02 INFO - 'LANGUAGE': 'en_US:en', 10:20:02 INFO - 'LOGNAME': 'cltbld', 10:20:02 INFO - 'MAIL': '/var/mail/cltbld', 10:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:02 INFO - 'MOZ_NO_REMOTE': '1', 10:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:02 INFO - 'NO_EM_RESTART': '1', 10:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:02 INFO - 'PWD': '/builds/slave/test', 10:20:02 INFO - 'SHELL': '/bin/bash', 10:20:02 INFO - 'SHLVL': '1', 10:20:02 INFO - 'TERM': 'linux', 10:20:02 INFO - 'TMOUT': '86400', 10:20:02 INFO - 'USER': 'cltbld', 10:20:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:02 INFO - '_': '/tools/buildbot/bin/python'} 10:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20:02 INFO - Cleaning up... 10:20:02 INFO - Return code: 0 10:20:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fdade4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a47850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, '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': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', '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 10:20: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 10:20: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 10:20:02 INFO - Using env: {'DISPLAY': ':0', 10:20:02 INFO - 'HOME': '/home/cltbld', 10:20:02 INFO - 'LANG': 'en_US.UTF-8', 10:20:02 INFO - 'LANGUAGE': 'en_US:en', 10:20:02 INFO - 'LOGNAME': 'cltbld', 10:20:02 INFO - 'MAIL': '/var/mail/cltbld', 10:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:02 INFO - 'MOZ_NO_REMOTE': '1', 10:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:02 INFO - 'NO_EM_RESTART': '1', 10:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:02 INFO - 'PWD': '/builds/slave/test', 10:20:02 INFO - 'SHELL': '/bin/bash', 10:20:02 INFO - 'SHLVL': '1', 10:20:02 INFO - 'TERM': 'linux', 10:20:02 INFO - 'TMOUT': '86400', 10:20:02 INFO - 'USER': 'cltbld', 10:20:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:02 INFO - '_': '/tools/buildbot/bin/python'} 10:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:02 INFO - Cleaning up... 10:20:02 INFO - Return code: 0 10:20:02 INFO - Running post-action listener: _resource_record_post_action 10:20:02 INFO - Running post-action listener: _start_resource_monitoring 10:20:02 INFO - Starting resource monitoring. 10:20:02 INFO - [mozharness: 2016-08-26 17:20:02.500219Z] Finished create-virtualenv step (success) 10:20:02 INFO - [mozharness: 2016-08-26 17:20:02.500685Z] Running install step. 10:20:02 INFO - Running pre-action listener: _resource_record_pre_action 10:20:02 INFO - Running main action method: install 10:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:02 INFO - Reading from file tmpfile_stdout 10:20:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:02 INFO - Reading from file tmpfile_stdout 10:20:02 INFO - Output received: 10:20:02 INFO - Usage: mozinstall [options] installer 10:20:02 INFO - Options: 10:20:02 INFO - -h, --help show this help message and exit 10:20:02 INFO - -d DEST, --destination=DEST 10:20:02 INFO - Directory to install application into. [default: 10:20:02 INFO - "/builds/slave/test"] 10:20:02 INFO - --app=APP Application being installed. [default: firefox] 10:20:02 INFO - mkdir: /builds/slave/test/build/application 10:20: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'] 10:20: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 10:20:19 INFO - Reading from file tmpfile_stdout 10:20:19 INFO - Output received: 10:20:19 INFO - /builds/slave/test/build/application/firefox/firefox 10:20:19 INFO - Running post-action listener: _resource_record_post_action 10:20:19 INFO - [mozharness: 2016-08-26 17:20:19.794216Z] Finished install step (success) 10:20:19 INFO - [mozharness: 2016-08-26 17:20:19.794474Z] Running run-tests step. 10:20:19 INFO - Running pre-action listener: _resource_record_pre_action 10:20:19 INFO - Running main action method: run_tests 10:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:19 INFO - Python 2.7.3 10:20:19 INFO - Return code: 0 10:20:19 INFO - grabbing minidump binary from tooltool 10:20: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')]} 10:20: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 0x1a42370>, '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 0x1a458f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20: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 10:20: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 10:20: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 10:20:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:19 INFO - Return code: 0 10:20:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:20:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:20:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 10:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 10:20:19 INFO - Using env: {'DISPLAY': ':0', 10:20:19 INFO - 'HOME': '/home/cltbld', 10:20:19 INFO - 'LANG': 'en_US.UTF-8', 10:20:19 INFO - 'LANGUAGE': 'en_US:en', 10:20:19 INFO - 'LOGNAME': 'cltbld', 10:20:19 INFO - 'MAIL': '/var/mail/cltbld', 10:20:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:19 INFO - 'MOZ_NO_REMOTE': '1', 10:20:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:19 INFO - 'NO_EM_RESTART': '1', 10:20:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:19 INFO - 'PWD': '/builds/slave/test', 10:20:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:19 INFO - 'SHELL': '/bin/bash', 10:20:19 INFO - 'SHLVL': '1', 10:20:19 INFO - 'TERM': 'linux', 10:20:19 INFO - 'TMOUT': '86400', 10:20:19 INFO - 'USER': 'cltbld', 10:20:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472229800.769056-545769750', 10:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:19 INFO - '_': '/tools/buildbot/bin/python'} 10:20:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 10:20:20 INFO - mozversion application_buildid: 20160826073014 10:20:20 INFO - mozversion application_changeset: a65b35c8e5b17c2585968974aef1da67a8c56642 10:20:20 INFO - mozversion application_display_name: Nightly 10:20:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:20 INFO - mozversion application_name: Firefox 10:20:20 INFO - mozversion application_remotingname: firefox 10:20:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:20:20 INFO - mozversion application_vendor: Mozilla 10:20:20 INFO - mozversion application_version: 51.0a1 10:20:20 INFO - mozversion platform_buildid: 20160826073014 10:20:20 INFO - mozversion platform_changeset: a65b35c8e5b17c2585968974aef1da67a8c56642 10:20:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:20:20 INFO - mozversion platform_version: 51.0a1 10:20:20 INFO - using testdate: 1472232020 10:20:20 INFO - actual date: 1472232020 10:20:20 INFO - starting webserver on 'localhost:34165' 10:20:20 INFO - SUITE-START | Running 2 tests 10:20:20 INFO - TEST-START | dromaeo_css 10:20:20 INFO - operating with platform_type : linux_ 10:20:20 INFO - Initialising browser for dromaeo_css test... 10:20:20 INFO - TEST-INFO | started process 5842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKKHNk6/profile http://localhost:34165/getInfo.html) 10:20:25 INFO - PROCESS | 5842 | __metrics Screen width/height:1600/1200 10:20:25 INFO - PROCESS | 5842 | colorDepth:24 10:20:25 INFO - PROCESS | 5842 | Browser inner width/height: 1024/697 10:20:25 INFO - PROCESS | 5842 | __metrics 10:20:26 INFO - PROCESS | 5842 | 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" 10:20:26 INFO - PROCESS | 5842 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:26 INFO - PROCESS | 5842 | console.error: PushService: 10:20:26 INFO - PROCESS | 5842 | stateChangeProcessEnqueue: Error transitioning state 10:20:26 INFO - PROCESS | 5842 | UnknownError 10:20:27 INFO - TEST-INFO | 5842: exit 0 10:20:27 INFO - Browser initialized. 10:20:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:27 INFO - TEST-INFO | started process 5925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKKHNk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:39 INFO - PROCESS | 5925 | RSS: Main: 179302400 10:20:39 INFO - PROCESS | 5925 | 10:21:30 INFO - PROCESS | 5925 | 1472232090797 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] 10:23:40 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34165/tests/dromaeo/cssquery-ext.html) 10:23:41 INFO - PROCESS | 5925 | RSS: Main: 290693120 10:23:41 INFO - PROCESS | 5925 | 10:26:43 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-ext.html (next: http://localhost:34165/tests/dromaeo/cssquery-jquery.html) 10:26:44 INFO - PROCESS | 5925 | RSS: Main: 280014848 10:26:44 INFO - PROCESS | 5925 | 10:29:46 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34165/tests/dromaeo/cssquery-mootools.html) 10:29:46 INFO - PROCESS | 5925 | RSS: Main: 214855680 10:29:46 INFO - PROCESS | 5925 | 10:32:48 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34165/tests/dromaeo/cssquery-prototype.html) 10:32:49 INFO - PROCESS | 5925 | RSS: Main: 214011904 10:32:49 INFO - PROCESS | 5925 | 10:35:52 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34165/tests/dromaeo/cssquery-yui.html) 10:35:52 INFO - PROCESS | 5925 | RSS: Main: 217997312 10:35:52 INFO - PROCESS | 5925 | 10:38:55 INFO - PROCESS | 5925 | Cycle 1(1): loaded http://localhost:34165/tests/dromaeo/cssquery-yui.html (next: http://localhost:34165/tests/dromaeo/cssquery-dojo.html) 10:38:56 INFO - PROCESS | 5925 | RSS: Main: 314916864 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | __start_tp_report 10:38:56 INFO - PROCESS | 5925 | _x_x_mozilla_page_load 10:38:56 INFO - PROCESS | 5925 | _x_x_mozilla_page_load_details 10:38:56 INFO - PROCESS | 5925 | |i|pagename|runs| 10:38:56 INFO - PROCESS | 5925 | |0;dojo.html;2943.8675259613315;2973.7620990320775;2978.1661134882233;3021.1540768584805;3034.984825075874;5051.898962020758;5116.437191908892;5117.846464606058;5178.689278643279;5194.844154675361;5192.221166824978;5215.243789650498;5225.843224703255;5276.577873770098;5306.70813105279;4698.788554515055;4722.881927951795;4756.66703330767;4790.5448982346625;4822.6624136310475;4729.527047295277;4798.088363210979;4959.132151873426;4963.404391473028;4968.378952630921;4870.246711183971;4903.411590609132;4904.092742842586;4911;4919.385076865392;4589.036302376505;4698.130845793539;4734.029523947617;4756.5243475652505;4758.333833263346;4666.416697912761;4709.929351059737;4718.4809670936165;4731.550502702238;4763.880902977418;5065.645404821664;5141.203113517374;5157.742112894378;5235.188545775411;5240.7379631018675;5487.368952570466;5492.286002819608;5495.120780675113;5497.285352904137;5506.705924107831;5518.751656175482;5519.116941289374;5522.0336441122645;5522.5581953443625;5538.6399884007415;5066.670666406671;5156.226566015128;5162.148245539482;5185.0926087934085;5225.843224703265;5643.492085712305;5729.255196824386;5734.942650573441;5777.335606405233;5791.5656325775735;5492.066348720727;5492.862678433071;5493.2034854946605;5497.560195184456;5500.28496295479;5378.139497680352;5488.91766623501;5570.5265052470995;5571.164325351229;5578.107502799614;5507.807226747044;5576.860578485489;5631.549476041907;5636.126400407943;5645.717714114277;5558.499735023867;5558.916616250679;5561.138023606267;5564.610477266552;5565.276514053228;4331.436913201327;4337;4344.066025804467;4387.2103021455805;4388.780560971939;3757.4176002719078;3774.981125094357;3806.0104372863257;3810.923781524354;3824.0822202671716;5201.5838732901275;5239.1355426354985;5239.318888544541;5241.659292145999;5308.416074231832;5419.295491586147;5534.4742249486235;5541.473560011793;5548.72256387179;5549.334079910356;5232.633715639945;5279.260903473517;5283.471652834763;5285.392179899284;5360.463953604608;4809.615230781529;4822.348982887335;4825.4933232010835;4826.493218212107;4881.414230292387;5563.7774489019985;5767.971160144172;5780.826575202835;5781.595288329777;5782.826515204551;5374.704391258519;5453.209284653783;5462.699551524545;5495.560355171657;5564.38791732901;5626.85932851682;5649.7740090397565;5651.208830763614;5653.745581448762;5655.519280861173;5281.287026251407;5469.617126801086;5472.972635136799;5498.642588231752;5506.476884695948;5489.313835770528;5528.281323427928;5539.473749993744;5567.55459563242;5634.492895639248;5372.221027950847;5402.945970540244;5417;5422.05114105038;5423.213634023124;5265.999460102568;5424.430434804289;5442.891142177214;5452.610429783392;5508.118701007819;5218.373795144607;5235.842924712265;5268.76290566933;5288.735563221747;5352.705601191816;5364.275822763877;5368.543673787772;5376.059189641719;5378.031954248273;5383.569314454756;5256.894862102813;5263.289455923555;5266.710330931835;5274;5325.786968521215 10:38:56 INFO - PROCESS | 5925 | |1;ext.html;586.8239528141559;598.1565991951347;608.878224355129;613.8005148326795;635.6503922842437;32329.67670323296;35414.82292588533;35417;35605.109872253175;46206.76896615512;45954.7702261489;46443.53556464434;46505.53494465054;46508.76745616267;46522.30216546755;8857.867131993025;9009;9014.36899417041;9016.053314401992;9018.278537717;7871.921280787176;8768.34237432192;8781.077986811388;8815.647374105029;10472.947635261813;10456.268061235716;10845.349279043243;10850.077743391781;10858.23992320538;10894.891051089468;10769.407682577455;10807.891921080767;10817.78364432707;10828.620998265023;10829.025387715104;10508;10572.418516981563;10574.365538067663;10575.418351990638;10583.259171857973;42666.14667706629;43142.352864707056;43191.78404107991;43222.56777432217;43290.783546082384;3362.5723728350367;3365.225998020469;3466.2201004773974;3522.2603253316834;3618.185908170667;32173;32580.674193258237;32751.18122046944;32761;32866;4351.412559304485;4438.178936896652;4458.7324760514475;4462.955370446319;4636.884077898046;322619;324088;324358;325334;326487;58491;58718.07306013633;58737.41262587405;59125.70437147787;59129;61290.951540573406;61707.38292617106;61730;61763.38236617576;62109.06836397458;16420.096894670667;16654.16729163537;16669.66660666804;16672.249748761336;16691.91654041722;12687.746245075232;12842.229466232056;12842.550510732079;12842.743145137045;12856.871431285754;16146.838531614534;17650;18089;18172.182251798702;18449.907750461163;6542.6401547914365;6775.559588626724;6795.864082718318;6896.413804826546;6994.230634630187;913.2283220678516;924.7503174142944;990.4404011733347;999.0509016434416;1095.5782023920847;30629.540556891665;30726.385472290876;31142.22144446407;31408;31918.840405797822;1005.959761609542;1043.3218408034838;1067.199600299775;1100.312304809494;1127.5546159267044;15678.879310344973;16306.510804675878;16476.176191190632;16477.505674829776;16559;450217;454468;457122;457746;458085;50616;57430.712846436334;58222.12666810001;58222.41777582255;58292.12561811576;1361.8570050144592;1364.8225730654951;1366.6719987203;1366.719822436398;1371.403439503799;30600;33010.66989330076;33192.1701957453;33256.667433325354;33831;51633.48366516437;51761.15313657785;52052.47947520476;52062.219066713275;52138.47861521488;437873;451689;460055;464878;659729;28146.577801332587;28224.71775282221;28534.857325713238;28565;28983.420331593672;47835.521644783104;48185.277220842414;48270.75864620795;48738.5126148734;49718.50281497283;39312.840852751615;42160.36759448549;42234.7888260569;42572.889797657124;43029.56970430256;38579.61420385873;39676.40485392664;41492.79253603713;43358.34962475502;45420.772896135306;40669.389959150045;40812.59187408206;41863.58136418597;42087;42138;34485.310293794486;37022.44466332953;37228.6277137236;37483.43774843434;37731.81134094312;27665.72334276712;27948.44103117967;27973.300667483476;28070.71929280681;28165 10:38:56 INFO - PROCESS | 5925 | |2;jquery.html;378.507939678418;384.2564637426579;389.8109416932789;390.6815945004821;404.43783141433414;16678.166091695413;18820.99999999998;18899.24403023881;19154.138063787144;19759.5060123497;18810;19057.52356191096;19342.51643708908;19528.804711952875;19617.11722972466;5501.972490137544;5507.311586051734;5733.283339582552;5746.051901436258;5749.511291540224;5660.29246344207;5671.517920976701;5698.914516282259;5728.914066289009;5729.856753581173;5458.344998600173;5595.888082238353;5626.718664066801;5714.57140714446;5716.1711551824965;5659.773609055633;5691.658500489963;5696.77212911483;5700.429957004329;5708.514776244025;4898.289747986558;5093.745312734349;5102.209157580581;5128.102582048126;5129.512696293846;19504.609907801907;19513.121909514106;20659.483512912146;23049.19327823535;23217.53564928709;2326.581215381231;2330.417395651087;2443.9389015274583;2558.731333210005;2897.9275518112004;13854;14023.29883505831;14804.629884252872;14827;14875.107493550422;1918.8177123173277;1961.0880940362658;1974.3780709076595;1986.1856638778177;2007.979920200794;62979.36577758235;81302;83389.58305208434;83525.58237208836;84228;9915.256355773347;10036.949815250877;10210.795784084277;10719.410432426135;11124.555017799197;14147.575572732834;14166.504172354124;14190.85809141916;14198.929005354907;14202.289885505683;7759.92240077592;7978.521288722695;8032.638531266107;8270.627821748036;8281.254687078072;7806.3364614007305;7855.8821617675785;7857.489263197874;8086.433949623588;8097.35221182304;6202.658853763086;6304.401081897213;6328.208973878265;6444.484441244689;6561.0814485972005;1804.909754512269;1815.963680726378;1819.2995696656617;1852.4905650945827;1863.3292014874635;906.3112034853559;919.7286800393766;954.4654993203828;963.3786207896007;1013.0932815130417;18139.637207255782;19813.60372792536;19966.50083747889;20081.497962551053;20086.69869951952;962.7833737409167;977.4868194198103;979.314479864098;989.7822479054596;991.8462638291077;10939.398333091756;11364.886351136549;11583.942080289713;11610.535578576762;11621.418929053514;452362;464557;466848;467235;468472;79948.6002569995;81070.4462670662;81314;82691;82763;1030.1655658916302;1032.8244198486275;1041.1618646989245;1055;1059.210887888528;16579.430188320828;16646.250918708443;16954;17444.651106977537;18142.45572632823;41361;41406.792966036184;41695;42027.15945681131;42112.3683144747;52468;52702.209466858796;53712;55650;55693.72153139208;7378.704851806082;7396.889046664197;7518.8496230074;7927.3261772747655;8310.127436619068;11566.380706701237;12734.235945843278;12832.615021549369;13015.154014988995;13281.406231252311;10898.564057437614;11066.612668556561;11260.605878794202;11358.09135269193;11513;11407.942960285145;11465.885341146482;11535.423228838692;11683.649490515298;11703.473343699725;11298.322100673986;11306.265092769272;11548.48031838586;11697.415129243334;11884.82172767392;7416.367189647597;7622.31399174077;7700.152983171959;7766.922330776846;7771.184025677222;9706.417614943126;10766.354018758899;10857.782844342912;10943.124550036136;11290 10:38:56 INFO - PROCESS | 5925 | |3;mootools.html;1329.9335033248335;1432.5702289313206;1441.7549016667165;1561.3208254409333;1736.800267969184;7960.442769006165;8266.38002149839;8277.710280140189;8594.828103437943;8604.612792424341;8392;8485.830283394329;8485.872711909326;8507.191816777411;8511.27654149398;1971.2312198242696;2203.680466332381;2288.8168946484243;2311.8034967027825;2322.7677232276806;2218.944526386837;2241.361212054565;2241.428435748882;2250.1449449209276;2253.1325439705665;2249.730032396115;2262.8529145605567;2268.9432764180947;2277.36233854521;2288.2906299047268;2117.565898990719;2182.2689399051337;2184.2573525001417;2223.144089525528;2230.4423894026495;2284.3717977556307;2289.1186893046297;2298.770122987705;2303.0787684925995;2303.170858490942;8216.753497395088;8308.335333173332;8359.958200209021;8368;8370.748877533684;4992.550670439641;5092.185250359925;5094.4650811664615;5106.05537975472;5108.872278193037;3025.0622307084873;3133.5143052826847;3207.1180425382972;3222.2105584132037;3233.030090972699;1039.5129795543291;1077.983830242547;1118.9160812939062;1123.1969142063465;1139.93730344831;11476.885231147666;11480.540778368939;11519.654410367702;11606.535738570446;11609.07127429812;4076.510818701775;4190.748555086705;4298.356510745932;4316.913661726748;4401.955980440219;9124.315676324302;9152.267818574499;9163.221126204215;9165.90834091664;9172.082791720908;5046.722430266371;5051.570616497639;5054.014467178865;5054.823081192214;5061.392632884003;4165.083681590046;4695.084458530554;4746.477887432379;4786.856394308176;4796.040791841646;3571.4107172316794;3610.097475631092;3713.721470889694;3726.2920045191327;3734.682551983112;1062.0388548363744;1065.5577935156823;1073.270176280137;1076.6985244131656;1096.2545469081101;830.3357314148657;899.3210126354692;910.4264313482464;927.4064598656865;939.9483028433365;5532.197831314517;5574.888502229933;5671.347795003545;5703.572232082611;5746.9425305747245;936.2042264075482;944.4427787605346;957.3107362698846;963.7301555564453;1027.5427434791595;3718.6839118674675;3826.081740382288;3876.7673939563715;3908.55051669056;3947;10203.642872499428;10485.895141048644;10534.420606866695;10550.841737373945;10564.102051325723;10362.378257304586;10451.581936722447;10456.058954694114;10469.476526173661;10526.842097368546;7385.556866587915;7573.962130189424;7623.656935437919;7626.885596716053;7656.310932016146;5664.915026274527;5783.508401785727;5817.243758311392;5839.0949402842625;5935.762569497172;9209.631614735335;9443.504221020701;9498.19265362452;9517.619295228113;9650.131488165818;9581.568829402833;9636.180924621485;9729.124378805658;9921.900780992097;9924.702258932244;6352.269489008639;7369.447291453055;7486.401087912845;7504.699812007677;7856.09654889695;7855.33229675484;8094.797630059295;8101.513909165234;8134.715284965235;8183.345332373515;7249.891251631335;7316.853662926818;7318.377937875127;7415.666295016845;7434.107907051189;7073.186583542958;7163;7253.492255542273;7337.889931650922;7464.962675186589;6479.287278399466;6490.156279683611;6531.248906375828;6532.248791389051;6536.117624120873;4990.950090499194;5000.949990500048;5061.114304996685;5064.316317297118;5123.666961647481;5005.774740136775;5009.559087107187;5093.490650934877;5159.071367153798;5180.222966555047 10:38:56 INFO - PROCESS | 5925 | |4;prototype.html;322.2732737676539;327.45805691580426;331.3257520944877;343.81262212094407;345.24736075355713;5222.582193424527;5252.686828292927;5281.33983252093;5286.603504737141;5300.257963885055;5171.534561889429;5183.870403239921;5185.766640501177;5223.895522089556;5229.764660590273;4037.7375470594466;4119.794010299488;4149.128682976579;4151.588459923625;4181.540030596632;4094.5464360152164;4130.628243458088;4162.500499939996;4164.625183733463;4173.332266837307;4074.3073677474754;4079.2657321682086;4092.1994322498003;4096.446979657752;4099.713020088595;3861.706328379996;3915.4126880968083;4029.5567487576345;4128.876133715993;4134.627883490471;3538.044727923472;3553.289342131584;3564.8395822188063;3566.982165089158;3582.659647333499;5037.798488060474;5049.34358533392;5050.444451110375;5071.974640126813;5091.643584949055;4287.635550978171;4373.2565463871215;4644.442666879996;4663.696859704109;4670.579647831712;5363.329583802025;5380.986647477425;5385.892282154335;5386.003589335985;5423.972880135613;4056.4118202860714;4066.8576599818866;4067.145899361108;4069.511658600957;4075.205334959684;5523.585731070186;5588.552915766729;5610.523105536035;5629.240052592889;5667.8583035424035;4144.41978123063;4154.459920210354;4165.97917010419;4189.392538082022;4195.895102622459;4231.851885184004;4237.788110594458;4240.745555266694;4242.257604919127;4250.702450828412;4531.501534831166;4637.489876113625;4675.95324046762;4756.405449318835;4781.139394908881;5436.673799572039;5441.292631957899;5445.591580631469;5462.453754624506;5465.6447330923365;1442.6898216883421;1462.9561113166621;1464.2898194375719;1468.6548661064642;1468.9192094434695;907.4509921497399;952.476138124029;956.9952150239344;959.4339339789418;967.4775621164492;4676.602488788491;4690.437147542249;4693.342931989524;4701.459332176775;4723.126221649006;4892.608591312757;4911.50884911506;4913.828016019494;4914.631402644816;4949.802007919643;4701.929471057937;4716.6698331116495;4742.33607294979;4779.784909679072;4931.235658472942;2820.8166469179846;2902.506573882445;2922.3716900866416;2949.395373948378;2953.0804976765276;5709.9714501427225;5719.914201286984;5723.513501352349;5760;5767.961766882002;5559.944400555943;5688.573356998241;5714.285714285715;5760.8396851180805;5793.392973162094;5774.797882074107;5774.94225057744;5792.842900619257;5793.131030345397;5794.594378393472;5529.668219906818;5566.860828479321;5569.888602228014;5609.551235901036;5644.774209031592;5294.841154765363;5402.135658294654;5468.234447177478;5476.972615136899;5492.47821456961;5687.971560142173;5694.772209111755;5715.39988301239;5717.17101020358;5720.599558031065;4011.4383986241364;4055.8174882129783;4057.9652188691693;4060.3503439449546;4072.2873497138476;5392.9483750669815;5468.863278418072;5493.533049690661;5503.642263253036;5533.861653458695;5326.055989563703;5328.600354973315;5366.946330536644;5381.8923621526565;5414.485623865727;5193.636445448782;5249.396319423163;5291.232771248225;5349.518543331119;5376.919346209888;5298.867528311823;5342.679439233659;5355;5364.141737322166;5374.355077390738;5403.432639572946;5426.918596221139;5437.728113594226;5452.263944367618;5455.918161227664;5132.948670513247;5296.443873393238;5306.708131052829;5308.25684404176;5324.866878328073 10:38:56 INFO - PROCESS | 5925 | |5;yui.html;725.1226016520011;728.8943103250028;740.3078121955972;750.54591971857;804.9597520123995;14072;14696.191709455976;14775.335109920052;14857.554273371803;14882.851171488282;13133.343332833369;13221.405036773343;13551.525696600622;13590;13639.249841258727;802.4663598706853;815.384384789486;818.8607936650784;819.0253598218102;819.2831272636444;662.2053535757111;785.0696924144878;802.6829402386054;810.3962547901792;821.1993306526119;863.3309185381316;865.5845194306737;865.8874346334968;866.384866744612;866.540733411293;864.2092485375873;864.779481232288;864.9913500864974;865.35098675993;865.6321063547967;513.0559770023139;599.403593424541;617.3332800575367;620.6307247187916;627.4854619212248;12793.48826046957;12839;12860.807087893689;12958.287294198815;13127.606171814861;13310.534131305454;13903.721925561433;14032.228227447486;14101.64745881351;14173.433062677585;12653.936730316289;12660;12763.5532756354;12995.740085198244;13085.869141308656;4333.2200203963275;4364.519902810688;4475.753833539154;4567.703099298568;4569.840055598072;77275;78746;78911;78979.60510197413;79058.60470697668;11352.318860868209;11721.706957326134;11843.23019003762;11995.520179192908;12053;21647.783522164893;21654.89172554127;21688.674669879965;21692.783072169077;21693;8429.536375499407;8485.151484851465;8486.787830304169;8580.656773729106;8632.525211113449;4290.656747460258;4575.039241759201;4658.464276608233;4713.457952335525;4713.95286047142;3216;3338.916527086842;3345.0466617014035;3345.130266130775;3347.196672798511;563.8533981164927;576.8442520519436;585.6383907415277;585.8476796033062;595.8510372406898;573.9282589676291;580.6123365157277;684.2165720250285;710.7690000749777;727.8034930568717;8512.872306915402;9031.81936361269;9637.469939153414;9721.513924303756;9921.114988152229;643.5237923936254;649.8407890066964;725.5570533661056;725.9854802903913;730.9963450182821;4201.508464495121;4392.978035109804;4540.750258735801;4545.36364908913;4558.635309175258;120531;121656.39171804085;123015;123530.38234808948;124785.37607311906;101900.49049754704;103624;104234.47882760537;105461.47269263757;107284.46357768161;58417.41582584205;77112.10762331838;89875.55062224779;90762.91566879506;99260.50369748105;10007.249456290952;10389.37663740178;10393.960603939848;10474.371537707762;10563.683089507327;53265.46734532605;53760.73119634377;54042.18936715874;54495.72752136214;56612.43387566072;71798;72239.27760722536;80821.59589202017;82113.58943205245;82127;13466.79799802984;13743.656408589864;13950.162990220213;13965.930170349084;14357.282135893372;14755.852441475448;14821.92589037048;14880.479183228535;15254;15496.225188740744;13077.738445231233;13500.5274815381;13857.653558661113;14259.572212833631;14800.703985920436;14079.859201407855;14200.928995354958;14311.355988980313;14430.783538247144;14459.855401446272;13558.457661693421;13580;13725.176489410667;13840.93079534596;13889.583312500641;11258.493367798304;11455.59905403307;11914.285142891455;11952.103592230791;12527.498900043896;11383.601573944872;11475.311481311148;11629.88370116288;11775.904947495019;11933.76132477363 10:38:56 INFO - PROCESS | 5925 | __end_tp_report 10:38:56 INFO - PROCESS | 5925 | __start_cc_report 10:38:56 INFO - PROCESS | 5925 | _x_x_mozilla_cycle_collect,934 10:38:56 INFO - PROCESS | 5925 | __end_cc_report 10:38:56 INFO - PROCESS | 5925 | __startTimestamp1472233136085__endTimestamp 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | ------- Summary: start ------- 10:38:56 INFO - PROCESS | 5925 | Number of tests: 6 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#0] dojo.html Cycles:165 Average:5158.50 Median:5306.71 stddev:566.80 (10.7%) stddev-sans-first:541.26 10:38:56 INFO - PROCESS | 5925 | Values: 2943.9 2973.8 2978.2 3021.2 3035.0 5051.9 5116.4 5117.8 5178.7 5194.8 5192.2 5215.2 5225.8 5276.6 5306.7 4698.8 4722.9 4756.7 4790.5 4822.7 4729.5 4798.1 4959.1 4963.4 4968.4 4870.2 4903.4 4904.1 4911.0 4919.4 4589.0 4698.1 4734.0 4756.5 4758.3 4666.4 4709.9 4718.5 4731.6 4763.9 5065.6 5141.2 5157.7 5235.2 5240.7 5487.4 5492.3 5495.1 5497.3 5506.7 5518.8 5519.1 5522.0 5522.6 5538.6 5066.7 5156.2 5162.1 5185.1 5225.8 5643.5 5729.3 5734.9 5777.3 5791.6 5492.1 5492.9 5493.2 5497.6 5500.3 5378.1 5488.9 5570.5 5571.2 5578.1 5507.8 5576.9 5631.5 5636.1 5645.7 5558.5 5558.9 5561.1 5564.6 5565.3 4331.4 4337.0 4344.1 4387.2 4388.8 3757.4 3775.0 3806.0 3810.9 3824.1 5201.6 5239.1 5239.3 5241.7 5308.4 5419.3 5534.5 5541.5 5548.7 5549.3 5232.6 5279.3 5283.5 5285.4 5360.5 4809.6 4822.3 4825.5 4826.5 4881.4 5563.8 5768.0 5780.8 5781.6 5782.8 5374.7 5453.2 5462.7 5495.6 5564.4 5626.9 5649.8 5651.2 5653.7 5655.5 5281.3 5469.6 5473.0 5498.6 5506.5 5489.3 5528.3 5539.5 5567.6 5634.5 5372.2 5402.9 5417.0 5422.1 5423.2 5266.0 5424.4 5442.9 5452.6 5508.1 5218.4 5235.8 5268.8 5288.7 5352.7 5364.3 5368.5 5376.1 5378.0 5383.6 5256.9 5263.3 5266.7 5274.0 5325.8 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#1] ext.html Cycles:180 Average:59061.39 Median:38155.71 stddev:114928.76 (301.2%) stddev-sans-first:115167.31 10:38:56 INFO - PROCESS | 5925 | Values: 586.8 598.2 608.9 613.8 635.7 32329.7 35414.8 35417.0 35605.1 46206.8 45954.8 46443.5 46505.5 46508.8 46522.3 8857.9 9009.0 9014.4 9016.1 9018.3 7871.9 8768.3 8781.1 8815.6 10472.9 10456.3 10845.3 10850.1 10858.2 10894.9 10769.4 10807.9 10817.8 10828.6 10829.0 10508.0 10572.4 10574.4 10575.4 10583.3 42666.1 43142.4 43191.8 43222.6 43290.8 3362.6 3365.2 3466.2 3522.3 3618.2 32173.0 32580.7 32751.2 32761.0 32866.0 4351.4 4438.2 4458.7 4463.0 4636.9 322619.0 324088.0 324358.0 325334.0 326487.0 58491.0 58718.1 58737.4 59125.7 59129.0 61291.0 61707.4 61730.0 61763.4 62109.1 16420.1 16654.2 16669.7 16672.2 16691.9 12687.7 12842.2 12842.6 12842.7 12856.9 16146.8 17650.0 18089.0 18172.2 18449.9 6542.6 6775.6 6795.9 6896.4 6994.2 913.2 924.8 990.4 999.1 1095.6 30629.5 30726.4 31142.2 31408.0 31918.8 1006.0 1043.3 1067.2 1100.3 1127.6 15678.9 16306.5 16476.2 16477.5 16559.0 450217.0 454468.0 457122.0 457746.0 458085.0 50616.0 57430.7 58222.1 58222.4 58292.1 1361.9 1364.8 1366.7 1366.7 1371.4 30600.0 33010.7 33192.2 33256.7 33831.0 51633.5 51761.2 52052.5 52062.2 52138.5 437873.0 451689.0 460055.0 464878.0 659729.0 28146.6 28224.7 28534.9 28565.0 28983.4 47835.5 48185.3 48270.8 48738.5 49718.5 39312.8 42160.4 42234.8 42572.9 43029.6 38579.6 39676.4 41492.8 43358.3 45420.8 40669.4 40812.6 41863.6 42087.0 42138.0 34485.3 37022.4 37228.6 37483.4 37731.8 27665.7 27948.4 27973.3 28070.7 28165.0 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#2] jquery.html Cycles:180 Average:27765.17 Median:387.03 stddev:76360.37 (19729.6%) stddev-sans-first:76546.89 10:38:56 INFO - PROCESS | 5925 | Values: 378.5 384.3 389.8 390.7 404.4 16678.2 18821.0 18899.2 19154.1 19759.5 18810.0 19057.5 19342.5 19528.8 19617.1 5502.0 5507.3 5733.3 5746.1 5749.5 5660.3 5671.5 5698.9 5728.9 5729.9 5458.3 5595.9 5626.7 5714.6 5716.2 5659.8 5691.7 5696.8 5700.4 5708.5 4898.3 5093.7 5102.2 5128.1 5129.5 19504.6 19513.1 20659.5 23049.2 23217.5 2326.6 2330.4 2443.9 2558.7 2897.9 13854.0 14023.3 14804.6 14827.0 14875.1 1918.8 1961.1 1974.4 1986.2 2008.0 62979.4 81302.0 83389.6 83525.6 84228.0 9915.3 10036.9 10210.8 10719.4 11124.6 14147.6 14166.5 14190.9 14198.9 14202.3 7759.9 7978.5 8032.6 8270.6 8281.3 7806.3 7855.9 7857.5 8086.4 8097.4 6202.7 6304.4 6328.2 6444.5 6561.1 1804.9 1816.0 1819.3 1852.5 1863.3 906.3 919.7 954.5 963.4 1013.1 18139.6 19813.6 19966.5 20081.5 20086.7 962.8 977.5 979.3 989.8 991.8 10939.4 11364.9 11583.9 11610.5 11621.4 452362.0 464557.0 466848.0 467235.0 468472.0 79948.6 81070.4 81314.0 82691.0 82763.0 1030.2 1032.8 1041.2 1055.0 1059.2 16579.4 16646.3 16954.0 17444.7 18142.5 41361.0 41406.8 41695.0 42027.2 42112.4 52468.0 52702.2 53712.0 55650.0 55693.7 7378.7 7396.9 7518.8 7927.3 8310.1 11566.4 12734.2 12832.6 13015.2 13281.4 10898.6 11066.6 11260.6 11358.1 11513.0 11407.9 11465.9 11535.4 11683.6 11703.5 11298.3 11306.3 11548.5 11697.4 11884.8 7416.4 7622.3 7700.2 7766.9 7771.2 9706.4 10766.4 10857.8 10943.1 11290.0 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#3] mootools.html Cycles:180 Average:5503.49 Median:5061.25 stddev:3102.03 (61.3%) stddev-sans-first:3094.88 10:38:56 INFO - PROCESS | 5925 | Values: 1329.9 1432.6 1441.8 1561.3 1736.8 7960.4 8266.4 8277.7 8594.8 8604.6 8392.0 8485.8 8485.9 8507.2 8511.3 1971.2 2203.7 2288.8 2311.8 2322.8 2218.9 2241.4 2241.4 2250.1 2253.1 2249.7 2262.9 2268.9 2277.4 2288.3 2117.6 2182.3 2184.3 2223.1 2230.4 2284.4 2289.1 2298.8 2303.1 2303.2 8216.8 8308.3 8360.0 8368.0 8370.7 4992.6 5092.2 5094.5 5106.1 5108.9 3025.1 3133.5 3207.1 3222.2 3233.0 1039.5 1078.0 1118.9 1123.2 1139.9 11476.9 11480.5 11519.7 11606.5 11609.1 4076.5 4190.7 4298.4 4316.9 4402.0 9124.3 9152.3 9163.2 9165.9 9172.1 5046.7 5051.6 5054.0 5054.8 5061.4 4165.1 4695.1 4746.5 4786.9 4796.0 3571.4 3610.1 3713.7 3726.3 3734.7 1062.0 1065.6 1073.3 1076.7 1096.3 830.3 899.3 910.4 927.4 939.9 5532.2 5574.9 5671.3 5703.6 5746.9 936.2 944.4 957.3 963.7 1027.5 3718.7 3826.1 3876.8 3908.6 3947.0 10203.6 10485.9 10534.4 10550.8 10564.1 10362.4 10451.6 10456.1 10469.5 10526.8 7385.6 7574.0 7623.7 7626.9 7656.3 5664.9 5783.5 5817.2 5839.1 5935.8 9209.6 9443.5 9498.2 9517.6 9650.1 9581.6 9636.2 9729.1 9921.9 9924.7 6352.3 7369.4 7486.4 7504.7 7856.1 7855.3 8094.8 8101.5 8134.7 8183.3 7249.9 7316.9 7318.4 7415.7 7434.1 7073.2 7163.0 7253.5 7337.9 7465.0 6479.3 6490.2 6531.2 6532.2 6536.1 4991.0 5000.9 5061.1 5064.3 5123.7 5005.8 5009.6 5093.5 5159.1 5180.2 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#4] prototype.html Cycles:180 Average:4550.47 Median:5152.24 stddev:1306.56 (25.4%) stddev-sans-first:1271.10 10:38:56 INFO - PROCESS | 5925 | Values: 322.3 327.5 331.3 343.8 345.2 5222.6 5252.7 5281.3 5286.6 5300.3 5171.5 5183.9 5185.8 5223.9 5229.8 4037.7 4119.8 4149.1 4151.6 4181.5 4094.5 4130.6 4162.5 4164.6 4173.3 4074.3 4079.3 4092.2 4096.4 4099.7 3861.7 3915.4 4029.6 4128.9 4134.6 3538.0 3553.3 3564.8 3567.0 3582.7 5037.8 5049.3 5050.4 5072.0 5091.6 4287.6 4373.3 4644.4 4663.7 4670.6 5363.3 5381.0 5385.9 5386.0 5424.0 4056.4 4066.9 4067.1 4069.5 4075.2 5523.6 5588.6 5610.5 5629.2 5667.9 4144.4 4154.5 4166.0 4189.4 4195.9 4231.9 4237.8 4240.7 4242.3 4250.7 4531.5 4637.5 4676.0 4756.4 4781.1 5436.7 5441.3 5445.6 5462.5 5465.6 1442.7 1463.0 1464.3 1468.7 1468.9 907.5 952.5 957.0 959.4 967.5 4676.6 4690.4 4693.3 4701.5 4723.1 4892.6 4911.5 4913.8 4914.6 4949.8 4701.9 4716.7 4742.3 4779.8 4931.2 2820.8 2902.5 2922.4 2949.4 2953.1 5710.0 5719.9 5723.5 5760.0 5768.0 5559.9 5688.6 5714.3 5760.8 5793.4 5774.8 5774.9 5792.8 5793.1 5794.6 5529.7 5566.9 5569.9 5609.6 5644.8 5294.8 5402.1 5468.2 5477.0 5492.5 5688.0 5694.8 5715.4 5717.2 5720.6 4011.4 4055.8 4058.0 4060.4 4072.3 5392.9 5468.9 5493.5 5503.6 5533.9 5326.1 5328.6 5366.9 5381.9 5414.5 5193.6 5249.4 5291.2 5349.5 5376.9 5298.9 5342.7 5355.0 5364.1 5374.4 5403.4 5426.9 5437.7 5452.3 5455.9 5132.9 5296.4 5306.7 5308.3 5324.9 10:38:56 INFO - PROCESS | 5925 | 10:38:56 INFO - PROCESS | 5925 | [#5] yui.html Cycles:180 Average:21342.51 Median:4246.08 stddev:31296.58 (737.1%) stddev-sans-first:31346.09 10:38:56 INFO - PROCESS | 5925 | Values: 725.1 728.9 740.3 750.5 805.0 14072.0 14696.2 14775.3 14857.6 14882.9 13133.3 13221.4 13551.5 13590.0 13639.2 802.5 815.4 818.9 819.0 819.3 662.2 785.1 802.7 810.4 821.2 863.3 865.6 865.9 866.4 866.5 864.2 864.8 865.0 865.4 865.6 513.1 599.4 617.3 620.6 627.5 12793.5 12839.0 12860.8 12958.3 13127.6 13310.5 13903.7 14032.2 14101.6 14173.4 12653.9 12660.0 12763.6 12995.7 13085.9 4333.2 4364.5 4475.8 4567.7 4569.8 77275.0 78746.0 78911.0 78979.6 79058.6 11352.3 11721.7 11843.2 11995.5 12053.0 21647.8 21654.9 21688.7 21692.8 21693.0 8429.5 8485.2 8486.8 8580.7 8632.5 4290.7 4575.0 4658.5 4713.5 4714.0 3216.0 3338.9 3345.0 3345.1 3347.2 563.9 576.8 585.6 585.8 595.9 573.9 580.6 684.2 710.8 727.8 8512.9 9031.8 9637.5 9721.5 9921.1 643.5 649.8 725.6 726.0 731.0 4201.5 4393.0 4540.8 4545.4 4558.6 120531.0 121656.4 123015.0 123530.4 124785.4 101900.5 103624.0 104234.5 105461.5 107284.5 58417.4 77112.1 89875.6 90762.9 99260.5 10007.2 10389.4 10394.0 10474.4 10563.7 53265.5 53760.7 54042.2 54495.7 56612.4 71798.0 72239.3 80821.6 82113.6 82127.0 13466.8 13743.7 13950.2 13965.9 14357.3 14755.9 14821.9 14880.5 15254.0 15496.2 13077.7 13500.5 13857.7 14259.6 14800.7 14079.9 14200.9 14311.4 14430.8 14459.9 13558.5 13580.0 13725.2 13840.9 13889.6 11258.5 11455.6 11914.3 11952.1 12527.5 11383.6 11475.3 11629.9 11775.9 11933.8 10:38:56 INFO - PROCESS | 5925 | -------- Summary: end -------- 10:38:56 INFO - PROCESS | 5925 | 10:38:57 INFO - TEST-INFO | 5925: exit 0 10:38:57 INFO - TEST-OK | dromaeo_css | took 1117024ms 10:38:57 INFO - TEST-START | kraken 10:38:57 INFO - operating with platform_type : linux_ 10:38:57 INFO - Initialising browser for kraken test... 10:38:57 INFO - TEST-INFO | started process 6234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wn9WT/profile http://localhost:34165/getInfo.html) 10:39:01 INFO - PROCESS | 6234 | __metrics Screen width/height:1600/1200 10:39:01 INFO - PROCESS | 6234 | colorDepth:24 10:39:01 INFO - PROCESS | 6234 | Browser inner width/height: 1024/697 10:39:01 INFO - PROCESS | 6234 | __metrics 10:39:02 INFO - PROCESS | 6234 | 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" 10:39:02 INFO - PROCESS | 6234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:03 INFO - PROCESS | 6234 | console.error: PushService: 10:39:03 INFO - PROCESS | 6234 | stateChangeProcessEnqueue: Error transitioning state 10:39:03 INFO - PROCESS | 6234 | UnknownError 10:39:04 INFO - TEST-INFO | 6234: exit 0 10:39:04 INFO - Browser initialized. 10:39:04 INFO - Running cycle 1/1 for kraken test... 10:39:04 INFO - TEST-INFO | started process 6315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wn9WT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:16 INFO - PROCESS | 6315 | RSS: Main: 179740672 10:39:16 INFO - PROCESS | 6315 | 10:39:18 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34165/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:19 INFO - PROCESS | 6315 | RSS: Main: 233410560 10:39:19 INFO - PROCESS | 6315 | 10:39:22 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34165/tests/kraken/driver.html?testName=audio-dft) 10:39:22 INFO - PROCESS | 6315 | RSS: Main: 223219712 10:39:22 INFO - PROCESS | 6315 | 10:39:25 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34165/tests/kraken/driver.html?testName=audio-fft) 10:39:26 INFO - PROCESS | 6315 | RSS: Main: 301658112 10:39:26 INFO - PROCESS | 6315 | 10:39:28 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34165/tests/kraken/driver.html?testName=audio-oscillator) 10:39:29 INFO - PROCESS | 6315 | RSS: Main: 211705856 10:39:29 INFO - PROCESS | 6315 | 10:39:31 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:31 INFO - PROCESS | 6315 | RSS: Main: 213987328 10:39:31 INFO - PROCESS | 6315 | 10:39:34 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34165/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:35 INFO - PROCESS | 6315 | RSS: Main: 252694528 10:39:35 INFO - PROCESS | 6315 | 10:39:38 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34165/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:39 INFO - PROCESS | 6315 | RSS: Main: 251297792 10:39:39 INFO - PROCESS | 6315 | 10:39:42 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34165/tests/kraken/driver.html?testName=json-parse-financial) 10:39:42 INFO - PROCESS | 6315 | RSS: Main: 251289600 10:39:42 INFO - PROCESS | 6315 | 10:39:44 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:44 INFO - PROCESS | 6315 | RSS: Main: 213520384 10:39:44 INFO - PROCESS | 6315 | 10:39:46 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:47 INFO - PROCESS | 6315 | RSS: Main: 220889088 10:39:47 INFO - PROCESS | 6315 | 10:39:49 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:50 INFO - PROCESS | 6315 | RSS: Main: 222089216 10:39:50 INFO - PROCESS | 6315 | 10:39:52 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:53 INFO - PROCESS | 6315 | RSS: Main: 222466048 10:39:53 INFO - PROCESS | 6315 | 10:39:55 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:56 INFO - PROCESS | 6315 | RSS: Main: 220758016 10:39:56 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | Cycle 1(1): loaded http://localhost:34165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34165/tests/kraken/driver.html?testName=ai-astar) 10:39:58 INFO - PROCESS | 6315 | RSS: Main: 272355328 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | __start_tp_report 10:39:58 INFO - PROCESS | 6315 | _x_x_mozilla_page_load 10:39:58 INFO - PROCESS | 6315 | _x_x_mozilla_page_load_details 10:39:58 INFO - PROCESS | 6315 | |i|pagename|runs| 10:39:58 INFO - PROCESS | 6315 | |0;ai-astar;113;112;133;111;117;111;111;110;111;110 10:39:58 INFO - PROCESS | 6315 | |1;audio-beat-detection;151;118;144;183;123;146;154;119;177;119 10:39:58 INFO - PROCESS | 6315 | |2;audio-dft;162;161;161;161;163;162;161;160;161;163 10:39:58 INFO - PROCESS | 6315 | |3;audio-fft;75;74;75;168;77;75;75;75;174;77 10:39:58 INFO - PROCESS | 6315 | |4;audio-oscillator;83;81;145;82;82;83;139;84;83;147 10:39:58 INFO - PROCESS | 6315 | |5;imaging-gaussian-blur;117;118;117;118;117;117;118;118;118;117 10:39:58 INFO - PROCESS | 6315 | |6;imaging-darkroom;146;145;146;145;146;147;146;147;146;146 10:39:58 INFO - PROCESS | 6315 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 10:39:58 INFO - PROCESS | 6315 | |8;json-parse-financial;54;53;53;53;54;54;54;53;53;55 10:39:58 INFO - PROCESS | 6315 | |9;json-stringify-tinderbox;64;73;62;63;62;63;62;63;63;64 10:39:58 INFO - PROCESS | 6315 | |10;stanford-crypto-aes;79;78;80;79;79;78;78;85;78;78 10:39:58 INFO - PROCESS | 6315 | |11;stanford-crypto-ccm;134;135;126;124;131;124;123;122;164;124 10:39:58 INFO - PROCESS | 6315 | |12;stanford-crypto-pbkdf2;162;165;162;159;163;160;159;161;161;160 10:39:58 INFO - PROCESS | 6315 | |13;stanford-crypto-sha256-iterative;67;64;66;65;68;65;70;65;63;65 10:39:58 INFO - PROCESS | 6315 | __end_tp_report 10:39:58 INFO - PROCESS | 6315 | __start_cc_report 10:39:58 INFO - PROCESS | 6315 | _x_x_mozilla_cycle_collect,1722 10:39:58 INFO - PROCESS | 6315 | __end_cc_report 10:39:58 INFO - PROCESS | 6315 | __startTimestamp1472233198409__endTimestamp 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | ------- Summary: start ------- 10:39:58 INFO - PROCESS | 6315 | Number of tests: 14 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#0] ai-astar Cycles:10 Average:113.90 Median:111.50 stddev:7.02 (6.3%) stddev-sans-first:7.43 10:39:58 INFO - PROCESS | 6315 | Values: 113.0 112.0 133.0 111.0 117.0 111.0 111.0 110.0 111.0 110.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:148.50 stddev:23.87 (16.1%) stddev-sans-first:25.16 10:39:58 INFO - PROCESS | 6315 | Values: 151.0 118.0 144.0 183.0 123.0 146.0 154.0 119.0 177.0 119.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 10:39:58 INFO - PROCESS | 6315 | Values: 162.0 161.0 161.0 161.0 163.0 162.0 161.0 160.0 161.0 163.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:40.35 (53.8%) stddev-sans-first:42.18 10:39:58 INFO - PROCESS | 6315 | Values: 75.0 74.0 75.0 168.0 77.0 75.0 75.0 75.0 174.0 77.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:82.50 stddev:29.59 (35.9%) stddev-sans-first:30.67 10:39:58 INFO - PROCESS | 6315 | Values: 83.0 81.0 145.0 82.0 82.0 83.0 139.0 84.0 83.0 147.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:39:58 INFO - PROCESS | 6315 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:39:58 INFO - PROCESS | 6315 | Values: 146.0 145.0 146.0 145.0 146.0 147.0 146.0 147.0 146.0 146.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:39:58 INFO - PROCESS | 6315 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 10:39:58 INFO - PROCESS | 6315 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 54.0 53.0 53.0 55.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:63.00 stddev:3.28 (5.2%) stddev-sans-first:3.48 10:39:58 INFO - PROCESS | 6315 | Values: 64.0 73.0 62.0 63.0 62.0 63.0 62.0 63.0 63.0 64.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.15 (2.7%) stddev-sans-first:2.28 10:39:58 INFO - PROCESS | 6315 | Values: 79.0 78.0 80.0 79.0 79.0 78.0 78.0 85.0 78.0 78.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:128.50 stddev:12.61 (9.8%) stddev-sans-first:13.31 10:39:58 INFO - PROCESS | 6315 | Values: 134.0 135.0 126.0 124.0 131.0 124.0 123.0 122.0 164.0 124.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:1.87 (1.2%) stddev-sans-first:1.96 10:39:58 INFO - PROCESS | 6315 | Values: 162.0 165.0 162.0 159.0 163.0 160.0 159.0 161.0 161.0 160.0 10:39:58 INFO - PROCESS | 6315 | 10:39:58 INFO - PROCESS | 6315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:2.04 (3.1%) stddev-sans-first:2.12 10:39:58 INFO - PROCESS | 6315 | Values: 67.0 64.0 66.0 65.0 68.0 65.0 70.0 65.0 63.0 65.0 10:39:58 INFO - PROCESS | 6315 | -------- Summary: end -------- 10:39:58 INFO - PROCESS | 6315 | 10:39:59 INFO - TEST-INFO | 6315: exit 0 10:39:59 INFO - TEST-OK | kraken | took 62457ms 10:39:59 INFO - SUITE-END | took 1179s 10:39:59 INFO - Completed test suite (00:19:39) 10:39:59 INFO - javascript benchmark 10:39:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2943.8675259613315, 2973.7620990320775, 2978.1661134882233, 3021.1540768584805, 3034.984825075874, 5051.898962020758, 5116.437191908892, 5117.846464606058, 5178.689278643279, 5194.844154675361, 5192.221166824978, 5215.243789650498, 5225.843224703255, 5276.577873770098, 5306.70813105279, 4698.788554515055, 4722.881927951795, 4756.66703330767, 4790.5448982346625, 4822.6624136310475, 4729.527047295277, 4798.088363210979, 4959.132151873426, 4963.404391473028, 4968.378952630921, 4870.246711183971, 4903.411590609132, 4904.092742842586, 4911.0, 4919.385076865392, 4589.036302376505, 4698.130845793539, 4734.029523947617, 4756.5243475652505, 4758.333833263346, 4666.416697912761, 4709.929351059737, 4718.4809670936165, 4731.550502702238, 4763.880902977418, 5065.645404821664, 5141.203113517374, 5157.742112894378, 5235.188545775411, 5240.7379631018675, 5487.368952570466, 5492.286002819608, 5495.120780675113, 5497.285352904137, 5506.705924107831, 5518.751656175482, 5519.116941289374, 5522.0336441122645, 5522.5581953443625, 5538.6399884007415, 5066.670666406671, 5156.226566015128, 5162.148245539482, 5185.0926087934085, 5225.843224703265, 5643.492085712305, 5729.255196824386, 5734.942650573441, 5777.335606405233, 5791.5656325775735, 5492.066348720727, 5492.862678433071, 5493.2034854946605, 5497.560195184456, 5500.28496295479, 5378.139497680352, 5488.91766623501, 5570.5265052470995, 5571.164325351229, 5578.107502799614, 5507.807226747044, 5576.860578485489, 5631.549476041907, 5636.126400407943, 5645.717714114277, 5558.499735023867, 5558.916616250679, 5561.138023606267, 5564.610477266552, 5565.276514053228, 4331.436913201327, 4337.0, 4344.066025804467, 4387.2103021455805, 4388.780560971939, 3757.4176002719078, 3774.981125094357, 3806.0104372863257, 3810.923781524354, 3824.0822202671716, 5201.5838732901275, 5239.1355426354985, 5239.318888544541, 5241.659292145999, 5308.416074231832, 5419.295491586147, 5534.4742249486235, 5541.473560011793, 5548.72256387179, 5549.334079910356, 5232.633715639945, 5279.260903473517, 5283.471652834763, 5285.392179899284, 5360.463953604608, 4809.615230781529, 4822.348982887335, 4825.4933232010835, 4826.493218212107, 4881.414230292387, 5563.7774489019985, 5767.971160144172, 5780.826575202835, 5781.595288329777, 5782.826515204551, 5374.704391258519, 5453.209284653783, 5462.699551524545, 5495.560355171657, 5564.38791732901, 5626.85932851682, 5649.7740090397565, 5651.208830763614, 5653.745581448762, 5655.519280861173, 5281.287026251407, 5469.617126801086, 5472.972635136799, 5498.642588231752, 5506.476884695948, 5489.313835770528, 5528.281323427928, 5539.473749993744, 5567.55459563242, 5634.492895639248, 5372.221027950847, 5402.945970540244, 5417.0, 5422.05114105038, 5423.213634023124, 5265.999460102568, 5424.430434804289, 5442.891142177214, 5452.610429783392, 5508.118701007819, 5218.373795144607, 5235.842924712265, 5268.76290566933, 5288.735563221747, 5352.705601191816, 5364.275822763877, 5368.543673787772, 5376.059189641719, 5378.031954248273, 5383.569314454756, 5256.894862102813, 5263.289455923555, 5266.710330931835, 5274.0, 5325.786968521215], "value": 5121.0206526474785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8239528141559, 598.1565991951347, 608.878224355129, 613.8005148326795, 635.6503922842437, 32329.67670323296, 35414.82292588533, 35417.0, 35605.109872253175, 46206.76896615512, 45954.7702261489, 46443.53556464434, 46505.53494465054, 46508.76745616267, 46522.30216546755, 8857.867131993025, 9009.0, 9014.36899417041, 9016.053314401992, 9018.278537717, 7871.921280787176, 8768.34237432192, 8781.077986811388, 8815.647374105029, 10472.947635261813, 10456.268061235716, 10845.349279043243, 10850.077743391781, 10858.23992320538, 10894.891051089468, 10769.407682577455, 10807.891921080767, 10817.78364432707, 10828.620998265023, 10829.025387715104, 10508.0, 10572.418516981563, 10574.365538067663, 10575.418351990638, 10583.259171857973, 42666.14667706629, 43142.352864707056, 43191.78404107991, 43222.56777432217, 43290.783546082384, 3362.5723728350367, 3365.225998020469, 3466.2201004773974, 3522.2603253316834, 3618.185908170667, 32173.0, 32580.674193258237, 32751.18122046944, 32761.0, 32866.0, 4351.412559304485, 4438.178936896652, 4458.7324760514475, 4462.955370446319, 4636.884077898046, 322619.0, 324088.0, 324358.0, 325334.0, 326487.0, 58491.0, 58718.07306013633, 58737.41262587405, 59125.70437147787, 59129.0, 61290.951540573406, 61707.38292617106, 61730.0, 61763.38236617576, 62109.06836397458, 16420.096894670667, 16654.16729163537, 16669.66660666804, 16672.249748761336, 16691.91654041722, 12687.746245075232, 12842.229466232056, 12842.550510732079, 12842.743145137045, 12856.871431285754, 16146.838531614534, 17650.0, 18089.0, 18172.182251798702, 18449.907750461163, 6542.6401547914365, 6775.559588626724, 6795.864082718318, 6896.413804826546, 6994.230634630187, 913.2283220678516, 924.7503174142944, 990.4404011733347, 999.0509016434416, 1095.5782023920847, 30629.540556891665, 30726.385472290876, 31142.22144446407, 31408.0, 31918.840405797822, 1005.959761609542, 1043.3218408034838, 1067.199600299775, 1100.312304809494, 1127.5546159267044, 15678.879310344973, 16306.510804675878, 16476.176191190632, 16477.505674829776, 16559.0, 450217.0, 454468.0, 457122.0, 457746.0, 458085.0, 50616.0, 57430.712846436334, 58222.12666810001, 58222.41777582255, 58292.12561811576, 1361.8570050144592, 1364.8225730654951, 1366.6719987203, 1366.719822436398, 1371.403439503799, 30600.0, 33010.66989330076, 33192.1701957453, 33256.667433325354, 33831.0, 51633.48366516437, 51761.15313657785, 52052.47947520476, 52062.219066713275, 52138.47861521488, 437873.0, 451689.0, 460055.0, 464878.0, 659729.0, 28146.577801332587, 28224.71775282221, 28534.857325713238, 28565.0, 28983.420331593672, 47835.521644783104, 48185.277220842414, 48270.75864620795, 48738.5126148734, 49718.50281497283, 39312.840852751615, 42160.36759448549, 42234.7888260569, 42572.889797657124, 43029.56970430256, 38579.61420385873, 39676.40485392664, 41492.79253603713, 43358.34962475502, 45420.772896135306, 40669.389959150045, 40812.59187408206, 41863.58136418597, 42087.0, 42138.0, 34485.310293794486, 37022.44466332953, 37228.6277137236, 37483.43774843434, 37731.81134094312, 27665.72334276712, 27948.44103117967, 27973.300667483476, 28070.71929280681, 28165.0], "value": 20271.785864975438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.507939678418, 384.2564637426579, 389.8109416932789, 390.6815945004821, 404.43783141433414, 16678.166091695413, 18820.99999999998, 18899.24403023881, 19154.138063787144, 19759.5060123497, 18810.0, 19057.52356191096, 19342.51643708908, 19528.804711952875, 19617.11722972466, 5501.972490137544, 5507.311586051734, 5733.283339582552, 5746.051901436258, 5749.511291540224, 5660.29246344207, 5671.517920976701, 5698.914516282259, 5728.914066289009, 5729.856753581173, 5458.344998600173, 5595.888082238353, 5626.718664066801, 5714.57140714446, 5716.1711551824965, 5659.773609055633, 5691.658500489963, 5696.77212911483, 5700.429957004329, 5708.514776244025, 4898.289747986558, 5093.745312734349, 5102.209157580581, 5128.102582048126, 5129.512696293846, 19504.609907801907, 19513.121909514106, 20659.483512912146, 23049.19327823535, 23217.53564928709, 2326.581215381231, 2330.417395651087, 2443.9389015274583, 2558.731333210005, 2897.9275518112004, 13854.0, 14023.29883505831, 14804.629884252872, 14827.0, 14875.107493550422, 1918.8177123173277, 1961.0880940362658, 1974.3780709076595, 1986.1856638778177, 2007.979920200794, 62979.36577758235, 81302.0, 83389.58305208434, 83525.58237208836, 84228.0, 9915.256355773347, 10036.949815250877, 10210.795784084277, 10719.410432426135, 11124.555017799197, 14147.575572732834, 14166.504172354124, 14190.85809141916, 14198.929005354907, 14202.289885505683, 7759.92240077592, 7978.521288722695, 8032.638531266107, 8270.627821748036, 8281.254687078072, 7806.3364614007305, 7855.8821617675785, 7857.489263197874, 8086.433949623588, 8097.35221182304, 6202.658853763086, 6304.401081897213, 6328.208973878265, 6444.484441244689, 6561.0814485972005, 1804.909754512269, 1815.963680726378, 1819.2995696656617, 1852.4905650945827, 1863.3292014874635, 906.3112034853559, 919.7286800393766, 954.4654993203828, 963.3786207896007, 1013.0932815130417, 18139.637207255782, 19813.60372792536, 19966.50083747889, 20081.497962551053, 20086.69869951952, 962.7833737409167, 977.4868194198103, 979.314479864098, 989.7822479054596, 991.8462638291077, 10939.398333091756, 11364.886351136549, 11583.942080289713, 11610.535578576762, 11621.418929053514, 452362.0, 464557.0, 466848.0, 467235.0, 468472.0, 79948.6002569995, 81070.4462670662, 81314.0, 82691.0, 82763.0, 1030.1655658916302, 1032.8244198486275, 1041.1618646989245, 1055.0, 1059.210887888528, 16579.430188320828, 16646.250918708443, 16954.0, 17444.651106977537, 18142.45572632823, 41361.0, 41406.792966036184, 41695.0, 42027.15945681131, 42112.3683144747, 52468.0, 52702.209466858796, 53712.0, 55650.0, 55693.72153139208, 7378.704851806082, 7396.889046664197, 7518.8496230074, 7927.3261772747655, 8310.127436619068, 11566.380706701237, 12734.235945843278, 12832.615021549369, 13015.154014988995, 13281.406231252311, 10898.564057437614, 11066.612668556561, 11260.605878794202, 11358.09135269193, 11513.0, 11407.942960285145, 11465.885341146482, 11535.423228838692, 11683.649490515298, 11703.473343699725, 11298.322100673986, 11306.265092769272, 11548.48031838586, 11697.415129243334, 11884.82172767392, 7416.367189647597, 7622.31399174077, 7700.152983171959, 7766.922330776846, 7771.184025677222, 9706.417614943126, 10766.354018758899, 10857.782844342912, 10943.124550036136, 11290.0], "value": 9126.740250121711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.9335033248335, 1432.5702289313206, 1441.7549016667165, 1561.3208254409333, 1736.800267969184, 7960.442769006165, 8266.38002149839, 8277.710280140189, 8594.828103437943, 8604.612792424341, 8392.0, 8485.830283394329, 8485.872711909326, 8507.191816777411, 8511.27654149398, 1971.2312198242696, 2203.680466332381, 2288.8168946484243, 2311.8034967027825, 2322.7677232276806, 2218.944526386837, 2241.361212054565, 2241.428435748882, 2250.1449449209276, 2253.1325439705665, 2249.730032396115, 2262.8529145605567, 2268.9432764180947, 2277.36233854521, 2288.2906299047268, 2117.565898990719, 2182.2689399051337, 2184.2573525001417, 2223.144089525528, 2230.4423894026495, 2284.3717977556307, 2289.1186893046297, 2298.770122987705, 2303.0787684925995, 2303.170858490942, 8216.753497395088, 8308.335333173332, 8359.958200209021, 8368.0, 8370.748877533684, 4992.550670439641, 5092.185250359925, 5094.4650811664615, 5106.05537975472, 5108.872278193037, 3025.0622307084873, 3133.5143052826847, 3207.1180425382972, 3222.2105584132037, 3233.030090972699, 1039.5129795543291, 1077.983830242547, 1118.9160812939062, 1123.1969142063465, 1139.93730344831, 11476.885231147666, 11480.540778368939, 11519.654410367702, 11606.535738570446, 11609.07127429812, 4076.510818701775, 4190.748555086705, 4298.356510745932, 4316.913661726748, 4401.955980440219, 9124.315676324302, 9152.267818574499, 9163.221126204215, 9165.90834091664, 9172.082791720908, 5046.722430266371, 5051.570616497639, 5054.014467178865, 5054.823081192214, 5061.392632884003, 4165.083681590046, 4695.084458530554, 4746.477887432379, 4786.856394308176, 4796.040791841646, 3571.4107172316794, 3610.097475631092, 3713.721470889694, 3726.2920045191327, 3734.682551983112, 1062.0388548363744, 1065.5577935156823, 1073.270176280137, 1076.6985244131656, 1096.2545469081101, 830.3357314148657, 899.3210126354692, 910.4264313482464, 927.4064598656865, 939.9483028433365, 5532.197831314517, 5574.888502229933, 5671.347795003545, 5703.572232082611, 5746.9425305747245, 936.2042264075482, 944.4427787605346, 957.3107362698846, 963.7301555564453, 1027.5427434791595, 3718.6839118674675, 3826.081740382288, 3876.7673939563715, 3908.55051669056, 3947.0, 10203.642872499428, 10485.895141048644, 10534.420606866695, 10550.841737373945, 10564.102051325723, 10362.378257304586, 10451.581936722447, 10456.058954694114, 10469.476526173661, 10526.842097368546, 7385.556866587915, 7573.962130189424, 7623.656935437919, 7626.885596716053, 7656.310932016146, 5664.915026274527, 5783.508401785727, 5817.243758311392, 5839.0949402842625, 5935.762569497172, 9209.631614735335, 9443.504221020701, 9498.19265362452, 9517.619295228113, 9650.131488165818, 9581.568829402833, 9636.180924621485, 9729.124378805658, 9921.900780992097, 9924.702258932244, 6352.269489008639, 7369.447291453055, 7486.401087912845, 7504.699812007677, 7856.09654889695, 7855.33229675484, 8094.797630059295, 8101.513909165234, 8134.715284965235, 8183.345332373515, 7249.891251631335, 7316.853662926818, 7318.377937875127, 7415.666295016845, 7434.107907051189, 7073.186583542958, 7163.0, 7253.492255542273, 7337.889931650922, 7464.962675186589, 6479.287278399466, 6490.156279683611, 6531.248906375828, 6532.248791389051, 6536.117624120873, 4990.950090499194, 5000.949990500048, 5061.114304996685, 5064.316317297118, 5123.666961647481, 5005.774740136775, 5009.559087107187, 5093.490650934877, 5159.071367153798, 5180.222966555047], "value": 4414.170995821431, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.2732737676539, 327.45805691580426, 331.3257520944877, 343.81262212094407, 345.24736075355713, 5222.582193424527, 5252.686828292927, 5281.33983252093, 5286.603504737141, 5300.257963885055, 5171.534561889429, 5183.870403239921, 5185.766640501177, 5223.895522089556, 5229.764660590273, 4037.7375470594466, 4119.794010299488, 4149.128682976579, 4151.588459923625, 4181.540030596632, 4094.5464360152164, 4130.628243458088, 4162.500499939996, 4164.625183733463, 4173.332266837307, 4074.3073677474754, 4079.2657321682086, 4092.1994322498003, 4096.446979657752, 4099.713020088595, 3861.706328379996, 3915.4126880968083, 4029.5567487576345, 4128.876133715993, 4134.627883490471, 3538.044727923472, 3553.289342131584, 3564.8395822188063, 3566.982165089158, 3582.659647333499, 5037.798488060474, 5049.34358533392, 5050.444451110375, 5071.974640126813, 5091.643584949055, 4287.635550978171, 4373.2565463871215, 4644.442666879996, 4663.696859704109, 4670.579647831712, 5363.329583802025, 5380.986647477425, 5385.892282154335, 5386.003589335985, 5423.972880135613, 4056.4118202860714, 4066.8576599818866, 4067.145899361108, 4069.511658600957, 4075.205334959684, 5523.585731070186, 5588.552915766729, 5610.523105536035, 5629.240052592889, 5667.8583035424035, 4144.41978123063, 4154.459920210354, 4165.97917010419, 4189.392538082022, 4195.895102622459, 4231.851885184004, 4237.788110594458, 4240.745555266694, 4242.257604919127, 4250.702450828412, 4531.501534831166, 4637.489876113625, 4675.95324046762, 4756.405449318835, 4781.139394908881, 5436.673799572039, 5441.292631957899, 5445.591580631469, 5462.453754624506, 5465.6447330923365, 1442.6898216883421, 1462.9561113166621, 1464.2898194375719, 1468.6548661064642, 1468.9192094434695, 907.4509921497399, 952.476138124029, 956.9952150239344, 959.4339339789418, 967.4775621164492, 4676.602488788491, 4690.437147542249, 4693.342931989524, 4701.459332176775, 4723.126221649006, 4892.608591312757, 4911.50884911506, 4913.828016019494, 4914.631402644816, 4949.802007919643, 4701.929471057937, 4716.6698331116495, 4742.33607294979, 4779.784909679072, 4931.235658472942, 2820.8166469179846, 2902.506573882445, 2922.3716900866416, 2949.395373948378, 2953.0804976765276, 5709.9714501427225, 5719.914201286984, 5723.513501352349, 5760.0, 5767.961766882002, 5559.944400555943, 5688.573356998241, 5714.285714285715, 5760.8396851180805, 5793.392973162094, 5774.797882074107, 5774.94225057744, 5792.842900619257, 5793.131030345397, 5794.594378393472, 5529.668219906818, 5566.860828479321, 5569.888602228014, 5609.551235901036, 5644.774209031592, 5294.841154765363, 5402.135658294654, 5468.234447177478, 5476.972615136899, 5492.47821456961, 5687.971560142173, 5694.772209111755, 5715.39988301239, 5717.17101020358, 5720.599558031065, 4011.4383986241364, 4055.8174882129783, 4057.9652188691693, 4060.3503439449546, 4072.2873497138476, 5392.9483750669815, 5468.863278418072, 5493.533049690661, 5503.642263253036, 5533.861653458695, 5326.055989563703, 5328.600354973315, 5366.946330536644, 5381.8923621526565, 5414.485623865727, 5193.636445448782, 5249.396319423163, 5291.232771248225, 5349.518543331119, 5376.919346209888, 5298.867528311823, 5342.679439233659, 5355.0, 5364.141737322166, 5374.355077390738, 5403.432639572946, 5426.918596221139, 5437.728113594226, 5452.263944367618, 5455.918161227664, 5132.948670513247, 5296.443873393238, 5306.708131052829, 5308.25684404176, 5324.866878328073], "value": 4140.520997944982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.1226016520011, 728.8943103250028, 740.3078121955972, 750.54591971857, 804.9597520123995, 14072.0, 14696.191709455976, 14775.335109920052, 14857.554273371803, 14882.851171488282, 13133.343332833369, 13221.405036773343, 13551.525696600622, 13590.0, 13639.249841258727, 802.4663598706853, 815.384384789486, 818.8607936650784, 819.0253598218102, 819.2831272636444, 662.2053535757111, 785.0696924144878, 802.6829402386054, 810.3962547901792, 821.1993306526119, 863.3309185381316, 865.5845194306737, 865.8874346334968, 866.384866744612, 866.540733411293, 864.2092485375873, 864.779481232288, 864.9913500864974, 865.35098675993, 865.6321063547967, 513.0559770023139, 599.403593424541, 617.3332800575367, 620.6307247187916, 627.4854619212248, 12793.48826046957, 12839.0, 12860.807087893689, 12958.287294198815, 13127.606171814861, 13310.534131305454, 13903.721925561433, 14032.228227447486, 14101.64745881351, 14173.433062677585, 12653.936730316289, 12660.0, 12763.5532756354, 12995.740085198244, 13085.869141308656, 4333.2200203963275, 4364.519902810688, 4475.753833539154, 4567.703099298568, 4569.840055598072, 77275.0, 78746.0, 78911.0, 78979.60510197413, 79058.60470697668, 11352.318860868209, 11721.706957326134, 11843.23019003762, 11995.520179192908, 12053.0, 21647.783522164893, 21654.89172554127, 21688.674669879965, 21692.783072169077, 21693.0, 8429.536375499407, 8485.151484851465, 8486.787830304169, 8580.656773729106, 8632.525211113449, 4290.656747460258, 4575.039241759201, 4658.464276608233, 4713.457952335525, 4713.95286047142, 3216.0, 3338.916527086842, 3345.0466617014035, 3345.130266130775, 3347.196672798511, 563.8533981164927, 576.8442520519436, 585.6383907415277, 585.8476796033062, 595.8510372406898, 573.9282589676291, 580.6123365157277, 684.2165720250285, 710.7690000749777, 727.8034930568717, 8512.872306915402, 9031.81936361269, 9637.469939153414, 9721.513924303756, 9921.114988152229, 643.5237923936254, 649.8407890066964, 725.5570533661056, 725.9854802903913, 730.9963450182821, 4201.508464495121, 4392.978035109804, 4540.750258735801, 4545.36364908913, 4558.635309175258, 120531.0, 121656.39171804085, 123015.0, 123530.38234808948, 124785.37607311906, 101900.49049754704, 103624.0, 104234.47882760537, 105461.47269263757, 107284.46357768161, 58417.41582584205, 77112.10762331838, 89875.55062224779, 90762.91566879506, 99260.50369748105, 10007.249456290952, 10389.37663740178, 10393.960603939848, 10474.371537707762, 10563.683089507327, 53265.46734532605, 53760.73119634377, 54042.18936715874, 54495.72752136214, 56612.43387566072, 71798.0, 72239.27760722536, 80821.59589202017, 82113.58943205245, 82127.0, 13466.79799802984, 13743.656408589864, 13950.162990220213, 13965.930170349084, 14357.282135893372, 14755.852441475448, 14821.92589037048, 14880.479183228535, 15254.0, 15496.225188740744, 13077.738445231233, 13500.5274815381, 13857.653558661113, 14259.572212833631, 14800.703985920436, 14079.859201407855, 14200.928995354958, 14311.355988980313, 14430.783538247144, 14459.855401446272, 13558.457661693421, 13580.0, 13725.176489410667, 13840.93079534596, 13889.583312500641, 11258.493367798304, 11455.59905403307, 11914.285142891455, 11952.103592230791, 12527.498900043896, 11383.601573944872, 11475.311481311148, 11629.88370116288, 11775.904947495019, 11933.76132477363], "value": 7575.957328766253, "unit": "score"}], "name": "dromaeo_css", "value": 7128.406504928408, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 133.0, 111.0, 117.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 144.0, 183.0, 123.0, 146.0, 154.0, 119.0, 177.0, 119.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 160.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 168.0, 77.0, 75.0, 75.0, 75.0, 174.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 145.0, 82.0, 82.0, 83.0, 139.0, 84.0, 83.0, 147.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 79.0, 79.0, 78.0, 78.0, 85.0, 78.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 126.0, 124.0, 131.0, 124.0, 123.0, 122.0, 164.0, 124.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 159.0, 163.0, 160.0, 159.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 65.0, 68.0, 65.0, 70.0, 65.0, 63.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1527.2, "alertThreshold": 2.0}]} 10:39:59 INFO - Return code: 0 10:39:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:59 INFO - # TBPL SUCCESS # 10:39:59 INFO - Running post-action listener: _resource_record_post_action 10:39:59 INFO - [mozharness: 2016-08-26 17:39:59.689942Z] Finished run-tests step (success) 10:39:59 INFO - Running post-run listener: _resource_record_post_run 10:39:59 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406843392; Read time: 20; Write time: 799296 10:39:59 INFO - TinderboxPrint: CPU usage
13.1% 10:39:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 10:39:59 INFO - TinderboxPrint: I/O write bytes / time
406,843,392 / 799,296 10:39:59 INFO - TinderboxPrint: CPU idle
8,298.6 (86.9%) 10:39:59 INFO - TinderboxPrint: CPU user
1,196.3 (12.5%) 10:39:59 INFO - TinderboxPrint: Swap in / out
0 / 0 10:39:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117428224; Read time: 0; Write time: 209564 10:39:59 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288489472; Read time: 12; Write time: 589680 10:40:00 INFO - Running post-run listener: _upload_blobber_files 10:40:00 INFO - Blob upload gear active. 10:40:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:00 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 10:40:00 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:40:00 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:40:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:10 INFO - (blobuploader) - INFO - Done attempting. 10:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:11 INFO - (blobuploader) - INFO - Done attempting. 10:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:12 INFO - (blobuploader) - INFO - Done attempting. 10:40:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:12 INFO - Return code: 0 10:40:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247217bbdee953bb7192d7fe682ba2a08735d1c0dce7a7aac1b781853471d8e21dfb841bb9b3f5d9033540a66be5c868bf578abc826d35effe08983acd86dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/052a3758ab7d65967fb9f3b698bd4c22b9966e4aa3e7a0df3c94990388631693f98e25467ae0c74a61d9fd73272b3269aa5a57c6cc41aedd6675913a140839f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f929501a9fee5dbfd7d44300bb48b05ce103f3315af97b8372bbfb808180bb0984039c30767d4fccc23de16bece1e72d7cbabce69f4a0f597ca078d44fdd9c9"} 10:40:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:12 INFO - Contents: 10:40:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247217bbdee953bb7192d7fe682ba2a08735d1c0dce7a7aac1b781853471d8e21dfb841bb9b3f5d9033540a66be5c868bf578abc826d35effe08983acd86dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/052a3758ab7d65967fb9f3b698bd4c22b9966e4aa3e7a0df3c94990388631693f98e25467ae0c74a61d9fd73272b3269aa5a57c6cc41aedd6675913a140839f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f929501a9fee5dbfd7d44300bb48b05ce103f3315af97b8372bbfb808180bb0984039c30767d4fccc23de16bece1e72d7cbabce69f4a0f597ca078d44fdd9c9"} 10:40:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:12 INFO - Copying logs to upload dir... 10:40:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.576817 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 10:40:12.553745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 10:40:12.562482) ========= 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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247217bbdee953bb7192d7fe682ba2a08735d1c0dce7a7aac1b781853471d8e21dfb841bb9b3f5d9033540a66be5c868bf578abc826d35effe08983acd86dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/052a3758ab7d65967fb9f3b698bd4c22b9966e4aa3e7a0df3c94990388631693f98e25467ae0c74a61d9fd73272b3269aa5a57c6cc41aedd6675913a140839f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f929501a9fee5dbfd7d44300bb48b05ce103f3315af97b8372bbfb808180bb0984039c30767d4fccc23de16bece1e72d7cbabce69f4a0f597ca078d44fdd9c9"} build_url:https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/ISzetS7uTUW6WeuAv8M1GA/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/Firefox/sha512/247217bbdee953bb7192d7fe682ba2a08735d1c0dce7a7aac1b781853471d8e21dfb841bb9b3f5d9033540a66be5c868bf578abc826d35effe08983acd86dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/052a3758ab7d65967fb9f3b698bd4c22b9966e4aa3e7a0df3c94990388631693f98e25467ae0c74a61d9fd73272b3269aa5a57c6cc41aedd6675913a140839f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f929501a9fee5dbfd7d44300bb48b05ce103f3315af97b8372bbfb808180bb0984039c30767d4fccc23de16bece1e72d7cbabce69f4a0f597ca078d44fdd9c9"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 10:40:12.991034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:40:12.995567) ========= 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=745a4373a2a16df560f216e000000264-1472229800.769056-545769750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:40:13.012200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 10:40:13.012511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 10:40:13.012804) ========= ========= Total master_lag: 0.90 =========