builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1474897795.17 results: success (0) buildid: 20160926045950 builduid: ba048a48e0a34b00bf17855d1a306d64 revision: 3c4ca5845f2c12974cad7617efe5f12137603721 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.168774) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.169143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.169410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.194908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.195159) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 06:49:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.8M=0s 2016-09-26 06:49:56 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118716 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.329157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.329447) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.379342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:55.379706) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3c4ca5845f2c12974cad7617efe5f12137603721 --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 3c4ca5845f2c12974cad7617efe5f12137603721 --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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 06:49:56,601 truncating revision to first 12 chars 2016-09-26 06:49:56,601 Setting DEBUG logging. 2016-09-26 06:49:56,601 attempt 1/10 2016-09-26 06:49:56,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3c4ca5845f2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 06:49:56,912 unpacking tar archive at: autoland-3c4ca5845f2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:56.113490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:56.113797) ========= script_repo_revision: 3c4ca5845f2c12974cad7617efe5f12137603721 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:56.114186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:56.114447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 06:49:56.123776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-26 06:49:56.124063) ========= /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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:57 INFO - MultiFileLogger online at 20160926 06:49:57 in /builds/slave/test 06:49:57 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 06:49:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:57 INFO - {'append_to_log': False, 06:49:57 INFO - 'base_work_dir': '/builds/slave/test', 06:49:57 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:49:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:57 INFO - 'branch': 'Autoland-Non-PGO', 06:49:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:57 INFO - 'config_files': ('talos/linux_config.py',), 06:49:57 INFO - 'default_actions': ('clobber', 06:49:57 INFO - 'read-buildbot-config', 06:49:57 INFO - 'download-and-extract', 06:49:57 INFO - 'populate-webroot', 06:49:57 INFO - 'create-virtualenv', 06:49:57 INFO - 'install', 06:49:57 INFO - 'run-tests'), 06:49:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:57 INFO - 'download_minidump_stackwalk': True, 06:49:57 INFO - 'download_symbols': 'ondemand', 06:49:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:57 INFO - 'installer_path': 'installer.exe', 06:49:57 INFO - 'log_level': 'info', 06:49:57 INFO - 'log_name': 'talos', 06:49:57 INFO - 'log_to_console': True, 06:49:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:57 INFO - 'opt_config_files': (), 06:49:57 INFO - 'pip_index': False, 06:49:57 INFO - 'sps_profile': False, 06:49:57 INFO - 'sps_profile_interval': 0, 06:49:57 INFO - 'suite': 'dromaeojs', 06:49:57 INFO - 'system_bits': '32', 06:49:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:57 INFO - 'title': 'talos-linux64-ix-023', 06:49:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:57 INFO - 'use_talos_json': True, 06:49:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:57 INFO - 'work_dir': 'build'} 06:49:57 INFO - [mozharness: 2016-09-26 13:49:57.430487Z] Running clobber step. 06:49:57 INFO - Running pre-action listener: _resource_record_pre_action 06:49:57 INFO - Running main action method: clobber 06:49:57 INFO - rmtree: /builds/slave/test/build 06:49:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:57 INFO - Running post-action listener: _resource_record_post_action 06:49:57 INFO - [mozharness: 2016-09-26 13:49:57.883882Z] Finished clobber step (success) 06:49:57 INFO - [mozharness: 2016-09-26 13:49:57.883981Z] Running read-buildbot-config step. 06:49:57 INFO - Running pre-action listener: _resource_record_pre_action 06:49:57 INFO - Running main action method: read_buildbot_config 06:49:57 INFO - Using buildbot properties: 06:49:57 INFO - { 06:49:57 INFO - "project": "", 06:49:57 INFO - "product": "firefox", 06:49:57 INFO - "script_repo_revision": "production", 06:49:57 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:49:57 INFO - "repository": "", 06:49:57 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 06:49:57 INFO - "buildid": "20160926045950", 06:49:57 INFO - "pgo_build": "False", 06:49:57 INFO - "basedir": "/builds/slave/test", 06:49:57 INFO - "buildnumber": 710, 06:49:57 INFO - "slavename": "talos-linux64-ix-023", 06:49:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:49:57 INFO - "platform": "ubuntu64_hw", 06:49:57 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 06:49:57 INFO - "branch": "autoland", 06:49:57 INFO - "repo_path": "integration/autoland", 06:49:57 INFO - "revision": "3c4ca5845f2c12974cad7617efe5f12137603721", 06:49:57 INFO - "stage_platform": "linux64", 06:49:57 INFO - "builduid": "ba048a48e0a34b00bf17855d1a306d64", 06:49:57 INFO - "slavebuilddir": "test" 06:49:57 INFO - } 06:49:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:49:57 INFO - Running post-action listener: _resource_record_post_action 06:49:57 INFO - [mozharness: 2016-09-26 13:49:57.886418Z] Finished read-buildbot-config step (success) 06:49:57 INFO - [mozharness: 2016-09-26 13:49:57.886505Z] Running download-and-extract step. 06:49:57 INFO - Running pre-action listener: _resource_record_pre_action 06:49:57 INFO - Running main action method: download_and_extract 06:49:57 INFO - mkdir: /builds/slave/test/build/tests 06:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:57 INFO - trying https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:49:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:49:58 INFO - Downloaded 1361 bytes. 06:49:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:49:58 INFO - Using the following test package requirements: 06:49:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:49:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'jsshell-linux-x86_64.zip'], 06:49:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:49:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:49:59 INFO - Expected file size: 20410868 06:50:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:50:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:50:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:50:03 INFO - Fetch https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:50:04 INFO - Expected file size: 20410868 06:50:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:50:09 INFO - Fetch https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:50:09 INFO - Expected file size: 14414057 06:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:10 INFO - trying https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:50:10 INFO - Downloading https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:50:12 INFO - Downloaded 55743217 bytes. 06:50:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:50:12 INFO - mkdir: /builds/slave/test/properties 06:50:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:12 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:12 INFO - Contents: 06:50:12 INFO - build_url:https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:50:14 INFO - Running post-action listener: _resource_record_post_action 06:50:14 INFO - Running post-action listener: set_extra_try_arguments 06:50:14 INFO - [mozharness: 2016-09-26 13:50:14.366071Z] Finished download-and-extract step (success) 06:50:14 INFO - [mozharness: 2016-09-26 13:50:14.366297Z] Running populate-webroot step. 06:50:14 INFO - Running pre-action listener: _resource_record_pre_action 06:50:14 INFO - Running main action method: populate_webroot 06:50:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:14 INFO - '--tppagecycles', 06:50:14 INFO - '7'], 06:50:14 INFO - 'tests': ['tsvgm']}}, 06:50:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:50:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:50:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['damp', 'tps']}, 06:50:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'tests': ['damp', 'tps']}, 06:50:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['dromaeo_dom']}, 06:50:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['basic_compositor_video']}, 06:50:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:50:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['a11yr', 06:50:14 INFO - 'ts_paint', 06:50:14 INFO - 'tpaint', 06:50:14 INFO - 'sessionrestore', 06:50:14 INFO - 'sessionrestore_no_auto_restore', 06:50:14 INFO - 'tabpaint']}, 06:50:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['tsvgx', 06:50:14 INFO - 'tsvgr_opacity', 06:50:14 INFO - 'tart', 06:50:14 INFO - 'tscrollx', 06:50:14 INFO - 'cart']}, 06:50:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:50:14 INFO - 'tsvgr_opacity', 06:50:14 INFO - 'tart', 06:50:14 INFO - 'tscrollx', 06:50:14 INFO - 'cart']}, 06:50:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'talos_options': ['--disable-e10s'], 06:50:14 INFO - 'tests': ['tp5o']}, 06:50:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'tests': ['tp5o']}, 06:50:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'talos_options': ['--disable-e10s', 06:50:14 INFO - '--xperf_path', 06:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:14 INFO - 'tests': ['tp5n']}, 06:50:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:14 INFO - 'talos_options': ['--xperf_path', 06:50:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:14 INFO - 'tests': ['tp5n']}}, 06:50:14 INFO - 'talos.zip': {'path': '', 06:50:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:14 INFO - Running post-action listener: _resource_record_post_action 06:50:14 INFO - [mozharness: 2016-09-26 13:50:14.382149Z] Finished populate-webroot step (success) 06:50:14 INFO - [mozharness: 2016-09-26 13:50:14.382237Z] Running create-virtualenv step. 06:50:14 INFO - Running pre-action listener: _resource_record_pre_action 06:50:14 INFO - Running main action method: create_virtualenv 06:50:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:14 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 06:50:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:14 INFO - Using real prefix '/usr' 06:50:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:16 INFO - Installing pip.................done. 06:50:16 INFO - Return code: 0 06:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:50:17 INFO - Reading from file tmpfile_stdout 06:50:17 INFO - Output received: 06:50:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:50:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:17 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 06:50:17 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 06:50:17 INFO - Using env: {'DISPLAY': ':0', 06:50:17 INFO - 'HOME': '/home/cltbld', 06:50:17 INFO - 'LANG': 'en_US.UTF-8', 06:50:17 INFO - 'LANGUAGE': 'en_US:en', 06:50:17 INFO - 'LOGNAME': 'cltbld', 06:50:17 INFO - 'MAIL': '/var/mail/cltbld', 06:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:17 INFO - 'MOZ_NO_REMOTE': '1', 06:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:17 INFO - 'NO_EM_RESTART': '1', 06:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:17 INFO - 'PWD': '/builds/slave/test', 06:50:17 INFO - 'SHELL': '/bin/bash', 06:50:17 INFO - 'SHLVL': '1', 06:50:17 INFO - 'TERM': 'linux', 06:50:17 INFO - 'TMOUT': '86400', 06:50:17 INFO - 'USER': 'cltbld', 06:50:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:17 INFO - '_': '/tools/buildbot/bin/python'} 06:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:17 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 06:50:17 INFO - Cleaning up... 06:50:17 INFO - Return code: 0 06:50:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:17 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 06:50:17 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 06:50:17 INFO - Using env: {'DISPLAY': ':0', 06:50:17 INFO - 'HOME': '/home/cltbld', 06:50:17 INFO - 'LANG': 'en_US.UTF-8', 06:50:17 INFO - 'LANGUAGE': 'en_US:en', 06:50:17 INFO - 'LOGNAME': 'cltbld', 06:50:17 INFO - 'MAIL': '/var/mail/cltbld', 06:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:17 INFO - 'MOZ_NO_REMOTE': '1', 06:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:17 INFO - 'NO_EM_RESTART': '1', 06:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:17 INFO - 'PWD': '/builds/slave/test', 06:50:17 INFO - 'SHELL': '/bin/bash', 06:50:17 INFO - 'SHLVL': '1', 06:50:17 INFO - 'TERM': 'linux', 06:50:17 INFO - 'TMOUT': '86400', 06:50:17 INFO - 'USER': 'cltbld', 06:50:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:17 INFO - '_': '/tools/buildbot/bin/python'} 06:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:17 INFO - Downloading/unpacking psutil>=3.1.1 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:19 INFO - Installing collected packages: psutil 06:50:19 INFO - Running setup.py install for psutil 06:50:19 INFO - building 'psutil._psutil_linux' extension 06:50:19 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 06:50:19 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 06:50:19 INFO - building 'psutil._psutil_posix' extension 06:50:19 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 06:50:19 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 06:50:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:20 INFO - Successfully installed psutil 06:50:20 INFO - Cleaning up... 06:50:20 INFO - Return code: 0 06:50:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:20 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:20 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 06:50:20 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 06:50:20 INFO - Using env: {'DISPLAY': ':0', 06:50:20 INFO - 'HOME': '/home/cltbld', 06:50:20 INFO - 'LANG': 'en_US.UTF-8', 06:50:20 INFO - 'LANGUAGE': 'en_US:en', 06:50:20 INFO - 'LOGNAME': 'cltbld', 06:50:20 INFO - 'MAIL': '/var/mail/cltbld', 06:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:20 INFO - 'MOZ_NO_REMOTE': '1', 06:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:20 INFO - 'NO_EM_RESTART': '1', 06:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:20 INFO - 'PWD': '/builds/slave/test', 06:50:20 INFO - 'SHELL': '/bin/bash', 06:50:20 INFO - 'SHLVL': '1', 06:50:20 INFO - 'TERM': 'linux', 06:50:20 INFO - 'TMOUT': '86400', 06:50:20 INFO - 'USER': 'cltbld', 06:50:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:20 INFO - '_': '/tools/buildbot/bin/python'} 06:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:50:22 INFO - Installing collected packages: mozsystemmonitor 06:50:22 INFO - Running setup.py install for mozsystemmonitor 06:50:22 INFO - Successfully installed mozsystemmonitor 06:50:22 INFO - Cleaning up... 06:50:22 INFO - Return code: 0 06:50:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:22 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:22 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 06:50:22 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 06:50:22 INFO - Using env: {'DISPLAY': ':0', 06:50:22 INFO - 'HOME': '/home/cltbld', 06:50:22 INFO - 'LANG': 'en_US.UTF-8', 06:50:22 INFO - 'LANGUAGE': 'en_US:en', 06:50:22 INFO - 'LOGNAME': 'cltbld', 06:50:22 INFO - 'MAIL': '/var/mail/cltbld', 06:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:22 INFO - 'MOZ_NO_REMOTE': '1', 06:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:22 INFO - 'NO_EM_RESTART': '1', 06:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:22 INFO - 'PWD': '/builds/slave/test', 06:50:22 INFO - 'SHELL': '/bin/bash', 06:50:22 INFO - 'SHLVL': '1', 06:50:22 INFO - 'TERM': 'linux', 06:50:22 INFO - 'TMOUT': '86400', 06:50:22 INFO - 'USER': 'cltbld', 06:50:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:22 INFO - '_': '/tools/buildbot/bin/python'} 06:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:24 INFO - warning: no files found matching '*.txt' 06:50:24 INFO - no previously-included directories found matching 'build' 06:50:24 INFO - no previously-included directories found matching 'dist' 06:50:24 INFO - no previously-included directories found matching '.git*' 06:50:24 INFO - Installing collected packages: jsonschema, functools32 06:50:24 INFO - Running setup.py install for functools32 06:50:24 INFO - warning: no files found matching '*.txt' 06:50:24 INFO - no previously-included directories found matching 'build' 06:50:24 INFO - no previously-included directories found matching 'dist' 06:50:24 INFO - no previously-included directories found matching '.git*' 06:50:24 INFO - Successfully installed jsonschema functools32 06:50:24 INFO - Cleaning up... 06:50:25 INFO - Return code: 0 06:50:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:50:25 INFO - Using env: {'DISPLAY': ':0', 06:50:25 INFO - 'HOME': '/home/cltbld', 06:50:25 INFO - 'LANG': 'en_US.UTF-8', 06:50:25 INFO - 'LANGUAGE': 'en_US:en', 06:50:25 INFO - 'LOGNAME': 'cltbld', 06:50:25 INFO - 'MAIL': '/var/mail/cltbld', 06:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:25 INFO - 'MOZ_NO_REMOTE': '1', 06:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:25 INFO - 'NO_EM_RESTART': '1', 06:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:25 INFO - 'PWD': '/builds/slave/test', 06:50:25 INFO - 'SHELL': '/bin/bash', 06:50:25 INFO - 'SHLVL': '1', 06:50:25 INFO - 'TERM': 'linux', 06:50:25 INFO - 'TMOUT': '86400', 06:50:25 INFO - 'USER': 'cltbld', 06:50:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:25 INFO - '_': '/tools/buildbot/bin/python'} 06:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:50:25 INFO - Cleaning up... 06:50:25 INFO - Return code: 0 06:50:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:25 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:25 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 06:50:25 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 06:50:25 INFO - Using env: {'DISPLAY': ':0', 06:50:25 INFO - 'HOME': '/home/cltbld', 06:50:25 INFO - 'LANG': 'en_US.UTF-8', 06:50:25 INFO - 'LANGUAGE': 'en_US:en', 06:50:25 INFO - 'LOGNAME': 'cltbld', 06:50:25 INFO - 'MAIL': '/var/mail/cltbld', 06:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:25 INFO - 'MOZ_NO_REMOTE': '1', 06:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:25 INFO - 'NO_EM_RESTART': '1', 06:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:25 INFO - 'PWD': '/builds/slave/test', 06:50:25 INFO - 'SHELL': '/bin/bash', 06:50:25 INFO - 'SHLVL': '1', 06:50:25 INFO - 'TERM': 'linux', 06:50:25 INFO - 'TMOUT': '86400', 06:50:25 INFO - 'USER': 'cltbld', 06:50:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:25 INFO - '_': '/tools/buildbot/bin/python'} 06:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:25 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 06:50:25 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 06:50:25 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 06:50:25 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 06:50:25 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 06:50:25 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 06:50:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:27 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 06:50:28 INFO - Downloading docopt-0.6.1.tar.gz 06:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:28 INFO - Running setup.py install for blobuploader 06:50:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:28 INFO - Running setup.py install for requests 06:50:28 INFO - Running setup.py install for docopt 06:50:28 INFO - Successfully installed blobuploader requests docopt 06:50:28 INFO - Cleaning up... 06:50:28 INFO - Return code: 0 06:50:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:28 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:28 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 06:50:28 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 06:50:28 INFO - Using env: {'DISPLAY': ':0', 06:50:28 INFO - 'HOME': '/home/cltbld', 06:50:28 INFO - 'LANG': 'en_US.UTF-8', 06:50:28 INFO - 'LANGUAGE': 'en_US:en', 06:50:28 INFO - 'LOGNAME': 'cltbld', 06:50:28 INFO - 'MAIL': '/var/mail/cltbld', 06:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:28 INFO - 'MOZ_NO_REMOTE': '1', 06:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:28 INFO - 'NO_EM_RESTART': '1', 06:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:28 INFO - 'PWD': '/builds/slave/test', 06:50:28 INFO - 'SHELL': '/bin/bash', 06:50:28 INFO - 'SHLVL': '1', 06:50:28 INFO - 'TERM': 'linux', 06:50:28 INFO - 'TMOUT': '86400', 06:50:28 INFO - 'USER': 'cltbld', 06:50:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:28 INFO - '_': '/tools/buildbot/bin/python'} 06:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:28 INFO - Running setup.py (path:/tmp/pip-E9Vsm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:29 INFO - Running setup.py (path:/tmp/pip-6bbzXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:29 INFO - Running setup.py (path:/tmp/pip-wsfP3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:29 INFO - Running setup.py (path:/tmp/pip-5Nfu0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:29 INFO - Running setup.py (path:/tmp/pip-Pl1UqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:29 INFO - Running setup.py (path:/tmp/pip-U7XaZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:29 INFO - Running setup.py (path:/tmp/pip-7bqQdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:29 INFO - Running setup.py (path:/tmp/pip-_0r8OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:29 INFO - Running setup.py (path:/tmp/pip-wzOJte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:29 INFO - Running setup.py (path:/tmp/pip-cy9pfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:29 INFO - Running setup.py (path:/tmp/pip-g2m3LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:29 INFO - Running setup.py (path:/tmp/pip-6fVFqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:29 INFO - Running setup.py (path:/tmp/pip-AI7EQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:29 INFO - Running setup.py (path:/tmp/pip-edJYAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:29 INFO - Running setup.py (path:/tmp/pip-CAbZ2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:30 INFO - Running setup.py (path:/tmp/pip-Q1jBxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:30 INFO - Running setup.py (path:/tmp/pip-TFJZg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:30 INFO - Running setup.py install for manifestparser 06:50:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Running setup.py install for mozcrash 06:50:30 INFO - Running setup.py install for mozdebug 06:50:30 INFO - Running setup.py install for mozdevice 06:50:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Running setup.py install for mozfile 06:50:30 INFO - Running setup.py install for mozhttpd 06:50:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Running setup.py install for mozinfo 06:50:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Running setup.py install for mozInstall 06:50:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:30 INFO - Running setup.py install for mozleak 06:50:31 INFO - Running setup.py install for mozlog 06:50:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Running setup.py install for moznetwork 06:50:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Running setup.py install for mozprocess 06:50:31 INFO - Running setup.py install for mozprofile 06:50:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Running setup.py install for mozrunner 06:50:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Running setup.py install for mozscreenshot 06:50:31 INFO - Running setup.py install for moztest 06:50:31 INFO - Running setup.py install for mozversion 06:50:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:31 INFO - Cleaning up... 06:50:31 INFO - Return code: 0 06:50:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:31 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:31 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 06:50:31 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 06:50:31 INFO - Using env: {'DISPLAY': ':0', 06:50:31 INFO - 'HOME': '/home/cltbld', 06:50:31 INFO - 'LANG': 'en_US.UTF-8', 06:50:31 INFO - 'LANGUAGE': 'en_US:en', 06:50:31 INFO - 'LOGNAME': 'cltbld', 06:50:31 INFO - 'MAIL': '/var/mail/cltbld', 06:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:31 INFO - 'MOZ_NO_REMOTE': '1', 06:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:31 INFO - 'NO_EM_RESTART': '1', 06:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:31 INFO - 'PWD': '/builds/slave/test', 06:50:31 INFO - 'SHELL': '/bin/bash', 06:50:31 INFO - 'SHLVL': '1', 06:50:31 INFO - 'TERM': 'linux', 06:50:31 INFO - 'TMOUT': '86400', 06:50:31 INFO - 'USER': 'cltbld', 06:50:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:31 INFO - '_': '/tools/buildbot/bin/python'} 06:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:32 INFO - Running setup.py (path:/tmp/pip-n5xOg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:32 INFO - Running setup.py (path:/tmp/pip-NHYqPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:32 INFO - Running setup.py (path:/tmp/pip-mGf95y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:32 INFO - Running setup.py (path:/tmp/pip-SfUcsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:32 INFO - Running setup.py (path:/tmp/pip-oYdcXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:32 INFO - Running setup.py (path:/tmp/pip-Z2mNUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:32 INFO - Running setup.py (path:/tmp/pip-a_Kaxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:32 INFO - Running setup.py (path:/tmp/pip-fBzvLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:32 INFO - Running setup.py (path:/tmp/pip-4h7Wa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:32 INFO - Running setup.py (path:/tmp/pip-6MMCM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:32 INFO - Running setup.py (path:/tmp/pip-O87h2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:32 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)) 06:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:32 INFO - Running setup.py (path:/tmp/pip-v7ooiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:33 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)) 06:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:33 INFO - Running setup.py (path:/tmp/pip-f2lMQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:33 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)) 06:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:33 INFO - Running setup.py (path:/tmp/pip-4ovjG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:33 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)) 06:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:33 INFO - Running setup.py (path:/tmp/pip-tBv82A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:33 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)) 06:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:33 INFO - Running setup.py (path:/tmp/pip-WHyyzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:33 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)) 06:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:33 INFO - Running setup.py (path:/tmp/pip-0VuNyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:33 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)) 06:50:33 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)) 06:50:33 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)) 06:50:33 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)) 06:50:33 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)) 06:50:33 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)) 06:50:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:33 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 06:50:33 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 06:50:33 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 06:50:33 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 06:50:33 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 06:50:33 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 06:50:35 INFO - Downloading blessings-1.6.tar.gz 06:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:35 INFO - Installing collected packages: blessings 06:50:35 INFO - Running setup.py install for blessings 06:50:35 INFO - Successfully installed blessings 06:50:35 INFO - Cleaning up... 06:50:35 INFO - Return code: 0 06:50:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:35 INFO - Reading from file tmpfile_stdout 06:50:35 INFO - Current package versions: 06:50:35 INFO - argparse == 1.2.1 06:50:35 INFO - blessings == 1.6 06:50:35 INFO - blobuploader == 1.2.4 06:50:35 INFO - docopt == 0.6.1 06:50:35 INFO - functools32 == 3.2.3-2 06:50:35 INFO - jsonschema == 2.5.1 06:50:35 INFO - manifestparser == 1.1 06:50:35 INFO - mozInstall == 1.12 06:50:35 INFO - mozcrash == 0.17 06:50:35 INFO - mozdebug == 0.1 06:50:35 INFO - mozdevice == 0.48 06:50:35 INFO - mozfile == 1.2 06:50:35 INFO - mozhttpd == 0.7 06:50:35 INFO - mozinfo == 0.9 06:50:35 INFO - mozleak == 0.1 06:50:35 INFO - mozlog == 3.4 06:50:35 INFO - moznetwork == 0.27 06:50:35 INFO - mozprocess == 0.23 06:50:35 INFO - mozprofile == 0.28 06:50:35 INFO - mozrunner == 6.12 06:50:35 INFO - mozscreenshot == 0.1 06:50:35 INFO - mozsystemmonitor == 0.3 06:50:35 INFO - moztest == 0.7 06:50:35 INFO - mozversion == 1.4 06:50:35 INFO - psutil == 3.1.1 06:50:35 INFO - requests == 1.2.3 06:50:35 INFO - wsgiref == 0.1.2 06:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:35 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:35 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 06:50:35 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 06:50:35 INFO - Using env: {'DISPLAY': ':0', 06:50:35 INFO - 'HOME': '/home/cltbld', 06:50:35 INFO - 'LANG': 'en_US.UTF-8', 06:50:35 INFO - 'LANGUAGE': 'en_US:en', 06:50:35 INFO - 'LOGNAME': 'cltbld', 06:50:35 INFO - 'MAIL': '/var/mail/cltbld', 06:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:35 INFO - 'MOZ_NO_REMOTE': '1', 06:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:35 INFO - 'NO_EM_RESTART': '1', 06:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:35 INFO - 'PWD': '/builds/slave/test', 06:50:35 INFO - 'SHELL': '/bin/bash', 06:50:35 INFO - 'SHLVL': '1', 06:50:35 INFO - 'TERM': 'linux', 06:50:35 INFO - 'TMOUT': '86400', 06:50:35 INFO - 'USER': 'cltbld', 06:50:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:35 INFO - '_': '/tools/buildbot/bin/python'} 06:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 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)) 06:50:35 INFO - Cleaning up... 06:50:35 INFO - Return code: 0 06:50:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:35 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 0x7f8183ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', '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 06:50:35 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 06:50:35 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 06:50:35 INFO - Using env: {'DISPLAY': ':0', 06:50:35 INFO - 'HOME': '/home/cltbld', 06:50:35 INFO - 'LANG': 'en_US.UTF-8', 06:50:35 INFO - 'LANGUAGE': 'en_US:en', 06:50:35 INFO - 'LOGNAME': 'cltbld', 06:50:35 INFO - 'MAIL': '/var/mail/cltbld', 06:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:35 INFO - 'MOZ_NO_REMOTE': '1', 06:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:35 INFO - 'NO_EM_RESTART': '1', 06:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:35 INFO - 'PWD': '/builds/slave/test', 06:50:35 INFO - 'SHELL': '/bin/bash', 06:50:35 INFO - 'SHLVL': '1', 06:50:35 INFO - 'TERM': 'linux', 06:50:35 INFO - 'TMOUT': '86400', 06:50:35 INFO - 'USER': 'cltbld', 06:50:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:35 INFO - '_': '/tools/buildbot/bin/python'} 06:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:50:36 INFO - Cleaning up... 06:50:36 INFO - Return code: 0 06:50:36 INFO - Running post-action listener: _resource_record_post_action 06:50:36 INFO - Running post-action listener: _start_resource_monitoring 06:50:36 INFO - Starting resource monitoring. 06:50:36 INFO - [mozharness: 2016-09-26 13:50:36.202420Z] Finished create-virtualenv step (success) 06:50:36 INFO - [mozharness: 2016-09-26 13:50:36.202944Z] Running install step. 06:50:36 INFO - Running pre-action listener: _resource_record_pre_action 06:50:36 INFO - Running main action method: install 06:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:36 INFO - Reading from file tmpfile_stdout 06:50:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:36 INFO - Reading from file tmpfile_stdout 06:50:36 INFO - Output received: 06:50:36 INFO - Usage: mozinstall [options] installer 06:50:36 INFO - Options: 06:50:36 INFO - -h, --help show this help message and exit 06:50:36 INFO - -d DEST, --destination=DEST 06:50:36 INFO - Directory to install application into. [default: 06:50:36 INFO - "/builds/slave/test"] 06:50:36 INFO - --app=APP Application being installed. [default: firefox] 06:50:36 INFO - mkdir: /builds/slave/test/build/application 06:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:50:52 INFO - Reading from file tmpfile_stdout 06:50:52 INFO - Output received: 06:50:52 INFO - /builds/slave/test/build/application/firefox/firefox 06:50:52 INFO - Running post-action listener: _resource_record_post_action 06:50:52 INFO - [mozharness: 2016-09-26 13:50:52.567788Z] Finished install step (success) 06:50:52 INFO - [mozharness: 2016-09-26 13:50:52.568031Z] Running run-tests step. 06:50:52 INFO - Running pre-action listener: _resource_record_pre_action 06:50:52 INFO - Running main action method: run_tests 06:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:52 INFO - Python 2.7.3 06:50:52 INFO - Return code: 0 06:50:52 INFO - grabbing minidump binary from tooltool 06:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:52 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 0x23bdf60>, '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 0x23bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:52 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 06:50:52 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 06:50:52 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 06:50:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:52 INFO - Return code: 0 06:50:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:50:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:50:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:52 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/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:50:52 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/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 06:50:52 INFO - Using env: {'DISPLAY': ':0', 06:50:52 INFO - 'HOME': '/home/cltbld', 06:50:52 INFO - 'LANG': 'en_US.UTF-8', 06:50:52 INFO - 'LANGUAGE': 'en_US:en', 06:50:52 INFO - 'LOGNAME': 'cltbld', 06:50:52 INFO - 'MAIL': '/var/mail/cltbld', 06:50:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:52 INFO - 'MOZ_NO_REMOTE': '1', 06:50:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:52 INFO - 'NO_EM_RESTART': '1', 06:50:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:52 INFO - 'PWD': '/builds/slave/test', 06:50:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:52 INFO - 'SHELL': '/bin/bash', 06:50:52 INFO - 'SHLVL': '1', 06:50:52 INFO - 'TERM': 'linux', 06:50:52 INFO - 'TMOUT': '86400', 06:50:52 INFO - 'USER': 'cltbld', 06:50:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749', 06:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:52 INFO - '_': '/tools/buildbot/bin/python'} 06:50:52 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/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:50:52 INFO - mozversion application_buildid: 20160926045950 06:50:52 INFO - mozversion application_changeset: 3c4ca5845f2c12974cad7617efe5f12137603721 06:50:52 INFO - mozversion application_display_name: Nightly 06:50:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:52 INFO - mozversion application_name: Firefox 06:50:52 INFO - mozversion application_remotingname: firefox 06:50:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:50:52 INFO - mozversion application_vendor: Mozilla 06:50:52 INFO - mozversion application_version: 52.0a1 06:50:52 INFO - mozversion platform_buildid: 20160926045950 06:50:52 INFO - mozversion platform_changeset: 3c4ca5845f2c12974cad7617efe5f12137603721 06:50:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:50:52 INFO - mozversion platform_version: 52.0a1 06:50:52 INFO - using testdate: 1474897852 06:50:52 INFO - actual date: 1474897852 06:50:52 INFO - starting webserver on 'localhost:55308' 06:50:52 INFO - SUITE-START | Running 2 tests 06:50:52 INFO - TEST-START | dromaeo_css 06:50:52 INFO - operating with platform_type : linux_ 06:50:52 INFO - Initialising browser for dromaeo_css test... 06:50:52 INFO - TEST-INFO | started process 31304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqqTAS_/profile http://localhost:55308/getInfo.html) 06:50:57 INFO - PROCESS | 31304 | __metrics Screen width/height:1600/1200 06:50:57 INFO - PROCESS | 31304 | colorDepth:24 06:50:57 INFO - PROCESS | 31304 | Browser inner width/height: 1024/697 06:50:57 INFO - PROCESS | 31304 | __metrics 06:50:57 INFO - PROCESS | 31304 | 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" 06:50:57 INFO - PROCESS | 31304 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:58 INFO - PROCESS | 31304 | console.error: PushService: 06:50:58 INFO - PROCESS | 31304 | stateChangeProcessEnqueue: Error transitioning state 06:50:58 INFO - PROCESS | 31304 | UnknownError 06:50:59 INFO - TEST-INFO | 31304: exit 0 06:50:59 INFO - Browser initialized. 06:50:59 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:59 INFO - TEST-INFO | started process 31384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqqTAS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:11 INFO - PROCESS | 31384 | RSS: Main: 175255552 06:51:11 INFO - PROCESS | 31384 | 06:52:03 INFO - PROCESS | 31384 | 1474897923048 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] 06:54:15 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55308/tests/dromaeo/cssquery-ext.html) 06:54:16 INFO - PROCESS | 31384 | RSS: Main: 310640640 06:54:16 INFO - PROCESS | 31384 | 06:57:19 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-ext.html (next: http://localhost:55308/tests/dromaeo/cssquery-jquery.html) 06:57:20 INFO - PROCESS | 31384 | RSS: Main: 274173952 06:57:20 INFO - PROCESS | 31384 | 07:00:22 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55308/tests/dromaeo/cssquery-mootools.html) 07:00:22 INFO - PROCESS | 31384 | RSS: Main: 263360512 07:00:22 INFO - PROCESS | 31384 | 07:03:25 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55308/tests/dromaeo/cssquery-prototype.html) 07:03:25 INFO - PROCESS | 31384 | RSS: Main: 220549120 07:03:25 INFO - PROCESS | 31384 | 07:06:29 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55308/tests/dromaeo/cssquery-yui.html) 07:06:29 INFO - PROCESS | 31384 | RSS: Main: 220340224 07:06:29 INFO - PROCESS | 31384 | 07:09:32 INFO - PROCESS | 31384 | Cycle 1(1): loaded http://localhost:55308/tests/dromaeo/cssquery-yui.html (next: http://localhost:55308/tests/dromaeo/cssquery-dojo.html) 07:09:33 INFO - PROCESS | 31384 | RSS: Main: 311398400 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | __start_tp_report 07:09:33 INFO - PROCESS | 31384 | _x_x_mozilla_page_load 07:09:33 INFO - PROCESS | 31384 | _x_x_mozilla_page_load_details 07:09:33 INFO - PROCESS | 31384 | |i|pagename|runs| 07:09:33 INFO - PROCESS | 31384 | |0;dojo.html;2574.407886186177;2597.0131350086986;2627.1461774923155;2630.316117809369;2648.3246772073117;4479.283314669654;4551.7041392309475;4624.537546245378;4638.559336862997;4652.32541281514;4575.473820510642;4603.424571928509;4635.490096089427;4667.603253723429;4715.669903106784;4216.388623649569;4217.177650358181;4244.787760611973;4266.168097221043;4270.594293542109;4029.81865816039;4295.162443323553;4334.60988511034;4369.431973843396;4425.181341451826;4167.83328666853;4289.056407590325;4299.355096735483;4350.521442641307;4396.758178300192;4161.0845613964875;4200.7479551227025;4203.810828512725;4212.68404869636;4257.446531950857;4184.602462766033;4187.97906010468;4194.182134483777;4234.153169366139;4250.42619246404;4513.345564893105;4536.8638940831825;4562.384078149441;4563.726176429424;4603.884902877421;4786.21027530457;4815.9036819263765;4838.346823178861;4853.490383509751;4902.607791376681;4900.730459824708;4903.779329930126;4907.852764417074;4938.826466916355;4961.05739909416;4590.724556526619;4593.678442509025;4594.908101837945;4645.070985802819;4649.651276154302;4863.708177509361;4904.509549045139;4963.677360971526;5020.49795020495;5028.673136246132;4876.097921884463;4893.290472881484;4898.804047838118;4950.084234416644;4965.081459929925;4966.304717339575;4968.975155124202;4969.726665033458;4971.577415919615;5038.3198268234055;4735.810567577259;4780.904381912343;4942.061008408391;4948.134076536592;5013.674111182761;4842.297866809293;4865.440474345495;4870.9269360959615;4875.780589873464;4900.901981960341;4160.958390416117;4219.493660760729;4223.345381465878;4223.493180818322;4226.661867050629;3656.835442405045;3722.8696995605023;3733.757305775116;3756.624337566276;3762.191128907298;4165.396017577435;4212.515560710557;4236.533981262059;4251.872443826628;4256.36154576816;4930.975345123323;4945.703257804471;4953.702777833341;4969.930670715922;5010.774515146827;4181.874543763692;4207.76857272853;4253.106847561985;4254.31930891056;4291;4423.778811059434;4454.242778727624;4500.662450316239;4505.752183629932;4556.658250631216;4712.717236965793;4714.858554243378;4733.171694953438;4736.3605913202655;4790.353302304284;5006.899862002812;5015.699058056528;5019.52314530119;5020.196768517019;5082.822101226588;4454.754988475535;4539.614132798617;4596.287575425815;4645.187092258773;4683.414573178353;4908.460069392436;4909.189983652657;4909.1899836528;4918.336024636771;4966.652334336562;4970.204767237225;4970.950290497049;4972.477889821516;4973.328600638867;5026.145555255688;4683.274092515666;4734.479207287264;4789.808407663794;4821.975890120667;4892.902141957212;4826.61387089025;4831.589314908272;4837.201861692782;4871.780769865293;4887.120318342732;4770.546798054179;4773.880652983703;4774.976125119352;4776.952230477651;4818.566329030404;4714.905701886011;4735.21868891629;4799.904001919872;4865.610751139971;4915.950840491692;4741.193997020584;4763.476017637988;4765.833195838129;4822.107910036654;4826.8069277228515 07:09:33 INFO - PROCESS | 31384 | |1;ext.html;560.9986174678199;566.5439321346317;574.1502576187243;574.8993926062939;578.3984655957804;27983.720162798367;28645.140645780608;38008.61991380089;39425.21149577014;39568;39589;39975.60024399755;39998.60001399985;40055.79972100143;40067.599324006755;7684;7826.882596761053;7827.3346765525;7841.0982736985125;7849.960750196269;7469.626518674045;7598.240175982412;7659.770206893802;9766.511674416286;9969.900300997006;10110.646127385544;10273.332233404843;10278.897211027868;10287;10289.073983341497;10080.899191008106;10127.949360253226;10131.848022279672;10145.036221559014;10149.035841595074;9818.65634702782;9905.306628536006;9905.90094099057;9907.108360247541;9909.801803963952;37295.06762330963;37690.81154594237;37710.81144594259;37719.245615087544;37719.81140094282;2917.1686069470097;2921.269682579355;2968.0947311070113;2991.1026691992315;3005.879764809405;26965.325866853487;27039;27464.450710985668;27934;28036.579451308247;3391.9660803392144;3413.9146521337166;3420.1449637590604;3421.5038819371302;3430.091025878144;255002;255080;255146;255773;256219.99999999814;52897.7355113222;53259;53312;53362.19956700652;53414.73292633512;32004.199895002344;33085.17287067843;33286.66713332884;35156.472652910226;35160.29679406397;13572.1856688599;13658.317084145752;13660.795088073686;13669.453221871212;13669.564695707006;9242.12199841014;11010.614628487965;11098.389588572705;11105.944470277596;11119.110471162288;15227;17207.397741079003;17554.38559650406;17841.28634854617;18296.908515457602;6678.298778628271;6865.485088618374;6914.239433662293;6979.581225126509;7050.788476345718;780.4458834227648;854.4830377621573;875.7329014650466;897.8114595934927;915.6154415145655;25924.351891202492;28014;28230.43539129206;28297.717022829507;28720.281992950342;930.9991758859253;944.5702205496483;952.7856232347666;991.7371896447447;1007.4308015970953;13710.794338084937;14709.338079786436;14758.269720101602;14798.704025919636;15116.54650360491;367807;369033;371048;371697;372230;48279.27581086286;48666.5133348662;48752.5124748748;48764;48844;1026.5226669598671;1098.593520397458;1111.766529028913;1157.5948418053783;1185.1526158796503;24313.270601881974;30060.398792024476;30913.536296955113;30958.84520577383;31404.644651651673;46034.30948535842;46673.53326466692;46768.766156169004;46851.53148468472;46852.29721554248;332780;335036;336304;336793;337273;23996.88001560051;24964.500709986063;25175.37061573402;31494.212644684067;32182.19544511406;40405.59594404136;41338.58661413468;41842.58157418387;45682.54317456783;46563;35005.47491787574;35276.47085293671;36443.63556364403;36716.44925326069;37174.628253717114;35292.47061294134;35478.113047174025;35690.28619427649;35749.46375804313;35963.28073438569;35060;35674.46488302729;35792;35999.46000809938;36474.635253648186;31009;32166.51750223795;32188.19529511687;32282;32643.18392040218;25095.49809003846;25199.37001574902;25292.62061069122;25462.49075018526;25638.230853074438 07:09:33 INFO - PROCESS | 31384 | |2;jquery.html;343.1044972621456;358.5124231045779;365.1983895349708;369.7300970291687;379.57866767887657;12343.753124937508;12523.499060037599;12864.807027894565;12883.71162883711;16968.06675632843;16196.35214591418;16391.344346226168;16505.66988660226;16832.495025149234;16940;4933.358663373757;4940.6047516198705;5030.924536131961;5085.618578606601;5116.104681680709;3643.198496330803;4974.552290293873;5059.721715305656;5059.949400505985;5069.518395752398;3806.90482737931;5580.107182850725;5833.795817146401;5861.443162899539;5975.850603734898;5139.280500729901;5407.567394608422;5955.374685658008;5966.880662386728;5969;5330.653507521999;5332.600054995891;5336.332958380202;5337.199420086979;5337.226102215196;12135.453904574315;14810.481633142788;19079.80920190794;19371.12829922657;19874;1782.4563508130016;1788.5081602559271;1805.8623067467543;1835.0457761963837;2005.2454102660172;8750.343724220646;8814;8872.512011839346;9013.549322533847;9368.01635828235;1630.9021458712516;1663.933442662292;1672.4279177573164;1683.1247751169446;1707.1976171199517;63751.36248637501;67583.66208168928;69337.65331173311;69571.30428695699;69991;9202.595039835303;9376.718698439057;9514.524273786283;9547.474888881039;10265.435401053013;12895.677608059874;12949.611511654666;13038.152520086354;13072.738545229233;13077.673058173621;6355;6447.709853056624;6481.805545833632;6607.9669601651685;6627.469802415795;5853.88292234153;5875;6045.455908968214;6063.969680151571;6115.663638499836;3860.417228936179;3919.6668283195677;3947.822347994347;3999.980000100039;4011.6991225658194;1680.9579760506085;1690.6872228637742;1744.4243399678076;1773.0868602669636;1786.7945186303482;786.2137862137862;795.6857041468587;807.769785611098;845.6067928413195;849.6389034660244;15763.605909852346;16359.918200408922;16866.83133168677;17042.48872533826;17529;790.7548659915444;801.7409231474039;844.9408541402166;850.4302117581235;876.7588913048835;8878.689245876363;9492.762680932894;9495.240380769523;9525.904740952501;9530.380525265835;354294;354470;354833;355085;355327;48072;48571.271430928566;49170.50829491731;72646;81730.59134704288;811.4563242627336;839.9202075802912;841.3815845353538;843.7806170395742;843.9409241353169;15387.692246155239;15586.688266234385;16266.918665406598;16350.591235219215;16535.586610334838;38664.80667596644;39051.41422878716;39144.80427597844;39328.80335598304;39674.801625991684;49832.501674982785;52529.17120774275;52642.21036684376;53045.247534156435;54212.728936355066;7258.528195667264;7535.777064940018;7596.620168991418;7653.57905315213;8035.879461807961;9725.9027409725;11862.881371186179;11992.76014479723;12202.694932626755;12728.363581821057;10549.52527136296;10556.788864222826;10592.523336450033;10643.201759867887;10758.246922715334;9752.951235244062;10089.747756306151;10343.793124137324;10484.737881553023;10776.245662803529;9312.48781317034;9515.857262140935;10027.749306267402;10160.593576256866;11023.61417350389;7587.848243035219;7713.382929365749;7719.610470115433;7810.336121429515;7981.122076571456;9885.258605604464;9988.300818942604;10242.180625549789;10539.367637941748;10874.67375978722 07:09:33 INFO - PROCESS | 31384 | |3;mootools.html;1232.0143884892084;1324.4569726412174;1351.6485713714433;1401.9649508762286;1653.37998250656;6649.667516624168;7178.497505174633;7451.888221676679;7468.178500364969;7672.616369181546;7519.624018799065;7583.84832303355;7585.620718964044;7589.582572958485;7593.810154746134;2087.478130467387;2123.957520849582;2125.043730321354;2125.3092744857904;2129.0419311309897;2048.4469193317796;2073.5645514441985;2097.7063211150453;2100.0864623888656;2102.201163557846;2043.1520918818671;2043.632146213681;2046;2053.27108876349;2064.576761763842;2067.5658111796542;2072.7305450291515;2075.5226297951554;2075.9065842036994;2077.210659949225;2039.3372154049994;2040.84693647977;2065.927692530754;2066.2561477867957;2067.865588736727;7129.750458733919;7245.384142347854;7355.411567074675;7358.77923662291;7464;4289.914201715979;4409.51495335516;4413.095315460355;4414.227510185705;4415.050764085705;2723.891044358223;2810.5924640927155;2862.613547171126;2872.8563571821533;2872.8850845966135;962.3407965543626;967.685502211784;977.4184360305607;984.5077461269366;988.3476905242577;10019.74950626233;10108.848367274497;10112.94943525285;10120;10126.088652021279;3953.604639536081;3964.781936993493;4077.510698716114;4093.4678491795876;4128.091819799639;8012.919870801334;8015.719449819228;8017.959910200529;8022.197780221931;8025.879611805827;4450.977745111254;4453.864264612568;4455.329251530676;4455.532169122261;4456.46522417312;3591.6587924147166;3737.9626203738158;4043.959560404417;4120.567340429272;4126.8761937141935;3203.8878639247982;3224.5808044954006;3329.3840639481773;3360.1767566946255;3368.326334733063;965.8502932045544;973.1533565797802;975.8341082016075;979.6669132494986;998.552099455792;745.1840234942729;748.9513181643176;759.5366826235992;773.9148693643695;794.6741835847275;4778.498257682893;4837.201861692782;4859.416869975626;4882.780274887638;5023.14606516893;375.88347612240295;384.4272034668324;385.95368555773484;386.0349127182045;396.8749843799194;3383.5263063171174;3388.2715216228135;3399.2351720863103;3427.2974040321674;3493.94759078614;8999.82000359989;9279.72160835176;9285.953570232106;9298.488583127993;9309.767255818659;9379.155875971059;9395.624175032923;9403.811923761486;9413.57638906251;9426.387284826464;7082.575045497287;7089;7142.142942846892;7204.459665525002;7216.170140433812;4725;4804.471508134172;4825.4933232010135;4855.732934688626;4924.581410580141;8557.101504341954;8564.614592343483;8617.05212426645;8647.0920553341;8649.697260595849;8336.333093352638;8669.826603467769;8678.305735541267;8733.432326898732;8971.058038905821;5848.883022339444;6457.128287681103;6601.438877695257;6602;6603;6498.350164983653;6692.163479565054;6718.160229971254;6719.160104986877;6724;6350.7459701611415;6393.488520918222;6447.194100737408;6463.676816159267;6654.500912431684;6313.43179113882;6332.081848131903;6333.145025421509;6338.080978258219;6346.174997250328;5722.370539240764;5817.94182058174;5821.505172060422;5826.213461182856;5828.154917537018;4192.580741925783;4251.149770046065;4266.829326827016;4277.123189746032;4442.355858400579;4215.494140703136;4342.9348559771;4397.934030989473;4432.312991486325;4613.354130421811 07:09:33 INFO - PROCESS | 31384 | |4;prototype.html;283.27905480551993;285.71143145423116;290.50033941620404;294.17923992062146;304.5036590357717;4665.1136284106;4780.928286075708;4786.928196077058;4829.855104346866;4864.3433136526555;4758.452777930539;4762.380890484233;4773.856784296477;4777.474477807447;4781.928271075936;3564.1980554375186;3622.8044745234142;3686.9353162229236;3798.525184351956;3814.294355544233;3707.202951365456;3730.5077968812557;3735.9252814943684;3754.624537546251;3759.1166075972124;3736.458213559032;3737.177820879402;3739.121306492972;3744.1388480649466;3756.9624303757023;3542.8051457169845;3626.8005259710703;3654.835532401048;3736.3461394256033;3751.7748935063846;3274.2469232076755;3327.38443387974;3334.3998080345527;3342.782719123249;3349.765516413852;4599.862004139881;4604.631629469634;4608.493065762764;4609.147307748044;4626.282926146453;4179.164167166548;4213.778004378757;4217.789110544491;4252.383404406375;4271.722338048017;4967.155583550769;4969.18008528596;4981.178105612606;4987.102321582114;4987.600991920638;3615.620359862203;3619.0952261934517;3620.294042661682;3623.5832879218965;3633.1098880774116;5140.228965655182;5208.114620514484;5236.21456781482;5236.633435659505;5239.764210610493;3483.4774783782127;3610.891673249807;3636.3636363636256;3645.2527231917393;3718.981405092957;3675.228202077594;3682.558093028854;3687.391580389206;3688;3689.612590677994;4218.599233072853;4225.767582782976;4228.9577104228565;4236.216299984513;4255.212785634606;4721;4952.4057113146655;4953.6532442729385;4972.279019542146;4988.825391111293;1242.589945318043;1270.3457719274581;1275.196626125535;1276.7063575377715;1277.9424925878359;801.8436404900988;807.7818988873089;819.3404309530765;826.9710560130367;833.5582141465034;3928.332183528807;3940.3796475343574;4213;4294.6993710439965;4346.217680817484;5098.515641014098;5103.438621751604;5105.668131571436;5139.8458046258675;5143.456962911187;4368.672349573794;4384.298512238027;4389.956100438954;4391.187630288407;4419.889502762392;2608.5695860183237;2677.0764086390163;2695;2709.647745793034;2713.6431784107945;4842.927356089662;4843.854684359475;4846.830360937421;4847.515248475195;4851.296561998491;5193.792248310101;5227.60792940531;5242.689327668083;5261.29008072378;5281.181416880389;4589.701669391479;4798.73606951621;4815.759212039384;4847.733374664357;4899.3053820399355;5063.392392912874;5136.922946155885;5137.431284357821;5149.845504634867;5185.792568297376;5044.319016932667;5046.520580544842;5048.444671086251;5051.494850514919;5069.225770980128;4670.3695001175765;4849.927251091166;4854.417469903634;4854.83008094715;4864.659473836798;3575.946360804538;3580.4629305604367;3584.741612783929;3586.336527742376;3590.640935906493;5097.61767867404;5155.226715992631;5156.871078223075;5165.199394093921;5167.483251674803;4832.130216561053;4979;5014.473480284518;5021.573166280907;5033.521815427529;4994.828284039589;5007.624428167975;5009.5992320615;5015.84952451427;5020.974895125647;4917.795140190533;4935.383077115361;4941.234108713155;4943.184374578154;4949.183384741477;4777.21176005969;4788.521147885183;4996.552378858576;5018.422881368543;5044.8234311798915;4796.424429068395;4816.34979277807;4925.6305777066145;4929.433115191799;4938.333325001079 07:09:33 INFO - PROCESS | 31384 | |5;yui.html;603.4107545602026;649.6426965169156;658.4304576541293;702.2310569925929;704.8590281943609;12768.744625107503;13677.110987785787;13716.931415342935;13723.931380343096;13735.519256826014;11473.139514536422;11601.825972610417;11619.360935148563;11663.300201987866;11737;609;629.0941044895359;732.2787054751066;742.2725728785794;743.4238465189494;754.1779460388176;756.3155344413315;756.527170518426;756.6065645864147;757.1595528962847;804.3846457460048;805.0178781886119;805.7663277649503;805.8549461097;805.8871757953862;638.3010603389305;652.1359199061263;767.5970115689252;787.6376866641352;803.6825453945688;579.3800633322347;579.8028670252135;579.9072148456269;579.9159121927297;579.9594028418012;12618.17981831178;12640.241585504898;12652.873471265262;12660.620181394574;12673;11900.226485278428;12247;12265.57070502528;12560.685982850411;12784.424700888483;10876.945615271952;11063.502142403531;11092.889071109266;11135.276207046516;11186.049185819214;3869.8241351152174;3932.4101384792225;3949.4668219790246;4025.054112283611;4110.136871257039;61528;61709.34958333576;61714.69142654258;62290.37709622891;62941.6852915737;9050.140236677506;9331.486768227813;9354.298427617956;9356.625734970661;9493.477858717699;18483.537911552048;18501.44495665132;18519.72220416695;18533.351332703292;18542.629147416978;6391.520635952322;6464.127342808754;6479.870402591921;6607.174103237096;6698.866022679616;3282.7537934654997;3286.193814924417;3351.379994700988;3359.076254030161;3397.320535892782;2611.7518835710575;2682.986585067062;2696.433748912711;2704.9053283134995;2705.174921648916;464.2826832543728;468.7515616723142;477.6298368764166;491.78115738496024;491.89178380756175;469.4319872953696;482.9251466022772;483.58653351384766;484.94180698316427;516.1071346570454;6563.409293163638;6837.62393068386;6893.28614863185;7034.8944765828555;7070.080889484437;435.48612637087905;435.7821089455272;474.2293772619493;495.6035171862496;526.557691539109;3154.763392745553;3443.8450269737923;3475.113845969312;3492.5983511895947;3526.8589256429455;56427.43572564304;59281.70359148177;100061.49969250253;104536.47731761445;104643;52197.7390113047;63462.682686586275;85008;89699;90442;68371.3162868375;75769.24230757733;76466.61766691243;76611.61694191494;76830.61584692041;6406.455451286693;6464.256610489666;6642.535022548568;6655.833604159935;6685.097511836035;36442;36936.63063369332;37388;42276.57723422726;46252.76873615745;53938;58421;58905;60630.696846515486;61459.69270153621;8489.235968762841;8798;9944;10349.534270957674;10438.791224175626;9889.258305626963;9995.500224988577;10123.291369604058;10766.246362754531;10778.838317425401;9014.774630634025;9143.817123657356;9330.813383732424;9692.224622030362;9692.75768105803;9201.125893040151;9377.202937750095;9652.517374131407;9840.704778856645;9940.751481213027;8885.555722213992;10284.537195826057;10627.36235825853;11361.886381136082;11430.714232144262;9116.589753461243;9242.907570924204;9381.390209636353;9487.383320084173;10085.445300508543;8758.386912916034;8797.868031979653;8869.911300887166;8903.777405564913;9169.266458683423 07:09:33 INFO - PROCESS | 31384 | __end_tp_report 07:09:33 INFO - PROCESS | 31384 | __start_cc_report 07:09:33 INFO - PROCESS | 31384 | _x_x_mozilla_cycle_collect,1155 07:09:33 INFO - PROCESS | 31384 | __end_cc_report 07:09:33 INFO - PROCESS | 31384 | __startTimestamp1474898973124__endTimestamp 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | ------- Summary: start ------- 07:09:33 INFO - PROCESS | 31384 | Number of tests: 6 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#0] dojo.html Cycles:165 Average:4568.29 Median:4714.91 stddev:471.55 (10.0%) stddev-sans-first:446.31 07:09:33 INFO - PROCESS | 31384 | Values: 2574.4 2597.0 2627.1 2630.3 2648.3 4479.3 4551.7 4624.5 4638.6 4652.3 4575.5 4603.4 4635.5 4667.6 4715.7 4216.4 4217.2 4244.8 4266.2 4270.6 4029.8 4295.2 4334.6 4369.4 4425.2 4167.8 4289.1 4299.4 4350.5 4396.8 4161.1 4200.7 4203.8 4212.7 4257.4 4184.6 4188.0 4194.2 4234.2 4250.4 4513.3 4536.9 4562.4 4563.7 4603.9 4786.2 4815.9 4838.3 4853.5 4902.6 4900.7 4903.8 4907.9 4938.8 4961.1 4590.7 4593.7 4594.9 4645.1 4649.7 4863.7 4904.5 4963.7 5020.5 5028.7 4876.1 4893.3 4898.8 4950.1 4965.1 4966.3 4969.0 4969.7 4971.6 5038.3 4735.8 4780.9 4942.1 4948.1 5013.7 4842.3 4865.4 4870.9 4875.8 4900.9 4161.0 4219.5 4223.3 4223.5 4226.7 3656.8 3722.9 3733.8 3756.6 3762.2 4165.4 4212.5 4236.5 4251.9 4256.4 4931.0 4945.7 4953.7 4969.9 5010.8 4181.9 4207.8 4253.1 4254.3 4291.0 4423.8 4454.2 4500.7 4505.8 4556.7 4712.7 4714.9 4733.2 4736.4 4790.4 5006.9 5015.7 5019.5 5020.2 5082.8 4454.8 4539.6 4596.3 4645.2 4683.4 4908.5 4909.2 4909.2 4918.3 4966.7 4970.2 4971.0 4972.5 4973.3 5026.1 4683.3 4734.5 4789.8 4822.0 4892.9 4826.6 4831.6 4837.2 4871.8 4887.1 4770.5 4773.9 4775.0 4777.0 4818.6 4714.9 4735.2 4799.9 4865.6 4916.0 4741.2 4763.5 4765.8 4822.1 4826.8 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#1] ext.html Cycles:180 Average:47114.37 Median:35032.74 stddev:85193.46 (243.2%) stddev-sans-first:85360.74 07:09:33 INFO - PROCESS | 31384 | Values: 561.0 566.5 574.2 574.9 578.4 27983.7 28645.1 38008.6 39425.2 39568.0 39589.0 39975.6 39998.6 40055.8 40067.6 7684.0 7826.9 7827.3 7841.1 7850.0 7469.6 7598.2 7659.8 9766.5 9969.9 10110.6 10273.3 10278.9 10287.0 10289.1 10080.9 10127.9 10131.8 10145.0 10149.0 9818.7 9905.3 9905.9 9907.1 9909.8 37295.1 37690.8 37710.8 37719.2 37719.8 2917.2 2921.3 2968.1 2991.1 3005.9 26965.3 27039.0 27464.5 27934.0 28036.6 3392.0 3413.9 3420.1 3421.5 3430.1 255002.0 255080.0 255146.0 255773.0 256220.0 52897.7 53259.0 53312.0 53362.2 53414.7 32004.2 33085.2 33286.7 35156.5 35160.3 13572.2 13658.3 13660.8 13669.5 13669.6 9242.1 11010.6 11098.4 11105.9 11119.1 15227.0 17207.4 17554.4 17841.3 18296.9 6678.3 6865.5 6914.2 6979.6 7050.8 780.4 854.5 875.7 897.8 915.6 25924.4 28014.0 28230.4 28297.7 28720.3 931.0 944.6 952.8 991.7 1007.4 13710.8 14709.3 14758.3 14798.7 15116.5 367807.0 369033.0 371048.0 371697.0 372230.0 48279.3 48666.5 48752.5 48764.0 48844.0 1026.5 1098.6 1111.8 1157.6 1185.2 24313.3 30060.4 30913.5 30958.8 31404.6 46034.3 46673.5 46768.8 46851.5 46852.3 332780.0 335036.0 336304.0 336793.0 337273.0 23996.9 24964.5 25175.4 31494.2 32182.2 40405.6 41338.6 41842.6 45682.5 46563.0 35005.5 35276.5 36443.6 36716.4 37174.6 35292.5 35478.1 35690.3 35749.5 35963.3 35060.0 35674.5 35792.0 35999.5 36474.6 31009.0 32166.5 32188.2 32282.0 32643.2 25095.5 25199.4 25292.6 25462.5 25638.2 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#2] jquery.html Cycles:180 Average:22622.06 Median:4936.98 stddev:58578.87 (1186.5%) stddev-sans-first:58719.32 07:09:33 INFO - PROCESS | 31384 | Values: 343.1 358.5 365.2 369.7 379.6 12343.8 12523.5 12864.8 12883.7 16968.1 16196.4 16391.3 16505.7 16832.5 16940.0 4933.4 4940.6 5030.9 5085.6 5116.1 3643.2 4974.6 5059.7 5059.9 5069.5 3806.9 5580.1 5833.8 5861.4 5975.9 5139.3 5407.6 5955.4 5966.9 5969.0 5330.7 5332.6 5336.3 5337.2 5337.2 12135.5 14810.5 19079.8 19371.1 19874.0 1782.5 1788.5 1805.9 1835.0 2005.2 8750.3 8814.0 8872.5 9013.5 9368.0 1630.9 1663.9 1672.4 1683.1 1707.2 63751.4 67583.7 69337.7 69571.3 69991.0 9202.6 9376.7 9514.5 9547.5 10265.4 12895.7 12949.6 13038.2 13072.7 13077.7 6355.0 6447.7 6481.8 6608.0 6627.5 5853.9 5875.0 6045.5 6064.0 6115.7 3860.4 3919.7 3947.8 4000.0 4011.7 1681.0 1690.7 1744.4 1773.1 1786.8 786.2 795.7 807.8 845.6 849.6 15763.6 16359.9 16866.8 17042.5 17529.0 790.8 801.7 844.9 850.4 876.8 8878.7 9492.8 9495.2 9525.9 9530.4 354294.0 354470.0 354833.0 355085.0 355327.0 48072.0 48571.3 49170.5 72646.0 81730.6 811.5 839.9 841.4 843.8 843.9 15387.7 15586.7 16266.9 16350.6 16535.6 38664.8 39051.4 39144.8 39328.8 39674.8 49832.5 52529.2 52642.2 53045.2 54212.7 7258.5 7535.8 7596.6 7653.6 8035.9 9725.9 11862.9 11992.8 12202.7 12728.4 10549.5 10556.8 10592.5 10643.2 10758.2 9753.0 10089.7 10343.8 10484.7 10776.2 9312.5 9515.9 10027.7 10160.6 11023.6 7587.8 7713.4 7719.6 7810.3 7981.1 9885.3 9988.3 10242.2 10539.4 10874.7 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#3] mootools.html Cycles:180 Average:4851.98 Median:4857.57 stddev:2750.74 (56.6%) stddev-sans-first:2745.01 07:09:33 INFO - PROCESS | 31384 | Values: 1232.0 1324.5 1351.6 1402.0 1653.4 6649.7 7178.5 7451.9 7468.2 7672.6 7519.6 7583.8 7585.6 7589.6 7593.8 2087.5 2124.0 2125.0 2125.3 2129.0 2048.4 2073.6 2097.7 2100.1 2102.2 2043.2 2043.6 2046.0 2053.3 2064.6 2067.6 2072.7 2075.5 2075.9 2077.2 2039.3 2040.8 2065.9 2066.3 2067.9 7129.8 7245.4 7355.4 7358.8 7464.0 4289.9 4409.5 4413.1 4414.2 4415.1 2723.9 2810.6 2862.6 2872.9 2872.9 962.3 967.7 977.4 984.5 988.3 10019.7 10108.8 10112.9 10120.0 10126.1 3953.6 3964.8 4077.5 4093.5 4128.1 8012.9 8015.7 8018.0 8022.2 8025.9 4451.0 4453.9 4455.3 4455.5 4456.5 3591.7 3738.0 4044.0 4120.6 4126.9 3203.9 3224.6 3329.4 3360.2 3368.3 965.9 973.2 975.8 979.7 998.6 745.2 749.0 759.5 773.9 794.7 4778.5 4837.2 4859.4 4882.8 5023.1 375.9 384.4 386.0 386.0 396.9 3383.5 3388.3 3399.2 3427.3 3493.9 8999.8 9279.7 9286.0 9298.5 9309.8 9379.2 9395.6 9403.8 9413.6 9426.4 7082.6 7089.0 7142.1 7204.5 7216.2 4725.0 4804.5 4825.5 4855.7 4924.6 8557.1 8564.6 8617.1 8647.1 8649.7 8336.3 8669.8 8678.3 8733.4 8971.1 5848.9 6457.1 6601.4 6602.0 6603.0 6498.4 6692.2 6718.2 6719.2 6724.0 6350.7 6393.5 6447.2 6463.7 6654.5 6313.4 6332.1 6333.1 6338.1 6346.2 5722.4 5817.9 5821.5 5826.2 5828.2 4192.6 4251.1 4266.8 4277.1 4442.4 4215.5 4342.9 4397.9 4432.3 4613.4 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#4] prototype.html Cycles:180 Average:4135.65 Median:4768.12 stddev:1205.43 (25.3%) stddev-sans-first:1173.62 07:09:33 INFO - PROCESS | 31384 | Values: 283.3 285.7 290.5 294.2 304.5 4665.1 4780.9 4786.9 4829.9 4864.3 4758.5 4762.4 4773.9 4777.5 4781.9 3564.2 3622.8 3686.9 3798.5 3814.3 3707.2 3730.5 3735.9 3754.6 3759.1 3736.5 3737.2 3739.1 3744.1 3757.0 3542.8 3626.8 3654.8 3736.3 3751.8 3274.2 3327.4 3334.4 3342.8 3349.8 4599.9 4604.6 4608.5 4609.1 4626.3 4179.2 4213.8 4217.8 4252.4 4271.7 4967.2 4969.2 4981.2 4987.1 4987.6 3615.6 3619.1 3620.3 3623.6 3633.1 5140.2 5208.1 5236.2 5236.6 5239.8 3483.5 3610.9 3636.4 3645.3 3719.0 3675.2 3682.6 3687.4 3688.0 3689.6 4218.6 4225.8 4229.0 4236.2 4255.2 4721.0 4952.4 4953.7 4972.3 4988.8 1242.6 1270.3 1275.2 1276.7 1277.9 801.8 807.8 819.3 827.0 833.6 3928.3 3940.4 4213.0 4294.7 4346.2 5098.5 5103.4 5105.7 5139.8 5143.5 4368.7 4384.3 4390.0 4391.2 4419.9 2608.6 2677.1 2695.0 2709.6 2713.6 4842.9 4843.9 4846.8 4847.5 4851.3 5193.8 5227.6 5242.7 5261.3 5281.2 4589.7 4798.7 4815.8 4847.7 4899.3 5063.4 5136.9 5137.4 5149.8 5185.8 5044.3 5046.5 5048.4 5051.5 5069.2 4670.4 4849.9 4854.4 4854.8 4864.7 3575.9 3580.5 3584.7 3586.3 3590.6 5097.6 5155.2 5156.9 5165.2 5167.5 4832.1 4979.0 5014.5 5021.6 5033.5 4994.8 5007.6 5009.6 5015.8 5021.0 4917.8 4935.4 4941.2 4943.2 4949.2 4777.2 4788.5 4996.6 5018.4 5044.8 4796.4 4816.3 4925.6 4929.4 4938.3 07:09:33 INFO - PROCESS | 31384 | 07:09:33 INFO - PROCESS | 31384 | [#5] yui.html Cycles:180 Average:16455.72 Median:29500.48 stddev:23955.31 (81.2%) stddev-sans-first:23992.94 07:09:33 INFO - PROCESS | 31384 | Values: 603.4 649.6 658.4 702.2 704.9 12768.7 13677.1 13716.9 13723.9 13735.5 11473.1 11601.8 11619.4 11663.3 11737.0 609.0 629.1 732.3 742.3 743.4 754.2 756.3 756.5 756.6 757.2 804.4 805.0 805.8 805.9 805.9 638.3 652.1 767.6 787.6 803.7 579.4 579.8 579.9 579.9 580.0 12618.2 12640.2 12652.9 12660.6 12673.0 11900.2 12247.0 12265.6 12560.7 12784.4 10876.9 11063.5 11092.9 11135.3 11186.0 3869.8 3932.4 3949.5 4025.1 4110.1 61528.0 61709.3 61714.7 62290.4 62941.7 9050.1 9331.5 9354.3 9356.6 9493.5 18483.5 18501.4 18519.7 18533.4 18542.6 6391.5 6464.1 6479.9 6607.2 6698.9 3282.8 3286.2 3351.4 3359.1 3397.3 2611.8 2683.0 2696.4 2704.9 2705.2 464.3 468.8 477.6 491.8 491.9 469.4 482.9 483.6 484.9 516.1 6563.4 6837.6 6893.3 7034.9 7070.1 435.5 435.8 474.2 495.6 526.6 3154.8 3443.8 3475.1 3492.6 3526.9 56427.4 59281.7 100061.5 104536.5 104643.0 52197.7 63462.7 85008.0 89699.0 90442.0 68371.3 75769.2 76466.6 76611.6 76830.6 6406.5 6464.3 6642.5 6655.8 6685.1 36442.0 36936.6 37388.0 42276.6 46252.8 53938.0 58421.0 58905.0 60630.7 61459.7 8489.2 8798.0 9944.0 10349.5 10438.8 9889.3 9995.5 10123.3 10766.2 10778.8 9014.8 9143.8 9330.8 9692.2 9692.8 9201.1 9377.2 9652.5 9840.7 9940.8 8885.6 10284.5 10627.4 11361.9 11430.7 9116.6 9242.9 9381.4 9487.4 10085.4 8758.4 8797.9 8869.9 8903.8 9169.3 07:09:33 INFO - PROCESS | 31384 | -------- Summary: end -------- 07:09:33 INFO - PROCESS | 31384 | 07:09:34 INFO - TEST-INFO | 31384: exit 0 07:09:34 INFO - TEST-OK | dromaeo_css | took 1121308ms 07:09:34 INFO - TEST-START | kraken 07:09:34 INFO - operating with platform_type : linux_ 07:09:34 INFO - Initialising browser for kraken test... 07:09:34 INFO - TEST-INFO | started process 31689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFzOIzi/profile http://localhost:55308/getInfo.html) 07:09:38 INFO - PROCESS | 31689 | __metrics Screen width/height:1600/1200 07:09:38 INFO - PROCESS | 31689 | colorDepth:24 07:09:38 INFO - PROCESS | 31689 | Browser inner width/height: 1024/697 07:09:38 INFO - PROCESS | 31689 | __metrics 07:09:39 INFO - PROCESS | 31689 | 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" 07:09:39 INFO - PROCESS | 31689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:39 INFO - PROCESS | 31689 | console.error: PushService: 07:09:39 INFO - PROCESS | 31689 | stateChangeProcessEnqueue: Error transitioning state 07:09:39 INFO - PROCESS | 31689 | UnknownError 07:09:40 INFO - TEST-INFO | 31689: exit 0 07:09:40 INFO - Browser initialized. 07:09:40 INFO - Running cycle 1/1 for kraken test... 07:09:40 INFO - TEST-INFO | started process 31774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFzOIzi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:52 INFO - PROCESS | 31774 | RSS: Main: 177274880 07:09:52 INFO - PROCESS | 31774 | 07:09:55 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55308/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:56 INFO - PROCESS | 31774 | RSS: Main: 233467904 07:09:56 INFO - PROCESS | 31774 | 07:09:59 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55308/tests/kraken/driver.html?testName=audio-dft) 07:09:59 INFO - PROCESS | 31774 | RSS: Main: 218505216 07:09:59 INFO - PROCESS | 31774 | 07:10:02 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55308/tests/kraken/driver.html?testName=audio-fft) 07:10:03 INFO - PROCESS | 31774 | RSS: Main: 300646400 07:10:03 INFO - PROCESS | 31774 | 07:10:05 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55308/tests/kraken/driver.html?testName=audio-oscillator) 07:10:06 INFO - PROCESS | 31774 | RSS: Main: 209842176 07:10:06 INFO - PROCESS | 31774 | 07:10:08 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:09 INFO - PROCESS | 31774 | RSS: Main: 213782528 07:10:09 INFO - PROCESS | 31774 | 07:10:12 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55308/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:13 INFO - PROCESS | 31774 | RSS: Main: 251043840 07:10:13 INFO - PROCESS | 31774 | 07:10:16 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55308/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:17 INFO - PROCESS | 31774 | RSS: Main: 249692160 07:10:17 INFO - PROCESS | 31774 | 07:10:20 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55308/tests/kraken/driver.html?testName=json-parse-financial) 07:10:20 INFO - PROCESS | 31774 | RSS: Main: 249376768 07:10:20 INFO - PROCESS | 31774 | 07:10:22 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:22 INFO - PROCESS | 31774 | RSS: Main: 211558400 07:10:22 INFO - PROCESS | 31774 | 07:10:24 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:25 INFO - PROCESS | 31774 | RSS: Main: 220065792 07:10:25 INFO - PROCESS | 31774 | 07:10:27 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:28 INFO - PROCESS | 31774 | RSS: Main: 223887360 07:10:28 INFO - PROCESS | 31774 | 07:10:31 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:31 INFO - PROCESS | 31774 | RSS: Main: 224776192 07:10:31 INFO - PROCESS | 31774 | 07:10:34 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:35 INFO - PROCESS | 31774 | RSS: Main: 222625792 07:10:35 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | Cycle 1(1): loaded http://localhost:55308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55308/tests/kraken/driver.html?testName=ai-astar) 07:10:37 INFO - PROCESS | 31774 | RSS: Main: 273567744 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | __start_tp_report 07:10:37 INFO - PROCESS | 31774 | _x_x_mozilla_page_load 07:10:37 INFO - PROCESS | 31774 | _x_x_mozilla_page_load_details 07:10:37 INFO - PROCESS | 31774 | |i|pagename|runs| 07:10:37 INFO - PROCESS | 31774 | |0;ai-astar;111;113;116;114;114;116;112;112;113;114 07:10:37 INFO - PROCESS | 31774 | |1;audio-beat-detection;156;123;124;174;127;130;124;125;160;128 07:10:37 INFO - PROCESS | 31774 | |2;audio-dft;162;162;161;163;162;159;163;162;164;163 07:10:37 INFO - PROCESS | 31774 | |3;audio-fft;75;77;77;107;77;76;77;75;97;77 07:10:37 INFO - PROCESS | 31774 | |4;audio-oscillator;85;85;122;85;85;83;115;84;83;113 07:10:37 INFO - PROCESS | 31774 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;118;116 07:10:37 INFO - PROCESS | 31774 | |6;imaging-darkroom;146;147;146;146;146;148;146;147;146;146 07:10:37 INFO - PROCESS | 31774 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;94 07:10:37 INFO - PROCESS | 31774 | |8;json-parse-financial;64;62;62;62;64;65;63;63;63;63 07:10:37 INFO - PROCESS | 31774 | |9;json-stringify-tinderbox;66;66;65;67;66;66;66;66;66;67 07:10:37 INFO - PROCESS | 31774 | |10;stanford-crypto-aes;83;83;82;82;83;83;82;82;81;81 07:10:37 INFO - PROCESS | 31774 | |11;stanford-crypto-ccm;134;136;133;139;133;134;135;137;179;146 07:10:37 INFO - PROCESS | 31774 | |12;stanford-crypto-pbkdf2;180;176;176;177;172;177;182;175;176;175 07:10:37 INFO - PROCESS | 31774 | |13;stanford-crypto-sha256-iterative;69;71;70;72;70;70;73;70;68;68 07:10:37 INFO - PROCESS | 31774 | __end_tp_report 07:10:37 INFO - PROCESS | 31774 | __start_cc_report 07:10:37 INFO - PROCESS | 31774 | _x_x_mozilla_cycle_collect,1924 07:10:37 INFO - PROCESS | 31774 | __end_cc_report 07:10:37 INFO - PROCESS | 31774 | __startTimestamp1474899037432__endTimestamp 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | ------- Summary: start ------- 07:10:37 INFO - PROCESS | 31774 | Number of tests: 14 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.48 07:10:37 INFO - PROCESS | 31774 | Values: 111.0 113.0 116.0 114.0 114.0 116.0 112.0 112.0 113.0 114.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:129.00 stddev:18.76 (14.5%) stddev-sans-first:18.61 07:10:37 INFO - PROCESS | 31774 | Values: 156.0 123.0 124.0 174.0 127.0 130.0 124.0 125.0 160.0 128.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 07:10:37 INFO - PROCESS | 31774 | Values: 162.0 162.0 161.0 163.0 162.0 159.0 163.0 162.0 164.0 163.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#3] audio-fft Cycles:10 Average:81.50 Median:77.00 stddev:11.09 (14.4%) stddev-sans-first:11.51 07:10:37 INFO - PROCESS | 31774 | Values: 75.0 77.0 77.0 107.0 77.0 76.0 77.0 75.0 97.0 77.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.50 stddev:15.82 (18.7%) stddev-sans-first:16.44 07:10:37 INFO - PROCESS | 31774 | Values: 85.0 85.0 122.0 85.0 85.0 83.0 115.0 84.0 83.0 113.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 07:10:37 INFO - PROCESS | 31774 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:10:37 INFO - PROCESS | 31774 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 147.0 146.0 146.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:10:37 INFO - PROCESS | 31774 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 07:10:37 INFO - PROCESS | 31774 | Values: 64.0 62.0 62.0 62.0 64.0 65.0 63.0 63.0 63.0 63.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:10:37 INFO - PROCESS | 31774 | Values: 66.0 66.0 65.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.79 (1.0%) stddev-sans-first:0.78 07:10:37 INFO - PROCESS | 31774 | Values: 83.0 83.0 82.0 82.0 83.0 83.0 82.0 82.0 81.0 81.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:136.50 stddev:14.04 (10.3%) stddev-sans-first:14.69 07:10:37 INFO - PROCESS | 31774 | Values: 134.0 136.0 133.0 139.0 133.0 134.0 135.0 137.0 179.0 146.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.50 stddev:2.76 (1.6%) stddev-sans-first:2.64 07:10:37 INFO - PROCESS | 31774 | Values: 180.0 176.0 176.0 177.0 172.0 177.0 182.0 175.0 176.0 175.0 07:10:37 INFO - PROCESS | 31774 | 07:10:37 INFO - PROCESS | 31774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.60 (2.3%) stddev-sans-first:1.64 07:10:37 INFO - PROCESS | 31774 | Values: 69.0 71.0 70.0 72.0 70.0 70.0 73.0 70.0 68.0 68.0 07:10:37 INFO - PROCESS | 31774 | -------- Summary: end -------- 07:10:37 INFO - PROCESS | 31774 | 07:10:38 INFO - TEST-INFO | 31774: exit 0 07:10:38 INFO - TEST-OK | kraken | took 64761ms 07:10:38 INFO - SUITE-END | took 1186s 07:10:39 INFO - Completed test suite (00:19:46) 07:10:39 INFO - javascript benchmark 07:10:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.407886186177, 2597.0131350086986, 2627.1461774923155, 2630.316117809369, 2648.3246772073117, 4479.283314669654, 4551.7041392309475, 4624.537546245378, 4638.559336862997, 4652.32541281514, 4575.473820510642, 4603.424571928509, 4635.490096089427, 4667.603253723429, 4715.669903106784, 4216.388623649569, 4217.177650358181, 4244.787760611973, 4266.168097221043, 4270.594293542109, 4029.81865816039, 4295.162443323553, 4334.60988511034, 4369.431973843396, 4425.181341451826, 4167.83328666853, 4289.056407590325, 4299.355096735483, 4350.521442641307, 4396.758178300192, 4161.0845613964875, 4200.7479551227025, 4203.810828512725, 4212.68404869636, 4257.446531950857, 4184.602462766033, 4187.97906010468, 4194.182134483777, 4234.153169366139, 4250.42619246404, 4513.345564893105, 4536.8638940831825, 4562.384078149441, 4563.726176429424, 4603.884902877421, 4786.21027530457, 4815.9036819263765, 4838.346823178861, 4853.490383509751, 4902.607791376681, 4900.730459824708, 4903.779329930126, 4907.852764417074, 4938.826466916355, 4961.05739909416, 4590.724556526619, 4593.678442509025, 4594.908101837945, 4645.070985802819, 4649.651276154302, 4863.708177509361, 4904.509549045139, 4963.677360971526, 5020.49795020495, 5028.673136246132, 4876.097921884463, 4893.290472881484, 4898.804047838118, 4950.084234416644, 4965.081459929925, 4966.304717339575, 4968.975155124202, 4969.726665033458, 4971.577415919615, 5038.3198268234055, 4735.810567577259, 4780.904381912343, 4942.061008408391, 4948.134076536592, 5013.674111182761, 4842.297866809293, 4865.440474345495, 4870.9269360959615, 4875.780589873464, 4900.901981960341, 4160.958390416117, 4219.493660760729, 4223.345381465878, 4223.493180818322, 4226.661867050629, 3656.835442405045, 3722.8696995605023, 3733.757305775116, 3756.624337566276, 3762.191128907298, 4165.396017577435, 4212.515560710557, 4236.533981262059, 4251.872443826628, 4256.36154576816, 4930.975345123323, 4945.703257804471, 4953.702777833341, 4969.930670715922, 5010.774515146827, 4181.874543763692, 4207.76857272853, 4253.106847561985, 4254.31930891056, 4291.0, 4423.778811059434, 4454.242778727624, 4500.662450316239, 4505.752183629932, 4556.658250631216, 4712.717236965793, 4714.858554243378, 4733.171694953438, 4736.3605913202655, 4790.353302304284, 5006.899862002812, 5015.699058056528, 5019.52314530119, 5020.196768517019, 5082.822101226588, 4454.754988475535, 4539.614132798617, 4596.287575425815, 4645.187092258773, 4683.414573178353, 4908.460069392436, 4909.189983652657, 4909.1899836528, 4918.336024636771, 4966.652334336562, 4970.204767237225, 4970.950290497049, 4972.477889821516, 4973.328600638867, 5026.145555255688, 4683.274092515666, 4734.479207287264, 4789.808407663794, 4821.975890120667, 4892.902141957212, 4826.61387089025, 4831.589314908272, 4837.201861692782, 4871.780769865293, 4887.120318342732, 4770.546798054179, 4773.880652983703, 4774.976125119352, 4776.952230477651, 4818.566329030404, 4714.905701886011, 4735.21868891629, 4799.904001919872, 4865.610751139971, 4915.950840491692, 4741.193997020584, 4763.476017637988, 4765.833195838129, 4822.107910036654, 4826.8069277228515], "value": 4538.916854696176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9986174678199, 566.5439321346317, 574.1502576187243, 574.8993926062939, 578.3984655957804, 27983.720162798367, 28645.140645780608, 38008.61991380089, 39425.21149577014, 39568.0, 39589.0, 39975.60024399755, 39998.60001399985, 40055.79972100143, 40067.599324006755, 7684.0, 7826.882596761053, 7827.3346765525, 7841.0982736985125, 7849.960750196269, 7469.626518674045, 7598.240175982412, 7659.770206893802, 9766.511674416286, 9969.900300997006, 10110.646127385544, 10273.332233404843, 10278.897211027868, 10287.0, 10289.073983341497, 10080.899191008106, 10127.949360253226, 10131.848022279672, 10145.036221559014, 10149.035841595074, 9818.65634702782, 9905.306628536006, 9905.90094099057, 9907.108360247541, 9909.801803963952, 37295.06762330963, 37690.81154594237, 37710.81144594259, 37719.245615087544, 37719.81140094282, 2917.1686069470097, 2921.269682579355, 2968.0947311070113, 2991.1026691992315, 3005.879764809405, 26965.325866853487, 27039.0, 27464.450710985668, 27934.0, 28036.579451308247, 3391.9660803392144, 3413.9146521337166, 3420.1449637590604, 3421.5038819371302, 3430.091025878144, 255002.0, 255080.0, 255146.0, 255773.0, 256219.99999999814, 52897.7355113222, 53259.0, 53312.0, 53362.19956700652, 53414.73292633512, 32004.199895002344, 33085.17287067843, 33286.66713332884, 35156.472652910226, 35160.29679406397, 13572.1856688599, 13658.317084145752, 13660.795088073686, 13669.453221871212, 13669.564695707006, 9242.12199841014, 11010.614628487965, 11098.389588572705, 11105.944470277596, 11119.110471162288, 15227.0, 17207.397741079003, 17554.38559650406, 17841.28634854617, 18296.908515457602, 6678.298778628271, 6865.485088618374, 6914.239433662293, 6979.581225126509, 7050.788476345718, 780.4458834227648, 854.4830377621573, 875.7329014650466, 897.8114595934927, 915.6154415145655, 25924.351891202492, 28014.0, 28230.43539129206, 28297.717022829507, 28720.281992950342, 930.9991758859253, 944.5702205496483, 952.7856232347666, 991.7371896447447, 1007.4308015970953, 13710.794338084937, 14709.338079786436, 14758.269720101602, 14798.704025919636, 15116.54650360491, 367807.0, 369033.0, 371048.0, 371697.0, 372230.0, 48279.27581086286, 48666.5133348662, 48752.5124748748, 48764.0, 48844.0, 1026.5226669598671, 1098.593520397458, 1111.766529028913, 1157.5948418053783, 1185.1526158796503, 24313.270601881974, 30060.398792024476, 30913.536296955113, 30958.84520577383, 31404.644651651673, 46034.30948535842, 46673.53326466692, 46768.766156169004, 46851.53148468472, 46852.29721554248, 332780.0, 335036.0, 336304.0, 336793.0, 337273.0, 23996.88001560051, 24964.500709986063, 25175.37061573402, 31494.212644684067, 32182.19544511406, 40405.59594404136, 41338.58661413468, 41842.58157418387, 45682.54317456783, 46563.0, 35005.47491787574, 35276.47085293671, 36443.63556364403, 36716.44925326069, 37174.628253717114, 35292.47061294134, 35478.113047174025, 35690.28619427649, 35749.46375804313, 35963.28073438569, 35060.0, 35674.46488302729, 35792.0, 35999.46000809938, 36474.635253648186, 31009.0, 32166.51750223795, 32188.19529511687, 32282.0, 32643.18392040218, 25095.49809003846, 25199.37001574902, 25292.62061069122, 25462.49075018526, 25638.230853074438], "value": 17560.00896720206, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1044972621456, 358.5124231045779, 365.1983895349708, 369.7300970291687, 379.57866767887657, 12343.753124937508, 12523.499060037599, 12864.807027894565, 12883.71162883711, 16968.06675632843, 16196.35214591418, 16391.344346226168, 16505.66988660226, 16832.495025149234, 16940.0, 4933.358663373757, 4940.6047516198705, 5030.924536131961, 5085.618578606601, 5116.104681680709, 3643.198496330803, 4974.552290293873, 5059.721715305656, 5059.949400505985, 5069.518395752398, 3806.90482737931, 5580.107182850725, 5833.795817146401, 5861.443162899539, 5975.850603734898, 5139.280500729901, 5407.567394608422, 5955.374685658008, 5966.880662386728, 5969.0, 5330.653507521999, 5332.600054995891, 5336.332958380202, 5337.199420086979, 5337.226102215196, 12135.453904574315, 14810.481633142788, 19079.80920190794, 19371.12829922657, 19874.0, 1782.4563508130016, 1788.5081602559271, 1805.8623067467543, 1835.0457761963837, 2005.2454102660172, 8750.343724220646, 8814.0, 8872.512011839346, 9013.549322533847, 9368.01635828235, 1630.9021458712516, 1663.933442662292, 1672.4279177573164, 1683.1247751169446, 1707.1976171199517, 63751.36248637501, 67583.66208168928, 69337.65331173311, 69571.30428695699, 69991.0, 9202.595039835303, 9376.718698439057, 9514.524273786283, 9547.474888881039, 10265.435401053013, 12895.677608059874, 12949.611511654666, 13038.152520086354, 13072.738545229233, 13077.673058173621, 6355.0, 6447.709853056624, 6481.805545833632, 6607.9669601651685, 6627.469802415795, 5853.88292234153, 5875.0, 6045.455908968214, 6063.969680151571, 6115.663638499836, 3860.417228936179, 3919.6668283195677, 3947.822347994347, 3999.980000100039, 4011.6991225658194, 1680.9579760506085, 1690.6872228637742, 1744.4243399678076, 1773.0868602669636, 1786.7945186303482, 786.2137862137862, 795.6857041468587, 807.769785611098, 845.6067928413195, 849.6389034660244, 15763.605909852346, 16359.918200408922, 16866.83133168677, 17042.48872533826, 17529.0, 790.7548659915444, 801.7409231474039, 844.9408541402166, 850.4302117581235, 876.7588913048835, 8878.689245876363, 9492.762680932894, 9495.240380769523, 9525.904740952501, 9530.380525265835, 354294.0, 354470.0, 354833.0, 355085.0, 355327.0, 48072.0, 48571.271430928566, 49170.50829491731, 72646.0, 81730.59134704288, 811.4563242627336, 839.9202075802912, 841.3815845353538, 843.7806170395742, 843.9409241353169, 15387.692246155239, 15586.688266234385, 16266.918665406598, 16350.591235219215, 16535.586610334838, 38664.80667596644, 39051.41422878716, 39144.80427597844, 39328.80335598304, 39674.801625991684, 49832.501674982785, 52529.17120774275, 52642.21036684376, 53045.247534156435, 54212.728936355066, 7258.528195667264, 7535.777064940018, 7596.620168991418, 7653.57905315213, 8035.879461807961, 9725.9027409725, 11862.881371186179, 11992.76014479723, 12202.694932626755, 12728.363581821057, 10549.52527136296, 10556.788864222826, 10592.523336450033, 10643.201759867887, 10758.246922715334, 9752.951235244062, 10089.747756306151, 10343.793124137324, 10484.737881553023, 10776.245662803529, 9312.48781317034, 9515.857262140935, 10027.749306267402, 10160.593576256866, 11023.61417350389, 7587.848243035219, 7713.382929365749, 7719.610470115433, 7810.336121429515, 7981.122076571456, 9885.258605604464, 9988.300818942604, 10242.180625549789, 10539.367637941748, 10874.67375978722], "value": 7854.1352253917485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.0143884892084, 1324.4569726412174, 1351.6485713714433, 1401.9649508762286, 1653.37998250656, 6649.667516624168, 7178.497505174633, 7451.888221676679, 7468.178500364969, 7672.616369181546, 7519.624018799065, 7583.84832303355, 7585.620718964044, 7589.582572958485, 7593.810154746134, 2087.478130467387, 2123.957520849582, 2125.043730321354, 2125.3092744857904, 2129.0419311309897, 2048.4469193317796, 2073.5645514441985, 2097.7063211150453, 2100.0864623888656, 2102.201163557846, 2043.1520918818671, 2043.632146213681, 2046.0, 2053.27108876349, 2064.576761763842, 2067.5658111796542, 2072.7305450291515, 2075.5226297951554, 2075.9065842036994, 2077.210659949225, 2039.3372154049994, 2040.84693647977, 2065.927692530754, 2066.2561477867957, 2067.865588736727, 7129.750458733919, 7245.384142347854, 7355.411567074675, 7358.77923662291, 7464.0, 4289.914201715979, 4409.51495335516, 4413.095315460355, 4414.227510185705, 4415.050764085705, 2723.891044358223, 2810.5924640927155, 2862.613547171126, 2872.8563571821533, 2872.8850845966135, 962.3407965543626, 967.685502211784, 977.4184360305607, 984.5077461269366, 988.3476905242577, 10019.74950626233, 10108.848367274497, 10112.94943525285, 10120.0, 10126.088652021279, 3953.604639536081, 3964.781936993493, 4077.510698716114, 4093.4678491795876, 4128.091819799639, 8012.919870801334, 8015.719449819228, 8017.959910200529, 8022.197780221931, 8025.879611805827, 4450.977745111254, 4453.864264612568, 4455.329251530676, 4455.532169122261, 4456.46522417312, 3591.6587924147166, 3737.9626203738158, 4043.959560404417, 4120.567340429272, 4126.8761937141935, 3203.8878639247982, 3224.5808044954006, 3329.3840639481773, 3360.1767566946255, 3368.326334733063, 965.8502932045544, 973.1533565797802, 975.8341082016075, 979.6669132494986, 998.552099455792, 745.1840234942729, 748.9513181643176, 759.5366826235992, 773.9148693643695, 794.6741835847275, 4778.498257682893, 4837.201861692782, 4859.416869975626, 4882.780274887638, 5023.14606516893, 375.88347612240295, 384.4272034668324, 385.95368555773484, 386.0349127182045, 396.8749843799194, 3383.5263063171174, 3388.2715216228135, 3399.2351720863103, 3427.2974040321674, 3493.94759078614, 8999.82000359989, 9279.72160835176, 9285.953570232106, 9298.488583127993, 9309.767255818659, 9379.155875971059, 9395.624175032923, 9403.811923761486, 9413.57638906251, 9426.387284826464, 7082.575045497287, 7089.0, 7142.142942846892, 7204.459665525002, 7216.170140433812, 4725.0, 4804.471508134172, 4825.4933232010135, 4855.732934688626, 4924.581410580141, 8557.101504341954, 8564.614592343483, 8617.05212426645, 8647.0920553341, 8649.697260595849, 8336.333093352638, 8669.826603467769, 8678.305735541267, 8733.432326898732, 8971.058038905821, 5848.883022339444, 6457.128287681103, 6601.438877695257, 6602.0, 6603.0, 6498.350164983653, 6692.163479565054, 6718.160229971254, 6719.160104986877, 6724.0, 6350.7459701611415, 6393.488520918222, 6447.194100737408, 6463.676816159267, 6654.500912431684, 6313.43179113882, 6332.081848131903, 6333.145025421509, 6338.080978258219, 6346.174997250328, 5722.370539240764, 5817.94182058174, 5821.505172060422, 5826.213461182856, 5828.154917537018, 4192.580741925783, 4251.149770046065, 4266.829326827016, 4277.123189746032, 4442.355858400579, 4215.494140703136, 4342.9348559771, 4397.934030989473, 4432.312991486325, 4613.354130421811], "value": 3834.1801221213136, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.27905480551993, 285.71143145423116, 290.50033941620404, 294.17923992062146, 304.5036590357717, 4665.1136284106, 4780.928286075708, 4786.928196077058, 4829.855104346866, 4864.3433136526555, 4758.452777930539, 4762.380890484233, 4773.856784296477, 4777.474477807447, 4781.928271075936, 3564.1980554375186, 3622.8044745234142, 3686.9353162229236, 3798.525184351956, 3814.294355544233, 3707.202951365456, 3730.5077968812557, 3735.9252814943684, 3754.624537546251, 3759.1166075972124, 3736.458213559032, 3737.177820879402, 3739.121306492972, 3744.1388480649466, 3756.9624303757023, 3542.8051457169845, 3626.8005259710703, 3654.835532401048, 3736.3461394256033, 3751.7748935063846, 3274.2469232076755, 3327.38443387974, 3334.3998080345527, 3342.782719123249, 3349.765516413852, 4599.862004139881, 4604.631629469634, 4608.493065762764, 4609.147307748044, 4626.282926146453, 4179.164167166548, 4213.778004378757, 4217.789110544491, 4252.383404406375, 4271.722338048017, 4967.155583550769, 4969.18008528596, 4981.178105612606, 4987.102321582114, 4987.600991920638, 3615.620359862203, 3619.0952261934517, 3620.294042661682, 3623.5832879218965, 3633.1098880774116, 5140.228965655182, 5208.114620514484, 5236.21456781482, 5236.633435659505, 5239.764210610493, 3483.4774783782127, 3610.891673249807, 3636.3636363636256, 3645.2527231917393, 3718.981405092957, 3675.228202077594, 3682.558093028854, 3687.391580389206, 3688.0, 3689.612590677994, 4218.599233072853, 4225.767582782976, 4228.9577104228565, 4236.216299984513, 4255.212785634606, 4721.0, 4952.4057113146655, 4953.6532442729385, 4972.279019542146, 4988.825391111293, 1242.589945318043, 1270.3457719274581, 1275.196626125535, 1276.7063575377715, 1277.9424925878359, 801.8436404900988, 807.7818988873089, 819.3404309530765, 826.9710560130367, 833.5582141465034, 3928.332183528807, 3940.3796475343574, 4213.0, 4294.6993710439965, 4346.217680817484, 5098.515641014098, 5103.438621751604, 5105.668131571436, 5139.8458046258675, 5143.456962911187, 4368.672349573794, 4384.298512238027, 4389.956100438954, 4391.187630288407, 4419.889502762392, 2608.5695860183237, 2677.0764086390163, 2695.0, 2709.647745793034, 2713.6431784107945, 4842.927356089662, 4843.854684359475, 4846.830360937421, 4847.515248475195, 4851.296561998491, 5193.792248310101, 5227.60792940531, 5242.689327668083, 5261.29008072378, 5281.181416880389, 4589.701669391479, 4798.73606951621, 4815.759212039384, 4847.733374664357, 4899.3053820399355, 5063.392392912874, 5136.922946155885, 5137.431284357821, 5149.845504634867, 5185.792568297376, 5044.319016932667, 5046.520580544842, 5048.444671086251, 5051.494850514919, 5069.225770980128, 4670.3695001175765, 4849.927251091166, 4854.417469903634, 4854.83008094715, 4864.659473836798, 3575.946360804538, 3580.4629305604367, 3584.741612783929, 3586.336527742376, 3590.640935906493, 5097.61767867404, 5155.226715992631, 5156.871078223075, 5165.199394093921, 5167.483251674803, 4832.130216561053, 4979.0, 5014.473480284518, 5021.573166280907, 5033.521815427529, 4994.828284039589, 5007.624428167975, 5009.5992320615, 5015.84952451427, 5020.974895125647, 4917.795140190533, 4935.383077115361, 4941.234108713155, 4943.184374578154, 4949.183384741477, 4777.21176005969, 4788.521147885183, 4996.552378858576, 5018.422881368543, 5044.8234311798915, 4796.424429068395, 4816.34979277807, 4925.6305777066145, 4929.433115191799, 4938.333325001079], "value": 3749.5055411994767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4107545602026, 649.6426965169156, 658.4304576541293, 702.2310569925929, 704.8590281943609, 12768.744625107503, 13677.110987785787, 13716.931415342935, 13723.931380343096, 13735.519256826014, 11473.139514536422, 11601.825972610417, 11619.360935148563, 11663.300201987866, 11737.0, 609.0, 629.0941044895359, 732.2787054751066, 742.2725728785794, 743.4238465189494, 754.1779460388176, 756.3155344413315, 756.527170518426, 756.6065645864147, 757.1595528962847, 804.3846457460048, 805.0178781886119, 805.7663277649503, 805.8549461097, 805.8871757953862, 638.3010603389305, 652.1359199061263, 767.5970115689252, 787.6376866641352, 803.6825453945688, 579.3800633322347, 579.8028670252135, 579.9072148456269, 579.9159121927297, 579.9594028418012, 12618.17981831178, 12640.241585504898, 12652.873471265262, 12660.620181394574, 12673.0, 11900.226485278428, 12247.0, 12265.57070502528, 12560.685982850411, 12784.424700888483, 10876.945615271952, 11063.502142403531, 11092.889071109266, 11135.276207046516, 11186.049185819214, 3869.8241351152174, 3932.4101384792225, 3949.4668219790246, 4025.054112283611, 4110.136871257039, 61528.0, 61709.34958333576, 61714.69142654258, 62290.37709622891, 62941.6852915737, 9050.140236677506, 9331.486768227813, 9354.298427617956, 9356.625734970661, 9493.477858717699, 18483.537911552048, 18501.44495665132, 18519.72220416695, 18533.351332703292, 18542.629147416978, 6391.520635952322, 6464.127342808754, 6479.870402591921, 6607.174103237096, 6698.866022679616, 3282.7537934654997, 3286.193814924417, 3351.379994700988, 3359.076254030161, 3397.320535892782, 2611.7518835710575, 2682.986585067062, 2696.433748912711, 2704.9053283134995, 2705.174921648916, 464.2826832543728, 468.7515616723142, 477.6298368764166, 491.78115738496024, 491.89178380756175, 469.4319872953696, 482.9251466022772, 483.58653351384766, 484.94180698316427, 516.1071346570454, 6563.409293163638, 6837.62393068386, 6893.28614863185, 7034.8944765828555, 7070.080889484437, 435.48612637087905, 435.7821089455272, 474.2293772619493, 495.6035171862496, 526.557691539109, 3154.763392745553, 3443.8450269737923, 3475.113845969312, 3492.5983511895947, 3526.8589256429455, 56427.43572564304, 59281.70359148177, 100061.49969250253, 104536.47731761445, 104643.0, 52197.7390113047, 63462.682686586275, 85008.0, 89699.0, 90442.0, 68371.3162868375, 75769.24230757733, 76466.61766691243, 76611.61694191494, 76830.61584692041, 6406.455451286693, 6464.256610489666, 6642.535022548568, 6655.833604159935, 6685.097511836035, 36442.0, 36936.63063369332, 37388.0, 42276.57723422726, 46252.76873615745, 53938.0, 58421.0, 58905.0, 60630.696846515486, 61459.69270153621, 8489.235968762841, 8798.0, 9944.0, 10349.534270957674, 10438.791224175626, 9889.258305626963, 9995.500224988577, 10123.291369604058, 10766.246362754531, 10778.838317425401, 9014.774630634025, 9143.817123657356, 9330.813383732424, 9692.224622030362, 9692.75768105803, 9201.125893040151, 9377.202937750095, 9652.517374131407, 9840.704778856645, 9940.751481213027, 8885.555722213992, 10284.537195826057, 10627.36235825853, 11361.886381136082, 11430.714232144262, 9116.589753461243, 9242.907570924204, 9381.390209636353, 9487.383320084173, 10085.445300508543, 8758.386912916034, 8797.868031979653, 8869.911300887166, 8903.777405564913, 9169.266458683423], "value": 6029.949655490104, "unit": "score"}], "name": "dromaeo_css", "value": 6153.159081413738, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 116.0, 114.0, 114.0, 116.0, 112.0, 112.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 124.0, 174.0, 127.0, 130.0, 124.0, 125.0, 160.0, 128.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 159.0, 163.0, 162.0, 164.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 107.0, 77.0, 76.0, 77.0, 75.0, 97.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 85.0, 85.0, 83.0, 115.0, 84.0, 83.0, 113.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 64.0, 65.0, 63.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 81.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 133.0, 139.0, 133.0, 134.0, 135.0, 137.0, 179.0, 146.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 176.0, 177.0, 172.0, 177.0, 182.0, 175.0, 176.0, 175.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 72.0, 70.0, 70.0, 73.0, 70.0, 68.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1545.3999999999999, "alertThreshold": 2.0}]} 07:10:39 INFO - Return code: 0 07:10:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:10:39 INFO - # TBPL SUCCESS # 07:10:39 INFO - Running post-action listener: _resource_record_post_action 07:10:39 INFO - [mozharness: 2016-09-26 14:10:39.215723Z] Finished run-tests step (success) 07:10:39 INFO - Running post-run listener: _resource_record_post_run 07:10:39 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 402595840; Read time: 132; Write time: 250796 07:10:39 INFO - TinderboxPrint: CPU usage
13.0% 07:10:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 132 07:10:39 INFO - TinderboxPrint: I/O write bytes / time
402,595,840 / 250,796 07:10:39 INFO - TinderboxPrint: CPU idle
8,344.3 (87.0%) 07:10:39 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 07:10:39 INFO - TinderboxPrint: Swap in / out
0 / 0 07:10:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99958784; Read time: 0; Write time: 73580 07:10:39 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291278848; Read time: 120; Write time: 174032 07:10:39 INFO - Running post-run listener: _upload_blobber_files 07:10:39 INFO - Blob upload gear active. 07:10:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:10:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:41 INFO - (blobuploader) - INFO - Done attempting. 07:10:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:41 INFO - (blobuploader) - INFO - Done attempting. 07:10:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:47 INFO - (blobuploader) - INFO - Done attempting. 07:10:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:47 INFO - Return code: 0 07:10:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63dd9f611acec1664d94f20a4bcca7e8da550e38d02988b9f531abdf3a1108736ef30328a7d2364e02f10ab89a8fa0aaff4b6cb0114d9bcba69a1f303b4f21d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7994ab1b1c17b8a03c9b2485c50a2a590979f3c4e748a68574290aaa6c9cd72d5e98e617292f16178c3f8900daa5bc8765034310ec5a86d35320339650dd2419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/df8aadc935828707a960ae184f3cd1d776519c16bf9db43c6d29196464ffaac4f00f7ba53687a417745a0eddb4f6d2e2c83f8e9dad895cac0c8bcc8861ce17fc"} 07:10:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:47 INFO - Contents: 07:10:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63dd9f611acec1664d94f20a4bcca7e8da550e38d02988b9f531abdf3a1108736ef30328a7d2364e02f10ab89a8fa0aaff4b6cb0114d9bcba69a1f303b4f21d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7994ab1b1c17b8a03c9b2485c50a2a590979f3c4e748a68574290aaa6c9cd72d5e98e617292f16178c3f8900daa5bc8765034310ec5a86d35320339650dd2419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/df8aadc935828707a960ae184f3cd1d776519c16bf9db43c6d29196464ffaac4f00f7ba53687a417745a0eddb4f6d2e2c83f8e9dad895cac0c8bcc8861ce17fc"} 07:10:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:47 INFO - Copying logs to upload dir... 07:10:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.739806 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-26 07:10:46.883163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:10:46.888093) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 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/63dd9f611acec1664d94f20a4bcca7e8da550e38d02988b9f531abdf3a1108736ef30328a7d2364e02f10ab89a8fa0aaff4b6cb0114d9bcba69a1f303b4f21d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7994ab1b1c17b8a03c9b2485c50a2a590979f3c4e748a68574290aaa6c9cd72d5e98e617292f16178c3f8900daa5bc8765034310ec5a86d35320339650dd2419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/df8aadc935828707a960ae184f3cd1d776519c16bf9db43c6d29196464ffaac4f00f7ba53687a417745a0eddb4f6d2e2c83f8e9dad895cac0c8bcc8861ce17fc"} build_url:https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/dNEXe6zHSz2W65ehzzbWHQ/artifacts/public/build/firefox-52.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/63dd9f611acec1664d94f20a4bcca7e8da550e38d02988b9f531abdf3a1108736ef30328a7d2364e02f10ab89a8fa0aaff4b6cb0114d9bcba69a1f303b4f21d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7994ab1b1c17b8a03c9b2485c50a2a590979f3c4e748a68574290aaa6c9cd72d5e98e617292f16178c3f8900daa5bc8765034310ec5a86d35320339650dd2419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/df8aadc935828707a960ae184f3cd1d776519c16bf9db43c6d29196464ffaac4f00f7ba53687a417745a0eddb4f6d2e2c83f8e9dad895cac0c8bcc8861ce17fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:10:46.916016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:10:46.916359) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474897594.13987-1532967749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:10:46.995479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:10:46.998837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:10:46.999155) ========= ========= Total master_lag: 0.18 =========