builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1471357048.23 results: success (0) buildid: 20160816053001 builduid: 310eae5b6877439b93b1a4324da4fded revision: dd8193695d2d56667f22a32b77adc243a034cfd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.225537) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.226001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.226364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.262537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.262844) ========= 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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 07:17:28-- 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% 46.6M=0s 2016-08-16 07:17:28 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.384954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.385310) ========= 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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015870 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.435525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:28.435919) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd8193695d2d56667f22a32b77adc243a034cfd2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dd8193695d2d56667f22a32b77adc243a034cfd2 --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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 07:17:28,974 truncating revision to first 12 chars 2016-08-16 07:17:28,974 Setting DEBUG logging. 2016-08-16 07:17:28,974 attempt 1/10 2016-08-16 07:17:28,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd8193695d2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 07:17:29,270 unpacking tar archive at: fx-team-dd8193695d2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:29.122783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:29.123115) ========= script_repo_revision: dd8193695d2d56667f22a32b77adc243a034cfd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:29.123598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:29.123923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 07:17:29.134146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-16 07:17:29.134495) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:29 INFO - MultiFileLogger online at 20160816 07:17:29 in /builds/slave/test 07:17:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:17:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:29 INFO - {'append_to_log': False, 07:17:29 INFO - 'base_work_dir': '/builds/slave/test', 07:17:29 INFO - 'blob_upload_branch': 'Fx-Team', 07:17:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:29 INFO - 'branch': 'Fx-Team', 07:17:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:29 INFO - 'config_files': ('talos/linux_config.py',), 07:17:29 INFO - 'default_actions': ('clobber', 07:17:29 INFO - 'read-buildbot-config', 07:17:29 INFO - 'download-and-extract', 07:17:29 INFO - 'populate-webroot', 07:17:29 INFO - 'create-virtualenv', 07:17:29 INFO - 'install', 07:17:29 INFO - 'run-tests'), 07:17:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:29 INFO - 'download_minidump_stackwalk': True, 07:17:29 INFO - 'download_symbols': 'ondemand', 07:17:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:29 INFO - 'installer_path': 'installer.exe', 07:17:29 INFO - 'log_level': 'info', 07:17:29 INFO - 'log_name': 'talos', 07:17:29 INFO - 'log_to_console': True, 07:17:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:29 INFO - 'opt_config_files': (), 07:17:29 INFO - 'pip_index': False, 07:17:29 INFO - 'sps_profile': False, 07:17:29 INFO - 'sps_profile_interval': 0, 07:17:29 INFO - 'suite': 'dromaeojs', 07:17:29 INFO - 'system_bits': '32', 07:17:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:29 INFO - 'title': 'talos-linux64-ix-017', 07:17:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:29 INFO - 'use_talos_json': True, 07:17:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:29 INFO - 'work_dir': 'build'} 07:17:29 INFO - [mozharness: 2016-08-16 14:17:29.763475Z] Running clobber step. 07:17:29 INFO - Running pre-action listener: _resource_record_pre_action 07:17:29 INFO - Running main action method: clobber 07:17:29 INFO - rmtree: /builds/slave/test/build 07:17:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:30 INFO - Running post-action listener: _resource_record_post_action 07:17:30 INFO - [mozharness: 2016-08-16 14:17:30.222243Z] Finished clobber step (success) 07:17:30 INFO - [mozharness: 2016-08-16 14:17:30.222344Z] Running read-buildbot-config step. 07:17:30 INFO - Running pre-action listener: _resource_record_pre_action 07:17:30 INFO - Running main action method: read_buildbot_config 07:17:30 INFO - Using buildbot properties: 07:17:30 INFO - { 07:17:30 INFO - "project": "", 07:17:30 INFO - "product": "firefox", 07:17:30 INFO - "script_repo_revision": "production", 07:17:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:17:30 INFO - "repository": "", 07:17:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:17:30 INFO - "buildid": "20160816053001", 07:17:30 INFO - "pgo_build": "True", 07:17:30 INFO - "basedir": "/builds/slave/test", 07:17:30 INFO - "buildnumber": 1464, 07:17:30 INFO - "slavename": "talos-linux64-ix-017", 07:17:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:30 INFO - "platform": "ubuntu64_hw", 07:17:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:17:30 INFO - "branch": "fx-team", 07:17:30 INFO - "repo_path": "integration/fx-team", 07:17:30 INFO - "revision": "dd8193695d2d56667f22a32b77adc243a034cfd2", 07:17:30 INFO - "stage_platform": "linux64-pgo", 07:17:30 INFO - "builduid": "310eae5b6877439b93b1a4324da4fded", 07:17:30 INFO - "slavebuilddir": "test" 07:17:30 INFO - } 07:17:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:17:30 INFO - Running post-action listener: _resource_record_post_action 07:17:30 INFO - [mozharness: 2016-08-16 14:17:30.224773Z] Finished read-buildbot-config step (success) 07:17:30 INFO - [mozharness: 2016-08-16 14:17:30.224861Z] Running download-and-extract step. 07:17:30 INFO - Running pre-action listener: _resource_record_pre_action 07:17:30 INFO - Running main action method: download_and_extract 07:17:30 INFO - mkdir: /builds/slave/test/build/tests 07:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:30 INFO - trying https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:17:30 INFO - Downloaded 1361 bytes. 07:17:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:17:30 INFO - Using the following test package requirements: 07:17:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:17:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'jsshell-linux-x86_64.zip'], 07:17:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:30 INFO - trying https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:31 INFO - Downloaded 21837590 bytes. 07:17:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:17:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:17: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')]} 07:17:35 INFO - trying https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:17:35 INFO - Downloading https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:36 INFO - Downloaded 21837590 bytes. 07:17:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:17:41 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')]} 07:17:41 INFO - trying https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:41 INFO - Downloading https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:17:42 INFO - Downloaded 14413719 bytes. 07:17:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:42 INFO - trying https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:17:43 INFO - Downloaded 59438566 bytes. 07:17:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:17:43 INFO - mkdir: /builds/slave/test/properties 07:17:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:43 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:43 INFO - Contents: 07:17:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:17:44 INFO - Running post-action listener: _resource_record_post_action 07:17:44 INFO - Running post-action listener: set_extra_try_arguments 07:17:44 INFO - [mozharness: 2016-08-16 14:17:44.041560Z] Finished download-and-extract step (success) 07:17:44 INFO - [mozharness: 2016-08-16 14:17:44.041785Z] Running populate-webroot step. 07:17:44 INFO - Running pre-action listener: _resource_record_pre_action 07:17:44 INFO - Running main action method: populate_webroot 07:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:44 INFO - '--tppagecycles', 07:17:44 INFO - '7'], 07:17:44 INFO - 'tests': ['tsvgm']}}, 07:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['damp', 'tps']}, 07:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['damp', 'tps']}, 07:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['dromaeo_dom']}, 07:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['basic_compositor_video']}, 07:17:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tsvgx', 07:17:44 INFO - 'tsvgr_opacity', 07:17:44 INFO - 'tart', 07:17:44 INFO - 'tscrollx', 07:17:44 INFO - 'cart']}, 07:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:44 INFO - 'tsvgr_opacity', 07:17:44 INFO - 'tart', 07:17:44 INFO - 'tscrollx', 07:17:44 INFO - 'cart']}, 07:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tp5o']}, 07:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['tp5o']}, 07:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s', 07:17:44 INFO - '--xperf_path', 07:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:44 INFO - 'tests': ['tp5n']}, 07:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--xperf_path', 07:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:44 INFO - 'tests': ['tp5n']}}, 07:17:44 INFO - 'talos.zip': {'path': '', 07:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:44 INFO - Running post-action listener: _resource_record_post_action 07:17:44 INFO - [mozharness: 2016-08-16 14:17:44.058804Z] Finished populate-webroot step (success) 07:17:44 INFO - [mozharness: 2016-08-16 14:17:44.058892Z] Running create-virtualenv step. 07:17:44 INFO - Running pre-action listener: _resource_record_pre_action 07:17:44 INFO - Running main action method: create_virtualenv 07:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:44 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 07:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:44 INFO - Using real prefix '/usr' 07:17:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:46 INFO - Installing pip.................done. 07:17:46 INFO - Return code: 0 07:17:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:46 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:46 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 07:17:46 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 07:17:46 INFO - Using env: {'DISPLAY': ':0', 07:17:46 INFO - 'HOME': '/home/cltbld', 07:17:46 INFO - 'LANG': 'en_US.UTF-8', 07:17:46 INFO - 'LANGUAGE': 'en_US:en', 07:17:46 INFO - 'LOGNAME': 'cltbld', 07:17:46 INFO - 'MAIL': '/var/mail/cltbld', 07:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:46 INFO - 'MOZ_NO_REMOTE': '1', 07:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:46 INFO - 'NO_EM_RESTART': '1', 07:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:46 INFO - 'PWD': '/builds/slave/test', 07:17:46 INFO - 'SHELL': '/bin/bash', 07:17:46 INFO - 'SHLVL': '1', 07:17:46 INFO - 'TERM': 'linux', 07:17:46 INFO - 'TMOUT': '86400', 07:17:46 INFO - 'USER': 'cltbld', 07:17:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:46 INFO - '_': '/tools/buildbot/bin/python'} 07:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:46 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 07:17:46 INFO - Cleaning up... 07:17:46 INFO - Return code: 0 07:17:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:46 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:46 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 07:17:46 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 07:17:46 INFO - Using env: {'DISPLAY': ':0', 07:17:46 INFO - 'HOME': '/home/cltbld', 07:17:46 INFO - 'LANG': 'en_US.UTF-8', 07:17:46 INFO - 'LANGUAGE': 'en_US:en', 07:17:46 INFO - 'LOGNAME': 'cltbld', 07:17:46 INFO - 'MAIL': '/var/mail/cltbld', 07:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:46 INFO - 'MOZ_NO_REMOTE': '1', 07:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:46 INFO - 'NO_EM_RESTART': '1', 07:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:46 INFO - 'PWD': '/builds/slave/test', 07:17:46 INFO - 'SHELL': '/bin/bash', 07:17:46 INFO - 'SHLVL': '1', 07:17:46 INFO - 'TERM': 'linux', 07:17:46 INFO - 'TMOUT': '86400', 07:17:46 INFO - 'USER': 'cltbld', 07:17:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:46 INFO - '_': '/tools/buildbot/bin/python'} 07:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:47 INFO - Downloading/unpacking psutil>=3.1.1 07:17:47 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 07:17:47 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 07:17:47 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 07:17:47 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 07:17:47 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 07:17:47 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 07:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:49 INFO - Installing collected packages: psutil 07:17:49 INFO - Running setup.py install for psutil 07:17:49 INFO - building 'psutil._psutil_linux' extension 07:17:49 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 07:17:49 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 07:17:49 INFO - building 'psutil._psutil_posix' extension 07:17:49 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 07:17:49 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 07:17:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:49 INFO - Successfully installed psutil 07:17:49 INFO - Cleaning up... 07:17:49 INFO - Return code: 0 07:17:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:49 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:49 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 07:17:49 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 07:17:49 INFO - Using env: {'DISPLAY': ':0', 07:17:49 INFO - 'HOME': '/home/cltbld', 07:17:49 INFO - 'LANG': 'en_US.UTF-8', 07:17:49 INFO - 'LANGUAGE': 'en_US:en', 07:17:49 INFO - 'LOGNAME': 'cltbld', 07:17:49 INFO - 'MAIL': '/var/mail/cltbld', 07:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:49 INFO - 'MOZ_NO_REMOTE': '1', 07:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:49 INFO - 'NO_EM_RESTART': '1', 07:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:49 INFO - 'PWD': '/builds/slave/test', 07:17:49 INFO - 'SHELL': '/bin/bash', 07:17:49 INFO - 'SHLVL': '1', 07:17:49 INFO - 'TERM': 'linux', 07:17:49 INFO - 'TMOUT': '86400', 07:17:49 INFO - 'USER': 'cltbld', 07:17:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:49 INFO - '_': '/tools/buildbot/bin/python'} 07:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:49 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 07:17:49 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 07:17:49 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 07:17:49 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 07:17:49 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 07:17:49 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 07:17:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:51 INFO - Installing collected packages: mozsystemmonitor 07:17:51 INFO - Running setup.py install for mozsystemmonitor 07:17:51 INFO - Successfully installed mozsystemmonitor 07:17:51 INFO - Cleaning up... 07:17:51 INFO - Return code: 0 07:17:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:17:51 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')]} 07:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:51 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')]} 07:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:51 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:51 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 07:17:51 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 07:17:51 INFO - Using env: {'DISPLAY': ':0', 07:17:51 INFO - 'HOME': '/home/cltbld', 07:17:51 INFO - 'LANG': 'en_US.UTF-8', 07:17:51 INFO - 'LANGUAGE': 'en_US:en', 07:17:51 INFO - 'LOGNAME': 'cltbld', 07:17:51 INFO - 'MAIL': '/var/mail/cltbld', 07:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:51 INFO - 'MOZ_NO_REMOTE': '1', 07:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:51 INFO - 'NO_EM_RESTART': '1', 07:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:51 INFO - 'PWD': '/builds/slave/test', 07:17:51 INFO - 'SHELL': '/bin/bash', 07:17:51 INFO - 'SHLVL': '1', 07:17:51 INFO - 'TERM': 'linux', 07:17:51 INFO - 'TMOUT': '86400', 07:17:51 INFO - 'USER': 'cltbld', 07:17:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:51 INFO - '_': '/tools/buildbot/bin/python'} 07:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:17:52 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 07:17:52 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 07:17:52 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 07:17:52 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 07:17:52 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 07:17:52 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 07:17:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:17:53 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 07:17:53 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 07:17:53 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 07:17:53 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 07:17:53 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 07:17:53 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 07:17:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:54 INFO - warning: no files found matching '*.txt' 07:17:54 INFO - no previously-included directories found matching 'build' 07:17:54 INFO - no previously-included directories found matching 'dist' 07:17:54 INFO - no previously-included directories found matching '.git*' 07:17:54 INFO - Installing collected packages: jsonschema, functools32 07:17:54 INFO - Running setup.py install for functools32 07:17:54 INFO - warning: no files found matching '*.txt' 07:17:54 INFO - no previously-included directories found matching 'build' 07:17:54 INFO - no previously-included directories found matching 'dist' 07:17:54 INFO - no previously-included directories found matching '.git*' 07:17:54 INFO - Successfully installed jsonschema functools32 07:17:54 INFO - Cleaning up... 07:17:54 INFO - Return code: 0 07:17:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:54 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:54 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 07:17:54 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 07:17:54 INFO - Using env: {'DISPLAY': ':0', 07:17:54 INFO - 'HOME': '/home/cltbld', 07:17:54 INFO - 'LANG': 'en_US.UTF-8', 07:17:54 INFO - 'LANGUAGE': 'en_US:en', 07:17:54 INFO - 'LOGNAME': 'cltbld', 07:17:54 INFO - 'MAIL': '/var/mail/cltbld', 07:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:54 INFO - 'MOZ_NO_REMOTE': '1', 07:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:54 INFO - 'NO_EM_RESTART': '1', 07:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:54 INFO - 'PWD': '/builds/slave/test', 07:17:54 INFO - 'SHELL': '/bin/bash', 07:17:54 INFO - 'SHLVL': '1', 07:17:54 INFO - 'TERM': 'linux', 07:17:54 INFO - 'TMOUT': '86400', 07:17:54 INFO - 'USER': 'cltbld', 07:17:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:54 INFO - '_': '/tools/buildbot/bin/python'} 07:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:17:54 INFO - Cleaning up... 07:17:54 INFO - Return code: 0 07:17:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:54 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:54 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 07:17:54 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 07:17:54 INFO - Using env: {'DISPLAY': ':0', 07:17:54 INFO - 'HOME': '/home/cltbld', 07:17:54 INFO - 'LANG': 'en_US.UTF-8', 07:17:54 INFO - 'LANGUAGE': 'en_US:en', 07:17:54 INFO - 'LOGNAME': 'cltbld', 07:17:54 INFO - 'MAIL': '/var/mail/cltbld', 07:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:54 INFO - 'MOZ_NO_REMOTE': '1', 07:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:54 INFO - 'NO_EM_RESTART': '1', 07:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:54 INFO - 'PWD': '/builds/slave/test', 07:17:54 INFO - 'SHELL': '/bin/bash', 07:17:54 INFO - 'SHLVL': '1', 07:17:54 INFO - 'TERM': 'linux', 07:17:54 INFO - 'TMOUT': '86400', 07:17:54 INFO - 'USER': 'cltbld', 07:17:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:54 INFO - '_': '/tools/buildbot/bin/python'} 07:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:54 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:54 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 07:17:54 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 07:17:54 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 07:17:54 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 07:17:54 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 07:17:54 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 07:17:56 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:56 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 07:17:56 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 07:17:56 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 07:17:56 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 07:17:56 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 07:17:56 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 07:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:57 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 07:17:57 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 07:17:57 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 07:17:57 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 07:17:57 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 07:17:57 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 07:17:57 INFO - Downloading docopt-0.6.1.tar.gz 07:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:57 INFO - Running setup.py install for blobuploader 07:17:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:57 INFO - Running setup.py install for requests 07:17:57 INFO - Running setup.py install for docopt 07:17:58 INFO - Successfully installed blobuploader requests docopt 07:17:58 INFO - Cleaning up... 07:17:58 INFO - Return code: 0 07:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:17:58 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 07:17:58 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 07:17:58 INFO - Using env: {'DISPLAY': ':0', 07:17:58 INFO - 'HOME': '/home/cltbld', 07:17:58 INFO - 'LANG': 'en_US.UTF-8', 07:17:58 INFO - 'LANGUAGE': 'en_US:en', 07:17:58 INFO - 'LOGNAME': 'cltbld', 07:17:58 INFO - 'MAIL': '/var/mail/cltbld', 07:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:58 INFO - 'MOZ_NO_REMOTE': '1', 07:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:58 INFO - 'NO_EM_RESTART': '1', 07:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:58 INFO - 'PWD': '/builds/slave/test', 07:17:58 INFO - 'SHELL': '/bin/bash', 07:17:58 INFO - 'SHLVL': '1', 07:17:58 INFO - 'TERM': 'linux', 07:17:58 INFO - 'TMOUT': '86400', 07:17:58 INFO - 'USER': 'cltbld', 07:17:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:58 INFO - '_': '/tools/buildbot/bin/python'} 07:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:58 INFO - Running setup.py (path:/tmp/pip-1UjtjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:58 INFO - Running setup.py (path:/tmp/pip-afuWx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:58 INFO - Running setup.py (path:/tmp/pip-Pn41Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:58 INFO - Running setup.py (path:/tmp/pip-cCaxwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:58 INFO - Running setup.py (path:/tmp/pip-FfAd1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:58 INFO - Running setup.py (path:/tmp/pip-vapWys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:58 INFO - Running setup.py (path:/tmp/pip-Pa7_3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:58 INFO - Running setup.py (path:/tmp/pip-4RCP9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:58 INFO - Running setup.py (path:/tmp/pip-fGyQrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:58 INFO - Running setup.py (path:/tmp/pip-Gjf0qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:59 INFO - Running setup.py (path:/tmp/pip-AtURPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:59 INFO - Running setup.py (path:/tmp/pip-qhy1ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:59 INFO - Running setup.py (path:/tmp/pip-W5Au74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:59 INFO - Running setup.py (path:/tmp/pip-uPpaVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:59 INFO - Running setup.py (path:/tmp/pip-aFLRVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:59 INFO - Running setup.py (path:/tmp/pip-1P1Hau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:59 INFO - Running setup.py (path:/tmp/pip-haPqnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:59 INFO - Running setup.py install for manifestparser 07:17:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:59 INFO - Running setup.py install for mozcrash 07:17:59 INFO - Running setup.py install for mozdebug 07:17:59 INFO - Running setup.py install for mozdevice 07:17:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:59 INFO - Running setup.py install for mozfile 07:18:00 INFO - Running setup.py install for mozhttpd 07:18:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozinfo 07:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozInstall 07:18:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozleak 07:18:00 INFO - Running setup.py install for mozlog 07:18:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for moznetwork 07:18:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozprocess 07:18:00 INFO - Running setup.py install for mozprofile 07:18:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozrunner 07:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Running setup.py install for mozscreenshot 07:18:01 INFO - Running setup.py install for moztest 07:18:01 INFO - Running setup.py install for mozversion 07:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:01 INFO - Cleaning up... 07:18:01 INFO - Return code: 0 07:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:18:01 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 07:18:01 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 07:18:01 INFO - Using env: {'DISPLAY': ':0', 07:18:01 INFO - 'HOME': '/home/cltbld', 07:18:01 INFO - 'LANG': 'en_US.UTF-8', 07:18:01 INFO - 'LANGUAGE': 'en_US:en', 07:18:01 INFO - 'LOGNAME': 'cltbld', 07:18:01 INFO - 'MAIL': '/var/mail/cltbld', 07:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:01 INFO - 'MOZ_NO_REMOTE': '1', 07:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:01 INFO - 'NO_EM_RESTART': '1', 07:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:01 INFO - 'PWD': '/builds/slave/test', 07:18:01 INFO - 'SHELL': '/bin/bash', 07:18:01 INFO - 'SHLVL': '1', 07:18:01 INFO - 'TERM': 'linux', 07:18:01 INFO - 'TMOUT': '86400', 07:18:01 INFO - 'USER': 'cltbld', 07:18:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:01 INFO - '_': '/tools/buildbot/bin/python'} 07:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:01 INFO - Running setup.py (path:/tmp/pip-ZxL0oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:01 INFO - Running setup.py (path:/tmp/pip-HziCzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:01 INFO - Running setup.py (path:/tmp/pip-WJJj6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:01 INFO - Running setup.py (path:/tmp/pip-bGsayc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:01 INFO - Running setup.py (path:/tmp/pip-l8NuZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:01 INFO - Running setup.py (path:/tmp/pip-_Pujan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:01 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)) 07:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:01 INFO - Running setup.py (path:/tmp/pip-_vufnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:02 INFO - Running setup.py (path:/tmp/pip-LNVuZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:02 INFO - Running setup.py (path:/tmp/pip-YPDXqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:02 INFO - Running setup.py (path:/tmp/pip-ut_RVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:02 INFO - Running setup.py (path:/tmp/pip-Dctxvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:02 INFO - Running setup.py (path:/tmp/pip-WJUR7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:02 INFO - Running setup.py (path:/tmp/pip-c2FFpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:02 INFO - Running setup.py (path:/tmp/pip-A24G_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:02 INFO - Running setup.py (path:/tmp/pip-fTwYf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:02 INFO - Running setup.py (path:/tmp/pip-8xwnp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:02 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)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:02 INFO - Running setup.py (path:/tmp/pip-cn0N52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:02 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)) 07:18:02 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)) 07:18:02 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)) 07:18:02 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)) 07:18:02 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)) 07:18:02 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)) 07:18:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:02 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 07:18:02 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 07:18:02 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 07:18:02 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 07:18:02 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 07:18:02 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 07:18:04 INFO - Downloading blessings-1.6.tar.gz 07:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:04 INFO - Installing collected packages: blessings 07:18:04 INFO - Running setup.py install for blessings 07:18:04 INFO - Successfully installed blessings 07:18:04 INFO - Cleaning up... 07:18:04 INFO - Return code: 0 07:18:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:05 INFO - Reading from file tmpfile_stdout 07:18:05 INFO - Current package versions: 07:18:05 INFO - argparse == 1.2.1 07:18:05 INFO - blessings == 1.6 07:18:05 INFO - blobuploader == 1.2.4 07:18:05 INFO - docopt == 0.6.1 07:18:05 INFO - functools32 == 3.2.3-2 07:18:05 INFO - jsonschema == 2.5.1 07:18:05 INFO - manifestparser == 1.1 07:18:05 INFO - mozInstall == 1.12 07:18:05 INFO - mozcrash == 0.17 07:18:05 INFO - mozdebug == 0.1 07:18:05 INFO - mozdevice == 0.48 07:18:05 INFO - mozfile == 1.2 07:18:05 INFO - mozhttpd == 0.7 07:18:05 INFO - mozinfo == 0.9 07:18:05 INFO - mozleak == 0.1 07:18:05 INFO - mozlog == 3.3 07:18:05 INFO - moznetwork == 0.27 07:18:05 INFO - mozprocess == 0.23 07:18:05 INFO - mozprofile == 0.28 07:18:05 INFO - mozrunner == 6.12 07:18:05 INFO - mozscreenshot == 0.1 07:18:05 INFO - mozsystemmonitor == 0.3 07:18:05 INFO - moztest == 0.7 07:18:05 INFO - mozversion == 1.4 07:18:05 INFO - psutil == 3.1.1 07:18:05 INFO - requests == 1.2.3 07:18:05 INFO - wsgiref == 0.1.2 07:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:18:05 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 07:18:05 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 07:18:05 INFO - Using env: {'DISPLAY': ':0', 07:18:05 INFO - 'HOME': '/home/cltbld', 07:18:05 INFO - 'LANG': 'en_US.UTF-8', 07:18:05 INFO - 'LANGUAGE': 'en_US:en', 07:18:05 INFO - 'LOGNAME': 'cltbld', 07:18:05 INFO - 'MAIL': '/var/mail/cltbld', 07:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:05 INFO - 'MOZ_NO_REMOTE': '1', 07:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:05 INFO - 'NO_EM_RESTART': '1', 07:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:05 INFO - 'PWD': '/builds/slave/test', 07:18:05 INFO - 'SHELL': '/bin/bash', 07:18:05 INFO - 'SHLVL': '1', 07:18:05 INFO - 'TERM': 'linux', 07:18:05 INFO - 'TMOUT': '86400', 07:18:05 INFO - 'USER': 'cltbld', 07:18:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:05 INFO - '_': '/tools/buildbot/bin/python'} 07:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 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)) 07:18:05 INFO - Cleaning up... 07:18:05 INFO - Return code: 0 07:18:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 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 0x7f77dabeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, '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': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', '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 07:18:05 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 07:18:05 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 07:18:05 INFO - Using env: {'DISPLAY': ':0', 07:18:05 INFO - 'HOME': '/home/cltbld', 07:18:05 INFO - 'LANG': 'en_US.UTF-8', 07:18:05 INFO - 'LANGUAGE': 'en_US:en', 07:18:05 INFO - 'LOGNAME': 'cltbld', 07:18:05 INFO - 'MAIL': '/var/mail/cltbld', 07:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:05 INFO - 'MOZ_NO_REMOTE': '1', 07:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:05 INFO - 'NO_EM_RESTART': '1', 07:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:05 INFO - 'PWD': '/builds/slave/test', 07:18:05 INFO - 'SHELL': '/bin/bash', 07:18:05 INFO - 'SHLVL': '1', 07:18:05 INFO - 'TERM': 'linux', 07:18:05 INFO - 'TMOUT': '86400', 07:18:05 INFO - 'USER': 'cltbld', 07:18:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:05 INFO - '_': '/tools/buildbot/bin/python'} 07:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:18:05 INFO - Cleaning up... 07:18:05 INFO - Return code: 0 07:18:05 INFO - Running post-action listener: _resource_record_post_action 07:18:05 INFO - Running post-action listener: _start_resource_monitoring 07:18:05 INFO - Starting resource monitoring. 07:18:05 INFO - [mozharness: 2016-08-16 14:18:05.643323Z] Finished create-virtualenv step (success) 07:18:05 INFO - [mozharness: 2016-08-16 14:18:05.643929Z] Running install step. 07:18:05 INFO - Running pre-action listener: _resource_record_pre_action 07:18:05 INFO - Running main action method: install 07:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:05 INFO - Reading from file tmpfile_stdout 07:18:05 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:18:05 INFO - Reading from file tmpfile_stdout 07:18:05 INFO - Output received: 07:18:05 INFO - Usage: mozinstall [options] installer 07:18:05 INFO - Options: 07:18:05 INFO - -h, --help show this help message and exit 07:18:05 INFO - -d DEST, --destination=DEST 07:18:05 INFO - Directory to install application into. [default: 07:18:05 INFO - "/builds/slave/test"] 07:18:05 INFO - --app=APP Application being installed. [default: firefox] 07:18:05 INFO - mkdir: /builds/slave/test/build/application 07:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:18:22 INFO - Reading from file tmpfile_stdout 07:18:22 INFO - Output received: 07:18:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:22 INFO - Running post-action listener: _resource_record_post_action 07:18:22 INFO - [mozharness: 2016-08-16 14:18:22.893406Z] Finished install step (success) 07:18:22 INFO - [mozharness: 2016-08-16 14:18:22.893652Z] Running run-tests step. 07:18:22 INFO - Running pre-action listener: _resource_record_pre_action 07:18:22 INFO - Running main action method: run_tests 07:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:22 INFO - Python 2.7.3 07:18:22 INFO - Return code: 0 07:18:22 INFO - grabbing minidump binary from tooltool 07:18: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')]} 07:18:22 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 0x1675370>, '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 0x16788f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1678d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:22 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 07:18:22 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 07:18:22 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 07:18:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:22 INFO - Return code: 0 07:18:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 07:18:22 INFO - Using env: {'DISPLAY': ':0', 07:18:22 INFO - 'HOME': '/home/cltbld', 07:18:22 INFO - 'LANG': 'en_US.UTF-8', 07:18:22 INFO - 'LANGUAGE': 'en_US:en', 07:18:22 INFO - 'LOGNAME': 'cltbld', 07:18:22 INFO - 'MAIL': '/var/mail/cltbld', 07:18:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:22 INFO - 'MOZ_NO_REMOTE': '1', 07:18:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:22 INFO - 'NO_EM_RESTART': '1', 07:18:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:22 INFO - 'PWD': '/builds/slave/test', 07:18:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:22 INFO - 'SHELL': '/bin/bash', 07:18:22 INFO - 'SHLVL': '1', 07:18:22 INFO - 'TERM': 'linux', 07:18:22 INFO - 'TMOUT': '86400', 07:18:22 INFO - 'USER': 'cltbld', 07:18:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110', 07:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:22 INFO - '_': '/tools/buildbot/bin/python'} 07:18:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:18:23 INFO - mozversion application_buildid: 20160816053001 07:18:23 INFO - mozversion application_changeset: dd8193695d2d56667f22a32b77adc243a034cfd2 07:18:23 INFO - mozversion application_display_name: Nightly 07:18:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:23 INFO - mozversion application_name: Firefox 07:18:23 INFO - mozversion application_remotingname: firefox 07:18:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:18:23 INFO - mozversion application_vendor: Mozilla 07:18:23 INFO - mozversion application_version: 51.0a1 07:18:23 INFO - mozversion platform_buildid: 20160816053001 07:18:23 INFO - mozversion platform_changeset: dd8193695d2d56667f22a32b77adc243a034cfd2 07:18:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:18:23 INFO - mozversion platform_version: 51.0a1 07:18:23 INFO - using testdate: 1471357103 07:18:23 INFO - actual date: 1471357103 07:18:23 INFO - starting webserver on 'localhost:53858' 07:18:23 INFO - SUITE-START | Running 2 tests 07:18:23 INFO - TEST-START | dromaeo_css 07:18:23 INFO - operating with platform_type : linux_ 07:18:23 INFO - Initialising browser for dromaeo_css test... 07:18:23 INFO - TEST-INFO | started process 10452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiqMDK/profile http://localhost:53858/getInfo.html) 07:18:26 INFO - PROCESS | 10452 | __metrics Screen width/height:1600/1200 07:18:26 INFO - PROCESS | 10452 | colorDepth:24 07:18:26 INFO - PROCESS | 10452 | Browser inner width/height: 1024/697 07:18:26 INFO - PROCESS | 10452 | __metrics 07:18:27 INFO - PROCESS | 10452 | 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:18:27 INFO - PROCESS | 10452 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:27 INFO - PROCESS | 10452 | console.error: PushService: 07:18:27 INFO - PROCESS | 10452 | stateChangeProcessEnqueue: Error transitioning state 07:18:27 INFO - PROCESS | 10452 | UnknownError 07:18:28 INFO - TEST-INFO | 10452: exit 0 07:18:28 INFO - Browser initialized. 07:18:28 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:28 INFO - TEST-INFO | started process 10536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiqMDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:40 INFO - PROCESS | 10536 | RSS: Main: 156078080 07:18:40 INFO - PROCESS | 10536 | 07:19:31 INFO - PROCESS | 10536 | 1471357171242 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] 07:21:40 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53858/tests/dromaeo/cssquery-ext.html) 07:21:41 INFO - PROCESS | 10536 | RSS: Main: 241147904 07:21:41 INFO - PROCESS | 10536 | 07:24:44 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-ext.html (next: http://localhost:53858/tests/dromaeo/cssquery-jquery.html) 07:24:44 INFO - PROCESS | 10536 | RSS: Main: 240185344 07:24:44 INFO - PROCESS | 10536 | 07:27:46 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53858/tests/dromaeo/cssquery-mootools.html) 07:27:47 INFO - PROCESS | 10536 | RSS: Main: 220139520 07:27:47 INFO - PROCESS | 10536 | 07:30:49 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53858/tests/dromaeo/cssquery-prototype.html) 07:30:49 INFO - PROCESS | 10536 | RSS: Main: 228278272 07:30:49 INFO - PROCESS | 10536 | 07:33:52 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53858/tests/dromaeo/cssquery-yui.html) 07:33:53 INFO - PROCESS | 10536 | RSS: Main: 191102976 07:33:53 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | Cycle 1(1): loaded http://localhost:53858/tests/dromaeo/cssquery-yui.html (next: http://localhost:53858/tests/dromaeo/cssquery-dojo.html) 07:36:56 INFO - PROCESS | 10536 | RSS: Main: 279781376 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | __start_tp_report 07:36:56 INFO - PROCESS | 10536 | _x_x_mozilla_page_load 07:36:56 INFO - PROCESS | 10536 | _x_x_mozilla_page_load_details 07:36:56 INFO - PROCESS | 10536 | |i|pagename|runs| 07:36:56 INFO - PROCESS | 10536 | |0;dojo.html;3052.938941221176;3071.20148761322;3087.521434177702;3101.596792416987;3108.9844550777243;5143.588512918966;5228.92156617651;5282.894342113155;5354.73226338683;5428.75570599323;5269.1832765921245;5272.288241087452;5348.705821179834;5388.7305634718205;5411.215373770801;4813.13363594552;4825.227963525819;4849.733264670442;4863.051704917542;4963.0818298614695;4845.176320025586;4903.950960490403;4918.852434426973;4932.457429682732;4960.181570040939;4702.13010593038;4747.715137091785;4754.500777418356;4832.661713680044;4836.443808961962;4767.880802979918;4793.496682848286;4796.352492413549;4799.9760001199775;4844.006978569385;4713.670043096985;4722.551357621055;4806.735629540374;4881.072596206709;4884.218525036013;5278.894422111536;5285.735713214324;5292.867678308035;5341.65279256847;5350.892982140374;5417.702026388547;5522.364928033247;5705.486506214419;5710.942890571124;5724.026915424388;5620.494155526022;5636.182753500761;5690.317161940552;5705.62913410627;5718.313802343704;5306.495882891119;5307.310049693554;5336.4129945705945;5338.412774594792;5338.599605029638;5636.436356364413;5770.365259821417;5814.447627475383;5843.970780146072;5860.120981852671;5630.746616402272;5634.04221282383;5667.773289068474;5681.318241811009;5686.744096515667;5714.085746280575;5770.134479827975;5777.566682498829;5779.133130030529;5782.10377391505;5393.514583687487;5539.667619942817;5548.805791797267;5702.486776190163;5716.828495145152;5639.154126881001;5641.915371269434;5675.347335056521;5679.971600141973;5684;4319.8488052918;4354.8911277217685;4357.215701173755;4362.672799540047;4389.670774691911;3816.4656948026745;3827.081500439874;3881;3899.2396482685604;3930.371140617545;5323.414424413311;5376.354837419456;5406.378266499324;5416.404195538487;5441.619086663895;5651.886962260814;5698.4871361576825;5702.714864256771;5705.4579814917515;5708.914366284509;5212.113940630102;5243.4232234454175;5382.542483888913;5391.56867450603;5396.325459317585;4880.6583539152625;4914.434839993446;4931.137051016058;4955.975220123948;4967.130752118364;5837.299524057055;5866.2373891393845;5874.735636896436;5878;5882.088276317178;5458.536024437967;5602.719864006702;5611.719414029364;5687.43125687428;5728.198052272768;5820.505257053029;5850.12248162762;5882.970585147047;5917.171595976481;5953.464188223081;5534.280543529477;5562.082256427644;5566.638168519034;5572.804951826666;5593.720313984366;5438.918416223681;5510.118381059011;5660.179274005329;5674.943250567607;5690.146478028329;5529.944700553104;5631.718414079198;5645.68948707825;5647.435256474319;5648.661080335193;5562.471565201299;5600.35595906476;5612.719364031864;5615.971920140373;5619.438056194512;5385.838424847261;5478.972605136949;5568.49883510486;5619.185218143264;5637.069883469182;5571.05292100352;5621.943780562142;5642.717864106696;5681.9147712783515;5690.032694442038;5496.862578435411;5507.091329930677;5507.862303442446;5510.035743744908;5511.807086751945 07:36:56 INFO - PROCESS | 10536 | |1;ext.html;592.2419303291787;624.4504835744544;625.3152797686531;626.0609086370445;636.2079211381828;32268.515972260404;35292.294154116935;43124.784376078074;44120.01459934311;44457.33314000293;44456.66520017602;45087.77456112723;45221;45237.32144017842;45263.77368113163;8853.513056781874;8996.460212387245;9004.729858104267;9008.819823603524;9015.188633023026;8808.207261346477;8899.95550022249;8900.8664870027;8907;8907.287417006624;8885.2447541959;8891.911080889206;8936.151065648754;8983.730488085368;8987.955060224722;8759.78100547485;8809.163129502718;8819.073997230262;8839.381243312971;8890.022097569263;8891.644334226623;8935;8964.775880603038;8974.326925480615;8983.416077954913;40853.59146408528;41132.588674113475;41208.1758364834;41220.38169427461;41269.58730412687;3290.6380298167182;3671.7429779915415;3808.6953043756434;4157.334826427757;4334.804933777988;31117;31838.522422163685;32057.038288851138;32099.197520062186;32155.302140253938;4324.991047626628;4381.912361752779;4420.359047938031;4463.218936686099;4469.10617876426;332788;333545;335745.99999999756;336666;336790;57495.425045749005;57532.71233643805;57693.13460298099;57880;57938.4206157933;59633;60311.698441508386;60471;60489.395106049255;60529.46029047839;14174.929125354307;14209.076410033314;14326.641833954234;14338.784918226234;14350.49773257931;10948.781024379468;11004.889951100547;11015.284006539548;11045.613403530999;11048;13135.540256090992;16552.172391380624;16713.331466741438;16725.498235052968;16809.495715128567;4781.652162062209;6127.969360153171;6155;6374.968125159345;6378.330275321117;993.562832353762;1044.9164066874632;1062.1555863088863;1066.4561073852235;1082.5182793656747;29512.107837289564;30088.398232035674;30169.69830301669;30184.396312074074;30433.543496847124;1120.6918097523082;1124.173732306754;1145.5646854195352;1168.339887963315;1213.1871645997203;16054;16563.08903010322;16674.16629168561;16695;16928.40750573724;569512;573088;573454;574343;574550;57968.42031579714;57971.420285797445;58058.12912806311;58096.709516452145;58102.709486452295;1211.4608998995539;1332.9666758331118;1342.758303505359;1363.3047145955634;1365.1126767601138;29014.564781528716;30495.390092198475;30543.23641908881;30748.538771918888;31062.22344441317;49867;50317.496825032744;50334.49665503298;50340.49659503358;50379;406200;407637;408224;408711;408745;27601.309967250978;28554.714452855205;28673.856630716713;29614.259643509085;29675;46926;47426.76286618545;47595.524044759106;47665;49263.50736492589;40252;40438.18280097774;40789.796051019555;42308;42393;40206.59793402028;40766.38850417187;41231.7938410306;41972.58027419809;42839.3574096395;40905;41560.376594351714;41611.58388416077;41984.58015419807;42433;34027.3194536103;35927.28145437129;36333.63666363408;36349.818250908575;36773.81613091917;27950;28381.451797117465;28642.570361444177;28847.134585962456;29055 07:36:56 INFO - PROCESS | 10536 | |2;jquery.html;358.4014695458584;380.73158423311565;392.3252006548735;393.6594845458678;417.25103439326404;14670.486532971348;16598;19257.711134332996;19660.01699915004;19889.900550497263;19070.427887163372;19171.233150673957;19177.808221917778;19445.611087778238;19488.90255548724;4146.917061658765;5442;5612.494875461208;5625.043742563774;5633.239512665778;6136.846578835521;6420.261669907974;6455.2253729552285;6541.7710380136705;6545.93454065458;6228.937710622881;6433.099366088752;6459.321771214002;6504.577202481847;6513.804585862408;6251.749930002795;6435.646039467827;6463.289038205794;6468.8059358219325;6470.09418681385;5697.6011679182475;5731.799387021434;5732.856678583069;5735.426457354231;5740.339860916007;22405.103795848147;22551.21070762532;22824.543509129726;22897.88551057251;23535.41161470977;2200.9009594568283;2377.227401094651;2467.8889449974795;2569.6017117346655;2781.721827817222;10761.51573179201;10899.673009809718;11020.724481888017;11097.1122310215;13071.281079540622;1934.864559480837;1940.6991916253003;1949.5321122930536;1982.5341044854447;1988.602279544097;81027.5948620259;82874.58562707268;83674;88043.55978220132;88089.55955220183;11097.72255693598;11100.777984440267;11143.108551315876;11385.14611404148;11493.77012459746;15938.681226375407;15944.362225511082;15958.441454549267;15971.840281597268;15994.680106397807;7701.691932322757;7919.84160316802;7980.281774640311;8154.75535733929;8156.429049966564;7399.778006659809;7414.110306763223;7442.18136005039;7694.576798276036;7696.461247712607;4858.368412106403;4864.124457597595;4879.73126986986;5032.572231360302;5033.823816166417;1988.5724569217398;2048.92828750993;2049.600327936038;2052.271443637517;2104.4528422610233;894.8702438146432;955.2119501411363;960.9903900960901;1001.6844693921391;1081.859358283418;19407.417777466697;19561.706574401396;19726.210951561778;19736.70394944077;19911.402657920287;980.3774603126923;985.8028394321165;1013.4172850610928;1023.0996722883815;1040.8386700061503;10217.18262538995;10391.227886631996;10904.945475272732;10906.127509799197;10975.83536246957;363999;448557;449693;457149;463650;64656.03015954764;98352;102344.48827755962;102523.48738256261;102550.48724756329;962.2494454325777;983.8229118758549;1027.4349107990574;1028.8559601655775;1029.6087486755134;16699.91650041742;16785.244663990394;17465;17592.648147037242;17830.286788528312;44301.33547996847;44417.777911110235;44852.55147448614;45006.324905125795;45606;61860.38139618546;62720.686396567726;62729.372706272356;62737.686311569974;63281.68359158359;7442.590657513889;7857.882131767914;8016.478928869605;8270.37972152079;8729.956350218208;9971.650992215238;12982;13290.20258784476;13487.932560337136;13494.93252533731;11722.355270460206;11849.940750296193;11994.160408771651;12193;12257.570985015482;10967.50646220906;11563.30620162793;11659.825102623297;11807.409629518661;12062.155649104478;11218.943905280421;11562.190646654653;11853.525858965544;12374.81437778416;12528.310942898228;7936.888835563142;8001.799955001172;8121.390895682729;8145.6334464950405;8193.71322003727;8422.747317580483;11354.205205635526;11643.41782910834;11784.764304713686;11847.170698051053 07:36:56 INFO - PROCESS | 10536 | |3;mootools.html;1443.1557538839775;1489.5978085916802;1606.9517914462563;1710.0851044691078;1755.175067718172;7879;8444.662213511467;8448.36637252207;8451;8458.703945361922;7257.237990011052;7936.801579960504;8096.433249672526;8119.26926576608;8254.463459875104;2243.2148747938213;2276.169198242638;2276.8633881967053;2282.5092605089903;2285.542891421714;2183.4213933307688;2228.65455854342;2270.137347807831;2274.8293877959136;2278.065992942894;1950.6293804177233;2229.49836286835;2278.1912421090524;2294.403455101669;2312.7918487336137;2242.921497747587;2279.247848210087;2289.8626082435107;2298.6666933294746;2299.2067736630834;2236.664500324948;2238.82089432845;2238.944026399337;2241.5180736141806;2247.7415097263697;8278.917210827874;8353.039400468962;8367.707130250474;8389.874151887727;8395.24442800151;4838.564529192355;4963.255511673278;4965.354503914468;4968.453470118284;4973.403191617029;3097.6902309769066;3176.3170918252686;3295.2750394913082;3302.5706658134527;3307.884224052171;1152.8443660105863;1159.6984783956232;1164.0454827041829;1181.6809461445448;1191.1483289448;11452.370119643416;11521.308721476655;11527.020203282731;11530.365829879353;11530.423478826026;4098.303288440972;4225.57744225575;4335.523092459827;4378.124375124988;4379.189849877719;9652.083052110038;9697;9703.951480242553;9720.513974301257;9721.854172187423;4988.251762235694;5017.046761115376;5018.623603229772;5019.749012549358;5020;4557.635389168859;4593.678442509059;4632.189366860854;4634.791434385394;4636.675432719677;3638.508801311789;3682.9079273018388;3688.870889518854;3736.23407201523;3782.6004378379625;1098.8901109888948;1181.9468123934444;1186.649938268213;1193.1886317304143;1193.91045671575;828.9295409890107;958.5494817435793;997.5162046407487;1002.7042022603349;1003.5534187286734;5520.530754885799;5922.111683247547;6063.787767428119;6081.695915204222;6087.360827113178;910.1035480052143;928.5542939389131;951.857221416793;959.2661613865398;976.7069879036261;4170.35359519275;4171.3325867860995;4220.345846393814;4235.983363992681;4243.0241044559925;10248.333858299187;10650.360978341325;10660.946695266473;10671.893281067245;10676.412797296069;9698.078682525149;10041.497925103715;10161.085502304828;10446.112080473093;10631.627893023862;7601.6579253933705;7635.732749353746;7800.726974555863;7804.024496937883;7810;5880.852978675567;5955.642661440327;6010.459058684739;6034.818955431344;6047.516198704181;9317.86023209666;9481.431114133175;9500.524973751422;9578.56896439648;9761.07269809367;9523.380980236263;9529.761755956157;9789.85315220258;9881.950590247003;9904.752381190528;7214.494985350975;7296.927030729625;7335.193128755939;7349.77950661481;7539.1706912238515;8079.919200808152;8261.297789687944;8261.628226729692;8266.13205613402;8269;7431.739889103856;7481.102267727908;7481.139668937924;7502.737404190827;7679.961600191963;7220.38626716735;7302.3792977597495;7400;7444.73943411978;7459.776206713807;6446.355364463516;6448.355164483514;6488.740450382121;6499.5775274607;6521.184851893513;5016.1221786188;5096.464871188472;5193.42872284056;5195.844124676266;5225.843224703265;5031.295618613471;5094.643374963717;5158.819441319536;5269.367675878919;5276.759961409142 07:36:56 INFO - PROCESS | 10536 | |4;prototype.html;312.3939557258919;319.221100514744;327.6919695486243;330.2701030722104;331.29599600848195;5184.481551844819;5191.6501709555505;5216.29580006699;5264.447233040533;5270.156774916014;4885.193942999401;4918;5101.897962040757;5109.821156259532;5165.431802501722;4013.113836496842;4017.598240175974;4040.2929487339743;4051.230266249418;4065.166640838621;4026.2350153470893;4030.5969403059753;4047.615476529725;4060.5939406059306;4066.1867626474823;3869.187470631171;3875.670568001723;3990.9600903991022;4002.5196976362877;4025.939610905839;4014.558398576154;4016.9397459038137;4020.638142567154;4021.2761702893467;4032.6370626643743;3580.480830279595;3586.1751797086818;3589.6948759355487;3602.70302691031;3602.873899413508;4827.565519103297;5036.21938599514;5042.840146766228;5081.618878584084;5108.821191258326;4459.9930031485965;4486.685931984763;4525.162844873676;4530.22986092365;4568.109218702354;5366.336435704905;5367.731613419313;5404.189371594253;5415.13357862744;5439.972800135974;3707.6292370762976;3759.586445490994;3786.8863934082024;3793.070697679059;3804.5434547854156;5542.39033706292;5595.440455954413;5598.552115830765;5599.552035837123;5602.831915042555;3968.940465893014;3972.463717398114;3973.2252210819192;3997.220541994341;3997.400389941532;3968;3983.183447393277;4036.192761447722;4037.6971727120585;4065.9390109148385;4436.689431739747;4574.6340292776495;4591.494935557086;4617.976910115495;4625.427354699418;5427.728613569306;5437.227014222774;5447.1829225616475;5471.37079235885;5510.779568817283;1388.3266615691382;1390.506370238571;1390.8748212660707;1400.27885638894;1403.9368228429746;852.9275011623957;904.5251243097426;961.6826447272383;963.3786207895868;965.8744363232735;5210.53105220532;5212.113940630102;5216.739163041832;5217.34783152106;5229.686218826882;5466.480684334982;5496.890062198733;5497.103499292738;5555.2222688823595;5564.248826408383;5120.92318615221;5200.6879587224885;5228.92156617651;5231.738413079331;5235.790568377299;2892.5082735934943;2896;2911.126662001391;2921.8100823446407;2924.7277434316143;5439.501354150034;5659.915101273484;5713.714314284269;5716.599838011382;5720.48515633595;5568.303962004749;5585.609007369527;5597.440255974451;5615.326160860641;5617.578681598897;5640.689762063043;5645.5483561314995;5660.349059858169;5660.688662123623;5698.772049117989;5266.552343050884;5435.83692489226;5455.399906010415;5496.835094947158;5526.585506086979;5414.648047876875;5416.539594134385;5418.701971391612;5422.620416570802;5424.891502170013;5651.237082993744;5654.660720356627;5657.349404818498;5661.556303142672;5687.232223649754;3734.3838266685693;3809.352410090236;3851.826667800012;3863.130795570974;3864.439656249884;5281.9471805281455;5358.249845021778;5390.730463476889;5472.753726082416;5534.225208470737;5401.270828438111;5415.4313797050745;5436.945630543644;5439.836804895701;5448.482394172547;5199.672209785665;5409.864753381197;5413.8089620285045;5413.918791218213;5429.375621803385;5386.380566234933;5388.811391601275;5391.29913111293;5408.161734931092;5410.458954104558;5415.620906536505;5434.701091440009;5439.673619582838;5440.863978400572;5466.972665136808;5218.347706536683;5318.665287790438;5324.121519949165;5338.813141540028;5350.946490535045 07:36:56 INFO - PROCESS | 10536 | |5;yui.html;746.7013194722114;752.3905636434489;759.6923246085333;820.290448761821;856.2764464027898;16013.83986160138;16938.745918811226;17440.30238790447;17455.563610909718;17502.29990800368;16427.4250401236;16978.49064528066;17189.226484808183;17193.398231061914;17216.741748873777;808.640155130967;829.4235506323108;831.8544254755424;831.8918540589746;832.2634468495364;671.8118926700531;792.3542313014904;815.995920020399;817.81190326225;818.8157664525494;674.0529555973865;676.9390754832065;677.5088061155648;677.8915373540234;679.3376457953506;672.1195234243157;672.4082807129744;673.717038843682;673.8382788130863;673.9258681545051;494.24380697532473;512.8564002079423;614.5544480251826;624.9687515624246;626.6866566716642;13232.073754837165;13242.337883105805;13269.469221231138;13276.402561884739;13281.734365312735;13540.322983850769;13992.160470371708;14304.785428218585;14478.71042579153;14683.192424416653;13428.328583570783;13446.86553134466;13753.38109785062;13767.655808604864;14078.648033799134;4509.661775366861;4536.8638940831825;4542.341360502742;4589;4826.61387089032;82008;83259.16740832575;83942.58028709878;84946.57526712326;85072.57463712704;11364.374959377314;11429.428528573704;11631.825522617168;11670.76658466826;11865.822012669816;21303.68044479334;21371.35885923425;21452;21488.14047438116;21496.570068598852;8102.189781021851;8129.349652027823;8130.268275855202;8230.917690823015;8299.29455996247;4654.836290927268;4681.9297710534365;4695.436547614308;4798.712077275374;4805.423349198119;3442.3115376924716;3600.207954250061;3611.476335931328;3611.7652352597524;3614.1868079682386;579.547952596975;581.5376775463517;588.3498733899065;589.7022003888009;605.2948315212728;655.52474456019;673.1451057157481;682.7405585877335;686.2519853359862;720.3085038363125;9813.214942804558;9845.261605379483;9847.704568862946;9880.555375008142;9966;529.9258103865462;615.3815415507387;642.7204166187723;663.1544780405022;679.5277282288861;4545.522720114406;4678.157931572349;4715.929261061018;4752.500987396343;4767.475577686451;120817;121845;123396;125342;126819.51453018846;104923;107566.46216768866;109669;113413;114418.38147457699;95872;96915;97563;99515.50242248742;101420;8795.560221988748;8814.471131732116;8865.379423440298;9056.184943354867;9221.077892210726;52989.20516192183;54382;55147.72426137843;55800;57290.42709573018;80082;80400.79398808906;81480;83567.58216209123;84001.15998840178;12022.338771367658;12054.457549410123;12201.267923924594;12408.255504669749;12417.130800844216;12913.612591622266;15186.3295037548;15187.772183417037;15337.233138342815;15669.451569195024;13809.723805523632;14515.201663908587;14761.92619036898;15369.846301537289;15385.076895386313;13128.277944713132;13512.587686854169;13693.520726774515;13831.170129792245;14344.49794257196;13557.457701691821;13734.45062197541;14172.858271417566;14204.715905682035;14214;11344.262622929484;11568.24806387582;11669.241499302518;11670;12418.441170147184;11542.307461552333;12546.560870369492;12849.357532123544;13071.477140914258;13091.288367935063 07:36:56 INFO - PROCESS | 10536 | __end_tp_report 07:36:56 INFO - PROCESS | 10536 | __start_cc_report 07:36:56 INFO - PROCESS | 10536 | _x_x_mozilla_cycle_collect,893 07:36:56 INFO - PROCESS | 10536 | __end_cc_report 07:36:56 INFO - PROCESS | 10536 | __startTimestamp1471358216327__endTimestamp 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | ------- Summary: start ------- 07:36:56 INFO - PROCESS | 10536 | Number of tests: 6 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#0] dojo.html Cycles:165 Average:5280.33 Median:5507.09 stddev:597.90 (10.9%) stddev-sans-first:573.63 07:36:56 INFO - PROCESS | 10536 | Values: 3052.9 3071.2 3087.5 3101.6 3109.0 5143.6 5228.9 5282.9 5354.7 5428.8 5269.2 5272.3 5348.7 5388.7 5411.2 4813.1 4825.2 4849.7 4863.1 4963.1 4845.2 4904.0 4918.9 4932.5 4960.2 4702.1 4747.7 4754.5 4832.7 4836.4 4767.9 4793.5 4796.4 4800.0 4844.0 4713.7 4722.6 4806.7 4881.1 4884.2 5278.9 5285.7 5292.9 5341.7 5350.9 5417.7 5522.4 5705.5 5710.9 5724.0 5620.5 5636.2 5690.3 5705.6 5718.3 5306.5 5307.3 5336.4 5338.4 5338.6 5636.4 5770.4 5814.4 5844.0 5860.1 5630.7 5634.0 5667.8 5681.3 5686.7 5714.1 5770.1 5777.6 5779.1 5782.1 5393.5 5539.7 5548.8 5702.5 5716.8 5639.2 5641.9 5675.3 5680.0 5684.0 4319.8 4354.9 4357.2 4362.7 4389.7 3816.5 3827.1 3881.0 3899.2 3930.4 5323.4 5376.4 5406.4 5416.4 5441.6 5651.9 5698.5 5702.7 5705.5 5708.9 5212.1 5243.4 5382.5 5391.6 5396.3 4880.7 4914.4 4931.1 4956.0 4967.1 5837.3 5866.2 5874.7 5878.0 5882.1 5458.5 5602.7 5611.7 5687.4 5728.2 5820.5 5850.1 5883.0 5917.2 5953.5 5534.3 5562.1 5566.6 5572.8 5593.7 5438.9 5510.1 5660.2 5674.9 5690.1 5529.9 5631.7 5645.7 5647.4 5648.7 5562.5 5600.4 5612.7 5616.0 5619.4 5385.8 5479.0 5568.5 5619.2 5637.1 5571.1 5621.9 5642.7 5681.9 5690.0 5496.9 5507.1 5507.9 5510.0 5511.8 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#1] ext.html Cycles:180 Average:59634.26 Median:41414.98 stddev:119557.26 (288.7%) stddev-sans-first:119810.47 07:36:56 INFO - PROCESS | 10536 | Values: 592.2 624.5 625.3 626.1 636.2 32268.5 35292.3 43124.8 44120.0 44457.3 44456.7 45087.8 45221.0 45237.3 45263.8 8853.5 8996.5 9004.7 9008.8 9015.2 8808.2 8900.0 8900.9 8907.0 8907.3 8885.2 8891.9 8936.2 8983.7 8988.0 8759.8 8809.2 8819.1 8839.4 8890.0 8891.6 8935.0 8964.8 8974.3 8983.4 40853.6 41132.6 41208.2 41220.4 41269.6 3290.6 3671.7 3808.7 4157.3 4334.8 31117.0 31838.5 32057.0 32099.2 32155.3 4325.0 4381.9 4420.4 4463.2 4469.1 332788.0 333545.0 335746.0 336666.0 336790.0 57495.4 57532.7 57693.1 57880.0 57938.4 59633.0 60311.7 60471.0 60489.4 60529.5 14174.9 14209.1 14326.6 14338.8 14350.5 10948.8 11004.9 11015.3 11045.6 11048.0 13135.5 16552.2 16713.3 16725.5 16809.5 4781.7 6128.0 6155.0 6375.0 6378.3 993.6 1044.9 1062.2 1066.5 1082.5 29512.1 30088.4 30169.7 30184.4 30433.5 1120.7 1124.2 1145.6 1168.3 1213.2 16054.0 16563.1 16674.2 16695.0 16928.4 569512.0 573088.0 573454.0 574343.0 574550.0 57968.4 57971.4 58058.1 58096.7 58102.7 1211.5 1333.0 1342.8 1363.3 1365.1 29014.6 30495.4 30543.2 30748.5 31062.2 49867.0 50317.5 50334.5 50340.5 50379.0 406200.0 407637.0 408224.0 408711.0 408745.0 27601.3 28554.7 28673.9 29614.3 29675.0 46926.0 47426.8 47595.5 47665.0 49263.5 40252.0 40438.2 40789.8 42308.0 42393.0 40206.6 40766.4 41231.8 41972.6 42839.4 40905.0 41560.4 41611.6 41984.6 42433.0 34027.3 35927.3 36333.6 36349.8 36773.8 27950.0 28381.5 28642.6 28847.1 29055.0 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#2] jquery.html Cycles:180 Average:27921.94 Median:2422.56 stddev:72817.11 (3005.8%) stddev-sans-first:72991.97 07:36:56 INFO - PROCESS | 10536 | Values: 358.4 380.7 392.3 393.7 417.3 14670.5 16598.0 19257.7 19660.0 19889.9 19070.4 19171.2 19177.8 19445.6 19488.9 4146.9 5442.0 5612.5 5625.0 5633.2 6136.8 6420.3 6455.2 6541.8 6545.9 6228.9 6433.1 6459.3 6504.6 6513.8 6251.7 6435.6 6463.3 6468.8 6470.1 5697.6 5731.8 5732.9 5735.4 5740.3 22405.1 22551.2 22824.5 22897.9 23535.4 2200.9 2377.2 2467.9 2569.6 2781.7 10761.5 10899.7 11020.7 11097.1 13071.3 1934.9 1940.7 1949.5 1982.5 1988.6 81027.6 82874.6 83674.0 88043.6 88089.6 11097.7 11100.8 11143.1 11385.1 11493.8 15938.7 15944.4 15958.4 15971.8 15994.7 7701.7 7919.8 7980.3 8154.8 8156.4 7399.8 7414.1 7442.2 7694.6 7696.5 4858.4 4864.1 4879.7 5032.6 5033.8 1988.6 2048.9 2049.6 2052.3 2104.5 894.9 955.2 961.0 1001.7 1081.9 19407.4 19561.7 19726.2 19736.7 19911.4 980.4 985.8 1013.4 1023.1 1040.8 10217.2 10391.2 10904.9 10906.1 10975.8 363999.0 448557.0 449693.0 457149.0 463650.0 64656.0 98352.0 102344.5 102523.5 102550.5 962.2 983.8 1027.4 1028.9 1029.6 16699.9 16785.2 17465.0 17592.6 17830.3 44301.3 44417.8 44852.6 45006.3 45606.0 61860.4 62720.7 62729.4 62737.7 63281.7 7442.6 7857.9 8016.5 8270.4 8730.0 9971.7 12982.0 13290.2 13487.9 13494.9 11722.4 11849.9 11994.2 12193.0 12257.6 10967.5 11563.3 11659.8 11807.4 12062.2 11218.9 11562.2 11853.5 12374.8 12528.3 7936.9 8001.8 8121.4 8145.6 8193.7 8422.7 11354.2 11643.4 11784.8 11847.2 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#3] mootools.html Cycles:180 Average:5551.89 Median:5019.87 stddev:3095.18 (61.7%) stddev-sans-first:3088.46 07:36:56 INFO - PROCESS | 10536 | Values: 1443.2 1489.6 1607.0 1710.1 1755.2 7879.0 8444.7 8448.4 8451.0 8458.7 7257.2 7936.8 8096.4 8119.3 8254.5 2243.2 2276.2 2276.9 2282.5 2285.5 2183.4 2228.7 2270.1 2274.8 2278.1 1950.6 2229.5 2278.2 2294.4 2312.8 2242.9 2279.2 2289.9 2298.7 2299.2 2236.7 2238.8 2238.9 2241.5 2247.7 8278.9 8353.0 8367.7 8389.9 8395.2 4838.6 4963.3 4965.4 4968.5 4973.4 3097.7 3176.3 3295.3 3302.6 3307.9 1152.8 1159.7 1164.0 1181.7 1191.1 11452.4 11521.3 11527.0 11530.4 11530.4 4098.3 4225.6 4335.5 4378.1 4379.2 9652.1 9697.0 9704.0 9720.5 9721.9 4988.3 5017.0 5018.6 5019.7 5020.0 4557.6 4593.7 4632.2 4634.8 4636.7 3638.5 3682.9 3688.9 3736.2 3782.6 1098.9 1181.9 1186.6 1193.2 1193.9 828.9 958.5 997.5 1002.7 1003.6 5520.5 5922.1 6063.8 6081.7 6087.4 910.1 928.6 951.9 959.3 976.7 4170.4 4171.3 4220.3 4236.0 4243.0 10248.3 10650.4 10660.9 10671.9 10676.4 9698.1 10041.5 10161.1 10446.1 10631.6 7601.7 7635.7 7800.7 7804.0 7810.0 5880.9 5955.6 6010.5 6034.8 6047.5 9317.9 9481.4 9500.5 9578.6 9761.1 9523.4 9529.8 9789.9 9882.0 9904.8 7214.5 7296.9 7335.2 7349.8 7539.2 8079.9 8261.3 8261.6 8266.1 8269.0 7431.7 7481.1 7481.1 7502.7 7680.0 7220.4 7302.4 7400.0 7444.7 7459.8 6446.4 6448.4 6488.7 6499.6 6521.2 5016.1 5096.5 5193.4 5195.8 5225.8 5031.3 5094.6 5158.8 5269.4 5276.8 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#4] prototype.html Cycles:180 Average:4536.99 Median:5223.63 stddev:1331.15 (25.5%) stddev-sans-first:1296.57 07:36:56 INFO - PROCESS | 10536 | Values: 312.4 319.2 327.7 330.3 331.3 5184.5 5191.7 5216.3 5264.4 5270.2 4885.2 4918.0 5101.9 5109.8 5165.4 4013.1 4017.6 4040.3 4051.2 4065.2 4026.2 4030.6 4047.6 4060.6 4066.2 3869.2 3875.7 3991.0 4002.5 4025.9 4014.6 4016.9 4020.6 4021.3 4032.6 3580.5 3586.2 3589.7 3602.7 3602.9 4827.6 5036.2 5042.8 5081.6 5108.8 4460.0 4486.7 4525.2 4530.2 4568.1 5366.3 5367.7 5404.2 5415.1 5440.0 3707.6 3759.6 3786.9 3793.1 3804.5 5542.4 5595.4 5598.6 5599.6 5602.8 3968.9 3972.5 3973.2 3997.2 3997.4 3968.0 3983.2 4036.2 4037.7 4065.9 4436.7 4574.6 4591.5 4618.0 4625.4 5427.7 5437.2 5447.2 5471.4 5510.8 1388.3 1390.5 1390.9 1400.3 1403.9 852.9 904.5 961.7 963.4 965.9 5210.5 5212.1 5216.7 5217.3 5229.7 5466.5 5496.9 5497.1 5555.2 5564.2 5120.9 5200.7 5228.9 5231.7 5235.8 2892.5 2896.0 2911.1 2921.8 2924.7 5439.5 5659.9 5713.7 5716.6 5720.5 5568.3 5585.6 5597.4 5615.3 5617.6 5640.7 5645.5 5660.3 5660.7 5698.8 5266.6 5435.8 5455.4 5496.8 5526.6 5414.6 5416.5 5418.7 5422.6 5424.9 5651.2 5654.7 5657.3 5661.6 5687.2 3734.4 3809.4 3851.8 3863.1 3864.4 5281.9 5358.2 5390.7 5472.8 5534.2 5401.3 5415.4 5436.9 5439.8 5448.5 5199.7 5409.9 5413.8 5413.9 5429.4 5386.4 5388.8 5391.3 5408.2 5410.5 5415.6 5434.7 5439.7 5440.9 5467.0 5218.3 5318.7 5324.1 5338.8 5350.9 07:36:56 INFO - PROCESS | 10536 | 07:36:56 INFO - PROCESS | 10536 | [#5] yui.html Cycles:180 Average:22380.87 Median:4621.92 stddev:33069.55 (715.5%) stddev-sans-first:33122.42 07:36:56 INFO - PROCESS | 10536 | Values: 746.7 752.4 759.7 820.3 856.3 16013.8 16938.7 17440.3 17455.6 17502.3 16427.4 16978.5 17189.2 17193.4 17216.7 808.6 829.4 831.9 831.9 832.3 671.8 792.4 816.0 817.8 818.8 674.1 676.9 677.5 677.9 679.3 672.1 672.4 673.7 673.8 673.9 494.2 512.9 614.6 625.0 626.7 13232.1 13242.3 13269.5 13276.4 13281.7 13540.3 13992.2 14304.8 14478.7 14683.2 13428.3 13446.9 13753.4 13767.7 14078.6 4509.7 4536.9 4542.3 4589.0 4826.6 82008.0 83259.2 83942.6 84946.6 85072.6 11364.4 11429.4 11631.8 11670.8 11865.8 21303.7 21371.4 21452.0 21488.1 21496.6 8102.2 8129.3 8130.3 8230.9 8299.3 4654.8 4681.9 4695.4 4798.7 4805.4 3442.3 3600.2 3611.5 3611.8 3614.2 579.5 581.5 588.3 589.7 605.3 655.5 673.1 682.7 686.3 720.3 9813.2 9845.3 9847.7 9880.6 9966.0 529.9 615.4 642.7 663.2 679.5 4545.5 4678.2 4715.9 4752.5 4767.5 120817.0 121845.0 123396.0 125342.0 126819.5 104923.0 107566.5 109669.0 113413.0 114418.4 95872.0 96915.0 97563.0 99515.5 101420.0 8795.6 8814.5 8865.4 9056.2 9221.1 52989.2 54382.0 55147.7 55800.0 57290.4 80082.0 80400.8 81480.0 83567.6 84001.2 12022.3 12054.5 12201.3 12408.3 12417.1 12913.6 15186.3 15187.8 15337.2 15669.5 13809.7 14515.2 14761.9 15369.8 15385.1 13128.3 13512.6 13693.5 13831.2 14344.5 13557.5 13734.5 14172.9 14204.7 14214.0 11344.3 11568.2 11669.2 11670.0 12418.4 11542.3 12546.6 12849.4 13071.5 13091.3 07:36:56 INFO - PROCESS | 10536 | -------- Summary: end -------- 07:36:56 INFO - PROCESS | 10536 | 07:36:57 INFO - TEST-INFO | 10536: exit 0 07:36:57 INFO - TEST-OK | dromaeo_css | took 1113875ms 07:36:57 INFO - TEST-START | kraken 07:36:57 INFO - operating with platform_type : linux_ 07:36:57 INFO - Initialising browser for kraken test... 07:36:57 INFO - TEST-INFO | started process 10876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TTAXN/profile http://localhost:53858/getInfo.html) 07:37:00 INFO - PROCESS | 10876 | __metrics Screen width/height:1600/1200 07:37:00 INFO - PROCESS | 10876 | colorDepth:24 07:37:00 INFO - PROCESS | 10876 | Browser inner width/height: 1024/697 07:37:00 INFO - PROCESS | 10876 | __metrics 07:37:01 INFO - PROCESS | 10876 | 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:37:01 INFO - PROCESS | 10876 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:01 INFO - PROCESS | 10876 | console.error: PushService: 07:37:01 INFO - PROCESS | 10876 | stateChangeProcessEnqueue: Error transitioning state 07:37:01 INFO - PROCESS | 10876 | UnknownError 07:37:02 INFO - TEST-INFO | 10876: exit 0 07:37:02 INFO - Browser initialized. 07:37:02 INFO - Running cycle 1/1 for kraken test... 07:37:02 INFO - TEST-INFO | started process 10957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TTAXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:13 INFO - PROCESS | 10957 | RSS: Main: 155795456 07:37:13 INFO - PROCESS | 10957 | 07:37:16 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53858/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:17 INFO - PROCESS | 10957 | RSS: Main: 204431360 07:37:17 INFO - PROCESS | 10957 | 07:37:19 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53858/tests/kraken/driver.html?testName=audio-dft) 07:37:20 INFO - PROCESS | 10957 | RSS: Main: 195174400 07:37:20 INFO - PROCESS | 10957 | 07:37:23 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53858/tests/kraken/driver.html?testName=audio-fft) 07:37:24 INFO - PROCESS | 10957 | RSS: Main: 275775488 07:37:24 INFO - PROCESS | 10957 | 07:37:26 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53858/tests/kraken/driver.html?testName=audio-oscillator) 07:37:26 INFO - PROCESS | 10957 | RSS: Main: 185577472 07:37:26 INFO - PROCESS | 10957 | 07:37:29 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:29 INFO - PROCESS | 10957 | RSS: Main: 190750720 07:37:29 INFO - PROCESS | 10957 | 07:37:32 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53858/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:33 INFO - PROCESS | 10957 | RSS: Main: 225845248 07:37:33 INFO - PROCESS | 10957 | 07:37:36 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53858/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:37 INFO - PROCESS | 10957 | RSS: Main: 225927168 07:37:37 INFO - PROCESS | 10957 | 07:37:40 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53858/tests/kraken/driver.html?testName=json-parse-financial) 07:37:40 INFO - PROCESS | 10957 | RSS: Main: 226144256 07:37:40 INFO - PROCESS | 10957 | 07:37:42 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:42 INFO - PROCESS | 10957 | RSS: Main: 188579840 07:37:42 INFO - PROCESS | 10957 | 07:37:44 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:45 INFO - PROCESS | 10957 | RSS: Main: 196808704 07:37:45 INFO - PROCESS | 10957 | 07:37:47 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:47 INFO - PROCESS | 10957 | RSS: Main: 193134592 07:37:47 INFO - PROCESS | 10957 | 07:37:50 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:51 INFO - PROCESS | 10957 | RSS: Main: 186830848 07:37:51 INFO - PROCESS | 10957 | 07:37:53 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:54 INFO - PROCESS | 10957 | RSS: Main: 191967232 07:37:54 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | Cycle 1(1): loaded http://localhost:53858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53858/tests/kraken/driver.html?testName=ai-astar) 07:37:56 INFO - PROCESS | 10957 | RSS: Main: 243146752 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | __start_tp_report 07:37:56 INFO - PROCESS | 10957 | _x_x_mozilla_page_load 07:37:56 INFO - PROCESS | 10957 | _x_x_mozilla_page_load_details 07:37:56 INFO - PROCESS | 10957 | |i|pagename|runs| 07:37:56 INFO - PROCESS | 10957 | |0;ai-astar;101;110;110;111;106;111;111;110;111;110 07:37:56 INFO - PROCESS | 10957 | |1;audio-beat-detection;148;117;117;177;117;133;147;116;158;118 07:37:56 INFO - PROCESS | 10957 | |2;audio-dft;160;160;161;160;161;161;160;161;161;160 07:37:56 INFO - PROCESS | 10957 | |3;audio-fft;75;75;75;121;76;74;75;74;111;76 07:37:56 INFO - PROCESS | 10957 | |4;audio-oscillator;85;85;126;85;84;84;121;85;85;139 07:37:56 INFO - PROCESS | 10957 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 07:37:56 INFO - PROCESS | 10957 | |6;imaging-darkroom;145;146;146;146;148;146;146;146;146;145 07:37:56 INFO - PROCESS | 10957 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 07:37:56 INFO - PROCESS | 10957 | |8;json-parse-financial;52;50;51;50;51;53;53;51;52;51 07:37:56 INFO - PROCESS | 10957 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;62;61;62 07:37:56 INFO - PROCESS | 10957 | |10;stanford-crypto-aes;80;78;77;77;78;78;78;78;77;81 07:37:56 INFO - PROCESS | 10957 | |11;stanford-crypto-ccm;127;120;121;121;121;129;132;122;149;132 07:37:56 INFO - PROCESS | 10957 | |12;stanford-crypto-pbkdf2;167;161;161;160;162;164;165;164;162;160 07:37:56 INFO - PROCESS | 10957 | |13;stanford-crypto-sha256-iterative;63;64;67;64;63;62;63;62;62;62 07:37:56 INFO - PROCESS | 10957 | __end_tp_report 07:37:56 INFO - PROCESS | 10957 | __start_cc_report 07:37:56 INFO - PROCESS | 10957 | _x_x_mozilla_cycle_collect,1702 07:37:56 INFO - PROCESS | 10957 | __end_cc_report 07:37:56 INFO - PROCESS | 10957 | __startTimestamp1471358276333__endTimestamp 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | ------- Summary: start ------- 07:37:56 INFO - PROCESS | 10957 | Number of tests: 14 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.21 (2.9%) stddev-sans-first:1.58 07:37:56 INFO - PROCESS | 10957 | Values: 101.0 110.0 110.0 111.0 106.0 111.0 111.0 110.0 111.0 110.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:140.00 stddev:21.68 (15.5%) stddev-sans-first:22.47 07:37:56 INFO - PROCESS | 10957 | Values: 148.0 117.0 117.0 177.0 117.0 133.0 147.0 116.0 158.0 118.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 07:37:56 INFO - PROCESS | 10957 | Values: 160.0 160.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 160.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:17.46 (23.3%) stddev-sans-first:18.27 07:37:56 INFO - PROCESS | 10957 | Values: 75.0 75.0 75.0 121.0 76.0 74.0 75.0 74.0 111.0 76.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.00 stddev:21.68 (25.5%) stddev-sans-first:22.49 07:37:56 INFO - PROCESS | 10957 | Values: 85.0 85.0 126.0 85.0 84.0 84.0 121.0 85.0 85.0 139.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:37:56 INFO - PROCESS | 10957 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 07:37:56 INFO - PROCESS | 10957 | Values: 145.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 145.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:37:56 INFO - PROCESS | 10957 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.07 (2.1%) stddev-sans-first:1.12 07:37:56 INFO - PROCESS | 10957 | Values: 52.0 50.0 51.0 50.0 51.0 53.0 53.0 51.0 52.0 51.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:37:56 INFO - PROCESS | 10957 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:1.32 (1.7%) stddev-sans-first:1.22 07:37:56 INFO - PROCESS | 10957 | Values: 80.0 78.0 77.0 77.0 78.0 78.0 78.0 78.0 77.0 81.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:8.93 (7.0%) stddev-sans-first:9.48 07:37:56 INFO - PROCESS | 10957 | Values: 127.0 120.0 121.0 121.0 121.0 129.0 132.0 122.0 149.0 132.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:1.83 07:37:56 INFO - PROCESS | 10957 | Values: 167.0 161.0 161.0 160.0 162.0 164.0 165.0 164.0 162.0 160.0 07:37:56 INFO - PROCESS | 10957 | 07:37:56 INFO - PROCESS | 10957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.55 (2.5%) stddev-sans-first:1.64 07:37:56 INFO - PROCESS | 10957 | Values: 63.0 64.0 67.0 64.0 63.0 62.0 63.0 62.0 62.0 62.0 07:37:56 INFO - PROCESS | 10957 | -------- Summary: end -------- 07:37:56 INFO - PROCESS | 10957 | 07:37:57 INFO - TEST-INFO | 10957: exit 0 07:37:57 INFO - TEST-OK | kraken | took 60322ms 07:37:57 INFO - SUITE-END | took 1174s 07:37:57 INFO - Completed test suite (00:19:34) 07:37:57 INFO - javascript benchmark 07:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.938941221176, 3071.20148761322, 3087.521434177702, 3101.596792416987, 3108.9844550777243, 5143.588512918966, 5228.92156617651, 5282.894342113155, 5354.73226338683, 5428.75570599323, 5269.1832765921245, 5272.288241087452, 5348.705821179834, 5388.7305634718205, 5411.215373770801, 4813.13363594552, 4825.227963525819, 4849.733264670442, 4863.051704917542, 4963.0818298614695, 4845.176320025586, 4903.950960490403, 4918.852434426973, 4932.457429682732, 4960.181570040939, 4702.13010593038, 4747.715137091785, 4754.500777418356, 4832.661713680044, 4836.443808961962, 4767.880802979918, 4793.496682848286, 4796.352492413549, 4799.9760001199775, 4844.006978569385, 4713.670043096985, 4722.551357621055, 4806.735629540374, 4881.072596206709, 4884.218525036013, 5278.894422111536, 5285.735713214324, 5292.867678308035, 5341.65279256847, 5350.892982140374, 5417.702026388547, 5522.364928033247, 5705.486506214419, 5710.942890571124, 5724.026915424388, 5620.494155526022, 5636.182753500761, 5690.317161940552, 5705.62913410627, 5718.313802343704, 5306.495882891119, 5307.310049693554, 5336.4129945705945, 5338.412774594792, 5338.599605029638, 5636.436356364413, 5770.365259821417, 5814.447627475383, 5843.970780146072, 5860.120981852671, 5630.746616402272, 5634.04221282383, 5667.773289068474, 5681.318241811009, 5686.744096515667, 5714.085746280575, 5770.134479827975, 5777.566682498829, 5779.133130030529, 5782.10377391505, 5393.514583687487, 5539.667619942817, 5548.805791797267, 5702.486776190163, 5716.828495145152, 5639.154126881001, 5641.915371269434, 5675.347335056521, 5679.971600141973, 5684.0, 4319.8488052918, 4354.8911277217685, 4357.215701173755, 4362.672799540047, 4389.670774691911, 3816.4656948026745, 3827.081500439874, 3881.0, 3899.2396482685604, 3930.371140617545, 5323.414424413311, 5376.354837419456, 5406.378266499324, 5416.404195538487, 5441.619086663895, 5651.886962260814, 5698.4871361576825, 5702.714864256771, 5705.4579814917515, 5708.914366284509, 5212.113940630102, 5243.4232234454175, 5382.542483888913, 5391.56867450603, 5396.325459317585, 4880.6583539152625, 4914.434839993446, 4931.137051016058, 4955.975220123948, 4967.130752118364, 5837.299524057055, 5866.2373891393845, 5874.735636896436, 5878.0, 5882.088276317178, 5458.536024437967, 5602.719864006702, 5611.719414029364, 5687.43125687428, 5728.198052272768, 5820.505257053029, 5850.12248162762, 5882.970585147047, 5917.171595976481, 5953.464188223081, 5534.280543529477, 5562.082256427644, 5566.638168519034, 5572.804951826666, 5593.720313984366, 5438.918416223681, 5510.118381059011, 5660.179274005329, 5674.943250567607, 5690.146478028329, 5529.944700553104, 5631.718414079198, 5645.68948707825, 5647.435256474319, 5648.661080335193, 5562.471565201299, 5600.35595906476, 5612.719364031864, 5615.971920140373, 5619.438056194512, 5385.838424847261, 5478.972605136949, 5568.49883510486, 5619.185218143264, 5637.069883469182, 5571.05292100352, 5621.943780562142, 5642.717864106696, 5681.9147712783515, 5690.032694442038, 5496.862578435411, 5507.091329930677, 5507.862303442446, 5510.035743744908, 5511.807086751945], "value": 5240.141023194452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2419303291787, 624.4504835744544, 625.3152797686531, 626.0609086370445, 636.2079211381828, 32268.515972260404, 35292.294154116935, 43124.784376078074, 44120.01459934311, 44457.33314000293, 44456.66520017602, 45087.77456112723, 45221.0, 45237.32144017842, 45263.77368113163, 8853.513056781874, 8996.460212387245, 9004.729858104267, 9008.819823603524, 9015.188633023026, 8808.207261346477, 8899.95550022249, 8900.8664870027, 8907.0, 8907.287417006624, 8885.2447541959, 8891.911080889206, 8936.151065648754, 8983.730488085368, 8987.955060224722, 8759.78100547485, 8809.163129502718, 8819.073997230262, 8839.381243312971, 8890.022097569263, 8891.644334226623, 8935.0, 8964.775880603038, 8974.326925480615, 8983.416077954913, 40853.59146408528, 41132.588674113475, 41208.1758364834, 41220.38169427461, 41269.58730412687, 3290.6380298167182, 3671.7429779915415, 3808.6953043756434, 4157.334826427757, 4334.804933777988, 31117.0, 31838.522422163685, 32057.038288851138, 32099.197520062186, 32155.302140253938, 4324.991047626628, 4381.912361752779, 4420.359047938031, 4463.218936686099, 4469.10617876426, 332788.0, 333545.0, 335745.99999999756, 336666.0, 336790.0, 57495.425045749005, 57532.71233643805, 57693.13460298099, 57880.0, 57938.4206157933, 59633.0, 60311.698441508386, 60471.0, 60489.395106049255, 60529.46029047839, 14174.929125354307, 14209.076410033314, 14326.641833954234, 14338.784918226234, 14350.49773257931, 10948.781024379468, 11004.889951100547, 11015.284006539548, 11045.613403530999, 11048.0, 13135.540256090992, 16552.172391380624, 16713.331466741438, 16725.498235052968, 16809.495715128567, 4781.652162062209, 6127.969360153171, 6155.0, 6374.968125159345, 6378.330275321117, 993.562832353762, 1044.9164066874632, 1062.1555863088863, 1066.4561073852235, 1082.5182793656747, 29512.107837289564, 30088.398232035674, 30169.69830301669, 30184.396312074074, 30433.543496847124, 1120.6918097523082, 1124.173732306754, 1145.5646854195352, 1168.339887963315, 1213.1871645997203, 16054.0, 16563.08903010322, 16674.16629168561, 16695.0, 16928.40750573724, 569512.0, 573088.0, 573454.0, 574343.0, 574550.0, 57968.42031579714, 57971.420285797445, 58058.12912806311, 58096.709516452145, 58102.709486452295, 1211.4608998995539, 1332.9666758331118, 1342.758303505359, 1363.3047145955634, 1365.1126767601138, 29014.564781528716, 30495.390092198475, 30543.23641908881, 30748.538771918888, 31062.22344441317, 49867.0, 50317.496825032744, 50334.49665503298, 50340.49659503358, 50379.0, 406200.0, 407637.0, 408224.0, 408711.0, 408745.0, 27601.309967250978, 28554.714452855205, 28673.856630716713, 29614.259643509085, 29675.0, 46926.0, 47426.76286618545, 47595.524044759106, 47665.0, 49263.50736492589, 40252.0, 40438.18280097774, 40789.796051019555, 42308.0, 42393.0, 40206.59793402028, 40766.38850417187, 41231.7938410306, 41972.58027419809, 42839.3574096395, 40905.0, 41560.376594351714, 41611.58388416077, 41984.58015419807, 42433.0, 34027.3194536103, 35927.28145437129, 36333.63666363408, 36349.818250908575, 36773.81613091917, 27950.0, 28381.451797117465, 28642.570361444177, 28847.134585962456, 29055.0], "value": 19712.893844178343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.4014695458584, 380.73158423311565, 392.3252006548735, 393.6594845458678, 417.25103439326404, 14670.486532971348, 16598.0, 19257.711134332996, 19660.01699915004, 19889.900550497263, 19070.427887163372, 19171.233150673957, 19177.808221917778, 19445.611087778238, 19488.90255548724, 4146.917061658765, 5442.0, 5612.494875461208, 5625.043742563774, 5633.239512665778, 6136.846578835521, 6420.261669907974, 6455.2253729552285, 6541.7710380136705, 6545.93454065458, 6228.937710622881, 6433.099366088752, 6459.321771214002, 6504.577202481847, 6513.804585862408, 6251.749930002795, 6435.646039467827, 6463.289038205794, 6468.8059358219325, 6470.09418681385, 5697.6011679182475, 5731.799387021434, 5732.856678583069, 5735.426457354231, 5740.339860916007, 22405.103795848147, 22551.21070762532, 22824.543509129726, 22897.88551057251, 23535.41161470977, 2200.9009594568283, 2377.227401094651, 2467.8889449974795, 2569.6017117346655, 2781.721827817222, 10761.51573179201, 10899.673009809718, 11020.724481888017, 11097.1122310215, 13071.281079540622, 1934.864559480837, 1940.6991916253003, 1949.5321122930536, 1982.5341044854447, 1988.602279544097, 81027.5948620259, 82874.58562707268, 83674.0, 88043.55978220132, 88089.55955220183, 11097.72255693598, 11100.777984440267, 11143.108551315876, 11385.14611404148, 11493.77012459746, 15938.681226375407, 15944.362225511082, 15958.441454549267, 15971.840281597268, 15994.680106397807, 7701.691932322757, 7919.84160316802, 7980.281774640311, 8154.75535733929, 8156.429049966564, 7399.778006659809, 7414.110306763223, 7442.18136005039, 7694.576798276036, 7696.461247712607, 4858.368412106403, 4864.124457597595, 4879.73126986986, 5032.572231360302, 5033.823816166417, 1988.5724569217398, 2048.92828750993, 2049.600327936038, 2052.271443637517, 2104.4528422610233, 894.8702438146432, 955.2119501411363, 960.9903900960901, 1001.6844693921391, 1081.859358283418, 19407.417777466697, 19561.706574401396, 19726.210951561778, 19736.70394944077, 19911.402657920287, 980.3774603126923, 985.8028394321165, 1013.4172850610928, 1023.0996722883815, 1040.8386700061503, 10217.18262538995, 10391.227886631996, 10904.945475272732, 10906.127509799197, 10975.83536246957, 363999.0, 448557.0, 449693.0, 457149.0, 463650.0, 64656.03015954764, 98352.0, 102344.48827755962, 102523.48738256261, 102550.48724756329, 962.2494454325777, 983.8229118758549, 1027.4349107990574, 1028.8559601655775, 1029.6087486755134, 16699.91650041742, 16785.244663990394, 17465.0, 17592.648147037242, 17830.286788528312, 44301.33547996847, 44417.777911110235, 44852.55147448614, 45006.324905125795, 45606.0, 61860.38139618546, 62720.686396567726, 62729.372706272356, 62737.686311569974, 63281.68359158359, 7442.590657513889, 7857.882131767914, 8016.478928869605, 8270.37972152079, 8729.956350218208, 9971.650992215238, 12982.0, 13290.20258784476, 13487.932560337136, 13494.93252533731, 11722.355270460206, 11849.940750296193, 11994.160408771651, 12193.0, 12257.570985015482, 10967.50646220906, 11563.30620162793, 11659.825102623297, 11807.409629518661, 12062.155649104478, 11218.943905280421, 11562.190646654653, 11853.525858965544, 12374.81437778416, 12528.310942898228, 7936.888835563142, 8001.799955001172, 8121.390895682729, 8145.6334464950405, 8193.71322003727, 8422.747317580483, 11354.205205635526, 11643.41782910834, 11784.764304713686, 11847.170698051053], "value": 9320.965519521733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.1557538839775, 1489.5978085916802, 1606.9517914462563, 1710.0851044691078, 1755.175067718172, 7879.0, 8444.662213511467, 8448.36637252207, 8451.0, 8458.703945361922, 7257.237990011052, 7936.801579960504, 8096.433249672526, 8119.26926576608, 8254.463459875104, 2243.2148747938213, 2276.169198242638, 2276.8633881967053, 2282.5092605089903, 2285.542891421714, 2183.4213933307688, 2228.65455854342, 2270.137347807831, 2274.8293877959136, 2278.065992942894, 1950.6293804177233, 2229.49836286835, 2278.1912421090524, 2294.403455101669, 2312.7918487336137, 2242.921497747587, 2279.247848210087, 2289.8626082435107, 2298.6666933294746, 2299.2067736630834, 2236.664500324948, 2238.82089432845, 2238.944026399337, 2241.5180736141806, 2247.7415097263697, 8278.917210827874, 8353.039400468962, 8367.707130250474, 8389.874151887727, 8395.24442800151, 4838.564529192355, 4963.255511673278, 4965.354503914468, 4968.453470118284, 4973.403191617029, 3097.6902309769066, 3176.3170918252686, 3295.2750394913082, 3302.5706658134527, 3307.884224052171, 1152.8443660105863, 1159.6984783956232, 1164.0454827041829, 1181.6809461445448, 1191.1483289448, 11452.370119643416, 11521.308721476655, 11527.020203282731, 11530.365829879353, 11530.423478826026, 4098.303288440972, 4225.57744225575, 4335.523092459827, 4378.124375124988, 4379.189849877719, 9652.083052110038, 9697.0, 9703.951480242553, 9720.513974301257, 9721.854172187423, 4988.251762235694, 5017.046761115376, 5018.623603229772, 5019.749012549358, 5020.0, 4557.635389168859, 4593.678442509059, 4632.189366860854, 4634.791434385394, 4636.675432719677, 3638.508801311789, 3682.9079273018388, 3688.870889518854, 3736.23407201523, 3782.6004378379625, 1098.8901109888948, 1181.9468123934444, 1186.649938268213, 1193.1886317304143, 1193.91045671575, 828.9295409890107, 958.5494817435793, 997.5162046407487, 1002.7042022603349, 1003.5534187286734, 5520.530754885799, 5922.111683247547, 6063.787767428119, 6081.695915204222, 6087.360827113178, 910.1035480052143, 928.5542939389131, 951.857221416793, 959.2661613865398, 976.7069879036261, 4170.35359519275, 4171.3325867860995, 4220.345846393814, 4235.983363992681, 4243.0241044559925, 10248.333858299187, 10650.360978341325, 10660.946695266473, 10671.893281067245, 10676.412797296069, 9698.078682525149, 10041.497925103715, 10161.085502304828, 10446.112080473093, 10631.627893023862, 7601.6579253933705, 7635.732749353746, 7800.726974555863, 7804.024496937883, 7810.0, 5880.852978675567, 5955.642661440327, 6010.459058684739, 6034.818955431344, 6047.516198704181, 9317.86023209666, 9481.431114133175, 9500.524973751422, 9578.56896439648, 9761.07269809367, 9523.380980236263, 9529.761755956157, 9789.85315220258, 9881.950590247003, 9904.752381190528, 7214.494985350975, 7296.927030729625, 7335.193128755939, 7349.77950661481, 7539.1706912238515, 8079.919200808152, 8261.297789687944, 8261.628226729692, 8266.13205613402, 8269.0, 7431.739889103856, 7481.102267727908, 7481.139668937924, 7502.737404190827, 7679.961600191963, 7220.38626716735, 7302.3792977597495, 7400.0, 7444.73943411978, 7459.776206713807, 6446.355364463516, 6448.355164483514, 6488.740450382121, 6499.5775274607, 6521.184851893513, 5016.1221786188, 5096.464871188472, 5193.42872284056, 5195.844124676266, 5225.843224703265, 5031.295618613471, 5094.643374963717, 5158.819441319536, 5269.367675878919, 5276.759961409142], "value": 4479.277065596123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3939557258919, 319.221100514744, 327.6919695486243, 330.2701030722104, 331.29599600848195, 5184.481551844819, 5191.6501709555505, 5216.29580006699, 5264.447233040533, 5270.156774916014, 4885.193942999401, 4918.0, 5101.897962040757, 5109.821156259532, 5165.431802501722, 4013.113836496842, 4017.598240175974, 4040.2929487339743, 4051.230266249418, 4065.166640838621, 4026.2350153470893, 4030.5969403059753, 4047.615476529725, 4060.5939406059306, 4066.1867626474823, 3869.187470631171, 3875.670568001723, 3990.9600903991022, 4002.5196976362877, 4025.939610905839, 4014.558398576154, 4016.9397459038137, 4020.638142567154, 4021.2761702893467, 4032.6370626643743, 3580.480830279595, 3586.1751797086818, 3589.6948759355487, 3602.70302691031, 3602.873899413508, 4827.565519103297, 5036.21938599514, 5042.840146766228, 5081.618878584084, 5108.821191258326, 4459.9930031485965, 4486.685931984763, 4525.162844873676, 4530.22986092365, 4568.109218702354, 5366.336435704905, 5367.731613419313, 5404.189371594253, 5415.13357862744, 5439.972800135974, 3707.6292370762976, 3759.586445490994, 3786.8863934082024, 3793.070697679059, 3804.5434547854156, 5542.39033706292, 5595.440455954413, 5598.552115830765, 5599.552035837123, 5602.831915042555, 3968.940465893014, 3972.463717398114, 3973.2252210819192, 3997.220541994341, 3997.400389941532, 3968.0, 3983.183447393277, 4036.192761447722, 4037.6971727120585, 4065.9390109148385, 4436.689431739747, 4574.6340292776495, 4591.494935557086, 4617.976910115495, 4625.427354699418, 5427.728613569306, 5437.227014222774, 5447.1829225616475, 5471.37079235885, 5510.779568817283, 1388.3266615691382, 1390.506370238571, 1390.8748212660707, 1400.27885638894, 1403.9368228429746, 852.9275011623957, 904.5251243097426, 961.6826447272383, 963.3786207895868, 965.8744363232735, 5210.53105220532, 5212.113940630102, 5216.739163041832, 5217.34783152106, 5229.686218826882, 5466.480684334982, 5496.890062198733, 5497.103499292738, 5555.2222688823595, 5564.248826408383, 5120.92318615221, 5200.6879587224885, 5228.92156617651, 5231.738413079331, 5235.790568377299, 2892.5082735934943, 2896.0, 2911.126662001391, 2921.8100823446407, 2924.7277434316143, 5439.501354150034, 5659.915101273484, 5713.714314284269, 5716.599838011382, 5720.48515633595, 5568.303962004749, 5585.609007369527, 5597.440255974451, 5615.326160860641, 5617.578681598897, 5640.689762063043, 5645.5483561314995, 5660.349059858169, 5660.688662123623, 5698.772049117989, 5266.552343050884, 5435.83692489226, 5455.399906010415, 5496.835094947158, 5526.585506086979, 5414.648047876875, 5416.539594134385, 5418.701971391612, 5422.620416570802, 5424.891502170013, 5651.237082993744, 5654.660720356627, 5657.349404818498, 5661.556303142672, 5687.232223649754, 3734.3838266685693, 3809.352410090236, 3851.826667800012, 3863.130795570974, 3864.439656249884, 5281.9471805281455, 5358.249845021778, 5390.730463476889, 5472.753726082416, 5534.225208470737, 5401.270828438111, 5415.4313797050745, 5436.945630543644, 5439.836804895701, 5448.482394172547, 5199.672209785665, 5409.864753381197, 5413.8089620285045, 5413.918791218213, 5429.375621803385, 5386.380566234933, 5388.811391601275, 5391.29913111293, 5408.161734931092, 5410.458954104558, 5415.620906536505, 5434.701091440009, 5439.673619582838, 5440.863978400572, 5466.972665136808, 5218.347706536683, 5318.665287790438, 5324.121519949165, 5338.813141540028, 5350.946490535045], "value": 4114.344630695354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.7013194722114, 752.3905636434489, 759.6923246085333, 820.290448761821, 856.2764464027898, 16013.83986160138, 16938.745918811226, 17440.30238790447, 17455.563610909718, 17502.29990800368, 16427.4250401236, 16978.49064528066, 17189.226484808183, 17193.398231061914, 17216.741748873777, 808.640155130967, 829.4235506323108, 831.8544254755424, 831.8918540589746, 832.2634468495364, 671.8118926700531, 792.3542313014904, 815.995920020399, 817.81190326225, 818.8157664525494, 674.0529555973865, 676.9390754832065, 677.5088061155648, 677.8915373540234, 679.3376457953506, 672.1195234243157, 672.4082807129744, 673.717038843682, 673.8382788130863, 673.9258681545051, 494.24380697532473, 512.8564002079423, 614.5544480251826, 624.9687515624246, 626.6866566716642, 13232.073754837165, 13242.337883105805, 13269.469221231138, 13276.402561884739, 13281.734365312735, 13540.322983850769, 13992.160470371708, 14304.785428218585, 14478.71042579153, 14683.192424416653, 13428.328583570783, 13446.86553134466, 13753.38109785062, 13767.655808604864, 14078.648033799134, 4509.661775366861, 4536.8638940831825, 4542.341360502742, 4589.0, 4826.61387089032, 82008.0, 83259.16740832575, 83942.58028709878, 84946.57526712326, 85072.57463712704, 11364.374959377314, 11429.428528573704, 11631.825522617168, 11670.76658466826, 11865.822012669816, 21303.68044479334, 21371.35885923425, 21452.0, 21488.14047438116, 21496.570068598852, 8102.189781021851, 8129.349652027823, 8130.268275855202, 8230.917690823015, 8299.29455996247, 4654.836290927268, 4681.9297710534365, 4695.436547614308, 4798.712077275374, 4805.423349198119, 3442.3115376924716, 3600.207954250061, 3611.476335931328, 3611.7652352597524, 3614.1868079682386, 579.547952596975, 581.5376775463517, 588.3498733899065, 589.7022003888009, 605.2948315212728, 655.52474456019, 673.1451057157481, 682.7405585877335, 686.2519853359862, 720.3085038363125, 9813.214942804558, 9845.261605379483, 9847.704568862946, 9880.555375008142, 9966.0, 529.9258103865462, 615.3815415507387, 642.7204166187723, 663.1544780405022, 679.5277282288861, 4545.522720114406, 4678.157931572349, 4715.929261061018, 4752.500987396343, 4767.475577686451, 120817.0, 121845.0, 123396.0, 125342.0, 126819.51453018846, 104923.0, 107566.46216768866, 109669.0, 113413.0, 114418.38147457699, 95872.0, 96915.0, 97563.0, 99515.50242248742, 101420.0, 8795.560221988748, 8814.471131732116, 8865.379423440298, 9056.184943354867, 9221.077892210726, 52989.20516192183, 54382.0, 55147.72426137843, 55800.0, 57290.42709573018, 80082.0, 80400.79398808906, 81480.0, 83567.58216209123, 84001.15998840178, 12022.338771367658, 12054.457549410123, 12201.267923924594, 12408.255504669749, 12417.130800844216, 12913.612591622266, 15186.3295037548, 15187.772183417037, 15337.233138342815, 15669.451569195024, 13809.723805523632, 14515.201663908587, 14761.92619036898, 15369.846301537289, 15385.076895386313, 13128.277944713132, 13512.587686854169, 13693.520726774515, 13831.170129792245, 14344.49794257196, 13557.457701691821, 13734.45062197541, 14172.858271417566, 14204.715905682035, 14214.0, 11344.262622929484, 11568.24806387582, 11669.241499302518, 11670.0, 12418.441170147184, 11542.307461552333, 12546.560870369492, 12849.357532123544, 13071.477140914258, 13091.288367935063], "value": 7647.743594798663, "unit": "score"}], "name": "dromaeo_css", "value": 7168.702840016951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 111.0, 106.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 117.0, 177.0, 117.0, 133.0, 147.0, 116.0, 158.0, 118.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 76.0, 74.0, 75.0, 74.0, 111.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 126.0, 85.0, 84.0, 84.0, 121.0, 85.0, 85.0, 139.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 50.0, 51.0, 53.0, 53.0, 51.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 77.0, 78.0, 78.0, 78.0, 78.0, 77.0, 81.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 121.0, 121.0, 121.0, 129.0, 132.0, 122.0, 149.0, 132.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 161.0, 160.0, 162.0, 164.0, 165.0, 164.0, 162.0, 160.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1487.6000000000001, "alertThreshold": 2.0}]} 07:37:57 INFO - Return code: 0 07:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:57 INFO - # TBPL SUCCESS # 07:37:57 INFO - Running post-action listener: _resource_record_post_action 07:37:57 INFO - [mozharness: 2016-08-16 14:37:57.635982Z] Finished run-tests step (success) 07:37:57 INFO - Running post-run listener: _resource_record_post_run 07:37:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2437120; Write bytes: 415354880; Read time: 536; Write time: 314148 07:37:57 INFO - TinderboxPrint: CPU usage
13.0% 07:37:57 INFO - TinderboxPrint: I/O read bytes / time
2,437,120 / 536 07:37:57 INFO - TinderboxPrint: I/O write bytes / time
415,354,880 / 314,148 07:37:57 INFO - TinderboxPrint: CPU idle
8,268.5 (87.0%) 07:37:57 INFO - TinderboxPrint: CPU user
1,193.8 (12.6%) 07:37:57 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 122130432; Read time: 0; Write time: 124152 07:37:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 2437120; Write bytes: 292896768; Read time: 536; Write time: 189996 07:37:58 INFO - Running post-run listener: _upload_blobber_files 07:37:58 INFO - Blob upload gear active. 07:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:58 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:37:58 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:58 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:59 INFO - (blobuploader) - INFO - Done attempting. 07:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:00 INFO - (blobuploader) - INFO - Done attempting. 07:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:03 INFO - (blobuploader) - INFO - Done attempting. 07:38:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:03 INFO - Return code: 0 07:38:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888301ad3c7185cad09f98d9e5b5d6e2b7067b44e57d1f33606c5f755d77b1e97327550ea42e7e8fb01744cdc97b521e8d5f1eb6e0fc8abdb26cb8a1ce761356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e9a25091d6504079e9d0ef88ddfdb0fe6be0fdaaac842acad9867392db929552132c04cebc2fccff80b25e0013f867544fd50d0da14410f13865ffbb3ef9ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1272700ed9cfaa4ffdb0390a0c2e2bd7f1f34a3f5c38b5b52dd6c3d66c17897bd57bb4ba1a01a9d9c7b726672f39f4c230802d857f7ad702bc45ea227abbaf76"} 07:38:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:03 INFO - Contents: 07:38:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888301ad3c7185cad09f98d9e5b5d6e2b7067b44e57d1f33606c5f755d77b1e97327550ea42e7e8fb01744cdc97b521e8d5f1eb6e0fc8abdb26cb8a1ce761356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e9a25091d6504079e9d0ef88ddfdb0fe6be0fdaaac842acad9867392db929552132c04cebc2fccff80b25e0013f867544fd50d0da14410f13865ffbb3ef9ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1272700ed9cfaa4ffdb0390a0c2e2bd7f1f34a3f5c38b5b52dd6c3d66c17897bd57bb4ba1a01a9d9c7b726672f39f4c230802d857f7ad702bc45ea227abbaf76"} 07:38:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:03 INFO - Copying logs to upload dir... 07:38:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.909598 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-16 07:38:03.055300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 07:38:03.058777) ========= 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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888301ad3c7185cad09f98d9e5b5d6e2b7067b44e57d1f33606c5f755d77b1e97327550ea42e7e8fb01744cdc97b521e8d5f1eb6e0fc8abdb26cb8a1ce761356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e9a25091d6504079e9d0ef88ddfdb0fe6be0fdaaac842acad9867392db929552132c04cebc2fccff80b25e0013f867544fd50d0da14410f13865ffbb3ef9ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1272700ed9cfaa4ffdb0390a0c2e2bd7f1f34a3f5c38b5b52dd6c3d66c17897bd57bb4ba1a01a9d9c7b726672f39f4c230802d857f7ad702bc45ea227abbaf76"} build_url:https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/AXYNHH1ZQuagPonViF5gwQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888301ad3c7185cad09f98d9e5b5d6e2b7067b44e57d1f33606c5f755d77b1e97327550ea42e7e8fb01744cdc97b521e8d5f1eb6e0fc8abdb26cb8a1ce761356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e9a25091d6504079e9d0ef88ddfdb0fe6be0fdaaac842acad9867392db929552132c04cebc2fccff80b25e0013f867544fd50d0da14410f13865ffbb3ef9ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1272700ed9cfaa4ffdb0390a0c2e2bd7f1f34a3f5c38b5b52dd6c3d66c17897bd57bb4ba1a01a9d9c7b726672f39f4c230802d857f7ad702bc45ea227abbaf76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 07:38:03.083609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:38:03.083924) ========= 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=0333a256a5e4f052382dd180000001b1-1471353299.273831-1949684110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 07:38:03.169164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 07:38:03.169487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 07:38:03.169789) ========= ========= Total master_lag: 0.17 =========