builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1469047378.8 results: success (0) buildid: 20160720122219 builduid: 87ec2ddfd7dc4f54a10c6441737b3f1e revision: b89f326ea06438d137b0baa91e124bac07e67b0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.799411) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.800004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.800357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.816125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.816429) ========= 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=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 13:42:58-- 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% 228M=0s 2016-07-20 13:42:58 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.952305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:58.952718) ========= 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=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020770 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.003595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.004047) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b89f326ea06438d137b0baa91e124bac07e67b0c --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 b89f326ea06438d137b0baa91e124bac07e67b0c --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=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 13:42:59,069 truncating revision to first 12 chars 2016-07-20 13:42:59,069 Setting DEBUG logging. 2016-07-20 13:42:59,069 attempt 1/10 2016-07-20 13:42:59,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b89f326ea064?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 13:42:59,386 unpacking tar archive at: autoland-b89f326ea064/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.671140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.671512) ========= script_repo_revision: b89f326ea06438d137b0baa91e124bac07e67b0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.671984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.672295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:42:59.682390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-20 13:42:59.682842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:42:59 INFO - MultiFileLogger online at 20160720 13:42:59 in /builds/slave/test 13:42:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:42:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:42:59 INFO - {'append_to_log': False, 13:42:59 INFO - 'base_work_dir': '/builds/slave/test', 13:42:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:42:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:42:59 INFO - 'branch': 'Autoland-Non-PGO', 13:42:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:42:59 INFO - 'config_files': ('talos/linux_config.py',), 13:42:59 INFO - 'default_actions': ('clobber', 13:42:59 INFO - 'read-buildbot-config', 13:42:59 INFO - 'download-and-extract', 13:42:59 INFO - 'populate-webroot', 13:42:59 INFO - 'create-virtualenv', 13:42:59 INFO - 'install', 13:42:59 INFO - 'run-tests'), 13:42:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:42:59 INFO - 'download_minidump_stackwalk': True, 13:42:59 INFO - 'download_symbols': 'ondemand', 13:42:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:42:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:42:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:42:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:42:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:42:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:42:59 INFO - 'installer_path': 'installer.exe', 13:42:59 INFO - 'log_level': 'info', 13:42:59 INFO - 'log_name': 'talos', 13:42:59 INFO - 'log_to_console': True, 13:42:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:42:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:42:59 INFO - 'opt_config_files': (), 13:42:59 INFO - 'pip_index': False, 13:42:59 INFO - 'sps_profile': False, 13:42:59 INFO - 'sps_profile_interval': 0, 13:42:59 INFO - 'suite': 'dromaeojs', 13:42:59 INFO - 'system_bits': '32', 13:42:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:42:59 INFO - 'title': 'talos-linux64-ix-065', 13:42:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:42:59 INFO - 'use_talos_json': True, 13:42:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:42:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:42:59 INFO - 'work_dir': 'build'} 13:42:59 INFO - [mozharness: 2016-07-20 20:42:59.839573Z] Running clobber step. 13:42:59 INFO - Running pre-action listener: _resource_record_pre_action 13:42:59 INFO - Running main action method: clobber 13:42:59 INFO - rmtree: /builds/slave/test/build 13:42:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:00 INFO - Running post-action listener: _resource_record_post_action 13:43:00 INFO - [mozharness: 2016-07-20 20:43:00.296624Z] Finished clobber step (success) 13:43:00 INFO - [mozharness: 2016-07-20 20:43:00.296725Z] Running read-buildbot-config step. 13:43:00 INFO - Running pre-action listener: _resource_record_pre_action 13:43:00 INFO - Running main action method: read_buildbot_config 13:43:00 INFO - Using buildbot properties: 13:43:00 INFO - { 13:43:00 INFO - "project": "", 13:43:00 INFO - "product": "firefox", 13:43:00 INFO - "script_repo_revision": "production", 13:43:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:43:00 INFO - "repository": "", 13:43:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:43:00 INFO - "buildid": "20160720122219", 13:43:00 INFO - "pgo_build": "False", 13:43:00 INFO - "basedir": "/builds/slave/test", 13:43:00 INFO - "buildnumber": 191, 13:43:00 INFO - "slavename": "talos-linux64-ix-065", 13:43:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:43:00 INFO - "platform": "ubuntu64_hw", 13:43:00 INFO - "scheduler": "tests-autoland-linux64-talos", 13:43:00 INFO - "branch": "autoland", 13:43:00 INFO - "repo_path": "integration/autoland", 13:43:00 INFO - "revision": "b89f326ea06438d137b0baa91e124bac07e67b0c", 13:43:00 INFO - "stage_platform": "linux64", 13:43:00 INFO - "builduid": "87ec2ddfd7dc4f54a10c6441737b3f1e", 13:43:00 INFO - "slavebuilddir": "test" 13:43:00 INFO - } 13:43:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:43:00 INFO - Running post-action listener: _resource_record_post_action 13:43:00 INFO - [mozharness: 2016-07-20 20:43:00.299181Z] Finished read-buildbot-config step (success) 13:43:00 INFO - [mozharness: 2016-07-20 20:43:00.299268Z] Running download-and-extract step. 13:43:00 INFO - Running pre-action listener: _resource_record_pre_action 13:43:00 INFO - Running main action method: download_and_extract 13:43:00 INFO - mkdir: /builds/slave/test/build/tests 13: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')]} 13:43:00 INFO - https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:01 INFO - Downloaded 1361 bytes. 13:43:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:43:01 INFO - Using the following test package requirements: 13:43:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:43:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'jsshell-linux-x86_64.zip'], 13:43:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:01 INFO - https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:02 INFO - Downloaded 22730093 bytes. 13:43:02 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'] 13:43:02 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 13:43:03 INFO - Return code: 0 13:43:03 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 13: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')]} 13:43:03 INFO - https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:04 INFO - Downloaded 22730093 bytes. 13:43:04 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'] 13:43:04 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 13:43:06 INFO - Return code: 0 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:06 INFO - https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:07 INFO - Downloaded 14403317 bytes. 13:43:07 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'] 13:43:07 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 13:43:07 INFO - Return code: 0 13:43:07 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')]} 13:43:07 INFO - https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:43:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:43:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McdPEUGVRsWe4m_m4grTXg/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 13:43:09 INFO - Downloaded 57143736 bytes. 13:43:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:43:09 INFO - mkdir: /builds/slave/test/properties 13:43:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:09 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:09 INFO - Contents: 13:43:09 INFO - build_url:https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:43:10 INFO - Running post-action listener: _resource_record_post_action 13:43:10 INFO - Running post-action listener: set_extra_try_arguments 13:43:10 INFO - [mozharness: 2016-07-20 20:43:10.133020Z] Finished download-and-extract step (success) 13:43:10 INFO - [mozharness: 2016-07-20 20:43:10.133260Z] Running populate-webroot step. 13:43:10 INFO - Running pre-action listener: _resource_record_pre_action 13:43:10 INFO - Running main action method: populate_webroot 13:43:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:10 INFO - '--tppagecycles', 13:43:10 INFO - '7'], 13:43:10 INFO - 'tests': ['tsvgm']}}, 13:43:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:43:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:43:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:43:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['damp', 'tps']}, 13:43:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'tests': ['damp', 'tps']}, 13:43:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['dromaeo_dom']}, 13:43:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['basic_compositor_video']}, 13:43:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:43:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'other-e10s': {'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['a11yr', 13:43:10 INFO - 'ts_paint', 13:43:10 INFO - 'tpaint', 13:43:10 INFO - 'sessionrestore', 13:43:10 INFO - 'sessionrestore_no_auto_restore', 13:43:10 INFO - 'tabpaint']}, 13:43:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['tsvgx', 13:43:10 INFO - 'tsvgr_opacity', 13:43:10 INFO - 'tart', 13:43:10 INFO - 'tscrollx', 13:43:10 INFO - 'cart']}, 13:43:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:43:10 INFO - 'tsvgr_opacity', 13:43:10 INFO - 'tart', 13:43:10 INFO - 'tscrollx', 13:43:10 INFO - 'cart']}, 13:43:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'talos_options': ['--disable-e10s'], 13:43:10 INFO - 'tests': ['tp5o']}, 13:43:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'tests': ['tp5o']}, 13:43:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'talos_options': ['--disable-e10s', 13:43:10 INFO - '--xperf_path', 13:43:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:10 INFO - 'tests': ['tp5n']}, 13:43:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:10 INFO - 'talos_options': ['--xperf_path', 13:43:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:10 INFO - 'tests': ['tp5n']}}, 13:43:10 INFO - 'talos.zip': {'path': '', 13:43:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:10 INFO - Running post-action listener: _resource_record_post_action 13:43:10 INFO - [mozharness: 2016-07-20 20:43:10.154770Z] Finished populate-webroot step (success) 13:43:10 INFO - [mozharness: 2016-07-20 20:43:10.154860Z] Running create-virtualenv step. 13:43:10 INFO - Running pre-action listener: _resource_record_pre_action 13:43:10 INFO - Running main action method: create_virtualenv 13:43:10 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:10 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 13:43:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:10 INFO - Using real prefix '/usr' 13:43:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:12 INFO - Installing pip.................done. 13:43:12 INFO - Return code: 0 13:43:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:43:12 INFO - Using env: {'DISPLAY': ':0', 13:43:12 INFO - 'HOME': '/home/cltbld', 13:43:12 INFO - 'LANG': 'en_US.UTF-8', 13:43:12 INFO - 'LANGUAGE': 'en_US:en', 13:43:12 INFO - 'LOGNAME': 'cltbld', 13:43:12 INFO - 'MAIL': '/var/mail/cltbld', 13:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:12 INFO - 'MOZ_NO_REMOTE': '1', 13:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:12 INFO - 'NO_EM_RESTART': '1', 13:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:12 INFO - 'PWD': '/builds/slave/test', 13:43:12 INFO - 'SHELL': '/bin/bash', 13:43:12 INFO - 'SHLVL': '1', 13:43:12 INFO - 'TERM': 'linux', 13:43:12 INFO - 'TMOUT': '86400', 13:43:12 INFO - 'USER': 'cltbld', 13:43:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:12 INFO - '_': '/tools/buildbot/bin/python'} 13:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:43:12 INFO - Cleaning up... 13:43:12 INFO - Return code: 0 13:43:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:43:12 INFO - Using env: {'DISPLAY': ':0', 13:43:12 INFO - 'HOME': '/home/cltbld', 13:43:12 INFO - 'LANG': 'en_US.UTF-8', 13:43:12 INFO - 'LANGUAGE': 'en_US:en', 13:43:12 INFO - 'LOGNAME': 'cltbld', 13:43:12 INFO - 'MAIL': '/var/mail/cltbld', 13:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:12 INFO - 'MOZ_NO_REMOTE': '1', 13:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:12 INFO - 'NO_EM_RESTART': '1', 13:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:12 INFO - 'PWD': '/builds/slave/test', 13:43:12 INFO - 'SHELL': '/bin/bash', 13:43:12 INFO - 'SHLVL': '1', 13:43:12 INFO - 'TERM': 'linux', 13:43:12 INFO - 'TMOUT': '86400', 13:43:12 INFO - 'USER': 'cltbld', 13:43:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:12 INFO - '_': '/tools/buildbot/bin/python'} 13:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:13 INFO - Downloading/unpacking psutil>=3.1.1 13: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 13: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 13: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 13: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 13: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 13: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 13:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:15 INFO - Installing collected packages: psutil 13:43:15 INFO - Running setup.py install for psutil 13:43:15 INFO - building 'psutil._psutil_linux' extension 13:43:15 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 13:43:16 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 13:43:16 INFO - building 'psutil._psutil_posix' extension 13:43:16 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 13:43:16 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 13:43:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:16 INFO - Successfully installed psutil 13:43:16 INFO - Cleaning up... 13:43:16 INFO - Return code: 0 13:43:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:43:16 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')]} 13:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:16 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')]} 13:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:16 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 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:16 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 13:43:16 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 13:43:16 INFO - Using env: {'DISPLAY': ':0', 13:43:16 INFO - 'HOME': '/home/cltbld', 13:43:16 INFO - 'LANG': 'en_US.UTF-8', 13:43:16 INFO - 'LANGUAGE': 'en_US:en', 13:43:16 INFO - 'LOGNAME': 'cltbld', 13:43:16 INFO - 'MAIL': '/var/mail/cltbld', 13:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:16 INFO - 'MOZ_NO_REMOTE': '1', 13:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:16 INFO - 'NO_EM_RESTART': '1', 13:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:16 INFO - 'PWD': '/builds/slave/test', 13:43:16 INFO - 'SHELL': '/bin/bash', 13:43:16 INFO - 'SHLVL': '1', 13:43:16 INFO - 'TERM': 'linux', 13:43:16 INFO - 'TMOUT': '86400', 13:43:16 INFO - 'USER': 'cltbld', 13:43:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:16 INFO - '_': '/tools/buildbot/bin/python'} 13:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 13: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 13: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 13: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 13: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 13: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 13: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 13:43:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:43:18 INFO - Installing collected packages: mozsystemmonitor 13:43:18 INFO - Running setup.py install for mozsystemmonitor 13:43:18 INFO - Successfully installed mozsystemmonitor 13:43:18 INFO - Cleaning up... 13:43:18 INFO - Return code: 0 13:43:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13: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')]} 13:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:43:18 INFO - Using env: {'DISPLAY': ':0', 13:43:18 INFO - 'HOME': '/home/cltbld', 13:43:18 INFO - 'LANG': 'en_US.UTF-8', 13:43:18 INFO - 'LANGUAGE': 'en_US:en', 13:43:18 INFO - 'LOGNAME': 'cltbld', 13:43:18 INFO - 'MAIL': '/var/mail/cltbld', 13:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:18 INFO - 'MOZ_NO_REMOTE': '1', 13:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:18 INFO - 'NO_EM_RESTART': '1', 13:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:18 INFO - 'PWD': '/builds/slave/test', 13:43:18 INFO - 'SHELL': '/bin/bash', 13:43:18 INFO - 'SHLVL': '1', 13:43:18 INFO - 'TERM': 'linux', 13:43:18 INFO - 'TMOUT': '86400', 13:43:18 INFO - 'USER': 'cltbld', 13:43:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:18 INFO - '_': '/tools/buildbot/bin/python'} 13:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:18 INFO - Downloading/unpacking jsonschema==2.5.1 13: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 13: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 13: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 13: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 13: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 13: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 13:43:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:43:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13: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 13: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 13: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 13: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 13: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 13: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 13:43:21 INFO - Downloading functools32-3.2.3-2.tar.gz 13:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:43:21 INFO - warning: no files found matching '*.txt' 13:43:21 INFO - no previously-included directories found matching 'build' 13:43:21 INFO - no previously-included directories found matching 'dist' 13:43:21 INFO - no previously-included directories found matching '.git*' 13:43:21 INFO - Installing collected packages: jsonschema, functools32 13:43:21 INFO - Running setup.py install for functools32 13:43:21 INFO - warning: no files found matching '*.txt' 13:43:21 INFO - no previously-included directories found matching 'build' 13:43:21 INFO - no previously-included directories found matching 'dist' 13:43:21 INFO - no previously-included directories found matching '.git*' 13:43:21 INFO - Successfully installed jsonschema functools32 13:43:21 INFO - Cleaning up... 13:43:21 INFO - Return code: 0 13:43:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:43:21 INFO - Using env: {'DISPLAY': ':0', 13:43:21 INFO - 'HOME': '/home/cltbld', 13:43:21 INFO - 'LANG': 'en_US.UTF-8', 13:43:21 INFO - 'LANGUAGE': 'en_US:en', 13:43:21 INFO - 'LOGNAME': 'cltbld', 13:43:21 INFO - 'MAIL': '/var/mail/cltbld', 13:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:21 INFO - 'MOZ_NO_REMOTE': '1', 13:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:21 INFO - 'NO_EM_RESTART': '1', 13:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:21 INFO - 'PWD': '/builds/slave/test', 13:43:21 INFO - 'SHELL': '/bin/bash', 13:43:21 INFO - 'SHLVL': '1', 13:43:21 INFO - 'TERM': 'linux', 13:43:21 INFO - 'TMOUT': '86400', 13:43:21 INFO - 'USER': 'cltbld', 13:43:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:21 INFO - '_': '/tools/buildbot/bin/python'} 13:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:21 INFO - Downloading/unpacking blobuploader==1.2.4 13: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 13: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 13: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 13: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 13: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 13: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 13:43:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:43:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:43:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - Downloading docopt-0.6.1.tar.gz 13:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:43:24 INFO - Installing collected packages: blobuploader, requests, docopt 13:43:24 INFO - Running setup.py install for blobuploader 13:43:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:43:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:43:24 INFO - Running setup.py install for requests 13:43:24 INFO - Running setup.py install for docopt 13:43:24 INFO - Successfully installed blobuploader requests docopt 13:43:24 INFO - Cleaning up... 13:43:24 INFO - Return code: 0 13:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:24 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 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:24 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 13:43:24 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 13:43:24 INFO - Using env: {'DISPLAY': ':0', 13:43:24 INFO - 'HOME': '/home/cltbld', 13:43:24 INFO - 'LANG': 'en_US.UTF-8', 13:43:24 INFO - 'LANGUAGE': 'en_US:en', 13:43:24 INFO - 'LOGNAME': 'cltbld', 13:43:24 INFO - 'MAIL': '/var/mail/cltbld', 13:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:24 INFO - 'MOZ_NO_REMOTE': '1', 13:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:24 INFO - 'NO_EM_RESTART': '1', 13:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:24 INFO - 'PWD': '/builds/slave/test', 13:43:24 INFO - 'SHELL': '/bin/bash', 13:43:24 INFO - 'SHLVL': '1', 13:43:24 INFO - 'TERM': 'linux', 13:43:24 INFO - 'TMOUT': '86400', 13:43:24 INFO - 'USER': 'cltbld', 13:43:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:24 INFO - '_': '/tools/buildbot/bin/python'} 13:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:25 INFO - Running setup.py (path:/tmp/pip-kqnEu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:25 INFO - Running setup.py (path:/tmp/pip-bV9RkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:25 INFO - Running setup.py (path:/tmp/pip-RzsI1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:25 INFO - Running setup.py (path:/tmp/pip-zbAyOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:25 INFO - Running setup.py (path:/tmp/pip-CnFHqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:25 INFO - Running setup.py (path:/tmp/pip-HQNk7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:25 INFO - Running setup.py (path:/tmp/pip-7GEzB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:25 INFO - Running setup.py (path:/tmp/pip-ssZVJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:25 INFO - Running setup.py (path:/tmp/pip-76FYZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:25 INFO - Running setup.py (path:/tmp/pip-48tpMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:25 INFO - Running setup.py (path:/tmp/pip-XUfhBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:25 INFO - Running setup.py (path:/tmp/pip-XEgS0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:25 INFO - Running setup.py (path:/tmp/pip-esSBjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:26 INFO - Running setup.py (path:/tmp/pip-55SeLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:26 INFO - Running setup.py (path:/tmp/pip-5HJ9WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:26 INFO - Running setup.py (path:/tmp/pip-ZVIIZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:26 INFO - Running setup.py (path:/tmp/pip-2PIEkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:43:26 INFO - Running setup.py install for manifestparser 13:43:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:43:26 INFO - Running setup.py install for mozcrash 13:43:26 INFO - Running setup.py install for mozdebug 13:43:26 INFO - Running setup.py install for mozdevice 13:43:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:43:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:43:26 INFO - Running setup.py install for mozfile 13:43:26 INFO - Running setup.py install for mozhttpd 13:43:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:43:26 INFO - Running setup.py install for mozinfo 13:43:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for mozInstall 13:43:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for mozleak 13:43:27 INFO - Running setup.py install for mozlog 13:43:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for moznetwork 13:43:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for mozprocess 13:43:27 INFO - Running setup.py install for mozprofile 13:43:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for mozrunner 13:43:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:43:27 INFO - Running setup.py install for mozscreenshot 13:43:27 INFO - Running setup.py install for moztest 13:43:28 INFO - Running setup.py install for mozversion 13:43:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:43:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:28 INFO - Cleaning up... 13:43:28 INFO - Return code: 0 13:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:28 INFO - Using env: {'DISPLAY': ':0', 13:43:28 INFO - 'HOME': '/home/cltbld', 13:43:28 INFO - 'LANG': 'en_US.UTF-8', 13:43:28 INFO - 'LANGUAGE': 'en_US:en', 13:43:28 INFO - 'LOGNAME': 'cltbld', 13:43:28 INFO - 'MAIL': '/var/mail/cltbld', 13:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:28 INFO - 'MOZ_NO_REMOTE': '1', 13:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:28 INFO - 'NO_EM_RESTART': '1', 13:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:28 INFO - 'PWD': '/builds/slave/test', 13:43:28 INFO - 'SHELL': '/bin/bash', 13:43:28 INFO - 'SHLVL': '1', 13:43:28 INFO - 'TERM': 'linux', 13:43:28 INFO - 'TMOUT': '86400', 13:43:28 INFO - 'USER': 'cltbld', 13:43:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:28 INFO - '_': '/tools/buildbot/bin/python'} 13:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:28 INFO - Running setup.py (path:/tmp/pip-X1e3Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:28 INFO - Running setup.py (path:/tmp/pip-zzAYP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:28 INFO - Running setup.py (path:/tmp/pip-HBiDdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:28 INFO - Running setup.py (path:/tmp/pip-EmUUhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:28 INFO - Running setup.py (path:/tmp/pip-fegmO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:28 INFO - Running setup.py (path:/tmp/pip-TKkKR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:28 INFO - Running setup.py (path:/tmp/pip-WDRLq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:28 INFO - Running setup.py (path:/tmp/pip-qr2TeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:28 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)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:28 INFO - Running setup.py (path:/tmp/pip-Rqx43k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:28 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)) 13:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:29 INFO - Running setup.py (path:/tmp/pip-MNQ7n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:29 INFO - Running setup.py (path:/tmp/pip-CUapsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:29 INFO - Running setup.py (path:/tmp/pip-dqBh_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:29 INFO - Running setup.py (path:/tmp/pip-FsiJvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:29 INFO - Running setup.py (path:/tmp/pip-ou_ZFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:29 INFO - Running setup.py (path:/tmp/pip-Cuvn1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:29 INFO - Running setup.py (path:/tmp/pip-YA7f_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:29 INFO - Running setup.py (path:/tmp/pip-NPsl0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:31 INFO - Downloading blessings-1.6.tar.gz 13:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:31 INFO - Installing collected packages: blessings 13:43:31 INFO - Running setup.py install for blessings 13:43:31 INFO - Successfully installed blessings 13:43:31 INFO - Cleaning up... 13:43:31 INFO - Return code: 0 13:43:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:31 INFO - Reading from file tmpfile_stdout 13:43:31 INFO - Current package versions: 13:43:31 INFO - argparse == 1.2.1 13:43:31 INFO - blessings == 1.6 13:43:31 INFO - blobuploader == 1.2.4 13:43:31 INFO - docopt == 0.6.1 13:43:31 INFO - functools32 == 3.2.3-2 13:43:31 INFO - jsonschema == 2.5.1 13:43:31 INFO - manifestparser == 1.1 13:43:31 INFO - mozInstall == 1.12 13:43:31 INFO - mozcrash == 0.17 13:43:31 INFO - mozdebug == 0.1 13:43:31 INFO - mozdevice == 0.48 13:43:31 INFO - mozfile == 1.2 13:43:31 INFO - mozhttpd == 0.7 13:43:31 INFO - mozinfo == 0.9 13:43:31 INFO - mozleak == 0.1 13:43:31 INFO - mozlog == 3.3 13:43:31 INFO - moznetwork == 0.27 13:43:31 INFO - mozprocess == 0.23 13:43:31 INFO - mozprofile == 0.28 13:43:31 INFO - mozrunner == 6.12 13:43:31 INFO - mozscreenshot == 0.1 13:43:31 INFO - mozsystemmonitor == 0.3 13:43:31 INFO - moztest == 0.7 13:43:31 INFO - mozversion == 1.4 13:43:31 INFO - psutil == 3.1.1 13:43:31 INFO - requests == 1.2.3 13:43:31 INFO - wsgiref == 0.1.2 13:43:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:31 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')]} 13:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:31 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')]} 13:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:31 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 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:31 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 13:43:31 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 13:43:31 INFO - Using env: {'DISPLAY': ':0', 13:43:31 INFO - 'HOME': '/home/cltbld', 13:43:31 INFO - 'LANG': 'en_US.UTF-8', 13:43:31 INFO - 'LANGUAGE': 'en_US:en', 13:43:31 INFO - 'LOGNAME': 'cltbld', 13:43:31 INFO - 'MAIL': '/var/mail/cltbld', 13:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:31 INFO - 'MOZ_NO_REMOTE': '1', 13:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:31 INFO - 'NO_EM_RESTART': '1', 13:43:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:31 INFO - 'PWD': '/builds/slave/test', 13:43:31 INFO - 'SHELL': '/bin/bash', 13:43:31 INFO - 'SHLVL': '1', 13:43:31 INFO - 'TERM': 'linux', 13:43:31 INFO - 'TMOUT': '86400', 13:43:31 INFO - 'USER': 'cltbld', 13:43:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:31 INFO - '_': '/tools/buildbot/bin/python'} 13:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:32 INFO - Cleaning up... 13:43:32 INFO - Return code: 0 13:43:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb5a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcbd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, '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': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', '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 13:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:43:32 INFO - Using env: {'DISPLAY': ':0', 13:43:32 INFO - 'HOME': '/home/cltbld', 13:43:32 INFO - 'LANG': 'en_US.UTF-8', 13:43:32 INFO - 'LANGUAGE': 'en_US:en', 13:43:32 INFO - 'LOGNAME': 'cltbld', 13:43:32 INFO - 'MAIL': '/var/mail/cltbld', 13:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:32 INFO - 'MOZ_NO_REMOTE': '1', 13:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:32 INFO - 'NO_EM_RESTART': '1', 13:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:32 INFO - 'PWD': '/builds/slave/test', 13:43:32 INFO - 'SHELL': '/bin/bash', 13:43:32 INFO - 'SHLVL': '1', 13:43:32 INFO - 'TERM': 'linux', 13:43:32 INFO - 'TMOUT': '86400', 13:43:32 INFO - 'USER': 'cltbld', 13:43:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:32 INFO - '_': '/tools/buildbot/bin/python'} 13:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:43:32 INFO - Cleaning up... 13:43:32 INFO - Return code: 0 13:43:32 INFO - Running post-action listener: _resource_record_post_action 13:43:32 INFO - Running post-action listener: _start_resource_monitoring 13:43:32 INFO - Starting resource monitoring. 13:43:32 INFO - [mozharness: 2016-07-20 20:43:32.403180Z] Finished create-virtualenv step (success) 13:43:32 INFO - [mozharness: 2016-07-20 20:43:32.403664Z] Running install step. 13:43:32 INFO - Running pre-action listener: _resource_record_pre_action 13:43:32 INFO - Running main action method: install 13:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:32 INFO - Reading from file tmpfile_stdout 13:43:32 INFO - Detecting whether we're running mozinstall >=1.0... 13:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:43:32 INFO - Reading from file tmpfile_stdout 13:43:32 INFO - Output received: 13:43:32 INFO - Usage: mozinstall [options] installer 13:43:32 INFO - Options: 13:43:32 INFO - -h, --help show this help message and exit 13:43:32 INFO - -d DEST, --destination=DEST 13:43:32 INFO - Directory to install application into. [default: 13:43:32 INFO - "/builds/slave/test"] 13:43:32 INFO - --app=APP Application being installed. [default: firefox] 13:43:32 INFO - mkdir: /builds/slave/test/build/application 13:43:32 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'] 13:43:32 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 13:43:49 INFO - Reading from file tmpfile_stdout 13:43:49 INFO - Output received: 13:43:49 INFO - /builds/slave/test/build/application/firefox/firefox 13:43:49 INFO - Running post-action listener: _resource_record_post_action 13:43:49 INFO - [mozharness: 2016-07-20 20:43:49.039631Z] Finished install step (success) 13:43:49 INFO - [mozharness: 2016-07-20 20:43:49.039909Z] Running run-tests step. 13:43:49 INFO - Running pre-action listener: _resource_record_pre_action 13:43:49 INFO - Running main action method: run_tests 13:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:43:49 INFO - Python 2.7.3 13:43:49 INFO - Return code: 0 13:43:49 INFO - grabbing minidump binary from tooltool 13:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:43:49 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 0xe193b0>, '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 0xe1a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:43:49 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 13:43:49 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 13:43:49 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 13:43:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:49 INFO - Return code: 0 13:43:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:43:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:43:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:43:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:43:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:43:49 INFO - Using env: {'DISPLAY': ':0', 13:43:49 INFO - 'HOME': '/home/cltbld', 13:43:49 INFO - 'LANG': 'en_US.UTF-8', 13:43:49 INFO - 'LANGUAGE': 'en_US:en', 13:43:49 INFO - 'LOGNAME': 'cltbld', 13:43:49 INFO - 'MAIL': '/var/mail/cltbld', 13:43:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:43:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:49 INFO - 'MOZ_NO_REMOTE': '1', 13:43:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:49 INFO - 'NO_EM_RESTART': '1', 13:43:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:49 INFO - 'PWD': '/builds/slave/test', 13:43:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:43:49 INFO - 'SHELL': '/bin/bash', 13:43:49 INFO - 'SHLVL': '1', 13:43:49 INFO - 'TERM': 'linux', 13:43:49 INFO - 'TMOUT': '86400', 13:43:49 INFO - 'USER': 'cltbld', 13:43:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875', 13:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:49 INFO - '_': '/tools/buildbot/bin/python'} 13:43:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:43:49 INFO - mozversion application_buildid: 20160720122219 13:43:49 INFO - mozversion application_changeset: b89f326ea06438d137b0baa91e124bac07e67b0c 13:43:49 INFO - mozversion application_display_name: Nightly 13:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:49 INFO - mozversion application_name: Firefox 13:43:49 INFO - mozversion application_remotingname: firefox 13:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:43:49 INFO - mozversion application_vendor: Mozilla 13:43:49 INFO - mozversion application_version: 50.0a1 13:43:49 INFO - mozversion platform_buildid: 20160720122219 13:43:49 INFO - mozversion platform_changeset: b89f326ea06438d137b0baa91e124bac07e67b0c 13:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:43:49 INFO - mozversion platform_version: 50.0a1 13:43:49 INFO - using testdate: 1469047429 13:43:49 INFO - actual date: 1469047429 13:43:49 INFO - starting webserver on 'localhost:55559' 13:43:49 INFO - SUITE-START | Running 2 tests 13:43:49 INFO - TEST-START | dromaeo_css 13:43:49 INFO - operating with platform_type : linux_ 13:43:49 INFO - Initialising browser for dromaeo_css test... 13:43:49 INFO - TEST-INFO | started process 3850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKwOhQ/profile http://localhost:55559/getInfo.html) 13:43:54 INFO - PROCESS | 3850 | __metrics Screen width/height:1600/1200 13:43:54 INFO - PROCESS | 3850 | colorDepth:24 13:43:54 INFO - PROCESS | 3850 | Browser inner width/height: 1024/697 13:43:54 INFO - PROCESS | 3850 | __metrics 13:43:57 INFO - PROCESS | 3850 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:43:57 INFO - PROCESS | 3850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:43:58 INFO - TEST-INFO | 3850: exit 0 13:43:58 INFO - Browser initialized. 13:43:58 INFO - Running cycle 1/1 for dromaeo_css test... 13:43:58 INFO - TEST-INFO | started process 3932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKwOhQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:10 INFO - PROCESS | 3932 | RSS: Main: 158453760 13:44:10 INFO - PROCESS | 3932 | 13:45:00 INFO - PROCESS | 3932 | 1469047500981 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] 13:47:13 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55559/tests/dromaeo/cssquery-ext.html) 13:47:14 INFO - PROCESS | 3932 | RSS: Main: 238514176 13:47:14 INFO - PROCESS | 3932 | 13:50:17 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-ext.html (next: http://localhost:55559/tests/dromaeo/cssquery-jquery.html) 13:50:18 INFO - PROCESS | 3932 | RSS: Main: 243212288 13:50:18 INFO - PROCESS | 3932 | 13:53:20 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55559/tests/dromaeo/cssquery-mootools.html) 13:53:21 INFO - PROCESS | 3932 | RSS: Main: 214040576 13:53:21 INFO - PROCESS | 3932 | 13:56:23 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55559/tests/dromaeo/cssquery-prototype.html) 13:56:24 INFO - PROCESS | 3932 | RSS: Main: 195407872 13:56:24 INFO - PROCESS | 3932 | 13:59:27 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55559/tests/dromaeo/cssquery-yui.html) 13:59:27 INFO - PROCESS | 3932 | RSS: Main: 191062016 13:59:27 INFO - PROCESS | 3932 | 14:02:30 INFO - PROCESS | 3932 | Cycle 1(1): loaded http://localhost:55559/tests/dromaeo/cssquery-yui.html (next: http://localhost:55559/tests/dromaeo/cssquery-dojo.html) 14:02:31 INFO - PROCESS | 3932 | RSS: Main: 281665536 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | __start_tp_report 14:02:31 INFO - PROCESS | 3932 | _x_x_mozilla_page_load 14:02:31 INFO - PROCESS | 3932 | _x_x_mozilla_page_load_details 14:02:31 INFO - PROCESS | 3932 | |i|pagename|runs| 14:02:31 INFO - PROCESS | 3932 | |0;dojo.html;2598.3893784960533;2598.8700564971746;2636.4990651776175;2638.7097419283878;2643.0220818297234;4538.795754191061;4597.701149425294;4694.906101877965;4731.455882573501;4749.40632420947;4705.058988202365;4744.928826067603;4766.78549465274;4772.57046865782;4822.035592881429;4317.266064768989;4379.321205213197;4427.247367947441;4476.820927162909;4554.817807287721;4472.731636101828;4500.954990450103;4513.684042117053;4527.298268768346;4536.56902594253;4235.237657221699;4335.826566937319;4337.739735615842;4393.868183954486;4420.381146639473;4138.544760076389;4141.855035073758;4168.2080404723;4254.042840360925;4438.866833994953;4180.184863951531;4180.24755544002;4185.100203456272;4219.156168766228;4227.492700875884;4584.15193189261;4594.19601569724;4603.49361570227;4627.375304333906;4633.189191891405;5037.194048952187;5050.191969284897;5052.949470505285;5086.567641750456;5102.846914592531;5099.33708617881;5111.539961403491;5115.104856650071;5121.769520371555;5122.462141475166;4655.557722016403;4718.551737584924;4726.5746082852365;4773.856784296408;4783.995360974234;5234.2933703949475;5263.815766448156;5269.420363759983;5303.973480132652;5314.229436731653;5039.521245481674;5056.494350564988;5057.115004874132;5103.055934652101;5109.642325037212;4979.751012449436;4980.950190498121;5064.063148317573;5091.490850914953;5176.171812510056;5039.496050394931;5058.570021548209;5069.290299358093;5071.087204303187;5101.464346243665;4998.575121114746;5020.422651395063;5022.623303252198;5028.723420211851;5075;4267.679924005712;4308.353746937984;4309.892252693645;4366.541513141075;4430.224710675619;3773.716971227169;3789.3368660484307;3837.4435706822355;3879.2241551689212;3912.315344814646;4441.866743997685;4453.376527286183;4459.264221403432;4460.665450091256;4514;5152.175651895679;5163;5190.896182076337;5200.8959820803375;5243.449437808975;4317;4374.475062992461;4381.452318460192;4397.274449715825;4432.711873728197;4690.273007683814;4698.765061746899;4704.85885423431;4728.38530990969;4741.83403580873;4850.53919877611;4860.829870954571;4861.440934292602;4861.871850538701;4904.386951631046;4900.8774780630765;4965.4289756678445;5098.107831129463;5104.2088476286235;5164.819231327036;4826.6621336506105;4864.878378040577;4865.56209941107;4877.414710234794;4879.121758083579;5096.51583099605;5096.745162741774;5096.872578185575;5098.260752190838;5144.6398752087;4992.975035124801;4995.850124496271;5064.4935506449065;5171.120909445328;5187.066328060985;4932.654714169974;4940.456549779593;4945.579625731853;4971.875703107451;4992.2761199626575;4934.703917764946;4946.15915294408;4951.084049450863;4953.083679519301;4991.051700176955;4768.260919557474;4841.467438581823;4855.6601037927;4869.756512174448;4928.8767780805765;4975.651704380659;4981.875453113701;4983.501649834988;5009.348784657971;5010.749462526932;4927.408710954708;4930;4946.282788995647;4949.480304568113;4996.7001979881325 14:02:31 INFO - PROCESS | 3932 | |1;ext.html;569.052527541643;574.5662025170996;582.5281521967206;588.1912370490576;595.9135925290831;28766.71233287669;29234.85382573087;29272.268193295153;38420;40307.395389069185;40261.59738402622;40754.59245407552;40797.796011019906;40808.18383632325;40815.59184408155;7809.297163255306;7984.6007699615075;7994.720184793533;7994.840103197933;7999.520028798262;7876.251756083191;7955.681772729084;7962.562059086777;7966.6813327467125;7969.282764551189;7998.280154786068;8034.758957231293;8034.879476807852;8038.598070096472;8045.798855028642;7954.00574928134;7998.840023199533;8011.719589814328;8026.959865200695;8040.115587285394;7748.922510774876;7815.804604884866;7817.843643127162;7818.6090695465;7818.921810781876;38757.61242387568;38998.805005975075;39097.60902390968;39125;39177.21645567073;2820.3106012132444;2974.4794660934467;3010.548417737357;3039.6200474940633;3269.4278501262183;29690;29734.25664358408;30093.398132037455;30264.24339391511;30521;3265.7877237979455;3434.158631135363;3496.160921378876;3556.8399422026073;3623;170253;170601;170621;170978;170995.14502427532;33178.17054573655;54602.72698636481;55155.17267240994;55229;55325;33920.830395847865;34054;34056.48915266273;34107.4883876742;34161.82919085389;12991.545295914597;13137.080404371602;13137.34313284332;13152.40814163365;13185.73628527424;10473.109785668303;10528.36829790215;10528.894711052792;10530.31552949056;10531.52608132636;7936.841263174704;7946.721864734822;7989.680412783424;8050.798730031796;8054.275115239657;3105.1305634422397;3108.0675797261183;3116.7350775184364;3132.9060128196193;3212.855421506038;831.5301854452215;886.5655828643918;929.340168480373;983.7048885334514;1011.0417714647074;27126.864365678044;28173.43653126926;28804.42391152207;28937.276568085967;29249.41501170007;893.4773157702687;920.5765347939889;923.5613083785148;929.8884133903839;976.2824324121765;14720.558383248519;15263.542093737206;15338.640440959703;15457.768133478006;15576.376944922076;408133;408769;408779;410278;414378;48243.51756482461;48994.26508602374;49027;49099.50900491021;49227.26159107616;1072.244067932106;1128.898399144081;1166.8016437205526;1189.7085214122421;1212.1878341511208;25732.228033159034;28800.711992879802;29664.55503167411;29706.371357102627;29897;42735;43034.56965430306;43193;43239.78380108079;43303.566964329955;257860;257870;258126;258499;258787;22438.10247590078;24470.75529244756;25199.244022679348;25371.87314063418;26041;40706.38940415837;40999.59000409958;41045.794771025954;41230.79384603058;42113.36829947615;34938.12654683653;35313.29373412466;35776.64223357733;35824.64175358317;36349.636503634625;35406;35560.28879422345;35570;35573.82213088918;36054.8197259012;31948.840255798572;33513.32973340471;34358.31283374369;35366.64633353634;35440.11399715028;30526.847365763027;32595;32655;32754.67245327516;33008;24513.264602061965;24742.50514989726;24800.627990580517;25081.74918250794;25364.492710145325 14:02:31 INFO - PROCESS | 3932 | |2;jquery.html;345.0098218114013;358.2923725641856;369.34994409838674;371.9460678201661;384.7306885180374;13294.66763330916;16157.838421615781;16334.83665163348;17149.914250428763;18284.451466456027;17041.82958170421;17392.47822565325;17448.47654570365;17451;17550.12249387532;5099.056674515217;5424.945750542503;5640.717964101799;5672.971635141839;5784.797532086378;3536.876209332674;5363.8122665706705;5665.206871038058;5690.430956904318;5697.715114244292;5625.943740562603;5692.459216374438;5708.942910570882;5710.371859095496;5715.71421428929;5450.863728406822;5599.076152434844;5620.241267428885;5704.1443783432405;5707.37218905918;3425.075229687995;5410.161424979135;5437.429069947638;5445.646033007842;5446.809361672362;11131.554737810478;11231.157663175212;12281.570145044881;12487.875121248853;12808.231506109663;1793.1482545790775;1826.2329821475012;1973.398113575359;2019.7374341335678;2081.9278071793037;9060.728178154666;9098.77253068672;9100.453972761656;9245.537723113817;9399.62401503939;1700.889442186254;1783.144090836393;1796.865235107359;1827.8909407941655;1913.7416448779516;46292;57129.42870571324;60130.398696013355;70237;70465;9969.351992120633;9999.600015999424;10210;10263;10373.688789336182;14034.228117453435;14053.367598458093;14059.507917223053;14062.71874562503;14074.929625351808;7222.241664625244;7374.078240219973;7420.925790742023;7475.990741249971;7562.621868906533;6612.305707900698;6741.898871516931;6856.177258728984;7034.8944765828555;7235.819104522429;4337.587929146726;4376.671749618791;4423.225935461282;4441.600255976913;4442.178197033559;1817.4638481647946;1826.5251034731066;1869.8504119670665;1871.8034606366407;1920.5992509363296;803.7387848948998;843.7384410832661;890.4746199742183;952.6134591527187;955.4267439536361;16322.75515867263;17284.481465556055;17341.913290433466;17489.825101749073;17822;857.1428571428571;857.7512521368733;863.9740807775777;870.3559366069189;882.6415489064044;9169.862452063224;9610.807783844284;9870.457124858201;9912.35569687968;9998.450085245382;394325;396062;399254;418812;419233;81471;83016.58491707624;83650;84546.57726711327;85293.57353213319;807.2049031703767;818.5211651184125;821.5194111444753;822.847773161967;826.1903334731876;14846.628834278798;15122.515094236778;15540.533783986499;15672;15863.444779432664;37061.814690926374;37396.69111581082;37702.811485942395;38848.41727374035;39543;51592.74203628958;52586.474135258155;52744.20883686671;52849;53007.469925300255;7286;7456.179820219663;7477.66350514239;7540.019797426299;7737.458377913492;8995.955020224857;10532.684019479428;10912;11005.834912476159;11467.139964502529;9799.314048016571;10580.735481613021;10669.146468282364;10718.303310284806;10832.133429325477;9953.353032053183;10130.898691012995;10254.58981640726;10477.266591338837;10525.684229473129;9641.758956025875;10252.38485690861;10290.691279261635;10322.845157322496;10805.837912431478;7672.73145439907;7714.768556943301;7748.418868584766;7770.45606807518;8062.113167551447;5629.746661400329;6944.652767361713;10710.785784284426;10841.295315804447;11134.164937629872 14:02:31 INFO - PROCESS | 3932 | |3;mootools.html;1283.300601172361;1372.4167228927704;1413.201541129262;1495.86537211651;1744.2674076887713;6741.764038258662;7576.280253375934;7880.881786773203;7887.369010479162;8130.593470326475;7952.681892724298;7988.041435027791;8010.39922005849;8013;8015.31869791067;1884.3028079610494;2151.752548456932;2187.3765976696604;2211.8672879627275;2217.700610417597;2213.2253711201033;2247.269637367862;2251.9324420267417;2253.50422906961;2254.0645632062674;2134.349023547817;2173.673948907661;2187.6937228787983;2191.9890400547974;2195.4072400451946;1830.9359172429033;2082.2607974169105;2191.485001024758;2199.3951663292723;2200.3948914048683;2182.5853087913247;2224.021430570544;2225.9332220033425;2227.465408302012;2227.509947811479;7836.764897053041;7913.287804097658;7921.801954951115;7927;7939.245771651742;4537.115262523809;4654.720716757005;4655.930161047587;4659.370984917026;4664.790084446208;2718.347596576827;2796.6783819860775;2841.261272069277;2847.2170153207826;2873.454043731684;960.2462067277154;989.2531138990016;992.9851052234222;1002.0580654185043;1005.9144972677332;10805.675829725122;10829.079528240189;10833.67498975032;10847.294925829796;10888.074513666348;3956.3669812829808;4049.3521036633997;4188.85339013133;4195.328747400401;4282.892927676833;9231.123043310874;9234.03042680509;9237.769055773659;9249.815003700023;9253.259739220846;4682.74244916526;4694.295855621615;4705.741184234831;4709.105269998689;4709.481956984729;3492.6158122606494;3914.72596918213;3995.4805875236034;4276;4283.550227226158;3539.8938031859084;3575.8748443804343;3664.6518580734787;3687.483752274684;3697.0572504011843;1140.6920131564432;1168.0305346562334;1178.7288923547633;1198.3469009389903;1203.8134089216185;685.4345165238599;853.1511146409363;860.8364410761935;862.5471627395542;867.2844902955087;5294.97352513235;5322.787088516493;5395.703236321961;5437;5440.183972404171;394.1407731146129;399.4208397823168;407.3157096078557;414.6848395219595;418.0593664255425;3734.7572407793405;3797.0317569020276;3818.2745278397015;3824.349860523718;3919.431682406035;9339.159475647224;9802.215822734164;9816.558254878548;9826.950865245772;9845.409275443353;9201.125893040151;9461.621535138655;9617.615295388247;9748.561314740853;9750.171235444925;7365.189829118793;7535.962320188473;7560.8487830244185;7563.584002880005;7564.319211270902;5436.374816896107;5565.7217139143695;5613.550915926634;5653.575981801464;5850.619709718854;9099.04460031687;9099.36304458708;9164.633414663605;9249;9259;9104.772380690536;9142.63429462814;9473.33686641956;9496.952515237379;9597.568109435231;6253.906191407042;6668.466522678077;6965.6168910708375;7082.433405327459;7104.964475177591;7495.325420712162;7659.502132361378;7737.187595302637;7744.49660772048;7745.302922736981;6953.1656201254145;6991.825204369931;6996.650167491707;7020.333068358498;7221.891671624825;6813.761518346834;6818.215905170969;6818.420434263143;6824.590524568542;6867.3476019778045;6478.578892371981;6486.837829054311;6522.543421960418;6580.868382632225;6587.934120658732;4319.892002699832;4445.133199026159;4474.418325617649;4544.818207271672;4577.130345234395;4439.267520859022;4520.299353600197;4562.77186140685;4580.496145424067;4750.287456881357 14:02:31 INFO - PROCESS | 3932 | |4;prototype.html;292.57722590856224;301.376151366671;306.2267773870977;309.0450507930494;310.866327479184;4677.181493238678;4801.935167877811;4817.6386770992185;4850.830220942268;4858.392700912386;4649.256119020957;4726.7400292983875;4798.520147985199;4808.879778005552;4822.276658501218;3844.2503711776217;3847.1920896611605;3854.325493038721;3855.2867719471847;3855.51806024247;3597.8380972856285;3654.2326111516613;3847.4228865670234;3874.5350557932948;3875.1668391295866;3795.373763329061;3802.4106263529197;3807.2195199984076;3824.6749026332795;3835.673967712748;3780.4707340972286;3792.1657235408165;3806;3811.5225103682687;3814.0846196912817;3367.0235631666787;3369.1745522346937;3371.7639765216445;3374.1227280906896;3389.6271410144864;4574.451065872084;4656.4645065817185;4711.293306004092;4721.5750582447745;4758.645155165635;4277.700560960734;4279.293916503773;4291.806868690916;4316.676249281317;4326.178026175016;5048.268001139814;5049.469805670426;5057.420715435154;5063;5068.341115654978;3454;3641.635836416364;3650.543682039745;3652.7990960497164;3658.432942893856;5280.313559237313;5285.814996475105;5286.629935904488;5291.973540132275;5293.576513878919;3718.3121122592406;3721.5720192178246;3722.1253005543676;3727.459518369821;3735.1969326594913;3771.905702357463;3773.716971227114;3780.2628487444686;3781.262653782486;3785.5835858055593;4185.3931179979345;4244.151169766059;4245;4248.214080395137;4310.525842157423;5024.62315326352;5034.421041580192;5048.798048078036;5055.317532133188;5067.162389062063;1227.8403807505147;1247.382545639914;1248.7752204603078;1291.1155858237137;1304.3673818198167;837.6398148796076;858.3090612057354;862.6980556805069;869.0310304010982;890.247740659142;4407.713498622579;4412.0734645724115;4417.2269852775635;4448.377227188196;4464.508904020555;5077.847664569995;5136.871578210575;5204.141316682781;5212.817551385683;5231.346081739783;4394.033312671208;4415.27148020573;4419.49175844782;4449.532799056117;4454.37638730578;2726.291164297297;2738.0422997556443;2739.068716636353;2743.7530622243694;2760.585912113199;4774.594159496482;4885.60915126789;4889.902201955941;4910.140725373117;4925.556699897026;5179.948200518022;5203.895922081537;5204.9219261711105;5243.397009343898;5273.578113750891;4834.661573689808;4839.637027222972;4842.854714358575;4844.328706596219;4884.877878053077;4950.292149208517;5165.096108181128;5177.0940085485645;5184.351956005499;5196.116660167705;5117.2835802986865;5120.103981803244;5149.536541711264;5153.278541004337;5186.507281808223;4958.776855041604;4984.252362145708;4991.900161996812;5023.723695196653;5029.497050294941;3643.635636436441;3745.6628903398823;3779.3197224498754;3780.3762379208224;3781.8676346327748;5227;5240.947590524046;5250.606204534752;5263.55252305619;5264.394359720322;5038.866255092575;5103.392431384103;5142.742862856917;5158.535731784157;5159.742012899415;5021.472745361684;5145.228215767515;5164.8192313268855;5165.870853228699;5168.121419358643;4762.690425122356;4823.3729615149805;4984.277279794337;5010.173321401928;5016.197408414636;5034.622403319839;5060.1903695408555;5069.847904562869;5078.492150784892;5096.159133742891;5014.122528557561;5031.446540880427;5036.722980236123;5041.243813427868;5059.342285502861 14:02:31 INFO - PROCESS | 3932 | |5;yui.html;602.9638221706696;624.2321944008869;662.3906006474045;671.4829581222456;713.6120246121296;12850.100492965485;13555.796663050061;13953.162810231393;13964.511242106515;14375.065620734646;13300.334983250823;13444.462221511129;13529.120607160528;13563.118397304168;13572.185668859875;633.1452539072262;762.7864198024562;777.9766607001799;778.3150827271993;778.9805254868645;760.4106817216674;797.4617133434937;804.2761514636816;805.243071512779;807.4146243973131;845.7209120990059;847.1528471528471;848.6223630484437;848.6944699908059;849.1041950741965;645.6319897658336;834.9123342049119;838.367032890167;838.4675730910885;838.4801423117675;583.1922786940077;597.9611325263844;603.9879202415927;604.0245004318039;604.3261763134118;13358.265295408748;13375.464981400732;13375.732485350238;13378.331083445886;13386.263755493444;12230.082743794252;12323.568675096418;12355.196912200769;12372;12850.742985140338;12054.734252903494;12145.332006739625;12210.694732631666;12239.877601223963;12403.317817520032;4213.894652633678;4216.304309788881;4251.574842515754;4289.571042895716;4300.2904520754355;56213.437865621636;59767;61080.69459652673;62597.6870115651;62896.371036289966;9729.70810875675;9931.602735890483;10108.747281318027;10136.189104871593;10246.48767561619;17951.55121121956;18053.638927221382;18060.638787224445;18141.727874081636;18406.447806565557;6764.797056088325;6797.5921444712485;6852.146500319704;6970.198427180838;7116.46626503004;3750.1187221003042;3766.5291838520184;3808.200277941608;3828.9234215316096;3925.666318362914;2738.288045108286;2835.248659105339;2839.2901774556362;2841.9147425577266;2844.2462747371965;502.57532385134505;515.2065818639254;524.2817340243814;566.7534622439252;606.7724603273772;531.4446403508343;566.0999011571539;567.7076305702567;568.692905830855;571.5884563114633;7742.419318551131;7979.3616510679;8069;8100.918990810134;8209.699290101247;468.5455108544774;531.9867003324871;548.8737590354241;554.5785203245563;558.8966041282375;3630.618785027587;3711.684506816897;3730.272596843644;3767.604401537854;3793.6206379361843;100324.99675003302;107007.46496267468;109151.45424272987;112062;112612;53038.734806326494;87240.56379718188;93705.5314723422;94112.0004799586;94444.52777736068;59270.703646482354;80466;81003;82059;83656.99999999878;6937.583744975318;7117.43060555144;7143.9285607143265;7274.381677557467;7313.158986716596;49182;49543.256851147984;49626.503734962185;50919.490805091475;51325.48674513207;64730;71960;73142.63428683035;74191;76946.2305376939;9817.165540929102;10324.22568307365;10849.132069434268;10907.345559266469;11044.06125479311;12868.935655321664;12964;13077.607671769862;13441.327933603085;14113.2943352834;13016.414261358072;13122.540711075066;13506.153469477507;13533.188008719508;13565.59303220905;10997.780044399227;11247.5682146954;11248.887511124783;12098.818517722066;12570.62288131321;11929.28424294545;12128.151029427856;12171.2697238166;12644;12935;10482.790344193227;10535.578576857146;10765.461726913467;10833.458327083772;11183.664490065312;10280.537375818256;10447.216458765472;10522.1056210223;10542.367457952547;10746.355218686904 14:02:31 INFO - PROCESS | 3932 | __end_tp_report 14:02:31 INFO - PROCESS | 3932 | __start_cc_report 14:02:31 INFO - PROCESS | 3932 | _x_x_mozilla_cycle_collect,938 14:02:31 INFO - PROCESS | 3932 | __end_cc_report 14:02:31 INFO - PROCESS | 3932 | __startTimestamp1469048551095__endTimestamp 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | ------- Summary: start ------- 14:02:31 INFO - PROCESS | 3932 | Number of tests: 6 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#0] dojo.html Cycles:165 Average:4708.60 Median:4861.87 stddev:503.64 (10.4%) stddev-sans-first:477.21 14:02:31 INFO - PROCESS | 3932 | Values: 2598.4 2598.9 2636.5 2638.7 2643.0 4538.8 4597.7 4694.9 4731.5 4749.4 4705.1 4744.9 4766.8 4772.6 4822.0 4317.3 4379.3 4427.2 4476.8 4554.8 4472.7 4501.0 4513.7 4527.3 4536.6 4235.2 4335.8 4337.7 4393.9 4420.4 4138.5 4141.9 4168.2 4254.0 4438.9 4180.2 4180.2 4185.1 4219.2 4227.5 4584.2 4594.2 4603.5 4627.4 4633.2 5037.2 5050.2 5052.9 5086.6 5102.8 5099.3 5111.5 5115.1 5121.8 5122.5 4655.6 4718.6 4726.6 4773.9 4784.0 5234.3 5263.8 5269.4 5304.0 5314.2 5039.5 5056.5 5057.1 5103.1 5109.6 4979.8 4981.0 5064.1 5091.5 5176.2 5039.5 5058.6 5069.3 5071.1 5101.5 4998.6 5020.4 5022.6 5028.7 5075.0 4267.7 4308.4 4309.9 4366.5 4430.2 3773.7 3789.3 3837.4 3879.2 3912.3 4441.9 4453.4 4459.3 4460.7 4514.0 5152.2 5163.0 5190.9 5200.9 5243.4 4317.0 4374.5 4381.5 4397.3 4432.7 4690.3 4698.8 4704.9 4728.4 4741.8 4850.5 4860.8 4861.4 4861.9 4904.4 4900.9 4965.4 5098.1 5104.2 5164.8 4826.7 4864.9 4865.6 4877.4 4879.1 5096.5 5096.7 5096.9 5098.3 5144.6 4993.0 4995.9 5064.5 5171.1 5187.1 4932.7 4940.5 4945.6 4971.9 4992.3 4934.7 4946.2 4951.1 4953.1 4991.1 4768.3 4841.5 4855.7 4869.8 4928.9 4975.7 4981.9 4983.5 5009.3 5010.7 4927.4 4930.0 4946.3 4949.5 4996.7 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#1] ext.html Cycles:180 Average:42899.11 Median:19498.48 stddev:78613.51 (403.2%) stddev-sans-first:78769.79 14:02:31 INFO - PROCESS | 3932 | Values: 569.1 574.6 582.5 588.2 595.9 28766.7 29234.9 29272.3 38420.0 40307.4 40261.6 40754.6 40797.8 40808.2 40815.6 7809.3 7984.6 7994.7 7994.8 7999.5 7876.3 7955.7 7962.6 7966.7 7969.3 7998.3 8034.8 8034.9 8038.6 8045.8 7954.0 7998.8 8011.7 8027.0 8040.1 7748.9 7815.8 7817.8 7818.6 7818.9 38757.6 38998.8 39097.6 39125.0 39177.2 2820.3 2974.5 3010.5 3039.6 3269.4 29690.0 29734.3 30093.4 30264.2 30521.0 3265.8 3434.2 3496.2 3556.8 3623.0 170253.0 170601.0 170621.0 170978.0 170995.1 33178.2 54602.7 55155.2 55229.0 55325.0 33920.8 34054.0 34056.5 34107.5 34161.8 12991.5 13137.1 13137.3 13152.4 13185.7 10473.1 10528.4 10528.9 10530.3 10531.5 7936.8 7946.7 7989.7 8050.8 8054.3 3105.1 3108.1 3116.7 3132.9 3212.9 831.5 886.6 929.3 983.7 1011.0 27126.9 28173.4 28804.4 28937.3 29249.4 893.5 920.6 923.6 929.9 976.3 14720.6 15263.5 15338.6 15457.8 15576.4 408133.0 408769.0 408779.0 410278.0 414378.0 48243.5 48994.3 49027.0 49099.5 49227.3 1072.2 1128.9 1166.8 1189.7 1212.2 25732.2 28800.7 29664.6 29706.4 29897.0 42735.0 43034.6 43193.0 43239.8 43303.6 257860.0 257870.0 258126.0 258499.0 258787.0 22438.1 24470.8 25199.2 25371.9 26041.0 40706.4 40999.6 41045.8 41230.8 42113.4 34938.1 35313.3 35776.6 35824.6 36349.6 35406.0 35560.3 35570.0 35573.8 36054.8 31948.8 33513.3 34358.3 35366.6 35440.1 30526.8 32595.0 32655.0 32754.7 33008.0 24513.3 24742.5 24800.6 25081.7 25364.5 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#2] jquery.html Cycles:180 Average:24509.04 Median:28345.90 stddev:66977.56 (236.3%) stddev-sans-first:67140.87 14:02:31 INFO - PROCESS | 3932 | Values: 345.0 358.3 369.3 371.9 384.7 13294.7 16157.8 16334.8 17149.9 18284.5 17041.8 17392.5 17448.5 17451.0 17550.1 5099.1 5424.9 5640.7 5673.0 5784.8 3536.9 5363.8 5665.2 5690.4 5697.7 5625.9 5692.5 5708.9 5710.4 5715.7 5450.9 5599.1 5620.2 5704.1 5707.4 3425.1 5410.2 5437.4 5445.6 5446.8 11131.6 11231.2 12281.6 12487.9 12808.2 1793.1 1826.2 1973.4 2019.7 2081.9 9060.7 9098.8 9100.5 9245.5 9399.6 1700.9 1783.1 1796.9 1827.9 1913.7 46292.0 57129.4 60130.4 70237.0 70465.0 9969.4 9999.6 10210.0 10263.0 10373.7 14034.2 14053.4 14059.5 14062.7 14074.9 7222.2 7374.1 7420.9 7476.0 7562.6 6612.3 6741.9 6856.2 7034.9 7235.8 4337.6 4376.7 4423.2 4441.6 4442.2 1817.5 1826.5 1869.9 1871.8 1920.6 803.7 843.7 890.5 952.6 955.4 16322.8 17284.5 17341.9 17489.8 17822.0 857.1 857.8 864.0 870.4 882.6 9169.9 9610.8 9870.5 9912.4 9998.5 394325.0 396062.0 399254.0 418812.0 419233.0 81471.0 83016.6 83650.0 84546.6 85293.6 807.2 818.5 821.5 822.8 826.2 14846.6 15122.5 15540.5 15672.0 15863.4 37061.8 37396.7 37702.8 38848.4 39543.0 51592.7 52586.5 52744.2 52849.0 53007.5 7286.0 7456.2 7477.7 7540.0 7737.5 8996.0 10532.7 10912.0 11005.8 11467.1 9799.3 10580.7 10669.1 10718.3 10832.1 9953.4 10130.9 10254.6 10477.3 10525.7 9641.8 10252.4 10290.7 10322.8 10805.8 7672.7 7714.8 7748.4 7770.5 8062.1 5629.7 6944.7 10710.8 10841.3 11134.2 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#3] mootools.html Cycles:180 Average:5204.44 Median:4729.88 stddev:2964.43 (62.7%) stddev-sans-first:2958.10 14:02:31 INFO - PROCESS | 3932 | Values: 1283.3 1372.4 1413.2 1495.9 1744.3 6741.8 7576.3 7880.9 7887.4 8130.6 7952.7 7988.0 8010.4 8013.0 8015.3 1884.3 2151.8 2187.4 2211.9 2217.7 2213.2 2247.3 2251.9 2253.5 2254.1 2134.3 2173.7 2187.7 2192.0 2195.4 1830.9 2082.3 2191.5 2199.4 2200.4 2182.6 2224.0 2225.9 2227.5 2227.5 7836.8 7913.3 7921.8 7927.0 7939.2 4537.1 4654.7 4655.9 4659.4 4664.8 2718.3 2796.7 2841.3 2847.2 2873.5 960.2 989.3 993.0 1002.1 1005.9 10805.7 10829.1 10833.7 10847.3 10888.1 3956.4 4049.4 4188.9 4195.3 4282.9 9231.1 9234.0 9237.8 9249.8 9253.3 4682.7 4694.3 4705.7 4709.1 4709.5 3492.6 3914.7 3995.5 4276.0 4283.6 3539.9 3575.9 3664.7 3687.5 3697.1 1140.7 1168.0 1178.7 1198.3 1203.8 685.4 853.2 860.8 862.5 867.3 5295.0 5322.8 5395.7 5437.0 5440.2 394.1 399.4 407.3 414.7 418.1 3734.8 3797.0 3818.3 3824.3 3919.4 9339.2 9802.2 9816.6 9827.0 9845.4 9201.1 9461.6 9617.6 9748.6 9750.2 7365.2 7536.0 7560.8 7563.6 7564.3 5436.4 5565.7 5613.6 5653.6 5850.6 9099.0 9099.4 9164.6 9249.0 9259.0 9104.8 9142.6 9473.3 9497.0 9597.6 6253.9 6668.5 6965.6 7082.4 7105.0 7495.3 7659.5 7737.2 7744.5 7745.3 6953.2 6991.8 6996.7 7020.3 7221.9 6813.8 6818.2 6818.4 6824.6 6867.3 6478.6 6486.8 6522.5 6580.9 6587.9 4319.9 4445.1 4474.4 4544.8 4577.1 4439.3 4520.3 4562.8 4580.5 4750.3 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#4] prototype.html Cycles:180 Average:4211.32 Median:4800.23 stddev:1217.94 (25.4%) stddev-sans-first:1185.31 14:02:31 INFO - PROCESS | 3932 | Values: 292.6 301.4 306.2 309.0 310.9 4677.2 4801.9 4817.6 4850.8 4858.4 4649.3 4726.7 4798.5 4808.9 4822.3 3844.3 3847.2 3854.3 3855.3 3855.5 3597.8 3654.2 3847.4 3874.5 3875.2 3795.4 3802.4 3807.2 3824.7 3835.7 3780.5 3792.2 3806.0 3811.5 3814.1 3367.0 3369.2 3371.8 3374.1 3389.6 4574.5 4656.5 4711.3 4721.6 4758.6 4277.7 4279.3 4291.8 4316.7 4326.2 5048.3 5049.5 5057.4 5063.0 5068.3 3454.0 3641.6 3650.5 3652.8 3658.4 5280.3 5285.8 5286.6 5292.0 5293.6 3718.3 3721.6 3722.1 3727.5 3735.2 3771.9 3773.7 3780.3 3781.3 3785.6 4185.4 4244.2 4245.0 4248.2 4310.5 5024.6 5034.4 5048.8 5055.3 5067.2 1227.8 1247.4 1248.8 1291.1 1304.4 837.6 858.3 862.7 869.0 890.2 4407.7 4412.1 4417.2 4448.4 4464.5 5077.8 5136.9 5204.1 5212.8 5231.3 4394.0 4415.3 4419.5 4449.5 4454.4 2726.3 2738.0 2739.1 2743.8 2760.6 4774.6 4885.6 4889.9 4910.1 4925.6 5179.9 5203.9 5204.9 5243.4 5273.6 4834.7 4839.6 4842.9 4844.3 4884.9 4950.3 5165.1 5177.1 5184.4 5196.1 5117.3 5120.1 5149.5 5153.3 5186.5 4958.8 4984.3 4991.9 5023.7 5029.5 3643.6 3745.7 3779.3 3780.4 3781.9 5227.0 5240.9 5250.6 5263.6 5264.4 5038.9 5103.4 5142.7 5158.5 5159.7 5021.5 5145.2 5164.8 5165.9 5168.1 4762.7 4823.4 4984.3 5010.2 5016.2 5034.6 5060.2 5069.8 5078.5 5096.2 5014.1 5031.4 5036.7 5041.2 5059.3 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - PROCESS | 3932 | [#5] yui.html Cycles:180 Average:18653.00 Median:4294.93 stddev:27235.92 (634.1%) stddev-sans-first:27278.60 14:02:31 INFO - PROCESS | 3932 | Values: 603.0 624.2 662.4 671.5 713.6 12850.1 13555.8 13953.2 13964.5 14375.1 13300.3 13444.5 13529.1 13563.1 13572.2 633.1 762.8 778.0 778.3 779.0 760.4 797.5 804.3 805.2 807.4 845.7 847.2 848.6 848.7 849.1 645.6 834.9 838.4 838.5 838.5 583.2 598.0 604.0 604.0 604.3 13358.3 13375.5 13375.7 13378.3 13386.3 12230.1 12323.6 12355.2 12372.0 12850.7 12054.7 12145.3 12210.7 12239.9 12403.3 4213.9 4216.3 4251.6 4289.6 4300.3 56213.4 59767.0 61080.7 62597.7 62896.4 9729.7 9931.6 10108.7 10136.2 10246.5 17951.6 18053.6 18060.6 18141.7 18406.4 6764.8 6797.6 6852.1 6970.2 7116.5 3750.1 3766.5 3808.2 3828.9 3925.7 2738.3 2835.2 2839.3 2841.9 2844.2 502.6 515.2 524.3 566.8 606.8 531.4 566.1 567.7 568.7 571.6 7742.4 7979.4 8069.0 8100.9 8209.7 468.5 532.0 548.9 554.6 558.9 3630.6 3711.7 3730.3 3767.6 3793.6 100325.0 107007.5 109151.5 112062.0 112612.0 53038.7 87240.6 93705.5 94112.0 94444.5 59270.7 80466.0 81003.0 82059.0 83657.0 6937.6 7117.4 7143.9 7274.4 7313.2 49182.0 49543.3 49626.5 50919.5 51325.5 64730.0 71960.0 73142.6 74191.0 76946.2 9817.2 10324.2 10849.1 10907.3 11044.1 12868.9 12964.0 13077.6 13441.3 14113.3 13016.4 13122.5 13506.2 13533.2 13565.6 10997.8 11247.6 11248.9 12098.8 12570.6 11929.3 12128.2 12171.3 12644.0 12935.0 10482.8 10535.6 10765.5 10833.5 11183.7 10280.5 10447.2 10522.1 10542.4 10746.4 14:02:31 INFO - PROCESS | 3932 | -------- Summary: end -------- 14:02:31 INFO - PROCESS | 3932 | 14:02:31 INFO - TEST-INFO | 3932: exit 0 14:02:31 INFO - TEST-OK | dromaeo_css | took 1122608ms 14:02:31 INFO - TEST-START | kraken 14:02:31 INFO - operating with platform_type : linux_ 14:02:31 INFO - Initialising browser for kraken test... 14:02:31 INFO - TEST-INFO | started process 4118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxj8Z1/profile http://localhost:55559/getInfo.html) 14:02:36 INFO - PROCESS | 4118 | __metrics Screen width/height:1600/1200 14:02:36 INFO - PROCESS | 4118 | colorDepth:24 14:02:36 INFO - PROCESS | 4118 | Browser inner width/height: 1024/697 14:02:36 INFO - PROCESS | 4118 | __metrics 14:02:36 INFO - PROCESS | 4118 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:02:36 INFO - PROCESS | 4118 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:38 INFO - TEST-INFO | 4118: exit 0 14:02:38 INFO - Browser initialized. 14:02:38 INFO - Running cycle 1/1 for kraken test... 14:02:38 INFO - TEST-INFO | started process 4201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxj8Z1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:50 INFO - PROCESS | 4201 | RSS: Main: 158806016 14:02:50 INFO - PROCESS | 4201 | 14:02:52 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55559/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:53 INFO - PROCESS | 4201 | RSS: Main: 214880256 14:02:53 INFO - PROCESS | 4201 | 14:02:56 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55559/tests/kraken/driver.html?testName=audio-dft) 14:02:57 INFO - PROCESS | 4201 | RSS: Main: 192401408 14:02:57 INFO - PROCESS | 4201 | 14:03:00 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55559/tests/kraken/driver.html?testName=audio-fft) 14:03:00 INFO - PROCESS | 4201 | RSS: Main: 272343040 14:03:00 INFO - PROCESS | 4201 | 14:03:03 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55559/tests/kraken/driver.html?testName=audio-oscillator) 14:03:03 INFO - PROCESS | 4201 | RSS: Main: 181575680 14:03:03 INFO - PROCESS | 4201 | 14:03:05 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:06 INFO - PROCESS | 4201 | RSS: Main: 186290176 14:03:06 INFO - PROCESS | 4201 | 14:03:09 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55559/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:10 INFO - PROCESS | 4201 | RSS: Main: 222433280 14:03:10 INFO - PROCESS | 4201 | 14:03:13 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55559/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:14 INFO - PROCESS | 4201 | RSS: Main: 216612864 14:03:14 INFO - PROCESS | 4201 | 14:03:17 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55559/tests/kraken/driver.html?testName=json-parse-financial) 14:03:17 INFO - PROCESS | 4201 | RSS: Main: 219951104 14:03:17 INFO - PROCESS | 4201 | 14:03:19 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:20 INFO - PROCESS | 4201 | RSS: Main: 185528320 14:03:20 INFO - PROCESS | 4201 | 14:03:22 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:22 INFO - PROCESS | 4201 | RSS: Main: 191004672 14:03:22 INFO - PROCESS | 4201 | 14:03:24 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:25 INFO - PROCESS | 4201 | RSS: Main: 195190784 14:03:25 INFO - PROCESS | 4201 | 14:03:28 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:28 INFO - PROCESS | 4201 | RSS: Main: 189296640 14:03:28 INFO - PROCESS | 4201 | 14:03:31 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:32 INFO - PROCESS | 4201 | RSS: Main: 193769472 14:03:32 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | Cycle 1(1): loaded http://localhost:55559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55559/tests/kraken/driver.html?testName=ai-astar) 14:03:34 INFO - PROCESS | 4201 | RSS: Main: 243912704 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | __start_tp_report 14:03:34 INFO - PROCESS | 4201 | _x_x_mozilla_page_load 14:03:34 INFO - PROCESS | 4201 | _x_x_mozilla_page_load_details 14:03:34 INFO - PROCESS | 4201 | |i|pagename|runs| 14:03:34 INFO - PROCESS | 4201 | |0;ai-astar;104;115;116;113;114;114;113;113;114;114 14:03:34 INFO - PROCESS | 4201 | |1;audio-beat-detection;147;121;139;181;128;144;144;122;194;124 14:03:34 INFO - PROCESS | 4201 | |2;audio-dft;161;161;161;159;162;163;161;163;161;160 14:03:34 INFO - PROCESS | 4201 | |3;audio-fft;74;74;76;106;77;76;76;76;111;76 14:03:34 INFO - PROCESS | 4201 | |4;audio-oscillator;84;87;109;85;85;86;119;84;86;118 14:03:34 INFO - PROCESS | 4201 | |5;imaging-gaussian-blur;117;117;117;116;118;116;117;117;117;117 14:03:34 INFO - PROCESS | 4201 | |6;imaging-darkroom;147;147;147;146;147;146;146;147;146;147 14:03:34 INFO - PROCESS | 4201 | |7;imaging-desaturate;95;95;94;95;95;96;94;95;95;94 14:03:34 INFO - PROCESS | 4201 | |8;json-parse-financial;64;63;63;62;64;64;62;62;62;62 14:03:34 INFO - PROCESS | 4201 | |9;json-stringify-tinderbox;65;67;65;67;66;65;66;65;65;66 14:03:34 INFO - PROCESS | 4201 | |10;stanford-crypto-aes;86;80;79;81;80;79;83;78;79;79 14:03:34 INFO - PROCESS | 4201 | |11;stanford-crypto-ccm;136;138;141;139;133;128;128;130;207;137 14:03:34 INFO - PROCESS | 4201 | |12;stanford-crypto-pbkdf2;162;165;168;171;170;164;169;165;166;161 14:03:34 INFO - PROCESS | 4201 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;73;66;67;65;66 14:03:34 INFO - PROCESS | 4201 | __end_tp_report 14:03:34 INFO - PROCESS | 4201 | __start_cc_report 14:03:34 INFO - PROCESS | 4201 | _x_x_mozilla_cycle_collect,1924 14:03:34 INFO - PROCESS | 4201 | __end_cc_report 14:03:34 INFO - PROCESS | 4201 | __startTimestamp1469048614446__endTimestamp 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | ------- Summary: start ------- 14:03:34 INFO - PROCESS | 4201 | Number of tests: 14 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:1.00 14:03:34 INFO - PROCESS | 4201 | Values: 104.0 115.0 116.0 113.0 114.0 114.0 113.0 113.0 114.0 114.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:144.00 stddev:24.88 (17.3%) stddev-sans-first:26.37 14:03:34 INFO - PROCESS | 4201 | Values: 147.0 121.0 139.0 181.0 128.0 144.0 144.0 122.0 194.0 124.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 14:03:34 INFO - PROCESS | 4201 | Values: 161.0 161.0 161.0 159.0 162.0 163.0 161.0 163.0 161.0 160.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.94 (18.3%) stddev-sans-first:14.47 14:03:34 INFO - PROCESS | 4201 | Values: 74.0 74.0 76.0 106.0 77.0 76.0 76.0 76.0 111.0 76.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:85.00 stddev:14.77 (17.4%) stddev-sans-first:15.19 14:03:34 INFO - PROCESS | 4201 | Values: 84.0 87.0 109.0 85.0 85.0 86.0 119.0 84.0 86.0 118.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:03:34 INFO - PROCESS | 4201 | Values: 117.0 117.0 117.0 116.0 118.0 116.0 117.0 117.0 117.0 117.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:03:34 INFO - PROCESS | 4201 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:03:34 INFO - PROCESS | 4201 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 94.0 95.0 95.0 94.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 14:03:34 INFO - PROCESS | 4201 | Values: 64.0 63.0 63.0 62.0 64.0 64.0 62.0 62.0 62.0 62.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 14:03:34 INFO - PROCESS | 4201 | Values: 65.0 67.0 65.0 67.0 66.0 65.0 66.0 65.0 65.0 66.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.41 (3.0%) stddev-sans-first:1.48 14:03:34 INFO - PROCESS | 4201 | Values: 86.0 80.0 79.0 81.0 80.0 79.0 83.0 78.0 79.0 79.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:137.50 stddev:23.40 (17.0%) stddev-sans-first:24.73 14:03:34 INFO - PROCESS | 4201 | Values: 136.0 138.0 141.0 139.0 133.0 128.0 128.0 130.0 207.0 137.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:167.00 stddev:3.35 (2.0%) stddev-sans-first:3.21 14:03:34 INFO - PROCESS | 4201 | Values: 162.0 165.0 168.0 171.0 170.0 164.0 169.0 165.0 166.0 161.0 14:03:34 INFO - PROCESS | 4201 | 14:03:34 INFO - PROCESS | 4201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.21 (3.3%) stddev-sans-first:2.35 14:03:34 INFO - PROCESS | 4201 | Values: 67.0 66.0 67.0 67.0 66.0 73.0 66.0 67.0 65.0 66.0 14:03:34 INFO - PROCESS | 4201 | -------- Summary: end -------- 14:03:34 INFO - PROCESS | 4201 | 14:03:35 INFO - TEST-INFO | 4201: exit 0 14:03:35 INFO - TEST-OK | kraken | took 63659ms 14:03:35 INFO - SUITE-END | took 1186s 14:03:35 INFO - Completed test suite (00:19:46) 14:03:35 INFO - javascript benchmark 14:03:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.3893784960533, 2598.8700564971746, 2636.4990651776175, 2638.7097419283878, 2643.0220818297234, 4538.795754191061, 4597.701149425294, 4694.906101877965, 4731.455882573501, 4749.40632420947, 4705.058988202365, 4744.928826067603, 4766.78549465274, 4772.57046865782, 4822.035592881429, 4317.266064768989, 4379.321205213197, 4427.247367947441, 4476.820927162909, 4554.817807287721, 4472.731636101828, 4500.954990450103, 4513.684042117053, 4527.298268768346, 4536.56902594253, 4235.237657221699, 4335.826566937319, 4337.739735615842, 4393.868183954486, 4420.381146639473, 4138.544760076389, 4141.855035073758, 4168.2080404723, 4254.042840360925, 4438.866833994953, 4180.184863951531, 4180.24755544002, 4185.100203456272, 4219.156168766228, 4227.492700875884, 4584.15193189261, 4594.19601569724, 4603.49361570227, 4627.375304333906, 4633.189191891405, 5037.194048952187, 5050.191969284897, 5052.949470505285, 5086.567641750456, 5102.846914592531, 5099.33708617881, 5111.539961403491, 5115.104856650071, 5121.769520371555, 5122.462141475166, 4655.557722016403, 4718.551737584924, 4726.5746082852365, 4773.856784296408, 4783.995360974234, 5234.2933703949475, 5263.815766448156, 5269.420363759983, 5303.973480132652, 5314.229436731653, 5039.521245481674, 5056.494350564988, 5057.115004874132, 5103.055934652101, 5109.642325037212, 4979.751012449436, 4980.950190498121, 5064.063148317573, 5091.490850914953, 5176.171812510056, 5039.496050394931, 5058.570021548209, 5069.290299358093, 5071.087204303187, 5101.464346243665, 4998.575121114746, 5020.422651395063, 5022.623303252198, 5028.723420211851, 5075.0, 4267.679924005712, 4308.353746937984, 4309.892252693645, 4366.541513141075, 4430.224710675619, 3773.716971227169, 3789.3368660484307, 3837.4435706822355, 3879.2241551689212, 3912.315344814646, 4441.866743997685, 4453.376527286183, 4459.264221403432, 4460.665450091256, 4514.0, 5152.175651895679, 5163.0, 5190.896182076337, 5200.8959820803375, 5243.449437808975, 4317.0, 4374.475062992461, 4381.452318460192, 4397.274449715825, 4432.711873728197, 4690.273007683814, 4698.765061746899, 4704.85885423431, 4728.38530990969, 4741.83403580873, 4850.53919877611, 4860.829870954571, 4861.440934292602, 4861.871850538701, 4904.386951631046, 4900.8774780630765, 4965.4289756678445, 5098.107831129463, 5104.2088476286235, 5164.819231327036, 4826.6621336506105, 4864.878378040577, 4865.56209941107, 4877.414710234794, 4879.121758083579, 5096.51583099605, 5096.745162741774, 5096.872578185575, 5098.260752190838, 5144.6398752087, 4992.975035124801, 4995.850124496271, 5064.4935506449065, 5171.120909445328, 5187.066328060985, 4932.654714169974, 4940.456549779593, 4945.579625731853, 4971.875703107451, 4992.2761199626575, 4934.703917764946, 4946.15915294408, 4951.084049450863, 4953.083679519301, 4991.051700176955, 4768.260919557474, 4841.467438581823, 4855.6601037927, 4869.756512174448, 4928.8767780805765, 4975.651704380659, 4981.875453113701, 4983.501649834988, 5009.348784657971, 5010.749462526932, 4927.408710954708, 4930.0, 4946.282788995647, 4949.480304568113, 4996.7001979881325], "value": 4675.70053572175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.052527541643, 574.5662025170996, 582.5281521967206, 588.1912370490576, 595.9135925290831, 28766.71233287669, 29234.85382573087, 29272.268193295153, 38420.0, 40307.395389069185, 40261.59738402622, 40754.59245407552, 40797.796011019906, 40808.18383632325, 40815.59184408155, 7809.297163255306, 7984.6007699615075, 7994.720184793533, 7994.840103197933, 7999.520028798262, 7876.251756083191, 7955.681772729084, 7962.562059086777, 7966.6813327467125, 7969.282764551189, 7998.280154786068, 8034.758957231293, 8034.879476807852, 8038.598070096472, 8045.798855028642, 7954.00574928134, 7998.840023199533, 8011.719589814328, 8026.959865200695, 8040.115587285394, 7748.922510774876, 7815.804604884866, 7817.843643127162, 7818.6090695465, 7818.921810781876, 38757.61242387568, 38998.805005975075, 39097.60902390968, 39125.0, 39177.21645567073, 2820.3106012132444, 2974.4794660934467, 3010.548417737357, 3039.6200474940633, 3269.4278501262183, 29690.0, 29734.25664358408, 30093.398132037455, 30264.24339391511, 30521.0, 3265.7877237979455, 3434.158631135363, 3496.160921378876, 3556.8399422026073, 3623.0, 170253.0, 170601.0, 170621.0, 170978.0, 170995.14502427532, 33178.17054573655, 54602.72698636481, 55155.17267240994, 55229.0, 55325.0, 33920.830395847865, 34054.0, 34056.48915266273, 34107.4883876742, 34161.82919085389, 12991.545295914597, 13137.080404371602, 13137.34313284332, 13152.40814163365, 13185.73628527424, 10473.109785668303, 10528.36829790215, 10528.894711052792, 10530.31552949056, 10531.52608132636, 7936.841263174704, 7946.721864734822, 7989.680412783424, 8050.798730031796, 8054.275115239657, 3105.1305634422397, 3108.0675797261183, 3116.7350775184364, 3132.9060128196193, 3212.855421506038, 831.5301854452215, 886.5655828643918, 929.340168480373, 983.7048885334514, 1011.0417714647074, 27126.864365678044, 28173.43653126926, 28804.42391152207, 28937.276568085967, 29249.41501170007, 893.4773157702687, 920.5765347939889, 923.5613083785148, 929.8884133903839, 976.2824324121765, 14720.558383248519, 15263.542093737206, 15338.640440959703, 15457.768133478006, 15576.376944922076, 408133.0, 408769.0, 408779.0, 410278.0, 414378.0, 48243.51756482461, 48994.26508602374, 49027.0, 49099.50900491021, 49227.26159107616, 1072.244067932106, 1128.898399144081, 1166.8016437205526, 1189.7085214122421, 1212.1878341511208, 25732.228033159034, 28800.711992879802, 29664.55503167411, 29706.371357102627, 29897.0, 42735.0, 43034.56965430306, 43193.0, 43239.78380108079, 43303.566964329955, 257860.0, 257870.0, 258126.0, 258499.0, 258787.0, 22438.10247590078, 24470.75529244756, 25199.244022679348, 25371.87314063418, 26041.0, 40706.38940415837, 40999.59000409958, 41045.794771025954, 41230.79384603058, 42113.36829947615, 34938.12654683653, 35313.29373412466, 35776.64223357733, 35824.64175358317, 36349.636503634625, 35406.0, 35560.28879422345, 35570.0, 35573.82213088918, 36054.8197259012, 31948.840255798572, 33513.32973340471, 34358.31283374369, 35366.64633353634, 35440.11399715028, 30526.847365763027, 32595.0, 32655.0, 32754.67245327516, 33008.0, 24513.264602061965, 24742.50514989726, 24800.627990580517, 25081.74918250794, 25364.492710145325], "value": 16147.890601306959, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.0098218114013, 358.2923725641856, 369.34994409838674, 371.9460678201661, 384.7306885180374, 13294.66763330916, 16157.838421615781, 16334.83665163348, 17149.914250428763, 18284.451466456027, 17041.82958170421, 17392.47822565325, 17448.47654570365, 17451.0, 17550.12249387532, 5099.056674515217, 5424.945750542503, 5640.717964101799, 5672.971635141839, 5784.797532086378, 3536.876209332674, 5363.8122665706705, 5665.206871038058, 5690.430956904318, 5697.715114244292, 5625.943740562603, 5692.459216374438, 5708.942910570882, 5710.371859095496, 5715.71421428929, 5450.863728406822, 5599.076152434844, 5620.241267428885, 5704.1443783432405, 5707.37218905918, 3425.075229687995, 5410.161424979135, 5437.429069947638, 5445.646033007842, 5446.809361672362, 11131.554737810478, 11231.157663175212, 12281.570145044881, 12487.875121248853, 12808.231506109663, 1793.1482545790775, 1826.2329821475012, 1973.398113575359, 2019.7374341335678, 2081.9278071793037, 9060.728178154666, 9098.77253068672, 9100.453972761656, 9245.537723113817, 9399.62401503939, 1700.889442186254, 1783.144090836393, 1796.865235107359, 1827.8909407941655, 1913.7416448779516, 46292.0, 57129.42870571324, 60130.398696013355, 70237.0, 70465.0, 9969.351992120633, 9999.600015999424, 10210.0, 10263.0, 10373.688789336182, 14034.228117453435, 14053.367598458093, 14059.507917223053, 14062.71874562503, 14074.929625351808, 7222.241664625244, 7374.078240219973, 7420.925790742023, 7475.990741249971, 7562.621868906533, 6612.305707900698, 6741.898871516931, 6856.177258728984, 7034.8944765828555, 7235.819104522429, 4337.587929146726, 4376.671749618791, 4423.225935461282, 4441.600255976913, 4442.178197033559, 1817.4638481647946, 1826.5251034731066, 1869.8504119670665, 1871.8034606366407, 1920.5992509363296, 803.7387848948998, 843.7384410832661, 890.4746199742183, 952.6134591527187, 955.4267439536361, 16322.75515867263, 17284.481465556055, 17341.913290433466, 17489.825101749073, 17822.0, 857.1428571428571, 857.7512521368733, 863.9740807775777, 870.3559366069189, 882.6415489064044, 9169.862452063224, 9610.807783844284, 9870.457124858201, 9912.35569687968, 9998.450085245382, 394325.0, 396062.0, 399254.0, 418812.0, 419233.0, 81471.0, 83016.58491707624, 83650.0, 84546.57726711327, 85293.57353213319, 807.2049031703767, 818.5211651184125, 821.5194111444753, 822.847773161967, 826.1903334731876, 14846.628834278798, 15122.515094236778, 15540.533783986499, 15672.0, 15863.444779432664, 37061.814690926374, 37396.69111581082, 37702.811485942395, 38848.41727374035, 39543.0, 51592.74203628958, 52586.474135258155, 52744.20883686671, 52849.0, 53007.469925300255, 7286.0, 7456.179820219663, 7477.66350514239, 7540.019797426299, 7737.458377913492, 8995.955020224857, 10532.684019479428, 10912.0, 11005.834912476159, 11467.139964502529, 9799.314048016571, 10580.735481613021, 10669.146468282364, 10718.303310284806, 10832.133429325477, 9953.353032053183, 10130.898691012995, 10254.58981640726, 10477.266591338837, 10525.684229473129, 9641.758956025875, 10252.38485690861, 10290.691279261635, 10322.845157322496, 10805.837912431478, 7672.73145439907, 7714.768556943301, 7748.418868584766, 7770.45606807518, 8062.113167551447, 5629.746661400329, 6944.652767361713, 10710.785784284426, 10841.295315804447, 11134.164937629872], "value": 8078.798905427323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.300601172361, 1372.4167228927704, 1413.201541129262, 1495.86537211651, 1744.2674076887713, 6741.764038258662, 7576.280253375934, 7880.881786773203, 7887.369010479162, 8130.593470326475, 7952.681892724298, 7988.041435027791, 8010.39922005849, 8013.0, 8015.31869791067, 1884.3028079610494, 2151.752548456932, 2187.3765976696604, 2211.8672879627275, 2217.700610417597, 2213.2253711201033, 2247.269637367862, 2251.9324420267417, 2253.50422906961, 2254.0645632062674, 2134.349023547817, 2173.673948907661, 2187.6937228787983, 2191.9890400547974, 2195.4072400451946, 1830.9359172429033, 2082.2607974169105, 2191.485001024758, 2199.3951663292723, 2200.3948914048683, 2182.5853087913247, 2224.021430570544, 2225.9332220033425, 2227.465408302012, 2227.509947811479, 7836.764897053041, 7913.287804097658, 7921.801954951115, 7927.0, 7939.245771651742, 4537.115262523809, 4654.720716757005, 4655.930161047587, 4659.370984917026, 4664.790084446208, 2718.347596576827, 2796.6783819860775, 2841.261272069277, 2847.2170153207826, 2873.454043731684, 960.2462067277154, 989.2531138990016, 992.9851052234222, 1002.0580654185043, 1005.9144972677332, 10805.675829725122, 10829.079528240189, 10833.67498975032, 10847.294925829796, 10888.074513666348, 3956.3669812829808, 4049.3521036633997, 4188.85339013133, 4195.328747400401, 4282.892927676833, 9231.123043310874, 9234.03042680509, 9237.769055773659, 9249.815003700023, 9253.259739220846, 4682.74244916526, 4694.295855621615, 4705.741184234831, 4709.105269998689, 4709.481956984729, 3492.6158122606494, 3914.72596918213, 3995.4805875236034, 4276.0, 4283.550227226158, 3539.8938031859084, 3575.8748443804343, 3664.6518580734787, 3687.483752274684, 3697.0572504011843, 1140.6920131564432, 1168.0305346562334, 1178.7288923547633, 1198.3469009389903, 1203.8134089216185, 685.4345165238599, 853.1511146409363, 860.8364410761935, 862.5471627395542, 867.2844902955087, 5294.97352513235, 5322.787088516493, 5395.703236321961, 5437.0, 5440.183972404171, 394.1407731146129, 399.4208397823168, 407.3157096078557, 414.6848395219595, 418.0593664255425, 3734.7572407793405, 3797.0317569020276, 3818.2745278397015, 3824.349860523718, 3919.431682406035, 9339.159475647224, 9802.215822734164, 9816.558254878548, 9826.950865245772, 9845.409275443353, 9201.125893040151, 9461.621535138655, 9617.615295388247, 9748.561314740853, 9750.171235444925, 7365.189829118793, 7535.962320188473, 7560.8487830244185, 7563.584002880005, 7564.319211270902, 5436.374816896107, 5565.7217139143695, 5613.550915926634, 5653.575981801464, 5850.619709718854, 9099.04460031687, 9099.36304458708, 9164.633414663605, 9249.0, 9259.0, 9104.772380690536, 9142.63429462814, 9473.33686641956, 9496.952515237379, 9597.568109435231, 6253.906191407042, 6668.466522678077, 6965.6168910708375, 7082.433405327459, 7104.964475177591, 7495.325420712162, 7659.502132361378, 7737.187595302637, 7744.49660772048, 7745.302922736981, 6953.1656201254145, 6991.825204369931, 6996.650167491707, 7020.333068358498, 7221.891671624825, 6813.761518346834, 6818.215905170969, 6818.420434263143, 6824.590524568542, 6867.3476019778045, 6478.578892371981, 6486.837829054311, 6522.543421960418, 6580.868382632225, 6587.934120658732, 4319.892002699832, 4445.133199026159, 4474.418325617649, 4544.818207271672, 4577.130345234395, 4439.267520859022, 4520.299353600197, 4562.77186140685, 4580.496145424067, 4750.287456881357], "value": 4100.620279689337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.57722590856224, 301.376151366671, 306.2267773870977, 309.0450507930494, 310.866327479184, 4677.181493238678, 4801.935167877811, 4817.6386770992185, 4850.830220942268, 4858.392700912386, 4649.256119020957, 4726.7400292983875, 4798.520147985199, 4808.879778005552, 4822.276658501218, 3844.2503711776217, 3847.1920896611605, 3854.325493038721, 3855.2867719471847, 3855.51806024247, 3597.8380972856285, 3654.2326111516613, 3847.4228865670234, 3874.5350557932948, 3875.1668391295866, 3795.373763329061, 3802.4106263529197, 3807.2195199984076, 3824.6749026332795, 3835.673967712748, 3780.4707340972286, 3792.1657235408165, 3806.0, 3811.5225103682687, 3814.0846196912817, 3367.0235631666787, 3369.1745522346937, 3371.7639765216445, 3374.1227280906896, 3389.6271410144864, 4574.451065872084, 4656.4645065817185, 4711.293306004092, 4721.5750582447745, 4758.645155165635, 4277.700560960734, 4279.293916503773, 4291.806868690916, 4316.676249281317, 4326.178026175016, 5048.268001139814, 5049.469805670426, 5057.420715435154, 5063.0, 5068.341115654978, 3454.0, 3641.635836416364, 3650.543682039745, 3652.7990960497164, 3658.432942893856, 5280.313559237313, 5285.814996475105, 5286.629935904488, 5291.973540132275, 5293.576513878919, 3718.3121122592406, 3721.5720192178246, 3722.1253005543676, 3727.459518369821, 3735.1969326594913, 3771.905702357463, 3773.716971227114, 3780.2628487444686, 3781.262653782486, 3785.5835858055593, 4185.3931179979345, 4244.151169766059, 4245.0, 4248.214080395137, 4310.525842157423, 5024.62315326352, 5034.421041580192, 5048.798048078036, 5055.317532133188, 5067.162389062063, 1227.8403807505147, 1247.382545639914, 1248.7752204603078, 1291.1155858237137, 1304.3673818198167, 837.6398148796076, 858.3090612057354, 862.6980556805069, 869.0310304010982, 890.247740659142, 4407.713498622579, 4412.0734645724115, 4417.2269852775635, 4448.377227188196, 4464.508904020555, 5077.847664569995, 5136.871578210575, 5204.141316682781, 5212.817551385683, 5231.346081739783, 4394.033312671208, 4415.27148020573, 4419.49175844782, 4449.532799056117, 4454.37638730578, 2726.291164297297, 2738.0422997556443, 2739.068716636353, 2743.7530622243694, 2760.585912113199, 4774.594159496482, 4885.60915126789, 4889.902201955941, 4910.140725373117, 4925.556699897026, 5179.948200518022, 5203.895922081537, 5204.9219261711105, 5243.397009343898, 5273.578113750891, 4834.661573689808, 4839.637027222972, 4842.854714358575, 4844.328706596219, 4884.877878053077, 4950.292149208517, 5165.096108181128, 5177.0940085485645, 5184.351956005499, 5196.116660167705, 5117.2835802986865, 5120.103981803244, 5149.536541711264, 5153.278541004337, 5186.507281808223, 4958.776855041604, 4984.252362145708, 4991.900161996812, 5023.723695196653, 5029.497050294941, 3643.635636436441, 3745.6628903398823, 3779.3197224498754, 3780.3762379208224, 3781.8676346327748, 5227.0, 5240.947590524046, 5250.606204534752, 5263.55252305619, 5264.394359720322, 5038.866255092575, 5103.392431384103, 5142.742862856917, 5158.535731784157, 5159.742012899415, 5021.472745361684, 5145.228215767515, 5164.8192313268855, 5165.870853228699, 5168.121419358643, 4762.690425122356, 4823.3729615149805, 4984.277279794337, 5010.173321401928, 5016.197408414636, 5034.622403319839, 5060.1903695408555, 5069.847904562869, 5078.492150784892, 5096.159133742891, 5014.122528557561, 5031.446540880427, 5036.722980236123, 5041.243813427868, 5059.342285502861], "value": 3823.766476998593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9638221706696, 624.2321944008869, 662.3906006474045, 671.4829581222456, 713.6120246121296, 12850.100492965485, 13555.796663050061, 13953.162810231393, 13964.511242106515, 14375.065620734646, 13300.334983250823, 13444.462221511129, 13529.120607160528, 13563.118397304168, 13572.185668859875, 633.1452539072262, 762.7864198024562, 777.9766607001799, 778.3150827271993, 778.9805254868645, 760.4106817216674, 797.4617133434937, 804.2761514636816, 805.243071512779, 807.4146243973131, 845.7209120990059, 847.1528471528471, 848.6223630484437, 848.6944699908059, 849.1041950741965, 645.6319897658336, 834.9123342049119, 838.367032890167, 838.4675730910885, 838.4801423117675, 583.1922786940077, 597.9611325263844, 603.9879202415927, 604.0245004318039, 604.3261763134118, 13358.265295408748, 13375.464981400732, 13375.732485350238, 13378.331083445886, 13386.263755493444, 12230.082743794252, 12323.568675096418, 12355.196912200769, 12372.0, 12850.742985140338, 12054.734252903494, 12145.332006739625, 12210.694732631666, 12239.877601223963, 12403.317817520032, 4213.894652633678, 4216.304309788881, 4251.574842515754, 4289.571042895716, 4300.2904520754355, 56213.437865621636, 59767.0, 61080.69459652673, 62597.6870115651, 62896.371036289966, 9729.70810875675, 9931.602735890483, 10108.747281318027, 10136.189104871593, 10246.48767561619, 17951.55121121956, 18053.638927221382, 18060.638787224445, 18141.727874081636, 18406.447806565557, 6764.797056088325, 6797.5921444712485, 6852.146500319704, 6970.198427180838, 7116.46626503004, 3750.1187221003042, 3766.5291838520184, 3808.200277941608, 3828.9234215316096, 3925.666318362914, 2738.288045108286, 2835.248659105339, 2839.2901774556362, 2841.9147425577266, 2844.2462747371965, 502.57532385134505, 515.2065818639254, 524.2817340243814, 566.7534622439252, 606.7724603273772, 531.4446403508343, 566.0999011571539, 567.7076305702567, 568.692905830855, 571.5884563114633, 7742.419318551131, 7979.3616510679, 8069.0, 8100.918990810134, 8209.699290101247, 468.5455108544774, 531.9867003324871, 548.8737590354241, 554.5785203245563, 558.8966041282375, 3630.618785027587, 3711.684506816897, 3730.272596843644, 3767.604401537854, 3793.6206379361843, 100324.99675003302, 107007.46496267468, 109151.45424272987, 112062.0, 112612.0, 53038.734806326494, 87240.56379718188, 93705.5314723422, 94112.0004799586, 94444.52777736068, 59270.703646482354, 80466.0, 81003.0, 82059.0, 83656.99999999878, 6937.583744975318, 7117.43060555144, 7143.9285607143265, 7274.381677557467, 7313.158986716596, 49182.0, 49543.256851147984, 49626.503734962185, 50919.490805091475, 51325.48674513207, 64730.0, 71960.0, 73142.63428683035, 74191.0, 76946.2305376939, 9817.165540929102, 10324.22568307365, 10849.132069434268, 10907.345559266469, 11044.06125479311, 12868.935655321664, 12964.0, 13077.607671769862, 13441.327933603085, 14113.2943352834, 13016.414261358072, 13122.540711075066, 13506.153469477507, 13533.188008719508, 13565.59303220905, 10997.780044399227, 11247.5682146954, 11248.887511124783, 12098.818517722066, 12570.62288131321, 11929.28424294545, 12128.151029427856, 12171.2697238166, 12644.0, 12935.0, 10482.790344193227, 10535.578576857146, 10765.461726913467, 10833.458327083772, 11183.664490065312, 10280.537375818256, 10447.216458765472, 10522.1056210223, 10542.367457952547, 10746.355218686904], "value": 6705.6491816950365, "unit": "score"}], "name": "dromaeo_css", "value": 6326.878452789792, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 116.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 139.0, 181.0, 128.0, 144.0, 144.0, 122.0, 194.0, 124.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 162.0, 163.0, 161.0, 163.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 106.0, 77.0, 76.0, 76.0, 76.0, 111.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 109.0, 85.0, 85.0, 86.0, 119.0, 84.0, 86.0, 118.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 64.0, 64.0, 62.0, 62.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 79.0, 81.0, 80.0, 79.0, 83.0, 78.0, 79.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 141.0, 139.0, 133.0, 128.0, 128.0, 130.0, 207.0, 137.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 168.0, 171.0, 170.0, 164.0, 169.0, 165.0, 166.0, 161.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 73.0, 66.0, 67.0, 65.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1537.1, "alertThreshold": 2.0}]} 14:03:35 INFO - Return code: 0 14:03:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:03:35 INFO - # TBPL SUCCESS # 14:03:35 INFO - Running post-action listener: _resource_record_post_action 14:03:35 INFO - [mozharness: 2016-07-20 21:03:35.730708Z] Finished run-tests step (success) 14:03:35 INFO - Running post-run listener: _resource_record_post_run 14:03:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 430080; Write bytes: 309477376; Read time: 52; Write time: 250300 14:03:35 INFO - TinderboxPrint: CPU usage
13.0% 14:03:35 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 52 14:03:35 INFO - TinderboxPrint: I/O write bytes / time
309,477,376 / 250,300 14:03:35 INFO - TinderboxPrint: CPU idle
8,357.7 (87.0%) 14:03:35 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 14:03:35 INFO - TinderboxPrint: Swap in / out
0 / 0 14:03:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 24416256; Read time: 0; Write time: 40264 14:03:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 425984; Write bytes: 285061120; Read time: 44; Write time: 210036 14:03:36 INFO - Running post-run listener: _upload_blobber_files 14:03:36 INFO - Blob upload gear active. 14:03:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:03:36 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 14:03:36 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'] 14:03:36 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 14:03:36 INFO - (blobuploader) - INFO - Open directory for files ... 14:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:42 INFO - (blobuploader) - INFO - Done attempting. 14:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:43 INFO - (blobuploader) - INFO - Done attempting. 14:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:44 INFO - (blobuploader) - INFO - Done attempting. 14:03:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:03:44 INFO - Return code: 0 14:03:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:03:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:03:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/50446b61eb143e1f886ae69531592176e07fc537883db38683aca6caff73ea671f9a7e9985fd5e4de6545af6129f44585d85806f80f8365df4a72b1bf29b091f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/570eec349a1737568f19b1ce3906aba15119e69de7714249a37f971f5c6241c489111f53d6dcdc6bbbde79e5e2ea83ce8c5f45f26f766adfaa04d83be44b1291", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44a21ae421fb555933918f25f78a8ec9079bc14eb1beaa9186eed2a5539883745d8b2631fe760bba2e75e0f9b62fb924e4c7383df0d4459e2365d6b9abc84b5"} 14:03:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:03:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:03:44 INFO - Contents: 14:03:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/50446b61eb143e1f886ae69531592176e07fc537883db38683aca6caff73ea671f9a7e9985fd5e4de6545af6129f44585d85806f80f8365df4a72b1bf29b091f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/570eec349a1737568f19b1ce3906aba15119e69de7714249a37f971f5c6241c489111f53d6dcdc6bbbde79e5e2ea83ce8c5f45f26f766adfaa04d83be44b1291", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44a21ae421fb555933918f25f78a8ec9079bc14eb1beaa9186eed2a5539883745d8b2631fe760bba2e75e0f9b62fb924e4c7383df0d4459e2365d6b9abc84b5"} 14:03:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:03:44 INFO - Copying logs to upload dir... 14:03:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:03:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.807102 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-20 14:03:44.494276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:03:44.497411) ========= 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=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/50446b61eb143e1f886ae69531592176e07fc537883db38683aca6caff73ea671f9a7e9985fd5e4de6545af6129f44585d85806f80f8365df4a72b1bf29b091f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/570eec349a1737568f19b1ce3906aba15119e69de7714249a37f971f5c6241c489111f53d6dcdc6bbbde79e5e2ea83ce8c5f45f26f766adfaa04d83be44b1291", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44a21ae421fb555933918f25f78a8ec9079bc14eb1beaa9186eed2a5539883745d8b2631fe760bba2e75e0f9b62fb924e4c7383df0d4459e2365d6b9abc84b5"} build_url:https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/McdPEUGVRsWe4m_m4grTXg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/50446b61eb143e1f886ae69531592176e07fc537883db38683aca6caff73ea671f9a7e9985fd5e4de6545af6129f44585d85806f80f8365df4a72b1bf29b091f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/570eec349a1737568f19b1ce3906aba15119e69de7714249a37f971f5c6241c489111f53d6dcdc6bbbde79e5e2ea83ce8c5f45f26f766adfaa04d83be44b1291", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44a21ae421fb555933918f25f78a8ec9079bc14eb1beaa9186eed2a5539883745d8b2631fe760bba2e75e0f9b62fb924e4c7383df0d4459e2365d6b9abc84b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:03:44.524843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:03:44.525206) ========= 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=523ca41ca1e0623de333ad52000001bf-1469047377.809932-1811169875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:03:44.610175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:03:44.610881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:03:44.611636) ========= ========= Total master_lag: 0.16 =========