builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1474563345.96 results: success (0) buildid: 20160922092943 builduid: b764f4a7eb5d47c68926162b1c6e6f82 revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:45.961546) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:45.961984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:45.962268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:45.976696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:45.976978) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 09:55:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-09-22 09:55:46 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.070903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.071318) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013821 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.120919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.121269) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f0e6cc6360213ba21fd98c887b55fce5c680df68 --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 f0e6cc6360213ba21fd98c887b55fce5c680df68 --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=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 09:55:47,054 truncating revision to first 12 chars 2016-09-22 09:55:47,054 Setting DEBUG logging. 2016-09-22 09:55:47,054 attempt 1/10 2016-09-22 09:55:47,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f0e6cc636021?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 09:55:47,365 unpacking tar archive at: fx-team-f0e6cc636021/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.786132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.786465) ========= script_repo_revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.786846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.787107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 09:55:46.796324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-22 09:55:46.796588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:55:47 INFO - MultiFileLogger online at 20160922 09:55:47 in /builds/slave/test 09:55:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:55:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:47 INFO - {'append_to_log': False, 09:55:47 INFO - 'base_work_dir': '/builds/slave/test', 09:55:47 INFO - 'blob_upload_branch': 'Fx-Team', 09:55:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:47 INFO - 'branch': 'Fx-Team', 09:55:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:47 INFO - 'config_files': ('talos/linux_config.py',), 09:55:47 INFO - 'default_actions': ('clobber', 09:55:47 INFO - 'read-buildbot-config', 09:55:47 INFO - 'download-and-extract', 09:55:47 INFO - 'populate-webroot', 09:55:47 INFO - 'create-virtualenv', 09:55:47 INFO - 'install', 09:55:47 INFO - 'run-tests'), 09:55:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:47 INFO - 'download_minidump_stackwalk': True, 09:55:47 INFO - 'download_symbols': 'ondemand', 09:55:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:47 INFO - 'installer_path': 'installer.exe', 09:55:47 INFO - 'log_level': 'info', 09:55:47 INFO - 'log_name': 'talos', 09:55:47 INFO - 'log_to_console': True, 09:55:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:55:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:55:47 INFO - 'opt_config_files': (), 09:55:47 INFO - 'pip_index': False, 09:55:47 INFO - 'sps_profile': False, 09:55:47 INFO - 'sps_profile_interval': 0, 09:55:47 INFO - 'suite': 'dromaeojs', 09:55:47 INFO - 'system_bits': '32', 09:55:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:47 INFO - 'title': 'talos-linux64-ix-055', 09:55:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:47 INFO - 'use_talos_json': True, 09:55:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:47 INFO - 'work_dir': 'build'} 09:55:47 INFO - [mozharness: 2016-09-22 16:55:47.826652Z] Running clobber step. 09:55:47 INFO - Running pre-action listener: _resource_record_pre_action 09:55:47 INFO - Running main action method: clobber 09:55:47 INFO - rmtree: /builds/slave/test/build 09:55:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:48 INFO - Running post-action listener: _resource_record_post_action 09:55:48 INFO - [mozharness: 2016-09-22 16:55:48.845161Z] Finished clobber step (success) 09:55:48 INFO - [mozharness: 2016-09-22 16:55:48.845262Z] Running read-buildbot-config step. 09:55:48 INFO - Running pre-action listener: _resource_record_pre_action 09:55:48 INFO - Running main action method: read_buildbot_config 09:55:48 INFO - Using buildbot properties: 09:55:48 INFO - { 09:55:48 INFO - "project": "", 09:55:48 INFO - "product": "firefox", 09:55:48 INFO - "script_repo_revision": "production", 09:55:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:55:48 INFO - "repository": "", 09:55:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:55:48 INFO - "buildid": "20160922092943", 09:55:48 INFO - "stage_platform": "linux64-pgo", 09:55:48 INFO - "basedir": "/builds/slave/test", 09:55:48 INFO - "buildnumber": 469, 09:55:48 INFO - "platform": "ubuntu64_hw", 09:55:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:55:48 INFO - "slavebuilddir": "test", 09:55:48 INFO - "branch": "fx-team", 09:55:48 INFO - "revision": "f0e6cc6360213ba21fd98c887b55fce5c680df68", 09:55:48 INFO - "slavename": "talos-linux64-ix-055", 09:55:48 INFO - "builduid": "b764f4a7eb5d47c68926162b1c6e6f82", 09:55:48 INFO - "repo_path": "integration/fx-team" 09:55:48 INFO - } 09:55:48 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:55:48 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 09:55:48 INFO - Running post-action listener: _resource_record_post_action 09:55:48 INFO - [mozharness: 2016-09-22 16:55:48.847663Z] Finished read-buildbot-config step (success) 09:55:48 INFO - [mozharness: 2016-09-22 16:55:48.847754Z] Running download-and-extract step. 09:55:48 INFO - Running pre-action listener: _resource_record_pre_action 09:55:48 INFO - Running main action method: download_and_extract 09:55:48 INFO - mkdir: /builds/slave/test/build/tests 09:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:48 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:55:48 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:55:48 INFO - Downloaded 1361 bytes. 09:55:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:55:48 INFO - Using the following test package requirements: 09:55:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:55:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:55:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'jsshell-linux-x86_64.zip'], 09:55:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:55:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:55:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:55:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:55:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:55:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:55:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:55:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:55:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:55:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:55:48 INFO - Expected file size: 21943973 09:55:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:55:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:55:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:55:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:55:53 INFO - Expected file size: 21943973 09:55:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:55:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:55:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:55:58 INFO - Expected file size: 14414059 09:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:58 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:55:58 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:55:59 INFO - Downloaded 59609451 bytes. 09:55:59 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:55:59 INFO - mkdir: /builds/slave/test/properties 09:55:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:59 INFO - Contents: 09:55:59 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:55:59 INFO - Running post-action listener: _resource_record_post_action 09:55:59 INFO - Running post-action listener: set_extra_try_arguments 09:55:59 INFO - [mozharness: 2016-09-22 16:55:59.845977Z] Finished download-and-extract step (success) 09:55:59 INFO - [mozharness: 2016-09-22 16:55:59.846207Z] Running populate-webroot step. 09:55:59 INFO - Running pre-action listener: _resource_record_pre_action 09:55:59 INFO - Running main action method: populate_webroot 09:55:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:59 INFO - '--tppagecycles', 09:55:59 INFO - '7'], 09:55:59 INFO - 'tests': ['tsvgm']}}, 09:55:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:55:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:55:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['damp', 'tps']}, 09:55:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'tests': ['damp', 'tps']}, 09:55:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['dromaeo_dom']}, 09:55:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['basic_compositor_video']}, 09:55:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:55:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'other-e10s': {'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['a11yr', 09:55:59 INFO - 'ts_paint', 09:55:59 INFO - 'tpaint', 09:55:59 INFO - 'sessionrestore', 09:55:59 INFO - 'sessionrestore_no_auto_restore', 09:55:59 INFO - 'tabpaint']}, 09:55:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['tsvgx', 09:55:59 INFO - 'tsvgr_opacity', 09:55:59 INFO - 'tart', 09:55:59 INFO - 'tscrollx', 09:55:59 INFO - 'cart']}, 09:55:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:55:59 INFO - 'tsvgr_opacity', 09:55:59 INFO - 'tart', 09:55:59 INFO - 'tscrollx', 09:55:59 INFO - 'cart']}, 09:55:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'talos_options': ['--disable-e10s'], 09:55:59 INFO - 'tests': ['tp5o']}, 09:55:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'tests': ['tp5o']}, 09:55:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'talos_options': ['--disable-e10s', 09:55:59 INFO - '--xperf_path', 09:55:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:59 INFO - 'tests': ['tp5n']}, 09:55:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:59 INFO - 'talos_options': ['--xperf_path', 09:55:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:59 INFO - 'tests': ['tp5n']}}, 09:55:59 INFO - 'talos.zip': {'path': '', 09:55:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:59 INFO - Running post-action listener: _resource_record_post_action 09:55:59 INFO - [mozharness: 2016-09-22 16:55:59.861896Z] Finished populate-webroot step (success) 09:55:59 INFO - [mozharness: 2016-09-22 16:55:59.861986Z] Running create-virtualenv step. 09:55:59 INFO - Running pre-action listener: _resource_record_pre_action 09:55:59 INFO - Running main action method: create_virtualenv 09:55:59 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:59 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:55:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:59 INFO - Using real prefix '/usr' 09:55:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:02 INFO - Installing pip.................done. 09:56:02 INFO - Return code: 0 09:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 09:56:02 INFO - 'HOME': '/home/cltbld', 09:56:02 INFO - 'LANG': 'en_US.UTF-8', 09:56:02 INFO - 'LANGUAGE': 'en_US:en', 09:56:02 INFO - 'LOGNAME': 'cltbld', 09:56:02 INFO - 'MAIL': '/var/mail/cltbld', 09:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:02 INFO - 'MOZ_NO_REMOTE': '1', 09:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:02 INFO - 'NO_EM_RESTART': '1', 09:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:02 INFO - 'PWD': '/builds/slave/test', 09:56:02 INFO - 'SHELL': '/bin/bash', 09:56:02 INFO - 'SHLVL': '1', 09:56:02 INFO - 'TERM': 'linux', 09:56:02 INFO - 'TMOUT': '86400', 09:56:02 INFO - 'USER': 'cltbld', 09:56:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:02 INFO - '_': '/tools/buildbot/bin/python'} 09:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:02 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:02 INFO - Cleaning up... 09:56:02 INFO - Return code: 0 09:56:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 09:56:02 INFO - 'HOME': '/home/cltbld', 09:56:02 INFO - 'LANG': 'en_US.UTF-8', 09:56:02 INFO - 'LANGUAGE': 'en_US:en', 09:56:02 INFO - 'LOGNAME': 'cltbld', 09:56:02 INFO - 'MAIL': '/var/mail/cltbld', 09:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:02 INFO - 'MOZ_NO_REMOTE': '1', 09:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:02 INFO - 'NO_EM_RESTART': '1', 09:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:02 INFO - 'PWD': '/builds/slave/test', 09:56:02 INFO - 'SHELL': '/bin/bash', 09:56:02 INFO - 'SHLVL': '1', 09:56:02 INFO - 'TERM': 'linux', 09:56:02 INFO - 'TMOUT': '86400', 09:56:02 INFO - 'USER': 'cltbld', 09:56:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:02 INFO - '_': '/tools/buildbot/bin/python'} 09:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:02 INFO - Downloading/unpacking psutil>=3.1.1 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:04 INFO - Installing collected packages: psutil 09:56:04 INFO - Running setup.py install for psutil 09:56:04 INFO - building 'psutil._psutil_linux' extension 09:56:04 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:05 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:05 INFO - building 'psutil._psutil_posix' extension 09:56:05 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:05 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:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:05 INFO - Successfully installed psutil 09:56:05 INFO - Cleaning up... 09:56:05 INFO - Return code: 0 09:56:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:56:05 INFO - Using env: {'DISPLAY': ':0', 09:56:05 INFO - 'HOME': '/home/cltbld', 09:56:05 INFO - 'LANG': 'en_US.UTF-8', 09:56:05 INFO - 'LANGUAGE': 'en_US:en', 09:56:05 INFO - 'LOGNAME': 'cltbld', 09:56:05 INFO - 'MAIL': '/var/mail/cltbld', 09:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:05 INFO - 'MOZ_NO_REMOTE': '1', 09:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:05 INFO - 'NO_EM_RESTART': '1', 09:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:05 INFO - 'PWD': '/builds/slave/test', 09:56:05 INFO - 'SHELL': '/bin/bash', 09:56:05 INFO - 'SHLVL': '1', 09:56:05 INFO - 'TERM': 'linux', 09:56:05 INFO - 'TMOUT': '86400', 09:56:05 INFO - 'USER': 'cltbld', 09:56:05 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:05 INFO - '_': '/tools/buildbot/bin/python'} 09:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56:05 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:05 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:05 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:05 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:05 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:05 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 - Downloading mozsystemmonitor-0.3.tar.gz 09:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:07 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:07 INFO - Installing collected packages: mozsystemmonitor 09:56:07 INFO - Running setup.py install for mozsystemmonitor 09:56:07 INFO - Successfully installed mozsystemmonitor 09:56:07 INFO - Cleaning up... 09:56:07 INFO - Return code: 0 09:56:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:07 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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 09:56:07 INFO - 'HOME': '/home/cltbld', 09:56:07 INFO - 'LANG': 'en_US.UTF-8', 09:56:07 INFO - 'LANGUAGE': 'en_US:en', 09:56:07 INFO - 'LOGNAME': 'cltbld', 09:56:07 INFO - 'MAIL': '/var/mail/cltbld', 09:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:07 INFO - 'MOZ_NO_REMOTE': '1', 09:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:07 INFO - 'NO_EM_RESTART': '1', 09:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:07 INFO - 'PWD': '/builds/slave/test', 09:56:07 INFO - 'SHELL': '/bin/bash', 09:56:07 INFO - 'SHLVL': '1', 09:56:07 INFO - 'TERM': 'linux', 09:56:07 INFO - 'TMOUT': '86400', 09:56:07 INFO - 'USER': 'cltbld', 09:56:07 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:07 INFO - '_': '/tools/buildbot/bin/python'} 09:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:07 INFO - Downloading/unpacking jsonschema==2.5.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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:10 INFO - warning: no files found matching '*.txt' 09:56:10 INFO - no previously-included directories found matching 'build' 09:56:10 INFO - no previously-included directories found matching 'dist' 09:56:10 INFO - no previously-included directories found matching '.git*' 09:56:10 INFO - Installing collected packages: jsonschema, functools32 09:56:10 INFO - Running setup.py install for functools32 09:56:10 INFO - warning: no files found matching '*.txt' 09:56:10 INFO - no previously-included directories found matching 'build' 09:56:10 INFO - no previously-included directories found matching 'dist' 09:56:10 INFO - no previously-included directories found matching '.git*' 09:56:10 INFO - Successfully installed jsonschema functools32 09:56:10 INFO - Cleaning up... 09:56:10 INFO - Return code: 0 09:56:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:56:10 INFO - Using env: {'DISPLAY': ':0', 09:56:10 INFO - 'HOME': '/home/cltbld', 09:56:10 INFO - 'LANG': 'en_US.UTF-8', 09:56:10 INFO - 'LANGUAGE': 'en_US:en', 09:56:10 INFO - 'LOGNAME': 'cltbld', 09:56:10 INFO - 'MAIL': '/var/mail/cltbld', 09:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:10 INFO - 'MOZ_NO_REMOTE': '1', 09:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:10 INFO - 'NO_EM_RESTART': '1', 09:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:10 INFO - 'PWD': '/builds/slave/test', 09:56:10 INFO - 'SHELL': '/bin/bash', 09:56:10 INFO - 'SHLVL': '1', 09:56:10 INFO - 'TERM': 'linux', 09:56:10 INFO - 'TMOUT': '86400', 09:56:10 INFO - 'USER': 'cltbld', 09:56:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:10 INFO - '_': '/tools/buildbot/bin/python'} 09:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:56:10 INFO - Cleaning up... 09:56:10 INFO - Return code: 0 09:56:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:56:10 INFO - Using env: {'DISPLAY': ':0', 09:56:10 INFO - 'HOME': '/home/cltbld', 09:56:10 INFO - 'LANG': 'en_US.UTF-8', 09:56:10 INFO - 'LANGUAGE': 'en_US:en', 09:56:10 INFO - 'LOGNAME': 'cltbld', 09:56:10 INFO - 'MAIL': '/var/mail/cltbld', 09:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:10 INFO - 'MOZ_NO_REMOTE': '1', 09:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:10 INFO - 'NO_EM_RESTART': '1', 09:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:10 INFO - 'PWD': '/builds/slave/test', 09:56:10 INFO - 'SHELL': '/bin/bash', 09:56:10 INFO - 'SHLVL': '1', 09:56:10 INFO - 'TERM': 'linux', 09:56:10 INFO - 'TMOUT': '86400', 09:56:10 INFO - 'USER': 'cltbld', 09:56:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:10 INFO - '_': '/tools/buildbot/bin/python'} 09:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:10 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:10 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:10 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:10 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:10 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:10 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 - Downloading blobuploader-1.2.4.tar.gz 09:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:13 INFO - Downloading docopt-0.6.1.tar.gz 09:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:13 INFO - Running setup.py install for blobuploader 09:56:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:13 INFO - Running setup.py install for requests 09:56:13 INFO - Running setup.py install for docopt 09:56:13 INFO - Successfully installed blobuploader requests docopt 09:56:13 INFO - Cleaning up... 09:56:13 INFO - Return code: 0 09:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:13 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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 09:56:13 INFO - 'HOME': '/home/cltbld', 09:56:13 INFO - 'LANG': 'en_US.UTF-8', 09:56:13 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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:14 INFO - Running setup.py (path:/tmp/pip-hoECLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:14 INFO - Running setup.py (path:/tmp/pip-hdlY9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:14 INFO - Running setup.py (path:/tmp/pip-hIRasV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:14 INFO - Running setup.py (path:/tmp/pip-6mk6aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:14 INFO - Running setup.py (path:/tmp/pip-DCK8ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:14 INFO - Running setup.py (path:/tmp/pip-Eu7DpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:14 INFO - Running setup.py (path:/tmp/pip-afCiym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:14 INFO - Running setup.py (path:/tmp/pip-YEkkbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:14 INFO - Running setup.py (path:/tmp/pip-pZHBaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:14 INFO - Running setup.py (path:/tmp/pip-RMdkLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:14 INFO - Running setup.py (path:/tmp/pip-O_9T5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:15 INFO - Running setup.py (path:/tmp/pip-zneeNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:15 INFO - Running setup.py (path:/tmp/pip-YtZCbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:15 INFO - Running setup.py (path:/tmp/pip-zUzyax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:15 INFO - Running setup.py (path:/tmp/pip-xF8ljQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:15 INFO - Running setup.py (path:/tmp/pip-YnPBIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:15 INFO - Running setup.py (path:/tmp/pip-RspqU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:15 INFO - Running setup.py install for manifestparser 09:56:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for mozcrash 09:56:15 INFO - Running setup.py install for mozdebug 09:56:15 INFO - Running setup.py install for mozdevice 09:56:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for mozfile 09:56:15 INFO - Running setup.py install for mozhttpd 09:56:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozinfo 09:56:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozInstall 09:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozleak 09:56:16 INFO - Running setup.py install for mozlog 09:56:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for moznetwork 09:56:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozprocess 09:56:16 INFO - Running setup.py install for mozprofile 09:56:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozrunner 09:56:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Running setup.py install for mozscreenshot 09:56:16 INFO - Running setup.py install for moztest 09:56:17 INFO - Running setup.py install for mozversion 09:56:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:17 INFO - Cleaning up... 09:56:17 INFO - Return code: 0 09:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:17 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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 09:56:17 INFO - 'HOME': '/home/cltbld', 09:56:17 INFO - 'LANG': 'en_US.UTF-8', 09:56:17 INFO - 'LANGUAGE': 'en_US:en', 09:56:17 INFO - 'LOGNAME': 'cltbld', 09:56:17 INFO - 'MAIL': '/var/mail/cltbld', 09:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:17 INFO - 'MOZ_NO_REMOTE': '1', 09:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:17 INFO - 'NO_EM_RESTART': '1', 09:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:17 INFO - 'PWD': '/builds/slave/test', 09:56:17 INFO - 'SHELL': '/bin/bash', 09:56:17 INFO - 'SHLVL': '1', 09:56:17 INFO - 'TERM': 'linux', 09:56:17 INFO - 'TMOUT': '86400', 09:56:17 INFO - 'USER': 'cltbld', 09:56:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:17 INFO - '_': '/tools/buildbot/bin/python'} 09:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:17 INFO - Running setup.py (path:/tmp/pip-azpVYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:17 INFO - Running setup.py (path:/tmp/pip-en6K5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:17 INFO - Running setup.py (path:/tmp/pip-ArGj6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:17 INFO - Running setup.py (path:/tmp/pip-sjdv4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:17 INFO - Running setup.py (path:/tmp/pip-Hd2T_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:17 INFO - Running setup.py (path:/tmp/pip-DoBCjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:17 INFO - Running setup.py (path:/tmp/pip-OqLqL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:17 INFO - Running setup.py (path:/tmp/pip-45iwFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:18 INFO - Running setup.py (path:/tmp/pip-XXIYrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:18 INFO - Running setup.py (path:/tmp/pip-hREY69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:18 INFO - Running setup.py (path:/tmp/pip-UAY2nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:18 INFO - Running setup.py (path:/tmp/pip-Ucr9XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:18 INFO - Running setup.py (path:/tmp/pip-WnhcKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:18 INFO - Running setup.py (path:/tmp/pip-5Eb0Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:18 INFO - Running setup.py (path:/tmp/pip-V_70_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:18 INFO - Running setup.py (path:/tmp/pip-N2TlQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:18 INFO - Running setup.py (path:/tmp/pip-B_bz4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - Downloading blessings-1.6.tar.gz 09:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:20 INFO - Installing collected packages: blessings 09:56:20 INFO - Running setup.py install for blessings 09:56:20 INFO - Successfully installed blessings 09:56:20 INFO - Cleaning up... 09:56:20 INFO - Return code: 0 09:56:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Current package versions: 09:56:21 INFO - argparse == 1.2.1 09:56:21 INFO - blessings == 1.6 09:56:21 INFO - blobuploader == 1.2.4 09:56:21 INFO - docopt == 0.6.1 09:56:21 INFO - functools32 == 3.2.3-2 09:56:21 INFO - jsonschema == 2.5.1 09:56:21 INFO - manifestparser == 1.1 09:56:21 INFO - mozInstall == 1.12 09:56:21 INFO - mozcrash == 0.17 09:56:21 INFO - mozdebug == 0.1 09:56:21 INFO - mozdevice == 0.48 09:56:21 INFO - mozfile == 1.2 09:56:21 INFO - mozhttpd == 0.7 09:56:21 INFO - mozinfo == 0.9 09:56:21 INFO - mozleak == 0.1 09:56:21 INFO - mozlog == 3.4 09:56:21 INFO - moznetwork == 0.27 09:56:21 INFO - mozprocess == 0.23 09:56:21 INFO - mozprofile == 0.28 09:56:21 INFO - mozrunner == 6.12 09:56:21 INFO - mozscreenshot == 0.1 09:56:21 INFO - mozsystemmonitor == 0.3 09:56:21 INFO - moztest == 0.7 09:56:21 INFO - mozversion == 1.4 09:56:21 INFO - psutil == 3.1.1 09:56:21 INFO - requests == 1.2.3 09:56:21 INFO - wsgiref == 0.1.2 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 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/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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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/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:21 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: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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 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 - 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Installing jsonschema 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 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', '--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 0x7f8d61e66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', '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', '--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:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 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': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 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 - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Running post-action listener: _resource_record_post_action 09:56:21 INFO - Running post-action listener: _start_resource_monitoring 09:56:21 INFO - Starting resource monitoring. 09:56:21 INFO - [mozharness: 2016-09-22 16:56:21.466484Z] Finished create-virtualenv step (success) 09:56:21 INFO - [mozharness: 2016-09-22 16:56:21.466942Z] Running install step. 09:56:21 INFO - Running pre-action listener: _resource_record_pre_action 09:56:21 INFO - Running main action method: install 09:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Output received: 09:56:21 INFO - Usage: mozinstall [options] installer 09:56:21 INFO - Options: 09:56:21 INFO - -h, --help show this help message and exit 09:56:21 INFO - -d DEST, --destination=DEST 09:56:21 INFO - Directory to install application into. [default: 09:56:21 INFO - "/builds/slave/test"] 09:56:21 INFO - --app=APP Application being installed. [default: firefox] 09:56:21 INFO - mkdir: /builds/slave/test/build/application 09:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:56:38 INFO - Reading from file tmpfile_stdout 09:56:38 INFO - Output received: 09:56:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:56:38 INFO - Running post-action listener: _resource_record_post_action 09:56:38 INFO - [mozharness: 2016-09-22 16:56:38.768661Z] Finished install step (success) 09:56:38 INFO - [mozharness: 2016-09-22 16:56:38.768909Z] Running run-tests step. 09:56:38 INFO - Running pre-action listener: _resource_record_pre_action 09:56:38 INFO - Running main action method: run_tests 09:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:38 INFO - Python 2.7.3 09:56:38 INFO - Return code: 0 09:56:38 INFO - grabbing minidump binary from tooltool 09:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:38 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 0x2bd3930>, '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 0x2bd4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:38 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:38 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:38 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:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:38 INFO - Return code: 0 09:56:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:56:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:56:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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:38 INFO - Using env: {'DISPLAY': ':0', 09:56:38 INFO - 'HOME': '/home/cltbld', 09:56:38 INFO - 'LANG': 'en_US.UTF-8', 09:56:38 INFO - 'LANGUAGE': 'en_US:en', 09:56:38 INFO - 'LOGNAME': 'cltbld', 09:56:38 INFO - 'MAIL': '/var/mail/cltbld', 09:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:38 INFO - 'MOZ_NO_REMOTE': '1', 09:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:38 INFO - 'NO_EM_RESTART': '1', 09:56:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:38 INFO - 'PWD': '/builds/slave/test', 09:56:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:38 INFO - 'SHELL': '/bin/bash', 09:56:38 INFO - 'SHLVL': '1', 09:56:38 INFO - 'TERM': 'linux', 09:56:38 INFO - 'TMOUT': '86400', 09:56:38 INFO - 'USER': 'cltbld', 09:56:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920', 09:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:38 INFO - '_': '/tools/buildbot/bin/python'} 09:56:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:39 INFO - mozversion application_buildid: 20160922063015 09:56:39 INFO - mozversion application_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 09:56:39 INFO - mozversion application_display_name: Nightly 09:56:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:39 INFO - mozversion application_name: Firefox 09:56:39 INFO - mozversion application_remotingname: firefox 09:56:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:56:39 INFO - mozversion application_vendor: Mozilla 09:56:39 INFO - mozversion application_version: 52.0a1 09:56:39 INFO - mozversion platform_buildid: 20160922063015 09:56:39 INFO - mozversion platform_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 09:56:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:56:39 INFO - mozversion platform_version: 52.0a1 09:56:39 INFO - using testdate: 1474563399 09:56:39 INFO - actual date: 1474563399 09:56:39 INFO - starting webserver on 'localhost:49143' 09:56:39 INFO - SUITE-START | Running 2 tests 09:56:39 INFO - TEST-START | dromaeo_css 09:56:39 INFO - operating with platform_type : linux_ 09:56:39 INFO - Initialising browser for dromaeo_css test... 09:56:39 INFO - TEST-INFO | started process 12886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxddxrk/profile http://localhost:49143/getInfo.html) 09:56:43 INFO - PROCESS | 12886 | __metrics Screen width/height:1600/1200 09:56:43 INFO - PROCESS | 12886 | colorDepth:24 09:56:43 INFO - PROCESS | 12886 | Browser inner width/height: 1024/697 09:56:43 INFO - PROCESS | 12886 | __metrics 09:56:43 INFO - PROCESS | 12886 | 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:43 INFO - PROCESS | 12886 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:44 INFO - PROCESS | 12886 | console.error: PushService: 09:56:44 INFO - PROCESS | 12886 | stateChangeProcessEnqueue: Error transitioning state 09:56:44 INFO - PROCESS | 12886 | UnknownError 09:56:45 INFO - TEST-INFO | 12886: exit 0 09:56:45 INFO - Browser initialized. 09:56:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:45 INFO - TEST-INFO | started process 12969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxddxrk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:57 INFO - PROCESS | 12969 | RSS: Main: 173146112 09:56:57 INFO - PROCESS | 12969 | 09:57:49 INFO - PROCESS | 12969 | 1474563469002 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] 09:59:58 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49143/tests/dromaeo/cssquery-ext.html) 09:59:59 INFO - PROCESS | 12969 | RSS: Main: 293957632 09:59:59 INFO - PROCESS | 12969 | 10:03:02 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-ext.html (next: http://localhost:49143/tests/dromaeo/cssquery-jquery.html) 10:03:02 INFO - PROCESS | 12969 | RSS: Main: 280846336 10:03:02 INFO - PROCESS | 12969 | 10:06:04 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49143/tests/dromaeo/cssquery-mootools.html) 10:06:05 INFO - PROCESS | 12969 | RSS: Main: 261165056 10:06:05 INFO - PROCESS | 12969 | 10:09:07 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49143/tests/dromaeo/cssquery-prototype.html) 10:09:08 INFO - PROCESS | 12969 | RSS: Main: 272756736 10:09:08 INFO - PROCESS | 12969 | 10:12:10 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49143/tests/dromaeo/cssquery-yui.html) 10:12:11 INFO - PROCESS | 12969 | RSS: Main: 220827648 10:12:11 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:49143/tests/dromaeo/cssquery-yui.html (next: http://localhost:49143/tests/dromaeo/cssquery-dojo.html) 10:15:14 INFO - PROCESS | 12969 | RSS: Main: 305463296 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | __start_tp_report 10:15:14 INFO - PROCESS | 12969 | _x_x_mozilla_page_load 10:15:14 INFO - PROCESS | 12969 | _x_x_mozilla_page_load_details 10:15:14 INFO - PROCESS | 12969 | |i|pagename|runs| 10:15:14 INFO - PROCESS | 12969 | |0;dojo.html;2997.910062698119;3023.0779612218266;3032.545118232265;3050;3082.660907300198;5149.201873709581;5193.922091168631;5240.397354304256;5283.075461794185;5320.255164277004;5195.142801437768;5244.39689435715;5263.657862238952;5285.709285989278;5325.147976323789;4727.054589082198;4821.734804585746;4824.324594556765;4830.516948305177;4939.283803848458;4869.610431165498;4904.06822703687;4929.383827021622;4930.7534623268875;4970.850874473772;4713.764311784397;4727.598154156901;4742.620590352763;4773.641976851715;4887.242477416006;4802.087603355351;4804.303376010494;4851.393575803025;4861.246506791453;4879.756012199376;4729.739864307462;4758.547937945889;4772.856814295576;4779.856604301842;4818.7831547580445;5116.769745361467;5198.610104242197;5258.8685282867855;5261.815836445744;5315.760790764386;5553.583481238883;5654.236678048452;5663.207150998864;5676.347220069703;5742.167385729088;5699.857503562403;5700.686462244575;5704.286964129484;5715.057015592464;5715.371309155989;5123.052235336475;5296.09966305729;5309.920351194735;5313.362396512443;5355.0360935031285;5607.074832652566;5711.7144142792695;5742.3396309424115;5751.281089863767;5843.94156058434;5516.117421212587;5551.139573366135;5560.471755183251;5570.526505247019;5573.219749235111;5594.244776955059;5639.605227634108;5648.774049038075;5657.8019769307875;5659.405762394971;5492.450754924475;5546.334439867242;5550.4449555044985;5639.0977443609645;5717.742701578439;5639.774409023676;5645.943540564624;5655.604107712421;5656.349519805192;5659.179418984224;4290.806913688892;4326.762028088486;4334.436523251957;4337.0458499130145;4343.283358245917;3873.903152421212;3888.300105980894;3892.3188442022533;3935.4883865097927;3937.07478742501;5325.201219817059;5377.542908852792;5384.380796208407;5390.299261096111;5443.183522471581;5436.130219164994;5491.643043202179;5552.639078459887;5581.469760372758;5684.687342196219;5315.468453154654;5322.2282768998275;5322.920156197582;5368.4631536846;5380.461953804588;4858.416989961227;4887.095887260868;4888.046830868017;4896.338994235733;4949.752512374439;5767;5780.826575202751;5783.16144159103;5811.128330750421;5849.64902105875;5643.322801263875;5694.4590263924865;5695.914561281501;5751.654900705971;5763.538916886555;5866.530677545871;5872.29532456108;5872.471477567039;5876.471117599265;5880.558958078076;5428.647137936022;5487;5582.720863956867;5584.162375643686;5591.860203494945;5618.775248989995;5644.85887852807;5680.573956953328;5699.629524080921;5763.077907534942;5504.752286147213;5540.63985840919;5546.278983732089;5552.139418390156;5555.388907220284;5379.112446446293;5496.285482887199;5540.418256083214;5551.2228288040515;5616.5787565931905;5363.168708850135;5411.431799661136;5446.074167391632;5475.151351540518;5570.164475328733;5571.7492712828835;5576.33084029919;5579;5586.497215250647;5589.329280486368;5438.129899216106;5442;5445.564354851682;5446.1558458439;5508.807191748269 10:15:14 INFO - PROCESS | 12969 | |1;ext.html;567.795593586309;584.4710536964044;592.668105860718;594.7680404642193;600.3036477685882;29376.85311573442;42654.36018459726;44355;44403.33394999074;47262.763686181606;44045.11909761803;44975.100497990104;45006.7749661252;45060.549394506044;45129.54870451295;8930.464172149676;9078.137576930181;9085.954570227139;9089;9090.409123406956;8922.197002269795;9044.231240344545;9047.276217902585;9054.32092593055;9054.32092593055;8922.286217102615;8965.506897120657;9018.639254429814;9037.95481022594;9039.638414463414;8917;8961.327900407496;8969.641214351419;8988.730338089868;9027.503487308195;8903.24322432594;8981.281497480186;8986.14631609996;8991.55042247885;8992.640294388282;41720.1655966879;42163.1567368654;42238.788806055774;42248.366274505905;42273.36589951153;3312.3540909522653;3319.68462996015;3329.8002119872885;3627.8548858045647;3652.4703917932015;31846.363072738648;31992.541421395024;32298.83850580732;32330.547726022953;33305;3565.8217089145437;3591.94612080819;3626.601073881871;3716.591174970751;3756.6055564165918;327042;330062;330627;331713;332238.99999999756;58873;59784.402155977885;59830.70084649549;59915;59920.70039649774;53078.73460632672;55696.44303556912;56638.43361566414;64578;64739.676301618194;14725.779113313309;15131.848681513044;15136.697266054618;15147.621309467351;15155.242237888062;11273.210875238654;11289.49197286124;11307.773844523064;11319.094472442184;11326.15053870963;16468.341266349453;16883.83116168847;18372;18653.81346186548;18810.905945470186;6702.430293425016;6900.758473453506;6907.171139463297;6954.23503414624;7072.92927070733;884.2483888694558;958.2812890332251;973.9026097390205;994.5623925472769;995.6515219673056;30290.54564181539;32305.676943230737;32352.67647323544;32471;32568.619418271275;977.3891317926297;985.935914165577;1011.4437059617181;1043.0351924469835;1057.8148823955778;15817.841821581867;16665.50206135134;16899.66200676004;16978.660426791394;17069.48791536256;500729;500999;504932;505293;505771;57978.71010645004;58203;58429.41570584325;58487;58552.4144758547;1215.6353094071744;1238.1456794811552;1244.4275633208645;1249.256692268099;1261.6719652890315;29426.43890197023;30821.69178308278;30968.53547196839;31236.687633123376;31272.21819454532;45291.320630191236;45330.77334613306;45348.31977520274;45479.54520454753;45611.77194114008;390569;393003;393510;393750;393827;25093.623595646444;25858.741412585634;27568.724312756614;28737;29318;43554.56445435632;47286;47333.29000064933;47774.283385749935;47935;39262.607373927036;40423;41059;41207.58792412037;42051;39190.317403976835;39721.2055758889;40256.79871600623;40606;41207.58792412037;40225.798871005456;40244.3963340556;40627;40885.795571021954;40899.7955010223;34479;36301.273974519834;36420.27159456743;37169.0707732298;37279.627203727614;27185.184444466697;27787.30531736642;27839.44321113607;27939.58090628683;28028.85985570059 10:15:14 INFO - PROCESS | 12969 | |2;jquery.html;377.45646269372116;393.28618557318464;400.33943992412526;403.4694376894384;420.82746074109605;13382.130161539506;15406.537803865875;19018.809811901876;19540.609187816237;19831.801681983176;18853.15160817763;19107.140178691956;19582.11880465379;19736.60526789467;19746.802531974678;5471.671699698031;5614.747336369853;5824.446677565625;5828.9417105828825;5829.766809327622;5700.37295897451;5773.278340207474;5777.826665200029;5779.306483222019;5782.508486778629;5793.884122317551;5794.62334948227;5798.565107616945;6100.938990610081;6500.057491663706;6566.113574667431;6590.736370545173;6602.735890564371;6607.933920660804;6608.504362172856;5634.239377684001;5658.660480371191;5706.087026075808;5707;5709.286339207599;13309.334533273297;13374.08483904151;13470.191788492624;22356.55286894253;22595.548089038126;2089.8328133749264;2136.209602447089;2233.3411643565023;2348.189874493297;2364.8817559121976;9468.337216394855;11056.281341712764;13717.519886804013;13829.377678004414;14366.20985845778;1889.2915156816193;1976.6012610039315;2006.6789313709737;2038.500567361006;2042.1627132875599;80242.59878700628;80400;80866;80923;82182.90530778328;11115.388653623966;11207;11382.430878456044;11443.599474018536;11564.76870462586;15485.690286194438;15513.45702900393;15616.921915390578;15773.763393549107;15779.132147731756;7349.265073492715;7415.480916335805;7468.925310746931;7636.31273185416;7816;7109.502334836512;7124.323189297009;7130.500864939404;7299.817504562428;7313.085864266966;4861.927071093936;4866.829660961849;4867.105099888324;4923.532264434873;4965.82619608312;1848.9352872649392;1882.5670095878024;1945.9805401946082;1971.5071232191951;2012.3359291433792;832.1595188859175;862.4523427623379;881.8809460722848;886.9113088691208;893.6719844804321;18789.168971211253;19345.806541934402;19548.51128721765;19571.315003974792;19617;904.7285814255697;912.1015799437548;941.1764705882352;948.7343543807744;1015.3653966271081;10156.441395723159;10687;10735.141188704885;10816.621418250323;10955.616553420752;422156;432565;433222;437174;437732;85729.57135214284;89239.55380223187;89262.55368723115;89573.55213223892;89816.550917245;948.2508818033814;960.596549449233;989.8762654668167;992.389680346596;992.831218692824;16613;16995.320187192374;17418.651626967643;17453.38913138034;17761.822381776015;39195.216095678494;39774.60225397709;40004.59995400125;40818.591814081476;41579.16841663211;55224;56321;56633;56771;58050.709746451;8134.83730325402;8159.632816523389;8195.549244791593;8304.252617264476;8345.374096942633;11250.262156574912;12013.219140755822;12390.5663301784;12403.25580465175;12443.813342799684;10235.232357573062;10315.27793054479;10426.843597346198;10698.090662293793;11089.556417743523;10836.241463097507;10849.945750271198;10916.945415272872;11233.66299011031;11484.368359740294;10185.134263587383;10548.836745380828;10898.564057437614;10946.945265273622;11123.499442524944;7714.575698336421;8122.75631731049;8317.542535160625;8823.07357727455;8861.512616806138;10150.54322555472;10341.931613677445;10450.42522661261;10479.371237725762;11002.449877505933 10:15:14 INFO - PROCESS | 12969 | |3;mootools.html;1201.9879801201985;1452.8837692984562;1498.1310839712967;1610.6778644271142;1775.7070083436233;7691.884621730672;8481.660733570658;8671.91328086719;8733.344999125075;9022.278217742582;8806.383553151281;8884.555772211395;8891.33315001376;8900.8664870027;8948.105189481048;2243.1924507177405;2266.2634643740766;2266.626006708891;2269.4439862233776;2271.7501074881748;2176.836737244705;2191.1345018717598;2235.2065016919005;2236.13908645172;2238.4963383238724;2215.2025270902463;2220.8667479951173;2222.2666520048347;2225.4770129019666;2261.7738226177416;2187.2344679362254;2198.3404978506464;2210.049678638185;2214.3467677035314;2215.3575463115676;2145.817605503534;2150.4301360139575;2153.4616345913523;2154.278316763886;2160.7299087614047;8904.109589041109;8950.731478055668;8963.68627098055;8965.641374345083;8968.417052891606;5015.0972824891505;5181.585473162176;5181.663191892552;5236.8690782730355;5238.633295669305;3287.572615559986;3414.231797845465;3445.4659527773233;3455.1534873956043;3492;1076.8815430302661;1108.2187058124002;1111.0833562311045;1122.2256642916361;1126.1103728054827;12180.147389682637;12251.448684809206;12274.509019639203;12338.198017128858;12359.382030898509;4282.593153650399;4372.453443319585;4500.977495112504;4567.474740404829;4612.815487380467;9730.756731081638;9735.805283894282;9736.853947190797;9749;9755.122039016522;5091.134507133796;5097.974510127426;5098.490150984871;5101.617378696613;5108.208227724708;4100.774457404812;4340.913181736348;4412.139632771643;4810.855674329776;4826.927596086061;3647.4133751818044;3747.4378843173195;3749.662530372225;3805.9238815224094;3838.1556057667267;1107.1640911112058;1112.8910714196713;1115.4757264085868;1128.7911736328806;1135.2677522997785;875.3784812782995;875.8642410426394;897.1028971028971;914.92680585553;933.8505839065717;5575.749091290902;5611.354694210137;5826.242588463558;5880.7353669085;5891.469767720926;889.4974339498162;903.1600611431301;937.2127412973135;937.5968333616611;975.331897650112;3827.73205875586;3919.470871432377;4081.1225586499045;4182.309918863414;4210.45264115663;10561.419121948213;10666.520006599721;10763.515641796137;10764.946175269073;10791.082757965662;10359.585616575403;10663.893361066444;10664.466776661136;10672.626458074086;10730.034296913314;7994.400419968526;8286.129956354496;8294.543800090933;8297.83404331922;8297.917020829715;5830.358660547421;5851.502622277154;5864.530837533072;5925.1704761332585;6088.695565221633;9805.55874985613;10239.436830974368;10255.33340332876;10406.323588966692;10416.479176041015;9377.859332109887;10481.37111773296;10604.151667866707;10623.946880265548;10627.09669678055;7134.571925684476;7526.473146879666;7701.152873183833;7779.533228006338;7997.560134192675;7764.805879853049;7854.882176767467;7856.410769192219;7963.323117535075;8079.394045446497;7499.775006749806;7683.9231607683205;7747.070351557849;7771.222877712184;7898.3681305496575;7652.540847549165;7654.73208437702;7733.7679869604;7762.495437796525;7885.526868387915;6369.936300636934;6486.740530378732;6518.348165183444;6572.309907459839;6584.76953306632;4872.902541949212;4893.853184404474;4934.5805606523845;4942.75286235694;5039.168537191323;4882.92675609859;4885.7801398937845;4998.850034498971;5009.9248511271635;5066.797328106834 10:15:14 INFO - PROCESS | 12969 | |4;prototype.html;325.347677905799;333.8614474992878;336.15960099750623;338.3723193476101;339.6671262163082;5296.364436267649;5320.76056577454;5334.173203153513;5345.946540534594;5349.652272602283;5039.823606173784;5105.463926287742;5118.820841270556;5198.194279886614;5324.494173053554;4174.332106862903;4185.727927684698;4188.706790524665;4199.55904630014;4209.347551129565;4185.409544373134;4213.1363070570615;4235.08945576701;4250;4251.5110762262275;3910.608939106095;3965.405189221611;4053.8041277822967;4083.8979025524304;4190.790460476979;4070.7761073140964;4100.671946244308;4110.136871257039;4118.464599602047;4123.814428350732;3615.3673107206396;3619.8552057917914;3621.149029977953;3624.6375362463805;3633.6003039665616;5008.198688209869;5042.647014708972;5061.190209566488;5091.8981620367385;5125.641205115643;4725.078609671115;4739.905201895977;4747.52524747526;4749.408948002423;4762.166620841339;5426.503808248211;5468.808591699271;5483.930633526464;5485.780568777244;5498.890022199534;3950.9529974556767;3986.4418981342637;4024.255512730125;4043.8584649537124;4067.9593204068174;5629.352624448159;5631.324241091054;5638.520725738317;5643.698436414702;5658.603897727161;4124.52567954683;4125.546189919107;4128.48162620801;4134.689898257582;4138.193052354762;4102.979485102555;4177.12280421115;4217;4229.767362795014;4234.428352172479;4709.1994360958715;4736.613321475162;4742.19382704941;4750.95249047512;4762.261849413347;5548.805791797267;5550.555955523549;5558.86102847424;5574.832755017356;5586.91619625706;1407.1754070863406;1441.5170917742464;1454.3092031285266;1480.178500931993;1481.896267261303;938.6339327662217;962.6775030364906;973.8636590877283;974.6734843827255;977.7018009507026;4547.522510136454;4759.524047595282;4780.259059845729;4800.615950724004;4819.915519008195;4965.3048573199785;4971.353724015855;4997.175466048061;5076.213186956028;5100.923486147711;4676.625869930397;4732.313814496879;4759.595434388047;4763.261694437368;4789.353437285922;2685.650865387487;2693.871841245394;2705.945881082367;2857.842818644953;3024.4555979923384;5882.588218824641;5928.525717942554;5940.31686356066;5943.643381397043;5943.910841337383;5772.191893134965;5796.768129274782;5802.533923082673;5810.571762659966;5814.796482123105;5661.405552417019;5799.449052340021;5803.535717142703;5830.2129212555765;5890.291815373579;5565.749541270734;5605.159226116115;5619.550435965195;5641.746121424464;5670.943290567042;5486.780528778964;5598.720063996865;5668.319801623831;5680.772769089355;5698.230738850202;5836.824895253149;5883.029070319461;5890.410958904075;5932.466078052823;5944.316403613467;4059.6143366380147;4066.898327541835;4066.9796651016554;4077.286474866946;4080.1635664688074;5239.659422137549;5475.260839786578;5597.04850175463;5657.4908258256955;5669.716514174357;5449.782008719607;5489.807856724996;5494.313210848644;5507.642003269774;5519.75805443772;5274.97362513185;5467.835964921059;5474.479924407175;5479.589030822784;5483.738740089722;5336.3863155736035;5383.219433182088;5427.674339539641;5449.2371068049715;5456.181572763959;5507.972460137674;5508.3114610673665;5510.338759348904;5533.667979921218;5592.7762889483965;5304.151335786256;5360.597955153301;5417.620766546304;5423.186522021729;5440.183972404171 10:15:14 INFO - PROCESS | 12969 | |5;yui.html;600.5885968111844;644.8806970710419;651.938065883741;678.5691086160286;723.3309189000173;12980.221186728792;13554.728905421885;13875.2368619726;13901.374438150282;13928.93035534821;13140.802887956688;13183.274919879403;13242.735145297089;13283.136596121245;13402.46390144393;610.3286384976535;793.9642716077776;813.9145389734082;816.6814942172557;817.0195765081896;498.16059939002895;796.5300472721093;813.0243707550933;817.81190326225;821.4250024982506;865.2256230673544;867.0375882770152;867.2541614211805;867.301822033263;872.4198408058666;704.9048378468892;855.0765173612483;860.3332417376521;868.2229404682805;868.6612221233723;509.6687153350315;610.7465401858224;618.5793660310986;624.7188765055697;625.9687015649245;13982.72034559303;14016.789748153786;14027.929860350632;14029.719405611933;14040.087394319438;12918.935405323007;13432.731345373038;13825.930870345685;13918.652033699138;14050.36773345202;13468.461261549526;13546.187228766206;13606.727865442635;13619.523316683868;13648.795268070988;4406.625436837872;4417.933730994037;4470.977645111786;4510.526394728572;4535.4103966484145;79949.20050799476;79952.60023699903;80201.19798801995;80297;80388.59805700992;11330.206885517935;11411.315321080761;11705.849947143604;11783.175177737476;11920.76158476843;21475.785242147693;21532.246371376925;21540.78459215388;21547.84521547864;21605.35183944484;7476.1776204617445;7801.882971755428;7838.294553490099;8062.1937806220085;8213.34293256538;4214.7471151731;4337.6963612546815;4353.085851971058;4379.146066516999;4409.669274804402;3357.647447018028;3486.0064881508647;3496.8601255949984;3502.141975216088;3504.0714210734177;563.1819781766941;573.1059547106527;578.673049726903;585.3327206984042;594.7591225553658;584.4798129664601;614.27822308787;644.5166125405946;645.8966565349522;655.8950567909112;8111.3916456266015;8465.365097617703;8474.1949514796;8573.828523429496;8900.109989001048;528.8545649946295;531.7314756048248;559.9720013999283;594.6342999055636;597.8834127345126;3920.5687374388795;4115.773632450244;4143.19207754491;4217.863543203376;4263.978680106579;89270.55364723135;92962;93092.53453732688;103131;108964;52440.737796311536;64674;87715.56142219248;89901.10098899058;96690;73320.63339683374;75166.24833751701;83359.5832020836;83694.16305836986;86168.56915715507;9401.388909720847;9418.481983490974;9447.149756521945;9600.471974041495;9881.752956175866;49314.26028609502;49325;49921.75039124781;51145.23282150845;52987.20519192292;66610.66694666496;69852.65073674599;75161.62419187868;76512.61743691246;77567;11769;12556.246625202151;12573.811392829299;12611.117221794386;12688.555900543806;12825.102242842911;13271.535496257584;13476.730465390441;14216.578342165702;14245.64385890361;13304.600861974157;13842.65393365174;14268.71462570722;14374.065685730395;14666.77999829982;11514.596989105341;12332.691682707646;12445.937770311091;12679.366031698193;13016.479340826261;12741.55404560873;13374.598762037154;13434.462621495031;13884.236366999912;13951.511697090553;11273.098152147644;11386.430678465878;11460;11488.885111148782;11517.769644607228;11341.206115571831;11416.257943233662;11474.598389056342;11578.42107894585;11742.354170520703 10:15:14 INFO - PROCESS | 12969 | __end_tp_report 10:15:14 INFO - PROCESS | 12969 | __start_cc_report 10:15:14 INFO - PROCESS | 12969 | _x_x_mozilla_cycle_collect,933 10:15:14 INFO - PROCESS | 12969 | __end_cc_report 10:15:14 INFO - PROCESS | 12969 | __startTimestamp1474564514383__endTimestamp 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | ------- Summary: start ------- 10:15:14 INFO - PROCESS | 12969 | Number of tests: 6 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#0] dojo.html Cycles:165 Average:5250.19 Median:5445.56 stddev:590.50 (10.8%) stddev-sans-first:565.26 10:15:14 INFO - PROCESS | 12969 | Values: 2997.9 3023.1 3032.5 3050.0 3082.7 5149.2 5193.9 5240.4 5283.1 5320.3 5195.1 5244.4 5263.7 5285.7 5325.1 4727.1 4821.7 4824.3 4830.5 4939.3 4869.6 4904.1 4929.4 4930.8 4970.9 4713.8 4727.6 4742.6 4773.6 4887.2 4802.1 4804.3 4851.4 4861.2 4879.8 4729.7 4758.5 4772.9 4779.9 4818.8 5116.8 5198.6 5258.9 5261.8 5315.8 5553.6 5654.2 5663.2 5676.3 5742.2 5699.9 5700.7 5704.3 5715.1 5715.4 5123.1 5296.1 5309.9 5313.4 5355.0 5607.1 5711.7 5742.3 5751.3 5843.9 5516.1 5551.1 5560.5 5570.5 5573.2 5594.2 5639.6 5648.8 5657.8 5659.4 5492.5 5546.3 5550.4 5639.1 5717.7 5639.8 5645.9 5655.6 5656.3 5659.2 4290.8 4326.8 4334.4 4337.0 4343.3 3873.9 3888.3 3892.3 3935.5 3937.1 5325.2 5377.5 5384.4 5390.3 5443.2 5436.1 5491.6 5552.6 5581.5 5684.7 5315.5 5322.2 5322.9 5368.5 5380.5 4858.4 4887.1 4888.0 4896.3 4949.8 5767.0 5780.8 5783.2 5811.1 5849.6 5643.3 5694.5 5695.9 5751.7 5763.5 5866.5 5872.3 5872.5 5876.5 5880.6 5428.6 5487.0 5582.7 5584.2 5591.9 5618.8 5644.9 5680.6 5699.6 5763.1 5504.8 5540.6 5546.3 5552.1 5555.4 5379.1 5496.3 5540.4 5551.2 5616.6 5363.2 5411.4 5446.1 5475.2 5570.2 5571.7 5576.3 5579.0 5586.5 5589.3 5438.1 5442.0 5445.6 5446.2 5508.8 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#1] ext.html Cycles:180 Average:57119.95 Median:41133.29 stddev:109865.15 (267.1%) stddev-sans-first:110091.30 10:15:14 INFO - PROCESS | 12969 | Values: 567.8 584.5 592.7 594.8 600.3 29376.9 42654.4 44355.0 44403.3 47262.8 44045.1 44975.1 45006.8 45060.5 45129.5 8930.5 9078.1 9086.0 9089.0 9090.4 8922.2 9044.2 9047.3 9054.3 9054.3 8922.3 8965.5 9018.6 9038.0 9039.6 8917.0 8961.3 8969.6 8988.7 9027.5 8903.2 8981.3 8986.1 8991.6 8992.6 41720.2 42163.2 42238.8 42248.4 42273.4 3312.4 3319.7 3329.8 3627.9 3652.5 31846.4 31992.5 32298.8 32330.5 33305.0 3565.8 3591.9 3626.6 3716.6 3756.6 327042.0 330062.0 330627.0 331713.0 332239.0 58873.0 59784.4 59830.7 59915.0 59920.7 53078.7 55696.4 56638.4 64578.0 64739.7 14725.8 15131.8 15136.7 15147.6 15155.2 11273.2 11289.5 11307.8 11319.1 11326.2 16468.3 16883.8 18372.0 18653.8 18810.9 6702.4 6900.8 6907.2 6954.2 7072.9 884.2 958.3 973.9 994.6 995.7 30290.5 32305.7 32352.7 32471.0 32568.6 977.4 985.9 1011.4 1043.0 1057.8 15817.8 16665.5 16899.7 16978.7 17069.5 500729.0 500999.0 504932.0 505293.0 505771.0 57978.7 58203.0 58429.4 58487.0 58552.4 1215.6 1238.1 1244.4 1249.3 1261.7 29426.4 30821.7 30968.5 31236.7 31272.2 45291.3 45330.8 45348.3 45479.5 45611.8 390569.0 393003.0 393510.0 393750.0 393827.0 25093.6 25858.7 27568.7 28737.0 29318.0 43554.6 47286.0 47333.3 47774.3 47935.0 39262.6 40423.0 41059.0 41207.6 42051.0 39190.3 39721.2 40256.8 40606.0 41207.6 40225.8 40244.4 40627.0 40885.8 40899.8 34479.0 36301.3 36420.3 37169.1 37279.6 27185.2 27787.3 27839.4 27939.6 28028.9 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#2] jquery.html Cycles:180 Average:26943.91 Median:20204.03 stddev:71623.18 (354.5%) stddev-sans-first:71796.32 10:15:14 INFO - PROCESS | 12969 | Values: 377.5 393.3 400.3 403.5 420.8 13382.1 15406.5 19018.8 19540.6 19831.8 18853.2 19107.1 19582.1 19736.6 19746.8 5471.7 5614.7 5824.4 5828.9 5829.8 5700.4 5773.3 5777.8 5779.3 5782.5 5793.9 5794.6 5798.6 6100.9 6500.1 6566.1 6590.7 6602.7 6607.9 6608.5 5634.2 5658.7 5706.1 5707.0 5709.3 13309.3 13374.1 13470.2 22356.6 22595.5 2089.8 2136.2 2233.3 2348.2 2364.9 9468.3 11056.3 13717.5 13829.4 14366.2 1889.3 1976.6 2006.7 2038.5 2042.2 80242.6 80400.0 80866.0 80923.0 82182.9 11115.4 11207.0 11382.4 11443.6 11564.8 15485.7 15513.5 15616.9 15773.8 15779.1 7349.3 7415.5 7468.9 7636.3 7816.0 7109.5 7124.3 7130.5 7299.8 7313.1 4861.9 4866.8 4867.1 4923.5 4965.8 1848.9 1882.6 1946.0 1971.5 2012.3 832.2 862.5 881.9 886.9 893.7 18789.2 19345.8 19548.5 19571.3 19617.0 904.7 912.1 941.2 948.7 1015.4 10156.4 10687.0 10735.1 10816.6 10955.6 422156.0 432565.0 433222.0 437174.0 437732.0 85729.6 89239.6 89262.6 89573.6 89816.6 948.3 960.6 989.9 992.4 992.8 16613.0 16995.3 17418.7 17453.4 17761.8 39195.2 39774.6 40004.6 40818.6 41579.2 55224.0 56321.0 56633.0 56771.0 58050.7 8134.8 8159.6 8195.5 8304.3 8345.4 11250.3 12013.2 12390.6 12403.3 12443.8 10235.2 10315.3 10426.8 10698.1 11089.6 10836.2 10849.9 10916.9 11233.7 11484.4 10185.1 10548.8 10898.6 10946.9 11123.5 7714.6 8122.8 8317.5 8823.1 8861.5 10150.5 10341.9 10450.4 10479.4 11002.4 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#3] mootools.html Cycles:180 Average:5685.18 Median:4889.82 stddev:3288.21 (67.2%) stddev-sans-first:3280.18 10:15:14 INFO - PROCESS | 12969 | Values: 1202.0 1452.9 1498.1 1610.7 1775.7 7691.9 8481.7 8671.9 8733.3 9022.3 8806.4 8884.6 8891.3 8900.9 8948.1 2243.2 2266.3 2266.6 2269.4 2271.8 2176.8 2191.1 2235.2 2236.1 2238.5 2215.2 2220.9 2222.3 2225.5 2261.8 2187.2 2198.3 2210.0 2214.3 2215.4 2145.8 2150.4 2153.5 2154.3 2160.7 8904.1 8950.7 8963.7 8965.6 8968.4 5015.1 5181.6 5181.7 5236.9 5238.6 3287.6 3414.2 3445.5 3455.2 3492.0 1076.9 1108.2 1111.1 1122.2 1126.1 12180.1 12251.4 12274.5 12338.2 12359.4 4282.6 4372.5 4501.0 4567.5 4612.8 9730.8 9735.8 9736.9 9749.0 9755.1 5091.1 5098.0 5098.5 5101.6 5108.2 4100.8 4340.9 4412.1 4810.9 4826.9 3647.4 3747.4 3749.7 3805.9 3838.2 1107.2 1112.9 1115.5 1128.8 1135.3 875.4 875.9 897.1 914.9 933.9 5575.7 5611.4 5826.2 5880.7 5891.5 889.5 903.2 937.2 937.6 975.3 3827.7 3919.5 4081.1 4182.3 4210.5 10561.4 10666.5 10763.5 10764.9 10791.1 10359.6 10663.9 10664.5 10672.6 10730.0 7994.4 8286.1 8294.5 8297.8 8297.9 5830.4 5851.5 5864.5 5925.2 6088.7 9805.6 10239.4 10255.3 10406.3 10416.5 9377.9 10481.4 10604.2 10623.9 10627.1 7134.6 7526.5 7701.2 7779.5 7997.6 7764.8 7854.9 7856.4 7963.3 8079.4 7499.8 7683.9 7747.1 7771.2 7898.4 7652.5 7654.7 7733.8 7762.5 7885.5 6369.9 6486.7 6518.3 6572.3 6584.8 4872.9 4893.9 4934.6 4942.8 5039.2 4882.9 4885.8 4998.9 5009.9 5066.8 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#4] prototype.html Cycles:180 Average:4606.09 Median:5112.14 stddev:1342.45 (26.3%) stddev-sans-first:1307.20 10:15:14 INFO - PROCESS | 12969 | Values: 325.3 333.9 336.2 338.4 339.7 5296.4 5320.8 5334.2 5345.9 5349.7 5039.8 5105.5 5118.8 5198.2 5324.5 4174.3 4185.7 4188.7 4199.6 4209.3 4185.4 4213.1 4235.1 4250.0 4251.5 3910.6 3965.4 4053.8 4083.9 4190.8 4070.8 4100.7 4110.1 4118.5 4123.8 3615.4 3619.9 3621.1 3624.6 3633.6 5008.2 5042.6 5061.2 5091.9 5125.6 4725.1 4739.9 4747.5 4749.4 4762.2 5426.5 5468.8 5483.9 5485.8 5498.9 3951.0 3986.4 4024.3 4043.9 4068.0 5629.4 5631.3 5638.5 5643.7 5658.6 4124.5 4125.5 4128.5 4134.7 4138.2 4103.0 4177.1 4217.0 4229.8 4234.4 4709.2 4736.6 4742.2 4751.0 4762.3 5548.8 5550.6 5558.9 5574.8 5586.9 1407.2 1441.5 1454.3 1480.2 1481.9 938.6 962.7 973.9 974.7 977.7 4547.5 4759.5 4780.3 4800.6 4819.9 4965.3 4971.4 4997.2 5076.2 5100.9 4676.6 4732.3 4759.6 4763.3 4789.4 2685.7 2693.9 2705.9 2857.8 3024.5 5882.6 5928.5 5940.3 5943.6 5943.9 5772.2 5796.8 5802.5 5810.6 5814.8 5661.4 5799.4 5803.5 5830.2 5890.3 5565.7 5605.2 5619.6 5641.7 5670.9 5486.8 5598.7 5668.3 5680.8 5698.2 5836.8 5883.0 5890.4 5932.5 5944.3 4059.6 4066.9 4067.0 4077.3 4080.2 5239.7 5475.3 5597.0 5657.5 5669.7 5449.8 5489.8 5494.3 5507.6 5519.8 5275.0 5467.8 5474.5 5479.6 5483.7 5336.4 5383.2 5427.7 5449.2 5456.2 5508.0 5508.3 5510.3 5533.7 5592.8 5304.2 5360.6 5417.6 5423.2 5440.2 10:15:14 INFO - PROCESS | 12969 | 10:15:14 INFO - PROCESS | 12969 | [#5] yui.html Cycles:180 Average:19410.61 Median:4522.97 stddev:27052.05 (598.1%) stddev-sans-first:27091.07 10:15:14 INFO - PROCESS | 12969 | Values: 600.6 644.9 651.9 678.6 723.3 12980.2 13554.7 13875.2 13901.4 13928.9 13140.8 13183.3 13242.7 13283.1 13402.5 610.3 794.0 813.9 816.7 817.0 498.2 796.5 813.0 817.8 821.4 865.2 867.0 867.3 867.3 872.4 704.9 855.1 860.3 868.2 868.7 509.7 610.7 618.6 624.7 626.0 13982.7 14016.8 14027.9 14029.7 14040.1 12918.9 13432.7 13825.9 13918.7 14050.4 13468.5 13546.2 13606.7 13619.5 13648.8 4406.6 4417.9 4471.0 4510.5 4535.4 79949.2 79952.6 80201.2 80297.0 80388.6 11330.2 11411.3 11705.8 11783.2 11920.8 21475.8 21532.2 21540.8 21547.8 21605.4 7476.2 7801.9 7838.3 8062.2 8213.3 4214.7 4337.7 4353.1 4379.1 4409.7 3357.6 3486.0 3496.9 3502.1 3504.1 563.2 573.1 578.7 585.3 594.8 584.5 614.3 644.5 645.9 655.9 8111.4 8465.4 8474.2 8573.8 8900.1 528.9 531.7 560.0 594.6 597.9 3920.6 4115.8 4143.2 4217.9 4264.0 89270.6 92962.0 93092.5 103131.0 108964.0 52440.7 64674.0 87715.6 89901.1 96690.0 73320.6 75166.2 83359.6 83694.2 86168.6 9401.4 9418.5 9447.1 9600.5 9881.8 49314.3 49325.0 49921.8 51145.2 52987.2 66610.7 69852.7 75161.6 76512.6 77567.0 11769.0 12556.2 12573.8 12611.1 12688.6 12825.1 13271.5 13476.7 14216.6 14245.6 13304.6 13842.7 14268.7 14374.1 14666.8 11514.6 12332.7 12445.9 12679.4 13016.5 12741.6 13374.6 13434.5 13884.2 13951.5 11273.1 11386.4 11460.0 11488.9 11517.8 11341.2 11416.3 11474.6 11578.4 11742.4 10:15:14 INFO - PROCESS | 12969 | -------- Summary: end -------- 10:15:14 INFO - PROCESS | 12969 | 10:15:15 INFO - TEST-INFO | 12969: exit 0 10:15:15 INFO - TEST-OK | dromaeo_css | took 1116175ms 10:15:15 INFO - TEST-START | kraken 10:15:15 INFO - operating with platform_type : linux_ 10:15:15 INFO - Initialising browser for kraken test... 10:15:15 INFO - TEST-INFO | started process 13275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5r9zN/profile http://localhost:49143/getInfo.html) 10:15:19 INFO - PROCESS | 13275 | __metrics Screen width/height:1600/1200 10:15:19 INFO - PROCESS | 13275 | colorDepth:24 10:15:19 INFO - PROCESS | 13275 | Browser inner width/height: 1024/697 10:15:19 INFO - PROCESS | 13275 | __metrics 10:15:20 INFO - PROCESS | 13275 | 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:20 INFO - PROCESS | 13275 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:20 INFO - PROCESS | 13275 | console.error: PushService: 10:15:20 INFO - PROCESS | 13275 | stateChangeProcessEnqueue: Error transitioning state 10:15:20 INFO - PROCESS | 13275 | UnknownError 10:15:21 INFO - TEST-INFO | 13275: exit 0 10:15:21 INFO - Browser initialized. 10:15:21 INFO - Running cycle 1/1 for kraken test... 10:15:21 INFO - TEST-INFO | started process 13358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5r9zN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:33 INFO - PROCESS | 13358 | RSS: Main: 173309952 10:15:33 INFO - PROCESS | 13358 | 10:15:36 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49143/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:36 INFO - PROCESS | 13358 | RSS: Main: 240893952 10:15:36 INFO - PROCESS | 13358 | 10:15:39 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49143/tests/kraken/driver.html?testName=audio-dft) 10:15:40 INFO - PROCESS | 13358 | RSS: Main: 217731072 10:15:40 INFO - PROCESS | 13358 | 10:15:43 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49143/tests/kraken/driver.html?testName=audio-fft) 10:15:43 INFO - PROCESS | 13358 | RSS: Main: 298340352 10:15:43 INFO - PROCESS | 13358 | 10:15:45 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49143/tests/kraken/driver.html?testName=audio-oscillator) 10:15:46 INFO - PROCESS | 13358 | RSS: Main: 207884288 10:15:46 INFO - PROCESS | 13358 | 10:15:48 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:49 INFO - PROCESS | 13358 | RSS: Main: 212398080 10:15:49 INFO - PROCESS | 13358 | 10:15:52 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49143/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:52 INFO - PROCESS | 13358 | RSS: Main: 249511936 10:15:52 INFO - PROCESS | 13358 | 10:15:56 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49143/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:56 INFO - PROCESS | 13358 | RSS: Main: 248479744 10:15:56 INFO - PROCESS | 13358 | 10:15:59 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49143/tests/kraken/driver.html?testName=json-parse-financial) 10:16:00 INFO - PROCESS | 13358 | RSS: Main: 248811520 10:16:00 INFO - PROCESS | 13358 | 10:16:01 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:02 INFO - PROCESS | 13358 | RSS: Main: 210673664 10:16:02 INFO - PROCESS | 13358 | 10:16:04 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:04 INFO - PROCESS | 13358 | RSS: Main: 217661440 10:16:04 INFO - PROCESS | 13358 | 10:16:06 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:07 INFO - PROCESS | 13358 | RSS: Main: 222707712 10:16:07 INFO - PROCESS | 13358 | 10:16:10 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:10 INFO - PROCESS | 13358 | RSS: Main: 222932992 10:16:10 INFO - PROCESS | 13358 | 10:16:13 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:14 INFO - PROCESS | 13358 | RSS: Main: 221065216 10:16:14 INFO - PROCESS | 13358 | 10:16:15 INFO - PROCESS | 13358 | Cycle 1(1): loaded http://localhost:49143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49143/tests/kraken/driver.html?testName=ai-astar) 10:16:15 INFO - PROCESS | 13358 | RSS: Main: 271810560 10:16:15 INFO - PROCESS | 13358 | 10:16:15 INFO - PROCESS | 13358 | __start_tp_report 10:16:15 INFO - PROCESS | 13358 | _x_x_mozilla_page_load 10:16:15 INFO - PROCESS | 13358 | _x_x_mozilla_page_load_details 10:16:15 INFO - PROCESS | 13358 | |i|pagename|runs| 10:16:15 INFO - PROCESS | 13358 | |0;ai-astar;111;112;111;111;111;112;111;109;112;112 10:16:15 INFO - PROCESS | 13358 | |1;audio-beat-detection;145;118;118;164;120;123;120;119;155;125 10:16:15 INFO - PROCESS | 13358 | |2;audio-dft;161;161;161;162;161;163;161;161;162;161 10:16:15 INFO - PROCESS | 13358 | |3;audio-fft;76;77;76;112;75;75;76;77;102;76 10:16:15 INFO - PROCESS | 13358 | |4;audio-oscillator;82;82;113;82;82;81;108;82;82;115 10:16:15 INFO - PROCESS | 13358 | |5;imaging-gaussian-blur;118;117;117;118;116;117;117;117;117;117 10:16:15 INFO - PROCESS | 13358 | |6;imaging-darkroom;146;147;146;147;146;147;146;146;146;146 10:16:15 INFO - PROCESS | 13358 | |7;imaging-desaturate;95;95;94;95;95;97;96;96;95;96 10:16:15 INFO - PROCESS | 13358 | |8;json-parse-financial;52;52;50;52;53;51;52;52;52;52 10:16:15 INFO - PROCESS | 13358 | |9;json-stringify-tinderbox;61;61;61;61;61;61;69;61;61;61 10:16:15 INFO - PROCESS | 13358 | |10;stanford-crypto-aes;79;88;80;87;80;79;79;78;79;79 10:16:15 INFO - PROCESS | 13358 | |11;stanford-crypto-ccm;135;133;129;134;126;127;126;133;178;125 10:16:15 INFO - PROCESS | 13358 | |12;stanford-crypto-pbkdf2;166;171;162;167;165;166;162;163;167;166 10:16:15 INFO - PROCESS | 13358 | |13;stanford-crypto-sha256-iterative;66;65;66;66;65;65;65;66;70;68 10:16:16 INFO - PROCESS | 13358 | __end_tp_report 10:16:16 INFO - PROCESS | 13358 | __start_cc_report 10:16:16 INFO - PROCESS | 13358 | _x_x_mozilla_cycle_collect,1599 10:16:16 INFO - PROCESS | 13358 | __end_cc_report 10:16:16 INFO - PROCESS | 13358 | __startTimestamp1474564575990__endTimestamp 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | ------- Summary: start ------- 10:16:16 INFO - PROCESS | 13358 | Number of tests: 14 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:0.92 (0.8%) stddev-sans-first:0.97 10:16:16 INFO - PROCESS | 13358 | Values: 111.0 112.0 111.0 111.0 111.0 112.0 111.0 109.0 112.0 112.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:124.00 stddev:17.27 (13.9%) stddev-sans-first:17.52 10:16:16 INFO - PROCESS | 13358 | Values: 145.0 118.0 118.0 164.0 120.0 123.0 120.0 119.0 155.0 125.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 10:16:16 INFO - PROCESS | 13358 | Values: 161.0 161.0 161.0 162.0 161.0 163.0 161.0 161.0 162.0 161.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.30 (17.5%) stddev-sans-first:13.91 10:16:16 INFO - PROCESS | 13358 | Values: 76.0 77.0 76.0 112.0 75.0 75.0 76.0 77.0 102.0 76.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:14.66 (17.9%) stddev-sans-first:15.19 10:16:16 INFO - PROCESS | 13358 | Values: 82.0 82.0 113.0 82.0 82.0 81.0 108.0 82.0 82.0 115.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:16:16 INFO - PROCESS | 13358 | Values: 118.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:16:16 INFO - PROCESS | 13358 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 10:16:16 INFO - PROCESS | 13358 | Values: 95.0 95.0 94.0 95.0 95.0 97.0 96.0 96.0 95.0 96.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 10:16:16 INFO - PROCESS | 13358 | Values: 52.0 52.0 50.0 52.0 53.0 51.0 52.0 52.0 52.0 52.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:2.53 (4.1%) stddev-sans-first:2.67 10:16:16 INFO - PROCESS | 13358 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 69.0 61.0 61.0 61.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.50 stddev:3.58 (4.5%) stddev-sans-first:3.74 10:16:16 INFO - PROCESS | 13358 | Values: 79.0 88.0 80.0 87.0 80.0 79.0 79.0 78.0 79.0 79.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:133.00 stddev:15.70 (11.8%) stddev-sans-first:16.65 10:16:16 INFO - PROCESS | 13358 | Values: 135.0 133.0 129.0 134.0 126.0 127.0 126.0 133.0 178.0 125.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:166.00 stddev:2.72 (1.6%) stddev-sans-first:2.88 10:16:16 INFO - PROCESS | 13358 | Values: 166.0 171.0 162.0 167.0 165.0 166.0 162.0 163.0 167.0 166.0 10:16:16 INFO - PROCESS | 13358 | 10:16:16 INFO - PROCESS | 13358 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 10:16:16 INFO - PROCESS | 13358 | Values: 66.0 65.0 66.0 66.0 65.0 65.0 65.0 66.0 70.0 68.0 10:16:16 INFO - PROCESS | 13358 | -------- Summary: end -------- 10:16:16 INFO - PROCESS | 13358 | 10:16:17 INFO - TEST-INFO | 13358: exit 0 10:16:17 INFO - TEST-OK | kraken | took 62015ms 10:16:17 INFO - SUITE-END | took 1178s 10:16:17 INFO - Completed test suite (00:19:38) 10:16:17 INFO - javascript benchmark 10:16:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2997.910062698119, 3023.0779612218266, 3032.545118232265, 3050.0, 3082.660907300198, 5149.201873709581, 5193.922091168631, 5240.397354304256, 5283.075461794185, 5320.255164277004, 5195.142801437768, 5244.39689435715, 5263.657862238952, 5285.709285989278, 5325.147976323789, 4727.054589082198, 4821.734804585746, 4824.324594556765, 4830.516948305177, 4939.283803848458, 4869.610431165498, 4904.06822703687, 4929.383827021622, 4930.7534623268875, 4970.850874473772, 4713.764311784397, 4727.598154156901, 4742.620590352763, 4773.641976851715, 4887.242477416006, 4802.087603355351, 4804.303376010494, 4851.393575803025, 4861.246506791453, 4879.756012199376, 4729.739864307462, 4758.547937945889, 4772.856814295576, 4779.856604301842, 4818.7831547580445, 5116.769745361467, 5198.610104242197, 5258.8685282867855, 5261.815836445744, 5315.760790764386, 5553.583481238883, 5654.236678048452, 5663.207150998864, 5676.347220069703, 5742.167385729088, 5699.857503562403, 5700.686462244575, 5704.286964129484, 5715.057015592464, 5715.371309155989, 5123.052235336475, 5296.09966305729, 5309.920351194735, 5313.362396512443, 5355.0360935031285, 5607.074832652566, 5711.7144142792695, 5742.3396309424115, 5751.281089863767, 5843.94156058434, 5516.117421212587, 5551.139573366135, 5560.471755183251, 5570.526505247019, 5573.219749235111, 5594.244776955059, 5639.605227634108, 5648.774049038075, 5657.8019769307875, 5659.405762394971, 5492.450754924475, 5546.334439867242, 5550.4449555044985, 5639.0977443609645, 5717.742701578439, 5639.774409023676, 5645.943540564624, 5655.604107712421, 5656.349519805192, 5659.179418984224, 4290.806913688892, 4326.762028088486, 4334.436523251957, 4337.0458499130145, 4343.283358245917, 3873.903152421212, 3888.300105980894, 3892.3188442022533, 3935.4883865097927, 3937.07478742501, 5325.201219817059, 5377.542908852792, 5384.380796208407, 5390.299261096111, 5443.183522471581, 5436.130219164994, 5491.643043202179, 5552.639078459887, 5581.469760372758, 5684.687342196219, 5315.468453154654, 5322.2282768998275, 5322.920156197582, 5368.4631536846, 5380.461953804588, 4858.416989961227, 4887.095887260868, 4888.046830868017, 4896.338994235733, 4949.752512374439, 5767.0, 5780.826575202751, 5783.16144159103, 5811.128330750421, 5849.64902105875, 5643.322801263875, 5694.4590263924865, 5695.914561281501, 5751.654900705971, 5763.538916886555, 5866.530677545871, 5872.29532456108, 5872.471477567039, 5876.471117599265, 5880.558958078076, 5428.647137936022, 5487.0, 5582.720863956867, 5584.162375643686, 5591.860203494945, 5618.775248989995, 5644.85887852807, 5680.573956953328, 5699.629524080921, 5763.077907534942, 5504.752286147213, 5540.63985840919, 5546.278983732089, 5552.139418390156, 5555.388907220284, 5379.112446446293, 5496.285482887199, 5540.418256083214, 5551.2228288040515, 5616.5787565931905, 5363.168708850135, 5411.431799661136, 5446.074167391632, 5475.151351540518, 5570.164475328733, 5571.7492712828835, 5576.33084029919, 5579.0, 5586.497215250647, 5589.329280486368, 5438.129899216106, 5442.0, 5445.564354851682, 5446.1558458439, 5508.807191748269], "value": 5210.484272343979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.795593586309, 584.4710536964044, 592.668105860718, 594.7680404642193, 600.3036477685882, 29376.85311573442, 42654.36018459726, 44355.0, 44403.33394999074, 47262.763686181606, 44045.11909761803, 44975.100497990104, 45006.7749661252, 45060.549394506044, 45129.54870451295, 8930.464172149676, 9078.137576930181, 9085.954570227139, 9089.0, 9090.409123406956, 8922.197002269795, 9044.231240344545, 9047.276217902585, 9054.32092593055, 9054.32092593055, 8922.286217102615, 8965.506897120657, 9018.639254429814, 9037.95481022594, 9039.638414463414, 8917.0, 8961.327900407496, 8969.641214351419, 8988.730338089868, 9027.503487308195, 8903.24322432594, 8981.281497480186, 8986.14631609996, 8991.55042247885, 8992.640294388282, 41720.1655966879, 42163.1567368654, 42238.788806055774, 42248.366274505905, 42273.36589951153, 3312.3540909522653, 3319.68462996015, 3329.8002119872885, 3627.8548858045647, 3652.4703917932015, 31846.363072738648, 31992.541421395024, 32298.83850580732, 32330.547726022953, 33305.0, 3565.8217089145437, 3591.94612080819, 3626.601073881871, 3716.591174970751, 3756.6055564165918, 327042.0, 330062.0, 330627.0, 331713.0, 332238.99999999756, 58873.0, 59784.402155977885, 59830.70084649549, 59915.0, 59920.70039649774, 53078.73460632672, 55696.44303556912, 56638.43361566414, 64578.0, 64739.676301618194, 14725.779113313309, 15131.848681513044, 15136.697266054618, 15147.621309467351, 15155.242237888062, 11273.210875238654, 11289.49197286124, 11307.773844523064, 11319.094472442184, 11326.15053870963, 16468.341266349453, 16883.83116168847, 18372.0, 18653.81346186548, 18810.905945470186, 6702.430293425016, 6900.758473453506, 6907.171139463297, 6954.23503414624, 7072.92927070733, 884.2483888694558, 958.2812890332251, 973.9026097390205, 994.5623925472769, 995.6515219673056, 30290.54564181539, 32305.676943230737, 32352.67647323544, 32471.0, 32568.619418271275, 977.3891317926297, 985.935914165577, 1011.4437059617181, 1043.0351924469835, 1057.8148823955778, 15817.841821581867, 16665.50206135134, 16899.66200676004, 16978.660426791394, 17069.48791536256, 500729.0, 500999.0, 504932.0, 505293.0, 505771.0, 57978.71010645004, 58203.0, 58429.41570584325, 58487.0, 58552.4144758547, 1215.6353094071744, 1238.1456794811552, 1244.4275633208645, 1249.256692268099, 1261.6719652890315, 29426.43890197023, 30821.69178308278, 30968.53547196839, 31236.687633123376, 31272.21819454532, 45291.320630191236, 45330.77334613306, 45348.31977520274, 45479.54520454753, 45611.77194114008, 390569.0, 393003.0, 393510.0, 393750.0, 393827.0, 25093.623595646444, 25858.741412585634, 27568.724312756614, 28737.0, 29318.0, 43554.56445435632, 47286.0, 47333.29000064933, 47774.283385749935, 47935.0, 39262.607373927036, 40423.0, 41059.0, 41207.58792412037, 42051.0, 39190.317403976835, 39721.2055758889, 40256.79871600623, 40606.0, 41207.58792412037, 40225.798871005456, 40244.3963340556, 40627.0, 40885.795571021954, 40899.7955010223, 34479.0, 36301.273974519834, 36420.27159456743, 37169.0707732298, 37279.627203727614, 27185.184444466697, 27787.30531736642, 27839.44321113607, 27939.58090628683, 28028.85985570059], "value": 19432.684226397756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.45646269372116, 393.28618557318464, 400.33943992412526, 403.4694376894384, 420.82746074109605, 13382.130161539506, 15406.537803865875, 19018.809811901876, 19540.609187816237, 19831.801681983176, 18853.15160817763, 19107.140178691956, 19582.11880465379, 19736.60526789467, 19746.802531974678, 5471.671699698031, 5614.747336369853, 5824.446677565625, 5828.9417105828825, 5829.766809327622, 5700.37295897451, 5773.278340207474, 5777.826665200029, 5779.306483222019, 5782.508486778629, 5793.884122317551, 5794.62334948227, 5798.565107616945, 6100.938990610081, 6500.057491663706, 6566.113574667431, 6590.736370545173, 6602.735890564371, 6607.933920660804, 6608.504362172856, 5634.239377684001, 5658.660480371191, 5706.087026075808, 5707.0, 5709.286339207599, 13309.334533273297, 13374.08483904151, 13470.191788492624, 22356.55286894253, 22595.548089038126, 2089.8328133749264, 2136.209602447089, 2233.3411643565023, 2348.189874493297, 2364.8817559121976, 9468.337216394855, 11056.281341712764, 13717.519886804013, 13829.377678004414, 14366.20985845778, 1889.2915156816193, 1976.6012610039315, 2006.6789313709737, 2038.500567361006, 2042.1627132875599, 80242.59878700628, 80400.0, 80866.0, 80923.0, 82182.90530778328, 11115.388653623966, 11207.0, 11382.430878456044, 11443.599474018536, 11564.76870462586, 15485.690286194438, 15513.45702900393, 15616.921915390578, 15773.763393549107, 15779.132147731756, 7349.265073492715, 7415.480916335805, 7468.925310746931, 7636.31273185416, 7816.0, 7109.502334836512, 7124.323189297009, 7130.500864939404, 7299.817504562428, 7313.085864266966, 4861.927071093936, 4866.829660961849, 4867.105099888324, 4923.532264434873, 4965.82619608312, 1848.9352872649392, 1882.5670095878024, 1945.9805401946082, 1971.5071232191951, 2012.3359291433792, 832.1595188859175, 862.4523427623379, 881.8809460722848, 886.9113088691208, 893.6719844804321, 18789.168971211253, 19345.806541934402, 19548.51128721765, 19571.315003974792, 19617.0, 904.7285814255697, 912.1015799437548, 941.1764705882352, 948.7343543807744, 1015.3653966271081, 10156.441395723159, 10687.0, 10735.141188704885, 10816.621418250323, 10955.616553420752, 422156.0, 432565.0, 433222.0, 437174.0, 437732.0, 85729.57135214284, 89239.55380223187, 89262.55368723115, 89573.55213223892, 89816.550917245, 948.2508818033814, 960.596549449233, 989.8762654668167, 992.389680346596, 992.831218692824, 16613.0, 16995.320187192374, 17418.651626967643, 17453.38913138034, 17761.822381776015, 39195.216095678494, 39774.60225397709, 40004.59995400125, 40818.591814081476, 41579.16841663211, 55224.0, 56321.0, 56633.0, 56771.0, 58050.709746451, 8134.83730325402, 8159.632816523389, 8195.549244791593, 8304.252617264476, 8345.374096942633, 11250.262156574912, 12013.219140755822, 12390.5663301784, 12403.25580465175, 12443.813342799684, 10235.232357573062, 10315.27793054479, 10426.843597346198, 10698.090662293793, 11089.556417743523, 10836.241463097507, 10849.945750271198, 10916.945415272872, 11233.66299011031, 11484.368359740294, 10185.134263587383, 10548.836745380828, 10898.564057437614, 10946.945265273622, 11123.499442524944, 7714.575698336421, 8122.75631731049, 8317.542535160625, 8823.07357727455, 8861.512616806138, 10150.54322555472, 10341.931613677445, 10450.42522661261, 10479.371237725762, 11002.449877505933], "value": 8960.491355366252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.9879801201985, 1452.8837692984562, 1498.1310839712967, 1610.6778644271142, 1775.7070083436233, 7691.884621730672, 8481.660733570658, 8671.91328086719, 8733.344999125075, 9022.278217742582, 8806.383553151281, 8884.555772211395, 8891.33315001376, 8900.8664870027, 8948.105189481048, 2243.1924507177405, 2266.2634643740766, 2266.626006708891, 2269.4439862233776, 2271.7501074881748, 2176.836737244705, 2191.1345018717598, 2235.2065016919005, 2236.13908645172, 2238.4963383238724, 2215.2025270902463, 2220.8667479951173, 2222.2666520048347, 2225.4770129019666, 2261.7738226177416, 2187.2344679362254, 2198.3404978506464, 2210.049678638185, 2214.3467677035314, 2215.3575463115676, 2145.817605503534, 2150.4301360139575, 2153.4616345913523, 2154.278316763886, 2160.7299087614047, 8904.109589041109, 8950.731478055668, 8963.68627098055, 8965.641374345083, 8968.417052891606, 5015.0972824891505, 5181.585473162176, 5181.663191892552, 5236.8690782730355, 5238.633295669305, 3287.572615559986, 3414.231797845465, 3445.4659527773233, 3455.1534873956043, 3492.0, 1076.8815430302661, 1108.2187058124002, 1111.0833562311045, 1122.2256642916361, 1126.1103728054827, 12180.147389682637, 12251.448684809206, 12274.509019639203, 12338.198017128858, 12359.382030898509, 4282.593153650399, 4372.453443319585, 4500.977495112504, 4567.474740404829, 4612.815487380467, 9730.756731081638, 9735.805283894282, 9736.853947190797, 9749.0, 9755.122039016522, 5091.134507133796, 5097.974510127426, 5098.490150984871, 5101.617378696613, 5108.208227724708, 4100.774457404812, 4340.913181736348, 4412.139632771643, 4810.855674329776, 4826.927596086061, 3647.4133751818044, 3747.4378843173195, 3749.662530372225, 3805.9238815224094, 3838.1556057667267, 1107.1640911112058, 1112.8910714196713, 1115.4757264085868, 1128.7911736328806, 1135.2677522997785, 875.3784812782995, 875.8642410426394, 897.1028971028971, 914.92680585553, 933.8505839065717, 5575.749091290902, 5611.354694210137, 5826.242588463558, 5880.7353669085, 5891.469767720926, 889.4974339498162, 903.1600611431301, 937.2127412973135, 937.5968333616611, 975.331897650112, 3827.73205875586, 3919.470871432377, 4081.1225586499045, 4182.309918863414, 4210.45264115663, 10561.419121948213, 10666.520006599721, 10763.515641796137, 10764.946175269073, 10791.082757965662, 10359.585616575403, 10663.893361066444, 10664.466776661136, 10672.626458074086, 10730.034296913314, 7994.400419968526, 8286.129956354496, 8294.543800090933, 8297.83404331922, 8297.917020829715, 5830.358660547421, 5851.502622277154, 5864.530837533072, 5925.1704761332585, 6088.695565221633, 9805.55874985613, 10239.436830974368, 10255.33340332876, 10406.323588966692, 10416.479176041015, 9377.859332109887, 10481.37111773296, 10604.151667866707, 10623.946880265548, 10627.09669678055, 7134.571925684476, 7526.473146879666, 7701.152873183833, 7779.533228006338, 7997.560134192675, 7764.805879853049, 7854.882176767467, 7856.410769192219, 7963.323117535075, 8079.394045446497, 7499.775006749806, 7683.9231607683205, 7747.070351557849, 7771.222877712184, 7898.3681305496575, 7652.540847549165, 7654.73208437702, 7733.7679869604, 7762.495437796525, 7885.526868387915, 6369.936300636934, 6486.740530378732, 6518.348165183444, 6572.309907459839, 6584.76953306632, 4872.902541949212, 4893.853184404474, 4934.5805606523845, 4942.75286235694, 5039.168537191323, 4882.92675609859, 4885.7801398937845, 4998.850034498971, 5009.9248511271635, 5066.797328106834], "value": 4511.695508740792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.347677905799, 333.8614474992878, 336.15960099750623, 338.3723193476101, 339.6671262163082, 5296.364436267649, 5320.76056577454, 5334.173203153513, 5345.946540534594, 5349.652272602283, 5039.823606173784, 5105.463926287742, 5118.820841270556, 5198.194279886614, 5324.494173053554, 4174.332106862903, 4185.727927684698, 4188.706790524665, 4199.55904630014, 4209.347551129565, 4185.409544373134, 4213.1363070570615, 4235.08945576701, 4250.0, 4251.5110762262275, 3910.608939106095, 3965.405189221611, 4053.8041277822967, 4083.8979025524304, 4190.790460476979, 4070.7761073140964, 4100.671946244308, 4110.136871257039, 4118.464599602047, 4123.814428350732, 3615.3673107206396, 3619.8552057917914, 3621.149029977953, 3624.6375362463805, 3633.6003039665616, 5008.198688209869, 5042.647014708972, 5061.190209566488, 5091.8981620367385, 5125.641205115643, 4725.078609671115, 4739.905201895977, 4747.52524747526, 4749.408948002423, 4762.166620841339, 5426.503808248211, 5468.808591699271, 5483.930633526464, 5485.780568777244, 5498.890022199534, 3950.9529974556767, 3986.4418981342637, 4024.255512730125, 4043.8584649537124, 4067.9593204068174, 5629.352624448159, 5631.324241091054, 5638.520725738317, 5643.698436414702, 5658.603897727161, 4124.52567954683, 4125.546189919107, 4128.48162620801, 4134.689898257582, 4138.193052354762, 4102.979485102555, 4177.12280421115, 4217.0, 4229.767362795014, 4234.428352172479, 4709.1994360958715, 4736.613321475162, 4742.19382704941, 4750.95249047512, 4762.261849413347, 5548.805791797267, 5550.555955523549, 5558.86102847424, 5574.832755017356, 5586.91619625706, 1407.1754070863406, 1441.5170917742464, 1454.3092031285266, 1480.178500931993, 1481.896267261303, 938.6339327662217, 962.6775030364906, 973.8636590877283, 974.6734843827255, 977.7018009507026, 4547.522510136454, 4759.524047595282, 4780.259059845729, 4800.615950724004, 4819.915519008195, 4965.3048573199785, 4971.353724015855, 4997.175466048061, 5076.213186956028, 5100.923486147711, 4676.625869930397, 4732.313814496879, 4759.595434388047, 4763.261694437368, 4789.353437285922, 2685.650865387487, 2693.871841245394, 2705.945881082367, 2857.842818644953, 3024.4555979923384, 5882.588218824641, 5928.525717942554, 5940.31686356066, 5943.643381397043, 5943.910841337383, 5772.191893134965, 5796.768129274782, 5802.533923082673, 5810.571762659966, 5814.796482123105, 5661.405552417019, 5799.449052340021, 5803.535717142703, 5830.2129212555765, 5890.291815373579, 5565.749541270734, 5605.159226116115, 5619.550435965195, 5641.746121424464, 5670.943290567042, 5486.780528778964, 5598.720063996865, 5668.319801623831, 5680.772769089355, 5698.230738850202, 5836.824895253149, 5883.029070319461, 5890.410958904075, 5932.466078052823, 5944.316403613467, 4059.6143366380147, 4066.898327541835, 4066.9796651016554, 4077.286474866946, 4080.1635664688074, 5239.659422137549, 5475.260839786578, 5597.04850175463, 5657.4908258256955, 5669.716514174357, 5449.782008719607, 5489.807856724996, 5494.313210848644, 5507.642003269774, 5519.75805443772, 5274.97362513185, 5467.835964921059, 5474.479924407175, 5479.589030822784, 5483.738740089722, 5336.3863155736035, 5383.219433182088, 5427.674339539641, 5449.2371068049715, 5456.181572763959, 5507.972460137674, 5508.3114610673665, 5510.338759348904, 5533.667979921218, 5592.7762889483965, 5304.151335786256, 5360.597955153301, 5417.620766546304, 5423.186522021729, 5440.183972404171], "value": 4183.918033202801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5885968111844, 644.8806970710419, 651.938065883741, 678.5691086160286, 723.3309189000173, 12980.221186728792, 13554.728905421885, 13875.2368619726, 13901.374438150282, 13928.93035534821, 13140.802887956688, 13183.274919879403, 13242.735145297089, 13283.136596121245, 13402.46390144393, 610.3286384976535, 793.9642716077776, 813.9145389734082, 816.6814942172557, 817.0195765081896, 498.16059939002895, 796.5300472721093, 813.0243707550933, 817.81190326225, 821.4250024982506, 865.2256230673544, 867.0375882770152, 867.2541614211805, 867.301822033263, 872.4198408058666, 704.9048378468892, 855.0765173612483, 860.3332417376521, 868.2229404682805, 868.6612221233723, 509.6687153350315, 610.7465401858224, 618.5793660310986, 624.7188765055697, 625.9687015649245, 13982.72034559303, 14016.789748153786, 14027.929860350632, 14029.719405611933, 14040.087394319438, 12918.935405323007, 13432.731345373038, 13825.930870345685, 13918.652033699138, 14050.36773345202, 13468.461261549526, 13546.187228766206, 13606.727865442635, 13619.523316683868, 13648.795268070988, 4406.625436837872, 4417.933730994037, 4470.977645111786, 4510.526394728572, 4535.4103966484145, 79949.20050799476, 79952.60023699903, 80201.19798801995, 80297.0, 80388.59805700992, 11330.206885517935, 11411.315321080761, 11705.849947143604, 11783.175177737476, 11920.76158476843, 21475.785242147693, 21532.246371376925, 21540.78459215388, 21547.84521547864, 21605.35183944484, 7476.1776204617445, 7801.882971755428, 7838.294553490099, 8062.1937806220085, 8213.34293256538, 4214.7471151731, 4337.6963612546815, 4353.085851971058, 4379.146066516999, 4409.669274804402, 3357.647447018028, 3486.0064881508647, 3496.8601255949984, 3502.141975216088, 3504.0714210734177, 563.1819781766941, 573.1059547106527, 578.673049726903, 585.3327206984042, 594.7591225553658, 584.4798129664601, 614.27822308787, 644.5166125405946, 645.8966565349522, 655.8950567909112, 8111.3916456266015, 8465.365097617703, 8474.1949514796, 8573.828523429496, 8900.109989001048, 528.8545649946295, 531.7314756048248, 559.9720013999283, 594.6342999055636, 597.8834127345126, 3920.5687374388795, 4115.773632450244, 4143.19207754491, 4217.863543203376, 4263.978680106579, 89270.55364723135, 92962.0, 93092.53453732688, 103131.0, 108964.0, 52440.737796311536, 64674.0, 87715.56142219248, 89901.10098899058, 96690.0, 73320.63339683374, 75166.24833751701, 83359.5832020836, 83694.16305836986, 86168.56915715507, 9401.388909720847, 9418.481983490974, 9447.149756521945, 9600.471974041495, 9881.752956175866, 49314.26028609502, 49325.0, 49921.75039124781, 51145.23282150845, 52987.20519192292, 66610.66694666496, 69852.65073674599, 75161.62419187868, 76512.61743691246, 77567.0, 11769.0, 12556.246625202151, 12573.811392829299, 12611.117221794386, 12688.555900543806, 12825.102242842911, 13271.535496257584, 13476.730465390441, 14216.578342165702, 14245.64385890361, 13304.600861974157, 13842.65393365174, 14268.71462570722, 14374.065685730395, 14666.77999829982, 11514.596989105341, 12332.691682707646, 12445.937770311091, 12679.366031698193, 13016.479340826261, 12741.55404560873, 13374.598762037154, 13434.462621495031, 13884.236366999912, 13951.511697090553, 11273.098152147644, 11386.430678465878, 11460.0, 11488.885111148782, 11517.769644607228, 11341.206115571831, 11416.257943233662, 11474.598389056342, 11578.42107894585, 11742.354170520703], "value": 7184.82173048588, "unit": "score"}], "name": "dromaeo_css", "value": 7052.684787765193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 111.0, 109.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 118.0, 164.0, 120.0, 123.0, 120.0, 119.0, 155.0, 125.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 112.0, 75.0, 75.0, 76.0, 77.0, 102.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 82.0, 82.0, 81.0, 108.0, 82.0, 82.0, 115.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 52.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 69.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 80.0, 87.0, 80.0, 79.0, 79.0, 78.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 129.0, 134.0, 126.0, 127.0, 126.0, 133.0, 178.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 162.0, 167.0, 165.0, 166.0, 162.0, 163.0, 167.0, 166.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 70.0, 68.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1495.8999999999999, "alertThreshold": 2.0}]} 10:16:17 INFO - Return code: 0 10:16:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:17 INFO - # TBPL SUCCESS # 10:16:17 INFO - Running post-action listener: _resource_record_post_action 10:16:17 INFO - [mozharness: 2016-09-22 17:16:17.808989Z] Finished run-tests step (success) 10:16:17 INFO - Running post-run listener: _resource_record_post_run 10:16:17 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 392536064; Read time: 0; Write time: 256612 10:16:17 INFO - TinderboxPrint: CPU usage
13.0% 10:16:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:16:17 INFO - TinderboxPrint: I/O write bytes / time
392,536,064 / 256,612 10:16:17 INFO - TinderboxPrint: CPU idle
8,297.5 (86.9%) 10:16:17 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 10:16:17 INFO - TinderboxPrint: Swap in / out
0 / 0 10:16:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102952960; Read time: 0; Write time: 62172 10:16:17 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288542720; Read time: 0; Write time: 194412 10:16:18 INFO - Running post-run listener: _upload_blobber_files 10:16:18 INFO - Blob upload gear active. 10:16:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:18 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:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:19 INFO - (blobuploader) - INFO - Done attempting. 10:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:20 INFO - (blobuploader) - INFO - Done attempting. 10:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:24 INFO - (blobuploader) - INFO - Done attempting. 10:16:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:24 INFO - Return code: 0 10:16:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1f93a6b819788a7d3f45bf2bba99c4668ca81df4c9bcb63907b266b1ddb809d567a95525f629a7a423cb1861f2823bb9718384b9b7bca3d684af0111eb308e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b927230ab97fc264411b26f39a08ba54f062abfb8e1d2eb4ca0fe6b4309150d9d94681ce6ec123d08494b31f12d529aaeb82b9f66b7afe4f8c1c7d105a43bba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecd06765e48dae0fe9bae2f0c26010d0534fff35d93e23a3b11dee23598c3d53ff775262862f0954ffe39495e4beeadc6f5a0c14f77bb6c452cf3a7b929e3ed3"} 10:16:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:24 INFO - Contents: 10:16:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1f93a6b819788a7d3f45bf2bba99c4668ca81df4c9bcb63907b266b1ddb809d567a95525f629a7a423cb1861f2823bb9718384b9b7bca3d684af0111eb308e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b927230ab97fc264411b26f39a08ba54f062abfb8e1d2eb4ca0fe6b4309150d9d94681ce6ec123d08494b31f12d529aaeb82b9f66b7afe4f8c1c7d105a43bba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecd06765e48dae0fe9bae2f0c26010d0534fff35d93e23a3b11dee23598c3d53ff775262862f0954ffe39495e4beeadc6f5a0c14f77bb6c452cf3a7b929e3ed3"} 10:16:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:24 INFO - Copying logs to upload dir... 10:16:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.898213 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-22 10:16:23.716207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:16:23.719701) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1f93a6b819788a7d3f45bf2bba99c4668ca81df4c9bcb63907b266b1ddb809d567a95525f629a7a423cb1861f2823bb9718384b9b7bca3d684af0111eb308e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b927230ab97fc264411b26f39a08ba54f062abfb8e1d2eb4ca0fe6b4309150d9d94681ce6ec123d08494b31f12d529aaeb82b9f66b7afe4f8c1c7d105a43bba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecd06765e48dae0fe9bae2f0c26010d0534fff35d93e23a3b11dee23598c3d53ff775262862f0954ffe39495e4beeadc6f5a0c14f77bb6c452cf3a7b929e3ed3"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1474551015/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1f93a6b819788a7d3f45bf2bba99c4668ca81df4c9bcb63907b266b1ddb809d567a95525f629a7a423cb1861f2823bb9718384b9b7bca3d684af0111eb308e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b927230ab97fc264411b26f39a08ba54f062abfb8e1d2eb4ca0fe6b4309150d9d94681ce6ec123d08494b31f12d529aaeb82b9f66b7afe4f8c1c7d105a43bba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecd06765e48dae0fe9bae2f0c26010d0534fff35d93e23a3b11dee23598c3d53ff775262862f0954ffe39495e4beeadc6f5a0c14f77bb6c452cf3a7b929e3ed3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:16:23.746687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:16:23.747103) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474563346.72860-444436920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:16:23.833549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:16:23.834072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:16:23.834531) ========= ========= Total master_lag: 0.18 =========