builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1471022082.49 results: success (0) buildid: 20160812084517 builduid: aab789c07fdc49629985afb1d396da7d revision: e8234e96da519dce5980f851c46648cdde83aab6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.492735) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.493249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.493550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.529655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.530044) ========= 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=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 10:14:42-- 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% 229M=0s 2016-08-12 10:14:42 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.667222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.667537) ========= 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=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.717104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:42.717504) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e8234e96da519dce5980f851c46648cdde83aab6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e8234e96da519dce5980f851c46648cdde83aab6 --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=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 10:14:42,807 truncating revision to first 12 chars 2016-08-12 10:14:42,807 Setting DEBUG logging. 2016-08-12 10:14:42,807 attempt 1/10 2016-08-12 10:14:42,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e8234e96da51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 10:14:43,120 unpacking tar archive at: autoland-e8234e96da51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:43.369258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:43.369574) ========= script_repo_revision: e8234e96da519dce5980f851c46648cdde83aab6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:43.369949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:43.370229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 10:14:43.379549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-12 10:14:43.379826) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:43 INFO - MultiFileLogger online at 20160812 10:14:43 in /builds/slave/test 10:14:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:14:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:43 INFO - {'append_to_log': False, 10:14:43 INFO - 'base_work_dir': '/builds/slave/test', 10:14:43 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:14:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:43 INFO - 'branch': 'Autoland-Non-PGO', 10:14:43 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:43 INFO - 'config_files': ('talos/linux_config.py',), 10:14:43 INFO - 'default_actions': ('clobber', 10:14:43 INFO - 'read-buildbot-config', 10:14:43 INFO - 'download-and-extract', 10:14:43 INFO - 'populate-webroot', 10:14:43 INFO - 'create-virtualenv', 10:14:43 INFO - 'install', 10:14:43 INFO - 'run-tests'), 10:14:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:43 INFO - 'download_minidump_stackwalk': True, 10:14:43 INFO - 'download_symbols': 'ondemand', 10:14:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:43 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:43 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:43 INFO - 'installer_path': 'installer.exe', 10:14:43 INFO - 'log_level': 'info', 10:14:43 INFO - 'log_name': 'talos', 10:14:43 INFO - 'log_to_console': True, 10:14:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:43 INFO - 'opt_config_files': (), 10:14:43 INFO - 'pip_index': False, 10:14:43 INFO - 'sps_profile': False, 10:14:43 INFO - 'sps_profile_interval': 0, 10:14:43 INFO - 'suite': 'dromaeojs', 10:14:43 INFO - 'system_bits': '32', 10:14:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:43 INFO - 'title': 'talos-linux64-ix-018', 10:14:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:43 INFO - 'use_talos_json': True, 10:14:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:43 INFO - 'work_dir': 'build'} 10:14:43 INFO - [mozharness: 2016-08-12 17:14:43.567139Z] Running clobber step. 10:14:43 INFO - Running pre-action listener: _resource_record_pre_action 10:14:43 INFO - Running main action method: clobber 10:14:43 INFO - rmtree: /builds/slave/test/build 10:14:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:44 INFO - Running post-action listener: _resource_record_post_action 10:14:44 INFO - [mozharness: 2016-08-12 17:14:44.018896Z] Finished clobber step (success) 10:14:44 INFO - [mozharness: 2016-08-12 17:14:44.018996Z] Running read-buildbot-config step. 10:14:44 INFO - Running pre-action listener: _resource_record_pre_action 10:14:44 INFO - Running main action method: read_buildbot_config 10:14:44 INFO - Using buildbot properties: 10:14:44 INFO - { 10:14:44 INFO - "project": "", 10:14:44 INFO - "product": "firefox", 10:14:44 INFO - "script_repo_revision": "production", 10:14:44 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:14:44 INFO - "repository": "", 10:14:44 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:14:44 INFO - "buildid": "20160812084517", 10:14:44 INFO - "pgo_build": "False", 10:14:44 INFO - "basedir": "/builds/slave/test", 10:14:44 INFO - "buildnumber": 273, 10:14:44 INFO - "slavename": "talos-linux64-ix-018", 10:14:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:14:44 INFO - "platform": "ubuntu64_hw", 10:14:44 INFO - "scheduler": "tests-autoland-linux64-talos", 10:14:44 INFO - "branch": "autoland", 10:14:44 INFO - "repo_path": "integration/autoland", 10:14:44 INFO - "revision": "e8234e96da519dce5980f851c46648cdde83aab6", 10:14:44 INFO - "stage_platform": "linux64", 10:14:44 INFO - "builduid": "aab789c07fdc49629985afb1d396da7d", 10:14:44 INFO - "slavebuilddir": "test" 10:14:44 INFO - } 10:14:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:14:44 INFO - Running post-action listener: _resource_record_post_action 10:14:44 INFO - [mozharness: 2016-08-12 17:14:44.021396Z] Finished read-buildbot-config step (success) 10:14:44 INFO - [mozharness: 2016-08-12 17:14:44.021484Z] Running download-and-extract step. 10:14:44 INFO - Running pre-action listener: _resource_record_pre_action 10:14:44 INFO - Running main action method: download_and_extract 10:14:44 INFO - mkdir: /builds/slave/test/build/tests 10:14:44 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:14:44 INFO - trying https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:14:44 INFO - Downloading https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:14:44 INFO - Downloaded 1361 bytes. 10:14:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:14:44 INFO - Using the following test package requirements: 10:14:44 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'jsshell-linux-x86_64.zip'], 10:14:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:44 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:44 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:14:44 INFO - trying https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:14:44 INFO - Downloading https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:14:49 INFO - Downloaded 20262801 bytes. 10:14:49 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:14:53 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:14:53 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:14:53 INFO - trying https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:14:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:15:24 INFO - Downloaded 20262801 bytes. 10:15:24 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:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:29 INFO - trying https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:15:29 INFO - Downloaded 14413719 bytes. 10:15:29 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:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:30 INFO - trying https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:15:30 INFO - Downloading https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/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:15:31 INFO - Downloaded 55649089 bytes. 10:15:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:15:31 INFO - mkdir: /builds/slave/test/properties 10:15:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:31 INFO - Contents: 10:15:31 INFO - build_url:https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - Running post-action listener: set_extra_try_arguments 10:15:32 INFO - [mozharness: 2016-08-12 17:15:32.155803Z] Finished download-and-extract step (success) 10:15:32 INFO - [mozharness: 2016-08-12 17:15:32.156027Z] Running populate-webroot step. 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: populate_webroot 10:15:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:32 INFO - '--tppagecycles', 10:15:32 INFO - '7'], 10:15:32 INFO - 'tests': ['tsvgm']}}, 10:15:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['basic_compositor_video']}, 10:15:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s', 10:15:32 INFO - '--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}, 10:15:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}}, 10:15:32 INFO - 'talos.zip': {'path': '', 10:15:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - [mozharness: 2016-08-12 17:15:32.175894Z] Finished populate-webroot step (success) 10:15:32 INFO - [mozharness: 2016-08-12 17:15:32.175982Z] Running create-virtualenv step. 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: create_virtualenv 10:15:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:32 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:15:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:32 INFO - Using real prefix '/usr' 10:15:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:34 INFO - Installing pip.................done. 10:15:34 INFO - Return code: 0 10:15:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:34 INFO - Using env: {'DISPLAY': ':0', 10:15:34 INFO - 'HOME': '/home/cltbld', 10:15:34 INFO - 'LANG': 'en_US.UTF-8', 10:15:34 INFO - 'LANGUAGE': 'en_US:en', 10:15:34 INFO - 'LOGNAME': 'cltbld', 10:15:34 INFO - 'MAIL': '/var/mail/cltbld', 10:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:34 INFO - 'MOZ_NO_REMOTE': '1', 10:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:34 INFO - 'NO_EM_RESTART': '1', 10:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:34 INFO - 'PWD': '/builds/slave/test', 10:15:34 INFO - 'SHELL': '/bin/bash', 10:15:34 INFO - 'SHLVL': '1', 10:15:34 INFO - 'TERM': 'linux', 10:15:34 INFO - 'TMOUT': '86400', 10:15:34 INFO - 'USER': 'cltbld', 10:15:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:34 INFO - '_': '/tools/buildbot/bin/python'} 10:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:34 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:15:34 INFO - Cleaning up... 10:15:34 INFO - Return code: 0 10:15:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:34 INFO - Using env: {'DISPLAY': ':0', 10:15:34 INFO - 'HOME': '/home/cltbld', 10:15:34 INFO - 'LANG': 'en_US.UTF-8', 10:15:34 INFO - 'LANGUAGE': 'en_US:en', 10:15:34 INFO - 'LOGNAME': 'cltbld', 10:15:34 INFO - 'MAIL': '/var/mail/cltbld', 10:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:34 INFO - 'MOZ_NO_REMOTE': '1', 10:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:34 INFO - 'NO_EM_RESTART': '1', 10:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:34 INFO - 'PWD': '/builds/slave/test', 10:15:34 INFO - 'SHELL': '/bin/bash', 10:15:34 INFO - 'SHLVL': '1', 10:15:34 INFO - 'TERM': 'linux', 10:15:34 INFO - 'TMOUT': '86400', 10:15:34 INFO - 'USER': 'cltbld', 10:15:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:34 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 INFO - Downloading/unpacking psutil>=3.1.1 10:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:37 INFO - Installing collected packages: psutil 10:15:37 INFO - Running setup.py install for psutil 10:15:37 INFO - building 'psutil._psutil_linux' extension 10:15:37 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:15:37 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:15:37 INFO - building 'psutil._psutil_posix' extension 10:15:37 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:15:37 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:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:37 INFO - Successfully installed psutil 10:15:37 INFO - Cleaning up... 10:15:37 INFO - Return code: 0 10:15:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15: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:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:37 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:15:37 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:15:37 INFO - Using env: {'DISPLAY': ':0', 10:15:37 INFO - 'HOME': '/home/cltbld', 10:15:37 INFO - 'LANG': 'en_US.UTF-8', 10:15:37 INFO - 'LANGUAGE': 'en_US:en', 10:15:37 INFO - 'LOGNAME': 'cltbld', 10:15:37 INFO - 'MAIL': '/var/mail/cltbld', 10:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:37 INFO - 'MOZ_NO_REMOTE': '1', 10:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:37 INFO - 'NO_EM_RESTART': '1', 10:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:37 INFO - 'PWD': '/builds/slave/test', 10:15:37 INFO - 'SHELL': '/bin/bash', 10:15:37 INFO - 'SHLVL': '1', 10:15:37 INFO - 'TERM': 'linux', 10:15:37 INFO - 'TMOUT': '86400', 10:15:37 INFO - 'USER': 'cltbld', 10:15:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:37 INFO - '_': '/tools/buildbot/bin/python'} 10:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:37 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:15:37 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:15:37 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:15:37 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:15:37 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:15:37 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:15:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:39 INFO - Installing collected packages: mozsystemmonitor 10:15:39 INFO - Running setup.py install for mozsystemmonitor 10:15:39 INFO - Successfully installed mozsystemmonitor 10:15:39 INFO - Cleaning up... 10:15:40 INFO - Return code: 0 10:15:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:15:40 INFO - Using env: {'DISPLAY': ':0', 10:15:40 INFO - 'HOME': '/home/cltbld', 10:15:40 INFO - 'LANG': 'en_US.UTF-8', 10:15:40 INFO - 'LANGUAGE': 'en_US:en', 10:15:40 INFO - 'LOGNAME': 'cltbld', 10:15:40 INFO - 'MAIL': '/var/mail/cltbld', 10:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:40 INFO - 'MOZ_NO_REMOTE': '1', 10:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:40 INFO - 'NO_EM_RESTART': '1', 10:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:40 INFO - 'PWD': '/builds/slave/test', 10:15:40 INFO - 'SHELL': '/bin/bash', 10:15:40 INFO - 'SHLVL': '1', 10:15:40 INFO - 'TERM': 'linux', 10:15:40 INFO - 'TMOUT': '86400', 10:15:40 INFO - 'USER': 'cltbld', 10:15:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:40 INFO - '_': '/tools/buildbot/bin/python'} 10:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:42 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:15:42 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:15:42 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:15:42 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:15:42 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:15:42 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:15:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:42 INFO - warning: no files found matching '*.txt' 10:15:42 INFO - no previously-included directories found matching 'build' 10:15:42 INFO - no previously-included directories found matching 'dist' 10:15:42 INFO - no previously-included directories found matching '.git*' 10:15:42 INFO - Installing collected packages: jsonschema, functools32 10:15:42 INFO - Running setup.py install for functools32 10:15:42 INFO - warning: no files found matching '*.txt' 10:15:42 INFO - no previously-included directories found matching 'build' 10:15:42 INFO - no previously-included directories found matching 'dist' 10:15:42 INFO - no previously-included directories found matching '.git*' 10:15:42 INFO - Successfully installed jsonschema functools32 10:15:42 INFO - Cleaning up... 10:15:42 INFO - Return code: 0 10:15:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:15:42 INFO - Using env: {'DISPLAY': ':0', 10:15:42 INFO - 'HOME': '/home/cltbld', 10:15:42 INFO - 'LANG': 'en_US.UTF-8', 10:15:42 INFO - 'LANGUAGE': 'en_US:en', 10:15:42 INFO - 'LOGNAME': 'cltbld', 10:15:42 INFO - 'MAIL': '/var/mail/cltbld', 10:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:42 INFO - 'MOZ_NO_REMOTE': '1', 10:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:42 INFO - 'NO_EM_RESTART': '1', 10:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:42 INFO - 'PWD': '/builds/slave/test', 10:15:42 INFO - 'SHELL': '/bin/bash', 10:15:42 INFO - 'SHLVL': '1', 10:15:42 INFO - 'TERM': 'linux', 10:15:42 INFO - 'TMOUT': '86400', 10:15:42 INFO - 'USER': 'cltbld', 10:15:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:42 INFO - '_': '/tools/buildbot/bin/python'} 10:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:15:42 INFO - Cleaning up... 10:15:42 INFO - Return code: 0 10:15:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:42 INFO - Using env: {'DISPLAY': ':0', 10:15:42 INFO - 'HOME': '/home/cltbld', 10:15:42 INFO - 'LANG': 'en_US.UTF-8', 10:15:42 INFO - 'LANGUAGE': 'en_US:en', 10:15:42 INFO - 'LOGNAME': 'cltbld', 10:15:42 INFO - 'MAIL': '/var/mail/cltbld', 10:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:42 INFO - 'MOZ_NO_REMOTE': '1', 10:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:42 INFO - 'NO_EM_RESTART': '1', 10:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:42 INFO - 'PWD': '/builds/slave/test', 10:15:42 INFO - 'SHELL': '/bin/bash', 10:15:42 INFO - 'SHLVL': '1', 10:15:42 INFO - 'TERM': 'linux', 10:15:42 INFO - 'TMOUT': '86400', 10:15:42 INFO - 'USER': 'cltbld', 10:15:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:42 INFO - '_': '/tools/buildbot/bin/python'} 10:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:42 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:15:42 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:15:42 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:15:42 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:15:42 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:15:42 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:15:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:44 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:15: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:15:44 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:15:44 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:15:44 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:15: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:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - Downloading docopt-0.6.1.tar.gz 10:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:45 INFO - Running setup.py install for blobuploader 10:15:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:45 INFO - Running setup.py install for requests 10:15:46 INFO - Running setup.py install for docopt 10:15:46 INFO - Successfully installed blobuploader requests docopt 10:15:46 INFO - Cleaning up... 10:15:46 INFO - Return code: 0 10:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15: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:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:46 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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:46 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:15:46 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:15:46 INFO - Using env: {'DISPLAY': ':0', 10:15:46 INFO - 'HOME': '/home/cltbld', 10:15:46 INFO - 'LANG': 'en_US.UTF-8', 10:15:46 INFO - 'LANGUAGE': 'en_US:en', 10:15:46 INFO - 'LOGNAME': 'cltbld', 10:15:46 INFO - 'MAIL': '/var/mail/cltbld', 10:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:46 INFO - 'MOZ_NO_REMOTE': '1', 10:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:46 INFO - 'NO_EM_RESTART': '1', 10:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:46 INFO - 'PWD': '/builds/slave/test', 10:15:46 INFO - 'SHELL': '/bin/bash', 10:15:46 INFO - 'SHLVL': '1', 10:15:46 INFO - 'TERM': 'linux', 10:15:46 INFO - 'TMOUT': '86400', 10:15:46 INFO - 'USER': 'cltbld', 10:15:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:46 INFO - '_': '/tools/buildbot/bin/python'} 10:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 INFO - Running setup.py (path:/tmp/pip-kbV5OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 INFO - Running setup.py (path:/tmp/pip-O_2ASE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 INFO - Running setup.py (path:/tmp/pip-3e7jWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 INFO - Running setup.py (path:/tmp/pip-YdLP0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:46 INFO - Running setup.py (path:/tmp/pip-5CDWjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:46 INFO - Running setup.py (path:/tmp/pip-dmkp9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:46 INFO - Running setup.py (path:/tmp/pip-jChxaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:46 INFO - Running setup.py (path:/tmp/pip-UWkmQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:47 INFO - Running setup.py (path:/tmp/pip-cR10wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:47 INFO - Running setup.py (path:/tmp/pip-iEuodk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 INFO - Running setup.py (path:/tmp/pip-jRqE9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 INFO - Running setup.py (path:/tmp/pip-0fvt8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 INFO - Running setup.py (path:/tmp/pip-BvtMeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 INFO - Running setup.py (path:/tmp/pip-zhHoHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 INFO - Running setup.py (path:/tmp/pip-rke9dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:47 INFO - Running setup.py (path:/tmp/pip-qRHAwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:47 INFO - Running setup.py (path:/tmp/pip-GVtyf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:47 INFO - Running setup.py install for manifestparser 10:15:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:47 INFO - Running setup.py install for mozcrash 10:15:47 INFO - Running setup.py install for mozdebug 10:15:47 INFO - Running setup.py install for mozdevice 10:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozfile 10:15:48 INFO - Running setup.py install for mozhttpd 10:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozinfo 10:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozInstall 10:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozleak 10:15:48 INFO - Running setup.py install for mozlog 10:15:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for moznetwork 10:15:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozprocess 10:15:48 INFO - Running setup.py install for mozprofile 10:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Running setup.py install for mozrunner 10:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Running setup.py install for mozscreenshot 10:15:49 INFO - Running setup.py install for moztest 10:15:49 INFO - Running setup.py install for mozversion 10:15:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:49 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:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:49 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:15:49 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:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:49 INFO - Running setup.py (path:/tmp/pip-r8L2PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:49 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:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:49 INFO - Running setup.py (path:/tmp/pip-vTZKmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:49 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:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:49 INFO - Running setup.py (path:/tmp/pip-SbM4fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:49 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:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:49 INFO - Running setup.py (path:/tmp/pip-WRFase-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:49 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:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:49 INFO - Running setup.py (path:/tmp/pip-f5cFK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:50 INFO - Running setup.py (path:/tmp/pip-lkL_Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:50 INFO - Running setup.py (path:/tmp/pip-Dsyd3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:50 INFO - Running setup.py (path:/tmp/pip-un5URz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:50 INFO - Running setup.py (path:/tmp/pip-ZRVnYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:50 INFO - Running setup.py (path:/tmp/pip-4gOW5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:50 INFO - Running setup.py (path:/tmp/pip-krnU30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:50 INFO - Running setup.py (path:/tmp/pip-0zjy2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:50 INFO - Running setup.py (path:/tmp/pip-KPYqwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:50 INFO - Running setup.py (path:/tmp/pip-WjJHzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:50 INFO - Running setup.py (path:/tmp/pip-bpa8ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:50 INFO - Running setup.py (path:/tmp/pip-hZ_dJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:50 INFO - Running setup.py (path:/tmp/pip-bn8_TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15: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:15: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:15: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:15: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:15: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:15: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:15:52 INFO - Downloading blessings-1.6.tar.gz 10:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:53 INFO - Installing collected packages: blessings 10:15:53 INFO - Running setup.py install for blessings 10:15:53 INFO - Successfully installed blessings 10:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:53 INFO - Reading from file tmpfile_stdout 10:15:53 INFO - Current package versions: 10:15:53 INFO - argparse == 1.2.1 10:15:53 INFO - blessings == 1.6 10:15:53 INFO - blobuploader == 1.2.4 10:15:53 INFO - docopt == 0.6.1 10:15:53 INFO - functools32 == 3.2.3-2 10:15:53 INFO - jsonschema == 2.5.1 10:15:53 INFO - manifestparser == 1.1 10:15:53 INFO - mozInstall == 1.12 10:15:53 INFO - mozcrash == 0.17 10:15:53 INFO - mozdebug == 0.1 10:15:53 INFO - mozdevice == 0.48 10:15:53 INFO - mozfile == 1.2 10:15:53 INFO - mozhttpd == 0.7 10:15:53 INFO - mozinfo == 0.9 10:15:53 INFO - mozleak == 0.1 10:15:53 INFO - mozlog == 3.3 10:15:53 INFO - moznetwork == 0.27 10:15:53 INFO - mozprocess == 0.23 10:15:53 INFO - mozprofile == 0.28 10:15:53 INFO - mozrunner == 6.12 10:15:53 INFO - mozscreenshot == 0.1 10:15:53 INFO - mozsystemmonitor == 0.3 10:15:53 INFO - moztest == 0.7 10:15:53 INFO - mozversion == 1.4 10:15:53 INFO - psutil == 3.1.1 10:15:53 INFO - requests == 1.2.3 10:15:53 INFO - wsgiref == 0.1.2 10:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:53 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:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:53 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:15:53 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:15:53 INFO - Using env: {'DISPLAY': ':0', 10:15:53 INFO - 'HOME': '/home/cltbld', 10:15:53 INFO - 'LANG': 'en_US.UTF-8', 10:15:53 INFO - 'LANGUAGE': 'en_US:en', 10:15:53 INFO - 'LOGNAME': 'cltbld', 10:15:53 INFO - 'MAIL': '/var/mail/cltbld', 10:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:53 INFO - 'MOZ_NO_REMOTE': '1', 10:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:53 INFO - 'NO_EM_RESTART': '1', 10:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:53 INFO - 'PWD': '/builds/slave/test', 10:15:53 INFO - 'SHELL': '/bin/bash', 10:15:53 INFO - 'SHLVL': '1', 10:15:53 INFO - 'TERM': 'linux', 10:15:53 INFO - 'TMOUT': '86400', 10:15:53 INFO - 'USER': 'cltbld', 10:15:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:53 INFO - '_': '/tools/buildbot/bin/python'} 10:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:53 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:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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 0x7fe356b5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, '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': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', '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:15:53 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:15:53 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:15:53 INFO - Using env: {'DISPLAY': ':0', 10:15:53 INFO - 'HOME': '/home/cltbld', 10:15:53 INFO - 'LANG': 'en_US.UTF-8', 10:15:53 INFO - 'LANGUAGE': 'en_US:en', 10:15:53 INFO - 'LOGNAME': 'cltbld', 10:15:53 INFO - 'MAIL': '/var/mail/cltbld', 10:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:53 INFO - 'MOZ_NO_REMOTE': '1', 10:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:53 INFO - 'NO_EM_RESTART': '1', 10:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:53 INFO - 'PWD': '/builds/slave/test', 10:15:53 INFO - 'SHELL': '/bin/bash', 10:15:53 INFO - 'SHLVL': '1', 10:15:53 INFO - 'TERM': 'linux', 10:15:53 INFO - 'TMOUT': '86400', 10:15:53 INFO - 'USER': 'cltbld', 10:15:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:53 INFO - '_': '/tools/buildbot/bin/python'} 10:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Running post-action listener: _resource_record_post_action 10:15:53 INFO - Running post-action listener: _start_resource_monitoring 10:15:53 INFO - Starting resource monitoring. 10:15:53 INFO - [mozharness: 2016-08-12 17:15:53.926815Z] Finished create-virtualenv step (success) 10:15:53 INFO - [mozharness: 2016-08-12 17:15:53.927325Z] Running install step. 10:15:53 INFO - Running pre-action listener: _resource_record_pre_action 10:15:53 INFO - Running main action method: install 10:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:54 INFO - Reading from file tmpfile_stdout 10:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:54 INFO - Reading from file tmpfile_stdout 10:15:54 INFO - Output received: 10:15:54 INFO - Usage: mozinstall [options] installer 10:15:54 INFO - Options: 10:15:54 INFO - -h, --help show this help message and exit 10:15:54 INFO - -d DEST, --destination=DEST 10:15:54 INFO - Directory to install application into. [default: 10:15:54 INFO - "/builds/slave/test"] 10:15:54 INFO - --app=APP Application being installed. [default: firefox] 10:15:54 INFO - mkdir: /builds/slave/test/build/application 10:15:54 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:15:54 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:16:10 INFO - Reading from file tmpfile_stdout 10:16:10 INFO - Output received: 10:16:10 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:10 INFO - Running post-action listener: _resource_record_post_action 10:16:10 INFO - [mozharness: 2016-08-12 17:16:10.345574Z] Finished install step (success) 10:16:10 INFO - [mozharness: 2016-08-12 17:16:10.345823Z] Running run-tests step. 10:16:10 INFO - Running pre-action listener: _resource_record_pre_action 10:16:10 INFO - Running main action method: run_tests 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:10 INFO - Python 2.7.3 10:16:10 INFO - Return code: 0 10:16:10 INFO - grabbing minidump binary from tooltool 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:10 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 0x2b5a090>, '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 0x2b5d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:10 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:16:10 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:16:10 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:16:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:10 INFO - Return code: 0 10:16:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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:16:10 INFO - Using env: {'DISPLAY': ':0', 10:16:10 INFO - 'HOME': '/home/cltbld', 10:16:10 INFO - 'LANG': 'en_US.UTF-8', 10:16:10 INFO - 'LANGUAGE': 'en_US:en', 10:16:10 INFO - 'LOGNAME': 'cltbld', 10:16:10 INFO - 'MAIL': '/var/mail/cltbld', 10:16:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:10 INFO - 'MOZ_NO_REMOTE': '1', 10:16:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:10 INFO - 'NO_EM_RESTART': '1', 10:16:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:10 INFO - 'PWD': '/builds/slave/test', 10:16:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:10 INFO - 'SHELL': '/bin/bash', 10:16:10 INFO - 'SHLVL': '1', 10:16:10 INFO - 'TERM': 'linux', 10:16:10 INFO - 'TMOUT': '86400', 10:16:10 INFO - 'USER': 'cltbld', 10:16:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652', 10:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:10 INFO - '_': '/tools/buildbot/bin/python'} 10:16:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:16:10 INFO - mozversion application_buildid: 20160812084517 10:16:10 INFO - mozversion application_changeset: e8234e96da519dce5980f851c46648cdde83aab6 10:16:10 INFO - mozversion application_display_name: Nightly 10:16:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:10 INFO - mozversion application_name: Firefox 10:16:10 INFO - mozversion application_remotingname: firefox 10:16:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:16:10 INFO - mozversion application_vendor: Mozilla 10:16:10 INFO - mozversion application_version: 51.0a1 10:16:10 INFO - mozversion platform_buildid: 20160812084517 10:16:10 INFO - mozversion platform_changeset: e8234e96da519dce5980f851c46648cdde83aab6 10:16:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:16:10 INFO - mozversion platform_version: 51.0a1 10:16:10 INFO - using testdate: 1471022170 10:16:10 INFO - actual date: 1471022170 10:16:10 INFO - starting webserver on 'localhost:57687' 10:16:10 INFO - SUITE-START | Running 2 tests 10:16:10 INFO - TEST-START | dromaeo_css 10:16:10 INFO - operating with platform_type : linux_ 10:16:10 INFO - Initialising browser for dromaeo_css test... 10:16:10 INFO - TEST-INFO | started process 4055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcx15RC/profile http://localhost:57687/getInfo.html) 10:16:14 INFO - PROCESS | 4055 | __metrics Screen width/height:1600/1200 10:16:14 INFO - PROCESS | 4055 | colorDepth:24 10:16:14 INFO - PROCESS | 4055 | Browser inner width/height: 1024/697 10:16:14 INFO - PROCESS | 4055 | __metrics 10:16:15 INFO - PROCESS | 4055 | 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:16:15 INFO - PROCESS | 4055 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:16 INFO - TEST-INFO | 4055: exit 0 10:16:16 INFO - Browser initialized. 10:16:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:16 INFO - TEST-INFO | started process 4135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcx15RC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:28 INFO - PROCESS | 4135 | RSS: Main: 157200384 10:16:28 INFO - PROCESS | 4135 | 10:17:19 INFO - PROCESS | 4135 | 1471022239781 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:19:32 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57687/tests/dromaeo/cssquery-ext.html) 10:19:33 INFO - PROCESS | 4135 | RSS: Main: 244355072 10:19:33 INFO - PROCESS | 4135 | 10:22:36 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-ext.html (next: http://localhost:57687/tests/dromaeo/cssquery-jquery.html) 10:22:36 INFO - PROCESS | 4135 | RSS: Main: 238727168 10:22:36 INFO - PROCESS | 4135 | 10:25:39 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57687/tests/dromaeo/cssquery-mootools.html) 10:25:39 INFO - PROCESS | 4135 | RSS: Main: 188858368 10:25:39 INFO - PROCESS | 4135 | 10:28:41 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57687/tests/dromaeo/cssquery-prototype.html) 10:28:42 INFO - PROCESS | 4135 | RSS: Main: 188567552 10:28:42 INFO - PROCESS | 4135 | 10:31:45 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57687/tests/dromaeo/cssquery-yui.html) 10:31:46 INFO - PROCESS | 4135 | RSS: Main: 188198912 10:31:46 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:57687/tests/dromaeo/cssquery-yui.html (next: http://localhost:57687/tests/dromaeo/cssquery-dojo.html) 10:34:49 INFO - PROCESS | 4135 | RSS: Main: 281669632 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | __start_tp_report 10:34:49 INFO - PROCESS | 4135 | _x_x_mozilla_page_load 10:34:49 INFO - PROCESS | 4135 | _x_x_mozilla_page_load_details 10:34:49 INFO - PROCESS | 4135 | |i|pagename|runs| 10:34:49 INFO - PROCESS | 4135 | |0;dojo.html;2621;2622.6459427977215;2656.8405895646256;2664.440467501826;2668.519666460036;4564.931526027112;4678.508756580561;4702.059588082384;4750.90498190036;4816.7109973401575;4742.099001189771;4776.140294746944;4796.136695394836;4804.927926081103;4813.927791083137;4328.50222224445;4330.84842030529;4403.735775853459;4455.598996090352;4510.977445112786;4378.905273681596;4450.888727781815;4454.420925279725;4471.709338892962;4482;4238.258304796679;4273.29490634045;4274.444322238089;4321.524632290446;4410.779461026936;4354.716943398701;4365.301551751736;4375.124975005012;4378.277584198603;4425.203463376591;4408.669349798746;4412.602865742067;4417.779111044435;4442.267025940716;4457.130859482402;4606.447226332828;4611.746353950532;4795.160846851822;4812.663113582051;4865.927011094836;4967.304577359173;4997.075541024886;5004.599632029429;5041.747912604392;5056.064628043824;5021.59827213822;5037.823676171316;5069.873253168664;5072.847814565569;5082.822101226439;4655.348251244828;4743.810247590058;4760.119377915097;4762.928556071662;4794;5236.842894713165;5259.868503287448;5299.655522391032;5305.787768489217;5308.044551980681;5048.242763585418;5083.771230294646;5094.108531007059;5097.796088156432;5101.566366858784;4924.8030078797165;4998.175301075282;5023.2716256143385;5124.590032797368;5177.767000484987;5000.474950130257;5015.623828212899;5024.145895197825;5024.874378140503;5058.822941197041;4994.925076123861;4999.475055119233;5015.27278544609;5023;5053.7220452875445;4196.370544418301;4235.047114399297;4240.215560121387;4323.24343239938;4387.232234359039;3785.09157802131;3796.8291426885858;3832.8466861325232;3859.4403811447182;3915.980420097881;4345.760983145894;4346;4359.455068116486;4364.367166760802;4408.272635015251;5138.897222055538;5143.922841157386;5148.4851514848215;5151.5106064923775;5201.063808514504;4213.5154457237195;4276;4289.227938970953;4301.849435269751;4366.432363792686;4568.1548913451115;4587.036722288357;4587.220172570671;4588.311753236974;4633.050224703928;4743.0988112258565;4766.594839438687;4768.546988036131;4770.522947705202;4777.4983626718695;4910.533499317559;5002.149634562061;5012.824551140692;5095.0574143783515;5100.030994111107;4798.136335459511;4803.471618121934;4813.085513752376;4823.204171311694;4843.878903027453;5054.797808087782;5060.367454068241;5060.3927528696795;5068.366454193226;5069.695818250917;4984.252362145562;5026.195808670595;5092.363454568179;5101.617378696538;5183.170692689152;4982.800687972441;4984.7258400788305;4990.1516742154645;4995.850124496271;5038.647294689336;4979.825706100269;4984.42679091909;4996.550310472075;4997.525235102659;5016.623753218596;4741.620670346433;4799.064182484382;4804.8798780030775;4825.710457372569;4965.851024469272;4927.1131196384995;4938.530839570235;4946.925796112989;4948.752562371939;4953.281774142657;4819.277108433763;4824.807007719652;4835.226363781778;4871.902561948812;4883.243097319921 10:34:49 INFO - PROCESS | 4135 | |1;ext.html;573.3406582430205;573.5726883471813;577.2178697864397;584.4827327814883;585.7012923409061;28205.858970705143;31125.68874311259;31136.377272454538;31149.221269468217;38750;36613.633863661424;40386.59613403865;40443.59556404435;40466.39300410489;40468;7597.81005474862;7746.341560967325;7746.535207887517;7747.457677962517;7752.922470775276;7381.778546643609;7500.474966752302;7661.195574464685;7681.846363072736;7917.802054948615;9889.554970026365;10122.240831937597;10136.189104871593;10452.738681532946;10550.525226364833;9963.601455941754;10038.598456061749;10045.296829221958;10053.648122315757;10055.245856560787;9871.555779989918;9903.108720215216;9910.80178396428;9914.157296629795;9918.40489570628;38441.61558384437;38693;38703;38730;38731.22537549233;3238.0609623209243;3276.541284220211;3294.934101317984;3482.512448257246;3653.3971894637352;25913.870430647916;25989.610155847677;27057.594136087973;29288.26779330534;30550.54174187367;3371;3400.3199360128074;3431.1422144463886;3489.596590256882;3537.345591065661;250661;254356.99999999814;254541;254633;254664;51112.74443627832;51543.7422812891;51729;51737.22394164091;51806.222906655676;32294.35411291761;32725.83637081847;32824.67175328264;35565.62126597969;35578;14663.853361466463;14828.40686372533;14830.33263503145;14836.777448338284;14844.2577871106;10771.892281077246;11104;11124.33254004746;11128.109751219883;11129.554817807197;15528;15934.203289835461;15942.68114637724;18036.729449058275;18240.270389184283;5831;6797.694103765342;7027.332403421667;7200.927990720026;7208.56748595086;795.3756301303449;883.88067610873;895.4135041547796;903.837309284322;996.5515518016921;26825.463490730468;27824.44351113007;28007;28202.43595128127;28381.290467738472;942.6842007927421;985.7929834734642;998.8951160128082;1039.8284283093205;1074.2426589254558;14464;15100.924495377672;15120;15382.923085384726;15401.22993850303;373438;378102;378915;378916;378937;48509;48866.511334886905;48901;48941.265881011816;49022.50977490251;1127.881572434899;1177.181858608259;1187.281694574787;1190.0420161769857;1191.5472120594118;25999.870000649877;26941.46117077608;27508.285778364614;27562.310942226606;27751.861240693666;41816.3727544081;42153.78923105488;42229.57770422257;42305.78847105745;42349.78825105855;315627;319155;320254;320830;321378;22407.663885041413;22966.770332296463;24596.6310505339;25308;25747.742522574536;37367.81316093511;37413.2517349646;37466;38523.614763852005;41855.162896742506;35125.47311790376;35141.82429087838;35467.645323546436;35974.46038309375;36151.63848361483;35072;35249.64750352463;35962;36113.27773444569;36382;34869.12827179341;35436.291274173855;35770.28459430745;36109.458358124124;36539.81730091439;31087.844560777958;33259;33540.1614959628;33557;33729.325413492086;24640.753592463847;25334.87332563399;25594.118992906904;25695.87152064228;25951.870240648677 10:34:49 INFO - PROCESS | 4135 | |2;jquery.html;339.26549021368754;339.4568690095845;361.36941037888886;372.099519163624;375.7707798243073;12717.872821271785;17121;17853.285868565275;19096.236150553963;19370.418887433363;17523.813325482868;17934.192961316738;18256.81743182568;18299.54251143722;18427.631447371044;5084.745762711859;5277.8944421111555;5292.550133238679;5292.708901010462;5308.575313974892;3766;4934.235193545006;5137.51193636604;5194.480551944813;5199.740012999354;6065;6140.263168419796;6152.384761523835;6155;6168.568200225986;5974.910376344358;6029.944759667041;6127.6017058891475;6153.323134455206;6161.938380616181;5388.78444862205;5395.460453954613;5397.514223719884;5397.7031263280505;5399.892002159974;21357.78642213589;21403.35789926289;21978.230761923416;22069.668954965688;23167.76832231673;1928.9903550482297;2017.213286818142;2106.747190337154;2158.708574342475;2195.067096483988;14701.70596588073;14952.925235373754;15269.770953435707;15384;15529.223538823013;1875.634251320993;1902.02996471799;1918.5970946101336;1922.826945574905;1961.1763059515038;75498;77482.61258693671;77697.61151194264;79926;80838.19161808366;16588.58528536796;16796.832031679525;16895;17283.481495555152;17346.392876249272;29512.11463656094;29568.852155739085;29953.400931981676;30000.24999375033;30056.24859378533;8920.821583568422;9069.637214511346;9088.454692718458;9271.629134834531;9293.488858112734;7500.512466689648;7550.35821955129;7578.621068946531;7779.649915753805;7788.065432148179;8190.631421586043;8328.252286471112;8478.491290522465;8596.91403085961;8605.26855217301;3069.355435358555;3208.5828842250826;3235.8058516488613;3296.703296703297;3426.5716785401823;754.6528596845512;800.9679612815422;855.2217482091268;875.8554838451585;904.4980036080038;16708.74936875948;16806.327746889987;17122.315107395814;17621.295148193927;17693.469195924143;856.8243510080418;858.7209157023992;866.0862789756867;870.9433886797337;873.8208667223204;9537.189338906132;9898.257630677585;9950;9953.651622193189;10088.546015429323;389982;399585;402422;402716;404717;73591.26408735951;73860.63069684725;74475;74733.626331868;75345.62327188329;911.3483859040817;917.2661870503571;955.9569819358285;962.3648392061206;974.4007435427161;15762.842371576597;15866.365345386055;16360.590985225464;16480.505584832474;16517.752233716743;29628.111156665334;35185.47221791624;36473.45289820708;36554.13039474789;39846.60153398429;51973.7401312991;52704.47295526996;52763;54305.45694543162;54473.45526544842;7648.80877978055;7835.5690437026515;7941.245581669732;7959.243871832398;8037.879431808411;9463.716088517356;11187.776244475228;11276.041536469163;12036.819447708467;12341.876581234432;10462.68611941643;10604.628837990633;10872.955572439729;10949;11145.331280123219;9774.609015639295;9968.50157492137;10064.748381290527;10421.843672345072;10945;10473.947630262104;10679.252452328263;10754.677359679223;10942.562297508011;11131.109511239243;7475.783023825366;7524.247575242432;7776.805579860549;7849.450538462481;7888.802779930547;9153.405028673382;10603.526186755178;10711.678649640524;10763.51564179598;11024.306857202606 10:34:49 INFO - PROCESS | 4135 | |3;mootools.html;1249.212995812638;1385.9584212473624;1418.0144799364439;1474.9041312314698;1690.3069741406025;6238.407351301625;6715.059891615178;7398.297161769637;7672.232776722325;7688.807779805507;7473.701051957915;7539.623018849049;7540.057492813398;7543.8491230175505;7576.96211518943;2134.8505604607685;2160.168335190955;2160.2547121243147;2163.1888041984257;2163.621366260906;2059.6498595238845;2088.749350077993;2132.61612909677;2140.636091864379;2141.935741927745;2074.3776866939934;2094.61249668811;2101.159536185523;2103.842211834111;2139.6469582518866;2056.516718571135;2064.3910046536307;2066.5866826634656;2067.7415323084615;2069.1826728442334;2002.7496562929634;2075.284027010679;2078.8752674839557;2079.563291708743;2080.6774949882792;7448.329650331496;7598.468107232496;7602.809929751746;7618.390528757742;7621.23787621239;4442.2004039272915;4463.776811159429;4613.792379342937;4614.215583350839;4617.37665415168;2940.558916162571;2974.2267010577407;2982.2246215983782;2984.5373967035143;2987.074007057819;865.705660075571;873.9519326437044;896.0994200828192;908.1191244492832;911.2755359489156;9904.851427228525;9967.352122112039;10003.299769016172;10013.499325033792;10015.44915029673;3661.377565813818;3836.2519308735086;3859.710521710883;3887.047673320055;3894.1822217334675;7944.086430060502;7960.283574478209;7966.6415011324625;7967.123616402191;7976.960115199503;4368.847090351886;4380.299152135707;4381.737095774264;4387.6270517006415;4391.736495810262;3413.1637748751714;4083.8774836754947;4095.5290141634096;4103.712740108223;4256.531781504032;3288.917777055545;3300.224447254893;3405.4210784166753;3421.469672200813;3422.606400263952;938.4697645830084;942.4627962061696;951.3958636266021;958.7890664053897;963.205355581648;853.3130829682166;854.1245223645813;863.7365603490996;887.3877024852831;888.8266787976412;5245.501677340647;5304;5341.198820177005;5509.338879334506;5578.107502799614;834.6869923778584;850.7447765670274;867.4751775176054;896.9103089691109;902.9367944243971;3709.684676802502;3721.3673675475234;3834.424836274525;3843.942340864833;3888.319544079775;9003.819923601492;9329.30030247734;9332.95333523328;9341.06589341074;9349.018353072965;9238.67664631748;9239.676611318571;9247.953760231156;9248.722538323862;9267.814643707088;6996.965015174993;7073.398761105261;7077.893831592531;7083.185433675193;7087.645617719197;5015.648904576645;5048.848534543969;5154.407243166934;5177.559907407913;5309.946900530946;8094.433389662902;8272.131426200162;8379.329653627818;8380.455270407649;8410.537420441935;8147.348212142896;8421;8524.872126917977;8572.52851093196;8581.570921454027;6364.490840732823;6389.424951754364;6467.126937863328;6480.57876238043;6497.415232629086;6926.341997510229;7040.049593304839;7045.788626341218;7047.929520704933;7058.153021637231;6570.737170513126;6583.177102862142;6714.328567143247;6733.42765864907;6831.419329357061;6299.937000630119;6326.3041065483685;6390.137331460193;6437.388448097423;6508.8047358579315;5900.675462849585;6003;6006.48944839676;6014.729337179925;6016.518678505797;4533.909321813479;4572.542745725401;4575;4634.791434385394;4668.323093151542;4612.238980568303;4661.394018777537;4719.339292498984;4777.116233496814;4827.662063655651 10:34:49 INFO - PROCESS | 4135 | |4;prototype.html;279.5052756620781;283.7914133112162;287.97696184305255;288.8599029470708;290.3032721468477;4713.151632706115;4752.500987396325;4760.595349395297;4783.952160478394;4793.281007848825;4727.976360118195;4738.170820106485;4740.834070807522;4743;4745.383100196969;3484.902255789431;3578.6600272974024;3595.442706380515;3656.780593164419;3682.6317368263094;3671.5043469131724;3679.7056235501095;3690.870819521317;3694.538182727159;3700.5559332880093;3652.5251717276715;3655.9397774645454;3662.176010397666;3665.541807274091;3667.8716244931434;3496.1609213788633;3576.5886923003927;3685.63143685632;3708.5735140458924;3711.5917249102577;3250.7159671929458;3275.6560561140977;3279.7048265655967;3279.770416070876;3287.8684852605866;4596.563326483979;4605.34207685233;4609.308603709437;4619.260918253097;4643.840614114453;3941.467901833273;4144.564820693814;4186.0581369192;4191.580841915815;4192.979035104805;4965.428975667808;4970.527799859007;4975.427825800043;4978.788681300541;4979.526944940225;3486.9476957845654;3488.1977145256733;3491.4064609016527;3496.6328535503662;3496.807675577842;5033.823816166453;5213.139831927728;5241.947580524184;5247.317848679685;5247.921281180786;3532.275883443888;3565.322588708137;3569.928601427957;3571.017970058203;3578.6958108561066;3611.422172452395;3612.710983121344;3616.0959760059986;3617.077645200457;3617.602063772983;4160.646345060643;4167.937480937789;4174.540800511942;4175.394567787654;4183.49798024239;4861.475405817444;4904.6566740327835;4996.500349964975;5029.497050294941;5052.267421223902;1231.2981600487815;1237.7648246833073;1242.9502819887284;1243.0676992255808;1251.7920207000107;755.2183490087733;780.4965797060864;783.2480818414386;783.764870538836;791.7387262203574;4190.20386126635;4233.1322078973735;4346.891542656603;4360.672949528798;4362.738235705868;5118.129917913963;5123.769430375642;5131;5149.6910185389;5156.226566015128;4380.4305440292555;4387.714798538085;4393.582609652142;4393.978030109829;4396.582324679151;2617.790576753893;2693.46130773846;2707.4855777402627;2718.5242582547976;2731.7677997370447;4775.543459244964;4776.5701086902345;4778.566430070965;4782.784774685148;4805.903881922342;5214.478552144755;5229.294045303911;5235.712035837989;5250.794666240112;5257.4742525747115;4533.41330534317;4838.080764654705;4855.295982082649;4855.441624213261;4865.445641038483;5120.924605832668;5163.896722065613;5180.7150606717;5186.4035635902355;5187.403448603459;4915.4592994771265;5055.898882022266;5070.822521211888;5074.619403544675;5078.136716758234;4809;4809.2064809306075;4812.807487700593;4824.0834241494;4830.478399304208;3547.2795694088863;3586.677199052098;3594.892153235407;3597.1187059169624;3604.5494313210847;5160.845174644766;5168.3539557555305;5170.586353091669;5179.637425380338;5190.844274671766;4751.596114330182;4940.160172770566;4984.22744474607;4985.750712464434;4996.450390456974;4985.052839960396;4989.575886049726;5012.9723406700805;5021.221710634857;5021.49785021495;4947.554720075211;4948.802047918043;4950.430700469492;4952.653314268111;4961.355023846877;4785.95214047869;4834.734089625104;4915.139850526215;5014.84955451337;5043.646944713835;4857;4902.935665209244;4907.705537667752;4927.753612319441;4942.678725882806 10:34:49 INFO - PROCESS | 4135 | |5;yui.html;603.6436325492564;652.3574279334852;674.2313762310966;693.3586432549891;697.6999890047277;12884.67788305293;13978.650533736662;13981.510647127365;13985.580432587014;14030.088044277114;13263;13434.992375571846;13440.798388024188;13446.193228406302;13460.259685717307;624.1199908129515;750.1785544828405;750.182301291592;761.2615762710162;761.8514389694012;756.2324240895496;756.5687558091889;756.8410633766915;757.0650246945046;757.4508481351004;808.8746244332137;809.1301850510695;809.3242142810731;809.3323008517996;811.3347055414563;664.5746722097886;799.9680012799481;803.4897839871694;822.2271065198694;824.9793755156109;603.3694788945562;606.5269090109722;606.9059295809157;606.9180660610805;607.3592360060135;12592.74814503714;12678.049146314062;12696.80954785679;12707.682307942376;12761.680957976032;12402.875971240263;12929.159604625669;13034.674133146653;13206.66983325415;13594.11638243511;10179.89820101797;10445.373277603368;11332.376719280437;11348;11471.483783229774;4122.670186385082;4161.979190104061;4176.081262122329;4211.452511173558;4366.737995720267;61170;61237;62748.37251627471;63988.680056599886;64010;10015.799684006279;10132.138768204637;10168.745781355525;10247.333923294962;10601.946990265;18071.638567228583;18118.184681689356;18403.26386944534;18441.81558184428;18451.81548184528;6700.932990670129;6719.260881303053;6740.4270636995425;6767.864642707118;7024.5434046786795;3757.799907043858;3761.567419746709;3787.62123787619;3887.3197190492115;3943.191645712622;2760.489309477753;2852.458032973728;2869.6412948381453;2882.827030378184;2885.9134225973253;490.6540888673548;491.11354006018763;501.8569707633307;503.9244113383022;504.54590868218895;438.7608753229434;529.2246858352532;543.8993786149575;558.5001423725743;589.6108568344957;8166.877496837552;9522.428654280766;9631.951840240754;9765.316427849983;9885.752856178653;596.385722705614;618.3538202578317;631.3528633150966;639.923922357212;648.8410339466766;3887.5334959805004;4200.348945913388;4235.7670328131635;4245.532991370947;4365.4979677337515;104174;104257.47871260595;107554.46222768993;108145;108357.45821271001;75540.62229688816;89997;90111.54944225236;90650.54674726583;91685;49213.75393123083;59873.700631497435;78043;79659.60170199112;83820.58089709512;7801.921980780119;8157.06193787722;8198.877016844872;8292.253697167283;8342.457740246864;44112.77943610262;44575.10849782921;44858;45766.77116614395;45962.77018614885;51744;64817.35182648302;65894;66598.33401665921;66836;10175.643852465128;10180.79638407213;10403.94798026005;10440.843387349349;10538.525766340686;12155.331456769962;13170.802437963246;13179.538716144889;13496.392662330416;14285.857141428869;12556.560520381743;12565;12776.169548979658;13047.804282935575;13347.599572012856;11967.281963081894;12436.378181090728;13131.710327869487;13398.933005334911;13536.526221582197;11494.54021839117;11805.468753905923;13063.346832658139;13094.083414160918;13094.476220951055;9166.587503562489;9392.67125650599;9697.97921362868;9718.828234871717;10016.749581260527;10037.69886903394;10771.419475506349;10914.126869850552;10928;10983.83524247121 10:34:49 INFO - PROCESS | 4135 | __end_tp_report 10:34:49 INFO - PROCESS | 4135 | __start_cc_report 10:34:49 INFO - PROCESS | 4135 | _x_x_mozilla_cycle_collect,954 10:34:49 INFO - PROCESS | 4135 | __end_cc_report 10:34:49 INFO - PROCESS | 4135 | __startTimestamp1471023289730__endTimestamp 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | ------- Summary: start ------- 10:34:49 INFO - PROCESS | 4135 | Number of tests: 6 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#0] dojo.html Cycles:165 Average:4696.55 Median:4813.09 stddev:491.31 (10.2%) stddev-sans-first:465.05 10:34:49 INFO - PROCESS | 4135 | Values: 2621.0 2622.6 2656.8 2664.4 2668.5 4564.9 4678.5 4702.1 4750.9 4816.7 4742.1 4776.1 4796.1 4804.9 4813.9 4328.5 4330.8 4403.7 4455.6 4511.0 4378.9 4450.9 4454.4 4471.7 4482.0 4238.3 4273.3 4274.4 4321.5 4410.8 4354.7 4365.3 4375.1 4378.3 4425.2 4408.7 4412.6 4417.8 4442.3 4457.1 4606.4 4611.7 4795.2 4812.7 4865.9 4967.3 4997.1 5004.6 5041.7 5056.1 5021.6 5037.8 5069.9 5072.8 5082.8 4655.3 4743.8 4760.1 4762.9 4794.0 5236.8 5259.9 5299.7 5305.8 5308.0 5048.2 5083.8 5094.1 5097.8 5101.6 4924.8 4998.2 5023.3 5124.6 5177.8 5000.5 5015.6 5024.1 5024.9 5058.8 4994.9 4999.5 5015.3 5023.0 5053.7 4196.4 4235.0 4240.2 4323.2 4387.2 3785.1 3796.8 3832.8 3859.4 3916.0 4345.8 4346.0 4359.5 4364.4 4408.3 5138.9 5143.9 5148.5 5151.5 5201.1 4213.5 4276.0 4289.2 4301.8 4366.4 4568.2 4587.0 4587.2 4588.3 4633.1 4743.1 4766.6 4768.5 4770.5 4777.5 4910.5 5002.1 5012.8 5095.1 5100.0 4798.1 4803.5 4813.1 4823.2 4843.9 5054.8 5060.4 5060.4 5068.4 5069.7 4984.3 5026.2 5092.4 5101.6 5183.2 4982.8 4984.7 4990.2 4995.9 5038.6 4979.8 4984.4 4996.6 4997.5 5016.6 4741.6 4799.1 4804.9 4825.7 4965.9 4927.1 4938.5 4946.9 4948.8 4953.3 4819.3 4824.8 4835.2 4871.9 4883.2 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#1] ext.html Cycles:180 Average:46367.64 Median:19280.80 stddev:84404.03 (437.8%) stddev-sans-first:84570.77 10:34:49 INFO - PROCESS | 4135 | Values: 573.3 573.6 577.2 584.5 585.7 28205.9 31125.7 31136.4 31149.2 38750.0 36613.6 40386.6 40443.6 40466.4 40468.0 7597.8 7746.3 7746.5 7747.5 7752.9 7381.8 7500.5 7661.2 7681.8 7917.8 9889.6 10122.2 10136.2 10452.7 10550.5 9963.6 10038.6 10045.3 10053.6 10055.2 9871.6 9903.1 9910.8 9914.2 9918.4 38441.6 38693.0 38703.0 38730.0 38731.2 3238.1 3276.5 3294.9 3482.5 3653.4 25913.9 25989.6 27057.6 29288.3 30550.5 3371.0 3400.3 3431.1 3489.6 3537.3 250661.0 254357.0 254541.0 254633.0 254664.0 51112.7 51543.7 51729.0 51737.2 51806.2 32294.4 32725.8 32824.7 35565.6 35578.0 14663.9 14828.4 14830.3 14836.8 14844.3 10771.9 11104.0 11124.3 11128.1 11129.6 15528.0 15934.2 15942.7 18036.7 18240.3 5831.0 6797.7 7027.3 7200.9 7208.6 795.4 883.9 895.4 903.8 996.6 26825.5 27824.4 28007.0 28202.4 28381.3 942.7 985.8 998.9 1039.8 1074.2 14464.0 15100.9 15120.0 15382.9 15401.2 373438.0 378102.0 378915.0 378916.0 378937.0 48509.0 48866.5 48901.0 48941.3 49022.5 1127.9 1177.2 1187.3 1190.0 1191.5 25999.9 26941.5 27508.3 27562.3 27751.9 41816.4 42153.8 42229.6 42305.8 42349.8 315627.0 319155.0 320254.0 320830.0 321378.0 22407.7 22966.8 24596.6 25308.0 25747.7 37367.8 37413.3 37466.0 38523.6 41855.2 35125.5 35141.8 35467.6 35974.5 36151.6 35072.0 35249.6 35962.0 36113.3 36382.0 34869.1 35436.3 35770.3 36109.5 36539.8 31087.8 33259.0 33540.2 33557.0 33729.3 24640.8 25334.9 25594.1 25695.9 25951.9 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#2] jquery.html Cycles:180 Average:26006.35 Median:402569.00 stddev:65933.34 (16.4%) stddev-sans-first:66090.14 10:34:49 INFO - PROCESS | 4135 | Values: 339.3 339.5 361.4 372.1 375.8 12717.9 17121.0 17853.3 19096.2 19370.4 17523.8 17934.2 18256.8 18299.5 18427.6 5084.7 5277.9 5292.6 5292.7 5308.6 3766.0 4934.2 5137.5 5194.5 5199.7 6065.0 6140.3 6152.4 6155.0 6168.6 5974.9 6029.9 6127.6 6153.3 6161.9 5388.8 5395.5 5397.5 5397.7 5399.9 21357.8 21403.4 21978.2 22069.7 23167.8 1929.0 2017.2 2106.7 2158.7 2195.1 14701.7 14952.9 15269.8 15384.0 15529.2 1875.6 1902.0 1918.6 1922.8 1961.2 75498.0 77482.6 77697.6 79926.0 80838.2 16588.6 16796.8 16895.0 17283.5 17346.4 29512.1 29568.9 29953.4 30000.2 30056.2 8920.8 9069.6 9088.5 9271.6 9293.5 7500.5 7550.4 7578.6 7779.6 7788.1 8190.6 8328.3 8478.5 8596.9 8605.3 3069.4 3208.6 3235.8 3296.7 3426.6 754.7 801.0 855.2 875.9 904.5 16708.7 16806.3 17122.3 17621.3 17693.5 856.8 858.7 866.1 870.9 873.8 9537.2 9898.3 9950.0 9953.7 10088.5 389982.0 399585.0 402422.0 402716.0 404717.0 73591.3 73860.6 74475.0 74733.6 75345.6 911.3 917.3 956.0 962.4 974.4 15762.8 15866.4 16360.6 16480.5 16517.8 29628.1 35185.5 36473.5 36554.1 39846.6 51973.7 52704.5 52763.0 54305.5 54473.5 7648.8 7835.6 7941.2 7959.2 8037.9 9463.7 11187.8 11276.0 12036.8 12341.9 10462.7 10604.6 10873.0 10949.0 11145.3 9774.6 9968.5 10064.7 10421.8 10945.0 10473.9 10679.3 10754.7 10942.6 11131.1 7475.8 7524.2 7776.8 7849.5 7888.8 9153.4 10603.5 10711.7 10763.5 11024.3 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#3] mootools.html Cycles:180 Average:4926.15 Median:6010.61 stddev:2698.34 (44.9%) stddev-sans-first:2691.76 10:34:49 INFO - PROCESS | 4135 | Values: 1249.2 1386.0 1418.0 1474.9 1690.3 6238.4 6715.1 7398.3 7672.2 7688.8 7473.7 7539.6 7540.1 7543.8 7577.0 2134.9 2160.2 2160.3 2163.2 2163.6 2059.6 2088.7 2132.6 2140.6 2141.9 2074.4 2094.6 2101.2 2103.8 2139.6 2056.5 2064.4 2066.6 2067.7 2069.2 2002.7 2075.3 2078.9 2079.6 2080.7 7448.3 7598.5 7602.8 7618.4 7621.2 4442.2 4463.8 4613.8 4614.2 4617.4 2940.6 2974.2 2982.2 2984.5 2987.1 865.7 874.0 896.1 908.1 911.3 9904.9 9967.4 10003.3 10013.5 10015.4 3661.4 3836.3 3859.7 3887.0 3894.2 7944.1 7960.3 7966.6 7967.1 7977.0 4368.8 4380.3 4381.7 4387.6 4391.7 3413.2 4083.9 4095.5 4103.7 4256.5 3288.9 3300.2 3405.4 3421.5 3422.6 938.5 942.5 951.4 958.8 963.2 853.3 854.1 863.7 887.4 888.8 5245.5 5304.0 5341.2 5509.3 5578.1 834.7 850.7 867.5 896.9 902.9 3709.7 3721.4 3834.4 3843.9 3888.3 9003.8 9329.3 9333.0 9341.1 9349.0 9238.7 9239.7 9248.0 9248.7 9267.8 6997.0 7073.4 7077.9 7083.2 7087.6 5015.6 5048.8 5154.4 5177.6 5309.9 8094.4 8272.1 8379.3 8380.5 8410.5 8147.3 8421.0 8524.9 8572.5 8581.6 6364.5 6389.4 6467.1 6480.6 6497.4 6926.3 7040.0 7045.8 7047.9 7058.2 6570.7 6583.2 6714.3 6733.4 6831.4 6299.9 6326.3 6390.1 6437.4 6508.8 5900.7 6003.0 6006.5 6014.7 6016.5 4533.9 4572.5 4575.0 4634.8 4668.3 4612.2 4661.4 4719.3 4777.1 4827.7 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#4] prototype.html Cycles:180 Average:4117.32 Median:4744.19 stddev:1216.60 (25.6%) stddev-sans-first:1185.42 10:34:49 INFO - PROCESS | 4135 | Values: 279.5 283.8 288.0 288.9 290.3 4713.2 4752.5 4760.6 4784.0 4793.3 4728.0 4738.2 4740.8 4743.0 4745.4 3484.9 3578.7 3595.4 3656.8 3682.6 3671.5 3679.7 3690.9 3694.5 3700.6 3652.5 3655.9 3662.2 3665.5 3667.9 3496.2 3576.6 3685.6 3708.6 3711.6 3250.7 3275.7 3279.7 3279.8 3287.9 4596.6 4605.3 4609.3 4619.3 4643.8 3941.5 4144.6 4186.1 4191.6 4193.0 4965.4 4970.5 4975.4 4978.8 4979.5 3486.9 3488.2 3491.4 3496.6 3496.8 5033.8 5213.1 5241.9 5247.3 5247.9 3532.3 3565.3 3569.9 3571.0 3578.7 3611.4 3612.7 3616.1 3617.1 3617.6 4160.6 4167.9 4174.5 4175.4 4183.5 4861.5 4904.7 4996.5 5029.5 5052.3 1231.3 1237.8 1243.0 1243.1 1251.8 755.2 780.5 783.2 783.8 791.7 4190.2 4233.1 4346.9 4360.7 4362.7 5118.1 5123.8 5131.0 5149.7 5156.2 4380.4 4387.7 4393.6 4394.0 4396.6 2617.8 2693.5 2707.5 2718.5 2731.8 4775.5 4776.6 4778.6 4782.8 4805.9 5214.5 5229.3 5235.7 5250.8 5257.5 4533.4 4838.1 4855.3 4855.4 4865.4 5120.9 5163.9 5180.7 5186.4 5187.4 4915.5 5055.9 5070.8 5074.6 5078.1 4809.0 4809.2 4812.8 4824.1 4830.5 3547.3 3586.7 3594.9 3597.1 3604.5 5160.8 5168.4 5170.6 5179.6 5190.8 4751.6 4940.2 4984.2 4985.8 4996.5 4985.1 4989.6 5013.0 5021.2 5021.5 4947.6 4948.8 4950.4 4952.7 4961.4 4786.0 4834.7 4915.1 5014.8 5043.6 4857.0 4902.9 4907.7 4927.8 4942.7 10:34:49 INFO - PROCESS | 4135 | 10:34:49 INFO - PROCESS | 4135 | [#5] yui.html Cycles:180 Average:18196.83 Median:2402.75 stddev:26273.03 (1093.5%) stddev-sans-first:26313.52 10:34:49 INFO - PROCESS | 4135 | Values: 603.6 652.4 674.2 693.4 697.7 12884.7 13978.7 13981.5 13985.6 14030.1 13263.0 13435.0 13440.8 13446.2 13460.3 624.1 750.2 750.2 761.3 761.9 756.2 756.6 756.8 757.1 757.5 808.9 809.1 809.3 809.3 811.3 664.6 800.0 803.5 822.2 825.0 603.4 606.5 606.9 606.9 607.4 12592.7 12678.0 12696.8 12707.7 12761.7 12402.9 12929.2 13034.7 13206.7 13594.1 10179.9 10445.4 11332.4 11348.0 11471.5 4122.7 4162.0 4176.1 4211.5 4366.7 61170.0 61237.0 62748.4 63988.7 64010.0 10015.8 10132.1 10168.7 10247.3 10601.9 18071.6 18118.2 18403.3 18441.8 18451.8 6700.9 6719.3 6740.4 6767.9 7024.5 3757.8 3761.6 3787.6 3887.3 3943.2 2760.5 2852.5 2869.6 2882.8 2885.9 490.7 491.1 501.9 503.9 504.5 438.8 529.2 543.9 558.5 589.6 8166.9 9522.4 9632.0 9765.3 9885.8 596.4 618.4 631.4 639.9 648.8 3887.5 4200.3 4235.8 4245.5 4365.5 104174.0 104257.5 107554.5 108145.0 108357.5 75540.6 89997.0 90111.5 90650.5 91685.0 49213.8 59873.7 78043.0 79659.6 83820.6 7801.9 8157.1 8198.9 8292.3 8342.5 44112.8 44575.1 44858.0 45766.8 45962.8 51744.0 64817.4 65894.0 66598.3 66836.0 10175.6 10180.8 10403.9 10440.8 10538.5 12155.3 13170.8 13179.5 13496.4 14285.9 12556.6 12565.0 12776.2 13047.8 13347.6 11967.3 12436.4 13131.7 13398.9 13536.5 11494.5 11805.5 13063.3 13094.1 13094.5 9166.6 9392.7 9698.0 9718.8 10016.7 10037.7 10771.4 10914.1 10928.0 10983.8 10:34:49 INFO - PROCESS | 4135 | -------- Summary: end -------- 10:34:49 INFO - PROCESS | 4135 | 10:34:50 INFO - TEST-INFO | 4135: exit 0 10:34:50 INFO - TEST-OK | dromaeo_css | took 1119929ms 10:34:50 INFO - TEST-START | kraken 10:34:50 INFO - operating with platform_type : linux_ 10:34:50 INFO - Initialising browser for kraken test... 10:34:50 INFO - TEST-INFO | started process 4439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYbxsK/profile http://localhost:57687/getInfo.html) 10:34:54 INFO - PROCESS | 4439 | __metrics Screen width/height:1600/1200 10:34:54 INFO - PROCESS | 4439 | colorDepth:24 10:34:54 INFO - PROCESS | 4439 | Browser inner width/height: 1024/697 10:34:54 INFO - PROCESS | 4439 | __metrics 10:34:55 INFO - PROCESS | 4439 | 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:34:55 INFO - PROCESS | 4439 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:56 INFO - TEST-INFO | 4439: exit 0 10:34:56 INFO - Browser initialized. 10:34:56 INFO - Running cycle 1/1 for kraken test... 10:34:56 INFO - TEST-INFO | started process 4518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYbxsK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:08 INFO - PROCESS | 4518 | RSS: Main: 157024256 10:35:08 INFO - PROCESS | 4518 | 10:35:11 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57687/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:12 INFO - PROCESS | 4518 | RSS: Main: 212701184 10:35:12 INFO - PROCESS | 4518 | 10:35:14 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57687/tests/kraken/driver.html?testName=audio-dft) 10:35:15 INFO - PROCESS | 4518 | RSS: Main: 191537152 10:35:15 INFO - PROCESS | 4518 | 10:35:18 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57687/tests/kraken/driver.html?testName=audio-fft) 10:35:19 INFO - PROCESS | 4518 | RSS: Main: 271806464 10:35:19 INFO - PROCESS | 4518 | 10:35:21 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57687/tests/kraken/driver.html?testName=audio-oscillator) 10:35:22 INFO - PROCESS | 4518 | RSS: Main: 178872320 10:35:22 INFO - PROCESS | 4518 | 10:35:24 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:25 INFO - PROCESS | 4518 | RSS: Main: 183603200 10:35:25 INFO - PROCESS | 4518 | 10:35:28 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57687/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:28 INFO - PROCESS | 4518 | RSS: Main: 219926528 10:35:28 INFO - PROCESS | 4518 | 10:35:32 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57687/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:32 INFO - PROCESS | 4518 | RSS: Main: 213893120 10:35:32 INFO - PROCESS | 4518 | 10:35:35 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57687/tests/kraken/driver.html?testName=json-parse-financial) 10:35:36 INFO - PROCESS | 4518 | RSS: Main: 217698304 10:35:36 INFO - PROCESS | 4518 | 10:35:38 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:38 INFO - PROCESS | 4518 | RSS: Main: 182972416 10:35:38 INFO - PROCESS | 4518 | 10:35:40 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:41 INFO - PROCESS | 4518 | RSS: Main: 190554112 10:35:41 INFO - PROCESS | 4518 | 10:35:43 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:44 INFO - PROCESS | 4518 | RSS: Main: 193298432 10:35:44 INFO - PROCESS | 4518 | 10:35:46 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:47 INFO - PROCESS | 4518 | RSS: Main: 188014592 10:35:47 INFO - PROCESS | 4518 | 10:35:50 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:51 INFO - PROCESS | 4518 | RSS: Main: 191737856 10:35:51 INFO - PROCESS | 4518 | 10:35:52 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:57687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57687/tests/kraken/driver.html?testName=ai-astar) 10:35:53 INFO - PROCESS | 4518 | RSS: Main: 241881088 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | __start_tp_report 10:35:53 INFO - PROCESS | 4518 | _x_x_mozilla_page_load 10:35:53 INFO - PROCESS | 4518 | _x_x_mozilla_page_load_details 10:35:53 INFO - PROCESS | 4518 | |i|pagename|runs| 10:35:53 INFO - PROCESS | 4518 | |0;ai-astar;103;114;113;114;115;113;113;114;114;113 10:35:53 INFO - PROCESS | 4518 | |1;audio-beat-detection;149;123;123;181;129;129;146;128;160;123 10:35:53 INFO - PROCESS | 4518 | |2;audio-dft;160;160;161;160;162;160;161;160;161;160 10:35:53 INFO - PROCESS | 4518 | |3;audio-fft;75;76;75;112;75;77;75;76;110;76 10:35:53 INFO - PROCESS | 4518 | |4;audio-oscillator;87;85;130;85;86;85;112;85;85;129 10:35:53 INFO - PROCESS | 4518 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 10:35:53 INFO - PROCESS | 4518 | |6;imaging-darkroom;147;146;146;146;145;146;147;147;146;146 10:35:53 INFO - PROCESS | 4518 | |7;imaging-desaturate;95;95;95;95;95;96;95;94;95;95 10:35:53 INFO - PROCESS | 4518 | |8;json-parse-financial;65;63;62;63;63;63;63;62;63;62 10:35:53 INFO - PROCESS | 4518 | |9;json-stringify-tinderbox;66;66;65;66;65;66;66;66;66;66 10:35:53 INFO - PROCESS | 4518 | |10;stanford-crypto-aes;89;82;80;79;81;79;90;78;78;79 10:35:53 INFO - PROCESS | 4518 | |11;stanford-crypto-ccm;139;134;138;130;144;130;131;138;151;144 10:35:53 INFO - PROCESS | 4518 | |12;stanford-crypto-pbkdf2;168;168;166;168;170;168;169;166;168;168 10:35:53 INFO - PROCESS | 4518 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;66;66;66;67;67 10:35:53 INFO - PROCESS | 4518 | __end_tp_report 10:35:53 INFO - PROCESS | 4518 | __start_cc_report 10:35:53 INFO - PROCESS | 4518 | _x_x_mozilla_cycle_collect,1935 10:35:53 INFO - PROCESS | 4518 | __end_cc_report 10:35:53 INFO - PROCESS | 4518 | __startTimestamp1471023353038__endTimestamp 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | ------- Summary: start ------- 10:35:53 INFO - PROCESS | 4518 | Number of tests: 14 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.44 (3.0%) stddev-sans-first:0.71 10:35:53 INFO - PROCESS | 4518 | Values: 103.0 114.0 113.0 114.0 115.0 113.0 113.0 114.0 114.0 113.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:137.50 stddev:19.56 (14.2%) stddev-sans-first:20.41 10:35:53 INFO - PROCESS | 4518 | Values: 149.0 123.0 123.0 181.0 129.0 129.0 146.0 128.0 160.0 123.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 10:35:53 INFO - PROCESS | 4518 | Values: 160.0 160.0 161.0 160.0 162.0 160.0 161.0 160.0 161.0 160.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:14.94 (19.8%) stddev-sans-first:15.58 10:35:53 INFO - PROCESS | 4518 | Values: 75.0 76.0 75.0 112.0 75.0 77.0 75.0 76.0 110.0 76.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.09 (22.5%) stddev-sans-first:19.91 10:35:53 INFO - PROCESS | 4518 | Values: 87.0 85.0 130.0 85.0 86.0 85.0 112.0 85.0 85.0 129.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:35:53 INFO - PROCESS | 4518 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:35:53 INFO - PROCESS | 4518 | Values: 147.0 146.0 146.0 146.0 145.0 146.0 147.0 147.0 146.0 146.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:35:53 INFO - PROCESS | 4518 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.50 10:35:53 INFO - PROCESS | 4518 | Values: 65.0 63.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 62.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 10:35:53 INFO - PROCESS | 4518 | Values: 66.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.50 stddev:4.40 (5.5%) stddev-sans-first:3.74 10:35:53 INFO - PROCESS | 4518 | Values: 89.0 82.0 80.0 79.0 81.0 79.0 90.0 78.0 78.0 79.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.50 stddev:6.95 (5.0%) stddev-sans-first:7.36 10:35:53 INFO - PROCESS | 4518 | Values: 139.0 134.0 138.0 130.0 144.0 130.0 131.0 138.0 151.0 144.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 10:35:53 INFO - PROCESS | 4518 | Values: 168.0 168.0 166.0 168.0 170.0 168.0 169.0 166.0 168.0 168.0 10:35:53 INFO - PROCESS | 4518 | 10:35:53 INFO - PROCESS | 4518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 10:35:53 INFO - PROCESS | 4518 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 10:35:53 INFO - PROCESS | 4518 | -------- Summary: end -------- 10:35:53 INFO - PROCESS | 4518 | 10:35:54 INFO - TEST-INFO | 4518: exit 0 10:35:54 INFO - TEST-OK | kraken | took 63611ms 10:35:54 INFO - SUITE-END | took 1183s 10:35:54 INFO - Completed test suite (00:19:43) 10:35:54 INFO - javascript benchmark 10:35:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.0, 2622.6459427977215, 2656.8405895646256, 2664.440467501826, 2668.519666460036, 4564.931526027112, 4678.508756580561, 4702.059588082384, 4750.90498190036, 4816.7109973401575, 4742.099001189771, 4776.140294746944, 4796.136695394836, 4804.927926081103, 4813.927791083137, 4328.50222224445, 4330.84842030529, 4403.735775853459, 4455.598996090352, 4510.977445112786, 4378.905273681596, 4450.888727781815, 4454.420925279725, 4471.709338892962, 4482.0, 4238.258304796679, 4273.29490634045, 4274.444322238089, 4321.524632290446, 4410.779461026936, 4354.716943398701, 4365.301551751736, 4375.124975005012, 4378.277584198603, 4425.203463376591, 4408.669349798746, 4412.602865742067, 4417.779111044435, 4442.267025940716, 4457.130859482402, 4606.447226332828, 4611.746353950532, 4795.160846851822, 4812.663113582051, 4865.927011094836, 4967.304577359173, 4997.075541024886, 5004.599632029429, 5041.747912604392, 5056.064628043824, 5021.59827213822, 5037.823676171316, 5069.873253168664, 5072.847814565569, 5082.822101226439, 4655.348251244828, 4743.810247590058, 4760.119377915097, 4762.928556071662, 4794.0, 5236.842894713165, 5259.868503287448, 5299.655522391032, 5305.787768489217, 5308.044551980681, 5048.242763585418, 5083.771230294646, 5094.108531007059, 5097.796088156432, 5101.566366858784, 4924.8030078797165, 4998.175301075282, 5023.2716256143385, 5124.590032797368, 5177.767000484987, 5000.474950130257, 5015.623828212899, 5024.145895197825, 5024.874378140503, 5058.822941197041, 4994.925076123861, 4999.475055119233, 5015.27278544609, 5023.0, 5053.7220452875445, 4196.370544418301, 4235.047114399297, 4240.215560121387, 4323.24343239938, 4387.232234359039, 3785.09157802131, 3796.8291426885858, 3832.8466861325232, 3859.4403811447182, 3915.980420097881, 4345.760983145894, 4346.0, 4359.455068116486, 4364.367166760802, 4408.272635015251, 5138.897222055538, 5143.922841157386, 5148.4851514848215, 5151.5106064923775, 5201.063808514504, 4213.5154457237195, 4276.0, 4289.227938970953, 4301.849435269751, 4366.432363792686, 4568.1548913451115, 4587.036722288357, 4587.220172570671, 4588.311753236974, 4633.050224703928, 4743.0988112258565, 4766.594839438687, 4768.546988036131, 4770.522947705202, 4777.4983626718695, 4910.533499317559, 5002.149634562061, 5012.824551140692, 5095.0574143783515, 5100.030994111107, 4798.136335459511, 4803.471618121934, 4813.085513752376, 4823.204171311694, 4843.878903027453, 5054.797808087782, 5060.367454068241, 5060.3927528696795, 5068.366454193226, 5069.695818250917, 4984.252362145562, 5026.195808670595, 5092.363454568179, 5101.617378696538, 5183.170692689152, 4982.800687972441, 4984.7258400788305, 4990.1516742154645, 4995.850124496271, 5038.647294689336, 4979.825706100269, 4984.42679091909, 4996.550310472075, 4997.525235102659, 5016.623753218596, 4741.620670346433, 4799.064182484382, 4804.8798780030775, 4825.710457372569, 4965.851024469272, 4927.1131196384995, 4938.530839570235, 4946.925796112989, 4948.752562371939, 4953.281774142657, 4819.277108433763, 4824.807007719652, 4835.226363781778, 4871.902561948812, 4883.243097319921], "value": 4665.238691701967, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3406582430205, 573.5726883471813, 577.2178697864397, 584.4827327814883, 585.7012923409061, 28205.858970705143, 31125.68874311259, 31136.377272454538, 31149.221269468217, 38750.0, 36613.633863661424, 40386.59613403865, 40443.59556404435, 40466.39300410489, 40468.0, 7597.81005474862, 7746.341560967325, 7746.535207887517, 7747.457677962517, 7752.922470775276, 7381.778546643609, 7500.474966752302, 7661.195574464685, 7681.846363072736, 7917.802054948615, 9889.554970026365, 10122.240831937597, 10136.189104871593, 10452.738681532946, 10550.525226364833, 9963.601455941754, 10038.598456061749, 10045.296829221958, 10053.648122315757, 10055.245856560787, 9871.555779989918, 9903.108720215216, 9910.80178396428, 9914.157296629795, 9918.40489570628, 38441.61558384437, 38693.0, 38703.0, 38730.0, 38731.22537549233, 3238.0609623209243, 3276.541284220211, 3294.934101317984, 3482.512448257246, 3653.3971894637352, 25913.870430647916, 25989.610155847677, 27057.594136087973, 29288.26779330534, 30550.54174187367, 3371.0, 3400.3199360128074, 3431.1422144463886, 3489.596590256882, 3537.345591065661, 250661.0, 254356.99999999814, 254541.0, 254633.0, 254664.0, 51112.74443627832, 51543.7422812891, 51729.0, 51737.22394164091, 51806.222906655676, 32294.35411291761, 32725.83637081847, 32824.67175328264, 35565.62126597969, 35578.0, 14663.853361466463, 14828.40686372533, 14830.33263503145, 14836.777448338284, 14844.2577871106, 10771.892281077246, 11104.0, 11124.33254004746, 11128.109751219883, 11129.554817807197, 15528.0, 15934.203289835461, 15942.68114637724, 18036.729449058275, 18240.270389184283, 5831.0, 6797.694103765342, 7027.332403421667, 7200.927990720026, 7208.56748595086, 795.3756301303449, 883.88067610873, 895.4135041547796, 903.837309284322, 996.5515518016921, 26825.463490730468, 27824.44351113007, 28007.0, 28202.43595128127, 28381.290467738472, 942.6842007927421, 985.7929834734642, 998.8951160128082, 1039.8284283093205, 1074.2426589254558, 14464.0, 15100.924495377672, 15120.0, 15382.923085384726, 15401.22993850303, 373438.0, 378102.0, 378915.0, 378916.0, 378937.0, 48509.0, 48866.511334886905, 48901.0, 48941.265881011816, 49022.50977490251, 1127.881572434899, 1177.181858608259, 1187.281694574787, 1190.0420161769857, 1191.5472120594118, 25999.870000649877, 26941.46117077608, 27508.285778364614, 27562.310942226606, 27751.861240693666, 41816.3727544081, 42153.78923105488, 42229.57770422257, 42305.78847105745, 42349.78825105855, 315627.0, 319155.0, 320254.0, 320830.0, 321378.0, 22407.663885041413, 22966.770332296463, 24596.6310505339, 25308.0, 25747.742522574536, 37367.81316093511, 37413.2517349646, 37466.0, 38523.614763852005, 41855.162896742506, 35125.47311790376, 35141.82429087838, 35467.645323546436, 35974.46038309375, 36151.63848361483, 35072.0, 35249.64750352463, 35962.0, 36113.27773444569, 36382.0, 34869.12827179341, 35436.291274173855, 35770.28459430745, 36109.458358124124, 36539.81730091439, 31087.844560777958, 33259.0, 33540.1614959628, 33557.0, 33729.325413492086, 24640.753592463847, 25334.87332563399, 25594.118992906904, 25695.87152064228, 25951.870240648677], "value": 17434.72873818409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.26549021368754, 339.4568690095845, 361.36941037888886, 372.099519163624, 375.7707798243073, 12717.872821271785, 17121.0, 17853.285868565275, 19096.236150553963, 19370.418887433363, 17523.813325482868, 17934.192961316738, 18256.81743182568, 18299.54251143722, 18427.631447371044, 5084.745762711859, 5277.8944421111555, 5292.550133238679, 5292.708901010462, 5308.575313974892, 3766.0, 4934.235193545006, 5137.51193636604, 5194.480551944813, 5199.740012999354, 6065.0, 6140.263168419796, 6152.384761523835, 6155.0, 6168.568200225986, 5974.910376344358, 6029.944759667041, 6127.6017058891475, 6153.323134455206, 6161.938380616181, 5388.78444862205, 5395.460453954613, 5397.514223719884, 5397.7031263280505, 5399.892002159974, 21357.78642213589, 21403.35789926289, 21978.230761923416, 22069.668954965688, 23167.76832231673, 1928.9903550482297, 2017.213286818142, 2106.747190337154, 2158.708574342475, 2195.067096483988, 14701.70596588073, 14952.925235373754, 15269.770953435707, 15384.0, 15529.223538823013, 1875.634251320993, 1902.02996471799, 1918.5970946101336, 1922.826945574905, 1961.1763059515038, 75498.0, 77482.61258693671, 77697.61151194264, 79926.0, 80838.19161808366, 16588.58528536796, 16796.832031679525, 16895.0, 17283.481495555152, 17346.392876249272, 29512.11463656094, 29568.852155739085, 29953.400931981676, 30000.24999375033, 30056.24859378533, 8920.821583568422, 9069.637214511346, 9088.454692718458, 9271.629134834531, 9293.488858112734, 7500.512466689648, 7550.35821955129, 7578.621068946531, 7779.649915753805, 7788.065432148179, 8190.631421586043, 8328.252286471112, 8478.491290522465, 8596.91403085961, 8605.26855217301, 3069.355435358555, 3208.5828842250826, 3235.8058516488613, 3296.703296703297, 3426.5716785401823, 754.6528596845512, 800.9679612815422, 855.2217482091268, 875.8554838451585, 904.4980036080038, 16708.74936875948, 16806.327746889987, 17122.315107395814, 17621.295148193927, 17693.469195924143, 856.8243510080418, 858.7209157023992, 866.0862789756867, 870.9433886797337, 873.8208667223204, 9537.189338906132, 9898.257630677585, 9950.0, 9953.651622193189, 10088.546015429323, 389982.0, 399585.0, 402422.0, 402716.0, 404717.0, 73591.26408735951, 73860.63069684725, 74475.0, 74733.626331868, 75345.62327188329, 911.3483859040817, 917.2661870503571, 955.9569819358285, 962.3648392061206, 974.4007435427161, 15762.842371576597, 15866.365345386055, 16360.590985225464, 16480.505584832474, 16517.752233716743, 29628.111156665334, 35185.47221791624, 36473.45289820708, 36554.13039474789, 39846.60153398429, 51973.7401312991, 52704.47295526996, 52763.0, 54305.45694543162, 54473.45526544842, 7648.80877978055, 7835.5690437026515, 7941.245581669732, 7959.243871832398, 8037.879431808411, 9463.716088517356, 11187.776244475228, 11276.041536469163, 12036.819447708467, 12341.876581234432, 10462.68611941643, 10604.628837990633, 10872.955572439729, 10949.0, 11145.331280123219, 9774.609015639295, 9968.50157492137, 10064.748381290527, 10421.843672345072, 10945.0, 10473.947630262104, 10679.252452328263, 10754.677359679223, 10942.562297508011, 11131.109511239243, 7475.783023825366, 7524.247575242432, 7776.805579860549, 7849.450538462481, 7888.802779930547, 9153.405028673382, 10603.526186755178, 10711.678649640524, 10763.51564179598, 11024.306857202606], "value": 9214.303769581278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.212995812638, 1385.9584212473624, 1418.0144799364439, 1474.9041312314698, 1690.3069741406025, 6238.407351301625, 6715.059891615178, 7398.297161769637, 7672.232776722325, 7688.807779805507, 7473.701051957915, 7539.623018849049, 7540.057492813398, 7543.8491230175505, 7576.96211518943, 2134.8505604607685, 2160.168335190955, 2160.2547121243147, 2163.1888041984257, 2163.621366260906, 2059.6498595238845, 2088.749350077993, 2132.61612909677, 2140.636091864379, 2141.935741927745, 2074.3776866939934, 2094.61249668811, 2101.159536185523, 2103.842211834111, 2139.6469582518866, 2056.516718571135, 2064.3910046536307, 2066.5866826634656, 2067.7415323084615, 2069.1826728442334, 2002.7496562929634, 2075.284027010679, 2078.8752674839557, 2079.563291708743, 2080.6774949882792, 7448.329650331496, 7598.468107232496, 7602.809929751746, 7618.390528757742, 7621.23787621239, 4442.2004039272915, 4463.776811159429, 4613.792379342937, 4614.215583350839, 4617.37665415168, 2940.558916162571, 2974.2267010577407, 2982.2246215983782, 2984.5373967035143, 2987.074007057819, 865.705660075571, 873.9519326437044, 896.0994200828192, 908.1191244492832, 911.2755359489156, 9904.851427228525, 9967.352122112039, 10003.299769016172, 10013.499325033792, 10015.44915029673, 3661.377565813818, 3836.2519308735086, 3859.710521710883, 3887.047673320055, 3894.1822217334675, 7944.086430060502, 7960.283574478209, 7966.6415011324625, 7967.123616402191, 7976.960115199503, 4368.847090351886, 4380.299152135707, 4381.737095774264, 4387.6270517006415, 4391.736495810262, 3413.1637748751714, 4083.8774836754947, 4095.5290141634096, 4103.712740108223, 4256.531781504032, 3288.917777055545, 3300.224447254893, 3405.4210784166753, 3421.469672200813, 3422.606400263952, 938.4697645830084, 942.4627962061696, 951.3958636266021, 958.7890664053897, 963.205355581648, 853.3130829682166, 854.1245223645813, 863.7365603490996, 887.3877024852831, 888.8266787976412, 5245.501677340647, 5304.0, 5341.198820177005, 5509.338879334506, 5578.107502799614, 834.6869923778584, 850.7447765670274, 867.4751775176054, 896.9103089691109, 902.9367944243971, 3709.684676802502, 3721.3673675475234, 3834.424836274525, 3843.942340864833, 3888.319544079775, 9003.819923601492, 9329.30030247734, 9332.95333523328, 9341.06589341074, 9349.018353072965, 9238.67664631748, 9239.676611318571, 9247.953760231156, 9248.722538323862, 9267.814643707088, 6996.965015174993, 7073.398761105261, 7077.893831592531, 7083.185433675193, 7087.645617719197, 5015.648904576645, 5048.848534543969, 5154.407243166934, 5177.559907407913, 5309.946900530946, 8094.433389662902, 8272.131426200162, 8379.329653627818, 8380.455270407649, 8410.537420441935, 8147.348212142896, 8421.0, 8524.872126917977, 8572.52851093196, 8581.570921454027, 6364.490840732823, 6389.424951754364, 6467.126937863328, 6480.57876238043, 6497.415232629086, 6926.341997510229, 7040.049593304839, 7045.788626341218, 7047.929520704933, 7058.153021637231, 6570.737170513126, 6583.177102862142, 6714.328567143247, 6733.42765864907, 6831.419329357061, 6299.937000630119, 6326.3041065483685, 6390.137331460193, 6437.388448097423, 6508.8047358579315, 5900.675462849585, 6003.0, 6006.48944839676, 6014.729337179925, 6016.518678505797, 4533.909321813479, 4572.542745725401, 4575.0, 4634.791434385394, 4668.323093151542, 4612.238980568303, 4661.394018777537, 4719.339292498984, 4777.116233496814, 4827.662063655651], "value": 3987.487928769162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.5052756620781, 283.7914133112162, 287.97696184305255, 288.8599029470708, 290.3032721468477, 4713.151632706115, 4752.500987396325, 4760.595349395297, 4783.952160478394, 4793.281007848825, 4727.976360118195, 4738.170820106485, 4740.834070807522, 4743.0, 4745.383100196969, 3484.902255789431, 3578.6600272974024, 3595.442706380515, 3656.780593164419, 3682.6317368263094, 3671.5043469131724, 3679.7056235501095, 3690.870819521317, 3694.538182727159, 3700.5559332880093, 3652.5251717276715, 3655.9397774645454, 3662.176010397666, 3665.541807274091, 3667.8716244931434, 3496.1609213788633, 3576.5886923003927, 3685.63143685632, 3708.5735140458924, 3711.5917249102577, 3250.7159671929458, 3275.6560561140977, 3279.7048265655967, 3279.770416070876, 3287.8684852605866, 4596.563326483979, 4605.34207685233, 4609.308603709437, 4619.260918253097, 4643.840614114453, 3941.467901833273, 4144.564820693814, 4186.0581369192, 4191.580841915815, 4192.979035104805, 4965.428975667808, 4970.527799859007, 4975.427825800043, 4978.788681300541, 4979.526944940225, 3486.9476957845654, 3488.1977145256733, 3491.4064609016527, 3496.6328535503662, 3496.807675577842, 5033.823816166453, 5213.139831927728, 5241.947580524184, 5247.317848679685, 5247.921281180786, 3532.275883443888, 3565.322588708137, 3569.928601427957, 3571.017970058203, 3578.6958108561066, 3611.422172452395, 3612.710983121344, 3616.0959760059986, 3617.077645200457, 3617.602063772983, 4160.646345060643, 4167.937480937789, 4174.540800511942, 4175.394567787654, 4183.49798024239, 4861.475405817444, 4904.6566740327835, 4996.500349964975, 5029.497050294941, 5052.267421223902, 1231.2981600487815, 1237.7648246833073, 1242.9502819887284, 1243.0676992255808, 1251.7920207000107, 755.2183490087733, 780.4965797060864, 783.2480818414386, 783.764870538836, 791.7387262203574, 4190.20386126635, 4233.1322078973735, 4346.891542656603, 4360.672949528798, 4362.738235705868, 5118.129917913963, 5123.769430375642, 5131.0, 5149.6910185389, 5156.226566015128, 4380.4305440292555, 4387.714798538085, 4393.582609652142, 4393.978030109829, 4396.582324679151, 2617.790576753893, 2693.46130773846, 2707.4855777402627, 2718.5242582547976, 2731.7677997370447, 4775.543459244964, 4776.5701086902345, 4778.566430070965, 4782.784774685148, 4805.903881922342, 5214.478552144755, 5229.294045303911, 5235.712035837989, 5250.794666240112, 5257.4742525747115, 4533.41330534317, 4838.080764654705, 4855.295982082649, 4855.441624213261, 4865.445641038483, 5120.924605832668, 5163.896722065613, 5180.7150606717, 5186.4035635902355, 5187.403448603459, 4915.4592994771265, 5055.898882022266, 5070.822521211888, 5074.619403544675, 5078.136716758234, 4809.0, 4809.2064809306075, 4812.807487700593, 4824.0834241494, 4830.478399304208, 3547.2795694088863, 3586.677199052098, 3594.892153235407, 3597.1187059169624, 3604.5494313210847, 5160.845174644766, 5168.3539557555305, 5170.586353091669, 5179.637425380338, 5190.844274671766, 4751.596114330182, 4940.160172770566, 4984.22744474607, 4985.750712464434, 4996.450390456974, 4985.052839960396, 4989.575886049726, 5012.9723406700805, 5021.221710634857, 5021.49785021495, 4947.554720075211, 4948.802047918043, 4950.430700469492, 4952.653314268111, 4961.355023846877, 4785.95214047869, 4834.734089625104, 4915.139850526215, 5014.84955451337, 5043.646944713835, 4857.0, 4902.935665209244, 4907.705537667752, 4927.753612319441, 4942.678725882806], "value": 3723.5485212203544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6436325492564, 652.3574279334852, 674.2313762310966, 693.3586432549891, 697.6999890047277, 12884.67788305293, 13978.650533736662, 13981.510647127365, 13985.580432587014, 14030.088044277114, 13263.0, 13434.992375571846, 13440.798388024188, 13446.193228406302, 13460.259685717307, 624.1199908129515, 750.1785544828405, 750.182301291592, 761.2615762710162, 761.8514389694012, 756.2324240895496, 756.5687558091889, 756.8410633766915, 757.0650246945046, 757.4508481351004, 808.8746244332137, 809.1301850510695, 809.3242142810731, 809.3323008517996, 811.3347055414563, 664.5746722097886, 799.9680012799481, 803.4897839871694, 822.2271065198694, 824.9793755156109, 603.3694788945562, 606.5269090109722, 606.9059295809157, 606.9180660610805, 607.3592360060135, 12592.74814503714, 12678.049146314062, 12696.80954785679, 12707.682307942376, 12761.680957976032, 12402.875971240263, 12929.159604625669, 13034.674133146653, 13206.66983325415, 13594.11638243511, 10179.89820101797, 10445.373277603368, 11332.376719280437, 11348.0, 11471.483783229774, 4122.670186385082, 4161.979190104061, 4176.081262122329, 4211.452511173558, 4366.737995720267, 61170.0, 61237.0, 62748.37251627471, 63988.680056599886, 64010.0, 10015.799684006279, 10132.138768204637, 10168.745781355525, 10247.333923294962, 10601.946990265, 18071.638567228583, 18118.184681689356, 18403.26386944534, 18441.81558184428, 18451.81548184528, 6700.932990670129, 6719.260881303053, 6740.4270636995425, 6767.864642707118, 7024.5434046786795, 3757.799907043858, 3761.567419746709, 3787.62123787619, 3887.3197190492115, 3943.191645712622, 2760.489309477753, 2852.458032973728, 2869.6412948381453, 2882.827030378184, 2885.9134225973253, 490.6540888673548, 491.11354006018763, 501.8569707633307, 503.9244113383022, 504.54590868218895, 438.7608753229434, 529.2246858352532, 543.8993786149575, 558.5001423725743, 589.6108568344957, 8166.877496837552, 9522.428654280766, 9631.951840240754, 9765.316427849983, 9885.752856178653, 596.385722705614, 618.3538202578317, 631.3528633150966, 639.923922357212, 648.8410339466766, 3887.5334959805004, 4200.348945913388, 4235.7670328131635, 4245.532991370947, 4365.4979677337515, 104174.0, 104257.47871260595, 107554.46222768993, 108145.0, 108357.45821271001, 75540.62229688816, 89997.0, 90111.54944225236, 90650.54674726583, 91685.0, 49213.75393123083, 59873.700631497435, 78043.0, 79659.60170199112, 83820.58089709512, 7801.921980780119, 8157.06193787722, 8198.877016844872, 8292.253697167283, 8342.457740246864, 44112.77943610262, 44575.10849782921, 44858.0, 45766.77116614395, 45962.77018614885, 51744.0, 64817.35182648302, 65894.0, 66598.33401665921, 66836.0, 10175.643852465128, 10180.79638407213, 10403.94798026005, 10440.843387349349, 10538.525766340686, 12155.331456769962, 13170.802437963246, 13179.538716144889, 13496.392662330416, 14285.857141428869, 12556.560520381743, 12565.0, 12776.169548979658, 13047.804282935575, 13347.599572012856, 11967.281963081894, 12436.378181090728, 13131.710327869487, 13398.933005334911, 13536.526221582197, 11494.54021839117, 11805.468753905923, 13063.346832658139, 13094.083414160918, 13094.476220951055, 9166.587503562489, 9392.67125650599, 9697.97921362868, 9718.828234871717, 10016.749581260527, 10037.69886903394, 10771.419475506349, 10914.126869850552, 10928.0, 10983.83524247121], "value": 6685.70524447034, "unit": "score"}], "name": "dromaeo_css", "value": 6485.371238621839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 181.0, 129.0, 129.0, 146.0, 128.0, 160.0, 123.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 112.0, 75.0, 77.0, 75.0, 76.0, 110.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 130.0, 85.0, 86.0, 85.0, 112.0, 85.0, 85.0, 129.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 80.0, 79.0, 81.0, 79.0, 90.0, 78.0, 78.0, 79.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 138.0, 130.0, 144.0, 130.0, 131.0, 138.0, 151.0, 144.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 168.0, 170.0, 168.0, 169.0, 166.0, 168.0, 168.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1532.7, "alertThreshold": 2.0}]} 10:35:54 INFO - Return code: 0 10:35:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:54 INFO - # TBPL SUCCESS # 10:35:54 INFO - Running post-action listener: _resource_record_post_action 10:35:54 INFO - [mozharness: 2016-08-12 17:35:54.329751Z] Finished run-tests step (success) 10:35:54 INFO - Running post-run listener: _resource_record_post_run 10:35:54 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 466944; Write bytes: 403681280; Read time: 100; Write time: 335776 10:35:54 INFO - TinderboxPrint: CPU usage
12.9% 10:35:54 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 100 10:35:54 INFO - TinderboxPrint: I/O write bytes / time
403,681,280 / 335,776 10:35:54 INFO - TinderboxPrint: CPU idle
8,336.3 (87.0%) 10:35:54 INFO - TinderboxPrint: CPU user
1,197.2 (12.5%) 10:35:54 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120827904; Read time: 0; Write time: 97600 10:35:54 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 462848; Write bytes: 282853376; Read time: 88; Write time: 238176 10:35:54 INFO - Running post-run listener: _upload_blobber_files 10:35:54 INFO - Blob upload gear active. 10:35:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:56 INFO - (blobuploader) - INFO - Done attempting. 10:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:57 INFO - (blobuploader) - INFO - Done attempting. 10:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:01 INFO - (blobuploader) - INFO - Done attempting. 10:36:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:01 INFO - Return code: 0 10:36:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d8674bfa17ff3a412e8c8a7f1092183f668b8bf36d615d2c31f4efa458719a57949fc825a131bad65f42122e9c3148baa5d91e12cbbfc68d50632e782c1aa7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcb82d192ae6dcbf1a0f377cd1dc695c706da36ab98f5a0a0f241b002a67aaae0b27c5f1ce2d1c92d5535bb7c1ad886e6bd91d41f8d5a2936dbdd474059e8b0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27e636b13bd1070b6f5337672ea66db9098ce90a8cc54bea8ec65e60c9a9a9fea902479f4c93cb8a06b2da5a609066e1262f9bf24fe0d9477b1b7767806df0e2"} 10:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:01 INFO - Contents: 10:36:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d8674bfa17ff3a412e8c8a7f1092183f668b8bf36d615d2c31f4efa458719a57949fc825a131bad65f42122e9c3148baa5d91e12cbbfc68d50632e782c1aa7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcb82d192ae6dcbf1a0f377cd1dc695c706da36ab98f5a0a0f241b002a67aaae0b27c5f1ce2d1c92d5535bb7c1ad886e6bd91d41f8d5a2936dbdd474059e8b0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27e636b13bd1070b6f5337672ea66db9098ce90a8cc54bea8ec65e60c9a9a9fea902479f4c93cb8a06b2da5a609066e1262f9bf24fe0d9477b1b7767806df0e2"} 10:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:01 INFO - Copying logs to upload dir... 10:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.685292 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-12 10:36:01.088041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 10:36:01.095813) ========= 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=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d8674bfa17ff3a412e8c8a7f1092183f668b8bf36d615d2c31f4efa458719a57949fc825a131bad65f42122e9c3148baa5d91e12cbbfc68d50632e782c1aa7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcb82d192ae6dcbf1a0f377cd1dc695c706da36ab98f5a0a0f241b002a67aaae0b27c5f1ce2d1c92d5535bb7c1ad886e6bd91d41f8d5a2936dbdd474059e8b0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27e636b13bd1070b6f5337672ea66db9098ce90a8cc54bea8ec65e60c9a9a9fea902479f4c93cb8a06b2da5a609066e1262f9bf24fe0d9477b1b7767806df0e2"} build_url:https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/OSSMuLHOT6-60qCbR7ErQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d8674bfa17ff3a412e8c8a7f1092183f668b8bf36d615d2c31f4efa458719a57949fc825a131bad65f42122e9c3148baa5d91e12cbbfc68d50632e782c1aa7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcb82d192ae6dcbf1a0f377cd1dc695c706da36ab98f5a0a0f241b002a67aaae0b27c5f1ce2d1c92d5535bb7c1ad886e6bd91d41f8d5a2936dbdd474059e8b0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27e636b13bd1070b6f5337672ea66db9098ce90a8cc54bea8ec65e60c9a9a9fea902479f4c93cb8a06b2da5a609066e1262f9bf24fe0d9477b1b7767806df0e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 10:36:01.121014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:36:01.121359) ========= 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=62c568580acbfdaac3eec7be000001dc-1471021916.911230-1562674652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004355 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:36:01.205480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 10:36:01.205834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 10:36:01.206194) ========= ========= Total master_lag: 0.18 =========