builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1468947348.8 results: success (0) buildid: 20160719092122 builduid: ce33170266f546f998d3754296c9864e revision: 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:48.803976) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:48.804500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:48.804831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:48.823630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:48.824020) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 09:55:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-07-19 09:55:49 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120151 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:49.220404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:49.220722) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014952 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:49.251639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 09:55:49.251990) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 --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 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 --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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 09:55:50,041 truncating revision to first 12 chars 2016-07-19 09:55:50,041 Setting DEBUG logging. 2016-07-19 09:55:50,041 attempt 1/10 2016-07-19 09:55:50,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4720fe92629a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 09:55:51,256 unpacking tar archive at: fx-team-4720fe92629a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.548775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 09:55:50.817559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:50.817919) ========= script_repo_revision: 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:50.818333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:50.818601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 09:55:50.829613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-19 09:55:50.830011) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:55:51 INFO - MultiFileLogger online at 20160719 09:55:51 in /builds/slave/test 09:55:51 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 09:55:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:51 INFO - {'append_to_log': False, 09:55:51 INFO - 'base_work_dir': '/builds/slave/test', 09:55:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:55:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:51 INFO - 'branch': 'Fx-Team-Non-PGO', 09:55:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:51 INFO - 'config_files': ('talos/linux_config.py',), 09:55:51 INFO - 'default_actions': ('clobber', 09:55:51 INFO - 'read-buildbot-config', 09:55:51 INFO - 'download-and-extract', 09:55:51 INFO - 'populate-webroot', 09:55:51 INFO - 'create-virtualenv', 09:55:51 INFO - 'install', 09:55:51 INFO - 'run-tests'), 09:55:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:51 INFO - 'download_minidump_stackwalk': True, 09:55:51 INFO - 'download_symbols': 'ondemand', 09:55:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:51 INFO - 'installer_path': 'installer.exe', 09:55:51 INFO - 'log_level': 'info', 09:55:51 INFO - 'log_name': 'talos', 09:55:51 INFO - 'log_to_console': True, 09:55:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:55:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:55:51 INFO - 'opt_config_files': (), 09:55:51 INFO - 'pip_index': False, 09:55:51 INFO - 'sps_profile': False, 09:55:51 INFO - 'sps_profile_interval': 0, 09:55:51 INFO - 'suite': 'dromaeojs', 09:55:51 INFO - 'system_bits': '32', 09:55:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:51 INFO - 'title': 'talos-linux64-ix-066', 09:55:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:51 INFO - 'use_talos_json': True, 09:55:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:51 INFO - 'work_dir': 'build'} 09:55:51 INFO - ##### 09:55:51 INFO - ##### Running clobber step. 09:55:51 INFO - ##### 09:55:51 INFO - Running pre-action listener: _resource_record_pre_action 09:55:51 INFO - Running main action method: clobber 09:55:51 INFO - rmtree: /builds/slave/test/build 09:55:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:52 INFO - Running post-action listener: _resource_record_post_action 09:55:52 INFO - ##### 09:55:52 INFO - ##### Finished clobber step (success) 09:55:52 INFO - ##### 09:55:52 INFO - ##### 09:55:52 INFO - ##### Running read-buildbot-config step. 09:55:52 INFO - ##### 09:55:52 INFO - Running pre-action listener: _resource_record_pre_action 09:55:52 INFO - Running main action method: read_buildbot_config 09:55:52 INFO - Using buildbot properties: 09:55:52 INFO - { 09:55:52 INFO - "project": "", 09:55:52 INFO - "product": "firefox", 09:55:52 INFO - "script_repo_revision": "production", 09:55:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:55:52 INFO - "repository": "", 09:55:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:55:52 INFO - "buildid": "20160719092122", 09:55:52 INFO - "pgo_build": "False", 09:55:52 INFO - "basedir": "/builds/slave/test", 09:55:52 INFO - "buildnumber": 2001, 09:55:52 INFO - "slavename": "talos-linux64-ix-066", 09:55:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:55:52 INFO - "platform": "ubuntu64_hw", 09:55:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:55:52 INFO - "branch": "fx-team", 09:55:52 INFO - "repo_path": "integration/fx-team", 09:55:52 INFO - "revision": "4720fe92629a2d2a7c4811e6c4a47eb20b035e59", 09:55:52 INFO - "stage_platform": "linux64", 09:55:52 INFO - "builduid": "ce33170266f546f998d3754296c9864e", 09:55:52 INFO - "slavebuilddir": "test" 09:55:52 INFO - } 09:55:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:55:52 INFO - Running post-action listener: _resource_record_post_action 09:55:52 INFO - ##### 09:55:52 INFO - ##### Finished read-buildbot-config step (success) 09:55:52 INFO - ##### 09:55:52 INFO - ##### 09:55:52 INFO - ##### Running download-and-extract step. 09:55:52 INFO - ##### 09:55:52 INFO - Running pre-action listener: _resource_record_pre_action 09:55:52 INFO - Running main action method: download_and_extract 09:55:52 INFO - mkdir: /builds/slave/test/build/tests 09:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:52 INFO - https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:55:52 INFO - Downloaded 1361 bytes. 09:55:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:55:52 INFO - Using the following test package requirements: 09:55:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:55:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:55:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'jsshell-linux-x86_64.zip'], 09:55:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:55:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:55:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:55:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:55:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:55:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:52 INFO - https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:54 INFO - Downloaded 22763363 bytes. 09:55:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:55:56 INFO - Return code: 0 09:55:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:56 INFO - https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:57 INFO - Downloaded 22763363 bytes. 09:55:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:55:59 INFO - Return code: 0 09:55: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:59 INFO - https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:55:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:56:00 INFO - Downloaded 14403317 bytes. 09:56:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:56:01 INFO - Return code: 0 09:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:01 INFO - https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:56:03 INFO - Downloaded 57121388 bytes. 09:56:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:03 INFO - mkdir: /builds/slave/test/properties 09:56:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:03 INFO - Contents: 09:56:03 INFO - build_url:https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:04 INFO - Running post-action listener: _resource_record_post_action 09:56:04 INFO - Running post-action listener: set_extra_try_arguments 09:56:04 INFO - ##### 09:56:04 INFO - ##### Finished download-and-extract step (success) 09:56:04 INFO - ##### 09:56:04 INFO - ##### 09:56:04 INFO - ##### Running populate-webroot step. 09:56:04 INFO - ##### 09:56:04 INFO - Running pre-action listener: _resource_record_pre_action 09:56:04 INFO - Running main action method: populate_webroot 09:56:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:04 INFO - '--tppagecycles', 09:56:04 INFO - '7'], 09:56:04 INFO - 'tests': ['tsvgm']}}, 09:56:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['damp', 'tps']}, 09:56:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'tests': ['damp', 'tps']}, 09:56:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['dromaeo_dom']}, 09:56:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['basic_compositor_video']}, 09:56:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:56:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['a11yr', 09:56:04 INFO - 'ts_paint', 09:56:04 INFO - 'tpaint', 09:56:04 INFO - 'sessionrestore', 09:56:04 INFO - 'sessionrestore_no_auto_restore', 09:56:04 INFO - 'tabpaint']}, 09:56:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['tsvgx', 09:56:04 INFO - 'tsvgr_opacity', 09:56:04 INFO - 'tart', 09:56:04 INFO - 'tscrollx', 09:56:04 INFO - 'cart']}, 09:56:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:04 INFO - 'tsvgr_opacity', 09:56:04 INFO - 'tart', 09:56:04 INFO - 'tscrollx', 09:56:04 INFO - 'cart']}, 09:56:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'talos_options': ['--disable-e10s'], 09:56:04 INFO - 'tests': ['tp5o']}, 09:56:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'tests': ['tp5o']}, 09:56:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'talos_options': ['--disable-e10s', 09:56:04 INFO - '--xperf_path', 09:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:04 INFO - 'tests': ['tp5n']}, 09:56:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:04 INFO - 'talos_options': ['--xperf_path', 09:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:04 INFO - 'tests': ['tp5n']}}, 09:56:04 INFO - 'talos.zip': {'path': '', 09:56:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:04 INFO - Running post-action listener: _resource_record_post_action 09:56:04 INFO - ##### 09:56:04 INFO - ##### Finished populate-webroot step (success) 09:56:04 INFO - ##### 09:56:04 INFO - ##### 09:56:04 INFO - ##### Running create-virtualenv step. 09:56:04 INFO - ##### 09:56:04 INFO - Running pre-action listener: _resource_record_pre_action 09:56:04 INFO - Running main action method: create_virtualenv 09:56:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:04 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 09:56:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:04 INFO - Using real prefix '/usr' 09:56:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:06 INFO - Installing pip.................done. 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:06 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 09:56:06 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 09:56:06 INFO - Using env: {'DISPLAY': ':0', 09:56:06 INFO - 'HOME': '/home/cltbld', 09:56:06 INFO - 'LANG': 'en_US.UTF-8', 09:56:06 INFO - 'LANGUAGE': 'en_US:en', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MAIL': '/var/mail/cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SHLVL': '1', 09:56:06 INFO - 'TERM': 'linux', 09:56:06 INFO - 'TMOUT': '86400', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - '_': '/tools/buildbot/bin/python'} 09:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:06 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 09:56:06 INFO - Cleaning up... 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:06 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 09:56:06 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 09:56:06 INFO - Using env: {'DISPLAY': ':0', 09:56:06 INFO - 'HOME': '/home/cltbld', 09:56:06 INFO - 'LANG': 'en_US.UTF-8', 09:56:06 INFO - 'LANGUAGE': 'en_US:en', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MAIL': '/var/mail/cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SHLVL': '1', 09:56:06 INFO - 'TERM': 'linux', 09:56:06 INFO - 'TMOUT': '86400', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - '_': '/tools/buildbot/bin/python'} 09:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:07 INFO - Downloading/unpacking psutil>=3.1.1 09:56:07 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 09:56:07 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 09:56:07 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 09:56:07 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 09:56:07 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 09:56:07 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 09:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:09 INFO - Installing collected packages: psutil 09:56:09 INFO - Running setup.py install for psutil 09:56:09 INFO - building 'psutil._psutil_linux' extension 09:56:09 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 09:56:09 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 09:56:09 INFO - building 'psutil._psutil_posix' extension 09:56:09 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 09:56:09 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 09:56:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:09 INFO - Successfully installed psutil 09:56:09 INFO - Cleaning up... 09:56:09 INFO - Return code: 0 09:56:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:56:09 INFO - Using env: {'DISPLAY': ':0', 09:56:09 INFO - 'HOME': '/home/cltbld', 09:56:09 INFO - 'LANG': 'en_US.UTF-8', 09:56:09 INFO - 'LANGUAGE': 'en_US:en', 09:56:09 INFO - 'LOGNAME': 'cltbld', 09:56:09 INFO - 'MAIL': '/var/mail/cltbld', 09:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:09 INFO - 'MOZ_NO_REMOTE': '1', 09:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:09 INFO - 'NO_EM_RESTART': '1', 09:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:09 INFO - 'PWD': '/builds/slave/test', 09:56:09 INFO - 'SHELL': '/bin/bash', 09:56:09 INFO - 'SHLVL': '1', 09:56:09 INFO - 'TERM': 'linux', 09:56:09 INFO - 'TMOUT': '86400', 09:56:09 INFO - 'USER': 'cltbld', 09:56:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:09 INFO - '_': '/tools/buildbot/bin/python'} 09:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:11 INFO - Installing collected packages: mozsystemmonitor 09:56:11 INFO - Running setup.py install for mozsystemmonitor 09:56:11 INFO - Successfully installed mozsystemmonitor 09:56:11 INFO - Cleaning up... 09:56:11 INFO - Return code: 0 09:56:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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', '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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:56: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 jsonschema==2.5.1 09:56:11 INFO - Using env: {'DISPLAY': ':0', 09:56:11 INFO - 'HOME': '/home/cltbld', 09:56:11 INFO - 'LANG': 'en_US.UTF-8', 09:56:11 INFO - 'LANGUAGE': 'en_US:en', 09:56:11 INFO - 'LOGNAME': 'cltbld', 09:56:11 INFO - 'MAIL': '/var/mail/cltbld', 09:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:11 INFO - 'MOZ_NO_REMOTE': '1', 09:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:11 INFO - 'NO_EM_RESTART': '1', 09:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:11 INFO - 'PWD': '/builds/slave/test', 09:56:11 INFO - 'SHELL': '/bin/bash', 09:56:11 INFO - 'SHLVL': '1', 09:56:11 INFO - 'TERM': 'linux', 09:56:11 INFO - 'TMOUT': '86400', 09:56:11 INFO - 'USER': 'cltbld', 09:56:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:11 INFO - '_': '/tools/buildbot/bin/python'} 09:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:56:12 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 09:56:12 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 09:56:12 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 09:56:12 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 09:56:12 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 09:56:12 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 09:56:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:14 INFO - warning: no files found matching '*.txt' 09:56:14 INFO - no previously-included directories found matching 'build' 09:56:14 INFO - no previously-included directories found matching 'dist' 09:56:14 INFO - no previously-included directories found matching '.git*' 09:56:14 INFO - Installing collected packages: jsonschema, functools32 09:56:14 INFO - Running setup.py install for functools32 09:56:14 INFO - warning: no files found matching '*.txt' 09:56:14 INFO - no previously-included directories found matching 'build' 09:56:14 INFO - no previously-included directories found matching 'dist' 09:56:14 INFO - no previously-included directories found matching '.git*' 09:56:14 INFO - Successfully installed jsonschema functools32 09:56:14 INFO - Cleaning up... 09:56:14 INFO - Return code: 0 09:56:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:14 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:14 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 09:56:14 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 09:56:14 INFO - Using env: {'DISPLAY': ':0', 09:56:14 INFO - 'HOME': '/home/cltbld', 09:56:14 INFO - 'LANG': 'en_US.UTF-8', 09:56:14 INFO - 'LANGUAGE': 'en_US:en', 09:56:14 INFO - 'LOGNAME': 'cltbld', 09:56:14 INFO - 'MAIL': '/var/mail/cltbld', 09:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:14 INFO - 'MOZ_NO_REMOTE': '1', 09:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:14 INFO - 'NO_EM_RESTART': '1', 09:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:14 INFO - 'PWD': '/builds/slave/test', 09:56:14 INFO - 'SHELL': '/bin/bash', 09:56:14 INFO - 'SHLVL': '1', 09:56:14 INFO - 'TERM': 'linux', 09:56:14 INFO - 'TMOUT': '86400', 09:56:14 INFO - 'USER': 'cltbld', 09:56:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:14 INFO - '_': '/tools/buildbot/bin/python'} 09:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:17 INFO - Downloading docopt-0.6.1.tar.gz 09:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:17 INFO - Running setup.py install for blobuploader 09:56:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:17 INFO - Running setup.py install for requests 09:56:17 INFO - Running setup.py install for docopt 09:56:18 INFO - Successfully installed blobuploader requests docopt 09:56:18 INFO - Cleaning up... 09:56:18 INFO - Return code: 0 09:56:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:18 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:18 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 09:56:18 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 09:56:18 INFO - Using env: {'DISPLAY': ':0', 09:56:18 INFO - 'HOME': '/home/cltbld', 09:56:18 INFO - 'LANG': 'en_US.UTF-8', 09:56:18 INFO - 'LANGUAGE': 'en_US:en', 09:56:18 INFO - 'LOGNAME': 'cltbld', 09:56:18 INFO - 'MAIL': '/var/mail/cltbld', 09:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:18 INFO - 'MOZ_NO_REMOTE': '1', 09:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:18 INFO - 'NO_EM_RESTART': '1', 09:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:18 INFO - 'PWD': '/builds/slave/test', 09:56:18 INFO - 'SHELL': '/bin/bash', 09:56:18 INFO - 'SHLVL': '1', 09:56:18 INFO - 'TERM': 'linux', 09:56:18 INFO - 'TMOUT': '86400', 09:56:18 INFO - 'USER': 'cltbld', 09:56:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:18 INFO - '_': '/tools/buildbot/bin/python'} 09:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:18 INFO - Running setup.py (path:/tmp/pip-AkEhg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:18 INFO - Running setup.py (path:/tmp/pip-9lmjIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:18 INFO - Running setup.py (path:/tmp/pip-zwoi_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:18 INFO - Running setup.py (path:/tmp/pip-iiallV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:18 INFO - Running setup.py (path:/tmp/pip-Ioxkuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:18 INFO - Running setup.py (path:/tmp/pip-qMAJ35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:18 INFO - Running setup.py (path:/tmp/pip-8Jbn0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:18 INFO - Running setup.py (path:/tmp/pip-tyPaKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:18 INFO - Running setup.py (path:/tmp/pip-VotouL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:18 INFO - Running setup.py (path:/tmp/pip-zqZda0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:19 INFO - Running setup.py (path:/tmp/pip-xQIoWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:19 INFO - Running setup.py (path:/tmp/pip-DFtu8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:19 INFO - Running setup.py (path:/tmp/pip-b34p10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:19 INFO - Running setup.py (path:/tmp/pip-zX_v0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:19 INFO - Running setup.py (path:/tmp/pip-vSMkG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:19 INFO - Running setup.py (path:/tmp/pip-trvtnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:19 INFO - Running setup.py (path:/tmp/pip-4LQwBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:19 INFO - Running setup.py install for manifestparser 09:56:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:19 INFO - Running setup.py install for mozcrash 09:56:19 INFO - Running setup.py install for mozdebug 09:56:19 INFO - Running setup.py install for mozdevice 09:56:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:19 INFO - Running setup.py install for mozfile 09:56:20 INFO - Running setup.py install for mozhttpd 09:56:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozinfo 09:56:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozInstall 09:56:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozleak 09:56:20 INFO - Running setup.py install for mozlog 09:56:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for moznetwork 09:56:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozprocess 09:56:20 INFO - Running setup.py install for mozprofile 09:56:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozrunner 09:56:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:20 INFO - Running setup.py install for mozscreenshot 09:56:21 INFO - Running setup.py install for moztest 09:56:21 INFO - Running setup.py install for mozversion 09:56:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:21 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 09:56:21 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 09:56:21 INFO - Using env: {'DISPLAY': ':0', 09:56:21 INFO - 'HOME': '/home/cltbld', 09:56:21 INFO - 'LANG': 'en_US.UTF-8', 09:56:21 INFO - 'LANGUAGE': 'en_US:en', 09:56:21 INFO - 'LOGNAME': 'cltbld', 09:56:21 INFO - 'MAIL': '/var/mail/cltbld', 09:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:21 INFO - 'MOZ_NO_REMOTE': '1', 09:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:21 INFO - 'NO_EM_RESTART': '1', 09:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:21 INFO - 'PWD': '/builds/slave/test', 09:56:21 INFO - 'SHELL': '/bin/bash', 09:56:21 INFO - 'SHLVL': '1', 09:56:21 INFO - 'TERM': 'linux', 09:56:21 INFO - 'TMOUT': '86400', 09:56:21 INFO - 'USER': 'cltbld', 09:56:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:21 INFO - '_': '/tools/buildbot/bin/python'} 09:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:21 INFO - Running setup.py (path:/tmp/pip-upPXlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:21 INFO - Running setup.py (path:/tmp/pip-pspuIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:21 INFO - Running setup.py (path:/tmp/pip-SQIGOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:21 INFO - Running setup.py (path:/tmp/pip-djKDkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:21 INFO - Running setup.py (path:/tmp/pip-S8Hstv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:21 INFO - Running setup.py (path:/tmp/pip-ocmrJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:21 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)) 09:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:21 INFO - Running setup.py (path:/tmp/pip-n0LAYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:22 INFO - Running setup.py (path:/tmp/pip-5VGWxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:22 INFO - Running setup.py (path:/tmp/pip-i4x9Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:22 INFO - Running setup.py (path:/tmp/pip-lDC6zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:22 INFO - Running setup.py (path:/tmp/pip-Tk5vPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:22 INFO - Running setup.py (path:/tmp/pip-2MsTRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:22 INFO - Running setup.py (path:/tmp/pip-wTentP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:22 INFO - Running setup.py (path:/tmp/pip-v29IKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:22 INFO - Running setup.py (path:/tmp/pip-O3xwE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:22 INFO - Running setup.py (path:/tmp/pip-hKQRhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:22 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)) 09:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:22 INFO - Running setup.py (path:/tmp/pip-21LSLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:22 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)) 09:56:22 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)) 09:56:22 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)) 09:56:22 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)) 09:56:22 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)) 09:56:22 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)) 09:56:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:24 INFO - Downloading blessings-1.6.tar.gz 09:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:24 INFO - Installing collected packages: blessings 09:56:24 INFO - Running setup.py install for blessings 09:56:24 INFO - Successfully installed blessings 09:56:24 INFO - Cleaning up... 09:56:24 INFO - Return code: 0 09:56:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:25 INFO - Reading from file tmpfile_stdout 09:56:25 INFO - Current package versions: 09:56:25 INFO - argparse == 1.2.1 09:56:25 INFO - blessings == 1.6 09:56:25 INFO - blobuploader == 1.2.4 09:56:25 INFO - docopt == 0.6.1 09:56:25 INFO - functools32 == 3.2.3-2 09:56:25 INFO - jsonschema == 2.5.1 09:56:25 INFO - manifestparser == 1.1 09:56:25 INFO - mozInstall == 1.12 09:56:25 INFO - mozcrash == 0.17 09:56:25 INFO - mozdebug == 0.1 09:56:25 INFO - mozdevice == 0.48 09:56:25 INFO - mozfile == 1.2 09:56:25 INFO - mozhttpd == 0.7 09:56:25 INFO - mozinfo == 0.9 09:56:25 INFO - mozleak == 0.1 09:56:25 INFO - mozlog == 3.2 09:56:25 INFO - moznetwork == 0.27 09:56:25 INFO - mozprocess == 0.23 09:56:25 INFO - mozprofile == 0.28 09:56:25 INFO - mozrunner == 6.12 09:56:25 INFO - mozscreenshot == 0.1 09:56:25 INFO - mozsystemmonitor == 0.3 09:56:25 INFO - moztest == 0.7 09:56:25 INFO - mozversion == 1.4 09:56:25 INFO - psutil == 3.1.1 09:56:25 INFO - requests == 1.2.3 09:56:25 INFO - wsgiref == 0.1.2 09:56:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 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 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:25 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 09:56:25 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 09:56:25 INFO - Using env: {'DISPLAY': ':0', 09:56:25 INFO - 'HOME': '/home/cltbld', 09:56:25 INFO - 'LANG': 'en_US.UTF-8', 09:56:25 INFO - 'LANGUAGE': 'en_US:en', 09:56:25 INFO - 'LOGNAME': 'cltbld', 09:56:25 INFO - 'MAIL': '/var/mail/cltbld', 09:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:25 INFO - 'MOZ_NO_REMOTE': '1', 09:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:25 INFO - 'NO_EM_RESTART': '1', 09:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:25 INFO - 'PWD': '/builds/slave/test', 09:56:25 INFO - 'SHELL': '/bin/bash', 09:56:25 INFO - 'SHLVL': '1', 09:56:25 INFO - 'TERM': 'linux', 09:56:25 INFO - 'TMOUT': '86400', 09:56:25 INFO - 'USER': 'cltbld', 09:56:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:25 INFO - '_': '/tools/buildbot/bin/python'} 09:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 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)) 09:56:25 INFO - Cleaning up... 09:56:25 INFO - Return code: 0 09:56:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', '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 09:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:25 INFO - Using env: {'DISPLAY': ':0', 09:56:25 INFO - 'HOME': '/home/cltbld', 09:56:25 INFO - 'LANG': 'en_US.UTF-8', 09:56:25 INFO - 'LANGUAGE': 'en_US:en', 09:56:25 INFO - 'LOGNAME': 'cltbld', 09:56:25 INFO - 'MAIL': '/var/mail/cltbld', 09:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:25 INFO - 'MOZ_NO_REMOTE': '1', 09:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:25 INFO - 'NO_EM_RESTART': '1', 09:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:25 INFO - 'PWD': '/builds/slave/test', 09:56:25 INFO - 'SHELL': '/bin/bash', 09:56:25 INFO - 'SHLVL': '1', 09:56:25 INFO - 'TERM': 'linux', 09:56:25 INFO - 'TMOUT': '86400', 09:56:25 INFO - 'USER': 'cltbld', 09:56:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:25 INFO - '_': '/tools/buildbot/bin/python'} 09:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:25 INFO - Cleaning up... 09:56:25 INFO - Return code: 0 09:56:25 INFO - Running post-action listener: _resource_record_post_action 09:56:25 INFO - Running post-action listener: _start_resource_monitoring 09:56:25 INFO - Starting resource monitoring. 09:56:25 INFO - ##### 09:56:25 INFO - ##### Finished create-virtualenv step (success) 09:56:25 INFO - ##### 09:56:25 INFO - ##### 09:56:25 INFO - ##### Running install step. 09:56:25 INFO - ##### 09:56:25 INFO - Running pre-action listener: _resource_record_pre_action 09:56:25 INFO - Running main action method: install 09:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:25 INFO - Reading from file tmpfile_stdout 09:56:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:25 INFO - Reading from file tmpfile_stdout 09:56:25 INFO - Output received: 09:56:25 INFO - Usage: mozinstall [options] installer 09:56:25 INFO - Options: 09:56:25 INFO - -h, --help show this help message and exit 09:56:25 INFO - -d DEST, --destination=DEST 09:56:25 INFO - Directory to install application into. [default: 09:56:25 INFO - "/builds/slave/test"] 09:56:25 INFO - --app=APP Application being installed. [default: firefox] 09:56:25 INFO - mkdir: /builds/slave/test/build/application 09:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:56:42 INFO - Reading from file tmpfile_stdout 09:56:42 INFO - Output received: 09:56:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:56:42 INFO - Running post-action listener: _resource_record_post_action 09:56:42 INFO - ##### 09:56:42 INFO - ##### Finished install step (success) 09:56:42 INFO - ##### 09:56:42 INFO - ##### 09:56:42 INFO - ##### Running run-tests step. 09:56:42 INFO - ##### 09:56:42 INFO - Running pre-action listener: _resource_record_pre_action 09:56:42 INFO - Running main action method: run_tests 09:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:42 INFO - Python 2.7.3 09:56:42 INFO - Return code: 0 09:56:42 INFO - grabbing minidump binary from tooltool 09:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:42 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 0x158d3b0>, '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 0x158e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:42 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 09:56:42 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 09:56:42 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 09:56:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:42 INFO - Return code: 0 09:56:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:56:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:56:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:42 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/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:56:42 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/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 09:56:42 INFO - Using env: {'DISPLAY': ':0', 09:56:42 INFO - 'HOME': '/home/cltbld', 09:56:42 INFO - 'LANG': 'en_US.UTF-8', 09:56:42 INFO - 'LANGUAGE': 'en_US:en', 09:56:42 INFO - 'LOGNAME': 'cltbld', 09:56:42 INFO - 'MAIL': '/var/mail/cltbld', 09:56:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:42 INFO - 'MOZ_NO_REMOTE': '1', 09:56:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:42 INFO - 'NO_EM_RESTART': '1', 09:56:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:42 INFO - 'PWD': '/builds/slave/test', 09:56:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:42 INFO - 'SHELL': '/bin/bash', 09:56:42 INFO - 'SHLVL': '1', 09:56:42 INFO - 'TERM': 'linux', 09:56:42 INFO - 'TMOUT': '86400', 09:56:42 INFO - 'USER': 'cltbld', 09:56:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186', 09:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:42 INFO - '_': '/tools/buildbot/bin/python'} 09:56:42 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/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:56:42 INFO - mozversion application_buildid: 20160719092122 09:56:42 INFO - mozversion application_changeset: 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 09:56:42 INFO - mozversion application_display_name: Nightly 09:56:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:42 INFO - mozversion application_name: Firefox 09:56:42 INFO - mozversion application_remotingname: firefox 09:56:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:56:42 INFO - mozversion application_vendor: Mozilla 09:56:42 INFO - mozversion application_version: 50.0a1 09:56:42 INFO - mozversion platform_buildid: 20160719092122 09:56:42 INFO - mozversion platform_changeset: 4720fe92629a2d2a7c4811e6c4a47eb20b035e59 09:56:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:56:42 INFO - mozversion platform_version: 50.0a1 09:56:42 INFO - using testdate: 1468947402 09:56:42 INFO - actual date: 1468947402 09:56:42 INFO - starting webserver on 'localhost:40120' 09:56:42 INFO - SUITE-START | Running 2 tests 09:56:42 INFO - TEST-START | dromaeo_css 09:56:42 INFO - operating with platform_type : linux_ 09:56:42 INFO - Initialising browser for dromaeo_css test... 09:56:42 INFO - TEST-INFO | started process 30943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3A6od/profile http://localhost:40120/getInfo.html) 09:56:47 INFO - PROCESS | 30943 | __metrics Screen width/height:1600/1200 09:56:47 INFO - PROCESS | 30943 | colorDepth:24 09:56:47 INFO - PROCESS | 30943 | Browser inner width/height: 1024/697 09:56:47 INFO - PROCESS | 30943 | __metrics 09:56:48 INFO - PROCESS | 30943 | 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" 09:56:48 INFO - PROCESS | 30943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:49 INFO - TEST-INFO | 30943: exit 0 09:56:49 INFO - Browser initialized. 09:56:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:49 INFO - TEST-INFO | started process 31026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3A6od/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:01 INFO - PROCESS | 31026 | RSS: Main: 159657984 09:57:01 INFO - PROCESS | 31026 | 09:57:52 INFO - PROCESS | 31026 | 1468947472054 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] 10:00:04 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40120/tests/dromaeo/cssquery-ext.html) 10:00:05 INFO - PROCESS | 31026 | RSS: Main: 239955968 10:00:05 INFO - PROCESS | 31026 | 10:03:08 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-ext.html (next: http://localhost:40120/tests/dromaeo/cssquery-jquery.html) 10:03:09 INFO - PROCESS | 31026 | RSS: Main: 240685056 10:03:09 INFO - PROCESS | 31026 | 10:06:11 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40120/tests/dromaeo/cssquery-mootools.html) 10:06:12 INFO - PROCESS | 31026 | RSS: Main: 244424704 10:06:12 INFO - PROCESS | 31026 | 10:09:14 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40120/tests/dromaeo/cssquery-prototype.html) 10:09:15 INFO - PROCESS | 31026 | RSS: Main: 245886976 10:09:15 INFO - PROCESS | 31026 | 10:12:18 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40120/tests/dromaeo/cssquery-yui.html) 10:12:18 INFO - PROCESS | 31026 | RSS: Main: 217923584 10:12:18 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | Cycle 1(1): loaded http://localhost:40120/tests/dromaeo/cssquery-yui.html (next: http://localhost:40120/tests/dromaeo/cssquery-dojo.html) 10:15:21 INFO - PROCESS | 31026 | RSS: Main: 309100544 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | __start_tp_report 10:15:21 INFO - PROCESS | 31026 | _x_x_mozilla_page_load 10:15:21 INFO - PROCESS | 31026 | _x_x_mozilla_page_load_details 10:15:21 INFO - PROCESS | 31026 | |i|pagename|runs| 10:15:21 INFO - PROCESS | 31026 | |0;dojo.html;2626.2252635472532;2641.2736497463184;2665.8800353984075;2682.919512414628;2688.448867982064;4681.508441613632;4711.505291944348;4759.167145749498;4795.688280261785;4830.130576496229;4707.929381059287;4723.574878260956;4738.005018946017;4778.665493415462;4783.952160478394;4150.273702102135;4314.935275970855;4416.381706561084;4439.88900277494;4497.595216430521;4416.094700586372;4418.9337159942625;4453.465584129909;4466.151431228072;4488.102379524092;4216.494020717503;4266.957330426687;4330.848420305306;4353.325234588644;4407.559244075599;4322.697411181219;4334.653227741773;4386.407834942306;4399.142167277382;4408.360787685768;4398.494173170095;4403.757793321366;4406.25093734066;4409.823607055714;4435.467743870724;4591.701539399962;4653.395058642389;4774.111662444206;4779.163646361872;4781.569658730697;5130.07658621448;5172.870678233036;5204.68771873685;5209.609279304067;5210.843674689765;5015.924761128586;5147.176451767699;5173.120569503193;5181.300524429192;5188.7146206958605;4744.881377965544;4813.711177329372;4816.012717392926;4863.708177509361;4878.756062196876;5326.174442961347;5352.223927530564;5356.5982551308025;5358.062339090644;5361.08861493547;4881.243407271879;4953.6037117030555;4993.7503124843615;5033.345665063518;5040.521150490697;4999.500049994971;5056.797728090909;5060.645754797129;5061.240813877874;5087.720175390315;5024.070546948826;5030.8239211627415;5031.84904452867;5039.168537191395;5075.746212689351;4964.05682920244;5026.1204289249235;5029.0947629427055;5033.446320904697;5035.244713292962;4396.1867054595;4398.692091553625;4417.889552761142;4454.844080457233;4459.799309031101;3819.8472061117245;3836.9424458633143;3840.807959602009;3845;3879.7478163919254;4325.5674432557125;4384.254676704968;4385.166818304512;4439.889002774957;4474.507804141542;5155.02054609623;5168.250603662448;5185.170372740344;5186.844394668166;5188.11801993662;4443.644508439317;4444.2444784386735;4445.533219012022;4481.977590112094;4488.416505854283;4482.081173359518;4546.5453454654935;4577.931331030038;4583.862484125481;4690;4751.073540659539;4759.881002974884;4766.880827979328;4768.284757286296;4816.494268101939;5064.670796398223;5076.137056700296;5077.365329333833;5081.136206844919;5126.333576635014;4630.097131059411;4717.716936983792;4720.244760838249;4769.904601907873;4790.4251489821445;4996.975015124901;5000.524950129878;5005.074061298671;5009.448960614257;5059.747012649426;5056.974715126548;5072.543471087472;5078.695278283315;5085.338905942203;5128.897422051613;4829.082474329866;4832.613390928647;4944.307796908363;5005.524475174852;5029.119904016856;4996.125678006407;5033.672811267256;5039.067772462106;5044.8234311798915;5088.313077734459;4799.688020278671;4945.604351651931;4959.82640607577;4979.900401992012;5020.297158397754;4888.144574699484;4927.556519913225;4935.136351138608;4946.134426475424;4957.975210123926;4826.686265392738;4844.515548445127;4854.101991131652;4864.552855237861;4905.068037072945 10:15:21 INFO - PROCESS | 31026 | |1;ext.html;587.0255376075714;594.8007417515132;600.4415893219306;611.4649681528663;614.5452365249714;26473.338166545847;28099.157025289223;28158.29604259892;39375.803120984354;40738.7963060185;40681.38977915334;40939.385909211385;40985.7950710246;41027.58972410275;41156.38265426014;7774.727884524029;7881.369490440751;7887;7919.802004949865;7923.603819808986;7547.924520754777;7736.845263094735;7741.729039483619;7760.262775036391;7942.602869856513;9992.200623950102;10263;10269.383836969768;10548.630797922075;10599.735006624858;10162.339447935861;10219.029192226726;10244.487775611264;10255.897441025569;10264.435456049914;7569.545827250327;7779.611019449005;7781.494202876795;9982.750431239205;10037.34757240777;33745;34425.82787086074;34501.82749086263;36971;36974.26051478955;2946.3665311958034;3004.474217012036;3130.9060728177965;3133.279345750467;3176.6029246344206;28844.567331490045;29217.85391073031;29481.262968425963;29591.70408295911;29852.70147298521;3335.4830001349587;3453.4819777033645;3502.964970350289;3528.541289632357;3577.5528058992627;260972;263335;263616;263869.68065159745;264699;46599.767001165455;48126.75936620295;53117.468825312026;55396;55457.44542554523;57033.42966570281;57085.143722844194;57184.42815571874;57211.713941430025;57284.14073788896;14338.139711617336;14437.711245775026;14445.711085778226;14449.422023119168;14452.494162704255;11309.49107290174;11344;11350.205485615928;11356.94321528387;11364.488598012944;16240.187990600423;17213.483595492155;17766;18180.727289090675;18312.542186445444;6939.410150137194;7073.398761105261;7089.89365159523;7098.503104782616;7123.572585644878;841.381584535366;955.2310390136007;971.4802580619335;1013.7820368620781;1027.219313321866;28386.71613283882;28571.71428285732;28609.85695071511;28709;28876;958.5782255807422;969.7963427680266;973.6786860336072;979.1677074486629;1015.9034891685278;14709.338079786436;14918.850811491746;15048.548543543711;15131;15211.543653690407;406432;408305;409980;410388;410394;46291;46917.29624055642;46948.06103877904;46959;46984.765076175085;1114.3815182573587;1114.8773634900153;1124.3591153042687;1188.869224385317;1232.9568465103678;22831.429214269778;27702.861485692443;29083.41833163367;29171.124866254046;29655.25861853471;46179.3073103897;46867.53132468768;46965.2955205679;46999.295010574184;47058.29412558883;363051;366446;368203;368549;368853;32011.35977280395;37161.14849308553;38426.807865960494;38640.6135938637;38714.80642596769;32181.678183218806;42926.570734292254;43157.56842431661;46508.53491465042;47536.286955695;34383;35314.46855314551;35697.643023569435;35795.463068053476;35905.64094359127;36105.458418124275;36458;36747.26505469929;36914.63085369112;36985.26029479449;36051.819740901126;36247;36380.090497737765;37236.441453378764;37295.25409491849;30244;32519.58544352809;32569.185770354983;32983.67016329806;33099.83450082734;24936.750632494168;25075;25360.74639253584;25533.3616659585;25843.870780645975 10:15:21 INFO - PROCESS | 31026 | |2;jquery.html;373.1064101476963;375.6600276749541;380.8057890475857;384.4636731759198;386.19863782650987;16251.91874040631;17435.82564174358;17878.910605446956;18305.633887322278;18375.90812045941;16674.166291685397;17026.82973170268;17139.82860171398;17417.651646967086;17433.738493922603;4900.142475066867;5116.948830511685;5131.846044618667;5132.255822905695;5132.5124113209185;3815.5993620669847;3999.1401848602545;5050.520200580957;6027.246594175728;6034.8793024139495;6049.092636104598;6065.332813390545;6068.635881847081;6090.116933044706;6094.055421409666;5732.369439361667;5927.644341339534;5953.642781433128;5954.612950158247;6059.818205453821;5230.006298803215;5235.39792923811;5235.869103272448;5238.240455133984;5243.4232234454175;20431.79568204314;21035.8948205258;21317.360479185496;21482;21514.247001355034;1961.1763059515038;1963.6465436221474;1980.6038792241466;1992.8505362097756;2017.9899100504404;12999.545015924397;13307.135036222615;13543.729125417534;13657.453701851913;13967.65080872976;1621.6999855026859;1730.4376077774773;1807.557148498613;1815.8442087079065;1824.2064701854604;48554.51445485535;51099;61055;69350;69993;9603.615855365708;9662.806743865083;9731.172850307661;9812;9933.552990115462;13267.933660331637;13369.131006484742;13371.264580447974;13376.598702038955;13377.130486518345;7453.403727701771;7483.962580187173;7591.620418979029;7630.122535908331;7642.5032372895585;7641.617919104023;7687.65647409212;7714.652840622185;7739.148693643695;7811.45319827618;6002.489788368038;6014.428629280212;6082.60463069899;6139.066426578514;6190.0714892765545;1707.812140664526;1737.2616637929082;1747.8776485645883;1756.9912150439166;1813.4740925131564;791.3748138970265;908.9636414543477;930.5951910918772;932.8554074118523;976.0629795396356;17157.142142892804;18078.00570968583;18241.543961401072;18353.63292734138;18619.441416757247;850.2177996243471;853.3216093205916;866.3366336633678;879.2702057292432;921.4517362169498;10047;10072.546735396925;10356.896431035593;10364.844527332096;10495.160387169008;390210;393941;394340;395128;425980;47614.523854761705;49743.75128124336;52413.7379313101;84643;86434;417.2364572831711;435.51875177927934;437.5427678076418;438.31185039487696;439.0253636926019;9350.20693570801;9708.368956017835;9941;10122.8481572775;10216.846747298945;38047.239055219296;38214.23571528498;38308;38585.421218682306;38672.80663596664;50303.245451318995;53546;53554;53594.73202633962;53656.463435366706;7770.206790153881;7788.454808163374;7790.14308426084;7945.801354966172;8018.518888866687;11079.501422436171;11895.22681025765;12162.756744864877;12177.391130443619;12268.693282668004;10217.693469195936;10270.6405275815;10328.741781455223;10405.375677459377;10670.946645266724;10134.543945522322;10193.23550733683;10445.216608754221;10561.947190264;10736.30214036085;10462.319949203278;10505;10626.73433164177;10739.033486986209;10824.242303039027;7009.228984811769;7077.82305442368;7327.63361831917;7873.488223265469;7961.72133975308;9924.801503970024;10195.490225488844;10261.435621040915;10309.793804124025;10340.431276279876 10:15:21 INFO - PROCESS | 31026 | |3;mootools.html;1234.678983464299;1361.7276544691058;1410.2596137028058;1448.6523234423735;1663.925123369449;6589.802305930823;7603.277688619586;7810.687572497093;7853.057633084024;8038.598070096501;7850.332721718646;7878.290953814156;7959.323457506119;7964.6017699114955;7968.9601551992155;2162.7080344153496;2174.1303478608525;2176.9020394082227;2190.2443656938412;2194.297824696098;2135.1032566322106;2160.0171921775554;2171.0772921508374;2173.576152650234;2173.706549615805;2158.233826991419;2159.157928407922;2161.6325224711836;2163.653815389538;2221.8444708870384;2094.6229678657837;2099.128861522466;2099.2757498663013;2102.2852230241792;2102.9579408411823;2074.118499637648;2144.120910426733;2144.142343062772;2145.2598853395552;2149.0544160569298;7726.072871255429;7942.3646108311195;7953.721619743281;8013.799655008613;8025.438219324649;4482.977585112054;4652.418447694038;4671.836485723017;4682.274247491644;4682.438107427097;2826.505361561739;2888.277930517371;2919.168037109435;2927.956080658792;2929.26768307923;906.5784410249265;914.1087439746261;921.9124183202586;921.9400738952014;923.4182465046978;10869.83695244572;10982;10982.231243812936;11016.06363459107;11023.283486573348;3888.5528164260904;3995.06116062725;4095.4266402703647;4103.466549348565;4110.301248787653;8591;8643.697470588499;8649.524276164871;8656.177663121993;8656.394052416397;4592.540745925381;4592.977035114803;4599.356090147382;4600.470945841271;4605.148047611136;3756.3050835595504;4183.811728472226;4204.831806727758;4206.663466922639;4309.41822853917;3500.5099286099967;3501;3561.5191949086543;3594.0655429588496;3594.8022858742497;1057.2704833664748;1082.7942690888706;1088.548252475214;1094.1520321750547;1095.1457862866976;784.4116912315764;868.7914900423852;879.907609700985;881.3742243007537;912.7033714042963;5410.1343784994215;5445.918311225335;5559.082751345983;5690.516306113944;5851.707414629337;831.6091437024588;842.7387509871959;915.1077699243318;937.4515908193783;968.080323692495;3764.3976963686227;3804.5814960354337;3829.463875057494;3933.095388060762;3948.9535273152637;9661.565229564687;9857.55640996157;9913.752156196153;9966.800663986825;9979.201663866874;9836.852447213298;9839.704808855746;9849.655262065937;9852.704418867446;9854.852177217348;7306.415486761046;7437.85124297511;7457.067866516685;7457.403407727369;7460;5426.64726792773;5501.834944951658;5575.0522411191005;5657.066584013756;5812.800063484533;8731.25784308341;9025.548722563977;9114.906211254427;9117.7264682057;9121.635134594808;8989.235914947303;9047.366684332033;9108.863367049633;9274.118958698913;9293.907060929574;6120.540959427972;6454.19322584677;6883.690233939385;6909.827254318682;7032.26161253061;7708.8072798178255;7721.536707797325;7809.843803123792;7810.414218933489;7813.531188128731;6774.71540438873;6974.37230649244;7032.824179395556;7055.400290975119;7057.682404291717;6675.632840193836;6699.363560461748;6880.621565813728;6968.442524597918;7026;6261.749530018748;6643.335666433318;6665.66671666405;6716.597004179765;6716.764913228014;4689.437267527782;4772.49888761675;4777.235642297216;4878.682885612566;4894.646387379348;4834.564889159992;4886.120498310338;4926.211806111005;4931.950680493149;5003.924941125959 10:15:21 INFO - PROCESS | 31026 | |4;prototype.html;296.8545412747754;300.4801693070987;301.5958615455289;304.1620335974392;307.7753240134703;4749.50130236325;4753.241300718731;4754.524547545244;4764.118638051958;4769.54689304516;4721.197396442604;4723.244280915054;4724.952750472494;4731.455882573505;4733.337332773414;3600.5679318481752;3662.8168591570447;3688.340246888897;3764.247150569883;3788.6590206881374;3739.8317075731657;3758.267137908109;3776.433534969749;3777.0557360659836;3789.9810500947456;3562.92874142517;3730;3745.5879853216125;3745.7565258258264;3748.4189950557707;3624.3294990426725;3726.347889119393;3741.4574886641285;3744.2137151198144;3744.588095309514;3305.5206994985833;3317.4857897026;3320.468725003988;3330.783499072577;3332.7667063305335;4607.7004994675235;4618.930716039262;4620.884477888046;4623.537646235383;4625.976870115662;4162.252913077385;4215;4222.831086756526;4235.9364609530885;4260.297050986584;4910.558049775502;4949.257611358289;4950.4307004694565;4954.43024052235;4957.256411538262;3568.4290513517712;3577.4438119418137;3577.588577313616;3578.2664553766676;3585.4980302757635;4910.410750709902;5176.352955880515;5189.455107213764;5191.922121168185;5193.2989046479;3732.5894151643297;3735.906602334909;3737.177820879402;3740.0275928258848;3747.6439738224826;3775.7923314217983;3779.4708740776314;3780.9621903781162;3800.7005761513888;3803.980980095137;4246.63903568194;4274.478057945827;4279.6091270337265;4283.421738065322;4283.807228674717;4697.31888876111;4996.2505624156665;5000.799968001239;5007.824726134568;5009.649324547247;1273.4778740716263;1280.257450678604;1282.9486820527075;1283.3775618824861;1285.2930888011556;808.9029316481942;820.5938060660012;845.218173189797;863.9524826134623;875.0024971532458;4331.978340108342;4358.106588149485;4362.629176520031;4368.432103826546;4379.605835474823;4981.252812078217;4985.152524070917;4987.750612469362;4999.275105109738;5066.392032956069;4254.702170848011;4354.368616550646;4379.430674012358;4385.605295523418;4390.62679672225;2676.8260063095836;2682.316009417586;2689.300781796747;2700.824446410977;2713.186044186736;4787.8563643090765;4792.664513484093;4795.976020119947;4796.352492413549;4797.352357431702;4942.777575009133;5098.9490105098475;5128.7179205144075;5154.716490593053;5172.663776854492;4736.881577960578;4778.187708089564;4782.736949467743;4787.305840653085;4790.760461976887;4992.079633414493;5022.899542009066;5024.271480635361;5026.52248036436;5048.217526283432;4773.331733557236;4884.92672609904;4921.753912304442;4925;5058.772355243949;4831.637627177905;4848.12733707936;4851.417829860439;4871.878203044952;4882;3622.2755448910852;3631.2192878530186;3635.745497815233;3643.5992040876013;3654.543182102237;5052.292679025013;5181.715005674724;5184.196449550326;5190.403103642979;5195.5583775378;4999.925001125059;5011.724355160355;5029.27075574047;5043.747812609428;5070.670406423571;5010.949890501049;5014.398272207359;5020.569137795711;5023.447420783637;5027.3464449621315;4742.407199100113;4932.202204302595;4944.233643785219;4944.505549445027;4954.455009948975;4828.782704778223;4888.340074089952;5014.044522636248;5030.673006254582;5034.219695947134;4896.36347274852;4907.043126590281;4913.238448040559;4914.164592019294;4919.401194611694 10:15:21 INFO - PROCESS | 31026 | |5;yui.html;645.7707513832588;669.2805234373047;685.9416949559287;738.9593572353518;745.6569977810209;11616.825747613782;12171.57399491018;12211.877881221197;12230.266184028953;12236.510539578407;12412.676520852696;12448.37758112093;12485.375731213426;12506.187097838634;12584.685382865433;605.6003037994924;772.8145245141168;785.5954183595453;787.0240901282398;788.7594283743456;744.5904752386193;772.6909236305466;775.3022279948035;779.07679399911;779.8011507065719;817.9141190175035;819.778659761864;820.0364571628343;820.2781552234026;820.983580328393;640.810960766575;784.7214238945149;807.6971135824066;809.8137428391444;810.7000409848364;594.1859652276408;594.6194435561245;597.2415032908226;597.3667912013279;598.3119412675414;12741.936290318581;12744.299063551502;12745.681357966032;12749.808752868714;12754.489820407172;12355.32045737484;13022.348882555929;13036.859574255772;13087.280199589019;13231.221918948197;11965.700857478632;12131.757364852741;12157.209781364183;12198;12443.502259909592;4154.293770059097;4195.622393984556;4207.453031105937;4213.789310534461;4219.852305169305;61366.386336136515;61655.38344616586;61705;62130.68934655298;62587.37412625861;10358.274920755475;10372.377657340583;10560.788784224273;10626.309289896131;10962.451877406098;19034.428967131007;19088.80911190898;19092.522686932938;19095.427137185907;19129.33047343336;6950.478714096362;7095.858082838315;7115.719170549351;7132.857342853114;7144.678489467987;3703.703703703697;3706.5737440194184;3841.2509560635967;3878.9224215515533;3919.294526985113;2662.9067982620513;2734.8632568371504;2745.368565229968;2746.6841313249233;2757.379589592326;502.53264464048783;510.19134671545277;534.3054029761295;542.5957661542176;544.599719206383;569.1491220625192;598.5869749872573;613.7238242790762;614.7940439952577;626.692920468976;8237.176282371835;8330.375221858385;8391.95804020976;8492.787680307918;8586.31309495239;610.5603965145089;611.7277811373984;613.3804857094367;617.3363634093367;618.5515501261549;3869.400242962345;3987.6809855211513;4028.1138149607627;4043.7071303238413;4077.5350990665174;104904;106353;107096;108406;109068;93331.53334233286;94217.52891235637;94822;94922.52538737262;94976;80843;83628;84034;85044;86337.56831215804;6793.116894803644;7404.259574042552;7476.962615186889;7505.587192704454;7844.254795794391;42355.7882210587;43243.56756432395;43547;44523;47354;64028.67985660042;66345.66827165833;66372;67346;67539.66230168818;9474.478903660365;9509.619615215313;9517.524123793644;9530.378456186605;9570;10784.514696838503;10878.401687906924;11091.833622495507;11233.887661123284;11344.035756960751;10721.571137154426;10761.784764304826;10937.179711521509;11079.00288973964;11990.340531270864;12242.571509997108;12316.384180790745;12754.744905102032;13104;13231.206127632373;12294.262344259372;12573.87426125727;12999.350032498527;13003.414846332127;13141.145825521311;9294.767630809014;9376;9713.70858874235;9929.801403972024;9975.052370024836;9493.620255189991;9507.952460237932;9943.950280248553;10063.849042264519;10106.585078088927 10:15:21 INFO - PROCESS | 31026 | __end_tp_report 10:15:21 INFO - PROCESS | 31026 | __start_cc_report 10:15:21 INFO - PROCESS | 31026 | _x_x_mozilla_cycle_collect,936 10:15:21 INFO - PROCESS | 31026 | __end_cc_report 10:15:21 INFO - PROCESS | 31026 | __startTimestamp1468948521791__endTimestamp 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | ------- Summary: start ------- 10:15:21 INFO - PROCESS | 31026 | Number of tests: 6 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#0] dojo.html Cycles:165 Average:4716.58 Median:4816.49 stddev:491.88 (10.2%) stddev-sans-first:465.25 10:15:21 INFO - PROCESS | 31026 | Values: 2626.2 2641.3 2665.9 2682.9 2688.4 4681.5 4711.5 4759.2 4795.7 4830.1 4707.9 4723.6 4738.0 4778.7 4784.0 4150.3 4314.9 4416.4 4439.9 4497.6 4416.1 4418.9 4453.5 4466.2 4488.1 4216.5 4267.0 4330.8 4353.3 4407.6 4322.7 4334.7 4386.4 4399.1 4408.4 4398.5 4403.8 4406.3 4409.8 4435.5 4591.7 4653.4 4774.1 4779.2 4781.6 5130.1 5172.9 5204.7 5209.6 5210.8 5015.9 5147.2 5173.1 5181.3 5188.7 4744.9 4813.7 4816.0 4863.7 4878.8 5326.2 5352.2 5356.6 5358.1 5361.1 4881.2 4953.6 4993.8 5033.3 5040.5 4999.5 5056.8 5060.6 5061.2 5087.7 5024.1 5030.8 5031.8 5039.2 5075.7 4964.1 5026.1 5029.1 5033.4 5035.2 4396.2 4398.7 4417.9 4454.8 4459.8 3819.8 3836.9 3840.8 3845.0 3879.7 4325.6 4384.3 4385.2 4439.9 4474.5 5155.0 5168.3 5185.2 5186.8 5188.1 4443.6 4444.2 4445.5 4482.0 4488.4 4482.1 4546.5 4577.9 4583.9 4690.0 4751.1 4759.9 4766.9 4768.3 4816.5 5064.7 5076.1 5077.4 5081.1 5126.3 4630.1 4717.7 4720.2 4769.9 4790.4 4997.0 5000.5 5005.1 5009.4 5059.7 5057.0 5072.5 5078.7 5085.3 5128.9 4829.1 4832.6 4944.3 5005.5 5029.1 4996.1 5033.7 5039.1 5044.8 5088.3 4799.7 4945.6 4959.8 4979.9 5020.3 4888.1 4927.6 4935.1 4946.1 4958.0 4826.7 4844.5 4854.1 4864.6 4905.1 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#1] ext.html Cycles:180 Average:50076.77 Median:35978.73 stddev:92775.05 (257.9%) stddev-sans-first:92960.90 10:15:21 INFO - PROCESS | 31026 | Values: 587.0 594.8 600.4 611.5 614.5 26473.3 28099.2 28158.3 39375.8 40738.8 40681.4 40939.4 40985.8 41027.6 41156.4 7774.7 7881.4 7887.0 7919.8 7923.6 7547.9 7736.8 7741.7 7760.3 7942.6 9992.2 10263.0 10269.4 10548.6 10599.7 10162.3 10219.0 10244.5 10255.9 10264.4 7569.5 7779.6 7781.5 9982.8 10037.3 33745.0 34425.8 34501.8 36971.0 36974.3 2946.4 3004.5 3130.9 3133.3 3176.6 28844.6 29217.9 29481.3 29591.7 29852.7 3335.5 3453.5 3503.0 3528.5 3577.6 260972.0 263335.0 263616.0 263869.7 264699.0 46599.8 48126.8 53117.5 55396.0 55457.4 57033.4 57085.1 57184.4 57211.7 57284.1 14338.1 14437.7 14445.7 14449.4 14452.5 11309.5 11344.0 11350.2 11356.9 11364.5 16240.2 17213.5 17766.0 18180.7 18312.5 6939.4 7073.4 7089.9 7098.5 7123.6 841.4 955.2 971.5 1013.8 1027.2 28386.7 28571.7 28609.9 28709.0 28876.0 958.6 969.8 973.7 979.2 1015.9 14709.3 14918.9 15048.5 15131.0 15211.5 406432.0 408305.0 409980.0 410388.0 410394.0 46291.0 46917.3 46948.1 46959.0 46984.8 1114.4 1114.9 1124.4 1188.9 1233.0 22831.4 27702.9 29083.4 29171.1 29655.3 46179.3 46867.5 46965.3 46999.3 47058.3 363051.0 366446.0 368203.0 368549.0 368853.0 32011.4 37161.1 38426.8 38640.6 38714.8 32181.7 42926.6 43157.6 46508.5 47536.3 34383.0 35314.5 35697.6 35795.5 35905.6 36105.5 36458.0 36747.3 36914.6 36985.3 36051.8 36247.0 36380.1 37236.4 37295.3 30244.0 32519.6 32569.2 32983.7 33099.8 24936.8 25075.0 25360.7 25533.4 25843.9 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#2] jquery.html Cycles:180 Average:24216.18 Median:199563.57 stddev:65678.26 (32.9%) stddev-sans-first:65838.11 10:15:21 INFO - PROCESS | 31026 | Values: 373.1 375.7 380.8 384.5 386.2 16251.9 17435.8 17878.9 18305.6 18375.9 16674.2 17026.8 17139.8 17417.7 17433.7 4900.1 5116.9 5131.8 5132.3 5132.5 3815.6 3999.1 5050.5 6027.2 6034.9 6049.1 6065.3 6068.6 6090.1 6094.1 5732.4 5927.6 5953.6 5954.6 6059.8 5230.0 5235.4 5235.9 5238.2 5243.4 20431.8 21035.9 21317.4 21482.0 21514.2 1961.2 1963.6 1980.6 1992.9 2018.0 12999.5 13307.1 13543.7 13657.5 13967.7 1621.7 1730.4 1807.6 1815.8 1824.2 48554.5 51099.0 61055.0 69350.0 69993.0 9603.6 9662.8 9731.2 9812.0 9933.6 13267.9 13369.1 13371.3 13376.6 13377.1 7453.4 7484.0 7591.6 7630.1 7642.5 7641.6 7687.7 7714.7 7739.1 7811.5 6002.5 6014.4 6082.6 6139.1 6190.1 1707.8 1737.3 1747.9 1757.0 1813.5 791.4 909.0 930.6 932.9 976.1 17157.1 18078.0 18241.5 18353.6 18619.4 850.2 853.3 866.3 879.3 921.5 10047.0 10072.5 10356.9 10364.8 10495.2 390210.0 393941.0 394340.0 395128.0 425980.0 47614.5 49743.8 52413.7 84643.0 86434.0 417.2 435.5 437.5 438.3 439.0 9350.2 9708.4 9941.0 10122.8 10216.8 38047.2 38214.2 38308.0 38585.4 38672.8 50303.2 53546.0 53554.0 53594.7 53656.5 7770.2 7788.5 7790.1 7945.8 8018.5 11079.5 11895.2 12162.8 12177.4 12268.7 10217.7 10270.6 10328.7 10405.4 10670.9 10134.5 10193.2 10445.2 10561.9 10736.3 10462.3 10505.0 10626.7 10739.0 10824.2 7009.2 7077.8 7327.6 7873.5 7961.7 9924.8 10195.5 10261.4 10309.8 10340.4 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#3] mootools.html Cycles:180 Average:5216.46 Median:5616.06 stddev:2935.51 (52.3%) stddev-sans-first:2928.49 10:15:21 INFO - PROCESS | 31026 | Values: 1234.7 1361.7 1410.3 1448.7 1663.9 6589.8 7603.3 7810.7 7853.1 8038.6 7850.3 7878.3 7959.3 7964.6 7969.0 2162.7 2174.1 2176.9 2190.2 2194.3 2135.1 2160.0 2171.1 2173.6 2173.7 2158.2 2159.2 2161.6 2163.7 2221.8 2094.6 2099.1 2099.3 2102.3 2103.0 2074.1 2144.1 2144.1 2145.3 2149.1 7726.1 7942.4 7953.7 8013.8 8025.4 4483.0 4652.4 4671.8 4682.3 4682.4 2826.5 2888.3 2919.2 2928.0 2929.3 906.6 914.1 921.9 921.9 923.4 10869.8 10982.0 10982.2 11016.1 11023.3 3888.6 3995.1 4095.4 4103.5 4110.3 8591.0 8643.7 8649.5 8656.2 8656.4 4592.5 4593.0 4599.4 4600.5 4605.1 3756.3 4183.8 4204.8 4206.7 4309.4 3500.5 3501.0 3561.5 3594.1 3594.8 1057.3 1082.8 1088.5 1094.2 1095.1 784.4 868.8 879.9 881.4 912.7 5410.1 5445.9 5559.1 5690.5 5851.7 831.6 842.7 915.1 937.5 968.1 3764.4 3804.6 3829.5 3933.1 3949.0 9661.6 9857.6 9913.8 9966.8 9979.2 9836.9 9839.7 9849.7 9852.7 9854.9 7306.4 7437.9 7457.1 7457.4 7460.0 5426.6 5501.8 5575.1 5657.1 5812.8 8731.3 9025.5 9114.9 9117.7 9121.6 8989.2 9047.4 9108.9 9274.1 9293.9 6120.5 6454.2 6883.7 6909.8 7032.3 7708.8 7721.5 7809.8 7810.4 7813.5 6774.7 6974.4 7032.8 7055.4 7057.7 6675.6 6699.4 6880.6 6968.4 7026.0 6261.7 6643.3 6665.7 6716.6 6716.8 4689.4 4772.5 4777.2 4878.7 4894.6 4834.6 4886.1 4926.2 4932.0 5003.9 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#4] prototype.html Cycles:180 Average:4134.79 Median:4735.11 stddev:1186.12 (25.0%) stddev-sans-first:1153.94 10:15:21 INFO - PROCESS | 31026 | Values: 296.9 300.5 301.6 304.2 307.8 4749.5 4753.2 4754.5 4764.1 4769.5 4721.2 4723.2 4725.0 4731.5 4733.3 3600.6 3662.8 3688.3 3764.2 3788.7 3739.8 3758.3 3776.4 3777.1 3790.0 3562.9 3730.0 3745.6 3745.8 3748.4 3624.3 3726.3 3741.5 3744.2 3744.6 3305.5 3317.5 3320.5 3330.8 3332.8 4607.7 4618.9 4620.9 4623.5 4626.0 4162.3 4215.0 4222.8 4235.9 4260.3 4910.6 4949.3 4950.4 4954.4 4957.3 3568.4 3577.4 3577.6 3578.3 3585.5 4910.4 5176.4 5189.5 5191.9 5193.3 3732.6 3735.9 3737.2 3740.0 3747.6 3775.8 3779.5 3781.0 3800.7 3804.0 4246.6 4274.5 4279.6 4283.4 4283.8 4697.3 4996.3 5000.8 5007.8 5009.6 1273.5 1280.3 1282.9 1283.4 1285.3 808.9 820.6 845.2 864.0 875.0 4332.0 4358.1 4362.6 4368.4 4379.6 4981.3 4985.2 4987.8 4999.3 5066.4 4254.7 4354.4 4379.4 4385.6 4390.6 2676.8 2682.3 2689.3 2700.8 2713.2 4787.9 4792.7 4796.0 4796.4 4797.4 4942.8 5098.9 5128.7 5154.7 5172.7 4736.9 4778.2 4782.7 4787.3 4790.8 4992.1 5022.9 5024.3 5026.5 5048.2 4773.3 4884.9 4921.8 4925.0 5058.8 4831.6 4848.1 4851.4 4871.9 4882.0 3622.3 3631.2 3635.7 3643.6 3654.5 5052.3 5181.7 5184.2 5190.4 5195.6 4999.9 5011.7 5029.3 5043.7 5070.7 5010.9 5014.4 5020.6 5023.4 5027.3 4742.4 4932.2 4944.2 4944.5 4954.5 4828.8 4888.3 5014.0 5030.7 5034.2 4896.4 4907.0 4913.2 4914.2 4919.4 10:15:21 INFO - PROCESS | 31026 | 10:15:21 INFO - PROCESS | 31026 | [#5] yui.html Cycles:180 Average:18628.34 Median:543.60 stddev:27718.27 (5099.0%) stddev-sans-first:27763.14 10:15:21 INFO - PROCESS | 31026 | Values: 645.8 669.3 685.9 739.0 745.7 11616.8 12171.6 12211.9 12230.3 12236.5 12412.7 12448.4 12485.4 12506.2 12584.7 605.6 772.8 785.6 787.0 788.8 744.6 772.7 775.3 779.1 779.8 817.9 819.8 820.0 820.3 821.0 640.8 784.7 807.7 809.8 810.7 594.2 594.6 597.2 597.4 598.3 12741.9 12744.3 12745.7 12749.8 12754.5 12355.3 13022.3 13036.9 13087.3 13231.2 11965.7 12131.8 12157.2 12198.0 12443.5 4154.3 4195.6 4207.5 4213.8 4219.9 61366.4 61655.4 61705.0 62130.7 62587.4 10358.3 10372.4 10560.8 10626.3 10962.5 19034.4 19088.8 19092.5 19095.4 19129.3 6950.5 7095.9 7115.7 7132.9 7144.7 3703.7 3706.6 3841.3 3878.9 3919.3 2662.9 2734.9 2745.4 2746.7 2757.4 502.5 510.2 534.3 542.6 544.6 569.1 598.6 613.7 614.8 626.7 8237.2 8330.4 8392.0 8492.8 8586.3 610.6 611.7 613.4 617.3 618.6 3869.4 3987.7 4028.1 4043.7 4077.5 104904.0 106353.0 107096.0 108406.0 109068.0 93331.5 94217.5 94822.0 94922.5 94976.0 80843.0 83628.0 84034.0 85044.0 86337.6 6793.1 7404.3 7477.0 7505.6 7844.3 42355.8 43243.6 43547.0 44523.0 47354.0 64028.7 66345.7 66372.0 67346.0 67539.7 9474.5 9509.6 9517.5 9530.4 9570.0 10784.5 10878.4 11091.8 11233.9 11344.0 10721.6 10761.8 10937.2 11079.0 11990.3 12242.6 12316.4 12754.7 13104.0 13231.2 12294.3 12573.9 12999.4 13003.4 13141.1 9294.8 9376.0 9713.7 9929.8 9975.1 9493.6 9508.0 9944.0 10063.8 10106.6 10:15:21 INFO - PROCESS | 31026 | -------- Summary: end -------- 10:15:21 INFO - PROCESS | 31026 | 10:15:22 INFO - TEST-INFO | 31026: exit 0 10:15:22 INFO - TEST-OK | dromaeo_css | took 1120011ms 10:15:22 INFO - TEST-START | kraken 10:15:22 INFO - operating with platform_type : linux_ 10:15:22 INFO - Initialising browser for kraken test... 10:15:22 INFO - TEST-INFO | started process 31216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vu_lM/profile http://localhost:40120/getInfo.html) 10:15:27 INFO - PROCESS | 31216 | __metrics Screen width/height:1600/1200 10:15:27 INFO - PROCESS | 31216 | colorDepth:24 10:15:27 INFO - PROCESS | 31216 | Browser inner width/height: 1024/697 10:15:27 INFO - PROCESS | 31216 | __metrics 10:15:27 INFO - PROCESS | 31216 | 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" 10:15:27 INFO - PROCESS | 31216 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:28 INFO - TEST-INFO | 31216: exit 0 10:15:28 INFO - Browser initialized. 10:15:28 INFO - Running cycle 1/1 for kraken test... 10:15:28 INFO - TEST-INFO | started process 31297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9vu_lM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:40 INFO - PROCESS | 31297 | RSS: Main: 159465472 10:15:40 INFO - PROCESS | 31297 | 10:15:43 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40120/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:44 INFO - PROCESS | 31297 | RSS: Main: 218238976 10:15:44 INFO - PROCESS | 31297 | 10:15:47 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40120/tests/kraken/driver.html?testName=audio-dft) 10:15:47 INFO - PROCESS | 31297 | RSS: Main: 206106624 10:15:47 INFO - PROCESS | 31297 | 10:15:51 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40120/tests/kraken/driver.html?testName=audio-fft) 10:15:51 INFO - PROCESS | 31297 | RSS: Main: 271294464 10:15:51 INFO - PROCESS | 31297 | 10:15:53 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40120/tests/kraken/driver.html?testName=audio-oscillator) 10:15:54 INFO - PROCESS | 31297 | RSS: Main: 181284864 10:15:54 INFO - PROCESS | 31297 | 10:15:56 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:57 INFO - PROCESS | 31297 | RSS: Main: 186531840 10:15:57 INFO - PROCESS | 31297 | 10:16:00 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40120/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:00 INFO - PROCESS | 31297 | RSS: Main: 221974528 10:16:00 INFO - PROCESS | 31297 | 10:16:04 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40120/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:05 INFO - PROCESS | 31297 | RSS: Main: 218279936 10:16:05 INFO - PROCESS | 31297 | 10:16:07 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40120/tests/kraken/driver.html?testName=json-parse-financial) 10:16:08 INFO - PROCESS | 31297 | RSS: Main: 221286400 10:16:08 INFO - PROCESS | 31297 | 10:16:10 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:10 INFO - PROCESS | 31297 | RSS: Main: 210587648 10:16:10 INFO - PROCESS | 31297 | 10:16:12 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:13 INFO - PROCESS | 31297 | RSS: Main: 214061056 10:16:13 INFO - PROCESS | 31297 | 10:16:15 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:16 INFO - PROCESS | 31297 | RSS: Main: 210817024 10:16:16 INFO - PROCESS | 31297 | 10:16:19 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:19 INFO - PROCESS | 31297 | RSS: Main: 224780288 10:16:19 INFO - PROCESS | 31297 | 10:16:22 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:23 INFO - PROCESS | 31297 | RSS: Main: 224694272 10:16:23 INFO - PROCESS | 31297 | 10:16:24 INFO - PROCESS | 31297 | Cycle 1(1): loaded http://localhost:40120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40120/tests/kraken/driver.html?testName=ai-astar) 10:16:25 INFO - PROCESS | 31297 | RSS: Main: 267395072 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | __start_tp_report 10:16:25 INFO - PROCESS | 31297 | _x_x_mozilla_page_load 10:16:25 INFO - PROCESS | 31297 | _x_x_mozilla_page_load_details 10:16:25 INFO - PROCESS | 31297 | |i|pagename|runs| 10:16:25 INFO - PROCESS | 31297 | |0;ai-astar;104;115;116;115;114;114;113;114;115;115 10:16:25 INFO - PROCESS | 31297 | |1;audio-beat-detection;155;121;123;166;129;123;152;123;195;123 10:16:25 INFO - PROCESS | 31297 | |2;audio-dft;161;161;162;161;161;163;163;162;161;167 10:16:25 INFO - PROCESS | 31297 | |3;audio-fft;76;75;76;104;76;77;76;75;105;76 10:16:25 INFO - PROCESS | 31297 | |4;audio-oscillator;86;87;120;85;86;84;119;85;86;134 10:16:25 INFO - PROCESS | 31297 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 10:16:25 INFO - PROCESS | 31297 | |6;imaging-darkroom;146;146;146;148;146;146;146;146;145;146 10:16:25 INFO - PROCESS | 31297 | |7;imaging-desaturate;95;95;96;95;94;95;95;95;95;95 10:16:25 INFO - PROCESS | 31297 | |8;json-parse-financial;64;67;63;64;64;65;67;65;64;66 10:16:25 INFO - PROCESS | 31297 | |9;json-stringify-tinderbox;67;66;66;66;66;66;67;67;66;71 10:16:25 INFO - PROCESS | 31297 | |10;stanford-crypto-aes;79;79;79;78;78;89;79;78;78;81 10:16:25 INFO - PROCESS | 31297 | |11;stanford-crypto-ccm;128;133;130;127;130;130;136;131;180;138 10:16:25 INFO - PROCESS | 31297 | |12;stanford-crypto-pbkdf2;164;168;169;167;167;167;163;166;167;161 10:16:25 INFO - PROCESS | 31297 | |13;stanford-crypto-sha256-iterative;65;67;66;66;68;66;67;66;65;65 10:16:25 INFO - PROCESS | 31297 | __end_tp_report 10:16:25 INFO - PROCESS | 31297 | __start_cc_report 10:16:25 INFO - PROCESS | 31297 | _x_x_mozilla_cycle_collect,1954 10:16:25 INFO - PROCESS | 31297 | __end_cc_report 10:16:25 INFO - PROCESS | 31297 | __startTimestamp1468948585092__endTimestamp 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | ------- Summary: start ------- 10:16:25 INFO - PROCESS | 31297 | Number of tests: 14 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.44 (3.0%) stddev-sans-first:0.88 10:16:25 INFO - PROCESS | 31297 | Values: 104.0 115.0 116.0 115.0 114.0 114.0 113.0 114.0 115.0 115.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:140.50 stddev:25.16 (17.9%) stddev-sans-first:26.17 10:16:25 INFO - PROCESS | 31297 | Values: 155.0 121.0 123.0 166.0 129.0 123.0 152.0 123.0 195.0 123.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.87 (1.2%) stddev-sans-first:1.94 10:16:25 INFO - PROCESS | 31297 | Values: 161.0 161.0 162.0 161.0 161.0 163.0 163.0 162.0 161.0 167.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.08 (15.9%) stddev-sans-first:12.65 10:16:25 INFO - PROCESS | 31297 | Values: 76.0 75.0 76.0 104.0 76.0 77.0 76.0 75.0 105.0 76.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.50 stddev:19.15 (22.4%) stddev-sans-first:19.88 10:16:25 INFO - PROCESS | 31297 | Values: 86.0 87.0 120.0 85.0 86.0 84.0 119.0 85.0 86.0 134.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:16:25 INFO - PROCESS | 31297 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:16:25 INFO - PROCESS | 31297 | Values: 146.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 145.0 146.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:16:25 INFO - PROCESS | 31297 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.41 10:16:25 INFO - PROCESS | 31297 | Values: 64.0 67.0 63.0 64.0 64.0 65.0 67.0 65.0 64.0 66.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.64 10:16:25 INFO - PROCESS | 31297 | Values: 67.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 71.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:3.36 (4.3%) stddev-sans-first:3.55 10:16:25 INFO - PROCESS | 31297 | Values: 79.0 79.0 79.0 78.0 78.0 89.0 79.0 78.0 78.0 81.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:132.00 stddev:15.73 (11.9%) stddev-sans-first:16.39 10:16:25 INFO - PROCESS | 31297 | Values: 128.0 133.0 130.0 127.0 130.0 130.0 136.0 131.0 180.0 138.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:167.00 stddev:2.47 (1.5%) stddev-sans-first:2.52 10:16:25 INFO - PROCESS | 31297 | Values: 164.0 168.0 169.0 167.0 167.0 167.0 163.0 166.0 167.0 161.0 10:16:25 INFO - PROCESS | 31297 | 10:16:25 INFO - PROCESS | 31297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 10:16:25 INFO - PROCESS | 31297 | Values: 65.0 67.0 66.0 66.0 68.0 66.0 67.0 66.0 65.0 65.0 10:16:25 INFO - PROCESS | 31297 | -------- Summary: end -------- 10:16:25 INFO - PROCESS | 31297 | 10:16:26 INFO - TEST-INFO | 31297: exit 0 10:16:26 INFO - TEST-OK | kraken | took 63575ms 10:16:26 INFO - SUITE-END | took 1183s 10:16:26 INFO - Completed test suite (00:19:43) 10:16:26 INFO - javascript benchmark 10:16:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.2252635472532, 2641.2736497463184, 2665.8800353984075, 2682.919512414628, 2688.448867982064, 4681.508441613632, 4711.505291944348, 4759.167145749498, 4795.688280261785, 4830.130576496229, 4707.929381059287, 4723.574878260956, 4738.005018946017, 4778.665493415462, 4783.952160478394, 4150.273702102135, 4314.935275970855, 4416.381706561084, 4439.88900277494, 4497.595216430521, 4416.094700586372, 4418.9337159942625, 4453.465584129909, 4466.151431228072, 4488.102379524092, 4216.494020717503, 4266.957330426687, 4330.848420305306, 4353.325234588644, 4407.559244075599, 4322.697411181219, 4334.653227741773, 4386.407834942306, 4399.142167277382, 4408.360787685768, 4398.494173170095, 4403.757793321366, 4406.25093734066, 4409.823607055714, 4435.467743870724, 4591.701539399962, 4653.395058642389, 4774.111662444206, 4779.163646361872, 4781.569658730697, 5130.07658621448, 5172.870678233036, 5204.68771873685, 5209.609279304067, 5210.843674689765, 5015.924761128586, 5147.176451767699, 5173.120569503193, 5181.300524429192, 5188.7146206958605, 4744.881377965544, 4813.711177329372, 4816.012717392926, 4863.708177509361, 4878.756062196876, 5326.174442961347, 5352.223927530564, 5356.5982551308025, 5358.062339090644, 5361.08861493547, 4881.243407271879, 4953.6037117030555, 4993.7503124843615, 5033.345665063518, 5040.521150490697, 4999.500049994971, 5056.797728090909, 5060.645754797129, 5061.240813877874, 5087.720175390315, 5024.070546948826, 5030.8239211627415, 5031.84904452867, 5039.168537191395, 5075.746212689351, 4964.05682920244, 5026.1204289249235, 5029.0947629427055, 5033.446320904697, 5035.244713292962, 4396.1867054595, 4398.692091553625, 4417.889552761142, 4454.844080457233, 4459.799309031101, 3819.8472061117245, 3836.9424458633143, 3840.807959602009, 3845.0, 3879.7478163919254, 4325.5674432557125, 4384.254676704968, 4385.166818304512, 4439.889002774957, 4474.507804141542, 5155.02054609623, 5168.250603662448, 5185.170372740344, 5186.844394668166, 5188.11801993662, 4443.644508439317, 4444.2444784386735, 4445.533219012022, 4481.977590112094, 4488.416505854283, 4482.081173359518, 4546.5453454654935, 4577.931331030038, 4583.862484125481, 4690.0, 4751.073540659539, 4759.881002974884, 4766.880827979328, 4768.284757286296, 4816.494268101939, 5064.670796398223, 5076.137056700296, 5077.365329333833, 5081.136206844919, 5126.333576635014, 4630.097131059411, 4717.716936983792, 4720.244760838249, 4769.904601907873, 4790.4251489821445, 4996.975015124901, 5000.524950129878, 5005.074061298671, 5009.448960614257, 5059.747012649426, 5056.974715126548, 5072.543471087472, 5078.695278283315, 5085.338905942203, 5128.897422051613, 4829.082474329866, 4832.613390928647, 4944.307796908363, 5005.524475174852, 5029.119904016856, 4996.125678006407, 5033.672811267256, 5039.067772462106, 5044.8234311798915, 5088.313077734459, 4799.688020278671, 4945.604351651931, 4959.82640607577, 4979.900401992012, 5020.297158397754, 4888.144574699484, 4927.556519913225, 4935.136351138608, 4946.134426475424, 4957.975210123926, 4826.686265392738, 4844.515548445127, 4854.101991131652, 4864.552855237861, 4905.068037072945], "value": 4685.369175740148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0255376075714, 594.8007417515132, 600.4415893219306, 611.4649681528663, 614.5452365249714, 26473.338166545847, 28099.157025289223, 28158.29604259892, 39375.803120984354, 40738.7963060185, 40681.38977915334, 40939.385909211385, 40985.7950710246, 41027.58972410275, 41156.38265426014, 7774.727884524029, 7881.369490440751, 7887.0, 7919.802004949865, 7923.603819808986, 7547.924520754777, 7736.845263094735, 7741.729039483619, 7760.262775036391, 7942.602869856513, 9992.200623950102, 10263.0, 10269.383836969768, 10548.630797922075, 10599.735006624858, 10162.339447935861, 10219.029192226726, 10244.487775611264, 10255.897441025569, 10264.435456049914, 7569.545827250327, 7779.611019449005, 7781.494202876795, 9982.750431239205, 10037.34757240777, 33745.0, 34425.82787086074, 34501.82749086263, 36971.0, 36974.26051478955, 2946.3665311958034, 3004.474217012036, 3130.9060728177965, 3133.279345750467, 3176.6029246344206, 28844.567331490045, 29217.85391073031, 29481.262968425963, 29591.70408295911, 29852.70147298521, 3335.4830001349587, 3453.4819777033645, 3502.964970350289, 3528.541289632357, 3577.5528058992627, 260972.0, 263335.0, 263616.0, 263869.68065159745, 264699.0, 46599.767001165455, 48126.75936620295, 53117.468825312026, 55396.0, 55457.44542554523, 57033.42966570281, 57085.143722844194, 57184.42815571874, 57211.713941430025, 57284.14073788896, 14338.139711617336, 14437.711245775026, 14445.711085778226, 14449.422023119168, 14452.494162704255, 11309.49107290174, 11344.0, 11350.205485615928, 11356.94321528387, 11364.488598012944, 16240.187990600423, 17213.483595492155, 17766.0, 18180.727289090675, 18312.542186445444, 6939.410150137194, 7073.398761105261, 7089.89365159523, 7098.503104782616, 7123.572585644878, 841.381584535366, 955.2310390136007, 971.4802580619335, 1013.7820368620781, 1027.219313321866, 28386.71613283882, 28571.71428285732, 28609.85695071511, 28709.0, 28876.0, 958.5782255807422, 969.7963427680266, 973.6786860336072, 979.1677074486629, 1015.9034891685278, 14709.338079786436, 14918.850811491746, 15048.548543543711, 15131.0, 15211.543653690407, 406432.0, 408305.0, 409980.0, 410388.0, 410394.0, 46291.0, 46917.29624055642, 46948.06103877904, 46959.0, 46984.765076175085, 1114.3815182573587, 1114.8773634900153, 1124.3591153042687, 1188.869224385317, 1232.9568465103678, 22831.429214269778, 27702.861485692443, 29083.41833163367, 29171.124866254046, 29655.25861853471, 46179.3073103897, 46867.53132468768, 46965.2955205679, 46999.295010574184, 47058.29412558883, 363051.0, 366446.0, 368203.0, 368549.0, 368853.0, 32011.35977280395, 37161.14849308553, 38426.807865960494, 38640.6135938637, 38714.80642596769, 32181.678183218806, 42926.570734292254, 43157.56842431661, 46508.53491465042, 47536.286955695, 34383.0, 35314.46855314551, 35697.643023569435, 35795.463068053476, 35905.64094359127, 36105.458418124275, 36458.0, 36747.26505469929, 36914.63085369112, 36985.26029479449, 36051.819740901126, 36247.0, 36380.090497737765, 37236.441453378764, 37295.25409491849, 30244.0, 32519.58544352809, 32569.185770354983, 32983.67016329806, 33099.83450082734, 24936.750632494168, 25075.0, 25360.74639253584, 25533.3616659585, 25843.870780645975], "value": 18141.71958093971, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1064101476963, 375.6600276749541, 380.8057890475857, 384.4636731759198, 386.19863782650987, 16251.91874040631, 17435.82564174358, 17878.910605446956, 18305.633887322278, 18375.90812045941, 16674.166291685397, 17026.82973170268, 17139.82860171398, 17417.651646967086, 17433.738493922603, 4900.142475066867, 5116.948830511685, 5131.846044618667, 5132.255822905695, 5132.5124113209185, 3815.5993620669847, 3999.1401848602545, 5050.520200580957, 6027.246594175728, 6034.8793024139495, 6049.092636104598, 6065.332813390545, 6068.635881847081, 6090.116933044706, 6094.055421409666, 5732.369439361667, 5927.644341339534, 5953.642781433128, 5954.612950158247, 6059.818205453821, 5230.006298803215, 5235.39792923811, 5235.869103272448, 5238.240455133984, 5243.4232234454175, 20431.79568204314, 21035.8948205258, 21317.360479185496, 21482.0, 21514.247001355034, 1961.1763059515038, 1963.6465436221474, 1980.6038792241466, 1992.8505362097756, 2017.9899100504404, 12999.545015924397, 13307.135036222615, 13543.729125417534, 13657.453701851913, 13967.65080872976, 1621.6999855026859, 1730.4376077774773, 1807.557148498613, 1815.8442087079065, 1824.2064701854604, 48554.51445485535, 51099.0, 61055.0, 69350.0, 69993.0, 9603.615855365708, 9662.806743865083, 9731.172850307661, 9812.0, 9933.552990115462, 13267.933660331637, 13369.131006484742, 13371.264580447974, 13376.598702038955, 13377.130486518345, 7453.403727701771, 7483.962580187173, 7591.620418979029, 7630.122535908331, 7642.5032372895585, 7641.617919104023, 7687.65647409212, 7714.652840622185, 7739.148693643695, 7811.45319827618, 6002.489788368038, 6014.428629280212, 6082.60463069899, 6139.066426578514, 6190.0714892765545, 1707.812140664526, 1737.2616637929082, 1747.8776485645883, 1756.9912150439166, 1813.4740925131564, 791.3748138970265, 908.9636414543477, 930.5951910918772, 932.8554074118523, 976.0629795396356, 17157.142142892804, 18078.00570968583, 18241.543961401072, 18353.63292734138, 18619.441416757247, 850.2177996243471, 853.3216093205916, 866.3366336633678, 879.2702057292432, 921.4517362169498, 10047.0, 10072.546735396925, 10356.896431035593, 10364.844527332096, 10495.160387169008, 390210.0, 393941.0, 394340.0, 395128.0, 425980.0, 47614.523854761705, 49743.75128124336, 52413.7379313101, 84643.0, 86434.0, 417.2364572831711, 435.51875177927934, 437.5427678076418, 438.31185039487696, 439.0253636926019, 9350.20693570801, 9708.368956017835, 9941.0, 10122.8481572775, 10216.846747298945, 38047.239055219296, 38214.23571528498, 38308.0, 38585.421218682306, 38672.80663596664, 50303.245451318995, 53546.0, 53554.0, 53594.73202633962, 53656.463435366706, 7770.206790153881, 7788.454808163374, 7790.14308426084, 7945.801354966172, 8018.518888866687, 11079.501422436171, 11895.22681025765, 12162.756744864877, 12177.391130443619, 12268.693282668004, 10217.693469195936, 10270.6405275815, 10328.741781455223, 10405.375677459377, 10670.946645266724, 10134.543945522322, 10193.23550733683, 10445.216608754221, 10561.947190264, 10736.30214036085, 10462.319949203278, 10505.0, 10626.73433164177, 10739.033486986209, 10824.242303039027, 7009.228984811769, 7077.82305442368, 7327.63361831917, 7873.488223265469, 7961.72133975308, 9924.801503970024, 10195.490225488844, 10261.435621040915, 10309.793804124025, 10340.431276279876], "value": 8179.356976744168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.678983464299, 1361.7276544691058, 1410.2596137028058, 1448.6523234423735, 1663.925123369449, 6589.802305930823, 7603.277688619586, 7810.687572497093, 7853.057633084024, 8038.598070096501, 7850.332721718646, 7878.290953814156, 7959.323457506119, 7964.6017699114955, 7968.9601551992155, 2162.7080344153496, 2174.1303478608525, 2176.9020394082227, 2190.2443656938412, 2194.297824696098, 2135.1032566322106, 2160.0171921775554, 2171.0772921508374, 2173.576152650234, 2173.706549615805, 2158.233826991419, 2159.157928407922, 2161.6325224711836, 2163.653815389538, 2221.8444708870384, 2094.6229678657837, 2099.128861522466, 2099.2757498663013, 2102.2852230241792, 2102.9579408411823, 2074.118499637648, 2144.120910426733, 2144.142343062772, 2145.2598853395552, 2149.0544160569298, 7726.072871255429, 7942.3646108311195, 7953.721619743281, 8013.799655008613, 8025.438219324649, 4482.977585112054, 4652.418447694038, 4671.836485723017, 4682.274247491644, 4682.438107427097, 2826.505361561739, 2888.277930517371, 2919.168037109435, 2927.956080658792, 2929.26768307923, 906.5784410249265, 914.1087439746261, 921.9124183202586, 921.9400738952014, 923.4182465046978, 10869.83695244572, 10982.0, 10982.231243812936, 11016.06363459107, 11023.283486573348, 3888.5528164260904, 3995.06116062725, 4095.4266402703647, 4103.466549348565, 4110.301248787653, 8591.0, 8643.697470588499, 8649.524276164871, 8656.177663121993, 8656.394052416397, 4592.540745925381, 4592.977035114803, 4599.356090147382, 4600.470945841271, 4605.148047611136, 3756.3050835595504, 4183.811728472226, 4204.831806727758, 4206.663466922639, 4309.41822853917, 3500.5099286099967, 3501.0, 3561.5191949086543, 3594.0655429588496, 3594.8022858742497, 1057.2704833664748, 1082.7942690888706, 1088.548252475214, 1094.1520321750547, 1095.1457862866976, 784.4116912315764, 868.7914900423852, 879.907609700985, 881.3742243007537, 912.7033714042963, 5410.1343784994215, 5445.918311225335, 5559.082751345983, 5690.516306113944, 5851.707414629337, 831.6091437024588, 842.7387509871959, 915.1077699243318, 937.4515908193783, 968.080323692495, 3764.3976963686227, 3804.5814960354337, 3829.463875057494, 3933.095388060762, 3948.9535273152637, 9661.565229564687, 9857.55640996157, 9913.752156196153, 9966.800663986825, 9979.201663866874, 9836.852447213298, 9839.704808855746, 9849.655262065937, 9852.704418867446, 9854.852177217348, 7306.415486761046, 7437.85124297511, 7457.067866516685, 7457.403407727369, 7460.0, 5426.64726792773, 5501.834944951658, 5575.0522411191005, 5657.066584013756, 5812.800063484533, 8731.25784308341, 9025.548722563977, 9114.906211254427, 9117.7264682057, 9121.635134594808, 8989.235914947303, 9047.366684332033, 9108.863367049633, 9274.118958698913, 9293.907060929574, 6120.540959427972, 6454.19322584677, 6883.690233939385, 6909.827254318682, 7032.26161253061, 7708.8072798178255, 7721.536707797325, 7809.843803123792, 7810.414218933489, 7813.531188128731, 6774.71540438873, 6974.37230649244, 7032.824179395556, 7055.400290975119, 7057.682404291717, 6675.632840193836, 6699.363560461748, 6880.621565813728, 6968.442524597918, 7026.0, 6261.749530018748, 6643.335666433318, 6665.66671666405, 6716.597004179765, 6716.764913228014, 4689.437267527782, 4772.49888761675, 4777.235642297216, 4878.682885612566, 4894.646387379348, 4834.564889159992, 4886.120498310338, 4926.211806111005, 4931.950680493149, 5003.924941125959], "value": 4181.162466542732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8545412747754, 300.4801693070987, 301.5958615455289, 304.1620335974392, 307.7753240134703, 4749.50130236325, 4753.241300718731, 4754.524547545244, 4764.118638051958, 4769.54689304516, 4721.197396442604, 4723.244280915054, 4724.952750472494, 4731.455882573505, 4733.337332773414, 3600.5679318481752, 3662.8168591570447, 3688.340246888897, 3764.247150569883, 3788.6590206881374, 3739.8317075731657, 3758.267137908109, 3776.433534969749, 3777.0557360659836, 3789.9810500947456, 3562.92874142517, 3730.0, 3745.5879853216125, 3745.7565258258264, 3748.4189950557707, 3624.3294990426725, 3726.347889119393, 3741.4574886641285, 3744.2137151198144, 3744.588095309514, 3305.5206994985833, 3317.4857897026, 3320.468725003988, 3330.783499072577, 3332.7667063305335, 4607.7004994675235, 4618.930716039262, 4620.884477888046, 4623.537646235383, 4625.976870115662, 4162.252913077385, 4215.0, 4222.831086756526, 4235.9364609530885, 4260.297050986584, 4910.558049775502, 4949.257611358289, 4950.4307004694565, 4954.43024052235, 4957.256411538262, 3568.4290513517712, 3577.4438119418137, 3577.588577313616, 3578.2664553766676, 3585.4980302757635, 4910.410750709902, 5176.352955880515, 5189.455107213764, 5191.922121168185, 5193.2989046479, 3732.5894151643297, 3735.906602334909, 3737.177820879402, 3740.0275928258848, 3747.6439738224826, 3775.7923314217983, 3779.4708740776314, 3780.9621903781162, 3800.7005761513888, 3803.980980095137, 4246.63903568194, 4274.478057945827, 4279.6091270337265, 4283.421738065322, 4283.807228674717, 4697.31888876111, 4996.2505624156665, 5000.799968001239, 5007.824726134568, 5009.649324547247, 1273.4778740716263, 1280.257450678604, 1282.9486820527075, 1283.3775618824861, 1285.2930888011556, 808.9029316481942, 820.5938060660012, 845.218173189797, 863.9524826134623, 875.0024971532458, 4331.978340108342, 4358.106588149485, 4362.629176520031, 4368.432103826546, 4379.605835474823, 4981.252812078217, 4985.152524070917, 4987.750612469362, 4999.275105109738, 5066.392032956069, 4254.702170848011, 4354.368616550646, 4379.430674012358, 4385.605295523418, 4390.62679672225, 2676.8260063095836, 2682.316009417586, 2689.300781796747, 2700.824446410977, 2713.186044186736, 4787.8563643090765, 4792.664513484093, 4795.976020119947, 4796.352492413549, 4797.352357431702, 4942.777575009133, 5098.9490105098475, 5128.7179205144075, 5154.716490593053, 5172.663776854492, 4736.881577960578, 4778.187708089564, 4782.736949467743, 4787.305840653085, 4790.760461976887, 4992.079633414493, 5022.899542009066, 5024.271480635361, 5026.52248036436, 5048.217526283432, 4773.331733557236, 4884.92672609904, 4921.753912304442, 4925.0, 5058.772355243949, 4831.637627177905, 4848.12733707936, 4851.417829860439, 4871.878203044952, 4882.0, 3622.2755448910852, 3631.2192878530186, 3635.745497815233, 3643.5992040876013, 3654.543182102237, 5052.292679025013, 5181.715005674724, 5184.196449550326, 5190.403103642979, 5195.5583775378, 4999.925001125059, 5011.724355160355, 5029.27075574047, 5043.747812609428, 5070.670406423571, 5010.949890501049, 5014.398272207359, 5020.569137795711, 5023.447420783637, 5027.3464449621315, 4742.407199100113, 4932.202204302595, 4944.233643785219, 4944.505549445027, 4954.455009948975, 4828.782704778223, 4888.340074089952, 5014.044522636248, 5030.673006254582, 5034.219695947134, 4896.36347274852, 4907.043126590281, 4913.238448040559, 4914.164592019294, 4919.401194611694], "value": 3758.8470165678473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.7707513832588, 669.2805234373047, 685.9416949559287, 738.9593572353518, 745.6569977810209, 11616.825747613782, 12171.57399491018, 12211.877881221197, 12230.266184028953, 12236.510539578407, 12412.676520852696, 12448.37758112093, 12485.375731213426, 12506.187097838634, 12584.685382865433, 605.6003037994924, 772.8145245141168, 785.5954183595453, 787.0240901282398, 788.7594283743456, 744.5904752386193, 772.6909236305466, 775.3022279948035, 779.07679399911, 779.8011507065719, 817.9141190175035, 819.778659761864, 820.0364571628343, 820.2781552234026, 820.983580328393, 640.810960766575, 784.7214238945149, 807.6971135824066, 809.8137428391444, 810.7000409848364, 594.1859652276408, 594.6194435561245, 597.2415032908226, 597.3667912013279, 598.3119412675414, 12741.936290318581, 12744.299063551502, 12745.681357966032, 12749.808752868714, 12754.489820407172, 12355.32045737484, 13022.348882555929, 13036.859574255772, 13087.280199589019, 13231.221918948197, 11965.700857478632, 12131.757364852741, 12157.209781364183, 12198.0, 12443.502259909592, 4154.293770059097, 4195.622393984556, 4207.453031105937, 4213.789310534461, 4219.852305169305, 61366.386336136515, 61655.38344616586, 61705.0, 62130.68934655298, 62587.37412625861, 10358.274920755475, 10372.377657340583, 10560.788784224273, 10626.309289896131, 10962.451877406098, 19034.428967131007, 19088.80911190898, 19092.522686932938, 19095.427137185907, 19129.33047343336, 6950.478714096362, 7095.858082838315, 7115.719170549351, 7132.857342853114, 7144.678489467987, 3703.703703703697, 3706.5737440194184, 3841.2509560635967, 3878.9224215515533, 3919.294526985113, 2662.9067982620513, 2734.8632568371504, 2745.368565229968, 2746.6841313249233, 2757.379589592326, 502.53264464048783, 510.19134671545277, 534.3054029761295, 542.5957661542176, 544.599719206383, 569.1491220625192, 598.5869749872573, 613.7238242790762, 614.7940439952577, 626.692920468976, 8237.176282371835, 8330.375221858385, 8391.95804020976, 8492.787680307918, 8586.31309495239, 610.5603965145089, 611.7277811373984, 613.3804857094367, 617.3363634093367, 618.5515501261549, 3869.400242962345, 3987.6809855211513, 4028.1138149607627, 4043.7071303238413, 4077.5350990665174, 104904.0, 106353.0, 107096.0, 108406.0, 109068.0, 93331.53334233286, 94217.52891235637, 94822.0, 94922.52538737262, 94976.0, 80843.0, 83628.0, 84034.0, 85044.0, 86337.56831215804, 6793.116894803644, 7404.259574042552, 7476.962615186889, 7505.587192704454, 7844.254795794391, 42355.7882210587, 43243.56756432395, 43547.0, 44523.0, 47354.0, 64028.67985660042, 66345.66827165833, 66372.0, 67346.0, 67539.66230168818, 9474.478903660365, 9509.619615215313, 9517.524123793644, 9530.378456186605, 9570.0, 10784.514696838503, 10878.401687906924, 11091.833622495507, 11233.887661123284, 11344.035756960751, 10721.571137154426, 10761.784764304826, 10937.179711521509, 11079.00288973964, 11990.340531270864, 12242.571509997108, 12316.384180790745, 12754.744905102032, 13104.0, 13231.206127632373, 12294.262344259372, 12573.87426125727, 12999.350032498527, 13003.414846332127, 13141.145825521311, 9294.767630809014, 9376.0, 9713.70858874235, 9929.801403972024, 9975.052370024836, 9493.620255189991, 9507.952460237932, 9943.950280248553, 10063.849042264519, 10106.585078088927], "value": 6639.050139305215, "unit": "score"}], "name": "dromaeo_css", "value": 6458.153355450171, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 116.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 123.0, 166.0, 129.0, 123.0, 152.0, 123.0, 195.0, 123.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 163.0, 162.0, 161.0, 167.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 104.0, 76.0, 77.0, 76.0, 75.0, 105.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 120.0, 85.0, 86.0, 84.0, 119.0, 85.0, 86.0, 134.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 63.0, 64.0, 64.0, 65.0, 67.0, 65.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 71.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 78.0, 89.0, 79.0, 78.0, 78.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 130.0, 127.0, 130.0, 130.0, 136.0, 131.0, 180.0, 138.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 169.0, 167.0, 167.0, 167.0, 163.0, 166.0, 167.0, 161.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 68.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1533.1999999999998, "alertThreshold": 2.0}]} 10:16:26 INFO - Return code: 0 10:16:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:26 INFO - # TBPL SUCCESS # 10:16:26 INFO - Running post-action listener: _resource_record_post_action 10:16:26 INFO - ##### 10:16:26 INFO - ##### Finished run-tests step (success) 10:16:26 INFO - ##### 10:16:26 INFO - Running post-run listener: _resource_record_post_run 10:16:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544825344; Read time: 8; Write time: 504032 10:16:26 INFO - TinderboxPrint: CPU usage
13.0% 10:16:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:16:26 INFO - TinderboxPrint: I/O write bytes / time
544,825,344 / 504,032 10:16:26 INFO - TinderboxPrint: CPU idle
8,335.0 (87.0%) 10:16:26 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 10:16:26 INFO - TinderboxPrint: Swap in / out
0 / 0 10:16:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256909312; Read time: 0; Write time: 268700 10:16:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287916032; Read time: 0; Write time: 235332 10:16:27 INFO - Running post-run listener: _upload_blobber_files 10:16:27 INFO - Blob upload gear active. 10:16:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:27 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 10:16:27 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'] 10:16:27 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 10:16:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:37 INFO - (blobuploader) - INFO - Done attempting. 10:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:38 INFO - (blobuploader) - INFO - Done attempting. 10:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:38 INFO - (blobuploader) - INFO - Done attempting. 10:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:38 INFO - Return code: 0 10:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f5c1ef5ed4da5ea02d9e3f9588580b334b18db819df3f7b703d364287673c6a50c5993c0816e6935200d9e182d80eca8e626ddd828c14da818deca8c243c264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acc7fba549b36366b3182cfc1644e455507f62ffc2fc3930bce4bd93d0cbc54238d9885069cad8d0a2bfe1da2bdc9f469540ec1b1f9a100f7b02986a5eb6d861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c92ee9019848d565c763e0e090be4aeadb6653164e359d157172637eadfee5e4ea5d94302ece5b8d2337e3fa362e7acba8c0f0f6a9cee044bc13e16b0042667"} 10:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:38 INFO - Contents: 10:16:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f5c1ef5ed4da5ea02d9e3f9588580b334b18db819df3f7b703d364287673c6a50c5993c0816e6935200d9e182d80eca8e626ddd828c14da818deca8c243c264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acc7fba549b36366b3182cfc1644e455507f62ffc2fc3930bce4bd93d0cbc54238d9885069cad8d0a2bfe1da2bdc9f469540ec1b1f9a100f7b02986a5eb6d861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c92ee9019848d565c763e0e090be4aeadb6653164e359d157172637eadfee5e4ea5d94302ece5b8d2337e3fa362e7acba8c0f0f6a9cee044bc13e16b0042667"} 10:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:38 INFO - Copying logs to upload dir... 10:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.327839 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-19 10:16:38.150778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 10:16:38.154646) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 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/4f5c1ef5ed4da5ea02d9e3f9588580b334b18db819df3f7b703d364287673c6a50c5993c0816e6935200d9e182d80eca8e626ddd828c14da818deca8c243c264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acc7fba549b36366b3182cfc1644e455507f62ffc2fc3930bce4bd93d0cbc54238d9885069cad8d0a2bfe1da2bdc9f469540ec1b1f9a100f7b02986a5eb6d861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c92ee9019848d565c763e0e090be4aeadb6653164e359d157172637eadfee5e4ea5d94302ece5b8d2337e3fa362e7acba8c0f0f6a9cee044bc13e16b0042667"} build_url:https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/KaDy6zbrTaG8uF_t44HoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f5c1ef5ed4da5ea02d9e3f9588580b334b18db819df3f7b703d364287673c6a50c5993c0816e6935200d9e182d80eca8e626ddd828c14da818deca8c243c264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acc7fba549b36366b3182cfc1644e455507f62ffc2fc3930bce4bd93d0cbc54238d9885069cad8d0a2bfe1da2bdc9f469540ec1b1f9a100f7b02986a5eb6d861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c92ee9019848d565c763e0e090be4aeadb6653164e359d157172637eadfee5e4ea5d94302ece5b8d2337e3fa362e7acba8c0f0f6a9cee044bc13e16b0042667"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 10:16:38.180034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 10:16:38.180379) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468947198.836298-767928186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 10:16:38.262167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 10:16:38.262493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 10:16:38.262789) ========= ========= Total master_lag: 0.39 =========