builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1468867374.99 results: success (0) buildid: 20160718102052 builduid: 689d9fd3c5d040439d6a1d3b88646e4d revision: 895873ee9b11fdb024fc133cdc6558d97038e0d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:54.991285) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:54.991742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:54.992019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:55.004981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:55.005248) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 11:42:55-- 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% 223M=0s 2016-07-18 11:42:55 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:55.101830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:55.102144) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:55.151443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:42:55.151840) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 895873ee9b11fdb024fc133cdc6558d97038e0d0 --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 895873ee9b11fdb024fc133cdc6558d97038e0d0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 11:42:55,350 truncating revision to first 12 chars 2016-07-18 11:42:55,350 Setting DEBUG logging. 2016-07-18 11:42:55,350 attempt 1/10 2016-07-18 11:42:55,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/895873ee9b11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:42:56,429 unpacking tar archive at: autoland-895873ee9b11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:42:56.570833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:56.571156) ========= script_repo_revision: 895873ee9b11fdb024fc133cdc6558d97038e0d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:56.571556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:56.571840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:42:56.583088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 11:42:56.583389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:56 INFO - MultiFileLogger online at 20160718 11:42:56 in /builds/slave/test 11:42:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 11:42:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:56 INFO - {'append_to_log': False, 11:42:56 INFO - 'base_work_dir': '/builds/slave/test', 11:42:56 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:42:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:56 INFO - 'branch': 'Autoland-Non-PGO', 11:42:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:56 INFO - 'config_files': ('talos/linux_config.py',), 11:42:56 INFO - 'default_actions': ('clobber', 11:42:56 INFO - 'read-buildbot-config', 11:42:56 INFO - 'download-and-extract', 11:42:56 INFO - 'populate-webroot', 11:42:56 INFO - 'create-virtualenv', 11:42:56 INFO - 'install', 11:42:56 INFO - 'run-tests'), 11:42:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:56 INFO - 'download_minidump_stackwalk': True, 11:42:56 INFO - 'download_symbols': 'ondemand', 11:42:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:56 INFO - 'installer_path': 'installer.exe', 11:42:56 INFO - 'log_level': 'info', 11:42:56 INFO - 'log_name': 'talos', 11:42:56 INFO - 'log_to_console': True, 11:42:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:56 INFO - 'opt_config_files': (), 11:42:56 INFO - 'pip_index': False, 11:42:56 INFO - 'sps_profile': False, 11:42:56 INFO - 'sps_profile_interval': 0, 11:42:56 INFO - 'suite': 'dromaeojs-e10s', 11:42:56 INFO - 'system_bits': '32', 11:42:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:56 INFO - 'title': 'talos-linux64-ix-032', 11:42:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:56 INFO - 'use_talos_json': True, 11:42:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:56 INFO - 'work_dir': 'build'} 11:42:56 INFO - ##### 11:42:56 INFO - ##### Running clobber step. 11:42:56 INFO - ##### 11:42:56 INFO - Running pre-action listener: _resource_record_pre_action 11:42:56 INFO - Running main action method: clobber 11:42:56 INFO - rmtree: /builds/slave/test/build 11:42:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:57 INFO - Running post-action listener: _resource_record_post_action 11:42:57 INFO - ##### 11:42:57 INFO - ##### Finished clobber step (success) 11:42:57 INFO - ##### 11:42:57 INFO - ##### 11:42:57 INFO - ##### Running read-buildbot-config step. 11:42:57 INFO - ##### 11:42:57 INFO - Running pre-action listener: _resource_record_pre_action 11:42:57 INFO - Running main action method: read_buildbot_config 11:42:57 INFO - Using buildbot properties: 11:42:57 INFO - { 11:42:57 INFO - "project": "", 11:42:57 INFO - "product": "firefox", 11:42:57 INFO - "script_repo_revision": "production", 11:42:57 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 11:42:57 INFO - "repository": "", 11:42:57 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 11:42:57 INFO - "buildid": "20160718102052", 11:42:57 INFO - "pgo_build": "False", 11:42:57 INFO - "basedir": "/builds/slave/test", 11:42:57 INFO - "buildnumber": 128, 11:42:57 INFO - "slavename": "talos-linux64-ix-032", 11:42:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:57 INFO - "platform": "ubuntu64_hw", 11:42:57 INFO - "scheduler": "tests-autoland-linux64-talos", 11:42:57 INFO - "branch": "autoland", 11:42:57 INFO - "repo_path": "integration/autoland", 11:42:57 INFO - "revision": "895873ee9b11fdb024fc133cdc6558d97038e0d0", 11:42:57 INFO - "stage_platform": "linux64", 11:42:57 INFO - "builduid": "689d9fd3c5d040439d6a1d3b88646e4d", 11:42:57 INFO - "slavebuilddir": "test" 11:42:57 INFO - } 11:42:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:42:57 INFO - Running post-action listener: _resource_record_post_action 11:42:57 INFO - ##### 11:42:57 INFO - ##### Finished read-buildbot-config step (success) 11:42:57 INFO - ##### 11:42:57 INFO - ##### 11:42:57 INFO - ##### Running download-and-extract step. 11:42:57 INFO - ##### 11:42:57 INFO - Running pre-action listener: _resource_record_pre_action 11:42:57 INFO - Running main action method: download_and_extract 11:42:57 INFO - mkdir: /builds/slave/test/build/tests 11:42:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:57 INFO - https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:42:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:42:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:42:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:42:58 INFO - Downloaded 1361 bytes. 11:42:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:42:58 INFO - Using the following test package requirements: 11:42:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:42:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'jsshell-linux-x86_64.zip'], 11:42:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:58 INFO - https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:59 INFO - Downloaded 22764883 bytes. 11:42:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:00 INFO - Return code: 0 11:43:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:00 INFO - https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:01 INFO - Downloaded 22764883 bytes. 11:43:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:03 INFO - Return code: 0 11:43:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:03 INFO - https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:43:04 INFO - Downloaded 14403317 bytes. 11:43:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:43:05 INFO - Return code: 0 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:05 INFO - https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:43:06 INFO - Downloaded 57134160 bytes. 11:43:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:43:06 INFO - mkdir: /builds/slave/test/properties 11:43:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:43:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:43:06 INFO - Contents: 11:43:06 INFO - build_url:https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:43:07 INFO - Running post-action listener: _resource_record_post_action 11:43:07 INFO - Running post-action listener: set_extra_try_arguments 11:43:07 INFO - ##### 11:43:07 INFO - ##### Finished download-and-extract step (success) 11:43:07 INFO - ##### 11:43:07 INFO - ##### 11:43:07 INFO - ##### Running populate-webroot step. 11:43:07 INFO - ##### 11:43:07 INFO - Running pre-action listener: _resource_record_pre_action 11:43:07 INFO - Running main action method: populate_webroot 11:43:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:43:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:43:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:43:07 INFO - '--tppagecycles', 11:43:07 INFO - '7'], 11:43:07 INFO - 'tests': ['tsvgm']}}, 11:43:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:43:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:43:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:43:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:43:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['damp', 'tps']}, 11:43:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'tests': ['damp', 'tps']}, 11:43:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['dromaeo_dom']}, 11:43:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:43:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['basic_compositor_video']}, 11:43:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:43:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['a11yr', 11:43:07 INFO - 'ts_paint', 11:43:07 INFO - 'tpaint', 11:43:07 INFO - 'sessionrestore', 11:43:07 INFO - 'sessionrestore_no_auto_restore', 11:43:07 INFO - 'tabpaint']}, 11:43:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['tsvgx', 11:43:07 INFO - 'tsvgr_opacity', 11:43:07 INFO - 'tart', 11:43:07 INFO - 'tscrollx', 11:43:07 INFO - 'cart']}, 11:43:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:43:07 INFO - 'tsvgr_opacity', 11:43:07 INFO - 'tart', 11:43:07 INFO - 'tscrollx', 11:43:07 INFO - 'cart']}, 11:43:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'talos_options': ['--disable-e10s'], 11:43:07 INFO - 'tests': ['tp5o']}, 11:43:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'tests': ['tp5o']}, 11:43:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'talos_options': ['--disable-e10s', 11:43:07 INFO - '--xperf_path', 11:43:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:07 INFO - 'tests': ['tp5n']}, 11:43:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:07 INFO - 'talos_options': ['--xperf_path', 11:43:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:07 INFO - 'tests': ['tp5n']}}, 11:43:07 INFO - 'talos.zip': {'path': '', 11:43:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:43:07 INFO - Running post-action listener: _resource_record_post_action 11:43:07 INFO - ##### 11:43:07 INFO - ##### Finished populate-webroot step (success) 11:43:07 INFO - ##### 11:43:07 INFO - ##### 11:43:07 INFO - ##### Running create-virtualenv step. 11:43:07 INFO - ##### 11:43:07 INFO - Running pre-action listener: _resource_record_pre_action 11:43:07 INFO - Running main action method: create_virtualenv 11:43:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:43:07 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 11:43:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:43:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:43:07 INFO - Using real prefix '/usr' 11:43:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:43:09 INFO - Installing pip.................done. 11:43:09 INFO - Return code: 0 11:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:09 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 11:43:09 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 11:43:09 INFO - Using env: {'DISPLAY': ':0', 11:43:09 INFO - 'HOME': '/home/cltbld', 11:43:09 INFO - 'LANG': 'en_US.UTF-8', 11:43:09 INFO - 'LANGUAGE': 'en_US:en', 11:43:09 INFO - 'LOGNAME': 'cltbld', 11:43:09 INFO - 'MAIL': '/var/mail/cltbld', 11:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:09 INFO - 'MOZ_NO_REMOTE': '1', 11:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:09 INFO - 'NO_EM_RESTART': '1', 11:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:09 INFO - 'PWD': '/builds/slave/test', 11:43:09 INFO - 'SHELL': '/bin/bash', 11:43:09 INFO - 'SHLVL': '1', 11:43:09 INFO - 'TERM': 'linux', 11:43:09 INFO - 'TMOUT': '86400', 11:43:09 INFO - 'USER': 'cltbld', 11:43:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:09 INFO - '_': '/tools/buildbot/bin/python'} 11:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:09 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 11:43:09 INFO - Cleaning up... 11:43:09 INFO - Return code: 0 11:43:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:09 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 11:43:09 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 11:43:09 INFO - Using env: {'DISPLAY': ':0', 11:43:09 INFO - 'HOME': '/home/cltbld', 11:43:09 INFO - 'LANG': 'en_US.UTF-8', 11:43:09 INFO - 'LANGUAGE': 'en_US:en', 11:43:09 INFO - 'LOGNAME': 'cltbld', 11:43:09 INFO - 'MAIL': '/var/mail/cltbld', 11:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:09 INFO - 'MOZ_NO_REMOTE': '1', 11:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:09 INFO - 'NO_EM_RESTART': '1', 11:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:09 INFO - 'PWD': '/builds/slave/test', 11:43:09 INFO - 'SHELL': '/bin/bash', 11:43:09 INFO - 'SHLVL': '1', 11:43:09 INFO - 'TERM': 'linux', 11:43:09 INFO - 'TMOUT': '86400', 11:43:09 INFO - 'USER': 'cltbld', 11:43:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:09 INFO - '_': '/tools/buildbot/bin/python'} 11:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:10 INFO - Downloading/unpacking psutil>=3.1.1 11:43:10 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 11:43:10 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 11:43:10 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 11:43:10 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 11:43:10 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 11:43:10 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 11:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:13 INFO - Installing collected packages: psutil 11:43:13 INFO - Running setup.py install for psutil 11:43:13 INFO - building 'psutil._psutil_linux' extension 11:43:13 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 11:43:13 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 11:43:13 INFO - building 'psutil._psutil_posix' extension 11:43:13 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 11:43:13 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 11:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:13 INFO - Successfully installed psutil 11:43:13 INFO - Cleaning up... 11:43:13 INFO - Return code: 0 11:43:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:43:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:13 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 11:43:13 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 11:43:13 INFO - Using env: {'DISPLAY': ':0', 11:43:13 INFO - 'HOME': '/home/cltbld', 11:43:13 INFO - 'LANG': 'en_US.UTF-8', 11:43:13 INFO - 'LANGUAGE': 'en_US:en', 11:43:13 INFO - 'LOGNAME': 'cltbld', 11:43:13 INFO - 'MAIL': '/var/mail/cltbld', 11:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:13 INFO - 'MOZ_NO_REMOTE': '1', 11:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:13 INFO - 'NO_EM_RESTART': '1', 11:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:13 INFO - 'PWD': '/builds/slave/test', 11:43:13 INFO - 'SHELL': '/bin/bash', 11:43:13 INFO - 'SHLVL': '1', 11:43:13 INFO - 'TERM': 'linux', 11:43:13 INFO - 'TMOUT': '86400', 11:43:13 INFO - 'USER': 'cltbld', 11:43:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:13 INFO - '_': '/tools/buildbot/bin/python'} 11:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:43:15 INFO - Installing collected packages: mozsystemmonitor 11:43:15 INFO - Running setup.py install for mozsystemmonitor 11:43:15 INFO - Successfully installed mozsystemmonitor 11:43:15 INFO - Cleaning up... 11:43:15 INFO - Return code: 0 11:43:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', '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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11: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 jsonschema==2.5.1 11:43:15 INFO - Using env: {'DISPLAY': ':0', 11:43:15 INFO - 'HOME': '/home/cltbld', 11:43:15 INFO - 'LANG': 'en_US.UTF-8', 11:43:15 INFO - 'LANGUAGE': 'en_US:en', 11:43:15 INFO - 'LOGNAME': 'cltbld', 11:43:15 INFO - 'MAIL': '/var/mail/cltbld', 11:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:15 INFO - 'MOZ_NO_REMOTE': '1', 11:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:15 INFO - 'NO_EM_RESTART': '1', 11:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:15 INFO - 'PWD': '/builds/slave/test', 11:43:15 INFO - 'SHELL': '/bin/bash', 11:43:15 INFO - 'SHLVL': '1', 11:43:15 INFO - 'TERM': 'linux', 11:43:15 INFO - 'TMOUT': '86400', 11:43:15 INFO - 'USER': 'cltbld', 11:43:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:15 INFO - '_': '/tools/buildbot/bin/python'} 11:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:43:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11: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 11: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 11: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 11: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 11: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 11: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 11:43:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:43:18 INFO - warning: no files found matching '*.txt' 11:43:18 INFO - no previously-included directories found matching 'build' 11:43:18 INFO - no previously-included directories found matching 'dist' 11:43:18 INFO - no previously-included directories found matching '.git*' 11:43:18 INFO - Installing collected packages: jsonschema, functools32 11:43:18 INFO - Running setup.py install for functools32 11:43:18 INFO - warning: no files found matching '*.txt' 11:43:18 INFO - no previously-included directories found matching 'build' 11:43:18 INFO - no previously-included directories found matching 'dist' 11:43:18 INFO - no previously-included directories found matching '.git*' 11:43:18 INFO - Successfully installed jsonschema functools32 11:43:18 INFO - Cleaning up... 11:43:18 INFO - Return code: 0 11:43:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', '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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11: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 blobuploader==1.2.4 11:43:18 INFO - Using env: {'DISPLAY': ':0', 11:43:18 INFO - 'HOME': '/home/cltbld', 11:43:18 INFO - 'LANG': 'en_US.UTF-8', 11:43:18 INFO - 'LANGUAGE': 'en_US:en', 11:43:18 INFO - 'LOGNAME': 'cltbld', 11:43:18 INFO - 'MAIL': '/var/mail/cltbld', 11:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:18 INFO - 'MOZ_NO_REMOTE': '1', 11:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:18 INFO - 'NO_EM_RESTART': '1', 11:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:18 INFO - 'PWD': '/builds/slave/test', 11:43:18 INFO - 'SHELL': '/bin/bash', 11:43:18 INFO - 'SHLVL': '1', 11:43:18 INFO - 'TERM': 'linux', 11:43:18 INFO - 'TMOUT': '86400', 11:43:18 INFO - 'USER': 'cltbld', 11:43:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:18 INFO - '_': '/tools/buildbot/bin/python'} 11:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:18 INFO - Downloading/unpacking blobuploader==1.2.4 11: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 11: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 11: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 11: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 11: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 11: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 11:43:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:43:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11: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 11: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 11: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 11: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 11: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 11: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 11:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:43:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11: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 11: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 11: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 11: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 11: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 11: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 11:43:21 INFO - Downloading docopt-0.6.1.tar.gz 11:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:43:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:43:21 INFO - Running setup.py install for blobuploader 11:43:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:43:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:43:21 INFO - Running setup.py install for requests 11:43:21 INFO - Running setup.py install for docopt 11:43:22 INFO - Successfully installed blobuploader requests docopt 11:43:22 INFO - Cleaning up... 11:43:22 INFO - Return code: 0 11:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:22 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:22 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 11:43:22 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 11:43:22 INFO - Using env: {'DISPLAY': ':0', 11:43:22 INFO - 'HOME': '/home/cltbld', 11:43:22 INFO - 'LANG': 'en_US.UTF-8', 11:43:22 INFO - 'LANGUAGE': 'en_US:en', 11:43:22 INFO - 'LOGNAME': 'cltbld', 11:43:22 INFO - 'MAIL': '/var/mail/cltbld', 11:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:22 INFO - 'MOZ_NO_REMOTE': '1', 11:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:22 INFO - 'NO_EM_RESTART': '1', 11:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:22 INFO - 'PWD': '/builds/slave/test', 11:43:22 INFO - 'SHELL': '/bin/bash', 11:43:22 INFO - 'SHLVL': '1', 11:43:22 INFO - 'TERM': 'linux', 11:43:22 INFO - 'TMOUT': '86400', 11:43:22 INFO - 'USER': 'cltbld', 11:43:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:22 INFO - '_': '/tools/buildbot/bin/python'} 11:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:43:22 INFO - Running setup.py (path:/tmp/pip-Dv0iuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:43:22 INFO - Running setup.py (path:/tmp/pip-_VZa3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:43:22 INFO - Running setup.py (path:/tmp/pip-W0T_AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:43:22 INFO - Running setup.py (path:/tmp/pip-hFd6Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:43:22 INFO - Running setup.py (path:/tmp/pip-Vz8Soi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:43:22 INFO - Running setup.py (path:/tmp/pip-driO6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:43:22 INFO - Running setup.py (path:/tmp/pip-ecfdT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:43:22 INFO - Running setup.py (path:/tmp/pip-nB1CP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:43:22 INFO - Running setup.py (path:/tmp/pip-T9CWX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:43:23 INFO - Running setup.py (path:/tmp/pip-BdVM4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:43:23 INFO - Running setup.py (path:/tmp/pip-FF_l2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:43:23 INFO - Running setup.py (path:/tmp/pip-fLvbeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:43:23 INFO - Running setup.py (path:/tmp/pip-6ErteK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:43:23 INFO - Running setup.py (path:/tmp/pip-CvKupY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:23 INFO - Running setup.py (path:/tmp/pip-6LPc3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:43:23 INFO - Running setup.py (path:/tmp/pip-78EN3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:43:23 INFO - Running setup.py (path:/tmp/pip-cs1UrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:43:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:43:23 INFO - Running setup.py install for manifestparser 11:43:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:43:23 INFO - Running setup.py install for mozcrash 11:43:23 INFO - Running setup.py install for mozdebug 11:43:23 INFO - Running setup.py install for mozdevice 11:43:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozfile 11:43:24 INFO - Running setup.py install for mozhttpd 11:43:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozinfo 11:43:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozInstall 11:43:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozleak 11:43:24 INFO - Running setup.py install for mozlog 11:43:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for moznetwork 11:43:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozprocess 11:43:24 INFO - Running setup.py install for mozprofile 11:43:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:43:24 INFO - Running setup.py install for mozrunner 11:43:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:43:25 INFO - Running setup.py install for mozscreenshot 11:43:25 INFO - Running setup.py install for moztest 11:43:25 INFO - Running setup.py install for mozversion 11:43:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:43:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:43:25 INFO - Cleaning up... 11:43:25 INFO - Return code: 0 11:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:25 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:25 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 11:43:25 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 11:43:25 INFO - Using env: {'DISPLAY': ':0', 11:43:25 INFO - 'HOME': '/home/cltbld', 11:43:25 INFO - 'LANG': 'en_US.UTF-8', 11:43:25 INFO - 'LANGUAGE': 'en_US:en', 11:43:25 INFO - 'LOGNAME': 'cltbld', 11:43:25 INFO - 'MAIL': '/var/mail/cltbld', 11:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:25 INFO - 'MOZ_NO_REMOTE': '1', 11:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:25 INFO - 'NO_EM_RESTART': '1', 11:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:25 INFO - 'PWD': '/builds/slave/test', 11:43:25 INFO - 'SHELL': '/bin/bash', 11:43:25 INFO - 'SHLVL': '1', 11:43:25 INFO - 'TERM': 'linux', 11:43:25 INFO - 'TMOUT': '86400', 11:43:25 INFO - 'USER': 'cltbld', 11:43:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:25 INFO - '_': '/tools/buildbot/bin/python'} 11:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:43:25 INFO - Running setup.py (path:/tmp/pip-VHR28p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:43:25 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)) 11:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:43:25 INFO - Running setup.py (path:/tmp/pip-UHneOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:43:25 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)) 11:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:43:25 INFO - Running setup.py (path:/tmp/pip-Ql5K6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:43:25 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)) 11:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:43:25 INFO - Running setup.py (path:/tmp/pip-IZUpSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:43:26 INFO - Running setup.py (path:/tmp/pip-8enIb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:43:26 INFO - Running setup.py (path:/tmp/pip-6iTk28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:43:26 INFO - Running setup.py (path:/tmp/pip-VxKwHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:43:26 INFO - Running setup.py (path:/tmp/pip-r0HKKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:43:26 INFO - Running setup.py (path:/tmp/pip-UEwJnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:43:26 INFO - Running setup.py (path:/tmp/pip-iVtVQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:43:26 INFO - Running setup.py (path:/tmp/pip-EG1Dro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:43:26 INFO - Running setup.py (path:/tmp/pip-oKlPQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:43:26 INFO - Running setup.py (path:/tmp/pip-cYUz1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:43:26 INFO - Running setup.py (path:/tmp/pip-hjDunJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:26 INFO - Running setup.py (path:/tmp/pip-PxlciQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:43:26 INFO - Running setup.py (path:/tmp/pip-pq0AjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:43:26 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)) 11:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:43:26 INFO - Running setup.py (path:/tmp/pip-UGnGjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:43:26 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)) 11:43:26 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)) 11:43:26 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)) 11:43:26 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)) 11:43:26 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)) 11:43:26 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)) 11:43:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:43:26 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 11:43:26 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 11:43:26 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 11:43:26 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 11:43:26 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 11:43:26 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 11:43:28 INFO - Downloading blessings-1.6.tar.gz 11:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:43:28 INFO - Installing collected packages: blessings 11:43:28 INFO - Running setup.py install for blessings 11:43:29 INFO - Successfully installed blessings 11:43:29 INFO - Cleaning up... 11:43:29 INFO - Return code: 0 11:43:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:43:29 INFO - Reading from file tmpfile_stdout 11:43:29 INFO - Current package versions: 11:43:29 INFO - argparse == 1.2.1 11:43:29 INFO - blessings == 1.6 11:43:29 INFO - blobuploader == 1.2.4 11:43:29 INFO - docopt == 0.6.1 11:43:29 INFO - functools32 == 3.2.3-2 11:43:29 INFO - jsonschema == 2.5.1 11:43:29 INFO - manifestparser == 1.1 11:43:29 INFO - mozInstall == 1.12 11:43:29 INFO - mozcrash == 0.17 11:43:29 INFO - mozdebug == 0.1 11:43:29 INFO - mozdevice == 0.48 11:43:29 INFO - mozfile == 1.2 11:43:29 INFO - mozhttpd == 0.7 11:43:29 INFO - mozinfo == 0.9 11:43:29 INFO - mozleak == 0.1 11:43:29 INFO - mozlog == 3.2 11:43:29 INFO - moznetwork == 0.27 11:43:29 INFO - mozprocess == 0.23 11:43:29 INFO - mozprofile == 0.28 11:43:29 INFO - mozrunner == 6.12 11:43:29 INFO - mozscreenshot == 0.1 11:43:29 INFO - mozsystemmonitor == 0.3 11:43:29 INFO - moztest == 0.7 11:43:29 INFO - mozversion == 1.4 11:43:29 INFO - psutil == 3.1.1 11:43:29 INFO - requests == 1.2.3 11:43:29 INFO - wsgiref == 0.1.2 11:43:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:29 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:29 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 11:43:29 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 11:43:29 INFO - Using env: {'DISPLAY': ':0', 11:43:29 INFO - 'HOME': '/home/cltbld', 11:43:29 INFO - 'LANG': 'en_US.UTF-8', 11:43:29 INFO - 'LANGUAGE': 'en_US:en', 11:43:29 INFO - 'LOGNAME': 'cltbld', 11:43:29 INFO - 'MAIL': '/var/mail/cltbld', 11:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:29 INFO - 'MOZ_NO_REMOTE': '1', 11:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:29 INFO - 'NO_EM_RESTART': '1', 11:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:29 INFO - 'PWD': '/builds/slave/test', 11:43:29 INFO - 'SHELL': '/bin/bash', 11:43:29 INFO - 'SHLVL': '1', 11:43:29 INFO - 'TERM': 'linux', 11:43:29 INFO - 'TMOUT': '86400', 11:43:29 INFO - 'USER': 'cltbld', 11:43:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:29 INFO - '_': '/tools/buildbot/bin/python'} 11:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11:43:29 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)) 11: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 mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:43:29 INFO - Cleaning up... 11:43:29 INFO - Return code: 0 11:43:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:29 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', '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 11:43:29 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 11:43:29 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 11:43:29 INFO - Using env: {'DISPLAY': ':0', 11:43:29 INFO - 'HOME': '/home/cltbld', 11:43:29 INFO - 'LANG': 'en_US.UTF-8', 11:43:29 INFO - 'LANGUAGE': 'en_US:en', 11:43:29 INFO - 'LOGNAME': 'cltbld', 11:43:29 INFO - 'MAIL': '/var/mail/cltbld', 11:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:29 INFO - 'MOZ_NO_REMOTE': '1', 11:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:29 INFO - 'NO_EM_RESTART': '1', 11:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:29 INFO - 'PWD': '/builds/slave/test', 11:43:29 INFO - 'SHELL': '/bin/bash', 11:43:29 INFO - 'SHLVL': '1', 11:43:29 INFO - 'TERM': 'linux', 11:43:29 INFO - 'TMOUT': '86400', 11:43:29 INFO - 'USER': 'cltbld', 11:43:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:29 INFO - '_': '/tools/buildbot/bin/python'} 11:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:43:29 INFO - Cleaning up... 11:43:29 INFO - Return code: 0 11:43:29 INFO - Running post-action listener: _resource_record_post_action 11:43:29 INFO - Running post-action listener: _start_resource_monitoring 11:43:29 INFO - Starting resource monitoring. 11:43:29 INFO - ##### 11:43:29 INFO - ##### Finished create-virtualenv step (success) 11:43:29 INFO - ##### 11:43:29 INFO - ##### 11:43:29 INFO - ##### Running install step. 11:43:29 INFO - ##### 11:43:29 INFO - Running pre-action listener: _resource_record_pre_action 11:43:29 INFO - Running main action method: install 11:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:43:30 INFO - Reading from file tmpfile_stdout 11:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:43:30 INFO - Reading from file tmpfile_stdout 11:43:30 INFO - Output received: 11:43:30 INFO - Usage: mozinstall [options] installer 11:43:30 INFO - Options: 11:43:30 INFO - -h, --help show this help message and exit 11:43:30 INFO - -d DEST, --destination=DEST 11:43:30 INFO - Directory to install application into. [default: 11:43:30 INFO - "/builds/slave/test"] 11:43:30 INFO - --app=APP Application being installed. [default: firefox] 11:43:30 INFO - mkdir: /builds/slave/test/build/application 11:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:43:46 INFO - Reading from file tmpfile_stdout 11:43:46 INFO - Output received: 11:43:46 INFO - /builds/slave/test/build/application/firefox/firefox 11:43:46 INFO - Running post-action listener: _resource_record_post_action 11:43:46 INFO - ##### 11:43:46 INFO - ##### Finished install step (success) 11:43:46 INFO - ##### 11:43:46 INFO - ##### 11:43:46 INFO - ##### Running run-tests step. 11:43:46 INFO - ##### 11:43:46 INFO - Running pre-action listener: _resource_record_pre_action 11:43:46 INFO - Running main action method: run_tests 11:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:46 INFO - Python 2.7.3 11:43:46 INFO - Return code: 0 11:43:46 INFO - grabbing minidump binary from tooltool 11:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:46 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 0x1cfc570>, '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 0x1cfd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:46 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 11:43:46 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 11:43:46 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 11:43:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:46 INFO - Return code: 0 11:43:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:43:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:43:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:43:46 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:43:46 INFO - Using env: {'DISPLAY': ':0', 11:43:46 INFO - 'HOME': '/home/cltbld', 11:43:46 INFO - 'LANG': 'en_US.UTF-8', 11:43:46 INFO - 'LANGUAGE': 'en_US:en', 11:43:46 INFO - 'LOGNAME': 'cltbld', 11:43:46 INFO - 'MAIL': '/var/mail/cltbld', 11:43:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:46 INFO - 'MOZ_NO_REMOTE': '1', 11:43:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:46 INFO - 'NO_EM_RESTART': '1', 11:43:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:46 INFO - 'PWD': '/builds/slave/test', 11:43:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:46 INFO - 'SHELL': '/bin/bash', 11:43:46 INFO - 'SHLVL': '1', 11:43:46 INFO - 'TERM': 'linux', 11:43:46 INFO - 'TMOUT': '86400', 11:43:46 INFO - 'USER': 'cltbld', 11:43:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468867374.377298-1479573686', 11:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:46 INFO - '_': '/tools/buildbot/bin/python'} 11:43:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:43:46 INFO - mozversion application_buildid: 20160718102052 11:43:46 INFO - mozversion application_changeset: 895873ee9b11fdb024fc133cdc6558d97038e0d0 11:43:46 INFO - mozversion application_display_name: Nightly 11:43:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:46 INFO - mozversion application_name: Firefox 11:43:46 INFO - mozversion application_remotingname: firefox 11:43:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:43:46 INFO - mozversion application_vendor: Mozilla 11:43:46 INFO - mozversion application_version: 50.0a1 11:43:46 INFO - mozversion platform_buildid: 20160718102052 11:43:46 INFO - mozversion platform_changeset: 895873ee9b11fdb024fc133cdc6558d97038e0d0 11:43:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:43:46 INFO - mozversion platform_version: 50.0a1 11:43:46 INFO - using testdate: 1468867426 11:43:46 INFO - actual date: 1468867426 11:43:46 INFO - starting webserver on 'localhost:40195' 11:43:46 INFO - SUITE-START | Running 2 tests 11:43:46 INFO - TEST-START | dromaeo_css 11:43:46 INFO - operating with platform_type : linux_ 11:43:46 INFO - Initialising browser for dromaeo_css test... 11:43:46 INFO - TEST-INFO | started process 20902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepWSws/profile http://localhost:40195/getInfo.html) 11:43:52 INFO - PROCESS | 20902 | __metrics Screen width/height:1600/1200 11:43:52 INFO - PROCESS | 20902 | colorDepth:24 11:43:52 INFO - PROCESS | 20902 | Browser inner width/height: 1024/697 11:43:52 INFO - PROCESS | 20902 | __metrics 11:43:52 ERROR - PROCESS | 20902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:43:53 INFO - TEST-INFO | 20902: exit 0 11:43:53 INFO - Browser initialized. 11:43:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:53 INFO - TEST-INFO | started process 21019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepWSws/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:05 INFO - PROCESS | 21019 | RSS: Main: 168722432 11:44:05 INFO - PROCESS | 21019 | 11:44:55 INFO - PROCESS | 21019 | 1468867495418 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] 11:47:07 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40195/tests/dromaeo/cssquery-ext.html) 11:47:09 INFO - PROCESS | 21019 | RSS: Main: 169713664 11:47:09 INFO - PROCESS | 21019 | 11:50:11 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-ext.html (next: http://localhost:40195/tests/dromaeo/cssquery-jquery.html) 11:50:12 INFO - PROCESS | 21019 | RSS: Main: 169443328 11:50:12 INFO - PROCESS | 21019 | 11:53:13 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40195/tests/dromaeo/cssquery-mootools.html) 11:53:14 INFO - PROCESS | 21019 | RSS: Main: 172933120 11:53:14 INFO - PROCESS | 21019 | 11:56:16 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40195/tests/dromaeo/cssquery-prototype.html) 11:56:17 INFO - PROCESS | 21019 | RSS: Main: 167321600 11:56:17 INFO - PROCESS | 21019 | 11:59:19 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40195/tests/dromaeo/cssquery-yui.html) 11:59:20 INFO - PROCESS | 21019 | RSS: Main: 169480192 11:59:20 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:40195/tests/dromaeo/cssquery-yui.html (next: http://localhost:40195/tests/dromaeo/cssquery-dojo.html) 12:02:23 INFO - PROCESS | 21019 | RSS: Main: 170635264 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | __start_tp_report 12:02:23 INFO - PROCESS | 21019 | _x_x_mozilla_page_load 12:02:23 INFO - PROCESS | 21019 | _x_x_mozilla_page_load_details 12:02:23 INFO - PROCESS | 21019 | |i|pagename|runs| 12:02:23 INFO - PROCESS | 21019 | |0;dojo.html;2618.266885272123;2642.6960899496553;2643.841369517829;2680.0217920459013;2689.5831146172336;4820.493848145947;4890.193118135508;4922.630802689795;4938;5001.724905130216;4626.46795618504;4806.975965120178;4833;4855.271709243615;4895.9020819583675;4383.561643835615;4421.894526368408;4542.568455996675;4555.362249285103;4556.6582506312;207.82725615387187;4441.111777644468;4509.25597276449;4535.750533720644;4550.044490656949;4450.710703804259;4474.373587697725;4484.8878778030485;4491;4527.683062185648;4403.6256918162;4488.349189367556;4538.636909047268;4545.659075569312;4550.362949187116;4383.145286669101;4471.955280447187;4478.910421791578;4478.955210447886;4522.118186953512;4830.879228019293;4843.055604157191;4874.951250487521;4896.143174944406;4924.75376231187;4987.501249875019;5105.387353517564;5131.281620573122;5155.278261043457;5191.9480805192225;5208.947910520884;5225.843224703265;5231.843044708665;5232.816851410221;5273.630845840793;4840.1287768201355;4847.587955023827;4850.029994001214;4856.732879691651;4905.730184839832;5137.306463627438;5293.285406470077;5332.733363331818;5336;5357.196420536873;5114.028334616485;5140.1004824155625;5155.200943853709;5160.92258616121;5169.4830516948;5246.842594722164;5250.7637156328055;5253.054450198924;5253.185756207794;5297.311349524614;4913.803447862117;5079.08576456234;5103.413107492612;5134.589232861362;5140.46025167352;4901.950980490149;4937.802487900515;4937.802487900515;5017.397912250481;5023.070731914608;4270.978645106755;4282.764447955392;4288.506821715543;4330.501992270866;4391.1217756448195;3867.8839634811;3873.0511024799102;3873.748206366577;3880.1269714314053;3913.9021524462114;4330.069035157457;4416.33754936762;4453.755043472575;4493.550644935481;4559.6124329431705;5180.870478237999;5243.23973023917;5252.868678283074;5261.289725886956;5299.046171689056;4464.218761716752;4483;4484.1031793641405;4490.595846373777;4522.615577675869;4493.5281795411665;4661.230896902041;4696.577308042292;4705.858824235278;4748.4539277982785;4946.727929963887;4972.900541989067;4980.551750342414;4998.275250088789;5009.474005229471;5303.337082864642;5314.97342513285;5318.228856815817;5320.148776195945;5355.277037599874;4762.76186190696;4821.2045012572535;4842.927356089591;4885.560299573055;4963.404391473046;5036.672616280077;5046.495350464924;5050.444451110301;5051.09080365523;5118.846434606968;5109.565686916654;5140.871478213075;5141.562967147835;5164.018836421068;5167;4841.782119804688;4922.261660750916;4928.630352723631;4964.975175124246;4967.552920237196;4946.35697359341;4955.8017679292425;4969.453360130455;4993.950060499348;5019;4840.322354870392;4895.4370247422;4895.534924182197;4913.115639184838;4931.2849636803185;4833.661643684908;4983.900321993612;5035.219540971156;5054.469280725618;5078.746062696924;4949.257611358325;5008.223725322581;5031.169856973558;5033.144365457954;5099.388073431212 12:02:23 INFO - PROCESS | 21019 | |1;ext.html;559.4796838939785;568.4684819693584;574.8131857146426;574.9281339832519;606.1271768653137;35944.820275898615;40607;40653;40929;41104.79447602758;40428.38286468538;40876.59123408765;40879;41045.38431923516;41087.178256434854;7718.228177182279;7867.567283799389;7883.881741773878;7919.604019799016;7922.128565857751;7865.134835168127;7897.6840926362875;7903.36773058154;7976.920230797676;7987.400944929124;8022.398320125984;8057;8060.314873235782;8060.355171586289;8075.434719569633;7922.36621070313;7997.320227780617;8020.077691065486;8023.67905283788;8039.31665808407;7761.805954851117;7821.178776228528;7852.960735196288;7863.213678632148;7881.921180788176;39129;39636.80181599102;39758.20483590312;39879.60120398788;39969.60030399688;3001.5797788309656;3041.847907604633;3109.751219902402;3137.30979184579;3184.347208822186;29891.701082989108;30207.697923020707;30287.091387258417;30686.203509885974;30776.230594235098;3290.7696461247724;3315.270320889;3363.5795525559306;3373.8987830365127;3414.3171365726953;263231.9999999981;265957;265980;267443;267801;54994.450055498935;55472.72263638656;55608;55634;55720.44279557234;33432.49851252233;34161.658383415845;34269.14327141792;36313.45529817055;59647.701761491786;13825.723485530232;13955.162690238618;13970.860291396955;13977.58067257984;14031.78952315716;11671.066314694805;11768.35274059935;11831.585894493823;11846.585369512026;11847.466863991142;18905.338313158973;18967.525811854815;18970.300791345555;19058.714119288223;19063.809361906482;6825.631595778706;6854.554453960576;7033.753818616324;7157.534760240567;7246.96376518114;772.119783446871;853.7182729699184;859.3984211052164;901.3104974694364;961.5721004153085;27990;29092.418151637274;29197;29432.852835735684;29627.111186664435;883.1742320929951;922.7877588154762;950.6595700062878;955.498363359228;981.259149342242;14871;15057.02129361588;15154.393824246907;15445.150516721464;15548.689026219412;381222;382835;383843;387741;389673;51653.741731291106;52049.21926171111;52135.47864521382;52272.738636306574;52648;1152.8386025956372;1190.1014733875868;1205.445495072259;1220.877912208772;1225.6445630767157;26575.60136597914;27782.305442364104;27814.721852781215;28252;28684.282892927844;41675.37486937759;41752.791236043624;41950.37074443947;42128;42182.78908605437;328872;329717;330791;331237;331477;25479.617805733298;25699.229023128588;26060.34849128787;26426.603600946386;26450.338741531617;43031.7848410756;43758.34362484629;43794;44320.335194972744;44450.55549444464;38017.61982380141;38163;38367.623334462216;38374.23251534898;38455;37771.62228377791;37772;38524.80737596294;38613.4207986886;38889;31136.22159446032;36010.63989360073;36358.8182059088;37201.44197837089;37602.435963460026;32377.51433728543;34035;34561.65438345685;34719.82640086783;34864.779732709234;26208;26221.34446638849;26502.469950600494;26728;26770.732292676825 12:02:23 INFO - PROCESS | 21019 | |2;jquery.html;370.5682879445448;375.08292225508626;375.9116607597214;382.8200745649544;388.6560394051267;16344.427945021927;17663.205155767988;18177.63644727105;18221;18256.908715456437;17002.659946801086;17225.554889022183;17571.385001524948;17653.20560574774;17713;5074.771635276412;5216.973915130438;5225.425203227642;5242.082635538765;5256.237845512398;3651.1054791576103;4141.378793181032;5170.715610641432;6147.077938309267;6274.341194174614;6173.166622505972;6183.505319574423;6205.844853878667;6209.596376235553;6216.409441103088;6038.0641000644755;6085.056816193497;6085.391460853902;6093.817185484399;6105.603135796181;5138.3833939927445;5267.104592219332;5308.097623404031;5331.226972089025;5331.386890507563;20632.27787027447;21234.256801012045;21455.892720536296;21516.139354425803;21720.674189887166;1906.323255244396;1935.1485346447519;1951.0634895250219;1972.743543339371;2063.9174433022813;13183.538576149884;13349.33253337339;13460.586638402925;13597.456101755917;13862.4455021799;1728.9654206915918;1737.6090379664602;1766.1787268919886;1803.1705415508882;1805.9909700451544;64463;66810;68451.65774171097;69008.30991690069;69291.307086929;9302;9447.811043779086;9491.240700743923;9623.663171788954;9872;13314.93342533281;13342.466301347837;13356.599302020955;13394.799078013837;13456.529021484397;7129.643517824088;7399.223081576357;7480.251974802476;7509.774706758806;7563.773086807405;7246.347828695337;7267.0552828132;7323.816904577428;7379.483436159418;7389.5196812208105;5999.340072592011;6066.908996365058;6181.690915454299;6192.845178870564;6254.593451425642;1699.192883380409;1756.5257380507192;1766.5760217547695;1771.2029586686042;1785.3572713823014;830.2278880641062;837.342685991506;853.3471894001094;860.1636700316658;869.4565896314804;17729.822701773075;17890.731639025424;18061.09694515269;18129;18612;864.9264812491009;891.0688330694439;891.5096696816724;911.0161026091805;927.4388994658269;9404;10367;10373.481325933673;10415.218858585637;10419.114375278186;363207;364066;364448;364786;391452;68166.31833681698;72121;73200.2679973204;73714;74292.25707742853;918.2011649864661;927.5408672707053;931.064280398209;952.1953948913157;958.2334132693817;15150.16674082936;15631.531054068397;15841.603959901095;15863.603409914844;15995.680086397973;35373.29253414969;35704;35798.8210058948;35894.82052589825;36949;46776.532234678576;48059.519404805505;48665;48792;48816.11838816232;7802.6488808004915;7833.804154896173;7860.4104692147175;7923.484973476706;8005.959970200344;11859.110566707359;12115.515379384726;12343.629691109281;12376.257424554555;12833.614991550268;10195.082442580204;10420.583176673152;10800.135989120694;10806.891931080903;10999.835002475129;9721.416714997124;10444.060034596923;10454.477276136315;10581.947090264499;10700.732481688021;10299.691009269734;10723.785524289626;10923.180761443082;10942.343459392461;11142.164337674545;7364.41084713211;7684.46208765381;7766.068071831416;7816.84366312682;7942.205779422012;10325.32885362449;10473.109785668303;10533.157347412342;10798.946005270238;10828.350298981772 12:02:23 INFO - PROCESS | 21019 | |3;mootools.html;1385.3142694366284;1413.3216056292981;1509.4716849102815;1702.0723705580474;1717.7595136680866;6830.556013859108;7377.8155546111375;7574.204708505604;8124.390670699699;8126.878096828545;7714.34428073613;7931.801704957379;8002.639881205345;8004.759857204279;8006.479578827372;2168.793964573371;2223.455253462904;2224.5773303072447;2224.92212772553;2227.599032174208;2181.1384503121258;2193.1008286602496;2207.933761987143;2232.408411770882;2233.4081468410886;2174.4563859035243;2175.7280339957506;2180.4330873972804;2181.225664888965;2200.1749343996003;2108.6309895768254;2116.322776711453;2123.883186424746;2127.680847872816;2138.9358319250446;2092.0794850265834;2109.630814607453;2123.861948973312;2133.541288622938;2138.7433507978985;7925.048994120685;7989.400794940345;8058.315043221333;8067.031956165239;8075.596220188967;4611.146937816515;4725.456572494173;4727.881802954919;4732;4740.525947405266;2741.7258274172623;2788.7768978481877;2840.5171120909495;2876.0652787844033;2913.766898648103;884.120300301198;892.6741739265186;901.3059943843269;903.4579252448544;911.1708345405649;10658.253922225447;10681.41252231127;10702.839457408145;10723.195760317929;10754.892451075468;4104.445899803548;4260.275753121977;4297.656187504992;4342.5874541918465;4368.344748287719;9127.08729127082;9154.176124148858;9156.496392698333;9160.404573702688;9176.44941303524;4626.4910859805395;4626.884327891762;4631.861044168681;4651.720896746206;4671.649626278043;3742.7754334740002;4214.810333534998;4219.957800421957;4264.701470897007;4416.072624748838;3542.3977923753023;3675.8162091895297;3685.262947410529;3733.775973441602;3880.825362858678;1187.4122309456875;1195.2847663602759;1198.149313987079;1209.4194786502528;1216.7566486702517;819.9463689159521;824.3487644760692;875.7898104454885;897.555709923579;921.4333185091255;5289.497497737709;5405.4324295949145;5532.502074813206;5629.718514074362;5679.148127780866;898.1198425543005;915.6657819895823;916.3951791817502;922.2253307221831;939.5349302095507;3976.5029371328583;4141.254574176677;4145.875623731293;4164.5210800757695;4184.372344148402;9593.952030239805;9647.179989700813;9725.805483890283;9739.56171972263;9764.267679924034;9530.666426675032;9555.378900371454;9618.711438656852;9648.614055437843;9659.90340096604;6994.370506654425;7259.310365515267;7288.416926645856;7335.853282934311;7335.926640733524;5597.944020559742;5721.370649228498;5862.530997520103;5877.853053673693;5919.378465261086;8624.353173512138;8990.460572365679;9026.774330641787;9206.17144457002;9244.399114057835;8893.421927574687;9251.861222081809;9256.24131415029;9378.95310523443;9402;6179.536534759821;6666.500012498985;6850.862982740217;6878.209005964178;6962.060121883481;7598.392128629807;7688.192739762245;7712.5758083305955;7751.6511756972195;7760.379169666526;6811.863762724619;7011.894821577578;7034.050403195503;7071.328223818729;7136.785896422908;6739.887918493394;6771.356721111487;6846.246912839683;6884.65576721152;7018.894716579358;6315.431611154834;6374.904376434264;6380.585261957958;6459.6770161490795;6474.805755827333;4691.390119284471;4726.338312636165;4761.500042495627;4768.094062128184;4796.9760151199025;4816.735079570657;4844.370231869834;4864.489228630943;4963.677360971526;4995.975020124876 12:02:23 INFO - PROCESS | 21019 | |4;prototype.html;302.8440353218093;305.3374178033667;309.5125177844893;312.99687003129975;315.451115059796;4978.875528111799;4997.9500204997985;5068.1637529807585;5078.898422031557;5091.770870310836;4983.277424773406;5024.271480635306;5032.572231360339;5074.873128171797;5086.855457522056;3746.5316835395574;3845;3952.2095580883793;3963.702722295825;3963.8612648557305;3938.1926705025403;3943.5464921534103;3953.4267531207956;3971.404289356605;3972.483577134983;3931.312020396419;3944.901377465572;3945.782981935992;3952.1305312831273;3959.366501359783;3756.5679946806194;3896.883093507199;3935.6457918787446;3950.4666869972475;3956.2987915196454;3404.131946353664;3412.1128506588216;3413.300273443938;3413.6586341365914;3423.442333738168;4933.703977761345;4945.579625731817;4951.925721114186;4954.9009019819405;4983.950160498385;4374.4531933508315;4466.53101424349;4470.307102399133;4484.5291244419195;4491.505934347252;5231.712255825928;5240.2401651760665;5245.606579506552;5251.212318152269;5259.316288882421;3749.250149970017;3751.8686845960533;3774.8678796242275;3780.4140358244517;3785.6403641653997;5404.297441332641;5517.172424136372;5533.142362933751;5546.140348246028;5553.8333849984565;3886.5724770275247;3887.5918028607157;3901.8439262429183;3907.238088572701;3914.805984174854;3956.823746939172;3962.9405558916637;3965.4844870166694;3966.4446977423186;3988.4615576897327;4491.079328737601;4507.797149128297;4514.706544074625;4515.774211289422;4529.411176547028;5134.871628209325;5188.169892817206;5239.345081864767;5245.239440281138;5305.787768489295;1355.302019459979;1369.9519867301522;1373.0800363756107;1374.9450021999207;1382.3295701584723;838.5639467477;861.573521107056;867.1891781184613;878.5870640798814;878.6309749905055;4498.595126438636;4621.653375996813;4630.675852690347;4641.164590373765;4669.463011753692;5418.810341638024;5444.183372494078;5459.153831156177;5483.314585676791;5491.615586908878;4436.556344365602;4581.977090114528;4607.170709272296;4610.449953535759;4650.883727906829;2892.5950366948646;2905.418916216765;2906.3896581717654;2922.8246305221755;2933.750631196372;5178.352705911761;5186.559142472856;5194.4026436959475;5218.504242096995;5221.634485586049;5481.369642491085;5581.609287349846;5598.300212473441;5630.5214056805635;5658.971705141448;5053.8881446081805;5094.2613321068975;5098.872528186825;5108.259302401131;5122.436531981479;5395.92081583677;5419.783208671766;5432.2123292123215;5466.699331536804;5470.72646367688;5116.667416617908;5334.3865455473115;5341;5350.652207606493;5381.5694744421135;5146.841960558844;5176.2494438306985;5177.404598471224;5187.403448603459;5198.948010519846;3939.4878665773267;3952.308346039374;3955.3473676843;3958.9208215836097;3959.7030222732833;5171.63798534099;5459.672419654833;5518.413031529538;5532.114861622121;5534.446555344594;5340.145576707708;5355.571554275571;5370.650907690988;5398.379186393615;5423.3491980962535;5168.638195326442;5353.812616558402;5358.32083958021;5389.167682987803;5406.4052954175795;5219.321488206509;5259.894802104013;5273.78904843802;5281.656692314988;5312.5484333832055;5062.367204099488;5194.065068287745;5320.388155362183;5333.919991200058;5367.550761294507;5213.218017297436;5217.686938783533;5219.19102539107;5220.347456567929;5232.4505926878655 12:02:23 INFO - PROCESS | 21019 | |5;yui.html;609.6561995780066;664.4319107163373;687.9208890977533;691.7959202035399;714.8606021825743;12650.987920966323;12772.872271277285;13209.669758256025;13776.173429594219;13845.030847840655;13008.219506829597;13057.151285166457;13185.538506152287;13187.076904616657;13188.142770719896;623.597779432266;763.4655740981322;769.7459838253363;782.1787123520281;783.4946459533597;791.066541481055;793.4961299574754;793.8809178623195;796.2594786848229;797.2386371015666;834.1950018232404;834.2950207075012;835.7367429259795;837.8240569480416;838.4005436113177;827.8799574061787;830.024720952881;830.1698301698302;830.3523251863526;831.1771346367113;604.087827380654;605.0410099991519;605.1407002057045;605.1437216338875;605.4883623338272;13901.58295251144;13945.372458239404;13979.440822367194;14019.369128389248;14119.505817296345;13973.161610303414;14147.29263536819;14159.858401415957;14219.50231741884;14251.216183109926;10516.263861529696;10689.518971646294;10700;10706.41114738689;10720;3282.7045565898943;3340.064781861083;3348.280119774236;3356.2616224430585;3357.2278375973665;68707.65646171737;69364;69600.65199673969;70737.64631176862;71726.64136679283;10817.513211905325;10841.566337346418;10904.454777261106;10991.725206869893;11089.39008354532;21020.47448813792;21024.26415075465;21040.894795525925;21191.152353905672;21608.459788505414;6857.177138743383;6918.273581273894;6976.860462790817;7124.643767811589;7384.076990376203;3737.4020156774786;3755.75587586806;3761.4169803680475;3833.5208098987628;3910.550286717064;3016.592759977419;3122.921926951799;3132.9530057049164;3135.7804953653026;3135.984320078385;483.9346688197119;493.71117896030506;501.38830626635445;508.707493191409;509.3226009407479;519.9610029247822;540.2139886465184;570.4096260370579;585.4350551717613;585.5169485174748;7455.925440745632;8086.150954149847;8181.713640022571;8376;8428;482.92031814750874;493.3192194771193;508.8269988204028;550.8319962411503;551.5174222555264;3807.7715337079862;3957.2283404736377;3996.1008773025837;4006.579309172495;4117.876463706094;53356.46643533515;102609;103287.4835625832;104561.47719261507;104767.4761626187;91759.54120229356;93816;94396;94725;95057;80738.59630701809;83994;85411.57294213613;86260.41218763447;86496;8266.380021498291;8357.206065423776;8358.373122015995;8490.787730306793;8501.19238672325;39069.80465097656;46787.29819052649;48533.75733121312;50238.748806257194;50786.238206427675;56100.71949640226;60740;61272;61674.69162654158;62066.68966655138;11570.652880413601;11675.474603643026;11724.941375293069;11736.706582335168;11809.468573914366;12453.377331133226;12719.98240140805;12773.552925647558;12847.678808029874;12868.613941581767;11465.713357166138;11898.286102833858;11917;12365.938170309091;12708;11633.53465861356;12026.75946481083;12090.697732556757;12222;12304.077194210291;11832.76334473323;12100.697482563006;12214.14500984958;12242.571509997108;12252.754944900873;9106.453612783254;9320.813583728423;9356.251499879858;10467.790644187226;10743;9382;9429;9550.140487356171;9681.951590242004;9805.656802011896 12:02:23 INFO - PROCESS | 21019 | __end_tp_report 12:02:23 INFO - PROCESS | 21019 | __start_cc_report 12:02:23 INFO - PROCESS | 21019 | _x_x_mozilla_cycle_collect,393 12:02:23 INFO - PROCESS | 21019 | __end_cc_report 12:02:23 INFO - PROCESS | 21019 | __startTimestamp1468868543300__endTimestamp 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | ------- Summary: start ------- 12:02:23 INFO - PROCESS | 21019 | Number of tests: 6 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#0] dojo.html Cycles:165 Average:4758.12 Median:4913.80 stddev:616.17 (12.5%) stddev-sans-first:594.75 12:02:23 INFO - PROCESS | 21019 | Values: 2618.3 2642.7 2643.8 2680.0 2689.6 4820.5 4890.2 4922.6 4938.0 5001.7 4626.5 4807.0 4833.0 4855.3 4895.9 4383.6 4421.9 4542.6 4555.4 4556.7 207.8 4441.1 4509.3 4535.8 4550.0 4450.7 4474.4 4484.9 4491.0 4527.7 4403.6 4488.3 4538.6 4545.7 4550.4 4383.1 4472.0 4478.9 4479.0 4522.1 4830.9 4843.1 4875.0 4896.1 4924.8 4987.5 5105.4 5131.3 5155.3 5191.9 5208.9 5225.8 5231.8 5232.8 5273.6 4840.1 4847.6 4850.0 4856.7 4905.7 5137.3 5293.3 5332.7 5336.0 5357.2 5114.0 5140.1 5155.2 5160.9 5169.5 5246.8 5250.8 5253.1 5253.2 5297.3 4913.8 5079.1 5103.4 5134.6 5140.5 4902.0 4937.8 4937.8 5017.4 5023.1 4271.0 4282.8 4288.5 4330.5 4391.1 3867.9 3873.1 3873.7 3880.1 3913.9 4330.1 4416.3 4453.8 4493.6 4559.6 5180.9 5243.2 5252.9 5261.3 5299.0 4464.2 4483.0 4484.1 4490.6 4522.6 4493.5 4661.2 4696.6 4705.9 4748.5 4946.7 4972.9 4980.6 4998.3 5009.5 5303.3 5315.0 5318.2 5320.1 5355.3 4762.8 4821.2 4842.9 4885.6 4963.4 5036.7 5046.5 5050.4 5051.1 5118.8 5109.6 5140.9 5141.6 5164.0 5167.0 4841.8 4922.3 4928.6 4965.0 4967.6 4946.4 4955.8 4969.5 4994.0 5019.0 4840.3 4895.4 4895.5 4913.1 4931.3 4833.7 4983.9 5035.2 5054.5 5078.7 4949.3 5008.2 5031.2 5033.1 5099.4 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#1] ext.html Cycles:180 Average:48271.71 Median:210601.31 stddev:87000.54 (41.3%) stddev-sans-first:87170.85 12:02:23 INFO - PROCESS | 21019 | Values: 559.5 568.5 574.8 574.9 606.1 35944.8 40607.0 40653.0 40929.0 41104.8 40428.4 40876.6 40879.0 41045.4 41087.2 7718.2 7867.6 7883.9 7919.6 7922.1 7865.1 7897.7 7903.4 7976.9 7987.4 8022.4 8057.0 8060.3 8060.4 8075.4 7922.4 7997.3 8020.1 8023.7 8039.3 7761.8 7821.2 7853.0 7863.2 7881.9 39129.0 39636.8 39758.2 39879.6 39969.6 3001.6 3041.8 3109.8 3137.3 3184.3 29891.7 30207.7 30287.1 30686.2 30776.2 3290.8 3315.3 3363.6 3373.9 3414.3 263232.0 265957.0 265980.0 267443.0 267801.0 54994.5 55472.7 55608.0 55634.0 55720.4 33432.5 34161.7 34269.1 36313.5 59647.7 13825.7 13955.2 13970.9 13977.6 14031.8 11671.1 11768.4 11831.6 11846.6 11847.5 18905.3 18967.5 18970.3 19058.7 19063.8 6825.6 6854.6 7033.8 7157.5 7247.0 772.1 853.7 859.4 901.3 961.6 27990.0 29092.4 29197.0 29432.9 29627.1 883.2 922.8 950.7 955.5 981.3 14871.0 15057.0 15154.4 15445.2 15548.7 381222.0 382835.0 383843.0 387741.0 389673.0 51653.7 52049.2 52135.5 52272.7 52648.0 1152.8 1190.1 1205.4 1220.9 1225.6 26575.6 27782.3 27814.7 28252.0 28684.3 41675.4 41752.8 41950.4 42128.0 42182.8 328872.0 329717.0 330791.0 331237.0 331477.0 25479.6 25699.2 26060.3 26426.6 26450.3 43031.8 43758.3 43794.0 44320.3 44450.6 38017.6 38163.0 38367.6 38374.2 38455.0 37771.6 37772.0 38524.8 38613.4 38889.0 31136.2 36010.6 36358.8 37201.4 37602.4 32377.5 34035.0 34561.7 34719.8 34864.8 26208.0 26221.3 26502.5 26728.0 26770.7 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#2] jquery.html Cycles:180 Average:23836.67 Median:379.37 stddev:60935.37 (16062.4%) stddev-sans-first:61080.84 12:02:23 INFO - PROCESS | 21019 | Values: 370.6 375.1 375.9 382.8 388.7 16344.4 17663.2 18177.6 18221.0 18256.9 17002.7 17225.6 17571.4 17653.2 17713.0 5074.8 5217.0 5225.4 5242.1 5256.2 3651.1 4141.4 5170.7 6147.1 6274.3 6173.2 6183.5 6205.8 6209.6 6216.4 6038.1 6085.1 6085.4 6093.8 6105.6 5138.4 5267.1 5308.1 5331.2 5331.4 20632.3 21234.3 21455.9 21516.1 21720.7 1906.3 1935.1 1951.1 1972.7 2063.9 13183.5 13349.3 13460.6 13597.5 13862.4 1729.0 1737.6 1766.2 1803.2 1806.0 64463.0 66810.0 68451.7 69008.3 69291.3 9302.0 9447.8 9491.2 9623.7 9872.0 13314.9 13342.5 13356.6 13394.8 13456.5 7129.6 7399.2 7480.3 7509.8 7563.8 7246.3 7267.1 7323.8 7379.5 7389.5 5999.3 6066.9 6181.7 6192.8 6254.6 1699.2 1756.5 1766.6 1771.2 1785.4 830.2 837.3 853.3 860.2 869.5 17729.8 17890.7 18061.1 18129.0 18612.0 864.9 891.1 891.5 911.0 927.4 9404.0 10367.0 10373.5 10415.2 10419.1 363207.0 364066.0 364448.0 364786.0 391452.0 68166.3 72121.0 73200.3 73714.0 74292.3 918.2 927.5 931.1 952.2 958.2 15150.2 15631.5 15841.6 15863.6 15995.7 35373.3 35704.0 35798.8 35894.8 36949.0 46776.5 48059.5 48665.0 48792.0 48816.1 7802.6 7833.8 7860.4 7923.5 8006.0 11859.1 12115.5 12343.6 12376.3 12833.6 10195.1 10420.6 10800.1 10806.9 10999.8 9721.4 10444.1 10454.5 10581.9 10700.7 10299.7 10723.8 10923.2 10942.3 11142.2 7364.4 7684.5 7766.1 7816.8 7942.2 10325.3 10473.1 10533.2 10798.9 10828.4 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#3] mootools.html Cycles:180 Average:5238.18 Median:5700.26 stddev:2901.72 (50.9%) stddev-sans-first:2895.41 12:02:23 INFO - PROCESS | 21019 | Values: 1385.3 1413.3 1509.5 1702.1 1717.8 6830.6 7377.8 7574.2 8124.4 8126.9 7714.3 7931.8 8002.6 8004.8 8006.5 2168.8 2223.5 2224.6 2224.9 2227.6 2181.1 2193.1 2207.9 2232.4 2233.4 2174.5 2175.7 2180.4 2181.2 2200.2 2108.6 2116.3 2123.9 2127.7 2138.9 2092.1 2109.6 2123.9 2133.5 2138.7 7925.0 7989.4 8058.3 8067.0 8075.6 4611.1 4725.5 4727.9 4732.0 4740.5 2741.7 2788.8 2840.5 2876.1 2913.8 884.1 892.7 901.3 903.5 911.2 10658.3 10681.4 10702.8 10723.2 10754.9 4104.4 4260.3 4297.7 4342.6 4368.3 9127.1 9154.2 9156.5 9160.4 9176.4 4626.5 4626.9 4631.9 4651.7 4671.6 3742.8 4214.8 4220.0 4264.7 4416.1 3542.4 3675.8 3685.3 3733.8 3880.8 1187.4 1195.3 1198.1 1209.4 1216.8 819.9 824.3 875.8 897.6 921.4 5289.5 5405.4 5532.5 5629.7 5679.1 898.1 915.7 916.4 922.2 939.5 3976.5 4141.3 4145.9 4164.5 4184.4 9594.0 9647.2 9725.8 9739.6 9764.3 9530.7 9555.4 9618.7 9648.6 9659.9 6994.4 7259.3 7288.4 7335.9 7335.9 5597.9 5721.4 5862.5 5877.9 5919.4 8624.4 8990.5 9026.8 9206.2 9244.4 8893.4 9251.9 9256.2 9379.0 9402.0 6179.5 6666.5 6850.9 6878.2 6962.1 7598.4 7688.2 7712.6 7751.7 7760.4 6811.9 7011.9 7034.1 7071.3 7136.8 6739.9 6771.4 6846.2 6884.7 7018.9 6315.4 6374.9 6380.6 6459.7 6474.8 4691.4 4726.3 4761.5 4768.1 4797.0 4816.7 4844.4 4864.5 4963.7 4996.0 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#4] prototype.html Cycles:180 Average:4402.71 Median:5058.13 stddev:1280.71 (25.3%) stddev-sans-first:1246.78 12:02:23 INFO - PROCESS | 21019 | Values: 302.8 305.3 309.5 313.0 315.5 4978.9 4998.0 5068.2 5078.9 5091.8 4983.3 5024.3 5032.6 5074.9 5086.9 3746.5 3845.0 3952.2 3963.7 3963.9 3938.2 3943.5 3953.4 3971.4 3972.5 3931.3 3944.9 3945.8 3952.1 3959.4 3756.6 3896.9 3935.6 3950.5 3956.3 3404.1 3412.1 3413.3 3413.7 3423.4 4933.7 4945.6 4951.9 4954.9 4984.0 4374.5 4466.5 4470.3 4484.5 4491.5 5231.7 5240.2 5245.6 5251.2 5259.3 3749.3 3751.9 3774.9 3780.4 3785.6 5404.3 5517.2 5533.1 5546.1 5553.8 3886.6 3887.6 3901.8 3907.2 3914.8 3956.8 3962.9 3965.5 3966.4 3988.5 4491.1 4507.8 4514.7 4515.8 4529.4 5134.9 5188.2 5239.3 5245.2 5305.8 1355.3 1370.0 1373.1 1374.9 1382.3 838.6 861.6 867.2 878.6 878.6 4498.6 4621.7 4630.7 4641.2 4669.5 5418.8 5444.2 5459.2 5483.3 5491.6 4436.6 4582.0 4607.2 4610.4 4650.9 2892.6 2905.4 2906.4 2922.8 2933.8 5178.4 5186.6 5194.4 5218.5 5221.6 5481.4 5581.6 5598.3 5630.5 5659.0 5053.9 5094.3 5098.9 5108.3 5122.4 5395.9 5419.8 5432.2 5466.7 5470.7 5116.7 5334.4 5341.0 5350.7 5381.6 5146.8 5176.2 5177.4 5187.4 5198.9 3939.5 3952.3 3955.3 3958.9 3959.7 5171.6 5459.7 5518.4 5532.1 5534.4 5340.1 5355.6 5370.7 5398.4 5423.3 5168.6 5353.8 5358.3 5389.2 5406.4 5219.3 5259.9 5273.8 5281.7 5312.5 5062.4 5194.1 5320.4 5333.9 5367.6 5213.2 5217.7 5219.2 5220.3 5232.5 12:02:23 INFO - PROCESS | 21019 | 12:02:23 INFO - PROCESS | 21019 | [#5] yui.html Cycles:180 Average:18636.56 Median:24513.54 stddev:26977.90 (110.1%) stddev-sans-first:27019.63 12:02:23 INFO - PROCESS | 21019 | Values: 609.7 664.4 687.9 691.8 714.9 12651.0 12772.9 13209.7 13776.2 13845.0 13008.2 13057.2 13185.5 13187.1 13188.1 623.6 763.5 769.7 782.2 783.5 791.1 793.5 793.9 796.3 797.2 834.2 834.3 835.7 837.8 838.4 827.9 830.0 830.2 830.4 831.2 604.1 605.0 605.1 605.1 605.5 13901.6 13945.4 13979.4 14019.4 14119.5 13973.2 14147.3 14159.9 14219.5 14251.2 10516.3 10689.5 10700.0 10706.4 10720.0 3282.7 3340.1 3348.3 3356.3 3357.2 68707.7 69364.0 69600.7 70737.6 71726.6 10817.5 10841.6 10904.5 10991.7 11089.4 21020.5 21024.3 21040.9 21191.2 21608.5 6857.2 6918.3 6976.9 7124.6 7384.1 3737.4 3755.8 3761.4 3833.5 3910.6 3016.6 3122.9 3133.0 3135.8 3136.0 483.9 493.7 501.4 508.7 509.3 520.0 540.2 570.4 585.4 585.5 7455.9 8086.2 8181.7 8376.0 8428.0 482.9 493.3 508.8 550.8 551.5 3807.8 3957.2 3996.1 4006.6 4117.9 53356.5 102609.0 103287.5 104561.5 104767.5 91759.5 93816.0 94396.0 94725.0 95057.0 80738.6 83994.0 85411.6 86260.4 86496.0 8266.4 8357.2 8358.4 8490.8 8501.2 39069.8 46787.3 48533.8 50238.7 50786.2 56100.7 60740.0 61272.0 61674.7 62066.7 11570.7 11675.5 11724.9 11736.7 11809.5 12453.4 12720.0 12773.6 12847.7 12868.6 11465.7 11898.3 11917.0 12365.9 12708.0 11633.5 12026.8 12090.7 12222.0 12304.1 11832.8 12100.7 12214.1 12242.6 12252.8 9106.5 9320.8 9356.3 10467.8 10743.0 9382.0 9429.0 9550.1 9682.0 9805.7 12:02:23 INFO - PROCESS | 21019 | -------- Summary: end -------- 12:02:23 INFO - PROCESS | 21019 | 12:02:24 INFO - TEST-INFO | 21019: exit 0 12:02:24 INFO - TEST-OK | dromaeo_css | took 1117193ms 12:02:24 INFO - TEST-START | kraken 12:02:24 INFO - operating with platform_type : linux_ 12:02:24 INFO - Initialising browser for kraken test... 12:02:24 INFO - TEST-INFO | started process 21264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3BzxSo/profile http://localhost:40195/getInfo.html) 12:02:29 INFO - PROCESS | 21264 | __metrics Screen width/height:1600/1200 12:02:29 INFO - PROCESS | 21264 | colorDepth:24 12:02:29 INFO - PROCESS | 21264 | Browser inner width/height: 1024/697 12:02:29 INFO - PROCESS | 21264 | __metrics 12:02:30 ERROR - PROCESS | 21264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:02:30 INFO - TEST-INFO | 21264: exit 0 12:02:30 INFO - Browser initialized. 12:02:30 INFO - Running cycle 1/1 for kraken test... 12:02:30 INFO - TEST-INFO | started process 21384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3BzxSo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:42 INFO - PROCESS | 21384 | RSS: Main: 168583168 12:02:42 INFO - PROCESS | 21384 | 12:02:45 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40195/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:46 INFO - PROCESS | 21384 | RSS: Main: 174260224 12:02:46 INFO - PROCESS | 21384 | 12:02:49 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40195/tests/kraken/driver.html?testName=audio-dft) 12:02:49 INFO - PROCESS | 21384 | RSS: Main: 174223360 12:02:49 INFO - PROCESS | 21384 | 12:02:52 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40195/tests/kraken/driver.html?testName=audio-fft) 12:02:53 INFO - PROCESS | 21384 | RSS: Main: 168501248 12:02:53 INFO - PROCESS | 21384 | 12:02:55 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40195/tests/kraken/driver.html?testName=audio-oscillator) 12:02:56 INFO - PROCESS | 21384 | RSS: Main: 169648128 12:02:56 INFO - PROCESS | 21384 | 12:02:58 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:59 INFO - PROCESS | 21384 | RSS: Main: 169295872 12:02:59 INFO - PROCESS | 21384 | 12:03:02 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40195/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:02 INFO - PROCESS | 21384 | RSS: Main: 169836544 12:03:02 INFO - PROCESS | 21384 | 12:03:06 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40195/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:07 INFO - PROCESS | 21384 | RSS: Main: 167264256 12:03:07 INFO - PROCESS | 21384 | 12:03:10 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40195/tests/kraken/driver.html?testName=json-parse-financial) 12:03:10 INFO - PROCESS | 21384 | RSS: Main: 168566784 12:03:10 INFO - PROCESS | 21384 | 12:03:12 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:13 INFO - PROCESS | 21384 | RSS: Main: 168628224 12:03:13 INFO - PROCESS | 21384 | 12:03:15 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:03:15 INFO - PROCESS | 21384 | RSS: Main: 169472000 12:03:15 INFO - PROCESS | 21384 | 12:03:17 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:03:18 INFO - PROCESS | 21384 | RSS: Main: 169553920 12:03:18 INFO - PROCESS | 21384 | 12:03:21 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:03:22 INFO - PROCESS | 21384 | RSS: Main: 170131456 12:03:22 INFO - PROCESS | 21384 | 12:03:24 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:03:25 INFO - PROCESS | 21384 | RSS: Main: 170160128 12:03:25 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | Cycle 1(1): loaded http://localhost:40195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40195/tests/kraken/driver.html?testName=ai-astar) 12:03:27 INFO - PROCESS | 21384 | RSS: Main: 170942464 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | __start_tp_report 12:03:27 INFO - PROCESS | 21384 | _x_x_mozilla_page_load 12:03:27 INFO - PROCESS | 21384 | _x_x_mozilla_page_load_details 12:03:27 INFO - PROCESS | 21384 | |i|pagename|runs| 12:03:27 INFO - PROCESS | 21384 | |0;ai-astar;107;115;108;115;114;114;118;114;115;115 12:03:27 INFO - PROCESS | 21384 | |1;audio-beat-detection;154;124;144;174;124;148;156;128;189;124 12:03:27 INFO - PROCESS | 21384 | |2;audio-dft;165;164;162;166;176;164;164;163;166;161 12:03:27 INFO - PROCESS | 21384 | |3;audio-fft;75;75;76;163;78;76;76;75;170;78 12:03:27 INFO - PROCESS | 21384 | |4;audio-oscillator;86;86;141;86;85;87;136;85;85;138 12:03:27 INFO - PROCESS | 21384 | |5;imaging-gaussian-blur;118;118;119;118;118;119;118;118;119;118 12:03:27 INFO - PROCESS | 21384 | |6;imaging-darkroom;148;147;149;148;148;148;147;148;148;149 12:03:27 INFO - PROCESS | 21384 | |7;imaging-desaturate;95;95;97;96;95;96;96;96;95;95 12:03:27 INFO - PROCESS | 21384 | |8;json-parse-financial;65;65;65;64;66;68;64;68;64;64 12:03:27 INFO - PROCESS | 21384 | |9;json-stringify-tinderbox;66;66;66;69;67;65;69;66;67;65 12:03:27 INFO - PROCESS | 21384 | |10;stanford-crypto-aes;86;80;81;82;79;80;80;80;81;83 12:03:27 INFO - PROCESS | 21384 | |11;stanford-crypto-ccm;158;136;131;138;139;131;139;134;179;134 12:03:27 INFO - PROCESS | 21384 | |12;stanford-crypto-pbkdf2;172;163;176;171;175;162;165;171;166;167 12:03:27 INFO - PROCESS | 21384 | |13;stanford-crypto-sha256-iterative;67;70;68;67;75;68;68;67;70;73 12:03:27 INFO - PROCESS | 21384 | __end_tp_report 12:03:27 INFO - PROCESS | 21384 | __start_cc_report 12:03:27 INFO - PROCESS | 21384 | _x_x_mozilla_cycle_collect,1000 12:03:27 INFO - PROCESS | 21384 | __end_cc_report 12:03:27 INFO - PROCESS | 21384 | __startTimestamp1468868607643__endTimestamp 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | ------- Summary: start ------- 12:03:27 INFO - PROCESS | 21384 | Number of tests: 14 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.37 (2.9%) stddev-sans-first:2.64 12:03:27 INFO - PROCESS | 21384 | Values: 107.0 115.0 108.0 115.0 114.0 114.0 118.0 114.0 115.0 115.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:151.00 stddev:22.55 (14.9%) stddev-sans-first:23.76 12:03:27 INFO - PROCESS | 21384 | Values: 154.0 124.0 144.0 174.0 124.0 148.0 156.0 128.0 189.0 124.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:4.15 (2.5%) stddev-sans-first:4.40 12:03:27 INFO - PROCESS | 21384 | Values: 165.0 164.0 162.0 166.0 176.0 164.0 164.0 163.0 166.0 161.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.16 (50.2%) stddev-sans-first:39.83 12:03:27 INFO - PROCESS | 21384 | Values: 75.0 75.0 76.0 163.0 78.0 76.0 76.0 75.0 170.0 78.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:85.50 stddev:25.45 (29.8%) stddev-sans-first:26.37 12:03:27 INFO - PROCESS | 21384 | Values: 86.0 86.0 141.0 86.0 85.0 87.0 136.0 85.0 85.0 138.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:03:27 INFO - PROCESS | 21384 | Values: 118.0 118.0 119.0 118.0 118.0 119.0 118.0 118.0 119.0 118.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:03:27 INFO - PROCESS | 21384 | Values: 148.0 147.0 149.0 148.0 148.0 148.0 147.0 148.0 148.0 149.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 12:03:27 INFO - PROCESS | 21384 | Values: 95.0 95.0 97.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.57 (2.4%) stddev-sans-first:1.66 12:03:27 INFO - PROCESS | 21384 | Values: 65.0 65.0 65.0 64.0 66.0 68.0 64.0 68.0 64.0 64.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.50 12:03:27 INFO - PROCESS | 21384 | Values: 66.0 66.0 66.0 69.0 67.0 65.0 69.0 66.0 67.0 65.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.04 (2.5%) stddev-sans-first:1.22 12:03:27 INFO - PROCESS | 21384 | Values: 86.0 80.0 81.0 82.0 79.0 80.0 80.0 80.0 81.0 83.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:138.50 stddev:15.15 (10.9%) stddev-sans-first:14.90 12:03:27 INFO - PROCESS | 21384 | Values: 158.0 136.0 131.0 138.0 139.0 131.0 139.0 134.0 179.0 134.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:171.00 stddev:4.89 (2.9%) stddev-sans-first:5.05 12:03:27 INFO - PROCESS | 21384 | Values: 172.0 163.0 176.0 171.0 175.0 162.0 165.0 171.0 166.0 167.0 12:03:27 INFO - PROCESS | 21384 | 12:03:27 INFO - PROCESS | 21384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.75 (4.0%) stddev-sans-first:2.79 12:03:27 INFO - PROCESS | 21384 | Values: 67.0 70.0 68.0 67.0 75.0 68.0 68.0 67.0 70.0 73.0 12:03:27 INFO - PROCESS | 21384 | -------- Summary: end -------- 12:03:27 INFO - PROCESS | 21384 | 12:03:28 INFO - TEST-INFO | 21384: exit 0 12:03:28 INFO - TEST-OK | kraken | took 64607ms 12:03:28 INFO - SUITE-END | took 1181s 12:03:28 INFO - Completed test suite (00:19:41) 12:03:28 INFO - javascript benchmark 12:03:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6569.478125860931, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.266885272123, 2642.6960899496553, 2643.841369517829, 2680.0217920459013, 2689.5831146172336, 4820.493848145947, 4890.193118135508, 4922.630802689795, 4938.0, 5001.724905130216, 4626.46795618504, 4806.975965120178, 4833.0, 4855.271709243615, 4895.9020819583675, 4383.561643835615, 4421.894526368408, 4542.568455996675, 4555.362249285103, 4556.6582506312, 207.82725615387187, 4441.111777644468, 4509.25597276449, 4535.750533720644, 4550.044490656949, 4450.710703804259, 4474.373587697725, 4484.8878778030485, 4491.0, 4527.683062185648, 4403.6256918162, 4488.349189367556, 4538.636909047268, 4545.659075569312, 4550.362949187116, 4383.145286669101, 4471.955280447187, 4478.910421791578, 4478.955210447886, 4522.118186953512, 4830.879228019293, 4843.055604157191, 4874.951250487521, 4896.143174944406, 4924.75376231187, 4987.501249875019, 5105.387353517564, 5131.281620573122, 5155.278261043457, 5191.9480805192225, 5208.947910520884, 5225.843224703265, 5231.843044708665, 5232.816851410221, 5273.630845840793, 4840.1287768201355, 4847.587955023827, 4850.029994001214, 4856.732879691651, 4905.730184839832, 5137.306463627438, 5293.285406470077, 5332.733363331818, 5336.0, 5357.196420536873, 5114.028334616485, 5140.1004824155625, 5155.200943853709, 5160.92258616121, 5169.4830516948, 5246.842594722164, 5250.7637156328055, 5253.054450198924, 5253.185756207794, 5297.311349524614, 4913.803447862117, 5079.08576456234, 5103.413107492612, 5134.589232861362, 5140.46025167352, 4901.950980490149, 4937.802487900515, 4937.802487900515, 5017.397912250481, 5023.070731914608, 4270.978645106755, 4282.764447955392, 4288.506821715543, 4330.501992270866, 4391.1217756448195, 3867.8839634811, 3873.0511024799102, 3873.748206366577, 3880.1269714314053, 3913.9021524462114, 4330.069035157457, 4416.33754936762, 4453.755043472575, 4493.550644935481, 4559.6124329431705, 5180.870478237999, 5243.23973023917, 5252.868678283074, 5261.289725886956, 5299.046171689056, 4464.218761716752, 4483.0, 4484.1031793641405, 4490.595846373777, 4522.615577675869, 4493.5281795411665, 4661.230896902041, 4696.577308042292, 4705.858824235278, 4748.4539277982785, 4946.727929963887, 4972.900541989067, 4980.551750342414, 4998.275250088789, 5009.474005229471, 5303.337082864642, 5314.97342513285, 5318.228856815817, 5320.148776195945, 5355.277037599874, 4762.76186190696, 4821.2045012572535, 4842.927356089591, 4885.560299573055, 4963.404391473046, 5036.672616280077, 5046.495350464924, 5050.444451110301, 5051.09080365523, 5118.846434606968, 5109.565686916654, 5140.871478213075, 5141.562967147835, 5164.018836421068, 5167.0, 4841.782119804688, 4922.261660750916, 4928.630352723631, 4964.975175124246, 4967.552920237196, 4946.35697359341, 4955.8017679292425, 4969.453360130455, 4993.950060499348, 5019.0, 4840.322354870392, 4895.4370247422, 4895.534924182197, 4913.115639184838, 4931.2849636803185, 4833.661643684908, 4983.900321993612, 5035.219540971156, 5054.469280725618, 5078.746062696924, 4949.257611358325, 5008.223725322581, 5031.169856973558, 5033.144365457954, 5099.388073431212], "value": 4721.229571773339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.4796838939785, 568.4684819693584, 574.8131857146426, 574.9281339832519, 606.1271768653137, 35944.820275898615, 40607.0, 40653.0, 40929.0, 41104.79447602758, 40428.38286468538, 40876.59123408765, 40879.0, 41045.38431923516, 41087.178256434854, 7718.228177182279, 7867.567283799389, 7883.881741773878, 7919.604019799016, 7922.128565857751, 7865.134835168127, 7897.6840926362875, 7903.36773058154, 7976.920230797676, 7987.400944929124, 8022.398320125984, 8057.0, 8060.314873235782, 8060.355171586289, 8075.434719569633, 7922.36621070313, 7997.320227780617, 8020.077691065486, 8023.67905283788, 8039.31665808407, 7761.805954851117, 7821.178776228528, 7852.960735196288, 7863.213678632148, 7881.921180788176, 39129.0, 39636.80181599102, 39758.20483590312, 39879.60120398788, 39969.60030399688, 3001.5797788309656, 3041.847907604633, 3109.751219902402, 3137.30979184579, 3184.347208822186, 29891.701082989108, 30207.697923020707, 30287.091387258417, 30686.203509885974, 30776.230594235098, 3290.7696461247724, 3315.270320889, 3363.5795525559306, 3373.8987830365127, 3414.3171365726953, 263231.9999999981, 265957.0, 265980.0, 267443.0, 267801.0, 54994.450055498935, 55472.72263638656, 55608.0, 55634.0, 55720.44279557234, 33432.49851252233, 34161.658383415845, 34269.14327141792, 36313.45529817055, 59647.701761491786, 13825.723485530232, 13955.162690238618, 13970.860291396955, 13977.58067257984, 14031.78952315716, 11671.066314694805, 11768.35274059935, 11831.585894493823, 11846.585369512026, 11847.466863991142, 18905.338313158973, 18967.525811854815, 18970.300791345555, 19058.714119288223, 19063.809361906482, 6825.631595778706, 6854.554453960576, 7033.753818616324, 7157.534760240567, 7246.96376518114, 772.119783446871, 853.7182729699184, 859.3984211052164, 901.3104974694364, 961.5721004153085, 27990.0, 29092.418151637274, 29197.0, 29432.852835735684, 29627.111186664435, 883.1742320929951, 922.7877588154762, 950.6595700062878, 955.498363359228, 981.259149342242, 14871.0, 15057.02129361588, 15154.393824246907, 15445.150516721464, 15548.689026219412, 381222.0, 382835.0, 383843.0, 387741.0, 389673.0, 51653.741731291106, 52049.21926171111, 52135.47864521382, 52272.738636306574, 52648.0, 1152.8386025956372, 1190.1014733875868, 1205.445495072259, 1220.877912208772, 1225.6445630767157, 26575.60136597914, 27782.305442364104, 27814.721852781215, 28252.0, 28684.282892927844, 41675.37486937759, 41752.791236043624, 41950.37074443947, 42128.0, 42182.78908605437, 328872.0, 329717.0, 330791.0, 331237.0, 331477.0, 25479.617805733298, 25699.229023128588, 26060.34849128787, 26426.603600946386, 26450.338741531617, 43031.7848410756, 43758.34362484629, 43794.0, 44320.335194972744, 44450.55549444464, 38017.61982380141, 38163.0, 38367.623334462216, 38374.23251534898, 38455.0, 37771.62228377791, 37772.0, 38524.80737596294, 38613.4207986886, 38889.0, 31136.22159446032, 36010.63989360073, 36358.8182059088, 37201.44197837089, 37602.435963460026, 32377.51433728543, 34035.0, 34561.65438345685, 34719.82640086783, 34864.779732709234, 26208.0, 26221.34446638849, 26502.469950600494, 26728.0, 26770.732292676825], "value": 17708.6999666811, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5682879445448, 375.08292225508626, 375.9116607597214, 382.8200745649544, 388.6560394051267, 16344.427945021927, 17663.205155767988, 18177.63644727105, 18221.0, 18256.908715456437, 17002.659946801086, 17225.554889022183, 17571.385001524948, 17653.20560574774, 17713.0, 5074.771635276412, 5216.973915130438, 5225.425203227642, 5242.082635538765, 5256.237845512398, 3651.1054791576103, 4141.378793181032, 5170.715610641432, 6147.077938309267, 6274.341194174614, 6173.166622505972, 6183.505319574423, 6205.844853878667, 6209.596376235553, 6216.409441103088, 6038.0641000644755, 6085.056816193497, 6085.391460853902, 6093.817185484399, 6105.603135796181, 5138.3833939927445, 5267.104592219332, 5308.097623404031, 5331.226972089025, 5331.386890507563, 20632.27787027447, 21234.256801012045, 21455.892720536296, 21516.139354425803, 21720.674189887166, 1906.323255244396, 1935.1485346447519, 1951.0634895250219, 1972.743543339371, 2063.9174433022813, 13183.538576149884, 13349.33253337339, 13460.586638402925, 13597.456101755917, 13862.4455021799, 1728.9654206915918, 1737.6090379664602, 1766.1787268919886, 1803.1705415508882, 1805.9909700451544, 64463.0, 66810.0, 68451.65774171097, 69008.30991690069, 69291.307086929, 9302.0, 9447.811043779086, 9491.240700743923, 9623.663171788954, 9872.0, 13314.93342533281, 13342.466301347837, 13356.599302020955, 13394.799078013837, 13456.529021484397, 7129.643517824088, 7399.223081576357, 7480.251974802476, 7509.774706758806, 7563.773086807405, 7246.347828695337, 7267.0552828132, 7323.816904577428, 7379.483436159418, 7389.5196812208105, 5999.340072592011, 6066.908996365058, 6181.690915454299, 6192.845178870564, 6254.593451425642, 1699.192883380409, 1756.5257380507192, 1766.5760217547695, 1771.2029586686042, 1785.3572713823014, 830.2278880641062, 837.342685991506, 853.3471894001094, 860.1636700316658, 869.4565896314804, 17729.822701773075, 17890.731639025424, 18061.09694515269, 18129.0, 18612.0, 864.9264812491009, 891.0688330694439, 891.5096696816724, 911.0161026091805, 927.4388994658269, 9404.0, 10367.0, 10373.481325933673, 10415.218858585637, 10419.114375278186, 363207.0, 364066.0, 364448.0, 364786.0, 391452.0, 68166.31833681698, 72121.0, 73200.2679973204, 73714.0, 74292.25707742853, 918.2011649864661, 927.5408672707053, 931.064280398209, 952.1953948913157, 958.2334132693817, 15150.16674082936, 15631.531054068397, 15841.603959901095, 15863.603409914844, 15995.680086397973, 35373.29253414969, 35704.0, 35798.8210058948, 35894.82052589825, 36949.0, 46776.532234678576, 48059.519404805505, 48665.0, 48792.0, 48816.11838816232, 7802.6488808004915, 7833.804154896173, 7860.4104692147175, 7923.484973476706, 8005.959970200344, 11859.110566707359, 12115.515379384726, 12343.629691109281, 12376.257424554555, 12833.614991550268, 10195.082442580204, 10420.583176673152, 10800.135989120694, 10806.891931080903, 10999.835002475129, 9721.416714997124, 10444.060034596923, 10454.477276136315, 10581.947090264499, 10700.732481688021, 10299.691009269734, 10723.785524289626, 10923.180761443082, 10942.343459392461, 11142.164337674545, 7364.41084713211, 7684.46208765381, 7766.068071831416, 7816.84366312682, 7942.205779422012, 10325.32885362449, 10473.109785668303, 10533.157347412342, 10798.946005270238, 10828.350298981772], "value": 8496.361876075716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.3142694366284, 1413.3216056292981, 1509.4716849102815, 1702.0723705580474, 1717.7595136680866, 6830.556013859108, 7377.8155546111375, 7574.204708505604, 8124.390670699699, 8126.878096828545, 7714.34428073613, 7931.801704957379, 8002.639881205345, 8004.759857204279, 8006.479578827372, 2168.793964573371, 2223.455253462904, 2224.5773303072447, 2224.92212772553, 2227.599032174208, 2181.1384503121258, 2193.1008286602496, 2207.933761987143, 2232.408411770882, 2233.4081468410886, 2174.4563859035243, 2175.7280339957506, 2180.4330873972804, 2181.225664888965, 2200.1749343996003, 2108.6309895768254, 2116.322776711453, 2123.883186424746, 2127.680847872816, 2138.9358319250446, 2092.0794850265834, 2109.630814607453, 2123.861948973312, 2133.541288622938, 2138.7433507978985, 7925.048994120685, 7989.400794940345, 8058.315043221333, 8067.031956165239, 8075.596220188967, 4611.146937816515, 4725.456572494173, 4727.881802954919, 4732.0, 4740.525947405266, 2741.7258274172623, 2788.7768978481877, 2840.5171120909495, 2876.0652787844033, 2913.766898648103, 884.120300301198, 892.6741739265186, 901.3059943843269, 903.4579252448544, 911.1708345405649, 10658.253922225447, 10681.41252231127, 10702.839457408145, 10723.195760317929, 10754.892451075468, 4104.445899803548, 4260.275753121977, 4297.656187504992, 4342.5874541918465, 4368.344748287719, 9127.08729127082, 9154.176124148858, 9156.496392698333, 9160.404573702688, 9176.44941303524, 4626.4910859805395, 4626.884327891762, 4631.861044168681, 4651.720896746206, 4671.649626278043, 3742.7754334740002, 4214.810333534998, 4219.957800421957, 4264.701470897007, 4416.072624748838, 3542.3977923753023, 3675.8162091895297, 3685.262947410529, 3733.775973441602, 3880.825362858678, 1187.4122309456875, 1195.2847663602759, 1198.149313987079, 1209.4194786502528, 1216.7566486702517, 819.9463689159521, 824.3487644760692, 875.7898104454885, 897.555709923579, 921.4333185091255, 5289.497497737709, 5405.4324295949145, 5532.502074813206, 5629.718514074362, 5679.148127780866, 898.1198425543005, 915.6657819895823, 916.3951791817502, 922.2253307221831, 939.5349302095507, 3976.5029371328583, 4141.254574176677, 4145.875623731293, 4164.5210800757695, 4184.372344148402, 9593.952030239805, 9647.179989700813, 9725.805483890283, 9739.56171972263, 9764.267679924034, 9530.666426675032, 9555.378900371454, 9618.711438656852, 9648.614055437843, 9659.90340096604, 6994.370506654425, 7259.310365515267, 7288.416926645856, 7335.853282934311, 7335.926640733524, 5597.944020559742, 5721.370649228498, 5862.530997520103, 5877.853053673693, 5919.378465261086, 8624.353173512138, 8990.460572365679, 9026.774330641787, 9206.17144457002, 9244.399114057835, 8893.421927574687, 9251.861222081809, 9256.24131415029, 9378.95310523443, 9402.0, 6179.536534759821, 6666.500012498985, 6850.862982740217, 6878.209005964178, 6962.060121883481, 7598.392128629807, 7688.192739762245, 7712.5758083305955, 7751.6511756972195, 7760.379169666526, 6811.863762724619, 7011.894821577578, 7034.050403195503, 7071.328223818729, 7136.785896422908, 6739.887918493394, 6771.356721111487, 6846.246912839683, 6884.65576721152, 7018.894716579358, 6315.431611154834, 6374.904376434264, 6380.585261957958, 6459.6770161490795, 6474.805755827333, 4691.390119284471, 4726.338312636165, 4761.500042495627, 4768.094062128184, 4796.9760151199025, 4816.735079570657, 4844.370231869834, 4864.489228630943, 4963.677360971526, 4995.975020124876], "value": 4225.228178421833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8440353218093, 305.3374178033667, 309.5125177844893, 312.99687003129975, 315.451115059796, 4978.875528111799, 4997.9500204997985, 5068.1637529807585, 5078.898422031557, 5091.770870310836, 4983.277424773406, 5024.271480635306, 5032.572231360339, 5074.873128171797, 5086.855457522056, 3746.5316835395574, 3845.0, 3952.2095580883793, 3963.702722295825, 3963.8612648557305, 3938.1926705025403, 3943.5464921534103, 3953.4267531207956, 3971.404289356605, 3972.483577134983, 3931.312020396419, 3944.901377465572, 3945.782981935992, 3952.1305312831273, 3959.366501359783, 3756.5679946806194, 3896.883093507199, 3935.6457918787446, 3950.4666869972475, 3956.2987915196454, 3404.131946353664, 3412.1128506588216, 3413.300273443938, 3413.6586341365914, 3423.442333738168, 4933.703977761345, 4945.579625731817, 4951.925721114186, 4954.9009019819405, 4983.950160498385, 4374.4531933508315, 4466.53101424349, 4470.307102399133, 4484.5291244419195, 4491.505934347252, 5231.712255825928, 5240.2401651760665, 5245.606579506552, 5251.212318152269, 5259.316288882421, 3749.250149970017, 3751.8686845960533, 3774.8678796242275, 3780.4140358244517, 3785.6403641653997, 5404.297441332641, 5517.172424136372, 5533.142362933751, 5546.140348246028, 5553.8333849984565, 3886.5724770275247, 3887.5918028607157, 3901.8439262429183, 3907.238088572701, 3914.805984174854, 3956.823746939172, 3962.9405558916637, 3965.4844870166694, 3966.4446977423186, 3988.4615576897327, 4491.079328737601, 4507.797149128297, 4514.706544074625, 4515.774211289422, 4529.411176547028, 5134.871628209325, 5188.169892817206, 5239.345081864767, 5245.239440281138, 5305.787768489295, 1355.302019459979, 1369.9519867301522, 1373.0800363756107, 1374.9450021999207, 1382.3295701584723, 838.5639467477, 861.573521107056, 867.1891781184613, 878.5870640798814, 878.6309749905055, 4498.595126438636, 4621.653375996813, 4630.675852690347, 4641.164590373765, 4669.463011753692, 5418.810341638024, 5444.183372494078, 5459.153831156177, 5483.314585676791, 5491.615586908878, 4436.556344365602, 4581.977090114528, 4607.170709272296, 4610.449953535759, 4650.883727906829, 2892.5950366948646, 2905.418916216765, 2906.3896581717654, 2922.8246305221755, 2933.750631196372, 5178.352705911761, 5186.559142472856, 5194.4026436959475, 5218.504242096995, 5221.634485586049, 5481.369642491085, 5581.609287349846, 5598.300212473441, 5630.5214056805635, 5658.971705141448, 5053.8881446081805, 5094.2613321068975, 5098.872528186825, 5108.259302401131, 5122.436531981479, 5395.92081583677, 5419.783208671766, 5432.2123292123215, 5466.699331536804, 5470.72646367688, 5116.667416617908, 5334.3865455473115, 5341.0, 5350.652207606493, 5381.5694744421135, 5146.841960558844, 5176.2494438306985, 5177.404598471224, 5187.403448603459, 5198.948010519846, 3939.4878665773267, 3952.308346039374, 3955.3473676843, 3958.9208215836097, 3959.7030222732833, 5171.63798534099, 5459.672419654833, 5518.413031529538, 5532.114861622121, 5534.446555344594, 5340.145576707708, 5355.571554275571, 5370.650907690988, 5398.379186393615, 5423.3491980962535, 5168.638195326442, 5353.812616558402, 5358.32083958021, 5389.167682987803, 5406.4052954175795, 5219.321488206509, 5259.894802104013, 5273.78904843802, 5281.656692314988, 5312.5484333832055, 5062.367204099488, 5194.065068287745, 5320.388155362183, 5333.919991200058, 5367.550761294507, 5213.218017297436, 5217.686938783533, 5219.19102539107, 5220.347456567929, 5232.4505926878655], "value": 3992.1205354888807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6561995780066, 664.4319107163373, 687.9208890977533, 691.7959202035399, 714.8606021825743, 12650.987920966323, 12772.872271277285, 13209.669758256025, 13776.173429594219, 13845.030847840655, 13008.219506829597, 13057.151285166457, 13185.538506152287, 13187.076904616657, 13188.142770719896, 623.597779432266, 763.4655740981322, 769.7459838253363, 782.1787123520281, 783.4946459533597, 791.066541481055, 793.4961299574754, 793.8809178623195, 796.2594786848229, 797.2386371015666, 834.1950018232404, 834.2950207075012, 835.7367429259795, 837.8240569480416, 838.4005436113177, 827.8799574061787, 830.024720952881, 830.1698301698302, 830.3523251863526, 831.1771346367113, 604.087827380654, 605.0410099991519, 605.1407002057045, 605.1437216338875, 605.4883623338272, 13901.58295251144, 13945.372458239404, 13979.440822367194, 14019.369128389248, 14119.505817296345, 13973.161610303414, 14147.29263536819, 14159.858401415957, 14219.50231741884, 14251.216183109926, 10516.263861529696, 10689.518971646294, 10700.0, 10706.41114738689, 10720.0, 3282.7045565898943, 3340.064781861083, 3348.280119774236, 3356.2616224430585, 3357.2278375973665, 68707.65646171737, 69364.0, 69600.65199673969, 70737.64631176862, 71726.64136679283, 10817.513211905325, 10841.566337346418, 10904.454777261106, 10991.725206869893, 11089.39008354532, 21020.47448813792, 21024.26415075465, 21040.894795525925, 21191.152353905672, 21608.459788505414, 6857.177138743383, 6918.273581273894, 6976.860462790817, 7124.643767811589, 7384.076990376203, 3737.4020156774786, 3755.75587586806, 3761.4169803680475, 3833.5208098987628, 3910.550286717064, 3016.592759977419, 3122.921926951799, 3132.9530057049164, 3135.7804953653026, 3135.984320078385, 483.9346688197119, 493.71117896030506, 501.38830626635445, 508.707493191409, 509.3226009407479, 519.9610029247822, 540.2139886465184, 570.4096260370579, 585.4350551717613, 585.5169485174748, 7455.925440745632, 8086.150954149847, 8181.713640022571, 8376.0, 8428.0, 482.92031814750874, 493.3192194771193, 508.8269988204028, 550.8319962411503, 551.5174222555264, 3807.7715337079862, 3957.2283404736377, 3996.1008773025837, 4006.579309172495, 4117.876463706094, 53356.46643533515, 102609.0, 103287.4835625832, 104561.47719261507, 104767.4761626187, 91759.54120229356, 93816.0, 94396.0, 94725.0, 95057.0, 80738.59630701809, 83994.0, 85411.57294213613, 86260.41218763447, 86496.0, 8266.380021498291, 8357.206065423776, 8358.373122015995, 8490.787730306793, 8501.19238672325, 39069.80465097656, 46787.29819052649, 48533.75733121312, 50238.748806257194, 50786.238206427675, 56100.71949640226, 60740.0, 61272.0, 61674.69162654158, 62066.68966655138, 11570.652880413601, 11675.474603643026, 11724.941375293069, 11736.706582335168, 11809.468573914366, 12453.377331133226, 12719.98240140805, 12773.552925647558, 12847.678808029874, 12868.613941581767, 11465.713357166138, 11898.286102833858, 11917.0, 12365.938170309091, 12708.0, 11633.53465861356, 12026.75946481083, 12090.697732556757, 12222.0, 12304.077194210291, 11832.76334473323, 12100.697482563006, 12214.14500984958, 12242.571509997108, 12252.754944900873, 9106.453612783254, 9320.813583728423, 9356.251499879858, 10467.790644187226, 10743.0, 9382.0, 9429.0, 9550.140487356171, 9681.951590242004, 9805.656802011896], "value": 6708.251432313688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 108.0, 115.0, 114.0, 114.0, 118.0, 114.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 144.0, 174.0, 124.0, 148.0, 156.0, 128.0, 189.0, 124.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 166.0, 176.0, 164.0, 164.0, 163.0, 166.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 163.0, 78.0, 76.0, 76.0, 75.0, 170.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 141.0, 86.0, 85.0, 87.0, 136.0, 85.0, 85.0, 138.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 68.0, 64.0, 68.0, 64.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 69.0, 67.0, 65.0, 69.0, 66.0, 67.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 81.0, 82.0, 79.0, 80.0, 80.0, 80.0, 81.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 136.0, 131.0, 138.0, 139.0, 131.0, 139.0, 134.0, 179.0, 134.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 163.0, 176.0, 171.0, 175.0, 162.0, 165.0, 171.0, 166.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 67.0, 75.0, 68.0, 68.0, 67.0, 70.0, 73.0], "value": 69.3, "unit": "score"}]}]} 12:03:28 INFO - Return code: 0 12:03:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:03:28 ERROR - # TBPL SUCCESS # 12:03:28 INFO - Running post-action listener: _resource_record_post_action 12:03:28 INFO - ##### 12:03:28 INFO - ##### Finished run-tests step (success) 12:03:28 INFO - ##### 12:03:28 INFO - Running post-run listener: _resource_record_post_run 12:03:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552378368; Read time: 8; Write time: 971052 12:03:29 INFO - TinderboxPrint: CPU usage
13.4% 12:03:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:03:29 INFO - TinderboxPrint: I/O write bytes / time
552,378,368 / 971,052 12:03:29 INFO - TinderboxPrint: CPU idle
8,287.4 (86.6%) 12:03:29 INFO - TinderboxPrint: CPU user
1,219.2 (12.7%) 12:03:29 INFO - TinderboxPrint: Swap in / out
0 / 0 12:03:29 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 247357440; Read time: 0; Write time: 613884 12:03:29 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301121536; Read time: 8; Write time: 356432 12:03:29 INFO - Running post-run listener: _upload_blobber_files 12:03:29 INFO - Blob upload gear active. 12:03:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:03:29 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 12:03:29 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'] 12:03:29 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 12:03:29 INFO - (blobuploader) - INFO - Open directory for files ... 12:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:39 INFO - (blobuploader) - INFO - Done attempting. 12:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:40 INFO - (blobuploader) - INFO - Done attempting. 12:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:41 INFO - (blobuploader) - INFO - Done attempting. 12:03:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:03:41 INFO - Return code: 0 12:03:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:03:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:03:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b09a76bcea48ff47ddda0b2fdf56d9600e40c3e70bc6be30894cd21c1b1bff1578bff8e3b2ddd8a77b3db0b19f4805c5c4a87bc317639821f45ef46b12eee127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/007c4162a04ad3d5344b6386e3325a3c8af2e560d0818188460c0c6522be64f216fc959f721814b8357a605c4ed5c7623918b9aae76a7845f0d6d63b22847438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75f90361b1f5fe505f7307daf812fe9fc55e62d65e60d3d5e0a8cc4c46b4d755a3e80a0da47c4be8cf69a50a3d0aa230a46555dbf85be166f1a9f2cb29644c03"} 12:03:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:03:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:03:41 INFO - Contents: 12:03:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b09a76bcea48ff47ddda0b2fdf56d9600e40c3e70bc6be30894cd21c1b1bff1578bff8e3b2ddd8a77b3db0b19f4805c5c4a87bc317639821f45ef46b12eee127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/007c4162a04ad3d5344b6386e3325a3c8af2e560d0818188460c0c6522be64f216fc959f721814b8357a605c4ed5c7623918b9aae76a7845f0d6d63b22847438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75f90361b1f5fe505f7307daf812fe9fc55e62d65e60d3d5e0a8cc4c46b4d755a3e80a0da47c4be8cf69a50a3d0aa230a46555dbf85be166f1a9f2cb29644c03"} 12:03:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:03:41 INFO - Copying logs to upload dir... 12:03:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:03:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.736313 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 12:03:41.347354) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 12:03:41.351019) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b09a76bcea48ff47ddda0b2fdf56d9600e40c3e70bc6be30894cd21c1b1bff1578bff8e3b2ddd8a77b3db0b19f4805c5c4a87bc317639821f45ef46b12eee127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/007c4162a04ad3d5344b6386e3325a3c8af2e560d0818188460c0c6522be64f216fc959f721814b8357a605c4ed5c7623918b9aae76a7845f0d6d63b22847438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75f90361b1f5fe505f7307daf812fe9fc55e62d65e60d3d5e0a8cc4c46b4d755a3e80a0da47c4be8cf69a50a3d0aa230a46555dbf85be166f1a9f2cb29644c03"} build_url:https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/GHdAk7AZSJ6aV6BEzWwcbg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b09a76bcea48ff47ddda0b2fdf56d9600e40c3e70bc6be30894cd21c1b1bff1578bff8e3b2ddd8a77b3db0b19f4805c5c4a87bc317639821f45ef46b12eee127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/007c4162a04ad3d5344b6386e3325a3c8af2e560d0818188460c0c6522be64f216fc959f721814b8357a605c4ed5c7623918b9aae76a7845f0d6d63b22847438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75f90361b1f5fe505f7307daf812fe9fc55e62d65e60d3d5e0a8cc4c46b4d755a3e80a0da47c4be8cf69a50a3d0aa230a46555dbf85be166f1a9f2cb29644c03"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 12:03:41.376934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:03:41.377260) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1468867374.377298-1479573686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:03:41.460213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 12:03:41.460530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 12:03:41.460815) ========= ========= Total master_lag: 0.18 =========