builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1472023010.19 results: success (0) buildid: 20160823230014 builduid: 210559543a0142338c596ba2e445cde6 revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.194518) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.197710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.198261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.236095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.236409) ========= 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=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 00:16:50-- 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% 43.1M=0s 2016-08-24 00:16:50 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.384167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.384780) ========= 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=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017680 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:50.440722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 00:16:50.441665) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --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 eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --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=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 00:16:51,044 truncating revision to first 12 chars 2016-08-24 00:16:51,044 Setting DEBUG logging. 2016-08-24 00:16:51,044 attempt 1/10 2016-08-24 00:16:51,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb8d56badefe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 00:16:52,471 unpacking tar archive at: fx-team-eb8d56badefe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 00:16:52.212761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:52.213218) ========= script_repo_revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:52.213684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:52.214003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 00:16:52.225977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-24 00:16:52.226460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:16:52 INFO - MultiFileLogger online at 20160824 00:16:52 in /builds/slave/test 00:16:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:16:52 INFO - {'append_to_log': False, 00:16:52 INFO - 'base_work_dir': '/builds/slave/test', 00:16:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:16:52 INFO - 'branch': 'Fx-Team-Non-PGO', 00:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 00:16:52 INFO - 'config_files': ('talos/linux_config.py',), 00:16:52 INFO - 'default_actions': ('clobber', 00:16:52 INFO - 'read-buildbot-config', 00:16:52 INFO - 'download-and-extract', 00:16:52 INFO - 'populate-webroot', 00:16:52 INFO - 'create-virtualenv', 00:16:52 INFO - 'install', 00:16:52 INFO - 'run-tests'), 00:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:16:52 INFO - 'download_minidump_stackwalk': True, 00:16:52 INFO - 'download_symbols': 'ondemand', 00:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 00:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 00:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:16:52 INFO - 'installer_path': 'installer.exe', 00:16:52 INFO - 'log_level': 'info', 00:16:52 INFO - 'log_name': 'talos', 00:16:52 INFO - 'log_to_console': True, 00:16:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:16:52 INFO - 'opt_config_files': (), 00:16:52 INFO - 'pip_index': False, 00:16:52 INFO - 'sps_profile': False, 00:16:52 INFO - 'sps_profile_interval': 0, 00:16:52 INFO - 'suite': 'dromaeojs', 00:16:52 INFO - 'system_bits': '32', 00:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:16:52 INFO - 'title': 'talos-linux64-ix-020', 00:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:16:52 INFO - 'use_talos_json': True, 00:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:16:52 INFO - 'work_dir': 'build'} 00:16:52 INFO - [mozharness: 2016-08-24 07:16:52.929331Z] Running clobber step. 00:16:52 INFO - Running pre-action listener: _resource_record_pre_action 00:16:52 INFO - Running main action method: clobber 00:16:52 INFO - rmtree: /builds/slave/test/build 00:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:16:53 INFO - Running post-action listener: _resource_record_post_action 00:16:53 INFO - [mozharness: 2016-08-24 07:16:53.393512Z] Finished clobber step (success) 00:16:53 INFO - [mozharness: 2016-08-24 07:16:53.393615Z] Running read-buildbot-config step. 00:16:53 INFO - Running pre-action listener: _resource_record_pre_action 00:16:53 INFO - Running main action method: read_buildbot_config 00:16:53 INFO - Using buildbot properties: 00:16:53 INFO - { 00:16:53 INFO - "project": "", 00:16:53 INFO - "product": "firefox", 00:16:53 INFO - "script_repo_revision": "production", 00:16:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:16:53 INFO - "repository": "", 00:16:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:16:53 INFO - "buildid": "20160823230014", 00:16:53 INFO - "pgo_build": "False", 00:16:53 INFO - "basedir": "/builds/slave/test", 00:16:53 INFO - "buildnumber": 2114, 00:16:53 INFO - "slavename": "talos-linux64-ix-020", 00:16:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:16:53 INFO - "platform": "ubuntu64_hw", 00:16:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:16:53 INFO - "branch": "fx-team", 00:16:53 INFO - "repo_path": "integration/fx-team", 00:16:53 INFO - "revision": "eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc", 00:16:53 INFO - "stage_platform": "linux64", 00:16:53 INFO - "builduid": "210559543a0142338c596ba2e445cde6", 00:16:53 INFO - "slavebuilddir": "test" 00:16:53 INFO - } 00:16:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:16:53 INFO - Running post-action listener: _resource_record_post_action 00:16:53 INFO - [mozharness: 2016-08-24 07:16:53.396028Z] Finished read-buildbot-config step (success) 00:16:53 INFO - [mozharness: 2016-08-24 07:16:53.396117Z] Running download-and-extract step. 00:16:53 INFO - Running pre-action listener: _resource_record_pre_action 00:16:53 INFO - Running main action method: download_and_extract 00:16:53 INFO - mkdir: /builds/slave/test/build/tests 00:16:53 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')]} 00:16:53 INFO - trying https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:53 INFO - Downloaded 1361 bytes. 00:16:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:16:54 INFO - Using the following test package requirements: 00:16:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:16:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:16:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:16:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'jsshell-linux-x86_64.zip'], 00:16:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:16:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:16:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:16:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:16:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:16:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:16:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:16:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:16: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')]} 00:16:54 INFO - trying https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:16:54 INFO - Downloading https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:54 INFO - Downloaded 20324645 bytes. 00:16:54 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 00:16:59 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 00:16:59 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')]} 00:16:59 INFO - trying https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:16:59 INFO - Downloading https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:16:59 INFO - Downloaded 20324645 bytes. 00:16:59 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 00:17:04 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')]} 00:17:04 INFO - trying https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:17:05 INFO - Downloaded 14413981 bytes. 00:17:05 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 00:17: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')]} 00:17:05 INFO - trying https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:17:05 INFO - Downloading https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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 00:17:07 INFO - Downloaded 55761129 bytes. 00:17:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:17:07 INFO - mkdir: /builds/slave/test/properties 00:17:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:17:07 INFO - Writing to file /builds/slave/test/properties/build_url 00:17:07 INFO - Contents: 00:17:07 INFO - build_url:https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:17:08 INFO - Running post-action listener: _resource_record_post_action 00:17:08 INFO - Running post-action listener: set_extra_try_arguments 00:17:08 INFO - [mozharness: 2016-08-24 07:17:08.311268Z] Finished download-and-extract step (success) 00:17:08 INFO - [mozharness: 2016-08-24 07:17:08.311492Z] Running populate-webroot step. 00:17:08 INFO - Running pre-action listener: _resource_record_pre_action 00:17:08 INFO - Running main action method: populate_webroot 00:17:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:17:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:17:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:17:08 INFO - '--tppagecycles', 00:17:08 INFO - '7'], 00:17:08 INFO - 'tests': ['tsvgm']}}, 00:17:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:17:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:17:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:17:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:17:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:17:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:17:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['damp', 'tps']}, 00:17:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'tests': ['damp', 'tps']}, 00:17:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['dromaeo_dom']}, 00:17:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:17:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['basic_compositor_video']}, 00:17:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:17:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'other-e10s': {'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['a11yr', 00:17:08 INFO - 'ts_paint', 00:17:08 INFO - 'tpaint', 00:17:08 INFO - 'sessionrestore', 00:17:08 INFO - 'sessionrestore_no_auto_restore', 00:17:08 INFO - 'tabpaint']}, 00:17:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['tsvgx', 00:17:08 INFO - 'tsvgr_opacity', 00:17:08 INFO - 'tart', 00:17:08 INFO - 'tscrollx', 00:17:08 INFO - 'cart']}, 00:17:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:17:08 INFO - 'tsvgr_opacity', 00:17:08 INFO - 'tart', 00:17:08 INFO - 'tscrollx', 00:17:08 INFO - 'cart']}, 00:17:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'talos_options': ['--disable-e10s'], 00:17:08 INFO - 'tests': ['tp5o']}, 00:17:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'tests': ['tp5o']}, 00:17:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'talos_options': ['--disable-e10s', 00:17:08 INFO - '--xperf_path', 00:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:17:08 INFO - 'tests': ['tp5n']}, 00:17:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:17:08 INFO - 'talos_options': ['--xperf_path', 00:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:17:08 INFO - 'tests': ['tp5n']}}, 00:17:08 INFO - 'talos.zip': {'path': '', 00:17:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:17:08 INFO - Running post-action listener: _resource_record_post_action 00:17:08 INFO - [mozharness: 2016-08-24 07:17:08.333246Z] Finished populate-webroot step (success) 00:17:08 INFO - [mozharness: 2016-08-24 07:17:08.333334Z] Running create-virtualenv step. 00:17:08 INFO - Running pre-action listener: _resource_record_pre_action 00:17:08 INFO - Running main action method: create_virtualenv 00:17:08 INFO - Creating virtualenv /builds/slave/test/build/venv 00:17:08 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 00:17:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:17:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:17:08 INFO - Using real prefix '/usr' 00:17:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 00:17:10 INFO - Installing pip.................done. 00:17:10 INFO - Return code: 0 00:17:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:10 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:10 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 00:17:10 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 00:17:10 INFO - Using env: {'DISPLAY': ':0', 00:17:10 INFO - 'HOME': '/home/cltbld', 00:17:10 INFO - 'LANG': 'en_US.UTF-8', 00:17:10 INFO - 'LANGUAGE': 'en_US:en', 00:17:10 INFO - 'LOGNAME': 'cltbld', 00:17:10 INFO - 'MAIL': '/var/mail/cltbld', 00:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:10 INFO - 'MOZ_NO_REMOTE': '1', 00:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:10 INFO - 'NO_EM_RESTART': '1', 00:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:10 INFO - 'PWD': '/builds/slave/test', 00:17:10 INFO - 'SHELL': '/bin/bash', 00:17:10 INFO - 'SHLVL': '1', 00:17:10 INFO - 'TERM': 'linux', 00:17:10 INFO - 'TMOUT': '86400', 00:17:10 INFO - 'USER': 'cltbld', 00:17:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:10 INFO - '_': '/tools/buildbot/bin/python'} 00:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:11 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 00:17:11 INFO - Cleaning up... 00:17:11 INFO - Return code: 0 00:17:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:17:11 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')]} 00:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:11 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')]} 00:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:11 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:11 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 00:17:11 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 00:17:11 INFO - Using env: {'DISPLAY': ':0', 00:17:11 INFO - 'HOME': '/home/cltbld', 00:17:11 INFO - 'LANG': 'en_US.UTF-8', 00:17:11 INFO - 'LANGUAGE': 'en_US:en', 00:17:11 INFO - 'LOGNAME': 'cltbld', 00:17:11 INFO - 'MAIL': '/var/mail/cltbld', 00:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:11 INFO - 'MOZ_NO_REMOTE': '1', 00:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:11 INFO - 'NO_EM_RESTART': '1', 00:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:11 INFO - 'PWD': '/builds/slave/test', 00:17:11 INFO - 'SHELL': '/bin/bash', 00:17:11 INFO - 'SHLVL': '1', 00:17:11 INFO - 'TERM': 'linux', 00:17:11 INFO - 'TMOUT': '86400', 00:17:11 INFO - 'USER': 'cltbld', 00:17:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:11 INFO - '_': '/tools/buildbot/bin/python'} 00:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:11 INFO - Downloading/unpacking psutil>=3.1.1 00:17:11 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 00:17:11 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 00:17:11 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 00:17:11 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 00:17:11 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 00:17:11 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 00:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:17:13 INFO - Installing collected packages: psutil 00:17:13 INFO - Running setup.py install for psutil 00:17:13 INFO - building 'psutil._psutil_linux' extension 00:17:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:17:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:17:13 INFO - building 'psutil._psutil_posix' extension 00:17:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:17:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:17:13 INFO - Successfully installed psutil 00:17:13 INFO - Cleaning up... 00:17:13 INFO - Return code: 0 00:17:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:17:13 INFO - Using env: {'DISPLAY': ':0', 00:17:13 INFO - 'HOME': '/home/cltbld', 00:17:13 INFO - 'LANG': 'en_US.UTF-8', 00:17:13 INFO - 'LANGUAGE': 'en_US:en', 00:17:13 INFO - 'LOGNAME': 'cltbld', 00:17:13 INFO - 'MAIL': '/var/mail/cltbld', 00:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:13 INFO - 'MOZ_NO_REMOTE': '1', 00:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:13 INFO - 'NO_EM_RESTART': '1', 00:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:13 INFO - 'PWD': '/builds/slave/test', 00:17:13 INFO - 'SHELL': '/bin/bash', 00:17:13 INFO - 'SHLVL': '1', 00:17:13 INFO - 'TERM': 'linux', 00:17:13 INFO - 'TMOUT': '86400', 00:17:13 INFO - 'USER': 'cltbld', 00:17:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:13 INFO - '_': '/tools/buildbot/bin/python'} 00:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:14 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 00:17:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:17:16 INFO - Installing collected packages: mozsystemmonitor 00:17:16 INFO - Running setup.py install for mozsystemmonitor 00:17:16 INFO - Successfully installed mozsystemmonitor 00:17:16 INFO - Cleaning up... 00:17:16 INFO - Return code: 0 00:17:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:17:16 INFO - Using env: {'DISPLAY': ':0', 00:17:16 INFO - 'HOME': '/home/cltbld', 00:17:16 INFO - 'LANG': 'en_US.UTF-8', 00:17:16 INFO - 'LANGUAGE': 'en_US:en', 00:17:16 INFO - 'LOGNAME': 'cltbld', 00:17:16 INFO - 'MAIL': '/var/mail/cltbld', 00:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:16 INFO - 'MOZ_NO_REMOTE': '1', 00:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:16 INFO - 'NO_EM_RESTART': '1', 00:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:16 INFO - 'PWD': '/builds/slave/test', 00:17:16 INFO - 'SHELL': '/bin/bash', 00:17:16 INFO - 'SHLVL': '1', 00:17:16 INFO - 'TERM': 'linux', 00:17:16 INFO - 'TMOUT': '86400', 00:17:16 INFO - 'USER': 'cltbld', 00:17:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:16 INFO - '_': '/tools/buildbot/bin/python'} 00:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:16 INFO - Downloading/unpacking jsonschema==2.5.1 00:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:17:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 00:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:17:18 INFO - warning: no files found matching '*.txt' 00:17:18 INFO - no previously-included directories found matching 'build' 00:17:18 INFO - no previously-included directories found matching 'dist' 00:17:18 INFO - no previously-included directories found matching '.git*' 00:17:18 INFO - Installing collected packages: jsonschema, functools32 00:17:18 INFO - Running setup.py install for functools32 00:17:18 INFO - warning: no files found matching '*.txt' 00:17:18 INFO - no previously-included directories found matching 'build' 00:17:18 INFO - no previously-included directories found matching 'dist' 00:17:18 INFO - no previously-included directories found matching '.git*' 00:17:18 INFO - Successfully installed jsonschema functools32 00:17:18 INFO - Cleaning up... 00:17:18 INFO - Return code: 0 00:17:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:17:18 INFO - Using env: {'DISPLAY': ':0', 00:17:18 INFO - 'HOME': '/home/cltbld', 00:17:18 INFO - 'LANG': 'en_US.UTF-8', 00:17:18 INFO - 'LANGUAGE': 'en_US:en', 00:17:18 INFO - 'LOGNAME': 'cltbld', 00:17:18 INFO - 'MAIL': '/var/mail/cltbld', 00:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:18 INFO - 'MOZ_NO_REMOTE': '1', 00:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:18 INFO - 'NO_EM_RESTART': '1', 00:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:18 INFO - 'PWD': '/builds/slave/test', 00:17:18 INFO - 'SHELL': '/bin/bash', 00:17:18 INFO - 'SHLVL': '1', 00:17:18 INFO - 'TERM': 'linux', 00:17:18 INFO - 'TMOUT': '86400', 00:17:18 INFO - 'USER': 'cltbld', 00:17:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:18 INFO - '_': '/tools/buildbot/bin/python'} 00:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:17:18 INFO - Cleaning up... 00:17:18 INFO - Return code: 0 00:17:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:17:18 INFO - Using env: {'DISPLAY': ':0', 00:17:18 INFO - 'HOME': '/home/cltbld', 00:17:18 INFO - 'LANG': 'en_US.UTF-8', 00:17:18 INFO - 'LANGUAGE': 'en_US:en', 00:17:18 INFO - 'LOGNAME': 'cltbld', 00:17:18 INFO - 'MAIL': '/var/mail/cltbld', 00:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:18 INFO - 'MOZ_NO_REMOTE': '1', 00:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:18 INFO - 'NO_EM_RESTART': '1', 00:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:18 INFO - 'PWD': '/builds/slave/test', 00:17:18 INFO - 'SHELL': '/bin/bash', 00:17:18 INFO - 'SHLVL': '1', 00:17:18 INFO - 'TERM': 'linux', 00:17:18 INFO - 'TMOUT': '86400', 00:17:18 INFO - 'USER': 'cltbld', 00:17:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:18 INFO - '_': '/tools/buildbot/bin/python'} 00:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:19 INFO - Downloading/unpacking blobuploader==1.2.4 00:17:19 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 00:17:19 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 00:17:19 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 00:17:19 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 00:17:19 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 00:17:19 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 00:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 00:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:17:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:17:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:17:22 INFO - Downloading docopt-0.6.1.tar.gz 00:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:17:22 INFO - Installing collected packages: blobuploader, requests, docopt 00:17:22 INFO - Running setup.py install for blobuploader 00:17:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:17:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:17:22 INFO - Running setup.py install for requests 00:17:23 INFO - Running setup.py install for docopt 00:17:23 INFO - Successfully installed blobuploader requests docopt 00:17:23 INFO - Cleaning up... 00:17:23 INFO - Return code: 0 00:17:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:17:23 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')]} 00:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:23 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')]} 00:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:23 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:23 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 00:17:23 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 00:17:23 INFO - Using env: {'DISPLAY': ':0', 00:17:23 INFO - 'HOME': '/home/cltbld', 00:17:23 INFO - 'LANG': 'en_US.UTF-8', 00:17:23 INFO - 'LANGUAGE': 'en_US:en', 00:17:23 INFO - 'LOGNAME': 'cltbld', 00:17:23 INFO - 'MAIL': '/var/mail/cltbld', 00:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:23 INFO - 'MOZ_NO_REMOTE': '1', 00:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:23 INFO - 'NO_EM_RESTART': '1', 00:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:23 INFO - 'PWD': '/builds/slave/test', 00:17:23 INFO - 'SHELL': '/bin/bash', 00:17:23 INFO - 'SHLVL': '1', 00:17:23 INFO - 'TERM': 'linux', 00:17:23 INFO - 'TMOUT': '86400', 00:17:23 INFO - 'USER': 'cltbld', 00:17:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:23 INFO - '_': '/tools/buildbot/bin/python'} 00:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:17:23 INFO - Running setup.py (path:/tmp/pip-5rzSkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:17:23 INFO - Running setup.py (path:/tmp/pip-CeUaxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:17:23 INFO - Running setup.py (path:/tmp/pip-Piza4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:17:23 INFO - Running setup.py (path:/tmp/pip-r2AvFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:17:23 INFO - Running setup.py (path:/tmp/pip-GhV8NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:17:23 INFO - Running setup.py (path:/tmp/pip-YpuhNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:17:24 INFO - Running setup.py (path:/tmp/pip-_gwNYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:17:24 INFO - Running setup.py (path:/tmp/pip-vI04eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:17:24 INFO - Running setup.py (path:/tmp/pip-KuAtJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:17:24 INFO - Running setup.py (path:/tmp/pip-Fr4Dh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:17:24 INFO - Running setup.py (path:/tmp/pip-acnTUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:17:24 INFO - Running setup.py (path:/tmp/pip-icRtw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:17:24 INFO - Running setup.py (path:/tmp/pip-xobmO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:17:24 INFO - Running setup.py (path:/tmp/pip-CBa78H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:24 INFO - Running setup.py (path:/tmp/pip-otw_As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:17:24 INFO - Running setup.py (path:/tmp/pip-RfMmGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:17:24 INFO - Running setup.py (path:/tmp/pip-3iHHhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:17:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:17:24 INFO - Running setup.py install for manifestparser 00:17:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:17:24 INFO - Running setup.py install for mozcrash 00:17:25 INFO - Running setup.py install for mozdebug 00:17:25 INFO - Running setup.py install for mozdevice 00:17:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for mozfile 00:17:25 INFO - Running setup.py install for mozhttpd 00:17:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for mozinfo 00:17:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for mozInstall 00:17:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for mozleak 00:17:25 INFO - Running setup.py install for mozlog 00:17:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for moznetwork 00:17:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:17:25 INFO - Running setup.py install for mozprocess 00:17:26 INFO - Running setup.py install for mozprofile 00:17:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:17:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:17:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:17:26 INFO - Running setup.py install for mozrunner 00:17:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:17:26 INFO - Running setup.py install for mozscreenshot 00:17:26 INFO - Running setup.py install for moztest 00:17:26 INFO - Running setup.py install for mozversion 00:17:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:17:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:17:26 INFO - Cleaning up... 00:17:26 INFO - Return code: 0 00:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:17:26 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')]} 00:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:26 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')]} 00:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:26 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:26 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 00:17:26 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 00:17:26 INFO - Using env: {'DISPLAY': ':0', 00:17:26 INFO - 'HOME': '/home/cltbld', 00:17:26 INFO - 'LANG': 'en_US.UTF-8', 00:17:26 INFO - 'LANGUAGE': 'en_US:en', 00:17:26 INFO - 'LOGNAME': 'cltbld', 00:17:26 INFO - 'MAIL': '/var/mail/cltbld', 00:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:26 INFO - 'MOZ_NO_REMOTE': '1', 00:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:26 INFO - 'NO_EM_RESTART': '1', 00:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:26 INFO - 'PWD': '/builds/slave/test', 00:17:26 INFO - 'SHELL': '/bin/bash', 00:17:26 INFO - 'SHLVL': '1', 00:17:26 INFO - 'TERM': 'linux', 00:17:26 INFO - 'TMOUT': '86400', 00:17:26 INFO - 'USER': 'cltbld', 00:17:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:26 INFO - '_': '/tools/buildbot/bin/python'} 00:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:17:26 INFO - Running setup.py (path:/tmp/pip-TE77w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:17:26 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)) 00:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:17:26 INFO - Running setup.py (path:/tmp/pip-l1EB_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:17:27 INFO - Running setup.py (path:/tmp/pip-SAIjmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:17:27 INFO - Running setup.py (path:/tmp/pip-RtVVj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:17:27 INFO - Running setup.py (path:/tmp/pip-PHloVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:17:27 INFO - Running setup.py (path:/tmp/pip-mLAL8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:17:27 INFO - Running setup.py (path:/tmp/pip-RJrE6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:17:27 INFO - Running setup.py (path:/tmp/pip-Q0EBu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:17:27 INFO - Running setup.py (path:/tmp/pip-b2CoKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:17:27 INFO - Running setup.py (path:/tmp/pip-C6NuRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:17:27 INFO - Running setup.py (path:/tmp/pip-NRUB0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:17:27 INFO - Running setup.py (path:/tmp/pip-_Kf8lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:17:27 INFO - Running setup.py (path:/tmp/pip-becBLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:17:27 INFO - Running setup.py (path:/tmp/pip-ALGK8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:27 INFO - Running setup.py (path:/tmp/pip-RNm_MA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:17:27 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)) 00:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:17:27 INFO - Running setup.py (path:/tmp/pip-zgdGab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:17:28 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)) 00:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:17:28 INFO - Running setup.py (path:/tmp/pip-vgqlwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:17:28 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)) 00:17:28 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)) 00:17:28 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)) 00:17:28 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)) 00:17:28 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)) 00:17:28 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)) 00:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:17:28 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 00:17:28 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 00:17:28 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 00:17:28 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 00:17:28 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 00:17:28 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 00:17:30 INFO - Downloading blessings-1.6.tar.gz 00:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:17:30 INFO - Installing collected packages: blessings 00:17:30 INFO - Running setup.py install for blessings 00:17:30 INFO - Successfully installed blessings 00:17:30 INFO - Cleaning up... 00:17:30 INFO - Return code: 0 00:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:17:30 INFO - Reading from file tmpfile_stdout 00:17:30 INFO - Current package versions: 00:17:30 INFO - argparse == 1.2.1 00:17:30 INFO - blessings == 1.6 00:17:30 INFO - blobuploader == 1.2.4 00:17:30 INFO - docopt == 0.6.1 00:17:30 INFO - functools32 == 3.2.3-2 00:17:30 INFO - jsonschema == 2.5.1 00:17:30 INFO - manifestparser == 1.1 00:17:30 INFO - mozInstall == 1.12 00:17:30 INFO - mozcrash == 0.17 00:17:30 INFO - mozdebug == 0.1 00:17:30 INFO - mozdevice == 0.48 00:17:30 INFO - mozfile == 1.2 00:17:30 INFO - mozhttpd == 0.7 00:17:30 INFO - mozinfo == 0.9 00:17:30 INFO - mozleak == 0.1 00:17:30 INFO - mozlog == 3.3 00:17:30 INFO - moznetwork == 0.27 00:17:30 INFO - mozprocess == 0.23 00:17:30 INFO - mozprofile == 0.28 00:17:30 INFO - mozrunner == 6.12 00:17:30 INFO - mozscreenshot == 0.1 00:17:30 INFO - mozsystemmonitor == 0.3 00:17:30 INFO - moztest == 0.7 00:17:30 INFO - mozversion == 1.4 00:17:30 INFO - psutil == 3.1.1 00:17:30 INFO - requests == 1.2.3 00:17:30 INFO - wsgiref == 0.1.2 00:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00: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')]} 00:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00: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')]} 00:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:30 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:30 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 00:17:30 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 00:17:30 INFO - Using env: {'DISPLAY': ':0', 00:17:30 INFO - 'HOME': '/home/cltbld', 00:17:30 INFO - 'LANG': 'en_US.UTF-8', 00:17:30 INFO - 'LANGUAGE': 'en_US:en', 00:17:30 INFO - 'LOGNAME': 'cltbld', 00:17:30 INFO - 'MAIL': '/var/mail/cltbld', 00:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:30 INFO - 'MOZ_NO_REMOTE': '1', 00:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:30 INFO - 'NO_EM_RESTART': '1', 00:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:30 INFO - 'PWD': '/builds/slave/test', 00:17:30 INFO - 'SHELL': '/bin/bash', 00:17:30 INFO - 'SHLVL': '1', 00:17:30 INFO - 'TERM': 'linux', 00:17:30 INFO - 'TMOUT': '86400', 00:17:30 INFO - 'USER': 'cltbld', 00:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:30 INFO - '_': '/tools/buildbot/bin/python'} 00:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 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)) 00:17:30 INFO - Cleaning up... 00:17:30 INFO - Return code: 0 00:17:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00: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')]} 00:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00: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')]} 00:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:17:30 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 0x7f4b028dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', '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 00:17:30 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 00:17:30 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 00:17:30 INFO - Using env: {'DISPLAY': ':0', 00:17:30 INFO - 'HOME': '/home/cltbld', 00:17:30 INFO - 'LANG': 'en_US.UTF-8', 00:17:30 INFO - 'LANGUAGE': 'en_US:en', 00:17:30 INFO - 'LOGNAME': 'cltbld', 00:17:30 INFO - 'MAIL': '/var/mail/cltbld', 00:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:30 INFO - 'MOZ_NO_REMOTE': '1', 00:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:30 INFO - 'NO_EM_RESTART': '1', 00:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:30 INFO - 'PWD': '/builds/slave/test', 00:17:30 INFO - 'SHELL': '/bin/bash', 00:17:30 INFO - 'SHLVL': '1', 00:17:30 INFO - 'TERM': 'linux', 00:17:30 INFO - 'TMOUT': '86400', 00:17:30 INFO - 'USER': 'cltbld', 00:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:30 INFO - '_': '/tools/buildbot/bin/python'} 00:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:17:30 INFO - Cleaning up... 00:17:30 INFO - Return code: 0 00:17:30 INFO - Running post-action listener: _resource_record_post_action 00:17:30 INFO - Running post-action listener: _start_resource_monitoring 00:17:31 INFO - Starting resource monitoring. 00:17:31 INFO - [mozharness: 2016-08-24 07:17:31.008295Z] Finished create-virtualenv step (success) 00:17:31 INFO - [mozharness: 2016-08-24 07:17:31.008807Z] Running install step. 00:17:31 INFO - Running pre-action listener: _resource_record_pre_action 00:17:31 INFO - Running main action method: install 00:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:17:31 INFO - Reading from file tmpfile_stdout 00:17:31 INFO - Detecting whether we're running mozinstall >=1.0... 00:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:17:31 INFO - Reading from file tmpfile_stdout 00:17:31 INFO - Output received: 00:17:31 INFO - Usage: mozinstall [options] installer 00:17:31 INFO - Options: 00:17:31 INFO - -h, --help show this help message and exit 00:17:31 INFO - -d DEST, --destination=DEST 00:17:31 INFO - Directory to install application into. [default: 00:17:31 INFO - "/builds/slave/test"] 00:17:31 INFO - --app=APP Application being installed. [default: firefox] 00:17:31 INFO - mkdir: /builds/slave/test/build/application 00:17:31 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'] 00:17:31 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 00:17:47 INFO - Reading from file tmpfile_stdout 00:17:47 INFO - Output received: 00:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 00:17:47 INFO - Running post-action listener: _resource_record_post_action 00:17:47 INFO - [mozharness: 2016-08-24 07:17:47.366525Z] Finished install step (success) 00:17:47 INFO - [mozharness: 2016-08-24 07:17:47.366772Z] Running run-tests step. 00:17:47 INFO - Running pre-action listener: _resource_record_pre_action 00:17:47 INFO - Running main action method: run_tests 00:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:17:47 INFO - Python 2.7.3 00:17:47 INFO - Return code: 0 00:17:47 INFO - grabbing minidump binary from tooltool 00:17:47 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')]} 00:17:47 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 0x23b3d20>, '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 0x23b4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b50b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:17:47 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 00:17:47 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 00:17:47 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 00:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:17:47 INFO - Return code: 0 00:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 00:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 00:17:47 INFO - Using env: {'DISPLAY': ':0', 00:17:47 INFO - 'HOME': '/home/cltbld', 00:17:47 INFO - 'LANG': 'en_US.UTF-8', 00:17:47 INFO - 'LANGUAGE': 'en_US:en', 00:17:47 INFO - 'LOGNAME': 'cltbld', 00:17:47 INFO - 'MAIL': '/var/mail/cltbld', 00:17:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:17:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:17:47 INFO - 'MOZ_NO_REMOTE': '1', 00:17:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:17:47 INFO - 'NO_EM_RESTART': '1', 00:17:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:17:47 INFO - 'PWD': '/builds/slave/test', 00:17:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:17:47 INFO - 'SHELL': '/bin/bash', 00:17:47 INFO - 'SHLVL': '1', 00:17:47 INFO - 'TERM': 'linux', 00:17:47 INFO - 'TMOUT': '86400', 00:17:47 INFO - 'USER': 'cltbld', 00:17:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658', 00:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:17:47 INFO - '_': '/tools/buildbot/bin/python'} 00:17:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 00:17:47 INFO - mozversion application_buildid: 20160823230014 00:17:47 INFO - mozversion application_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 00:17:47 INFO - mozversion application_display_name: Nightly 00:17:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:17:47 INFO - mozversion application_name: Firefox 00:17:47 INFO - mozversion application_remotingname: firefox 00:17:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:17:47 INFO - mozversion application_vendor: Mozilla 00:17:47 INFO - mozversion application_version: 51.0a1 00:17:47 INFO - mozversion platform_buildid: 20160823230014 00:17:47 INFO - mozversion platform_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 00:17:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:17:47 INFO - mozversion platform_version: 51.0a1 00:17:47 INFO - using testdate: 1472023067 00:17:47 INFO - actual date: 1472023067 00:17:47 INFO - starting webserver on 'localhost:42684' 00:17:47 INFO - SUITE-START | Running 2 tests 00:17:47 INFO - TEST-START | dromaeo_css 00:17:47 INFO - operating with platform_type : linux_ 00:17:47 INFO - Initialising browser for dromaeo_css test... 00:17:47 INFO - TEST-INFO | started process 17853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdPFF3/profile http://localhost:42684/getInfo.html) 00:17:52 INFO - PROCESS | 17853 | __metrics Screen width/height:1600/1200 00:17:52 INFO - PROCESS | 17853 | colorDepth:24 00:17:52 INFO - PROCESS | 17853 | Browser inner width/height: 1024/697 00:17:52 INFO - PROCESS | 17853 | __metrics 00:17:53 INFO - PROCESS | 17853 | 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" 00:17:53 INFO - PROCESS | 17853 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:17:54 INFO - TEST-INFO | 17853: exit 0 00:17:54 INFO - Browser initialized. 00:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 00:17:54 INFO - TEST-INFO | started process 17933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdPFF3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:18:06 INFO - PROCESS | 17933 | RSS: Main: 181665792 00:18:06 INFO - PROCESS | 17933 | 00:18:57 INFO - PROCESS | 17933 | 1472023137753 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] 00:21:10 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42684/tests/dromaeo/cssquery-ext.html) 00:21:12 INFO - PROCESS | 17933 | RSS: Main: 270065664 00:21:12 INFO - PROCESS | 17933 | 00:24:14 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-ext.html (next: http://localhost:42684/tests/dromaeo/cssquery-jquery.html) 00:24:15 INFO - PROCESS | 17933 | RSS: Main: 274116608 00:24:15 INFO - PROCESS | 17933 | 00:27:17 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42684/tests/dromaeo/cssquery-mootools.html) 00:27:18 INFO - PROCESS | 17933 | RSS: Main: 218869760 00:27:18 INFO - PROCESS | 17933 | 00:30:20 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42684/tests/dromaeo/cssquery-prototype.html) 00:30:21 INFO - PROCESS | 17933 | RSS: Main: 218447872 00:30:21 INFO - PROCESS | 17933 | 00:33:24 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42684/tests/dromaeo/cssquery-yui.html) 00:33:24 INFO - PROCESS | 17933 | RSS: Main: 227811328 00:33:24 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-yui.html (next: http://localhost:42684/tests/dromaeo/cssquery-dojo.html) 00:36:28 INFO - PROCESS | 17933 | RSS: Main: 301809664 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | __start_tp_report 00:36:28 INFO - PROCESS | 17933 | _x_x_mozilla_page_load 00:36:28 INFO - PROCESS | 17933 | _x_x_mozilla_page_load_details 00:36:28 INFO - PROCESS | 17933 | |i|pagename|runs| 00:36:28 INFO - PROCESS | 17933 | |0;dojo.html;2536.061657186841;2602.323395917061;2610.477904419117;2631.3027047832315;2632.9341766455836;4633.351330813689;4696.1781688204555;4723.3151193077065;4763.333133361332;4843.9757801211035;4598.494165641777;4632.583067523922;4715.599174070199;4750.619950403968;4760.714357138574;4138.6482149017365;4189.141226048668;4204.11713540157;4288.056627541936;4438.090191510749;4338.652907767371;4367.475902891658;4427.247367947457;4439.400680908085;4440.222960981831;4293.184294983943;4344.891377715582;4349.630281426051;4352.847650332224;4432.534583868695;4265.53079161292;4270.231358355495;4281.31498960168;4302.075053863435;4335.674824388152;4267.039916018902;4315.050688848449;4318.589733975267;4319.935200971988;4387.341898715186;4656.231721765938;4672.827284922795;4715.717056976592;4721.409823772028;4723.669343145981;4971.105201063807;5005.149124648782;5022.6233032522705;5025.447200807908;5040.445550989388;5049.747512624354;5057;5060.316857224265;5067.5859476623245;5092.592592592584;4654.953450465519;4697;4722.1972264714395;4733.195356789354;4737;5054.115529782273;5091.949080509147;5101.20931255656;5108.335916330853;5132.8460146195675;4908.969116485507;4913.287573301851;4917.901641967141;4920;4985.626078044161;4910.361652985089;4978.701277923336;4990.6257030722845;4992.151334273182;4993.1262029144755;4918.778654960535;4918.778654960535;4921.606271498272;4950.504949505093;5012.022655582199;4919.7540122993705;4923.138450771101;4926.581240594518;4928.852134435972;4989.126902791997;4161.479815023122;4169.312063509547;4174.582541745801;4186.665066794649;4217.8523751668545;3602.1534939289245;3633.182533929845;3656.7440279180732;3688.61269566697;3733.533308336458;4372.191144638188;4375.47494300686;4375.540568240289;4425.181341451842;4430;5032.245163225545;5037;5040.722760248222;5042.369703787027;5113.181890897438;4231.534531201565;4270.12462445198;4343.348497725303;4352.412424322739;4379.0366119453665;4477.574630410106;4498.437695288089;4549.977250113729;4552.70407423523;4562.178807814559;4769.73766442842;4780.713157210578;4784.258439941815;4785.282207668877;4796.112719146969;4890.168671325812;5013.974930125326;5051.974740126276;5058;5078.263651770399;4758.5241475852135;4763.118823017753;4766.213574760126;4796.25658023007;4808.711477311373;4954.77703503336;4956.479569645136;4959.677620954626;4970.478099799469;5006.69959802413;4935.629827763004;4995.675281106716;5043.142665746906;5044.293798868235;5109.514596113363;4932.062908047459;4937.456879743298;4938.08645400602;4964.106460837084;4975.477574854588;4919.655624106278;4925.605951523941;4928.383952005999;4939.678920870132;4988.9501104988485;4767.237242041257;4773.37946067009;4812.8796780080775;4847.515248475124;4920.163572192664;4955.851324460272;4959.528844759742;4961.355023846877;4991.5258050485145;5006.69959802413;4824.975875120602;4833.03339332128;4836.492168322417;4839.1531481991215;4901.142300097397 00:36:28 INFO - PROCESS | 17933 | |1;ext.html;569.7806344557345;587.9412058794123;588.8998870192067;591.8431615621859;594.4293478260869;29105.85447072764;43607.563924360744;44922.55077449224;45012.3248151278;45060.09879802402;41542.169156616925;41943.790281048554;41971.37042944358;41992.58007419925;42019.15961680764;7656.119546252183;7797.220277972214;7802.960985195066;7804.531728096304;7805.804854878616;7675.232476752336;7734.651940662656;7782.338501227402;7787.688492460295;7788.961055194716;7776.883346749803;7831.686732530692;7836.2947334739865;7838;7842.372610191171;7723.459357844953;7756.534607923542;7771.261730135628;7777.066751989769;7777.961110194413;7701.576413297266;7770.689172433096;7778.805529861742;7781.416393770433;7781.922180778176;38909.61090389088;39252.803735981426;39332.606673933464;39351.4097288538;39377.60622393797;2767.501849667059;2899.347646779479;2920.386718789057;3137.703125776493;3546.4680297955256;29237.41525169506;29955.70044299551;30003.249918752204;30156.849215754;31237.37525249505;3555.3955827509385;3601.099725068733;3669;3705.7776533408082;3769.9623003769884;249949;251089;251154;252459;252635;31578.36843263168;54767.72616136894;55022.17466738002;55030.44969550333;55108.72445637746;32061;32218.67781322157;32288;32328;32334.35331293361;12500.624981250578;12506;12522.186057906207;12623.747525049632;12627.368631568384;10238.641647542301;10332.690019299433;10350.637727679496;10356.430396328124;10365.429901355346;7774.844503109906;7825.943497627862;7877.212278772192;7910.208979102159;7917.643706033243;3044.8325342106396;3064.846757662108;3070.293832418556;3075.2465645916895;3075.6924307569066;854.81621451387;919.1957037592107;949.6106596295485;975.2003357247131;986.7237173591406;27393.86303068472;28075.43849123047;28162.577561336595;28693;28863.278418039296;755.2409828122702;909.231699214163;933.8972713001565;957.9904200957901;961.4663861556903;13801.230326755604;14784.90633257125;14809.259537023107;14879.702405952037;14896.911821638103;368066;368771;370634.17463301704;370823;372506;49241.26138107931;49819;49831.501684983414;49872;49937.500624993285;1132.8980391764617;1142.2175809570472;1176.129664048615;1178.116412690482;1179.4102948525738;26321.736782631928;26713.46573068489;27122.457550849267;28109;28233;42685.35971960485;42932;43008.9035309183;43009.13981720411;43042.35436468518;312566;312991;313129;313201;314264;23648.290551283488;25978.35054123662;26283.79459286505;26307.736922630527;26312.3421914446;43083;43385.56614433941;43560.56439435565;44043.55956440394;44890.18433433064;36798.8160059198;36862.63137368592;37158.071048222926;37198.25840927326;38008.239835202585;36779.81610091932;37496.81251593724;37527.81236093802;37609.4358584616;37747;35348.293034139686;35740.82129589335;35810.28379432449;35934.281314373045;36305.63694363023;31702.682973169973;32755;32778.67221327756;32873.34253314872;32981.835090824396;25008.62487062659;25165.37086572777;25334.493310133326;25389.746102539477;25784.097556585428 00:36:28 INFO - PROCESS | 17933 | |2;jquery.html;346.0707999022623;365.4025668032764;371.88805471639796;373.49391574416666;384.54431498674074;12806.807897881528;15900.92049539752;15972.84027159728;16441.095739734308;17368.392106276282;16283.430079947204;16559.420420285292;16638.168091595402;16875.240614172362;16961.660766784687;5008.82469113582;5055.508624955629;5110.693358398489;5110.923336149961;5147.22791581262;3694.501242332278;5038.899222015558;5124.0776660201145;5127.230915362707;5767.625104368223;6069.908951365733;6112.633242005471;6173.722182501798;6184.381561843825;6187.071939209132;5940.584159108864;6002.819915402545;6023.126646636257;6049.667268300242;6172.69136543171;5334.826338205588;5341.67949923002;5341.839744807662;5343.412224655285;5343.893122137574;20456;20805.479863003395;21148;21361.465963350885;21638.675419868716;1851.6666999940005;1866.673332166879;1886.7075603281514;2151.6664916937743;2566.679165104362;13713.314334283346;14059.78910316346;14100.92949535256;14410.783838242434;15628.765568516481;1830.5606654402848;1868.26203649559;1868.4581471373285;1889.3765057530982;1926.1813729165049;55091;76909.23090769077;81518.77721834237;83287;83672;15654.608634784221;16191.595210119605;16562.50312490627;16877.662446750997;16878.409255675993;28805.85597072001;28816.135515934555;28907.277318066797;28948.42103157925;29002.854985724935;8598.312135029182;8777.51723655205;8911;9103.408278461879;9162.725118246462;7160.820979475555;7182.497225194186;7246.130464344313;7443.255674432622;7453.329200371993;8131.471454355448;8313.12712165214;8421.747347579583;8466.32269418445;8559.572021398904;3226.8870589529256;3268.6894744999186;3297.1262615406936;3324.985879306786;3406.744494162948;694.982625434358;841.4362377207286;853.7225401744458;862.5859587397958;942.9811403771886;16175.110368929587;16602.418915337905;16771.748423773653;17051.573710657332;17516.38692645751;812.8658771302787;814.6619153051417;815.4780940198278;849.1720572441943;879.8298263309782;8724.738257852274;9515.143637072697;9615.711528654152;9659.806803863883;9776.51117444125;374409;376757;379283;390732;396287;72045;75969.24030759733;76549;77184;79575;878.9780255493536;896.5248418338291;918.6646873891116;919.5494207838111;926.6478738079621;14878.527983846589;14934.626634334229;15406.38374465009;15481.380744770084;15791.131487768283;35385.82307088448;36206.45690314595;36964.815175925025;37785.62214377931;38529.80735096306;44776.77611612051;46876;50601;51514.22728659148;51993.7400312996;7137.286271372821;7313.561186328838;7515.098188217449;7540;7773.494722842997;10590.788184236426;10638.468076596295;10675.14598832076;10861;10923.180761443082;9352.67265645699;9352.859707104262;9386.249100072115;9804.264680148875;10044.849327260243;9419.764505887408;9424.670136545188;9435.386699864486;9558.378705384128;9709.854352184864;9175.587098580714;9481.051894810464;9514.952425237829;9961.950190249003;10049.799004019733;7358.705651773869;7474.551526908403;7486.022931867689;7495.40036797044;7787.727429539939;7529.73645922412;9335.626574936927;9628.66299679508;9648.179904708179;9690.806183876142 00:36:28 INFO - PROCESS | 17933 | |3;mootools.html;1329.1028555724886;1375.7592421326267;1400.8599140085992;1603.1743652019213;1609.1230279497672;7348.70605175793;7847.411444141684;7855.1359350471475;7859.449838511307;7868.606569671522;6742.69657865396;7429.888551671729;7698.384129269645;7700.4224683148705;7702.499337543056;2171.7285339332625;2192.1012384922187;2200.834937379695;2201.4276288165033;2205.162038425396;2119.8198153157;2176.064292354287;2177.4556360909774;2180.9127634894667;2187.9935229794314;2152.569486102778;2159.0931808640407;2173.250228671106;2173.587018466494;2174.369432864475;2119.6396612575822;2123.702681624574;2127.0747224957195;2127.8404119691086;2127.925522606701;2083.624947509448;2111.6304646686767;2113.471632091977;2114.492521794758;2117.1002324012234;7771.106322772897;7834.608269586498;7850.175731548219;7867.134615192324;7892.684292628288;4420.226460369422;4579.450465944108;4582.358469814229;4588.7246765194195;4602;2701.284159697682;2759.075709637274;2822.8588570571387;2835.206142280165;2847.501687204731;828.8715249136394;883.8364902493059;892.3931726426027;894.6958034268315;1831.8626103042193;9959.701208963743;10326.328788628714;10338.379697218115;10339.379637221715;10353.327033742782;3658.5609726832417;3901.902452438712;3935.9016024599614;3954.663853572421;3961.920761584752;8301.501909885426;8304.377171712145;8311.293540049042;8315.126911674188;8326.333893288522;4391.055922976511;4395.120975804852;4400.427944367212;4407.0524837160165;4414.735115893057;3583.5699716033723;3987.4218238355274;4112.09533902541;4116.794160292034;4189.853355132616;3310.6192787829227;3389.8135602542097;3439.8624055038017;3494.633063528344;3499.3176330615283;995.4972738766876;999.8500224966314;1009.5658866687248;1010.5099026971913;1010.6109147978082;692.3491917597443;828.1428721273453;831.4387788242911;843.3464065349403;846.3313981954187;4978.77595508203;5093.23601459784;5115.437301896788;5142.331496905378;5279.498447647467;352.74426041120495;403.5117507815517;403.7476577139288;407.28928020604235;409.4002286650072;3490.214701692099;3549.8580056797437;3626.782393056425;3688.7786732796117;3719.1445967427644;9494.430334179971;9770.12068913787;9830.901690983143;9835.164011058998;9835.606575737034;9415.199708024758;9519.286053546011;9744.90255097454;9796;9802.117809397047;7270.709171633075;7339.963300183572;7360.96319518399;7378.520396174232;7387.039684840936;5151.330327057459;5155.639105262596;5161.406438259648;5193.896122077613;5438.293021907285;8816.559172041243;8836.867446988428;8843.955780221058;8856;8856.64573417082;8805.955970220364;9087.454752714593;9139.223166030963;9167.862482062641;9193;5672.347680016685;6017.217761690952;6218.471429928507;6249.375062493896;6298.874022519615;7417.221191774786;7564.50830696003;7579.54522728638;7580.81047973783;7582.241775822374;6672.199336079701;6755.256921738506;6770.729170833309;6985.860282794417;6997.265287144776;6532.41208291256;6574.605523668404;6616.106825578485;6628.27089020217;6695.363940425652;5864.384239654775;5959.970200148971;5961.225040744849;5963.105534169909;5968.224130863134;4445.555444455528;4607.262837945913;4668.813247470063;4686.953130468652;4704.858854234379;4457;4549.158405694957;4549.294859296814;4679.110968915895;4689.812407503661 00:36:28 INFO - PROCESS | 17933 | |4;prototype.html;296.19287441721303;299.92052106191863;303.5189225078249;304.7896951103739;305.06497584902286;4852.999999999991;4859.708417494953;4870.756462176886;4875.975620121899;4878;4800.927986080203;4806.927896081562;4810.542998415153;4813.181759100952;4814.9759251203695;3614.186807968206;3647.4893514907935;3805.4862593549933;3822.3310920588924;3824.8470061197518;3801.7909015004166;3811.6950643948417;3830.3105441020607;3842.385218365062;3856.5179352580926;3791.9620803791886;3793.298239825627;3796.9810150949343;3806.219724956391;3834.7699138051667;3615.8553657853654;3670.743047986642;3766.2090960898245;3775.565809931838;3803.2773772983046;3349.7990120592845;3352.430086885235;3358.7740474726793;3360.7397226040234;3361.8991430257133;4674.439067311944;4682.782476556086;4683.1336202802595;4698.107359601699;4745.857624271277;4210.3684447332835;4295.957040429618;4323.135372925428;4334.111507141029;4343.9348409773875;4993.375828021497;5007.749612519359;5024.924626130611;5051.44434112251;5070.3915530136255;3651.356889399781;3657.4696668982847;3682;3683.557973043225;3691.3724666806706;5058.797648094109;5272.393674727378;5274.127684671925;5275.525202731734;5297.947020529784;3724.981375093107;3735.9066023349633;3742.700583953277;3745.5318085239346;3755.962440375561;3788.844402457277;3791.677707394847;3798.3732684106812;3800.7149463790324;3802.885913422602;4257;4286.7856607169515;4287.421198138211;4290.89272768177;4317.546657600969;4854.68444551103;4997.9750101249265;5003.674761140514;5009.599232061426;5081.8475445736685;1295.859643513702;1310.914790538631;1311.5475161069417;1313.9868601314056;1316.4602512969827;827.6772058897035;852.7186028610544;854.4147259127393;863.2403484933219;869.3132425384002;4356.542563030899;4459.598636122764;4473.485549161888;4482.041852377415;4506.436695413074;5148.150555158357;5154.5360917516855;5156.329677142023;5157.73910611182;5205.193195054772;4468.21806183923;4476.46282446102;4491.797869095899;4499.605122412063;4509.624564507857;2614.4509652972706;2750.037486879616;2769.238459423634;2770.6449517909614;2771.431856469419;4913.361263035782;4913.518673070077;4918.745719841418;4926.630502712311;4927.694161047325;5213.713245771519;5257.000695997287;5325.360956685223;5333.733313334318;5345.599080069011;4883.267509873547;4890.877728056756;4897.314375987436;4906.950930490792;4926.236433352836;5143.177091665316;5159.974200129125;5160.148575485003;5165.638405311592;5174.637775355689;4867.831720387011;5040.269160971565;5080.960636294081;5082.263071854634;5084;4868.2210846264425;4887.169181239269;4891.510848915223;4917.139500587311;4919.532644398776;3331.1172539277595;3365.5793025871767;3385.5260263562627;3390.965755444613;3393.474011528217;4481.574250446202;4638.257878739386;4649.442066951988;4683.812647494062;4686.625069994324;4428.202923473806;4466.977665111654;4471.898207842309;4472.485664148665;4508.692479181001;4417.293233082692;4465.955340446554;4466.419365482467;4467.910641787081;4482.484514280899;4414.9558504414545;4429.247028005311;4436.977815110904;4445.644348452051;4465.263231566755;4177.3316269396755;4434.492272627323;4502.842400515966;4512;4516.306385105586;4414.580614841585;4415.403920470695;4436.955630443655;4445.933311000273;4455.821767129279 00:36:28 INFO - PROCESS | 17933 | |5;yui.html;608.1668114682884;645.1741770533713;652.5171373183842;700.5621486570893;713.8536599997001;12609.873901260997;13621.387037583308;13662.726745465085;13662.931685341584;13676;13430.529931452402;13526;13567.796483052762;13582.320883955786;13587.252701101435;619.900815869461;732.7545272333748;737.049206523584;749.9887501687479;756.3797685897566;756.474250395975;765.6439755513685;766.4673052228703;766.5017738470011;768.8692922203239;797.2386371015696;799.168864381046;799.7920540659442;799.9880001799978;800;647.6988200486796;765.5712800831552;790.2611058660171;790.4980337485681;790.5651891459675;573.5984810632532;578.0433382751553;578.3522454850594;578.892904812611;579.183351474419;13035.087543871932;13055.608331750063;13061.085723999324;13072.281024543647;13094.279814610192;11489.942550287278;11624.360660163687;11715.648530544097;11951.521939122425;12682.36588170597;11529.423528823525;11581.652550423501;11751.47118379675;11951.043916486748;12467.688307792287;4057.5536690963972;4114.218298523271;4196.536287226932;4222.5566315536735;4344.978275108604;65079;67638;67653.66173169103;67762.66118669424;67892.58698184651;10080.193584513221;10224.386536807815;10432.634857779942;10617.522211500502;11040.779184416428;18930.52673683169;19018.239270429305;19305.131269092926;19345.51636209106;19348.129334179997;6866.793996180123;7002;7031.367176953996;7133.607651579109;7255.201927787939;3567.4470457079196;3797.7911214883447;3817.3701339279264;3851.6340947609933;3859.671927886105;2954.7340739333563;3052.4505588994193;3076.923076923095;3081.260497480633;3089.9536506952413;510.13022796132503;511.69809812210974;517.9844604661866;518.4918779596017;527.0960303080236;481.5497509828252;522.8326935380642;545.9017376872122;548.2105767694508;558.5140927393194;7563.621818909142;7691.346235569928;7720.227977202235;7796.259355361231;8230.259276665129;559.8572364047142;573.2061095382925;575.5855783835632;580.9186713860063;588.9852753681192;3598.7660802047785;3660.2679464107287;3720.925581488409;3722.7952462614817;3906.12505997123;96969.48488241847;99461;106359;109871.45064274788;110232;88835;89398;89512;89963;92074;61879.381206189166;78388;78543.60728196322;79305.60347198226;83461;7447.627618618939;8243.668923778909;8444.873326900224;8461.280791132822;8517.616707248313;33680.66319336873;41507.792461037505;41855.7907210462;43606.78196608997;44782.55217447914;56062;60715;64602.676986614766;65222.67388663026;68096;10585.153187745116;10669.253152279265;10878.292910960763;10944.452777361259;10994.725131871768;12198.756024879276;12774.425150868048;12873.291968941423;12934.482620695444;13134.211947283193;11125.332480051224;11310.886891130984;11469.770604587695;11607.89724976126;12076.09429292789;11678.649640510459;12019.399030048287;12022.63932082039;12229.633111006684;12405.255684658949;10595.788084238426;10676.252662313875;11091.389973551532;11950.760984780429;11951.521939122338;9374.343795934492;9647;9762.951185244028;9830.213582913208;10219.335743176669;8879.33404994615;8942.86585701202;9052.81894362096;9823;10044.899551004397 00:36:28 INFO - PROCESS | 17933 | __end_tp_report 00:36:28 INFO - PROCESS | 17933 | __start_cc_report 00:36:28 INFO - PROCESS | 17933 | _x_x_mozilla_cycle_collect,938 00:36:28 INFO - PROCESS | 17933 | __end_cc_report 00:36:28 INFO - PROCESS | 17933 | __startTimestamp1472024188548__endTimestamp 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | ------- Summary: start ------- 00:36:28 INFO - PROCESS | 17933 | Number of tests: 6 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#0] dojo.html Cycles:165 Average:4644.34 Median:4785.28 stddev:492.98 (10.3%) stddev-sans-first:465.92 00:36:28 INFO - PROCESS | 17933 | Values: 2536.1 2602.3 2610.5 2631.3 2632.9 4633.4 4696.2 4723.3 4763.3 4844.0 4598.5 4632.6 4715.6 4750.6 4760.7 4138.6 4189.1 4204.1 4288.1 4438.1 4338.7 4367.5 4427.2 4439.4 4440.2 4293.2 4344.9 4349.6 4352.8 4432.5 4265.5 4270.2 4281.3 4302.1 4335.7 4267.0 4315.1 4318.6 4319.9 4387.3 4656.2 4672.8 4715.7 4721.4 4723.7 4971.1 5005.1 5022.6 5025.4 5040.4 5049.7 5057.0 5060.3 5067.6 5092.6 4655.0 4697.0 4722.2 4733.2 4737.0 5054.1 5091.9 5101.2 5108.3 5132.8 4909.0 4913.3 4917.9 4920.0 4985.6 4910.4 4978.7 4990.6 4992.2 4993.1 4918.8 4918.8 4921.6 4950.5 5012.0 4919.8 4923.1 4926.6 4928.9 4989.1 4161.5 4169.3 4174.6 4186.7 4217.9 3602.2 3633.2 3656.7 3688.6 3733.5 4372.2 4375.5 4375.5 4425.2 4430.0 5032.2 5037.0 5040.7 5042.4 5113.2 4231.5 4270.1 4343.3 4352.4 4379.0 4477.6 4498.4 4550.0 4552.7 4562.2 4769.7 4780.7 4784.3 4785.3 4796.1 4890.2 5014.0 5052.0 5058.0 5078.3 4758.5 4763.1 4766.2 4796.3 4808.7 4954.8 4956.5 4959.7 4970.5 5006.7 4935.6 4995.7 5043.1 5044.3 5109.5 4932.1 4937.5 4938.1 4964.1 4975.5 4919.7 4925.6 4928.4 4939.7 4989.0 4767.2 4773.4 4812.9 4847.5 4920.2 4955.9 4959.5 4961.4 4991.5 5006.7 4825.0 4833.0 4836.5 4839.2 4901.1 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#1] ext.html Cycles:180 Average:45943.10 Median:187169.98 stddev:83079.49 (44.4%) stddev-sans-first:83242.70 00:36:28 INFO - PROCESS | 17933 | Values: 569.8 587.9 588.9 591.8 594.4 29105.9 43607.6 44922.6 45012.3 45060.1 41542.2 41943.8 41971.4 41992.6 42019.2 7656.1 7797.2 7803.0 7804.5 7805.8 7675.2 7734.7 7782.3 7787.7 7789.0 7776.9 7831.7 7836.3 7838.0 7842.4 7723.5 7756.5 7771.3 7777.1 7778.0 7701.6 7770.7 7778.8 7781.4 7781.9 38909.6 39252.8 39332.6 39351.4 39377.6 2767.5 2899.3 2920.4 3137.7 3546.5 29237.4 29955.7 30003.2 30156.8 31237.4 3555.4 3601.1 3669.0 3705.8 3770.0 249949.0 251089.0 251154.0 252459.0 252635.0 31578.4 54767.7 55022.2 55030.4 55108.7 32061.0 32218.7 32288.0 32328.0 32334.4 12500.6 12506.0 12522.2 12623.7 12627.4 10238.6 10332.7 10350.6 10356.4 10365.4 7774.8 7825.9 7877.2 7910.2 7917.6 3044.8 3064.8 3070.3 3075.2 3075.7 854.8 919.2 949.6 975.2 986.7 27393.9 28075.4 28162.6 28693.0 28863.3 755.2 909.2 933.9 958.0 961.5 13801.2 14784.9 14809.3 14879.7 14896.9 368066.0 368771.0 370634.2 370823.0 372506.0 49241.3 49819.0 49831.5 49872.0 49937.5 1132.9 1142.2 1176.1 1178.1 1179.4 26321.7 26713.5 27122.5 28109.0 28233.0 42685.4 42932.0 43008.9 43009.1 43042.4 312566.0 312991.0 313129.0 313201.0 314264.0 23648.3 25978.4 26283.8 26307.7 26312.3 43083.0 43385.6 43560.6 44043.6 44890.2 36798.8 36862.6 37158.1 37198.3 38008.2 36779.8 37496.8 37527.8 37609.4 37747.0 35348.3 35740.8 35810.3 35934.3 36305.6 31702.7 32755.0 32778.7 32873.3 32981.8 25008.6 25165.4 25334.5 25389.7 25784.1 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#2] jquery.html Cycles:180 Average:25074.31 Median:28664.28 stddev:63396.19 (221.2%) stddev-sans-first:63546.84 00:36:28 INFO - PROCESS | 17933 | Values: 346.1 365.4 371.9 373.5 384.5 12806.8 15900.9 15972.8 16441.1 17368.4 16283.4 16559.4 16638.2 16875.2 16961.7 5008.8 5055.5 5110.7 5110.9 5147.2 3694.5 5038.9 5124.1 5127.2 5767.6 6069.9 6112.6 6173.7 6184.4 6187.1 5940.6 6002.8 6023.1 6049.7 6172.7 5334.8 5341.7 5341.8 5343.4 5343.9 20456.0 20805.5 21148.0 21361.5 21638.7 1851.7 1866.7 1886.7 2151.7 2566.7 13713.3 14059.8 14100.9 14410.8 15628.8 1830.6 1868.3 1868.5 1889.4 1926.2 55091.0 76909.2 81518.8 83287.0 83672.0 15654.6 16191.6 16562.5 16877.7 16878.4 28805.9 28816.1 28907.3 28948.4 29002.9 8598.3 8777.5 8911.0 9103.4 9162.7 7160.8 7182.5 7246.1 7443.3 7453.3 8131.5 8313.1 8421.7 8466.3 8559.6 3226.9 3268.7 3297.1 3325.0 3406.7 695.0 841.4 853.7 862.6 943.0 16175.1 16602.4 16771.7 17051.6 17516.4 812.9 814.7 815.5 849.2 879.8 8724.7 9515.1 9615.7 9659.8 9776.5 374409.0 376757.0 379283.0 390732.0 396287.0 72045.0 75969.2 76549.0 77184.0 79575.0 879.0 896.5 918.7 919.5 926.6 14878.5 14934.6 15406.4 15481.4 15791.1 35385.8 36206.5 36964.8 37785.6 38529.8 44776.8 46876.0 50601.0 51514.2 51993.7 7137.3 7313.6 7515.1 7540.0 7773.5 10590.8 10638.5 10675.1 10861.0 10923.2 9352.7 9352.9 9386.2 9804.3 10044.8 9419.8 9424.7 9435.4 9558.4 9709.9 9175.6 9481.1 9515.0 9962.0 10049.8 7358.7 7474.6 7486.0 7495.4 7787.7 7529.7 9335.6 9628.7 9648.2 9690.8 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#3] mootools.html Cycles:180 Average:5029.27 Median:5128.88 stddev:2857.79 (55.7%) stddev-sans-first:2852.28 00:36:28 INFO - PROCESS | 17933 | Values: 1329.1 1375.8 1400.9 1603.2 1609.1 7348.7 7847.4 7855.1 7859.4 7868.6 6742.7 7429.9 7698.4 7700.4 7702.5 2171.7 2192.1 2200.8 2201.4 2205.2 2119.8 2176.1 2177.5 2180.9 2188.0 2152.6 2159.1 2173.3 2173.6 2174.4 2119.6 2123.7 2127.1 2127.8 2127.9 2083.6 2111.6 2113.5 2114.5 2117.1 7771.1 7834.6 7850.2 7867.1 7892.7 4420.2 4579.5 4582.4 4588.7 4602.0 2701.3 2759.1 2822.9 2835.2 2847.5 828.9 883.8 892.4 894.7 1831.9 9959.7 10326.3 10338.4 10339.4 10353.3 3658.6 3901.9 3935.9 3954.7 3961.9 8301.5 8304.4 8311.3 8315.1 8326.3 4391.1 4395.1 4400.4 4407.1 4414.7 3583.6 3987.4 4112.1 4116.8 4189.9 3310.6 3389.8 3439.9 3494.6 3499.3 995.5 999.9 1009.6 1010.5 1010.6 692.3 828.1 831.4 843.3 846.3 4978.8 5093.2 5115.4 5142.3 5279.5 352.7 403.5 403.7 407.3 409.4 3490.2 3549.9 3626.8 3688.8 3719.1 9494.4 9770.1 9830.9 9835.2 9835.6 9415.2 9519.3 9744.9 9796.0 9802.1 7270.7 7340.0 7361.0 7378.5 7387.0 5151.3 5155.6 5161.4 5193.9 5438.3 8816.6 8836.9 8844.0 8856.0 8856.6 8806.0 9087.5 9139.2 9167.9 9193.0 5672.3 6017.2 6218.5 6249.4 6298.9 7417.2 7564.5 7579.5 7580.8 7582.2 6672.2 6755.3 6770.7 6985.9 6997.3 6532.4 6574.6 6616.1 6628.3 6695.4 5864.4 5960.0 5961.2 5963.1 5968.2 4445.6 4607.3 4668.8 4687.0 4704.9 4457.0 4549.2 4549.3 4679.1 4689.8 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#4] prototype.html Cycles:180 Average:4100.93 Median:4470.06 stddev:1166.67 (26.1%) stddev-sans-first:1134.46 00:36:28 INFO - PROCESS | 17933 | Values: 296.2 299.9 303.5 304.8 305.1 4853.0 4859.7 4870.8 4876.0 4878.0 4800.9 4806.9 4810.5 4813.2 4815.0 3614.2 3647.5 3805.5 3822.3 3824.8 3801.8 3811.7 3830.3 3842.4 3856.5 3792.0 3793.3 3797.0 3806.2 3834.8 3615.9 3670.7 3766.2 3775.6 3803.3 3349.8 3352.4 3358.8 3360.7 3361.9 4674.4 4682.8 4683.1 4698.1 4745.9 4210.4 4296.0 4323.1 4334.1 4343.9 4993.4 5007.7 5024.9 5051.4 5070.4 3651.4 3657.5 3682.0 3683.6 3691.4 5058.8 5272.4 5274.1 5275.5 5297.9 3725.0 3735.9 3742.7 3745.5 3756.0 3788.8 3791.7 3798.4 3800.7 3802.9 4257.0 4286.8 4287.4 4290.9 4317.5 4854.7 4998.0 5003.7 5009.6 5081.8 1295.9 1310.9 1311.5 1314.0 1316.5 827.7 852.7 854.4 863.2 869.3 4356.5 4459.6 4473.5 4482.0 4506.4 5148.2 5154.5 5156.3 5157.7 5205.2 4468.2 4476.5 4491.8 4499.6 4509.6 2614.5 2750.0 2769.2 2770.6 2771.4 4913.4 4913.5 4918.7 4926.6 4927.7 5213.7 5257.0 5325.4 5333.7 5345.6 4883.3 4890.9 4897.3 4907.0 4926.2 5143.2 5160.0 5160.1 5165.6 5174.6 4867.8 5040.3 5081.0 5082.3 5084.0 4868.2 4887.2 4891.5 4917.1 4919.5 3331.1 3365.6 3385.5 3391.0 3393.5 4481.6 4638.3 4649.4 4683.8 4686.6 4428.2 4467.0 4471.9 4472.5 4508.7 4417.3 4466.0 4466.4 4467.9 4482.5 4415.0 4429.2 4437.0 4445.6 4465.3 4177.3 4434.5 4502.8 4512.0 4516.3 4414.6 4415.4 4437.0 4445.9 4455.8 00:36:28 INFO - PROCESS | 17933 | 00:36:28 INFO - PROCESS | 17933 | [#5] yui.html Cycles:180 Average:18245.27 Median:495.84 stddev:26718.48 (5388.5%) stddev-sans-first:26760.61 00:36:28 INFO - PROCESS | 17933 | Values: 608.2 645.2 652.5 700.6 713.9 12609.9 13621.4 13662.7 13662.9 13676.0 13430.5 13526.0 13567.8 13582.3 13587.3 619.9 732.8 737.0 750.0 756.4 756.5 765.6 766.5 766.5 768.9 797.2 799.2 799.8 800.0 800.0 647.7 765.6 790.3 790.5 790.6 573.6 578.0 578.4 578.9 579.2 13035.1 13055.6 13061.1 13072.3 13094.3 11489.9 11624.4 11715.6 11951.5 12682.4 11529.4 11581.7 11751.5 11951.0 12467.7 4057.6 4114.2 4196.5 4222.6 4345.0 65079.0 67638.0 67653.7 67762.7 67892.6 10080.2 10224.4 10432.6 10617.5 11040.8 18930.5 19018.2 19305.1 19345.5 19348.1 6866.8 7002.0 7031.4 7133.6 7255.2 3567.4 3797.8 3817.4 3851.6 3859.7 2954.7 3052.5 3076.9 3081.3 3090.0 510.1 511.7 518.0 518.5 527.1 481.5 522.8 545.9 548.2 558.5 7563.6 7691.3 7720.2 7796.3 8230.3 559.9 573.2 575.6 580.9 589.0 3598.8 3660.3 3720.9 3722.8 3906.1 96969.5 99461.0 106359.0 109871.5 110232.0 88835.0 89398.0 89512.0 89963.0 92074.0 61879.4 78388.0 78543.6 79305.6 83461.0 7447.6 8243.7 8444.9 8461.3 8517.6 33680.7 41507.8 41855.8 43606.8 44782.6 56062.0 60715.0 64602.7 65222.7 68096.0 10585.2 10669.3 10878.3 10944.5 10994.7 12198.8 12774.4 12873.3 12934.5 13134.2 11125.3 11310.9 11469.8 11607.9 12076.1 11678.6 12019.4 12022.6 12229.6 12405.3 10595.8 10676.3 11091.4 11950.8 11951.5 9374.3 9647.0 9763.0 9830.2 10219.3 8879.3 8942.9 9052.8 9823.0 10044.9 00:36:28 INFO - PROCESS | 17933 | -------- Summary: end -------- 00:36:28 INFO - PROCESS | 17933 | 00:36:29 INFO - TEST-INFO | 17933: exit 0 00:36:29 INFO - TEST-OK | dromaeo_css | took 1121961ms 00:36:29 INFO - TEST-START | kraken 00:36:29 INFO - operating with platform_type : linux_ 00:36:29 INFO - Initialising browser for kraken test... 00:36:29 INFO - TEST-INFO | started process 18235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdD7Ru/profile http://localhost:42684/getInfo.html) 00:36:34 INFO - PROCESS | 18235 | __metrics Screen width/height:1600/1200 00:36:34 INFO - PROCESS | 18235 | colorDepth:24 00:36:34 INFO - PROCESS | 18235 | Browser inner width/height: 1024/697 00:36:34 INFO - PROCESS | 18235 | __metrics 00:36:34 INFO - PROCESS | 18235 | 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" 00:36:34 INFO - PROCESS | 18235 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:36:35 INFO - PROCESS | 18235 | console.error: PushService: 00:36:35 INFO - PROCESS | 18235 | stateChangeProcessEnqueue: Error transitioning state 00:36:35 INFO - PROCESS | 18235 | UnknownError 00:36:36 INFO - TEST-INFO | 18235: exit 0 00:36:36 INFO - Browser initialized. 00:36:36 INFO - Running cycle 1/1 for kraken test... 00:36:36 INFO - TEST-INFO | started process 18316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdD7Ru/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:36:48 INFO - PROCESS | 18316 | RSS: Main: 181153792 00:36:48 INFO - PROCESS | 18316 | 00:36:51 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-beat-detection) 00:36:52 INFO - PROCESS | 18316 | RSS: Main: 235175936 00:36:52 INFO - PROCESS | 18316 | 00:36:54 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-dft) 00:36:55 INFO - PROCESS | 18316 | RSS: Main: 225705984 00:36:55 INFO - PROCESS | 18316 | 00:36:58 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-fft) 00:36:59 INFO - PROCESS | 18316 | RSS: Main: 303190016 00:36:59 INFO - PROCESS | 18316 | 00:37:01 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-oscillator) 00:37:02 INFO - PROCESS | 18316 | RSS: Main: 212566016 00:37:02 INFO - PROCESS | 18316 | 00:37:04 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:37:05 INFO - PROCESS | 18316 | RSS: Main: 213278720 00:37:05 INFO - PROCESS | 18316 | 00:37:08 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-darkroom) 00:37:09 INFO - PROCESS | 18316 | RSS: Main: 252096512 00:37:09 INFO - PROCESS | 18316 | 00:37:12 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-desaturate) 00:37:13 INFO - PROCESS | 18316 | RSS: Main: 245628928 00:37:13 INFO - PROCESS | 18316 | 00:37:16 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42684/tests/kraken/driver.html?testName=json-parse-financial) 00:37:16 INFO - PROCESS | 18316 | RSS: Main: 249249792 00:37:16 INFO - PROCESS | 18316 | 00:37:18 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:37:19 INFO - PROCESS | 18316 | RSS: Main: 213516288 00:37:19 INFO - PROCESS | 18316 | 00:37:20 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:37:21 INFO - PROCESS | 18316 | RSS: Main: 220876800 00:37:21 INFO - PROCESS | 18316 | 00:37:23 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:37:24 INFO - PROCESS | 18316 | RSS: Main: 222171136 00:37:24 INFO - PROCESS | 18316 | 00:37:27 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:37:28 INFO - PROCESS | 18316 | RSS: Main: 217763840 00:37:28 INFO - PROCESS | 18316 | 00:37:31 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:37:31 INFO - PROCESS | 18316 | RSS: Main: 220020736 00:37:31 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42684/tests/kraken/driver.html?testName=ai-astar) 00:37:33 INFO - PROCESS | 18316 | RSS: Main: 271044608 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | __start_tp_report 00:37:33 INFO - PROCESS | 18316 | _x_x_mozilla_page_load 00:37:33 INFO - PROCESS | 18316 | _x_x_mozilla_page_load_details 00:37:33 INFO - PROCESS | 18316 | |i|pagename|runs| 00:37:33 INFO - PROCESS | 18316 | |0;ai-astar;114;115;133;115;113;114;113;113;115;115 00:37:33 INFO - PROCESS | 18316 | |1;audio-beat-detection;153;126;147;181;122;148;159;124;181;124 00:37:33 INFO - PROCESS | 18316 | |2;audio-dft;161;161;161;161;162;162;161;160;161;162 00:37:33 INFO - PROCESS | 18316 | |3;audio-fft;77;76;76;166;76;76;76;76;159;75 00:37:33 INFO - PROCESS | 18316 | |4;audio-oscillator;87;89;154;87;86;87;131;88;87;148 00:37:33 INFO - PROCESS | 18316 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;116;117;117 00:37:33 INFO - PROCESS | 18316 | |6;imaging-darkroom;146;146;147;146;147;146;147;148;148;147 00:37:33 INFO - PROCESS | 18316 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 00:37:33 INFO - PROCESS | 18316 | |8;json-parse-financial;65;67;67;67;67;66;67;68;66;65 00:37:33 INFO - PROCESS | 18316 | |9;json-stringify-tinderbox;65;66;64;68;66;65;65;66;66;65 00:37:33 INFO - PROCESS | 18316 | |10;stanford-crypto-aes;81;82;90;82;92;86;81;82;82;82 00:37:33 INFO - PROCESS | 18316 | |11;stanford-crypto-ccm;135;137;154;135;139;141;133;131;152;133 00:37:33 INFO - PROCESS | 18316 | |12;stanford-crypto-pbkdf2;174;172;169;172;172;174;171;174;174;169 00:37:33 INFO - PROCESS | 18316 | |13;stanford-crypto-sha256-iterative;70;68;69;69;68;69;68;69;68;69 00:37:33 INFO - PROCESS | 18316 | __end_tp_report 00:37:33 INFO - PROCESS | 18316 | __start_cc_report 00:37:33 INFO - PROCESS | 18316 | _x_x_mozilla_cycle_collect,1958 00:37:33 INFO - PROCESS | 18316 | __end_cc_report 00:37:33 INFO - PROCESS | 18316 | __startTimestamp1472024253708__endTimestamp 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | ------- Summary: start ------- 00:37:33 INFO - PROCESS | 18316 | Number of tests: 14 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:6.04 (5.2%) stddev-sans-first:6.36 00:37:33 INFO - PROCESS | 18316 | Values: 114.0 115.0 133.0 115.0 113.0 114.0 113.0 113.0 115.0 115.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:150.50 stddev:22.64 (15.0%) stddev-sans-first:23.89 00:37:33 INFO - PROCESS | 18316 | Values: 153.0 126.0 147.0 181.0 122.0 148.0 159.0 124.0 181.0 124.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 00:37:33 INFO - PROCESS | 18316 | Values: 161.0 161.0 161.0 161.0 162.0 162.0 161.0 160.0 161.0 162.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.51 (48.0%) stddev-sans-first:38.25 00:37:33 INFO - PROCESS | 18316 | Values: 77.0 76.0 76.0 166.0 76.0 76.0 76.0 76.0 159.0 75.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:87.00 stddev:28.14 (32.3%) stddev-sans-first:29.13 00:37:33 INFO - PROCESS | 18316 | Values: 87.0 89.0 154.0 87.0 86.0 87.0 131.0 88.0 87.0 148.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 00:37:33 INFO - PROCESS | 18316 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 00:37:33 INFO - PROCESS | 18316 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 148.0 148.0 147.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:37:33 INFO - PROCESS | 18316 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 00:37:33 INFO - PROCESS | 18316 | Values: 65.0 67.0 67.0 67.0 67.0 66.0 67.0 68.0 66.0 65.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 00:37:33 INFO - PROCESS | 18316 | Values: 65.0 66.0 64.0 68.0 66.0 65.0 65.0 66.0 66.0 65.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.00 stddev:3.97 (4.8%) stddev-sans-first:4.06 00:37:33 INFO - PROCESS | 18316 | Values: 81.0 82.0 90.0 82.0 92.0 86.0 81.0 82.0 82.0 82.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.00 stddev:7.96 (5.8%) stddev-sans-first:8.31 00:37:33 INFO - PROCESS | 18316 | Values: 135.0 137.0 154.0 135.0 139.0 141.0 133.0 131.0 152.0 133.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:1.97 (1.1%) stddev-sans-first:1.96 00:37:33 INFO - PROCESS | 18316 | Values: 174.0 172.0 169.0 172.0 172.0 174.0 171.0 174.0 174.0 169.0 00:37:33 INFO - PROCESS | 18316 | 00:37:33 INFO - PROCESS | 18316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 00:37:33 INFO - PROCESS | 18316 | Values: 70.0 68.0 69.0 69.0 68.0 69.0 68.0 69.0 68.0 69.0 00:37:33 INFO - PROCESS | 18316 | -------- Summary: end -------- 00:37:33 INFO - PROCESS | 18316 | 00:37:34 INFO - TEST-INFO | 18316: exit 0 00:37:35 INFO - TEST-OK | kraken | took 65411ms 00:37:35 INFO - SUITE-END | took 1187s 00:37:35 INFO - Completed test suite (00:19:47) 00:37:35 INFO - javascript benchmark 00:37:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2536.061657186841, 2602.323395917061, 2610.477904419117, 2631.3027047832315, 2632.9341766455836, 4633.351330813689, 4696.1781688204555, 4723.3151193077065, 4763.333133361332, 4843.9757801211035, 4598.494165641777, 4632.583067523922, 4715.599174070199, 4750.619950403968, 4760.714357138574, 4138.6482149017365, 4189.141226048668, 4204.11713540157, 4288.056627541936, 4438.090191510749, 4338.652907767371, 4367.475902891658, 4427.247367947457, 4439.400680908085, 4440.222960981831, 4293.184294983943, 4344.891377715582, 4349.630281426051, 4352.847650332224, 4432.534583868695, 4265.53079161292, 4270.231358355495, 4281.31498960168, 4302.075053863435, 4335.674824388152, 4267.039916018902, 4315.050688848449, 4318.589733975267, 4319.935200971988, 4387.341898715186, 4656.231721765938, 4672.827284922795, 4715.717056976592, 4721.409823772028, 4723.669343145981, 4971.105201063807, 5005.149124648782, 5022.6233032522705, 5025.447200807908, 5040.445550989388, 5049.747512624354, 5057.0, 5060.316857224265, 5067.5859476623245, 5092.592592592584, 4654.953450465519, 4697.0, 4722.1972264714395, 4733.195356789354, 4737.0, 5054.115529782273, 5091.949080509147, 5101.20931255656, 5108.335916330853, 5132.8460146195675, 4908.969116485507, 4913.287573301851, 4917.901641967141, 4920.0, 4985.626078044161, 4910.361652985089, 4978.701277923336, 4990.6257030722845, 4992.151334273182, 4993.1262029144755, 4918.778654960535, 4918.778654960535, 4921.606271498272, 4950.504949505093, 5012.022655582199, 4919.7540122993705, 4923.138450771101, 4926.581240594518, 4928.852134435972, 4989.126902791997, 4161.479815023122, 4169.312063509547, 4174.582541745801, 4186.665066794649, 4217.8523751668545, 3602.1534939289245, 3633.182533929845, 3656.7440279180732, 3688.61269566697, 3733.533308336458, 4372.191144638188, 4375.47494300686, 4375.540568240289, 4425.181341451842, 4430.0, 5032.245163225545, 5037.0, 5040.722760248222, 5042.369703787027, 5113.181890897438, 4231.534531201565, 4270.12462445198, 4343.348497725303, 4352.412424322739, 4379.0366119453665, 4477.574630410106, 4498.437695288089, 4549.977250113729, 4552.70407423523, 4562.178807814559, 4769.73766442842, 4780.713157210578, 4784.258439941815, 4785.282207668877, 4796.112719146969, 4890.168671325812, 5013.974930125326, 5051.974740126276, 5058.0, 5078.263651770399, 4758.5241475852135, 4763.118823017753, 4766.213574760126, 4796.25658023007, 4808.711477311373, 4954.77703503336, 4956.479569645136, 4959.677620954626, 4970.478099799469, 5006.69959802413, 4935.629827763004, 4995.675281106716, 5043.142665746906, 5044.293798868235, 5109.514596113363, 4932.062908047459, 4937.456879743298, 4938.08645400602, 4964.106460837084, 4975.477574854588, 4919.655624106278, 4925.605951523941, 4928.383952005999, 4939.678920870132, 4988.9501104988485, 4767.237242041257, 4773.37946067009, 4812.8796780080775, 4847.515248475124, 4920.163572192664, 4955.851324460272, 4959.528844759742, 4961.355023846877, 4991.5258050485145, 5006.69959802413, 4824.975875120602, 4833.03339332128, 4836.492168322417, 4839.1531481991215, 4901.142300097397], "value": 4612.201241859491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7806344557345, 587.9412058794123, 588.8998870192067, 591.8431615621859, 594.4293478260869, 29105.85447072764, 43607.563924360744, 44922.55077449224, 45012.3248151278, 45060.09879802402, 41542.169156616925, 41943.790281048554, 41971.37042944358, 41992.58007419925, 42019.15961680764, 7656.119546252183, 7797.220277972214, 7802.960985195066, 7804.531728096304, 7805.804854878616, 7675.232476752336, 7734.651940662656, 7782.338501227402, 7787.688492460295, 7788.961055194716, 7776.883346749803, 7831.686732530692, 7836.2947334739865, 7838.0, 7842.372610191171, 7723.459357844953, 7756.534607923542, 7771.261730135628, 7777.066751989769, 7777.961110194413, 7701.576413297266, 7770.689172433096, 7778.805529861742, 7781.416393770433, 7781.922180778176, 38909.61090389088, 39252.803735981426, 39332.606673933464, 39351.4097288538, 39377.60622393797, 2767.501849667059, 2899.347646779479, 2920.386718789057, 3137.703125776493, 3546.4680297955256, 29237.41525169506, 29955.70044299551, 30003.249918752204, 30156.849215754, 31237.37525249505, 3555.3955827509385, 3601.099725068733, 3669.0, 3705.7776533408082, 3769.9623003769884, 249949.0, 251089.0, 251154.0, 252459.0, 252635.0, 31578.36843263168, 54767.72616136894, 55022.17466738002, 55030.44969550333, 55108.72445637746, 32061.0, 32218.67781322157, 32288.0, 32328.0, 32334.35331293361, 12500.624981250578, 12506.0, 12522.186057906207, 12623.747525049632, 12627.368631568384, 10238.641647542301, 10332.690019299433, 10350.637727679496, 10356.430396328124, 10365.429901355346, 7774.844503109906, 7825.943497627862, 7877.212278772192, 7910.208979102159, 7917.643706033243, 3044.8325342106396, 3064.846757662108, 3070.293832418556, 3075.2465645916895, 3075.6924307569066, 854.81621451387, 919.1957037592107, 949.6106596295485, 975.2003357247131, 986.7237173591406, 27393.86303068472, 28075.43849123047, 28162.577561336595, 28693.0, 28863.278418039296, 755.2409828122702, 909.231699214163, 933.8972713001565, 957.9904200957901, 961.4663861556903, 13801.230326755604, 14784.90633257125, 14809.259537023107, 14879.702405952037, 14896.911821638103, 368066.0, 368771.0, 370634.17463301704, 370823.0, 372506.0, 49241.26138107931, 49819.0, 49831.501684983414, 49872.0, 49937.500624993285, 1132.8980391764617, 1142.2175809570472, 1176.129664048615, 1178.116412690482, 1179.4102948525738, 26321.736782631928, 26713.46573068489, 27122.457550849267, 28109.0, 28233.0, 42685.35971960485, 42932.0, 43008.9035309183, 43009.13981720411, 43042.35436468518, 312566.0, 312991.0, 313129.0, 313201.0, 314264.0, 23648.290551283488, 25978.35054123662, 26283.79459286505, 26307.736922630527, 26312.3421914446, 43083.0, 43385.56614433941, 43560.56439435565, 44043.55956440394, 44890.18433433064, 36798.8160059198, 36862.63137368592, 37158.071048222926, 37198.25840927326, 38008.239835202585, 36779.81610091932, 37496.81251593724, 37527.81236093802, 37609.4358584616, 37747.0, 35348.293034139686, 35740.82129589335, 35810.28379432449, 35934.281314373045, 36305.63694363023, 31702.682973169973, 32755.0, 32778.67221327756, 32873.34253314872, 32981.835090824396, 25008.62487062659, 25165.37086572777, 25334.493310133326, 25389.746102539477, 25784.097556585428], "value": 16465.760397343744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0707999022623, 365.4025668032764, 371.88805471639796, 373.49391574416666, 384.54431498674074, 12806.807897881528, 15900.92049539752, 15972.84027159728, 16441.095739734308, 17368.392106276282, 16283.430079947204, 16559.420420285292, 16638.168091595402, 16875.240614172362, 16961.660766784687, 5008.82469113582, 5055.508624955629, 5110.693358398489, 5110.923336149961, 5147.22791581262, 3694.501242332278, 5038.899222015558, 5124.0776660201145, 5127.230915362707, 5767.625104368223, 6069.908951365733, 6112.633242005471, 6173.722182501798, 6184.381561843825, 6187.071939209132, 5940.584159108864, 6002.819915402545, 6023.126646636257, 6049.667268300242, 6172.69136543171, 5334.826338205588, 5341.67949923002, 5341.839744807662, 5343.412224655285, 5343.893122137574, 20456.0, 20805.479863003395, 21148.0, 21361.465963350885, 21638.675419868716, 1851.6666999940005, 1866.673332166879, 1886.7075603281514, 2151.6664916937743, 2566.679165104362, 13713.314334283346, 14059.78910316346, 14100.92949535256, 14410.783838242434, 15628.765568516481, 1830.5606654402848, 1868.26203649559, 1868.4581471373285, 1889.3765057530982, 1926.1813729165049, 55091.0, 76909.23090769077, 81518.77721834237, 83287.0, 83672.0, 15654.608634784221, 16191.595210119605, 16562.50312490627, 16877.662446750997, 16878.409255675993, 28805.85597072001, 28816.135515934555, 28907.277318066797, 28948.42103157925, 29002.854985724935, 8598.312135029182, 8777.51723655205, 8911.0, 9103.408278461879, 9162.725118246462, 7160.820979475555, 7182.497225194186, 7246.130464344313, 7443.255674432622, 7453.329200371993, 8131.471454355448, 8313.12712165214, 8421.747347579583, 8466.32269418445, 8559.572021398904, 3226.8870589529256, 3268.6894744999186, 3297.1262615406936, 3324.985879306786, 3406.744494162948, 694.982625434358, 841.4362377207286, 853.7225401744458, 862.5859587397958, 942.9811403771886, 16175.110368929587, 16602.418915337905, 16771.748423773653, 17051.573710657332, 17516.38692645751, 812.8658771302787, 814.6619153051417, 815.4780940198278, 849.1720572441943, 879.8298263309782, 8724.738257852274, 9515.143637072697, 9615.711528654152, 9659.806803863883, 9776.51117444125, 374409.0, 376757.0, 379283.0, 390732.0, 396287.0, 72045.0, 75969.24030759733, 76549.0, 77184.0, 79575.0, 878.9780255493536, 896.5248418338291, 918.6646873891116, 919.5494207838111, 926.6478738079621, 14878.527983846589, 14934.626634334229, 15406.38374465009, 15481.380744770084, 15791.131487768283, 35385.82307088448, 36206.45690314595, 36964.815175925025, 37785.62214377931, 38529.80735096306, 44776.77611612051, 46876.0, 50601.0, 51514.22728659148, 51993.7400312996, 7137.286271372821, 7313.561186328838, 7515.098188217449, 7540.0, 7773.494722842997, 10590.788184236426, 10638.468076596295, 10675.14598832076, 10861.0, 10923.180761443082, 9352.67265645699, 9352.859707104262, 9386.249100072115, 9804.264680148875, 10044.849327260243, 9419.764505887408, 9424.670136545188, 9435.386699864486, 9558.378705384128, 9709.854352184864, 9175.587098580714, 9481.051894810464, 9514.952425237829, 9961.950190249003, 10049.799004019733, 7358.705651773869, 7474.551526908403, 7486.022931867689, 7495.40036797044, 7787.727429539939, 7529.73645922412, 9335.626574936927, 9628.66299679508, 9648.179904708179, 9690.806183876142], "value": 8894.750820295434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.1028555724886, 1375.7592421326267, 1400.8599140085992, 1603.1743652019213, 1609.1230279497672, 7348.70605175793, 7847.411444141684, 7855.1359350471475, 7859.449838511307, 7868.606569671522, 6742.69657865396, 7429.888551671729, 7698.384129269645, 7700.4224683148705, 7702.499337543056, 2171.7285339332625, 2192.1012384922187, 2200.834937379695, 2201.4276288165033, 2205.162038425396, 2119.8198153157, 2176.064292354287, 2177.4556360909774, 2180.9127634894667, 2187.9935229794314, 2152.569486102778, 2159.0931808640407, 2173.250228671106, 2173.587018466494, 2174.369432864475, 2119.6396612575822, 2123.702681624574, 2127.0747224957195, 2127.8404119691086, 2127.925522606701, 2083.624947509448, 2111.6304646686767, 2113.471632091977, 2114.492521794758, 2117.1002324012234, 7771.106322772897, 7834.608269586498, 7850.175731548219, 7867.134615192324, 7892.684292628288, 4420.226460369422, 4579.450465944108, 4582.358469814229, 4588.7246765194195, 4602.0, 2701.284159697682, 2759.075709637274, 2822.8588570571387, 2835.206142280165, 2847.501687204731, 828.8715249136394, 883.8364902493059, 892.3931726426027, 894.6958034268315, 1831.8626103042193, 9959.701208963743, 10326.328788628714, 10338.379697218115, 10339.379637221715, 10353.327033742782, 3658.5609726832417, 3901.902452438712, 3935.9016024599614, 3954.663853572421, 3961.920761584752, 8301.501909885426, 8304.377171712145, 8311.293540049042, 8315.126911674188, 8326.333893288522, 4391.055922976511, 4395.120975804852, 4400.427944367212, 4407.0524837160165, 4414.735115893057, 3583.5699716033723, 3987.4218238355274, 4112.09533902541, 4116.794160292034, 4189.853355132616, 3310.6192787829227, 3389.8135602542097, 3439.8624055038017, 3494.633063528344, 3499.3176330615283, 995.4972738766876, 999.8500224966314, 1009.5658866687248, 1010.5099026971913, 1010.6109147978082, 692.3491917597443, 828.1428721273453, 831.4387788242911, 843.3464065349403, 846.3313981954187, 4978.77595508203, 5093.23601459784, 5115.437301896788, 5142.331496905378, 5279.498447647467, 352.74426041120495, 403.5117507815517, 403.7476577139288, 407.28928020604235, 409.4002286650072, 3490.214701692099, 3549.8580056797437, 3626.782393056425, 3688.7786732796117, 3719.1445967427644, 9494.430334179971, 9770.12068913787, 9830.901690983143, 9835.164011058998, 9835.606575737034, 9415.199708024758, 9519.286053546011, 9744.90255097454, 9796.0, 9802.117809397047, 7270.709171633075, 7339.963300183572, 7360.96319518399, 7378.520396174232, 7387.039684840936, 5151.330327057459, 5155.639105262596, 5161.406438259648, 5193.896122077613, 5438.293021907285, 8816.559172041243, 8836.867446988428, 8843.955780221058, 8856.0, 8856.64573417082, 8805.955970220364, 9087.454752714593, 9139.223166030963, 9167.862482062641, 9193.0, 5672.347680016685, 6017.217761690952, 6218.471429928507, 6249.375062493896, 6298.874022519615, 7417.221191774786, 7564.50830696003, 7579.54522728638, 7580.81047973783, 7582.241775822374, 6672.199336079701, 6755.256921738506, 6770.729170833309, 6985.860282794417, 6997.265287144776, 6532.41208291256, 6574.605523668404, 6616.106825578485, 6628.27089020217, 6695.363940425652, 5864.384239654775, 5959.970200148971, 5961.225040744849, 5963.105534169909, 5968.224130863134, 4445.555444455528, 4607.262837945913, 4668.813247470063, 4686.953130468652, 4704.858854234379, 4457.0, 4549.158405694957, 4549.294859296814, 4679.110968915895, 4689.812407503661], "value": 3974.832211778997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.19287441721303, 299.92052106191863, 303.5189225078249, 304.7896951103739, 305.06497584902286, 4852.999999999991, 4859.708417494953, 4870.756462176886, 4875.975620121899, 4878.0, 4800.927986080203, 4806.927896081562, 4810.542998415153, 4813.181759100952, 4814.9759251203695, 3614.186807968206, 3647.4893514907935, 3805.4862593549933, 3822.3310920588924, 3824.8470061197518, 3801.7909015004166, 3811.6950643948417, 3830.3105441020607, 3842.385218365062, 3856.5179352580926, 3791.9620803791886, 3793.298239825627, 3796.9810150949343, 3806.219724956391, 3834.7699138051667, 3615.8553657853654, 3670.743047986642, 3766.2090960898245, 3775.565809931838, 3803.2773772983046, 3349.7990120592845, 3352.430086885235, 3358.7740474726793, 3360.7397226040234, 3361.8991430257133, 4674.439067311944, 4682.782476556086, 4683.1336202802595, 4698.107359601699, 4745.857624271277, 4210.3684447332835, 4295.957040429618, 4323.135372925428, 4334.111507141029, 4343.9348409773875, 4993.375828021497, 5007.749612519359, 5024.924626130611, 5051.44434112251, 5070.3915530136255, 3651.356889399781, 3657.4696668982847, 3682.0, 3683.557973043225, 3691.3724666806706, 5058.797648094109, 5272.393674727378, 5274.127684671925, 5275.525202731734, 5297.947020529784, 3724.981375093107, 3735.9066023349633, 3742.700583953277, 3745.5318085239346, 3755.962440375561, 3788.844402457277, 3791.677707394847, 3798.3732684106812, 3800.7149463790324, 3802.885913422602, 4257.0, 4286.7856607169515, 4287.421198138211, 4290.89272768177, 4317.546657600969, 4854.68444551103, 4997.9750101249265, 5003.674761140514, 5009.599232061426, 5081.8475445736685, 1295.859643513702, 1310.914790538631, 1311.5475161069417, 1313.9868601314056, 1316.4602512969827, 827.6772058897035, 852.7186028610544, 854.4147259127393, 863.2403484933219, 869.3132425384002, 4356.542563030899, 4459.598636122764, 4473.485549161888, 4482.041852377415, 4506.436695413074, 5148.150555158357, 5154.5360917516855, 5156.329677142023, 5157.73910611182, 5205.193195054772, 4468.21806183923, 4476.46282446102, 4491.797869095899, 4499.605122412063, 4509.624564507857, 2614.4509652972706, 2750.037486879616, 2769.238459423634, 2770.6449517909614, 2771.431856469419, 4913.361263035782, 4913.518673070077, 4918.745719841418, 4926.630502712311, 4927.694161047325, 5213.713245771519, 5257.000695997287, 5325.360956685223, 5333.733313334318, 5345.599080069011, 4883.267509873547, 4890.877728056756, 4897.314375987436, 4906.950930490792, 4926.236433352836, 5143.177091665316, 5159.974200129125, 5160.148575485003, 5165.638405311592, 5174.637775355689, 4867.831720387011, 5040.269160971565, 5080.960636294081, 5082.263071854634, 5084.0, 4868.2210846264425, 4887.169181239269, 4891.510848915223, 4917.139500587311, 4919.532644398776, 3331.1172539277595, 3365.5793025871767, 3385.5260263562627, 3390.965755444613, 3393.474011528217, 4481.574250446202, 4638.257878739386, 4649.442066951988, 4683.812647494062, 4686.625069994324, 4428.202923473806, 4466.977665111654, 4471.898207842309, 4472.485664148665, 4508.692479181001, 4417.293233082692, 4465.955340446554, 4466.419365482467, 4467.910641787081, 4482.484514280899, 4414.9558504414545, 4429.247028005311, 4436.977815110904, 4445.644348452051, 4465.263231566755, 4177.3316269396755, 4434.492272627323, 4502.842400515966, 4512.0, 4516.306385105586, 4414.580614841585, 4415.403920470695, 4436.955630443655, 4445.933311000273, 4455.821767129279], "value": 3734.709540004972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.1668114682884, 645.1741770533713, 652.5171373183842, 700.5621486570893, 713.8536599997001, 12609.873901260997, 13621.387037583308, 13662.726745465085, 13662.931685341584, 13676.0, 13430.529931452402, 13526.0, 13567.796483052762, 13582.320883955786, 13587.252701101435, 619.900815869461, 732.7545272333748, 737.049206523584, 749.9887501687479, 756.3797685897566, 756.474250395975, 765.6439755513685, 766.4673052228703, 766.5017738470011, 768.8692922203239, 797.2386371015696, 799.168864381046, 799.7920540659442, 799.9880001799978, 800.0, 647.6988200486796, 765.5712800831552, 790.2611058660171, 790.4980337485681, 790.5651891459675, 573.5984810632532, 578.0433382751553, 578.3522454850594, 578.892904812611, 579.183351474419, 13035.087543871932, 13055.608331750063, 13061.085723999324, 13072.281024543647, 13094.279814610192, 11489.942550287278, 11624.360660163687, 11715.648530544097, 11951.521939122425, 12682.36588170597, 11529.423528823525, 11581.652550423501, 11751.47118379675, 11951.043916486748, 12467.688307792287, 4057.5536690963972, 4114.218298523271, 4196.536287226932, 4222.5566315536735, 4344.978275108604, 65079.0, 67638.0, 67653.66173169103, 67762.66118669424, 67892.58698184651, 10080.193584513221, 10224.386536807815, 10432.634857779942, 10617.522211500502, 11040.779184416428, 18930.52673683169, 19018.239270429305, 19305.131269092926, 19345.51636209106, 19348.129334179997, 6866.793996180123, 7002.0, 7031.367176953996, 7133.607651579109, 7255.201927787939, 3567.4470457079196, 3797.7911214883447, 3817.3701339279264, 3851.6340947609933, 3859.671927886105, 2954.7340739333563, 3052.4505588994193, 3076.923076923095, 3081.260497480633, 3089.9536506952413, 510.13022796132503, 511.69809812210974, 517.9844604661866, 518.4918779596017, 527.0960303080236, 481.5497509828252, 522.8326935380642, 545.9017376872122, 548.2105767694508, 558.5140927393194, 7563.621818909142, 7691.346235569928, 7720.227977202235, 7796.259355361231, 8230.259276665129, 559.8572364047142, 573.2061095382925, 575.5855783835632, 580.9186713860063, 588.9852753681192, 3598.7660802047785, 3660.2679464107287, 3720.925581488409, 3722.7952462614817, 3906.12505997123, 96969.48488241847, 99461.0, 106359.0, 109871.45064274788, 110232.0, 88835.0, 89398.0, 89512.0, 89963.0, 92074.0, 61879.381206189166, 78388.0, 78543.60728196322, 79305.60347198226, 83461.0, 7447.627618618939, 8243.668923778909, 8444.873326900224, 8461.280791132822, 8517.616707248313, 33680.66319336873, 41507.792461037505, 41855.7907210462, 43606.78196608997, 44782.55217447914, 56062.0, 60715.0, 64602.676986614766, 65222.67388663026, 68096.0, 10585.153187745116, 10669.253152279265, 10878.292910960763, 10944.452777361259, 10994.725131871768, 12198.756024879276, 12774.425150868048, 12873.291968941423, 12934.482620695444, 13134.211947283193, 11125.332480051224, 11310.886891130984, 11469.770604587695, 11607.89724976126, 12076.09429292789, 11678.649640510459, 12019.399030048287, 12022.63932082039, 12229.633111006684, 12405.255684658949, 10595.788084238426, 10676.252662313875, 11091.389973551532, 11950.760984780429, 11951.521939122338, 9374.343795934492, 9647.0, 9762.951185244028, 9830.213582913208, 10219.335743176669, 8879.33404994615, 8942.86585701202, 9052.81894362096, 9823.0, 10044.899551004397], "value": 6573.585908704026, "unit": "score"}], "name": "dromaeo_css", "value": 6355.876707667986, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 133.0, 115.0, 113.0, 114.0, 113.0, 113.0, 115.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 147.0, 181.0, 122.0, 148.0, 159.0, 124.0, 181.0, 124.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 166.0, 76.0, 76.0, 76.0, 76.0, 159.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 154.0, 87.0, 86.0, 87.0, 131.0, 88.0, 87.0, 148.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 68.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 90.0, 82.0, 92.0, 86.0, 81.0, 82.0, 82.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 154.0, 135.0, 139.0, 141.0, 133.0, 131.0, 152.0, 133.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 169.0, 172.0, 172.0, 174.0, 171.0, 174.0, 174.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1575.9999999999998, "alertThreshold": 2.0}]} 00:37:35 INFO - Return code: 0 00:37:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:37:35 INFO - # TBPL SUCCESS # 00:37:35 INFO - Running post-action listener: _resource_record_post_action 00:37:35 INFO - [mozharness: 2016-08-24 07:37:35.505417Z] Finished run-tests step (success) 00:37:35 INFO - Running post-run listener: _resource_record_post_run 00:37:35 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405061632; Read time: 320; Write time: 398820 00:37:35 INFO - TinderboxPrint: CPU usage
13.3% 00:37:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 320 00:37:35 INFO - TinderboxPrint: I/O write bytes / time
405,061,632 / 398,820 00:37:35 INFO - TinderboxPrint: CPU idle
8,326.4 (86.7%) 00:37:35 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 00:37:35 INFO - TinderboxPrint: Swap in / out
0 / 0 00:37:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114294784; Read time: 0; Write time: 158344 00:37:35 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290766848; Read time: 304; Write time: 240476 00:37:36 INFO - Running post-run listener: _upload_blobber_files 00:37:36 INFO - Blob upload gear active. 00:37:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:37:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:37:36 INFO - (blobuploader) - INFO - Open directory for files ... 00:37:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:37:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:39 INFO - (blobuploader) - INFO - Done attempting. 00:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:40 INFO - (blobuploader) - INFO - Done attempting. 00:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:37:41 INFO - (blobuploader) - INFO - Done attempting. 00:37:41 INFO - (blobuploader) - INFO - Iteration through files over. 00:37:41 INFO - Return code: 0 00:37:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:37:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:37:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81afe42e349bbcdccce080c54b8def494b7c6bcdd7b1424b778559b394fcbd3878d60411760f94959b5c6c84c934222ad54222b9083851b1ae7d27228739491e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a4cddea90e92e51c969b18d33692c046e00442afc7505a1452d2beb6e371601e3828c36fbbf12a0e7261edbf8806bee916c2a4395bd42c904fb19201ab47004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e46f4db07e9e7d0495589b88fbc7fe396fbc47a1e2d32bf6976e2385a77f4c3cbdfc12555b1ebdb4aa11a19412289ce455bd00fe77c4f4520607f842dbb69b6"} 00:37:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:37:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:37:41 INFO - Contents: 00:37:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81afe42e349bbcdccce080c54b8def494b7c6bcdd7b1424b778559b394fcbd3878d60411760f94959b5c6c84c934222ad54222b9083851b1ae7d27228739491e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a4cddea90e92e51c969b18d33692c046e00442afc7505a1452d2beb6e371601e3828c36fbbf12a0e7261edbf8806bee916c2a4395bd42c904fb19201ab47004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e46f4db07e9e7d0495589b88fbc7fe396fbc47a1e2d32bf6976e2385a77f4c3cbdfc12555b1ebdb4aa11a19412289ce455bd00fe77c4f4520607f842dbb69b6"} 00:37:41 INFO - Running post-run listener: copy_logs_to_upload_dir 00:37:41 INFO - Copying logs to upload dir... 00:37:41 INFO - mkdir: /builds/slave/test/build/upload/logs 00:37:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.483309 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-24 00:37:40.725312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 00:37:40.728467) ========= 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=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 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-Non-PGO/sha512/81afe42e349bbcdccce080c54b8def494b7c6bcdd7b1424b778559b394fcbd3878d60411760f94959b5c6c84c934222ad54222b9083851b1ae7d27228739491e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a4cddea90e92e51c969b18d33692c046e00442afc7505a1452d2beb6e371601e3828c36fbbf12a0e7261edbf8806bee916c2a4395bd42c904fb19201ab47004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e46f4db07e9e7d0495589b88fbc7fe396fbc47a1e2d32bf6976e2385a77f4c3cbdfc12555b1ebdb4aa11a19412289ce455bd00fe77c4f4520607f842dbb69b6"} build_url:https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/XhfqHZ-zT5G67nfudC6P9g/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-Non-PGO/sha512/81afe42e349bbcdccce080c54b8def494b7c6bcdd7b1424b778559b394fcbd3878d60411760f94959b5c6c84c934222ad54222b9083851b1ae7d27228739491e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a4cddea90e92e51c969b18d33692c046e00442afc7505a1452d2beb6e371601e3828c36fbbf12a0e7261edbf8806bee916c2a4395bd42c904fb19201ab47004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e46f4db07e9e7d0495589b88fbc7fe396fbc47a1e2d32bf6976e2385a77f4c3cbdfc12555b1ebdb4aa11a19412289ce455bd00fe77c4f4520607f842dbb69b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 00:37:40.756138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:37:40.756698) ========= 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=af724c981e2a0f424dbabf99000001e7-1472023009.988801-1260945658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 00:37:40.841357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 00:37:40.841976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 00:37:40.842599) ========= ========= Total master_lag: 0.18 =========