builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1471837370.78 results: success (0) buildid: 20160821190553 builduid: f1ab0ff5d7e94cbdb307cfe6c5e36e00 revision: d16d42082abf5a0251baef11ce2913828f653b2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.781496) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.781926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.782299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.797254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.797510) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-21 20:42:52-- 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% 15.2M=0.001s 2016-08-21 20:42:52 (15.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.942444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:50.943092) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021153 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:51.016629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 20:42:51.016936) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d16d42082abf5a0251baef11ce2913828f653b2b --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 d16d42082abf5a0251baef11ce2913828f653b2b --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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-21 20:42:52,269 truncating revision to first 12 chars 2016-08-21 20:42:52,269 Setting DEBUG logging. 2016-08-21 20:42:52,269 attempt 1/10 2016-08-21 20:42:52,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d16d42082abf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-21 20:42:53,109 unpacking tar archive at: autoland-d16d42082abf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 20:42:52.172718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:52.173331) ========= script_repo_revision: d16d42082abf5a0251baef11ce2913828f653b2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:52.173759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:52.174076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 20:42:52.187727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-21 20:42:52.188043) ========= /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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:42:53 INFO - MultiFileLogger online at 20160821 20:42:53 in /builds/slave/test 20:42:53 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 20:42:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:42:53 INFO - {'append_to_log': False, 20:42:53 INFO - 'base_work_dir': '/builds/slave/test', 20:42:53 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:42:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:42:53 INFO - 'branch': 'Autoland-Non-PGO', 20:42:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:42:53 INFO - 'config_files': ('talos/linux_config.py',), 20:42:53 INFO - 'default_actions': ('clobber', 20:42:53 INFO - 'read-buildbot-config', 20:42:53 INFO - 'download-and-extract', 20:42:53 INFO - 'populate-webroot', 20:42:53 INFO - 'create-virtualenv', 20:42:53 INFO - 'install', 20:42:53 INFO - 'run-tests'), 20:42:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:42:53 INFO - 'download_minidump_stackwalk': True, 20:42:53 INFO - 'download_symbols': 'ondemand', 20:42:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:42:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:42:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:42:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:42:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:42:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:42:53 INFO - 'installer_path': 'installer.exe', 20:42:53 INFO - 'log_level': 'info', 20:42:53 INFO - 'log_name': 'talos', 20:42:53 INFO - 'log_to_console': True, 20:42:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:42:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:42:53 INFO - 'opt_config_files': (), 20:42:53 INFO - 'pip_index': False, 20:42:53 INFO - 'sps_profile': False, 20:42:53 INFO - 'sps_profile_interval': 0, 20:42:53 INFO - 'suite': 'dromaeojs', 20:42:53 INFO - 'system_bits': '32', 20:42:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:42:53 INFO - 'title': 'talos-linux64-ix-011', 20:42:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:42:53 INFO - 'use_talos_json': True, 20:42:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:42:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:42:53 INFO - 'work_dir': 'build'} 20:42:53 INFO - [mozharness: 2016-08-22 03:42:53.543031Z] Running clobber step. 20:42:53 INFO - Running pre-action listener: _resource_record_pre_action 20:42:53 INFO - Running main action method: clobber 20:42:53 INFO - rmtree: /builds/slave/test/build 20:42:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:42:54 INFO - Running post-action listener: _resource_record_post_action 20:42:54 INFO - [mozharness: 2016-08-22 03:42:54.525645Z] Finished clobber step (success) 20:42:54 INFO - [mozharness: 2016-08-22 03:42:54.526036Z] Running read-buildbot-config step. 20:42:54 INFO - Running pre-action listener: _resource_record_pre_action 20:42:54 INFO - Running main action method: read_buildbot_config 20:42:54 INFO - Using buildbot properties: 20:42:54 INFO - { 20:42:54 INFO - "project": "", 20:42:54 INFO - "product": "firefox", 20:42:54 INFO - "script_repo_revision": "production", 20:42:54 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:42:54 INFO - "repository": "", 20:42:54 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:42:54 INFO - "buildid": "20160821190553", 20:42:54 INFO - "pgo_build": "False", 20:42:54 INFO - "basedir": "/builds/slave/test", 20:42:54 INFO - "buildnumber": 441, 20:42:54 INFO - "slavename": "talos-linux64-ix-011", 20:42:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:42:54 INFO - "platform": "ubuntu64_hw", 20:42:54 INFO - "scheduler": "tests-autoland-linux64-talos", 20:42:54 INFO - "branch": "autoland", 20:42:54 INFO - "repo_path": "integration/autoland", 20:42:54 INFO - "revision": "d16d42082abf5a0251baef11ce2913828f653b2b", 20:42:54 INFO - "stage_platform": "linux64", 20:42:54 INFO - "builduid": "f1ab0ff5d7e94cbdb307cfe6c5e36e00", 20:42:54 INFO - "slavebuilddir": "test" 20:42:54 INFO - } 20:42:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:42:54 INFO - Running post-action listener: _resource_record_post_action 20:42:54 INFO - [mozharness: 2016-08-22 03:42:54.528454Z] Finished read-buildbot-config step (success) 20:42:54 INFO - [mozharness: 2016-08-22 03:42:54.528542Z] Running download-and-extract step. 20:42:54 INFO - Running pre-action listener: _resource_record_pre_action 20:42:54 INFO - Running main action method: download_and_extract 20:42:54 INFO - mkdir: /builds/slave/test/build/tests 20:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:54 INFO - trying https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:42:54 INFO - Downloading https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:42:55 INFO - Downloaded 1361 bytes. 20:42:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:42:55 INFO - Using the following test package requirements: 20:42:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:42:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:42:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:42:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'jsshell-linux-x86_64.zip'], 20:42:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:42:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:42:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:42:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:42:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:42:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:42:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:42:55 INFO - trying https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:42:55 INFO - Downloading https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:42:55 INFO - Downloaded 20330229 bytes. 20:42:55 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 20:43:00 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 20:43:00 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')]} 20:43:00 INFO - trying https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:43:00 INFO - Downloading https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:01 INFO - Downloaded 20330229 bytes. 20:43:01 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 20:43:05 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')]} 20:43:05 INFO - trying https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:43:05 INFO - Downloading https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:06 INFO - Downloaded 14413981 bytes. 20:43:06 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 20:43:06 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')]} 20:43:06 INFO - trying https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:43:06 INFO - Downloading https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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 20:43:09 INFO - Downloaded 55772494 bytes. 20:43:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:43:09 INFO - mkdir: /builds/slave/test/properties 20:43:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:43:09 INFO - Writing to file /builds/slave/test/properties/build_url 20:43:09 INFO - Contents: 20:43:09 INFO - build_url:https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:43:09 INFO - Running post-action listener: _resource_record_post_action 20:43:09 INFO - Running post-action listener: set_extra_try_arguments 20:43:09 INFO - [mozharness: 2016-08-22 03:43:09.894602Z] Finished download-and-extract step (success) 20:43:09 INFO - [mozharness: 2016-08-22 03:43:09.894826Z] Running populate-webroot step. 20:43:09 INFO - Running pre-action listener: _resource_record_pre_action 20:43:09 INFO - Running main action method: populate_webroot 20:43:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:43:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:43:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:43:09 INFO - '--tppagecycles', 20:43:09 INFO - '7'], 20:43:09 INFO - 'tests': ['tsvgm']}}, 20:43:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:43:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:43:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:43:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:43:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:43:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:43:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['damp', 'tps']}, 20:43:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'tests': ['damp', 'tps']}, 20:43:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['dromaeo_dom']}, 20:43:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:43:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['basic_compositor_video']}, 20:43:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:43:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['a11yr', 20:43:09 INFO - 'ts_paint', 20:43:09 INFO - 'tpaint', 20:43:09 INFO - 'sessionrestore', 20:43:09 INFO - 'sessionrestore_no_auto_restore', 20:43:09 INFO - 'tabpaint']}, 20:43:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['tsvgx', 20:43:09 INFO - 'tsvgr_opacity', 20:43:09 INFO - 'tart', 20:43:09 INFO - 'tscrollx', 20:43:09 INFO - 'cart']}, 20:43:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:43:09 INFO - 'tsvgr_opacity', 20:43:09 INFO - 'tart', 20:43:09 INFO - 'tscrollx', 20:43:09 INFO - 'cart']}, 20:43:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'talos_options': ['--disable-e10s'], 20:43:09 INFO - 'tests': ['tp5o']}, 20:43:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'tests': ['tp5o']}, 20:43:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'talos_options': ['--disable-e10s', 20:43:09 INFO - '--xperf_path', 20:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:43:09 INFO - 'tests': ['tp5n']}, 20:43:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:43:09 INFO - 'talos_options': ['--xperf_path', 20:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:43:09 INFO - 'tests': ['tp5n']}}, 20:43:09 INFO - 'talos.zip': {'path': '', 20:43:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:43:09 INFO - Running post-action listener: _resource_record_post_action 20:43:09 INFO - [mozharness: 2016-08-22 03:43:09.910008Z] Finished populate-webroot step (success) 20:43:09 INFO - [mozharness: 2016-08-22 03:43:09.910096Z] Running create-virtualenv step. 20:43:09 INFO - Running pre-action listener: _resource_record_pre_action 20:43:09 INFO - Running main action method: create_virtualenv 20:43:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:43:09 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 20:43:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:43:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:43:10 INFO - Using real prefix '/usr' 20:43:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 20:43:12 INFO - Installing pip.................done. 20:43:12 INFO - Return code: 0 20:43:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:43:12 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')]} 20:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:12 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')]} 20:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:12 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:12 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 20:43:12 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 20:43:12 INFO - Using env: {'DISPLAY': ':0', 20:43:12 INFO - 'HOME': '/home/cltbld', 20:43:12 INFO - 'LANG': 'en_US.UTF-8', 20:43:12 INFO - 'LANGUAGE': 'en_US:en', 20:43:12 INFO - 'LOGNAME': 'cltbld', 20:43:12 INFO - 'MAIL': '/var/mail/cltbld', 20:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:12 INFO - 'MOZ_NO_REMOTE': '1', 20:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:12 INFO - 'NO_EM_RESTART': '1', 20:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:12 INFO - 'PWD': '/builds/slave/test', 20:43:12 INFO - 'SHELL': '/bin/bash', 20:43:12 INFO - 'SHLVL': '1', 20:43:12 INFO - 'TERM': 'linux', 20:43:12 INFO - 'TMOUT': '86400', 20:43:12 INFO - 'USER': 'cltbld', 20:43:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:12 INFO - '_': '/tools/buildbot/bin/python'} 20:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:12 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 20:43:12 INFO - Cleaning up... 20:43:12 INFO - Return code: 0 20:43:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:43:12 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')]} 20:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:12 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')]} 20:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:12 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:12 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 20:43:12 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 20:43:12 INFO - Using env: {'DISPLAY': ':0', 20:43:12 INFO - 'HOME': '/home/cltbld', 20:43:12 INFO - 'LANG': 'en_US.UTF-8', 20:43:12 INFO - 'LANGUAGE': 'en_US:en', 20:43:12 INFO - 'LOGNAME': 'cltbld', 20:43:12 INFO - 'MAIL': '/var/mail/cltbld', 20:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:12 INFO - 'MOZ_NO_REMOTE': '1', 20:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:12 INFO - 'NO_EM_RESTART': '1', 20:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:12 INFO - 'PWD': '/builds/slave/test', 20:43:12 INFO - 'SHELL': '/bin/bash', 20:43:12 INFO - 'SHLVL': '1', 20:43:12 INFO - 'TERM': 'linux', 20:43:12 INFO - 'TMOUT': '86400', 20:43:12 INFO - 'USER': 'cltbld', 20:43:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:12 INFO - '_': '/tools/buildbot/bin/python'} 20:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:12 INFO - Downloading/unpacking psutil>=3.1.1 20:43:12 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 20:43:12 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 20:43:12 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 20:43:12 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 20:43:12 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 20:43:12 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 20:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:43:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:43:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:43:14 INFO - Installing collected packages: psutil 20:43:14 INFO - Running setup.py install for psutil 20:43:14 INFO - building 'psutil._psutil_linux' extension 20:43:14 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 20:43:15 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 20:43:15 INFO - building 'psutil._psutil_posix' extension 20:43:15 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 20:43:15 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 20:43:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:43:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:43:15 INFO - Successfully installed psutil 20:43:15 INFO - Cleaning up... 20:43:15 INFO - Return code: 0 20:43:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:43:15 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')]} 20:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:15 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')]} 20:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:15 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:15 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 20:43:15 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 20:43:15 INFO - Using env: {'DISPLAY': ':0', 20:43:15 INFO - 'HOME': '/home/cltbld', 20:43:15 INFO - 'LANG': 'en_US.UTF-8', 20:43:15 INFO - 'LANGUAGE': 'en_US:en', 20:43:15 INFO - 'LOGNAME': 'cltbld', 20:43:15 INFO - 'MAIL': '/var/mail/cltbld', 20:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:15 INFO - 'MOZ_NO_REMOTE': '1', 20:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:15 INFO - 'NO_EM_RESTART': '1', 20:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:15 INFO - 'PWD': '/builds/slave/test', 20:43:15 INFO - 'SHELL': '/bin/bash', 20:43:15 INFO - 'SHLVL': '1', 20:43:15 INFO - 'TERM': 'linux', 20:43:15 INFO - 'TMOUT': '86400', 20:43:15 INFO - 'USER': 'cltbld', 20:43:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:15 INFO - '_': '/tools/buildbot/bin/python'} 20:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:43:15 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 20:43:15 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 20:43:15 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 20:43:15 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 20:43:15 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 20:43:15 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 20:43:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:43:18 INFO - Installing collected packages: mozsystemmonitor 20:43:18 INFO - Running setup.py install for mozsystemmonitor 20:43:18 INFO - Successfully installed mozsystemmonitor 20:43:18 INFO - Cleaning up... 20:43:18 INFO - Return code: 0 20:43:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:43:18 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')]} 20:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:18 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')]} 20:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:18 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:18 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 20:43:18 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 20:43:18 INFO - Using env: {'DISPLAY': ':0', 20:43:18 INFO - 'HOME': '/home/cltbld', 20:43:18 INFO - 'LANG': 'en_US.UTF-8', 20:43:18 INFO - 'LANGUAGE': 'en_US:en', 20:43:18 INFO - 'LOGNAME': 'cltbld', 20:43:18 INFO - 'MAIL': '/var/mail/cltbld', 20:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:18 INFO - 'MOZ_NO_REMOTE': '1', 20:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:18 INFO - 'NO_EM_RESTART': '1', 20:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:18 INFO - 'PWD': '/builds/slave/test', 20:43:18 INFO - 'SHELL': '/bin/bash', 20:43:18 INFO - 'SHLVL': '1', 20:43:18 INFO - 'TERM': 'linux', 20:43:18 INFO - 'TMOUT': '86400', 20:43:18 INFO - 'USER': 'cltbld', 20:43:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:18 INFO - '_': '/tools/buildbot/bin/python'} 20:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:18 INFO - Downloading/unpacking jsonschema==2.5.1 20:43:18 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 20:43:18 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 20:43:18 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 20:43:18 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 20:43:18 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 20:43:18 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 20:43:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:43:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:43:20 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 20:43:20 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 20:43:20 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 20:43:20 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 20:43:20 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 20:43:20 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 20:43:21 INFO - Downloading functools32-3.2.3-2.tar.gz 20:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:43:21 INFO - warning: no files found matching '*.txt' 20:43:21 INFO - no previously-included directories found matching 'build' 20:43:21 INFO - no previously-included directories found matching 'dist' 20:43:21 INFO - no previously-included directories found matching '.git*' 20:43:21 INFO - Installing collected packages: jsonschema, functools32 20:43:21 INFO - Running setup.py install for functools32 20:43:21 INFO - warning: no files found matching '*.txt' 20:43:21 INFO - no previously-included directories found matching 'build' 20:43:21 INFO - no previously-included directories found matching 'dist' 20:43:21 INFO - no previously-included directories found matching '.git*' 20:43:21 INFO - Successfully installed jsonschema functools32 20:43:21 INFO - Cleaning up... 20:43:21 INFO - Return code: 0 20:43:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:43:21 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')]} 20:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:21 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')]} 20:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:21 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:21 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 20:43:21 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 20:43:21 INFO - Using env: {'DISPLAY': ':0', 20:43:21 INFO - 'HOME': '/home/cltbld', 20:43:21 INFO - 'LANG': 'en_US.UTF-8', 20:43:21 INFO - 'LANGUAGE': 'en_US:en', 20:43:21 INFO - 'LOGNAME': 'cltbld', 20:43:21 INFO - 'MAIL': '/var/mail/cltbld', 20:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:21 INFO - 'MOZ_NO_REMOTE': '1', 20:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:21 INFO - 'NO_EM_RESTART': '1', 20:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:21 INFO - 'PWD': '/builds/slave/test', 20:43:21 INFO - 'SHELL': '/bin/bash', 20:43:21 INFO - 'SHLVL': '1', 20:43:21 INFO - 'TERM': 'linux', 20:43:21 INFO - 'TMOUT': '86400', 20:43:21 INFO - 'USER': 'cltbld', 20:43:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:21 INFO - '_': '/tools/buildbot/bin/python'} 20:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:43:21 INFO - Cleaning up... 20:43:21 INFO - Return code: 0 20:43:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:43:21 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')]} 20:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:21 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')]} 20:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:21 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:21 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 20:43:21 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 20:43:21 INFO - Using env: {'DISPLAY': ':0', 20:43:21 INFO - 'HOME': '/home/cltbld', 20:43:21 INFO - 'LANG': 'en_US.UTF-8', 20:43:21 INFO - 'LANGUAGE': 'en_US:en', 20:43:21 INFO - 'LOGNAME': 'cltbld', 20:43:21 INFO - 'MAIL': '/var/mail/cltbld', 20:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:21 INFO - 'MOZ_NO_REMOTE': '1', 20:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:21 INFO - 'NO_EM_RESTART': '1', 20:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:21 INFO - 'PWD': '/builds/slave/test', 20:43:21 INFO - 'SHELL': '/bin/bash', 20:43:21 INFO - 'SHLVL': '1', 20:43:21 INFO - 'TERM': 'linux', 20:43:21 INFO - 'TMOUT': '86400', 20:43:21 INFO - 'USER': 'cltbld', 20:43:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:21 INFO - '_': '/tools/buildbot/bin/python'} 20:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:21 INFO - Downloading/unpacking blobuploader==1.2.4 20:43:21 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 20:43:21 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 20:43:21 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 20:43:21 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 20:43:21 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 20:43:21 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 20:43:23 INFO - Downloading blobuploader-1.2.4.tar.gz 20:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:43:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:43:23 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 20:43:23 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 20:43:23 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 20:43:23 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 20:43:23 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 20:43:23 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 20:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:43:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:24 INFO - Downloading docopt-0.6.1.tar.gz 20:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:43:24 INFO - Installing collected packages: blobuploader, requests, docopt 20:43:24 INFO - Running setup.py install for blobuploader 20:43:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:43:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:43:24 INFO - Running setup.py install for requests 20:43:24 INFO - Running setup.py install for docopt 20:43:24 INFO - Successfully installed blobuploader requests docopt 20:43:24 INFO - Cleaning up... 20:43:25 INFO - Return code: 0 20:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:25 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:25 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 20:43:25 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 20:43:25 INFO - Using env: {'DISPLAY': ':0', 20:43:25 INFO - 'HOME': '/home/cltbld', 20:43:25 INFO - 'LANG': 'en_US.UTF-8', 20:43:25 INFO - 'LANGUAGE': 'en_US:en', 20:43:25 INFO - 'LOGNAME': 'cltbld', 20:43:25 INFO - 'MAIL': '/var/mail/cltbld', 20:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:25 INFO - 'MOZ_NO_REMOTE': '1', 20:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:25 INFO - 'NO_EM_RESTART': '1', 20:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:25 INFO - 'PWD': '/builds/slave/test', 20:43:25 INFO - 'SHELL': '/bin/bash', 20:43:25 INFO - 'SHLVL': '1', 20:43:25 INFO - 'TERM': 'linux', 20:43:25 INFO - 'TMOUT': '86400', 20:43:25 INFO - 'USER': 'cltbld', 20:43:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:25 INFO - '_': '/tools/buildbot/bin/python'} 20:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:25 INFO - Running setup.py (path:/tmp/pip-BKmYc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:25 INFO - Running setup.py (path:/tmp/pip-odfCNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:25 INFO - Running setup.py (path:/tmp/pip-jeROLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:25 INFO - Running setup.py (path:/tmp/pip-NuR1tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:25 INFO - Running setup.py (path:/tmp/pip-iaIZSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:25 INFO - Running setup.py (path:/tmp/pip-TQz6_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:25 INFO - Running setup.py (path:/tmp/pip-GgjKxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:25 INFO - Running setup.py (path:/tmp/pip-IKfJ9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:25 INFO - Running setup.py (path:/tmp/pip-NO8GHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:25 INFO - Running setup.py (path:/tmp/pip-ROWCUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:25 INFO - Running setup.py (path:/tmp/pip-xjSRHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:26 INFO - Running setup.py (path:/tmp/pip-uAYgsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:26 INFO - Running setup.py (path:/tmp/pip-SvfKva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:26 INFO - Running setup.py (path:/tmp/pip-dralxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:26 INFO - Running setup.py (path:/tmp/pip-72bj8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:26 INFO - Running setup.py (path:/tmp/pip-1A6LHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:26 INFO - Running setup.py (path:/tmp/pip-NCCZ6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:43:26 INFO - Running setup.py install for manifestparser 20:43:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:43:26 INFO - Running setup.py install for mozcrash 20:43:26 INFO - Running setup.py install for mozdebug 20:43:26 INFO - Running setup.py install for mozdevice 20:43:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:43:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:43:26 INFO - Running setup.py install for mozfile 20:43:26 INFO - Running setup.py install for mozhttpd 20:43:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozinfo 20:43:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozInstall 20:43:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozleak 20:43:27 INFO - Running setup.py install for mozlog 20:43:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for moznetwork 20:43:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozprocess 20:43:27 INFO - Running setup.py install for mozprofile 20:43:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozrunner 20:43:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:43:27 INFO - Running setup.py install for mozscreenshot 20:43:28 INFO - Running setup.py install for moztest 20:43:28 INFO - Running setup.py install for mozversion 20:43:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:43:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:43:28 INFO - Cleaning up... 20:43:28 INFO - Return code: 0 20:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:28 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:28 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 20:43:28 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 20:43:28 INFO - Using env: {'DISPLAY': ':0', 20:43:28 INFO - 'HOME': '/home/cltbld', 20:43:28 INFO - 'LANG': 'en_US.UTF-8', 20:43:28 INFO - 'LANGUAGE': 'en_US:en', 20:43:28 INFO - 'LOGNAME': 'cltbld', 20:43:28 INFO - 'MAIL': '/var/mail/cltbld', 20:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:28 INFO - 'MOZ_NO_REMOTE': '1', 20:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:28 INFO - 'NO_EM_RESTART': '1', 20:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:28 INFO - 'PWD': '/builds/slave/test', 20:43:28 INFO - 'SHELL': '/bin/bash', 20:43:28 INFO - 'SHLVL': '1', 20:43:28 INFO - 'TERM': 'linux', 20:43:28 INFO - 'TMOUT': '86400', 20:43:28 INFO - 'USER': 'cltbld', 20:43:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:28 INFO - '_': '/tools/buildbot/bin/python'} 20:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:28 INFO - Running setup.py (path:/tmp/pip-560XZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:28 INFO - Running setup.py (path:/tmp/pip-Df5WDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:28 INFO - Running setup.py (path:/tmp/pip-L3PWU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:28 INFO - Running setup.py (path:/tmp/pip-bzRwz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:28 INFO - Running setup.py (path:/tmp/pip-ZTPkyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:28 INFO - Running setup.py (path:/tmp/pip-Szn5oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:28 INFO - Running setup.py (path:/tmp/pip-cQoac3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:28 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)) 20:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:29 INFO - Running setup.py (path:/tmp/pip-xDNeMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:29 INFO - Running setup.py (path:/tmp/pip-X1WVnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:29 INFO - Running setup.py (path:/tmp/pip-a09Pq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:29 INFO - Running setup.py (path:/tmp/pip-Kozmtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:29 INFO - Running setup.py (path:/tmp/pip-6URcC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:29 INFO - Running setup.py (path:/tmp/pip-uoIhYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:29 INFO - Running setup.py (path:/tmp/pip-6ARcGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:29 INFO - Running setup.py (path:/tmp/pip-t5jc_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:29 INFO - Running setup.py (path:/tmp/pip-0u58Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:29 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)) 20:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:29 INFO - Running setup.py (path:/tmp/pip-J9MJ9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:29 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)) 20:43:29 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)) 20:43:29 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)) 20:43:29 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)) 20:43:29 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)) 20:43:29 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)) 20:43:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:31 INFO - Downloading blessings-1.6.tar.gz 20:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:43:31 INFO - Installing collected packages: blessings 20:43:31 INFO - Running setup.py install for blessings 20:43:31 INFO - Successfully installed blessings 20:43:31 INFO - Cleaning up... 20:43:31 INFO - Return code: 0 20:43:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:32 INFO - Reading from file tmpfile_stdout 20:43:32 INFO - Current package versions: 20:43:32 INFO - argparse == 1.2.1 20:43:32 INFO - blessings == 1.6 20:43:32 INFO - blobuploader == 1.2.4 20:43:32 INFO - docopt == 0.6.1 20:43:32 INFO - functools32 == 3.2.3-2 20:43:32 INFO - jsonschema == 2.5.1 20:43:32 INFO - manifestparser == 1.1 20:43:32 INFO - mozInstall == 1.12 20:43:32 INFO - mozcrash == 0.17 20:43:32 INFO - mozdebug == 0.1 20:43:32 INFO - mozdevice == 0.48 20:43:32 INFO - mozfile == 1.2 20:43:32 INFO - mozhttpd == 0.7 20:43:32 INFO - mozinfo == 0.9 20:43:32 INFO - mozleak == 0.1 20:43:32 INFO - mozlog == 3.3 20:43:32 INFO - moznetwork == 0.27 20:43:32 INFO - mozprocess == 0.23 20:43:32 INFO - mozprofile == 0.28 20:43:32 INFO - mozrunner == 6.12 20:43:32 INFO - mozscreenshot == 0.1 20:43:32 INFO - mozsystemmonitor == 0.3 20:43:32 INFO - moztest == 0.7 20:43:32 INFO - mozversion == 1.4 20:43:32 INFO - psutil == 3.1.1 20:43:32 INFO - requests == 1.2.3 20:43:32 INFO - wsgiref == 0.1.2 20:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:32 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:32 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 20:43:32 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 20:43:32 INFO - Using env: {'DISPLAY': ':0', 20:43:32 INFO - 'HOME': '/home/cltbld', 20:43:32 INFO - 'LANG': 'en_US.UTF-8', 20:43:32 INFO - 'LANGUAGE': 'en_US:en', 20:43:32 INFO - 'LOGNAME': 'cltbld', 20:43:32 INFO - 'MAIL': '/var/mail/cltbld', 20:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:32 INFO - 'MOZ_NO_REMOTE': '1', 20:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:32 INFO - 'NO_EM_RESTART': '1', 20:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:32 INFO - 'PWD': '/builds/slave/test', 20:43:32 INFO - 'SHELL': '/bin/bash', 20:43:32 INFO - 'SHLVL': '1', 20:43:32 INFO - 'TERM': 'linux', 20:43:32 INFO - 'TMOUT': '86400', 20:43:32 INFO - 'USER': 'cltbld', 20:43:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:32 INFO - '_': '/tools/buildbot/bin/python'} 20:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 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)) 20:43:32 INFO - Cleaning up... 20:43:32 INFO - Return code: 0 20:43:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:32 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 0x7fc22d124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', '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 20:43:32 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 20:43:32 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 20:43:32 INFO - Using env: {'DISPLAY': ':0', 20:43:32 INFO - 'HOME': '/home/cltbld', 20:43:32 INFO - 'LANG': 'en_US.UTF-8', 20:43:32 INFO - 'LANGUAGE': 'en_US:en', 20:43:32 INFO - 'LOGNAME': 'cltbld', 20:43:32 INFO - 'MAIL': '/var/mail/cltbld', 20:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:32 INFO - 'MOZ_NO_REMOTE': '1', 20:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:32 INFO - 'NO_EM_RESTART': '1', 20:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:32 INFO - 'PWD': '/builds/slave/test', 20:43:32 INFO - 'SHELL': '/bin/bash', 20:43:32 INFO - 'SHLVL': '1', 20:43:32 INFO - 'TERM': 'linux', 20:43:32 INFO - 'TMOUT': '86400', 20:43:32 INFO - 'USER': 'cltbld', 20:43:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:32 INFO - '_': '/tools/buildbot/bin/python'} 20:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:43:32 INFO - Cleaning up... 20:43:32 INFO - Return code: 0 20:43:32 INFO - Running post-action listener: _resource_record_post_action 20:43:32 INFO - Running post-action listener: _start_resource_monitoring 20:43:32 INFO - Starting resource monitoring. 20:43:32 INFO - [mozharness: 2016-08-22 03:43:32.570898Z] Finished create-virtualenv step (success) 20:43:32 INFO - [mozharness: 2016-08-22 03:43:32.571357Z] Running install step. 20:43:32 INFO - Running pre-action listener: _resource_record_pre_action 20:43:32 INFO - Running main action method: install 20:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:32 INFO - Reading from file tmpfile_stdout 20:43:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:43:32 INFO - Reading from file tmpfile_stdout 20:43:32 INFO - Output received: 20:43:32 INFO - Usage: mozinstall [options] installer 20:43:32 INFO - Options: 20:43:32 INFO - -h, --help show this help message and exit 20:43:32 INFO - -d DEST, --destination=DEST 20:43:32 INFO - Directory to install application into. [default: 20:43:32 INFO - "/builds/slave/test"] 20:43:32 INFO - --app=APP Application being installed. [default: firefox] 20:43:32 INFO - mkdir: /builds/slave/test/build/application 20:43:32 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'] 20:43:32 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 20:43:50 INFO - Reading from file tmpfile_stdout 20:43:50 INFO - Output received: 20:43:50 INFO - /builds/slave/test/build/application/firefox/firefox 20:43:50 INFO - Running post-action listener: _resource_record_post_action 20:43:50 INFO - [mozharness: 2016-08-22 03:43:50.305092Z] Finished install step (success) 20:43:50 INFO - [mozharness: 2016-08-22 03:43:50.305338Z] Running run-tests step. 20:43:50 INFO - Running pre-action listener: _resource_record_pre_action 20:43:50 INFO - Running main action method: run_tests 20:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:43:50 INFO - Python 2.7.3 20:43:50 INFO - Return code: 0 20:43:50 INFO - grabbing minidump binary from tooltool 20:43:50 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')]} 20:43:50 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 0xf00090>, '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 0xf039b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:43:50 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 20:43:50 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 20:43:50 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 20:43:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:43:50 INFO - Return code: 0 20:43:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:43:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:43:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:43:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:43:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:43:50 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/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:43:50 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/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 20:43:50 INFO - Using env: {'DISPLAY': ':0', 20:43:50 INFO - 'HOME': '/home/cltbld', 20:43:50 INFO - 'LANG': 'en_US.UTF-8', 20:43:50 INFO - 'LANGUAGE': 'en_US:en', 20:43:50 INFO - 'LOGNAME': 'cltbld', 20:43:50 INFO - 'MAIL': '/var/mail/cltbld', 20:43:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:43:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:50 INFO - 'MOZ_NO_REMOTE': '1', 20:43:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:50 INFO - 'NO_EM_RESTART': '1', 20:43:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:50 INFO - 'PWD': '/builds/slave/test', 20:43:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:43:50 INFO - 'SHELL': '/bin/bash', 20:43:50 INFO - 'SHLVL': '1', 20:43:50 INFO - 'TERM': 'linux', 20:43:50 INFO - 'TMOUT': '86400', 20:43:50 INFO - 'USER': 'cltbld', 20:43:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295', 20:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:50 INFO - '_': '/tools/buildbot/bin/python'} 20:43:50 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/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:43:50 INFO - mozversion application_buildid: 20160821190553 20:43:50 INFO - mozversion application_changeset: d16d42082abf5a0251baef11ce2913828f653b2b 20:43:50 INFO - mozversion application_display_name: Nightly 20:43:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:43:50 INFO - mozversion application_name: Firefox 20:43:50 INFO - mozversion application_remotingname: firefox 20:43:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:43:50 INFO - mozversion application_vendor: Mozilla 20:43:50 INFO - mozversion application_version: 51.0a1 20:43:50 INFO - mozversion platform_buildid: 20160821190553 20:43:50 INFO - mozversion platform_changeset: d16d42082abf5a0251baef11ce2913828f653b2b 20:43:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:43:50 INFO - mozversion platform_version: 51.0a1 20:43:50 INFO - using testdate: 1471837430 20:43:50 INFO - actual date: 1471837430 20:43:50 INFO - starting webserver on 'localhost:33538' 20:43:50 INFO - SUITE-START | Running 2 tests 20:43:50 INFO - TEST-START | dromaeo_css 20:43:50 INFO - operating with platform_type : linux_ 20:43:50 INFO - Initialising browser for dromaeo_css test... 20:43:50 INFO - TEST-INFO | started process 15040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSCOGT/profile http://localhost:33538/getInfo.html) 20:43:55 INFO - PROCESS | 15040 | __metrics Screen width/height:1600/1200 20:43:55 INFO - PROCESS | 15040 | colorDepth:24 20:43:55 INFO - PROCESS | 15040 | Browser inner width/height: 1024/697 20:43:55 INFO - PROCESS | 15040 | __metrics 20:43:56 INFO - PROCESS | 15040 | 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" 20:43:56 INFO - PROCESS | 15040 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:43:57 INFO - PROCESS | 15040 | console.error: PushService: 20:43:57 INFO - PROCESS | 15040 | stateChangeProcessEnqueue: Error transitioning state 20:43:57 INFO - PROCESS | 15040 | UnknownError 20:43:57 INFO - TEST-INFO | 15040: exit 0 20:43:57 INFO - Browser initialized. 20:43:57 INFO - Running cycle 1/1 for dromaeo_css test... 20:43:57 INFO - TEST-INFO | started process 15120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSCOGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:10 INFO - PROCESS | 15120 | RSS: Main: 180887552 20:44:10 INFO - PROCESS | 15120 | 20:45:01 INFO - PROCESS | 15120 | 1471837501918 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] 20:47:14 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33538/tests/dromaeo/cssquery-ext.html) 20:47:15 INFO - PROCESS | 15120 | RSS: Main: 263946240 20:47:15 INFO - PROCESS | 15120 | 20:50:18 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-ext.html (next: http://localhost:33538/tests/dromaeo/cssquery-jquery.html) 20:50:19 INFO - PROCESS | 15120 | RSS: Main: 278159360 20:50:19 INFO - PROCESS | 15120 | 20:53:21 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33538/tests/dromaeo/cssquery-mootools.html) 20:53:22 INFO - PROCESS | 15120 | RSS: Main: 238792704 20:53:22 INFO - PROCESS | 15120 | 20:56:24 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33538/tests/dromaeo/cssquery-prototype.html) 20:56:25 INFO - PROCESS | 15120 | RSS: Main: 218652672 20:56:25 INFO - PROCESS | 15120 | 20:59:28 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33538/tests/dromaeo/cssquery-yui.html) 20:59:28 INFO - PROCESS | 15120 | RSS: Main: 218562560 20:59:28 INFO - PROCESS | 15120 | 21:02:31 INFO - PROCESS | 15120 | Cycle 1(1): loaded http://localhost:33538/tests/dromaeo/cssquery-yui.html (next: http://localhost:33538/tests/dromaeo/cssquery-dojo.html) 21:02:32 INFO - PROCESS | 15120 | RSS: Main: 287744000 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | __start_tp_report 21:02:32 INFO - PROCESS | 15120 | _x_x_mozilla_page_load 21:02:32 INFO - PROCESS | 15120 | _x_x_mozilla_page_load_details 21:02:32 INFO - PROCESS | 15120 | |i|pagename|runs| 21:02:32 INFO - PROCESS | 15120 | |0;dojo.html;2555.1312553731727;2585.017693276555;2591.688997320322;2593.0794567928374;2594.2865711929217;4686.695364801286;4714.080754252922;4798.4961579034225;4882.633802464816;4910.607151427891;4810.711357318563;4826.734529600871;4868.099401610696;4876.561109500144;4909.042736666352;4444.20004399208;4466.352378905057;4491.101779644068;4515.142122996636;4526.117407105616;4526.705764125338;4551.317302404649;4564.589186973171;4570.154521413532;4571.200039993005;4305.375720520538;4346.8043938022865;4362.803673834654;4503.932441013388;4530.229860923618;4376.912461750747;4382;4383.517813040563;4409.779511024468;4411.735295882258;4427.2695005324085;4438.778061096932;4441.911161776747;4481.7983190756495;4505.144022635689;4895.510448955111;4930.605551555867;4930.654854160211;4930.926036109461;4932.753362331869;5058.266551350033;5068.467810879842;5119.6160287978555;5124.154514505102;5257.605679574009;5185.740712964337;5186.636935414523;5188;5214.165733482662;5224.242484839677;4849.539293767087;4860.1008813369635;4862.05189987949;4868.537488938545;4873.171560834667;5132;5238;5303.7878484860175;5304.708241046702;5384.273123128406;5130.384353877558;5160.767765450564;5166.45752196014;5166.509181627739;5166.664166829144;5225.372955245319;5234.659747116425;5252.684838909678;5260.552853007537;5275;5006.098902197639;5032.421271553745;5092.26162206478;5096.0827051131155;5141.126008578551;5176.534111929869;5176.559992400613;5181.844544663666;5186.818461353834;5187.507186817246;4493.595576398075;4495.056038231943;4496.348029535699;4502.977485112553;4503.752293623882;3776.962230377716;3820.465134881119;3840.635139661728;3858.5562660293863;3875.8255878485534;4437.356583295404;4445.711028783118;4445.711028783118;4457.8439754608435;4463.531329210451;5270.894582108336;5272.762725677354;5275.841724748264;5280.9207861882105;5289.523942845162;4285.849995250152;4336.848210312624;4397.098594788061;4408.074304396048;4440.666949978765;4739.218029025241;4744.7390393528685;4753.120672675566;4760.119377915027;4767.427908650984;4802.639802014793;4845.854624361275;4848.0788650156355;4848.975755121343;4852;5001.824936127218;5119.28330033803;5126.615503837153;5132.153194722829;5249.133892907627;4781.497942715965;4786.353842231254;4803.279508073817;4803.5916947059895;4823.372961515121;5149.201873709581;5159.793608255628;5161.071007218737;5161.09680805865;5161.458046905021;4996.7001979881325;4997.225430058346;5079.415867175322;5099.184130539096;5212.452692467388;5003.599712023102;5056.84829455117;5065.341505604248;5066.493350664904;5067.46791586878;5049.949500505095;5052.292679025013;5062.594992400673;5065.316182315488;5069.949300507095;4681.882952926204;4835.29888166221;4846.830360937351;4884.41387033544;4962.206047032601;5067.569256613082;5080.237964305236;5086.720230387365;5095.286659867696;5124.077666020152;4988.8752781180765;4992.72540010303;5000.824971125993;5005.924911126263;5006.199008158677 21:02:32 INFO - PROCESS | 15120 | |1;ext.html;526.3604720264879;567.0586825869058;567.480755109075;568.5196009372082;568.9886202275954;28417.289567760818;30884.69115308846;38863.22273554531;39888.202235955265;39971.60028399715;39668.60331396685;40056.59943400565;40103.19793604126;40113.59886401135;40150.397744033864;7609.733659321939;7772.455928085036;7784.532928024309;7788.299053085221;7793.4934229275195;7331.41348692106;7662.616869156548;9643.710688679352;9873.851892221586;9888.752781180492;10056.69829905104;10125.24060695447;10125.696229113139;10130.442825644586;10130.84803727941;9745.122938935494;9752.609895604168;9780.266480014028;9810.70567882961;9811.166050885684;9751.609935602568;9812.595914001044;9815.11663950248;9816.950915245377;9818.65634702782;36887.81556092203;37270.44094338587;37277;37503.24993500115;37504.24991500155;2832.9433411331865;2950.144458107168;2961.4373269078806;2996.0712179224292;3035.4232695787728;28217.576736348972;28801.855990719912;28816;28841.85579072112;28845.134645960447;3235.7573182011442;3240.319532898094;3286.7112042009567;3320.933581328384;3388.119089036868;179309.1034544832;179342;179398;179425;179850;50481.74759126181;50625.24062139071;50816.745916270185;50846.49153508418;50858.439909206;52980.47019529755;53213.467865321625;53267.20099198515;53400.38793017294;53410;12967.675808104685;13137.146085504412;13150.60548183556;13167.736645267041;13173.868261317455;9003.234725048313;9806.117449429586;9828.655997040212;9844.753881152885;9860.260480463994;13492.730145397038;14992.400303987719;15375.615609609626;15447.459338923083;16018.919905400398;4929.926051109236;5561.249231353715;5727.169560413717;5729.4843464088435;5761.193432919395;682.501773705188;738.5716284554945;755.4183278875236;782.5383024015858;838.0822998816286;23504.882475587856;23636.527269454513;23694.88152559226;23998;24128.63807042896;821.40858581821;827.2513375395276;828.4076885027234;829.639106988462;837.9916200838036;12417.875821241852;12567.874321256853;12645.304508251951;12722.427490762939;12765.106442549119;357323;359460;360214;361289;362229;42914.78542607267;47815.282770758466;48522.5147748518;48567.27149092766;48600.27099593509;1127.4982632728356;1141.0814294493014;1165.0621249893916;1165.5862168930078;1173.7593793272188;27361.042363517976;28352;28489.43595076453;28797.856010719814;28946.565801512574;41139.588604113575;41537.37693934654;41543.169136617704;41607;41622;311971;312999;313059;313487;313914;23980;24841.627375589742;35620.28759424849;35776;35941.28117437689;40469.797651011555;40667.7966610165;41055.58944410637;41403.86723069994;42356.152876942906;34969.65030349664;35463.82268088643;35890.820545897106;36092.819535902156;36252.63747362493;35456.29087418289;36207;36247.81876090708;36277.818610906776;36458.63541364658;34816.47775283423;35018.299634007686;35117.29765404729;35127.82436087803;35987;30540.389192216477;33008.1747956303;33059.50410743889;33250;33601.49597755987;24940.376490587154;25261;25385.478202347866;25455.618165727898;25471.36321591975 21:02:32 INFO - PROCESS | 15120 | |2;jquery.html;343.2682118711102;361.4921035944497;368.9557253129624;370.5497820148519;388.2506761949438;12808.359582020908;16164.515064548068;16212.594685132877;16236.269367878444;16470.588235294093;15686.294116764744;15817.525474235763;16180.75728864068;16423.67152656949;16590.50228493144;4461.241588929874;4960.751962401883;5168.896622067557;5208.479152084799;5252.921206181911;5050.696958182502;5076.466970968032;5113.5909127269915;5114.718690472023;5116.641835071547;4933.333999910002;5079.415867175267;5088.058709138802;5096.4648711885275;5142.511461411179;5024.145895197807;5050.090983622947;5050.873728156789;5055.69665820052;5056.544910958013;4355.216061108999;4523.751193684346;4535.478419981679;4536.818527258905;4566.725996440225;20374;20853;20951.68572471414;21000;21079.789202107935;1822.3986084592052;1868.1291411271256;1940.4469726128127;2049.918003279867;2249.6962910007105;12803;13149.86850131496;13389.531366402227;13609;13623.18260904349;1779.4661601519492;1779.8932064076198;1783.7413575031678;1784.2060283173994;1795.6139430022477;69244.30755692479;69787.99999999949;69984;70114.64942675254;71996;8511;8535.445196062235;8889.777755556033;9764.658236961672;9977.306127345577;13182.209067455791;13222.404991775393;13222.669433264246;13223.206607603575;13237.933810330887;6928.669450202918;7003.2296447390745;7197.1363436387965;7219.927800722031;7265.455090868206;6534.215894092739;6587.80236592903;6588.901166482507;6758.898616520658;6761.560498567577;6068.33248342682;6143.109249158936;6144.631322120687;6176.258848938156;6343.302236753953;1744.1453687693192;1785.2501949181376;1805.1786437171056;1808.3489943620286;1815.2648177488138;821.7165078048064;830.98338033239;888.2139306713605;914.679862048291;948.7059011706393;16599.50201493957;16938.491845244414;17357.7396339055;17442.24991626781;17758.733618995724;738.5384134915678;745.7240820896303;818.1859050245045;847.6355167278007;870.9608067636972;9629.759256018655;9955.104040636377;9984.500774961223;10067.295289329677;10109.64616238428;352384;355890;360916;362797;363481;66725.33274667288;67195;67574.66212668906;67976.66011670009;70222.64888675524;877.7015814623059;880.5465185429509;910.2763303173992;911.145818259838;914.7438717159206;14947.77578336304;15181.924090379478;15545.37818487293;15781.368745250062;15931.8406815935;34684;34714.63871507664;35228.82385588055;36021.81989090038;36719.449208261365;44729.32906006347;45341.54658453373;45970.540294597966;46361.53638463572;46408.30387544122;4387.692861499664;7202.243764404662;7207.171175314906;7301.452391070798;7724.420668450001;10578.206634502598;10638.14894808398;10687.946560267148;10873.130149588173;10915.290506117077;8863.778405539913;8941.284697224337;9484.715458536255;9695.272854535797;9922.156616687662;4496.865094047183;7117.430605551647;8106.270435660819;9405.05949405054;10031.197504199792;8982.55087245622;9258.583363748512;9568.234541236545;9906.306558540833;10202.897971020195;7309.342159205697;7436.553806771611;7504.249575042452;7671.041119860018;7849.882251766342;9499.857502137611;9536.666216682383;9578.090081442251;9711.125998660154;9858.408495490294 21:02:32 INFO - PROCESS | 15120 | |3;mootools.html;1247.7130260040185;1355.8711922367377;1381.2265131526347;1449.4347204590213;1657.1796960504553;6550.8689826203445;7075;7348.706051757937;7358.04345435094;7551.244875512446;7378.151512576042;7448.106227252737;7449.441291903116;7455.813604659887;7458.067741532309;2168.0568952505632;2196.0447205465675;2198.7691292414306;2200.2189222825905;2201.3395981205576;2135.647618143012;2165.891705414731;2202.702635144251;2203.790639889208;2204.0853045985896;2148.785121487854;2169.533550286688;2174.63031284682;2175.1299480207963;2177.510060236442;2091.3203208957075;2095.20382254743;2097.748270207585;2100.096958307927;2101.054525463532;2069.772325044244;2128.936131916045;2129;2129.7231359923267;2131.445824085749;7236.059312289369;7396.4822462427655;7437.44219183558;7441.627918604048;7444.330010299099;4188.518320393163;4304.720193187464;4318;4324.589164029412;4327.956720432819;2765.2119146043483;2890.8554572271514;2911.7379435850876;2924.1666125154443;2926.75122614578;927.7587827164919;934.700895713372;939.8919124300656;949.852772820214;960.7934294126796;9605;9610.231181505533;9650.276229282832;9655.806883862284;9658.275629327758;3838.3858582626644;3960.603939606074;3971.4241434991764;4080.449139366207;4271.252530807096;7669.53982761025;7794.142644309121;7801.609919504002;7805.726799561988;7808.726694565663;4276.978615106967;4313.61177494027;4317.481902171759;4321.2005778931;4323.54602766705;3428.9828550857587;3796.354619714655;3941.0541470047556;3966.940495892564;3967.3850553164307;3282.5240340150544;3295.489199174132;3363.714084302813;3409.7272218222483;3416.4533674611944;1036.388530766851;1037.984430233547;1053.2837670384213;1057.1384321777728;1068.2148620763733;804.3926835239357;822.3421262989584;830.7082486733187;832.1262674192075;847.588919374103;4852.1508735971065;4916.483769204254;5017.297578339036;5038.47096054909;5100.336956195745;410.1673602586694;417.89761508430627;421.8228344095487;422.7019950934584;425.9893502662458;3283.2612662150823;3309.3712194682935;3310.536524886518;3414.931701365959;3455.222574920673;8575.1424857515;8940.240079593308;8948.463092214357;8958.328125390623;8977.865332020025;8913.866292005625;8915.37592368541;8920.152585504367;8921.375503714808;8923.196912277926;6873.862522749617;6945.131858517685;6949.339812717783;6952.965235173893;6956.791296261019;4719;4730.5269473053795;4784.138855006132;4836.12949669063;4962.578180854523;8186.426950113673;8201.26188643025;8211.302039326723;8316.126806685212;8360.122187170502;8255.628496717542;8357.289630381243;8399.580020999048;8402.11777763326;8417;5536.114221724505;6001.7599296027665;6056.697165141637;6069.848253793691;6080.027195648675;6862.142232220973;7017.333353331425;7075.150981882207;7173.067501225016;7181.820454488679;6182.721777519932;6373.267074286517;6388.4569811566535;6441.5490915635455;6497.4477169441125;6193.318734939063;6281.937180628135;6290.748370065146;6331.2085989251345;6367.681615919279;5717.685527296038;5749.54003679713;5749.655020698604;5757.884842303047;5760.135979603093;4206.621404073648;4238.894027649333;4241.597048280409;4344.413504176896;4370.606645401929;4203.243416185116;4275.700700951028;4365.257906155897;4390.275604525217;4515 21:02:32 INFO - PROCESS | 15120 | |4;prototype.html;302.5129541438284;303.8025283565682;305.454763247603;305.669876533344;308.6019035444277;4758.904821903559;4856.611471082314;4868.440129385117;4934.605231581474;4955.454899961011;4812.061647978646;4837.274408838676;4852.902941941159;4886.8778280543;4893.608511319095;3608;3686.64976827201;3699.8335074921692;3785.772853628784;3786.8295926683227;3755.230177813555;3781.338265803487;3791.867284645038;3792.3742582473997;3822.808859557025;3738.21497485527;3762.623737626243;3764.228333191703;3780.659740623343;3784.148566572513;3574.964250357489;3634.309481198564;3749.625037496256;3761.492198553188;3764.908176628761;3283.326917981808;3292.5555050068174;3313.3207692422993;3313.8343082846004;3332.783369081026;4691.366665500148;4703.106409782131;4711.717296962159;4723.976380118112;4731.787069581843;4145.461090058273;4259.403683484315;4260.70175087744;4268.551802060801;4275.862068965517;4928.67963582366;4963.45402005779;4968.950310496921;4971.37857767779;4993.750312484398;3561.8397172127316;3569.1969306906;3571.6785489305826;3572.910677233064;3584.2473080652835;5223.947760522384;5250.291210686585;5285.286486324336;5308.867278318073;5324.201369794523;3582.731295152874;3648.1973965727498;3660.670539651444;3661.761985470936;3661.8901432957055;3703.203811180609;3707.5180226570374;3723.590405055442;3746.119661879456;3749.3063783200196;4250.936235956463;4253.766042867672;4271.693285625789;4274.166537525215;4283.678724095706;4838.129136755348;5012.145506162743;5035.269885866602;5044.344235249394;5067.41724701664;1269.2130878854985;1287.2019348004296;1294.4239813283186;1299.753046921082;1301.9674508137373;799.2846402469758;814.5642081486376;816.8202995341015;831;835.3233880556769;3980.960190398059;3990.2817492851564;4240.745555266694;4367.323064924942;4371.715838470553;5051.570616497639;5080.898382032413;5109.718965456936;5117;5211.244369566468;4420.381146639473;4426.490953540319;4431.290993441034;4447.777611119431;4457.375967364572;2661.5209262332964;2756.6967633560294;2759.7654199392873;2774.5283301838735;2788.4144329690585;4806.279058141236;4812.374391329105;4820.783064762094;4822.276658501253;4836.371271734652;5299.231611416323;5307.8142265021315;5309.65487243328;5320.388155362106;5338.866528336823;4687.882802929954;4829.9275510868065;4849.806007759721;4860.6111511079735;4890.290907818347;5153.330067091404;5178.275041494269;5184.377874654915;5188.688678679291;5204.141316682856;5081.4918508148885;5102;5103.157978933435;5156.819511317086;5160.767765450489;4705.270683044134;4743.359646447685;4768.235752771497;4774.522547745198;4792.424909010941;3634.164142247351;3640.180959284246;3641.2717456509336;3652.160003199226;3652.9406771620966;5226.163813789775;5236.162214045735;5243.370795504564;5247.370315562157;5258.263843062051;4877.5366340197625;5028.472010438852;5050.005247927122;5082.009008243505;5108.284840122312;5001.349824522788;5004.946982340696;5010.348654674869;5016.372953380827;5038.748062596782;4962.255661650781;4965;4981.2030075187795;4992.375953005874;5023.643616223672;4859.125357435695;4917.188663870421;5084.186530155157;5113.903299647127;5128.692278463304;4876.951230487792;5011.223260394645;5044.697318160922;5052.1411360069615;5053.8736531587 21:02:32 INFO - PROCESS | 15120 | |5;yui.html;574.3309044962618;585.6837307853757;638.4477427025624;661.4543002023332;670.2225418514524;12054.69863253418;12055.698607534816;12666.620001399973;12827.871721282796;13292.202467851912;13103.73792524149;13202.53791117311;13328.866711332883;13375.933120334408;13413.061085724003;626.7242413338116;740.2375553180233;767.2136060537938;775.0970119810414;775.437807589496;740.1968863782802;763.1338430880962;768.1089935674619;770.5954373953663;772.8377040821434;810.0603300171801;812.9065157506903;813.1177672225642;813.3615112136973;813.9959300203491;646.8027251688234;804.7947773317767;807.5033854179667;807.7617102954642;807.9232472915064;566;569.7607005057886;577.3648986115239;586.1939832729996;586.3637952821194;12642.304673242968;12783.29691866947;12804.551840685532;12833.743325133444;12936.935315323457;12313.322767247797;12764.042696797776;12807.679808004781;13145.60563183106;13448.529301474402;11087.72280692989;11188.552457901675;11342.262752921033;11560.190786644938;11574.47914843834;4092.9386059209137;4120.876373708794;4127.855525056639;4298.20483210607;4326.675499337531;57753.13370299407;58489;58647;59480.70259648717;59715.70142149262;10083.243756718275;10259.076683098408;10358.274920755626;10367.222458315657;10440.216983726252;19266.422007339803;19319.517012074528;19321.806781932282;19330.323438679578;19337;6069.756160342169;6741.764038258735;6805.693743781541;6834.897476537856;6864.553804002724;3649.923272634579;3732.8506859725308;3768.679662228741;3795.2030073684837;3913.4521167036637;2593.6757905261843;2663.094547853739;2678.5178667839978;2682.5573780326417;2684.2215757430517;447.9507254202035;465.26720415345966;470.22882472744726;477.69904959875055;484.2977682360521;451.905099929012;487.36642364925456;489.9583535399531;492.4164864635347;501.15555289337584;7591.620418979029;7875.763727088197;7935.285824275843;7944.245296696805;7953.761387158394;457.9404677391984;485.61636307316826;492.9580985616263;496.35226030031157;496.68708713510256;3553.520274762874;3571.392873207067;3623.166671665532;3679.7608155469807;3708.4622729704042;92997.5350123245;100494;102359.48820255851;102915;103046;77352;86920;87423.56288218519;90058;91122.54438727896;72382.2761772386;77524.61237693776;79025.20974790293;79470;79836.60081699787;7033.859322813618;7058.752943647153;7061.329173728693;7325.084364454443;7437.367823735043;45597.54402455933;47458.28812567745;48449.5155048445;49378.75310623424;49419.75290123526;63002.68498657477;66863.66568167323;67302.3269767296;68492.657536712;70942.29057709356;9016.684416045407;9055.728328150166;9272.907270927204;9391.154796068387;9508.191803696764;9679;9823.85264221023;9934.652287169914;10057.396556206651;10168.847467288144;8794.384393092421;8803.779905502413;8851.955740221258;8863.689770857989;9226.123518265755;8592.871106933277;8599.52702601363;8645.697400590949;8766.21104100634;9038.728838134866;8437.87343189865;8561.14388561139;8631.611577479154;8846.15961483658;8961.625169330002;7707.2292770724725;7785.026871641045;7812.92187078122;8014.759557213293;8244.051934027664;7588.96205518991;7759.534427934342;7988.960055199686;8260.421770476249;8333.624986875484 21:02:32 INFO - PROCESS | 15120 | __end_tp_report 21:02:32 INFO - PROCESS | 15120 | __start_cc_report 21:02:32 INFO - PROCESS | 15120 | _x_x_mozilla_cycle_collect,1022 21:02:32 INFO - PROCESS | 15120 | __end_cc_report 21:02:32 INFO - PROCESS | 15120 | __startTimestamp1471838552043__endTimestamp 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | ------- Summary: start ------- 21:02:32 INFO - PROCESS | 15120 | Number of tests: 6 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#0] dojo.html Cycles:165 Average:4782.64 Median:4895.51 stddev:516.35 (10.5%) stddev-sans-first:487.47 21:02:32 INFO - PROCESS | 15120 | Values: 2555.1 2585.0 2591.7 2593.1 2594.3 4686.7 4714.1 4798.5 4882.6 4910.6 4810.7 4826.7 4868.1 4876.6 4909.0 4444.2 4466.4 4491.1 4515.1 4526.1 4526.7 4551.3 4564.6 4570.2 4571.2 4305.4 4346.8 4362.8 4503.9 4530.2 4376.9 4382.0 4383.5 4409.8 4411.7 4427.3 4438.8 4441.9 4481.8 4505.1 4895.5 4930.6 4930.7 4930.9 4932.8 5058.3 5068.5 5119.6 5124.2 5257.6 5185.7 5186.6 5188.0 5214.2 5224.2 4849.5 4860.1 4862.1 4868.5 4873.2 5132.0 5238.0 5303.8 5304.7 5384.3 5130.4 5160.8 5166.5 5166.5 5166.7 5225.4 5234.7 5252.7 5260.6 5275.0 5006.1 5032.4 5092.3 5096.1 5141.1 5176.5 5176.6 5181.8 5186.8 5187.5 4493.6 4495.1 4496.3 4503.0 4503.8 3777.0 3820.5 3840.6 3858.6 3875.8 4437.4 4445.7 4445.7 4457.8 4463.5 5270.9 5272.8 5275.8 5280.9 5289.5 4285.8 4336.8 4397.1 4408.1 4440.7 4739.2 4744.7 4753.1 4760.1 4767.4 4802.6 4845.9 4848.1 4849.0 4852.0 5001.8 5119.3 5126.6 5132.2 5249.1 4781.5 4786.4 4803.3 4803.6 4823.4 5149.2 5159.8 5161.1 5161.1 5161.5 4996.7 4997.2 5079.4 5099.2 5212.5 5003.6 5056.8 5065.3 5066.5 5067.5 5049.9 5052.3 5062.6 5065.3 5069.9 4681.9 4835.3 4846.8 4884.4 4962.2 5067.6 5080.2 5086.7 5095.3 5124.1 4988.9 4992.7 5000.8 5005.9 5006.2 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#1] ext.html Cycles:180 Average:44127.72 Median:198748.00 stddev:77502.11 (39.0%) stddev-sans-first:77650.38 21:02:32 INFO - PROCESS | 15120 | Values: 526.4 567.1 567.5 568.5 569.0 28417.3 30884.7 38863.2 39888.2 39971.6 39668.6 40056.6 40103.2 40113.6 40150.4 7609.7 7772.5 7784.5 7788.3 7793.5 7331.4 7662.6 9643.7 9873.9 9888.8 10056.7 10125.2 10125.7 10130.4 10130.8 9745.1 9752.6 9780.3 9810.7 9811.2 9751.6 9812.6 9815.1 9817.0 9818.7 36887.8 37270.4 37277.0 37503.2 37504.2 2832.9 2950.1 2961.4 2996.1 3035.4 28217.6 28801.9 28816.0 28841.9 28845.1 3235.8 3240.3 3286.7 3320.9 3388.1 179309.1 179342.0 179398.0 179425.0 179850.0 50481.7 50625.2 50816.7 50846.5 50858.4 52980.5 53213.5 53267.2 53400.4 53410.0 12967.7 13137.1 13150.6 13167.7 13173.9 9003.2 9806.1 9828.7 9844.8 9860.3 13492.7 14992.4 15375.6 15447.5 16018.9 4929.9 5561.2 5727.2 5729.5 5761.2 682.5 738.6 755.4 782.5 838.1 23504.9 23636.5 23694.9 23998.0 24128.6 821.4 827.3 828.4 829.6 838.0 12417.9 12567.9 12645.3 12722.4 12765.1 357323.0 359460.0 360214.0 361289.0 362229.0 42914.8 47815.3 48522.5 48567.3 48600.3 1127.5 1141.1 1165.1 1165.6 1173.8 27361.0 28352.0 28489.4 28797.9 28946.6 41139.6 41537.4 41543.2 41607.0 41622.0 311971.0 312999.0 313059.0 313487.0 313914.0 23980.0 24841.6 35620.3 35776.0 35941.3 40469.8 40667.8 41055.6 41403.9 42356.2 34969.7 35463.8 35890.8 36092.8 36252.6 35456.3 36207.0 36247.8 36277.8 36458.6 34816.5 35018.3 35117.3 35127.8 35987.0 30540.4 33008.2 33059.5 33250.0 33601.5 24940.4 25261.0 25385.5 25455.6 25471.4 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#2] jquery.html Cycles:180 Average:22890.28 Median:5050.39 stddev:59289.26 (1174.0%) stddev-sans-first:59431.41 21:02:32 INFO - PROCESS | 15120 | Values: 343.3 361.5 369.0 370.5 388.3 12808.4 16164.5 16212.6 16236.3 16470.6 15686.3 15817.5 16180.8 16423.7 16590.5 4461.2 4960.8 5168.9 5208.5 5252.9 5050.7 5076.5 5113.6 5114.7 5116.6 4933.3 5079.4 5088.1 5096.5 5142.5 5024.1 5050.1 5050.9 5055.7 5056.5 4355.2 4523.8 4535.5 4536.8 4566.7 20374.0 20853.0 20951.7 21000.0 21079.8 1822.4 1868.1 1940.4 2049.9 2249.7 12803.0 13149.9 13389.5 13609.0 13623.2 1779.5 1779.9 1783.7 1784.2 1795.6 69244.3 69788.0 69984.0 70114.6 71996.0 8511.0 8535.4 8889.8 9764.7 9977.3 13182.2 13222.4 13222.7 13223.2 13237.9 6928.7 7003.2 7197.1 7219.9 7265.5 6534.2 6587.8 6588.9 6758.9 6761.6 6068.3 6143.1 6144.6 6176.3 6343.3 1744.1 1785.3 1805.2 1808.3 1815.3 821.7 831.0 888.2 914.7 948.7 16599.5 16938.5 17357.7 17442.2 17758.7 738.5 745.7 818.2 847.6 871.0 9629.8 9955.1 9984.5 10067.3 10109.6 352384.0 355890.0 360916.0 362797.0 363481.0 66725.3 67195.0 67574.7 67976.7 70222.6 877.7 880.5 910.3 911.1 914.7 14947.8 15181.9 15545.4 15781.4 15931.8 34684.0 34714.6 35228.8 36021.8 36719.4 44729.3 45341.5 45970.5 46361.5 46408.3 4387.7 7202.2 7207.2 7301.5 7724.4 10578.2 10638.1 10687.9 10873.1 10915.3 8863.8 8941.3 9484.7 9695.3 9922.2 4496.9 7117.4 8106.3 9405.1 10031.2 8982.6 9258.6 9568.2 9906.3 10202.9 7309.3 7436.6 7504.2 7671.0 7849.9 9499.9 9536.7 9578.1 9711.1 9858.4 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#3] mootools.html Cycles:180 Average:4780.01 Median:4939.53 stddev:2629.98 (53.2%) stddev-sans-first:2623.96 21:02:32 INFO - PROCESS | 15120 | Values: 1247.7 1355.9 1381.2 1449.4 1657.2 6550.9 7075.0 7348.7 7358.0 7551.2 7378.2 7448.1 7449.4 7455.8 7458.1 2168.1 2196.0 2198.8 2200.2 2201.3 2135.6 2165.9 2202.7 2203.8 2204.1 2148.8 2169.5 2174.6 2175.1 2177.5 2091.3 2095.2 2097.7 2100.1 2101.1 2069.8 2128.9 2129.0 2129.7 2131.4 7236.1 7396.5 7437.4 7441.6 7444.3 4188.5 4304.7 4318.0 4324.6 4328.0 2765.2 2890.9 2911.7 2924.2 2926.8 927.8 934.7 939.9 949.9 960.8 9605.0 9610.2 9650.3 9655.8 9658.3 3838.4 3960.6 3971.4 4080.4 4271.3 7669.5 7794.1 7801.6 7805.7 7808.7 4277.0 4313.6 4317.5 4321.2 4323.5 3429.0 3796.4 3941.1 3966.9 3967.4 3282.5 3295.5 3363.7 3409.7 3416.5 1036.4 1038.0 1053.3 1057.1 1068.2 804.4 822.3 830.7 832.1 847.6 4852.2 4916.5 5017.3 5038.5 5100.3 410.2 417.9 421.8 422.7 426.0 3283.3 3309.4 3310.5 3414.9 3455.2 8575.1 8940.2 8948.5 8958.3 8977.9 8913.9 8915.4 8920.2 8921.4 8923.2 6873.9 6945.1 6949.3 6953.0 6956.8 4719.0 4730.5 4784.1 4836.1 4962.6 8186.4 8201.3 8211.3 8316.1 8360.1 8255.6 8357.3 8399.6 8402.1 8417.0 5536.1 6001.8 6056.7 6069.8 6080.0 6862.1 7017.3 7075.2 7173.1 7181.8 6182.7 6373.3 6388.5 6441.5 6497.4 6193.3 6281.9 6290.7 6331.2 6367.7 5717.7 5749.5 5749.7 5757.9 5760.1 4206.6 4238.9 4241.6 4344.4 4370.6 4203.2 4275.7 4365.3 4390.3 4515.0 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#4] prototype.html Cycles:180 Average:4174.29 Median:4783.47 stddev:1217.64 (25.5%) stddev-sans-first:1185.88 21:02:32 INFO - PROCESS | 15120 | Values: 302.5 303.8 305.5 305.7 308.6 4758.9 4856.6 4868.4 4934.6 4955.5 4812.1 4837.3 4852.9 4886.9 4893.6 3608.0 3686.6 3699.8 3785.8 3786.8 3755.2 3781.3 3791.9 3792.4 3822.8 3738.2 3762.6 3764.2 3780.7 3784.1 3575.0 3634.3 3749.6 3761.5 3764.9 3283.3 3292.6 3313.3 3313.8 3332.8 4691.4 4703.1 4711.7 4724.0 4731.8 4145.5 4259.4 4260.7 4268.6 4275.9 4928.7 4963.5 4969.0 4971.4 4993.8 3561.8 3569.2 3571.7 3572.9 3584.2 5223.9 5250.3 5285.3 5308.9 5324.2 3582.7 3648.2 3660.7 3661.8 3661.9 3703.2 3707.5 3723.6 3746.1 3749.3 4250.9 4253.8 4271.7 4274.2 4283.7 4838.1 5012.1 5035.3 5044.3 5067.4 1269.2 1287.2 1294.4 1299.8 1302.0 799.3 814.6 816.8 831.0 835.3 3981.0 3990.3 4240.7 4367.3 4371.7 5051.6 5080.9 5109.7 5117.0 5211.2 4420.4 4426.5 4431.3 4447.8 4457.4 2661.5 2756.7 2759.8 2774.5 2788.4 4806.3 4812.4 4820.8 4822.3 4836.4 5299.2 5307.8 5309.7 5320.4 5338.9 4687.9 4829.9 4849.8 4860.6 4890.3 5153.3 5178.3 5184.4 5188.7 5204.1 5081.5 5102.0 5103.2 5156.8 5160.8 4705.3 4743.4 4768.2 4774.5 4792.4 3634.2 3640.2 3641.3 3652.2 3652.9 5226.2 5236.2 5243.4 5247.4 5258.3 4877.5 5028.5 5050.0 5082.0 5108.3 5001.3 5004.9 5010.3 5016.4 5038.7 4962.3 4965.0 4981.2 4992.4 5023.6 4859.1 4917.2 5084.2 5113.9 5128.7 4877.0 5011.2 5044.7 5052.1 5053.9 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - PROCESS | 15120 | [#5] yui.html Cycles:180 Average:17622.40 Median:59063.85 stddev:26321.28 (44.6%) stddev-sans-first:26363.99 21:02:32 INFO - PROCESS | 15120 | Values: 574.3 585.7 638.4 661.5 670.2 12054.7 12055.7 12666.6 12827.9 13292.2 13103.7 13202.5 13328.9 13375.9 13413.1 626.7 740.2 767.2 775.1 775.4 740.2 763.1 768.1 770.6 772.8 810.1 812.9 813.1 813.4 814.0 646.8 804.8 807.5 807.8 807.9 566.0 569.8 577.4 586.2 586.4 12642.3 12783.3 12804.6 12833.7 12936.9 12313.3 12764.0 12807.7 13145.6 13448.5 11087.7 11188.6 11342.3 11560.2 11574.5 4092.9 4120.9 4127.9 4298.2 4326.7 57753.1 58489.0 58647.0 59480.7 59715.7 10083.2 10259.1 10358.3 10367.2 10440.2 19266.4 19319.5 19321.8 19330.3 19337.0 6069.8 6741.8 6805.7 6834.9 6864.6 3649.9 3732.9 3768.7 3795.2 3913.5 2593.7 2663.1 2678.5 2682.6 2684.2 448.0 465.3 470.2 477.7 484.3 451.9 487.4 490.0 492.4 501.2 7591.6 7875.8 7935.3 7944.2 7953.8 457.9 485.6 493.0 496.4 496.7 3553.5 3571.4 3623.2 3679.8 3708.5 92997.5 100494.0 102359.5 102915.0 103046.0 77352.0 86920.0 87423.6 90058.0 91122.5 72382.3 77524.6 79025.2 79470.0 79836.6 7033.9 7058.8 7061.3 7325.1 7437.4 45597.5 47458.3 48449.5 49378.8 49419.8 63002.7 66863.7 67302.3 68492.7 70942.3 9016.7 9055.7 9272.9 9391.2 9508.2 9679.0 9823.9 9934.7 10057.4 10168.8 8794.4 8803.8 8852.0 8863.7 9226.1 8592.9 8599.5 8645.7 8766.2 9038.7 8437.9 8561.1 8631.6 8846.2 8961.6 7707.2 7785.0 7812.9 8014.8 8244.1 7589.0 7759.5 7989.0 8260.4 8333.6 21:02:32 INFO - PROCESS | 15120 | -------- Summary: end -------- 21:02:32 INFO - PROCESS | 15120 | 21:02:32 INFO - TEST-INFO | 15120: exit 0 21:02:32 INFO - TEST-OK | dromaeo_css | took 1122415ms 21:02:32 INFO - TEST-START | kraken 21:02:32 INFO - operating with platform_type : linux_ 21:02:32 INFO - Initialising browser for kraken test... 21:02:32 INFO - TEST-INFO | started process 15422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MSwY3/profile http://localhost:33538/getInfo.html) 21:02:38 INFO - PROCESS | 15422 | __metrics Screen width/height:1600/1200 21:02:38 INFO - PROCESS | 15422 | colorDepth:24 21:02:38 INFO - PROCESS | 15422 | Browser inner width/height: 1024/697 21:02:38 INFO - PROCESS | 15422 | __metrics 21:02:38 INFO - PROCESS | 15422 | 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" 21:02:38 INFO - PROCESS | 15422 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:02:39 INFO - PROCESS | 15422 | console.error: PushService: 21:02:39 INFO - PROCESS | 15422 | stateChangeProcessEnqueue: Error transitioning state 21:02:39 INFO - PROCESS | 15422 | UnknownError 21:02:39 INFO - TEST-INFO | 15422: exit 0 21:02:39 INFO - Browser initialized. 21:02:39 INFO - Running cycle 1/1 for kraken test... 21:02:39 INFO - TEST-INFO | started process 15500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MSwY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:52 INFO - PROCESS | 15500 | RSS: Main: 174972928 21:02:52 INFO - PROCESS | 15500 | 21:02:54 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33538/tests/kraken/driver.html?testName=audio-beat-detection) 21:02:55 INFO - PROCESS | 15500 | RSS: Main: 244543488 21:02:55 INFO - PROCESS | 15500 | 21:02:58 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33538/tests/kraken/driver.html?testName=audio-dft) 21:02:59 INFO - PROCESS | 15500 | RSS: Main: 227065856 21:02:59 INFO - PROCESS | 15500 | 21:03:02 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33538/tests/kraken/driver.html?testName=audio-fft) 21:03:03 INFO - PROCESS | 15500 | RSS: Main: 302444544 21:03:03 INFO - PROCESS | 15500 | 21:03:05 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33538/tests/kraken/driver.html?testName=audio-oscillator) 21:03:05 INFO - PROCESS | 15500 | RSS: Main: 210432000 21:03:05 INFO - PROCESS | 15500 | 21:03:08 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33538/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:03:08 INFO - PROCESS | 15500 | RSS: Main: 215195648 21:03:08 INFO - PROCESS | 15500 | 21:03:12 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33538/tests/kraken/driver.html?testName=imaging-darkroom) 21:03:12 INFO - PROCESS | 15500 | RSS: Main: 250273792 21:03:12 INFO - PROCESS | 15500 | 21:03:16 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33538/tests/kraken/driver.html?testName=imaging-desaturate) 21:03:16 INFO - PROCESS | 15500 | RSS: Main: 249155584 21:03:16 INFO - PROCESS | 15500 | 21:03:19 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33538/tests/kraken/driver.html?testName=json-parse-financial) 21:03:20 INFO - PROCESS | 15500 | RSS: Main: 249360384 21:03:20 INFO - PROCESS | 15500 | 21:03:22 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33538/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:03:22 INFO - PROCESS | 15500 | RSS: Main: 212185088 21:03:22 INFO - PROCESS | 15500 | 21:03:24 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:03:25 INFO - PROCESS | 15500 | RSS: Main: 219410432 21:03:25 INFO - PROCESS | 15500 | 21:03:27 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:03:28 INFO - PROCESS | 15500 | RSS: Main: 224194560 21:03:28 INFO - PROCESS | 15500 | 21:03:30 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:03:31 INFO - PROCESS | 15500 | RSS: Main: 219049984 21:03:31 INFO - PROCESS | 15500 | 21:03:34 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:03:35 INFO - PROCESS | 15500 | RSS: Main: 222281728 21:03:35 INFO - PROCESS | 15500 | 21:03:36 INFO - PROCESS | 15500 | Cycle 1(1): loaded http://localhost:33538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33538/tests/kraken/driver.html?testName=ai-astar) 21:03:37 INFO - PROCESS | 15500 | RSS: Main: 272879616 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | __start_tp_report 21:03:37 INFO - PROCESS | 15500 | _x_x_mozilla_page_load 21:03:37 INFO - PROCESS | 15500 | _x_x_mozilla_page_load_details 21:03:37 INFO - PROCESS | 15500 | |i|pagename|runs| 21:03:37 INFO - PROCESS | 15500 | |0;ai-astar;101;115;112;115;115;117;120;115;115;115 21:03:37 INFO - PROCESS | 15500 | |1;audio-beat-detection;154;127;155;196;129;157;157;123;197;121 21:03:37 INFO - PROCESS | 15500 | |2;audio-dft;162;162;163;161;164;162;161;163;162;162 21:03:37 INFO - PROCESS | 15500 | |3;audio-fft;75;75;76;179;77;76;77;125;112;76 21:03:37 INFO - PROCESS | 15500 | |4;audio-oscillator;87;86;152;86;86;87;137;88;88;137 21:03:37 INFO - PROCESS | 15500 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 21:03:37 INFO - PROCESS | 15500 | |6;imaging-darkroom;147;148;148;146;146;146;147;146;146;146 21:03:37 INFO - PROCESS | 15500 | |7;imaging-desaturate;95;95;95;94;95;94;94;95;95;94 21:03:37 INFO - PROCESS | 15500 | |8;json-parse-financial;64;64;66;66;65;66;67;65;65;65 21:03:37 INFO - PROCESS | 15500 | |9;json-stringify-tinderbox;65;65;66;65;66;64;65;65;65;72 21:03:37 INFO - PROCESS | 15500 | |10;stanford-crypto-aes;81;82;82;81;86;83;81;83;82;83 21:03:37 INFO - PROCESS | 15500 | |11;stanford-crypto-ccm;134;134;136;133;132;130;129;132;156;134 21:03:37 INFO - PROCESS | 15500 | |12;stanford-crypto-pbkdf2;178;172;173;172;173;176;175;175;175;171 21:03:37 INFO - PROCESS | 15500 | |13;stanford-crypto-sha256-iterative;70;71;71;71;68;69;69;67;72;67 21:03:37 INFO - PROCESS | 15500 | __end_tp_report 21:03:37 INFO - PROCESS | 15500 | __start_cc_report 21:03:37 INFO - PROCESS | 15500 | _x_x_mozilla_cycle_collect,2005 21:03:37 INFO - PROCESS | 15500 | __end_cc_report 21:03:37 INFO - PROCESS | 15500 | __startTimestamp1471838617218__endTimestamp 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | ------- Summary: start ------- 21:03:37 INFO - PROCESS | 15500 | Number of tests: 14 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:4.99 (4.3%) stddev-sans-first:2.13 21:03:37 INFO - PROCESS | 15500 | Values: 101.0 115.0 112.0 115.0 115.0 117.0 120.0 115.0 115.0 115.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.00 stddev:27.85 (17.8%) stddev-sans-first:29.52 21:03:37 INFO - PROCESS | 15500 | Values: 154.0 127.0 155.0 196.0 129.0 157.0 157.0 123.0 197.0 121.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 21:03:37 INFO - PROCESS | 15500 | Values: 162.0 162.0 163.0 161.0 164.0 162.0 161.0 163.0 162.0 162.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:34.60 (45.5%) stddev-sans-first:35.95 21:03:37 INFO - PROCESS | 15500 | Values: 75.0 75.0 76.0 179.0 77.0 76.0 77.0 125.0 112.0 76.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:86.50 stddev:26.96 (31.2%) stddev-sans-first:27.93 21:03:37 INFO - PROCESS | 15500 | Values: 87.0 86.0 152.0 86.0 86.0 87.0 137.0 88.0 88.0 137.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:03:37 INFO - PROCESS | 15500 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:03:37 INFO - PROCESS | 15500 | Values: 147.0 148.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:03:37 INFO - PROCESS | 15500 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 21:03:37 INFO - PROCESS | 15500 | Values: 64.0 64.0 66.0 66.0 65.0 66.0 67.0 65.0 65.0 65.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:2.25 (3.5%) stddev-sans-first:2.37 21:03:37 INFO - PROCESS | 15500 | Values: 65.0 65.0 66.0 65.0 66.0 64.0 65.0 65.0 65.0 72.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.51 (1.8%) stddev-sans-first:1.51 21:03:37 INFO - PROCESS | 15500 | Values: 81.0 82.0 82.0 81.0 86.0 83.0 81.0 83.0 82.0 83.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:134.00 stddev:7.66 (5.7%) stddev-sans-first:8.12 21:03:37 INFO - PROCESS | 15500 | Values: 134.0 134.0 136.0 133.0 132.0 130.0 129.0 132.0 156.0 134.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.00 stddev:2.16 (1.2%) stddev-sans-first:1.74 21:03:37 INFO - PROCESS | 15500 | Values: 178.0 172.0 173.0 172.0 173.0 176.0 175.0 175.0 175.0 171.0 21:03:37 INFO - PROCESS | 15500 | 21:03:37 INFO - PROCESS | 15500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.50 stddev:1.78 (2.5%) stddev-sans-first:1.88 21:03:37 INFO - PROCESS | 15500 | Values: 70.0 71.0 71.0 71.0 68.0 69.0 69.0 67.0 72.0 67.0 21:03:37 INFO - PROCESS | 15500 | -------- Summary: end -------- 21:03:37 INFO - PROCESS | 15500 | 21:03:38 INFO - TEST-INFO | 15500: exit 0 21:03:38 INFO - TEST-OK | kraken | took 65522ms 21:03:38 INFO - SUITE-END | took 1187s 21:03:38 INFO - Completed test suite (00:19:48) 21:03:38 INFO - javascript benchmark 21:03:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2555.1312553731727, 2585.017693276555, 2591.688997320322, 2593.0794567928374, 2594.2865711929217, 4686.695364801286, 4714.080754252922, 4798.4961579034225, 4882.633802464816, 4910.607151427891, 4810.711357318563, 4826.734529600871, 4868.099401610696, 4876.561109500144, 4909.042736666352, 4444.20004399208, 4466.352378905057, 4491.101779644068, 4515.142122996636, 4526.117407105616, 4526.705764125338, 4551.317302404649, 4564.589186973171, 4570.154521413532, 4571.200039993005, 4305.375720520538, 4346.8043938022865, 4362.803673834654, 4503.932441013388, 4530.229860923618, 4376.912461750747, 4382.0, 4383.517813040563, 4409.779511024468, 4411.735295882258, 4427.2695005324085, 4438.778061096932, 4441.911161776747, 4481.7983190756495, 4505.144022635689, 4895.510448955111, 4930.605551555867, 4930.654854160211, 4930.926036109461, 4932.753362331869, 5058.266551350033, 5068.467810879842, 5119.6160287978555, 5124.154514505102, 5257.605679574009, 5185.740712964337, 5186.636935414523, 5188.0, 5214.165733482662, 5224.242484839677, 4849.539293767087, 4860.1008813369635, 4862.05189987949, 4868.537488938545, 4873.171560834667, 5132.0, 5238.0, 5303.7878484860175, 5304.708241046702, 5384.273123128406, 5130.384353877558, 5160.767765450564, 5166.45752196014, 5166.509181627739, 5166.664166829144, 5225.372955245319, 5234.659747116425, 5252.684838909678, 5260.552853007537, 5275.0, 5006.098902197639, 5032.421271553745, 5092.26162206478, 5096.0827051131155, 5141.126008578551, 5176.534111929869, 5176.559992400613, 5181.844544663666, 5186.818461353834, 5187.507186817246, 4493.595576398075, 4495.056038231943, 4496.348029535699, 4502.977485112553, 4503.752293623882, 3776.962230377716, 3820.465134881119, 3840.635139661728, 3858.5562660293863, 3875.8255878485534, 4437.356583295404, 4445.711028783118, 4445.711028783118, 4457.8439754608435, 4463.531329210451, 5270.894582108336, 5272.762725677354, 5275.841724748264, 5280.9207861882105, 5289.523942845162, 4285.849995250152, 4336.848210312624, 4397.098594788061, 4408.074304396048, 4440.666949978765, 4739.218029025241, 4744.7390393528685, 4753.120672675566, 4760.119377915027, 4767.427908650984, 4802.639802014793, 4845.854624361275, 4848.0788650156355, 4848.975755121343, 4852.0, 5001.824936127218, 5119.28330033803, 5126.615503837153, 5132.153194722829, 5249.133892907627, 4781.497942715965, 4786.353842231254, 4803.279508073817, 4803.5916947059895, 4823.372961515121, 5149.201873709581, 5159.793608255628, 5161.071007218737, 5161.09680805865, 5161.458046905021, 4996.7001979881325, 4997.225430058346, 5079.415867175322, 5099.184130539096, 5212.452692467388, 5003.599712023102, 5056.84829455117, 5065.341505604248, 5066.493350664904, 5067.46791586878, 5049.949500505095, 5052.292679025013, 5062.594992400673, 5065.316182315488, 5069.949300507095, 4681.882952926204, 4835.29888166221, 4846.830360937351, 4884.41387033544, 4962.206047032601, 5067.569256613082, 5080.237964305236, 5086.720230387365, 5095.286659867696, 5124.077666020152, 4988.8752781180765, 4992.72540010303, 5000.824971125993, 5005.924911126263, 5006.199008158677], "value": 4747.72904129582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.3604720264879, 567.0586825869058, 567.480755109075, 568.5196009372082, 568.9886202275954, 28417.289567760818, 30884.69115308846, 38863.22273554531, 39888.202235955265, 39971.60028399715, 39668.60331396685, 40056.59943400565, 40103.19793604126, 40113.59886401135, 40150.397744033864, 7609.733659321939, 7772.455928085036, 7784.532928024309, 7788.299053085221, 7793.4934229275195, 7331.41348692106, 7662.616869156548, 9643.710688679352, 9873.851892221586, 9888.752781180492, 10056.69829905104, 10125.24060695447, 10125.696229113139, 10130.442825644586, 10130.84803727941, 9745.122938935494, 9752.609895604168, 9780.266480014028, 9810.70567882961, 9811.166050885684, 9751.609935602568, 9812.595914001044, 9815.11663950248, 9816.950915245377, 9818.65634702782, 36887.81556092203, 37270.44094338587, 37277.0, 37503.24993500115, 37504.24991500155, 2832.9433411331865, 2950.144458107168, 2961.4373269078806, 2996.0712179224292, 3035.4232695787728, 28217.576736348972, 28801.855990719912, 28816.0, 28841.85579072112, 28845.134645960447, 3235.7573182011442, 3240.319532898094, 3286.7112042009567, 3320.933581328384, 3388.119089036868, 179309.1034544832, 179342.0, 179398.0, 179425.0, 179850.0, 50481.74759126181, 50625.24062139071, 50816.745916270185, 50846.49153508418, 50858.439909206, 52980.47019529755, 53213.467865321625, 53267.20099198515, 53400.38793017294, 53410.0, 12967.675808104685, 13137.146085504412, 13150.60548183556, 13167.736645267041, 13173.868261317455, 9003.234725048313, 9806.117449429586, 9828.655997040212, 9844.753881152885, 9860.260480463994, 13492.730145397038, 14992.400303987719, 15375.615609609626, 15447.459338923083, 16018.919905400398, 4929.926051109236, 5561.249231353715, 5727.169560413717, 5729.4843464088435, 5761.193432919395, 682.501773705188, 738.5716284554945, 755.4183278875236, 782.5383024015858, 838.0822998816286, 23504.882475587856, 23636.527269454513, 23694.88152559226, 23998.0, 24128.63807042896, 821.40858581821, 827.2513375395276, 828.4076885027234, 829.639106988462, 837.9916200838036, 12417.875821241852, 12567.874321256853, 12645.304508251951, 12722.427490762939, 12765.106442549119, 357323.0, 359460.0, 360214.0, 361289.0, 362229.0, 42914.78542607267, 47815.282770758466, 48522.5147748518, 48567.27149092766, 48600.27099593509, 1127.4982632728356, 1141.0814294493014, 1165.0621249893916, 1165.5862168930078, 1173.7593793272188, 27361.042363517976, 28352.0, 28489.43595076453, 28797.856010719814, 28946.565801512574, 41139.588604113575, 41537.37693934654, 41543.169136617704, 41607.0, 41622.0, 311971.0, 312999.0, 313059.0, 313487.0, 313914.0, 23980.0, 24841.627375589742, 35620.28759424849, 35776.0, 35941.28117437689, 40469.797651011555, 40667.7966610165, 41055.58944410637, 41403.86723069994, 42356.152876942906, 34969.65030349664, 35463.82268088643, 35890.820545897106, 36092.819535902156, 36252.63747362493, 35456.29087418289, 36207.0, 36247.81876090708, 36277.818610906776, 36458.63541364658, 34816.47775283423, 35018.299634007686, 35117.29765404729, 35127.82436087803, 35987.0, 30540.389192216477, 33008.1747956303, 33059.50410743889, 33250.0, 33601.49597755987, 24940.376490587154, 25261.0, 25385.478202347866, 25455.618165727898, 25471.36321591975], "value": 16980.570479376503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2682118711102, 361.4921035944497, 368.9557253129624, 370.5497820148519, 388.2506761949438, 12808.359582020908, 16164.515064548068, 16212.594685132877, 16236.269367878444, 16470.588235294093, 15686.294116764744, 15817.525474235763, 16180.75728864068, 16423.67152656949, 16590.50228493144, 4461.241588929874, 4960.751962401883, 5168.896622067557, 5208.479152084799, 5252.921206181911, 5050.696958182502, 5076.466970968032, 5113.5909127269915, 5114.718690472023, 5116.641835071547, 4933.333999910002, 5079.415867175267, 5088.058709138802, 5096.4648711885275, 5142.511461411179, 5024.145895197807, 5050.090983622947, 5050.873728156789, 5055.69665820052, 5056.544910958013, 4355.216061108999, 4523.751193684346, 4535.478419981679, 4536.818527258905, 4566.725996440225, 20374.0, 20853.0, 20951.68572471414, 21000.0, 21079.789202107935, 1822.3986084592052, 1868.1291411271256, 1940.4469726128127, 2049.918003279867, 2249.6962910007105, 12803.0, 13149.86850131496, 13389.531366402227, 13609.0, 13623.18260904349, 1779.4661601519492, 1779.8932064076198, 1783.7413575031678, 1784.2060283173994, 1795.6139430022477, 69244.30755692479, 69787.99999999949, 69984.0, 70114.64942675254, 71996.0, 8511.0, 8535.445196062235, 8889.777755556033, 9764.658236961672, 9977.306127345577, 13182.209067455791, 13222.404991775393, 13222.669433264246, 13223.206607603575, 13237.933810330887, 6928.669450202918, 7003.2296447390745, 7197.1363436387965, 7219.927800722031, 7265.455090868206, 6534.215894092739, 6587.80236592903, 6588.901166482507, 6758.898616520658, 6761.560498567577, 6068.33248342682, 6143.109249158936, 6144.631322120687, 6176.258848938156, 6343.302236753953, 1744.1453687693192, 1785.2501949181376, 1805.1786437171056, 1808.3489943620286, 1815.2648177488138, 821.7165078048064, 830.98338033239, 888.2139306713605, 914.679862048291, 948.7059011706393, 16599.50201493957, 16938.491845244414, 17357.7396339055, 17442.24991626781, 17758.733618995724, 738.5384134915678, 745.7240820896303, 818.1859050245045, 847.6355167278007, 870.9608067636972, 9629.759256018655, 9955.104040636377, 9984.500774961223, 10067.295289329677, 10109.64616238428, 352384.0, 355890.0, 360916.0, 362797.0, 363481.0, 66725.33274667288, 67195.0, 67574.66212668906, 67976.66011670009, 70222.64888675524, 877.7015814623059, 880.5465185429509, 910.2763303173992, 911.145818259838, 914.7438717159206, 14947.77578336304, 15181.924090379478, 15545.37818487293, 15781.368745250062, 15931.8406815935, 34684.0, 34714.63871507664, 35228.82385588055, 36021.81989090038, 36719.449208261365, 44729.32906006347, 45341.54658453373, 45970.540294597966, 46361.53638463572, 46408.30387544122, 4387.692861499664, 7202.243764404662, 7207.171175314906, 7301.452391070798, 7724.420668450001, 10578.206634502598, 10638.14894808398, 10687.946560267148, 10873.130149588173, 10915.290506117077, 8863.778405539913, 8941.284697224337, 9484.715458536255, 9695.272854535797, 9922.156616687662, 4496.865094047183, 7117.430605551647, 8106.270435660819, 9405.05949405054, 10031.197504199792, 8982.55087245622, 9258.583363748512, 9568.234541236545, 9906.306558540833, 10202.897971020195, 7309.342159205697, 7436.553806771611, 7504.249575042452, 7671.041119860018, 7849.882251766342, 9499.857502137611, 9536.666216682383, 9578.090081442251, 9711.125998660154, 9858.408495490294], "value": 7980.160218860874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.7130260040185, 1355.8711922367377, 1381.2265131526347, 1449.4347204590213, 1657.1796960504553, 6550.8689826203445, 7075.0, 7348.706051757937, 7358.04345435094, 7551.244875512446, 7378.151512576042, 7448.106227252737, 7449.441291903116, 7455.813604659887, 7458.067741532309, 2168.0568952505632, 2196.0447205465675, 2198.7691292414306, 2200.2189222825905, 2201.3395981205576, 2135.647618143012, 2165.891705414731, 2202.702635144251, 2203.790639889208, 2204.0853045985896, 2148.785121487854, 2169.533550286688, 2174.63031284682, 2175.1299480207963, 2177.510060236442, 2091.3203208957075, 2095.20382254743, 2097.748270207585, 2100.096958307927, 2101.054525463532, 2069.772325044244, 2128.936131916045, 2129.0, 2129.7231359923267, 2131.445824085749, 7236.059312289369, 7396.4822462427655, 7437.44219183558, 7441.627918604048, 7444.330010299099, 4188.518320393163, 4304.720193187464, 4318.0, 4324.589164029412, 4327.956720432819, 2765.2119146043483, 2890.8554572271514, 2911.7379435850876, 2924.1666125154443, 2926.75122614578, 927.7587827164919, 934.700895713372, 939.8919124300656, 949.852772820214, 960.7934294126796, 9605.0, 9610.231181505533, 9650.276229282832, 9655.806883862284, 9658.275629327758, 3838.3858582626644, 3960.603939606074, 3971.4241434991764, 4080.449139366207, 4271.252530807096, 7669.53982761025, 7794.142644309121, 7801.609919504002, 7805.726799561988, 7808.726694565663, 4276.978615106967, 4313.61177494027, 4317.481902171759, 4321.2005778931, 4323.54602766705, 3428.9828550857587, 3796.354619714655, 3941.0541470047556, 3966.940495892564, 3967.3850553164307, 3282.5240340150544, 3295.489199174132, 3363.714084302813, 3409.7272218222483, 3416.4533674611944, 1036.388530766851, 1037.984430233547, 1053.2837670384213, 1057.1384321777728, 1068.2148620763733, 804.3926835239357, 822.3421262989584, 830.7082486733187, 832.1262674192075, 847.588919374103, 4852.1508735971065, 4916.483769204254, 5017.297578339036, 5038.47096054909, 5100.336956195745, 410.1673602586694, 417.89761508430627, 421.8228344095487, 422.7019950934584, 425.9893502662458, 3283.2612662150823, 3309.3712194682935, 3310.536524886518, 3414.931701365959, 3455.222574920673, 8575.1424857515, 8940.240079593308, 8948.463092214357, 8958.328125390623, 8977.865332020025, 8913.866292005625, 8915.37592368541, 8920.152585504367, 8921.375503714808, 8923.196912277926, 6873.862522749617, 6945.131858517685, 6949.339812717783, 6952.965235173893, 6956.791296261019, 4719.0, 4730.5269473053795, 4784.138855006132, 4836.12949669063, 4962.578180854523, 8186.426950113673, 8201.26188643025, 8211.302039326723, 8316.126806685212, 8360.122187170502, 8255.628496717542, 8357.289630381243, 8399.580020999048, 8402.11777763326, 8417.0, 5536.114221724505, 6001.7599296027665, 6056.697165141637, 6069.848253793691, 6080.027195648675, 6862.142232220973, 7017.333353331425, 7075.150981882207, 7173.067501225016, 7181.820454488679, 6182.721777519932, 6373.267074286517, 6388.4569811566535, 6441.5490915635455, 6497.4477169441125, 6193.318734939063, 6281.937180628135, 6290.748370065146, 6331.2085989251345, 6367.681615919279, 5717.685527296038, 5749.54003679713, 5749.655020698604, 5757.884842303047, 5760.135979603093, 4206.621404073648, 4238.894027649333, 4241.597048280409, 4344.413504176896, 4370.606645401929, 4203.243416185116, 4275.700700951028, 4365.257906155897, 4390.275604525217, 4515.0], "value": 3832.2630218951945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5129541438284, 303.8025283565682, 305.454763247603, 305.669876533344, 308.6019035444277, 4758.904821903559, 4856.611471082314, 4868.440129385117, 4934.605231581474, 4955.454899961011, 4812.061647978646, 4837.274408838676, 4852.902941941159, 4886.8778280543, 4893.608511319095, 3608.0, 3686.64976827201, 3699.8335074921692, 3785.772853628784, 3786.8295926683227, 3755.230177813555, 3781.338265803487, 3791.867284645038, 3792.3742582473997, 3822.808859557025, 3738.21497485527, 3762.623737626243, 3764.228333191703, 3780.659740623343, 3784.148566572513, 3574.964250357489, 3634.309481198564, 3749.625037496256, 3761.492198553188, 3764.908176628761, 3283.326917981808, 3292.5555050068174, 3313.3207692422993, 3313.8343082846004, 3332.783369081026, 4691.366665500148, 4703.106409782131, 4711.717296962159, 4723.976380118112, 4731.787069581843, 4145.461090058273, 4259.403683484315, 4260.70175087744, 4268.551802060801, 4275.862068965517, 4928.67963582366, 4963.45402005779, 4968.950310496921, 4971.37857767779, 4993.750312484398, 3561.8397172127316, 3569.1969306906, 3571.6785489305826, 3572.910677233064, 3584.2473080652835, 5223.947760522384, 5250.291210686585, 5285.286486324336, 5308.867278318073, 5324.201369794523, 3582.731295152874, 3648.1973965727498, 3660.670539651444, 3661.761985470936, 3661.8901432957055, 3703.203811180609, 3707.5180226570374, 3723.590405055442, 3746.119661879456, 3749.3063783200196, 4250.936235956463, 4253.766042867672, 4271.693285625789, 4274.166537525215, 4283.678724095706, 4838.129136755348, 5012.145506162743, 5035.269885866602, 5044.344235249394, 5067.41724701664, 1269.2130878854985, 1287.2019348004296, 1294.4239813283186, 1299.753046921082, 1301.9674508137373, 799.2846402469758, 814.5642081486376, 816.8202995341015, 831.0, 835.3233880556769, 3980.960190398059, 3990.2817492851564, 4240.745555266694, 4367.323064924942, 4371.715838470553, 5051.570616497639, 5080.898382032413, 5109.718965456936, 5117.0, 5211.244369566468, 4420.381146639473, 4426.490953540319, 4431.290993441034, 4447.777611119431, 4457.375967364572, 2661.5209262332964, 2756.6967633560294, 2759.7654199392873, 2774.5283301838735, 2788.4144329690585, 4806.279058141236, 4812.374391329105, 4820.783064762094, 4822.276658501253, 4836.371271734652, 5299.231611416323, 5307.8142265021315, 5309.65487243328, 5320.388155362106, 5338.866528336823, 4687.882802929954, 4829.9275510868065, 4849.806007759721, 4860.6111511079735, 4890.290907818347, 5153.330067091404, 5178.275041494269, 5184.377874654915, 5188.688678679291, 5204.141316682856, 5081.4918508148885, 5102.0, 5103.157978933435, 5156.819511317086, 5160.767765450489, 4705.270683044134, 4743.359646447685, 4768.235752771497, 4774.522547745198, 4792.424909010941, 3634.164142247351, 3640.180959284246, 3641.2717456509336, 3652.160003199226, 3652.9406771620966, 5226.163813789775, 5236.162214045735, 5243.370795504564, 5247.370315562157, 5258.263843062051, 4877.5366340197625, 5028.472010438852, 5050.005247927122, 5082.009008243505, 5108.284840122312, 5001.349824522788, 5004.946982340696, 5010.348654674869, 5016.372953380827, 5038.748062596782, 4962.255661650781, 4965.0, 4981.2030075187795, 4992.375953005874, 5023.643616223672, 4859.125357435695, 4917.188663870421, 5084.186530155157, 5113.903299647127, 5128.692278463304, 4876.951230487792, 5011.223260394645, 5044.697318160922, 5052.1411360069615, 5053.8736531587], "value": 3787.5702665561294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.3309044962618, 585.6837307853757, 638.4477427025624, 661.4543002023332, 670.2225418514524, 12054.69863253418, 12055.698607534816, 12666.620001399973, 12827.871721282796, 13292.202467851912, 13103.73792524149, 13202.53791117311, 13328.866711332883, 13375.933120334408, 13413.061085724003, 626.7242413338116, 740.2375553180233, 767.2136060537938, 775.0970119810414, 775.437807589496, 740.1968863782802, 763.1338430880962, 768.1089935674619, 770.5954373953663, 772.8377040821434, 810.0603300171801, 812.9065157506903, 813.1177672225642, 813.3615112136973, 813.9959300203491, 646.8027251688234, 804.7947773317767, 807.5033854179667, 807.7617102954642, 807.9232472915064, 566.0, 569.7607005057886, 577.3648986115239, 586.1939832729996, 586.3637952821194, 12642.304673242968, 12783.29691866947, 12804.551840685532, 12833.743325133444, 12936.935315323457, 12313.322767247797, 12764.042696797776, 12807.679808004781, 13145.60563183106, 13448.529301474402, 11087.72280692989, 11188.552457901675, 11342.262752921033, 11560.190786644938, 11574.47914843834, 4092.9386059209137, 4120.876373708794, 4127.855525056639, 4298.20483210607, 4326.675499337531, 57753.13370299407, 58489.0, 58647.0, 59480.70259648717, 59715.70142149262, 10083.243756718275, 10259.076683098408, 10358.274920755626, 10367.222458315657, 10440.216983726252, 19266.422007339803, 19319.517012074528, 19321.806781932282, 19330.323438679578, 19337.0, 6069.756160342169, 6741.764038258735, 6805.693743781541, 6834.897476537856, 6864.553804002724, 3649.923272634579, 3732.8506859725308, 3768.679662228741, 3795.2030073684837, 3913.4521167036637, 2593.6757905261843, 2663.094547853739, 2678.5178667839978, 2682.5573780326417, 2684.2215757430517, 447.9507254202035, 465.26720415345966, 470.22882472744726, 477.69904959875055, 484.2977682360521, 451.905099929012, 487.36642364925456, 489.9583535399531, 492.4164864635347, 501.15555289337584, 7591.620418979029, 7875.763727088197, 7935.285824275843, 7944.245296696805, 7953.761387158394, 457.9404677391984, 485.61636307316826, 492.9580985616263, 496.35226030031157, 496.68708713510256, 3553.520274762874, 3571.392873207067, 3623.166671665532, 3679.7608155469807, 3708.4622729704042, 92997.5350123245, 100494.0, 102359.48820255851, 102915.0, 103046.0, 77352.0, 86920.0, 87423.56288218519, 90058.0, 91122.54438727896, 72382.2761772386, 77524.61237693776, 79025.20974790293, 79470.0, 79836.60081699787, 7033.859322813618, 7058.752943647153, 7061.329173728693, 7325.084364454443, 7437.367823735043, 45597.54402455933, 47458.28812567745, 48449.5155048445, 49378.75310623424, 49419.75290123526, 63002.68498657477, 66863.66568167323, 67302.3269767296, 68492.657536712, 70942.29057709356, 9016.684416045407, 9055.728328150166, 9272.907270927204, 9391.154796068387, 9508.191803696764, 9679.0, 9823.85264221023, 9934.652287169914, 10057.396556206651, 10168.847467288144, 8794.384393092421, 8803.779905502413, 8851.955740221258, 8863.689770857989, 9226.123518265755, 8592.871106933277, 8599.52702601363, 8645.697400590949, 8766.21104100634, 9038.728838134866, 8437.87343189865, 8561.14388561139, 8631.611577479154, 8846.15961483658, 8961.625169330002, 7707.2292770724725, 7785.026871641045, 7812.92187078122, 8014.759557213293, 8244.051934027664, 7588.96205518991, 7759.534427934342, 7988.960055199686, 8260.421770476249, 8333.624986875484], "value": 6154.508103703879, "unit": "score"}], "name": "dromaeo_css", "value": 6212.288564675116, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 115.0, 112.0, 115.0, 115.0, 117.0, 120.0, 115.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 155.0, 196.0, 129.0, 157.0, 157.0, 123.0, 197.0, 121.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 164.0, 162.0, 161.0, 163.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 179.0, 77.0, 76.0, 77.0, 125.0, 112.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 152.0, 86.0, 86.0, 87.0, 137.0, 88.0, 88.0, 137.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 72.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 86.0, 83.0, 81.0, 83.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 136.0, 133.0, 132.0, 130.0, 129.0, 132.0, 156.0, 134.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 172.0, 173.0, 172.0, 173.0, 176.0, 175.0, 175.0, 175.0, 171.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 71.0, 68.0, 69.0, 69.0, 67.0, 72.0, 67.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1576.0, "alertThreshold": 2.0}]} 21:03:38 INFO - Return code: 0 21:03:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:03:39 INFO - # TBPL SUCCESS # 21:03:39 INFO - Running post-action listener: _resource_record_post_action 21:03:39 INFO - [mozharness: 2016-08-22 04:03:39.036406Z] Finished run-tests step (success) 21:03:39 INFO - Running post-run listener: _resource_record_post_run 21:03:39 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403472384; Read time: 24; Write time: 609940 21:03:39 INFO - TinderboxPrint: CPU usage
13.3% 21:03:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 21:03:39 INFO - TinderboxPrint: I/O write bytes / time
403,472,384 / 609,940 21:03:39 INFO - TinderboxPrint: CPU idle
8,346.2 (86.7%) 21:03:39 INFO - TinderboxPrint: CPU user
1,205.4 (12.5%) 21:03:39 INFO - TinderboxPrint: Swap in / out
0 / 0 21:03:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 114405376; Read time: 0; Write time: 201768 21:03:39 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289067008; Read time: 24; Write time: 408172 21:03:39 INFO - Running post-run listener: _upload_blobber_files 21:03:39 INFO - Blob upload gear active. 21:03:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:03:39 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 21:03:39 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'] 21:03:39 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 21:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 21:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:41 INFO - (blobuploader) - INFO - Done attempting. 21:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:41 INFO - (blobuploader) - INFO - Done attempting. 21:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:44 INFO - (blobuploader) - INFO - Done attempting. 21:03:44 INFO - (blobuploader) - INFO - Iteration through files over. 21:03:44 INFO - Return code: 0 21:03:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:03:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:03:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5faf9fd5d6379898e611ddefff37817bbbf8a5302227c0c48a1c9d97c2259c31954352f1e9e94dbaec302abbd65dce400a75661e2d31749abd9dfdaef39d517c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e843843a12bc6c62755d9828f74dc9199976491f2924564dab0b414f6fd03e0717d47332b16921dd342bf0cc5590749d40d23eca507391996faecdd2e17b8c0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6eb93b0db94ae8ab292de9f9a6962946d9423061beff65f69863183dd3c055fdab2fa6eb8fd6ee609d1d94f91ecb05354cb043feb5990d0a112aa57b171b52c"} 21:03:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:03:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:03:44 INFO - Contents: 21:03:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5faf9fd5d6379898e611ddefff37817bbbf8a5302227c0c48a1c9d97c2259c31954352f1e9e94dbaec302abbd65dce400a75661e2d31749abd9dfdaef39d517c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e843843a12bc6c62755d9828f74dc9199976491f2924564dab0b414f6fd03e0717d47332b16921dd342bf0cc5590749d40d23eca507391996faecdd2e17b8c0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6eb93b0db94ae8ab292de9f9a6962946d9423061beff65f69863183dd3c055fdab2fa6eb8fd6ee609d1d94f91ecb05354cb043feb5990d0a112aa57b171b52c"} 21:03:44 INFO - Running post-run listener: copy_logs_to_upload_dir 21:03:44 INFO - Copying logs to upload dir... 21:03:44 INFO - mkdir: /builds/slave/test/build/upload/logs 21:03:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.600316 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-21 21:03:43.813596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 21:03:43.817511) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 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/5faf9fd5d6379898e611ddefff37817bbbf8a5302227c0c48a1c9d97c2259c31954352f1e9e94dbaec302abbd65dce400a75661e2d31749abd9dfdaef39d517c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e843843a12bc6c62755d9828f74dc9199976491f2924564dab0b414f6fd03e0717d47332b16921dd342bf0cc5590749d40d23eca507391996faecdd2e17b8c0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6eb93b0db94ae8ab292de9f9a6962946d9423061beff65f69863183dd3c055fdab2fa6eb8fd6ee609d1d94f91ecb05354cb043feb5990d0a112aa57b171b52c"} build_url:https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/a2VC8LXMS-60n1CKq2W3aA/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/5faf9fd5d6379898e611ddefff37817bbbf8a5302227c0c48a1c9d97c2259c31954352f1e9e94dbaec302abbd65dce400a75661e2d31749abd9dfdaef39d517c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e843843a12bc6c62755d9828f74dc9199976491f2924564dab0b414f6fd03e0717d47332b16921dd342bf0cc5590749d40d23eca507391996faecdd2e17b8c0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6eb93b0db94ae8ab292de9f9a6962946d9423061beff65f69863183dd3c055fdab2fa6eb8fd6ee609d1d94f91ecb05354cb043feb5990d0a112aa57b171b52c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 21:03:43.847210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 21:03:43.847879) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471836470.168648-1159871295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 21:03:43.929627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 21:03:43.929971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 21:03:43.930312) ========= ========= Total master_lag: 0.21 =========