builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1472748297.45 results: success (0) buildid: 20160901092718 builduid: 12abaeaeea074d7e90cb345a62e8b875 revision: 0d714827d06cd931283ce1863994ee3d0ae2763e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.454356) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.454842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.455133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.469878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.470264) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 09:44:57-- 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% 88.6M=0s 2016-09-01 09:44:57 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.564953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.565294) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017299 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:57.615441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 09:44:57.615805) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0d714827d06cd931283ce1863994ee3d0ae2763e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0d714827d06cd931283ce1863994ee3d0ae2763e --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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 09:44:57,895 truncating revision to first 12 chars 2016-09-01 09:44:57,896 Setting DEBUG logging. 2016-09-01 09:44:57,896 attempt 1/10 2016-09-01 09:44:57,896 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0d714827d06c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 09:44:59,287 unpacking tar archive at: autoland-0d714827d06c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.693199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 09:44:59.322436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:59.322757) ========= script_repo_revision: 0d714827d06cd931283ce1863994ee3d0ae2763e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:59.323160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:59.323446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:44:59.332534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-01 09:44:59.332881) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:44:59 INFO - MultiFileLogger online at 20160901 09:44:59 in /builds/slave/test 09:44:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:44:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:59 INFO - {'append_to_log': False, 09:44:59 INFO - 'base_work_dir': '/builds/slave/test', 09:44:59 INFO - 'blob_upload_branch': 'Autoland', 09:44:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:59 INFO - 'branch': 'Autoland', 09:44:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:59 INFO - 'config_files': ('talos/linux_config.py',), 09:44:59 INFO - 'default_actions': ('clobber', 09:44:59 INFO - 'read-buildbot-config', 09:44:59 INFO - 'download-and-extract', 09:44:59 INFO - 'populate-webroot', 09:44:59 INFO - 'create-virtualenv', 09:44:59 INFO - 'install', 09:44:59 INFO - 'run-tests'), 09:44:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:59 INFO - 'download_minidump_stackwalk': True, 09:44:59 INFO - 'download_symbols': 'ondemand', 09:44:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:59 INFO - 'installer_path': 'installer.exe', 09:44:59 INFO - 'log_level': 'info', 09:44:59 INFO - 'log_name': 'talos', 09:44:59 INFO - 'log_to_console': True, 09:44:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:44:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:44:59 INFO - 'opt_config_files': (), 09:44:59 INFO - 'pip_index': False, 09:44:59 INFO - 'sps_profile': False, 09:44:59 INFO - 'sps_profile_interval': 0, 09:44:59 INFO - 'suite': 'dromaeojs', 09:44:59 INFO - 'system_bits': '32', 09:44:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:59 INFO - 'title': 'talos-linux64-ix-060', 09:44:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:59 INFO - 'use_talos_json': True, 09:44:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:59 INFO - 'work_dir': 'build'} 09:44:59 INFO - [mozharness: 2016-09-01 16:44:59.702894Z] Running clobber step. 09:44:59 INFO - Running pre-action listener: _resource_record_pre_action 09:44:59 INFO - Running main action method: clobber 09:44:59 INFO - rmtree: /builds/slave/test/build 09:44:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:00 INFO - Running post-action listener: _resource_record_post_action 09:45:00 INFO - [mozharness: 2016-09-01 16:45:00.164792Z] Finished clobber step (success) 09:45:00 INFO - [mozharness: 2016-09-01 16:45:00.164894Z] Running read-buildbot-config step. 09:45:00 INFO - Running pre-action listener: _resource_record_pre_action 09:45:00 INFO - Running main action method: read_buildbot_config 09:45:00 INFO - Using buildbot properties: 09:45:00 INFO - { 09:45:00 INFO - "project": "", 09:45:00 INFO - "product": "firefox", 09:45:00 INFO - "script_repo_revision": "production", 09:45:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:45:00 INFO - "repository": "", 09:45:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 09:45:00 INFO - "buildid": "20160901092718", 09:45:00 INFO - "stage_platform": "linux64-pgo", 09:45:00 INFO - "basedir": "/builds/slave/test", 09:45:00 INFO - "buildnumber": 165, 09:45:00 INFO - "platform": "ubuntu64_hw", 09:45:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:45:00 INFO - "slavebuilddir": "test", 09:45:00 INFO - "branch": "autoland", 09:45:00 INFO - "revision": "0d714827d06cd931283ce1863994ee3d0ae2763e", 09:45:00 INFO - "slavename": "talos-linux64-ix-060", 09:45:00 INFO - "builduid": "12abaeaeea074d7e90cb345a62e8b875", 09:45:00 INFO - "repo_path": "integration/autoland" 09:45:00 INFO - } 09:45:00 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:45:00 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 09:45:00 INFO - Running post-action listener: _resource_record_post_action 09:45:00 INFO - [mozharness: 2016-09-01 16:45:00.167270Z] Finished read-buildbot-config step (success) 09:45:00 INFO - [mozharness: 2016-09-01 16:45:00.167361Z] Running download-and-extract step. 09:45:00 INFO - Running pre-action listener: _resource_record_pre_action 09:45:00 INFO - Running main action method: download_and_extract 09:45:00 INFO - mkdir: /builds/slave/test/build/tests 09:45:00 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:45:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:45:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:45:00 INFO - Downloaded 1361 bytes. 09:45:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:45:00 INFO - Using the following test package requirements: 09:45:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'jsshell-linux-x86_64.zip'], 09:45:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:00 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:45:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:00 INFO - Downloaded 21903545 bytes. 09:45:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:45:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:04 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:04 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:05 INFO - Downloaded 21903545 bytes. 09:45:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:09 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:09 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:45:10 INFO - Downloaded 14413998 bytes. 09:45:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 09:45: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:45:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:45:10 INFO - Downloaded 59739402 bytes. 09:45:10 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:10 INFO - mkdir: /builds/slave/test/properties 09:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:10 INFO - Contents: 09:45:10 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - Running post-action listener: set_extra_try_arguments 09:45:11 INFO - [mozharness: 2016-09-01 16:45:11.252657Z] Finished download-and-extract step (success) 09:45:11 INFO - [mozharness: 2016-09-01 16:45:11.252885Z] Running populate-webroot step. 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: populate_webroot 09:45:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:11 INFO - '--tppagecycles', 09:45:11 INFO - '7'], 09:45:11 INFO - 'tests': ['tsvgm']}}, 09:45:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['damp', 'tps']}, 09:45:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['damp', 'tps']}, 09:45:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['dromaeo_dom']}, 09:45:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['basic_compositor_video']}, 09:45:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tsvgx', 09:45:11 INFO - 'tsvgr_opacity', 09:45:11 INFO - 'tart', 09:45:11 INFO - 'tscrollx', 09:45:11 INFO - 'cart']}, 09:45:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:11 INFO - 'tsvgr_opacity', 09:45:11 INFO - 'tart', 09:45:11 INFO - 'tscrollx', 09:45:11 INFO - 'cart']}, 09:45:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tp5o']}, 09:45:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['tp5o']}, 09:45:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s', 09:45:11 INFO - '--xperf_path', 09:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:11 INFO - 'tests': ['tp5n']}, 09:45:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--xperf_path', 09:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:11 INFO - 'tests': ['tp5n']}}, 09:45:11 INFO - 'talos.zip': {'path': '', 09:45:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - [mozharness: 2016-09-01 16:45:11.268898Z] Finished populate-webroot step (success) 09:45:11 INFO - [mozharness: 2016-09-01 16:45:11.268988Z] Running create-virtualenv step. 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: create_virtualenv 09:45:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:11 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:45:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:11 INFO - Using real prefix '/usr' 09:45:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:13 INFO - Installing pip.................done. 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45: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:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:13 INFO - Using env: {'DISPLAY': ':0', 09:45:13 INFO - 'HOME': '/home/cltbld', 09:45:13 INFO - 'LANG': 'en_US.UTF-8', 09:45:13 INFO - 'LANGUAGE': 'en_US:en', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MAIL': '/var/mail/cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SHLVL': '1', 09:45:13 INFO - 'TERM': 'linux', 09:45:13 INFO - 'TMOUT': '86400', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - '_': '/tools/buildbot/bin/python'} 09:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:14 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:45:14 INFO - Cleaning up... 09:45:14 INFO - Return code: 0 09:45:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:14 INFO - Using env: {'DISPLAY': ':0', 09:45:14 INFO - 'HOME': '/home/cltbld', 09:45:14 INFO - 'LANG': 'en_US.UTF-8', 09:45:14 INFO - 'LANGUAGE': 'en_US:en', 09:45:14 INFO - 'LOGNAME': 'cltbld', 09:45:14 INFO - 'MAIL': '/var/mail/cltbld', 09:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:14 INFO - 'MOZ_NO_REMOTE': '1', 09:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:14 INFO - 'NO_EM_RESTART': '1', 09:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:14 INFO - 'PWD': '/builds/slave/test', 09:45:14 INFO - 'SHELL': '/bin/bash', 09:45:14 INFO - 'SHLVL': '1', 09:45:14 INFO - 'TERM': 'linux', 09:45:14 INFO - 'TMOUT': '86400', 09:45:14 INFO - 'USER': 'cltbld', 09:45:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:14 INFO - '_': '/tools/buildbot/bin/python'} 09:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:14 INFO - Downloading/unpacking psutil>=3.1.1 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:16 INFO - Installing collected packages: psutil 09:45:16 INFO - Running setup.py install for psutil 09:45:16 INFO - building 'psutil._psutil_linux' extension 09:45:16 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:45:16 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:45:16 INFO - building 'psutil._psutil_posix' extension 09:45:16 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:45:16 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:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:16 INFO - Successfully installed psutil 09:45:16 INFO - Cleaning up... 09:45:16 INFO - Return code: 0 09:45:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:45:16 INFO - Using env: {'DISPLAY': ':0', 09:45:16 INFO - 'HOME': '/home/cltbld', 09:45:16 INFO - 'LANG': 'en_US.UTF-8', 09:45:16 INFO - 'LANGUAGE': 'en_US:en', 09:45:16 INFO - 'LOGNAME': 'cltbld', 09:45:16 INFO - 'MAIL': '/var/mail/cltbld', 09:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:16 INFO - 'MOZ_NO_REMOTE': '1', 09:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:16 INFO - 'NO_EM_RESTART': '1', 09:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:16 INFO - 'PWD': '/builds/slave/test', 09:45:16 INFO - 'SHELL': '/bin/bash', 09:45:16 INFO - 'SHLVL': '1', 09:45:16 INFO - 'TERM': 'linux', 09:45:16 INFO - 'TMOUT': '86400', 09:45:16 INFO - 'USER': 'cltbld', 09:45:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:16 INFO - '_': '/tools/buildbot/bin/python'} 09:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:18 INFO - Installing collected packages: mozsystemmonitor 09:45:18 INFO - Running setup.py install for mozsystemmonitor 09:45:18 INFO - Successfully installed mozsystemmonitor 09:45:18 INFO - Cleaning up... 09:45:19 INFO - Return code: 0 09:45:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:19 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:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:19 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:45:19 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:45:19 INFO - Using env: {'DISPLAY': ':0', 09:45:19 INFO - 'HOME': '/home/cltbld', 09:45:19 INFO - 'LANG': 'en_US.UTF-8', 09:45:19 INFO - 'LANGUAGE': 'en_US:en', 09:45:19 INFO - 'LOGNAME': 'cltbld', 09:45:19 INFO - 'MAIL': '/var/mail/cltbld', 09:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:19 INFO - 'MOZ_NO_REMOTE': '1', 09:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:19 INFO - 'NO_EM_RESTART': '1', 09:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:19 INFO - 'PWD': '/builds/slave/test', 09:45:19 INFO - 'SHELL': '/bin/bash', 09:45:19 INFO - 'SHLVL': '1', 09:45:19 INFO - 'TERM': 'linux', 09:45:19 INFO - 'TMOUT': '86400', 09:45:19 INFO - 'USER': 'cltbld', 09:45:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:19 INFO - '_': '/tools/buildbot/bin/python'} 09:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:21 INFO - warning: no files found matching '*.txt' 09:45:21 INFO - no previously-included directories found matching 'build' 09:45:21 INFO - no previously-included directories found matching 'dist' 09:45:21 INFO - no previously-included directories found matching '.git*' 09:45:21 INFO - Installing collected packages: jsonschema, functools32 09:45:21 INFO - Running setup.py install for functools32 09:45:21 INFO - warning: no files found matching '*.txt' 09:45:21 INFO - no previously-included directories found matching 'build' 09:45:21 INFO - no previously-included directories found matching 'dist' 09:45:21 INFO - no previously-included directories found matching '.git*' 09:45:21 INFO - Successfully installed jsonschema functools32 09:45:21 INFO - Cleaning up... 09:45:21 INFO - Return code: 0 09:45:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45: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:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:45: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 functools32==3.2.3-2 09:45:21 INFO - Using env: {'DISPLAY': ':0', 09:45:21 INFO - 'HOME': '/home/cltbld', 09:45:21 INFO - 'LANG': 'en_US.UTF-8', 09:45:21 INFO - 'LANGUAGE': 'en_US:en', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MAIL': '/var/mail/cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SHLVL': '1', 09:45:21 INFO - 'TERM': 'linux', 09:45:21 INFO - 'TMOUT': '86400', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - '_': '/tools/buildbot/bin/python'} 09:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:21 INFO - Cleaning up... 09:45:21 INFO - Return code: 0 09:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45: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:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45: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 blobuploader==1.2.4 09:45:21 INFO - Using env: {'DISPLAY': ':0', 09:45:21 INFO - 'HOME': '/home/cltbld', 09:45:21 INFO - 'LANG': 'en_US.UTF-8', 09:45:21 INFO - 'LANGUAGE': 'en_US:en', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MAIL': '/var/mail/cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SHLVL': '1', 09:45:21 INFO - 'TERM': 'linux', 09:45:21 INFO - 'TMOUT': '86400', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - '_': '/tools/buildbot/bin/python'} 09:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:24 INFO - Downloading docopt-0.6.1.tar.gz 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:24 INFO - Running setup.py install for blobuploader 09:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:24 INFO - Running setup.py install for requests 09:45:25 INFO - Running setup.py install for docopt 09:45:25 INFO - Successfully installed blobuploader requests docopt 09:45:25 INFO - Cleaning up... 09:45:25 INFO - Return code: 0 09:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:25 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:45:25 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:45:25 INFO - Using env: {'DISPLAY': ':0', 09:45:25 INFO - 'HOME': '/home/cltbld', 09:45:25 INFO - 'LANG': 'en_US.UTF-8', 09:45:25 INFO - 'LANGUAGE': 'en_US:en', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MAIL': '/var/mail/cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SHLVL': '1', 09:45:25 INFO - 'TERM': 'linux', 09:45:25 INFO - 'TMOUT': '86400', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - '_': '/tools/buildbot/bin/python'} 09:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:25 INFO - Running setup.py (path:/tmp/pip-9SxZFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:25 INFO - Running setup.py (path:/tmp/pip-9HPYbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:25 INFO - Running setup.py (path:/tmp/pip-UjjZix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:25 INFO - Running setup.py (path:/tmp/pip-6M0JV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:25 INFO - Running setup.py (path:/tmp/pip-Hdr8WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:25 INFO - Running setup.py (path:/tmp/pip-nF8eFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:25 INFO - Running setup.py (path:/tmp/pip-7thIHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:25 INFO - Running setup.py (path:/tmp/pip-iPBtwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:26 INFO - Running setup.py (path:/tmp/pip-CK4V2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:26 INFO - Running setup.py (path:/tmp/pip-kHwXCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:26 INFO - Running setup.py (path:/tmp/pip-1OGm14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:26 INFO - Running setup.py (path:/tmp/pip-GATpBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:26 INFO - Running setup.py (path:/tmp/pip-HBqgsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:26 INFO - Running setup.py (path:/tmp/pip-zQdMH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:26 INFO - Running setup.py (path:/tmp/pip-Pxvp89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:26 INFO - Running setup.py (path:/tmp/pip-IqCiEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:26 INFO - Running setup.py (path:/tmp/pip-iGZMmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:26 INFO - Running setup.py install for manifestparser 09:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozcrash 09:45:26 INFO - Running setup.py install for mozdebug 09:45:26 INFO - Running setup.py install for mozdevice 09:45:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozfile 09:45:27 INFO - Running setup.py install for mozhttpd 09:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozinfo 09:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozInstall 09:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozleak 09:45:27 INFO - Running setup.py install for mozlog 09:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for moznetwork 09:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozprocess 09:45:27 INFO - Running setup.py install for mozprofile 09:45:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozrunner 09:45:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozscreenshot 09:45:28 INFO - Running setup.py install for moztest 09:45:28 INFO - Running setup.py install for mozversion 09:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:28 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:45:28 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:45:28 INFO - Using env: {'DISPLAY': ':0', 09:45:28 INFO - 'HOME': '/home/cltbld', 09:45:28 INFO - 'LANG': 'en_US.UTF-8', 09:45:28 INFO - 'LANGUAGE': 'en_US:en', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MAIL': '/var/mail/cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SHLVL': '1', 09:45:28 INFO - 'TERM': 'linux', 09:45:28 INFO - 'TMOUT': '86400', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - '_': '/tools/buildbot/bin/python'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Running setup.py (path:/tmp/pip-u910oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 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:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 INFO - Running setup.py (path:/tmp/pip-6_BZ7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 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:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 INFO - Running setup.py (path:/tmp/pip-S9oYEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 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:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 INFO - Running setup.py (path:/tmp/pip-Z7uJxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 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:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:28 INFO - Running setup.py (path:/tmp/pip-Ax9FX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Running setup.py (path:/tmp/pip-e_hhpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Running setup.py (path:/tmp/pip-XkMl88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Running setup.py (path:/tmp/pip-CXtizl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Running setup.py (path:/tmp/pip-DrP6d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Running setup.py (path:/tmp/pip-6OwCic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 INFO - Running setup.py (path:/tmp/pip-shi2we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 INFO - Running setup.py (path:/tmp/pip-TEqFjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 INFO - Running setup.py (path:/tmp/pip-bi1c6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 INFO - Running setup.py (path:/tmp/pip-4P31OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 INFO - Running setup.py (path:/tmp/pip-O7UTM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:29 INFO - Running setup.py (path:/tmp/pip-s_EDLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:29 INFO - Running setup.py (path:/tmp/pip-Ur9WyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:29 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:45:29 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:45:29 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:45:29 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:45:29 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:45:29 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:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:29 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:45:29 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:45:29 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:45:29 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:45:29 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:45:29 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:45:31 INFO - Downloading blessings-1.6.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:31 INFO - Installing collected packages: blessings 09:45:31 INFO - Running setup.py install for blessings 09:45:31 INFO - Successfully installed blessings 09:45:31 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:32 INFO - Reading from file tmpfile_stdout 09:45:32 INFO - Current package versions: 09:45:32 INFO - argparse == 1.2.1 09:45:32 INFO - blessings == 1.6 09:45:32 INFO - blobuploader == 1.2.4 09:45:32 INFO - docopt == 0.6.1 09:45:32 INFO - functools32 == 3.2.3-2 09:45:32 INFO - jsonschema == 2.5.1 09:45:32 INFO - manifestparser == 1.1 09:45:32 INFO - mozInstall == 1.12 09:45:32 INFO - mozcrash == 0.17 09:45:32 INFO - mozdebug == 0.1 09:45:32 INFO - mozdevice == 0.48 09:45:32 INFO - mozfile == 1.2 09:45:32 INFO - mozhttpd == 0.7 09:45:32 INFO - mozinfo == 0.9 09:45:32 INFO - mozleak == 0.1 09:45:32 INFO - mozlog == 3.3 09:45:32 INFO - moznetwork == 0.27 09:45:32 INFO - mozprocess == 0.23 09:45:32 INFO - mozprofile == 0.28 09:45:32 INFO - mozrunner == 6.12 09:45:32 INFO - mozscreenshot == 0.1 09:45:32 INFO - mozsystemmonitor == 0.3 09:45:32 INFO - moztest == 0.7 09:45:32 INFO - mozversion == 1.4 09:45:32 INFO - psutil == 3.1.1 09:45:32 INFO - requests == 1.2.3 09:45:32 INFO - wsgiref == 0.1.2 09:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:32 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:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:32 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:45:32 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:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:32 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:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f714acbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', '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:45:32 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:45:32 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:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:32 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Running post-action listener: _resource_record_post_action 09:45:32 INFO - Running post-action listener: _start_resource_monitoring 09:45:32 INFO - Starting resource monitoring. 09:45:32 INFO - [mozharness: 2016-09-01 16:45:32.740926Z] Finished create-virtualenv step (success) 09:45:32 INFO - [mozharness: 2016-09-01 16:45:32.741439Z] Running install step. 09:45:32 INFO - Running pre-action listener: _resource_record_pre_action 09:45:32 INFO - Running main action method: install 09:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:32 INFO - Reading from file tmpfile_stdout 09:45:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:33 INFO - Reading from file tmpfile_stdout 09:45:33 INFO - Output received: 09:45:33 INFO - Usage: mozinstall [options] installer 09:45:33 INFO - Options: 09:45:33 INFO - -h, --help show this help message and exit 09:45:33 INFO - -d DEST, --destination=DEST 09:45:33 INFO - Directory to install application into. [default: 09:45:33 INFO - "/builds/slave/test"] 09:45:33 INFO - --app=APP Application being installed. [default: firefox] 09:45:33 INFO - mkdir: /builds/slave/test/build/application 09:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:45:50 INFO - Reading from file tmpfile_stdout 09:45:50 INFO - Output received: 09:45:50 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:50 INFO - Running post-action listener: _resource_record_post_action 09:45:50 INFO - [mozharness: 2016-09-01 16:45:50.047448Z] Finished install step (success) 09:45:50 INFO - [mozharness: 2016-09-01 16:45:50.047698Z] Running run-tests step. 09:45:50 INFO - Running pre-action listener: _resource_record_pre_action 09:45:50 INFO - Running main action method: run_tests 09:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:50 INFO - Python 2.7.3 09:45:50 INFO - Return code: 0 09:45:50 INFO - grabbing minidump binary from tooltool 09:45:50 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:45:50 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 0x14ac370>, '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 0x14af8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:50 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:45:50 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:45:50 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:45:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:50 INFO - Return code: 0 09:45:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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:45:50 INFO - Using env: {'DISPLAY': ':0', 09:45:50 INFO - 'HOME': '/home/cltbld', 09:45:50 INFO - 'LANG': 'en_US.UTF-8', 09:45:50 INFO - 'LANGUAGE': 'en_US:en', 09:45:50 INFO - 'LOGNAME': 'cltbld', 09:45:50 INFO - 'MAIL': '/var/mail/cltbld', 09:45:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:50 INFO - 'MOZ_NO_REMOTE': '1', 09:45:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:50 INFO - 'NO_EM_RESTART': '1', 09:45:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:50 INFO - 'PWD': '/builds/slave/test', 09:45:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:50 INFO - 'SHELL': '/bin/bash', 09:45:50 INFO - 'SHLVL': '1', 09:45:50 INFO - 'TERM': 'linux', 09:45:50 INFO - 'TMOUT': '86400', 09:45:50 INFO - 'USER': 'cltbld', 09:45:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969', 09:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:50 INFO - '_': '/tools/buildbot/bin/python'} 09:45:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:45:50 INFO - mozversion application_buildid: 20160901063002 09:45:50 INFO - mozversion application_changeset: 0d714827d06cd931283ce1863994ee3d0ae2763e 09:45:50 INFO - mozversion application_display_name: Nightly 09:45:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:50 INFO - mozversion application_name: Firefox 09:45:50 INFO - mozversion application_remotingname: firefox 09:45:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:45:50 INFO - mozversion application_vendor: Mozilla 09:45:50 INFO - mozversion application_version: 51.0a1 09:45:50 INFO - mozversion platform_buildid: 20160901063002 09:45:50 INFO - mozversion platform_changeset: 0d714827d06cd931283ce1863994ee3d0ae2763e 09:45:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:45:50 INFO - mozversion platform_version: 51.0a1 09:45:50 INFO - using testdate: 1472748350 09:45:50 INFO - actual date: 1472748350 09:45:50 INFO - starting webserver on 'localhost:47485' 09:45:50 INFO - SUITE-START | Running 2 tests 09:45:50 INFO - TEST-START | dromaeo_css 09:45:50 INFO - operating with platform_type : linux_ 09:45:50 INFO - Initialising browser for dromaeo_css test... 09:45:50 INFO - TEST-INFO | started process 15149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq_U3I3/profile http://localhost:47485/getInfo.html) 09:45:54 INFO - PROCESS | 15149 | __metrics Screen width/height:1600/1200 09:45:54 INFO - PROCESS | 15149 | colorDepth:24 09:45:54 INFO - PROCESS | 15149 | Browser inner width/height: 1024/697 09:45:54 INFO - PROCESS | 15149 | __metrics 09:45:55 INFO - PROCESS | 15149 | 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:45:55 INFO - PROCESS | 15149 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:55 INFO - PROCESS | 15149 | console.error: PushService: 09:45:55 INFO - PROCESS | 15149 | stateChangeProcessEnqueue: Error transitioning state 09:45:55 INFO - PROCESS | 15149 | UnknownError 09:45:56 INFO - TEST-INFO | 15149: exit 0 09:45:56 INFO - Browser initialized. 09:45:56 INFO - Running cycle 1/1 for dromaeo_css test... 09:45:56 INFO - TEST-INFO | started process 15233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq_U3I3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:08 INFO - PROCESS | 15233 | RSS: Main: 180772864 09:46:08 INFO - PROCESS | 15233 | 09:46:59 INFO - PROCESS | 15233 | 1472748419639 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:49:09 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47485/tests/dromaeo/cssquery-ext.html) 09:49:10 INFO - PROCESS | 15233 | RSS: Main: 300097536 09:49:10 INFO - PROCESS | 15233 | 09:52:13 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-ext.html (next: http://localhost:47485/tests/dromaeo/cssquery-jquery.html) 09:52:14 INFO - PROCESS | 15233 | RSS: Main: 271572992 09:52:14 INFO - PROCESS | 15233 | 09:55:16 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47485/tests/dromaeo/cssquery-mootools.html) 09:55:16 INFO - PROCESS | 15233 | RSS: Main: 214147072 09:55:16 INFO - PROCESS | 15233 | 09:58:18 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47485/tests/dromaeo/cssquery-prototype.html) 09:58:19 INFO - PROCESS | 15233 | RSS: Main: 214900736 09:58:19 INFO - PROCESS | 15233 | 10:01:22 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47485/tests/dromaeo/cssquery-yui.html) 10:01:22 INFO - PROCESS | 15233 | RSS: Main: 215900160 10:01:22 INFO - PROCESS | 15233 | 10:04:25 INFO - PROCESS | 15233 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-yui.html (next: http://localhost:47485/tests/dromaeo/cssquery-dojo.html) 10:04:26 INFO - PROCESS | 15233 | RSS: Main: 303538176 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | __start_tp_report 10:04:26 INFO - PROCESS | 15233 | _x_x_mozilla_page_load 10:04:26 INFO - PROCESS | 15233 | _x_x_mozilla_page_load_details 10:04:26 INFO - PROCESS | 15233 | |i|pagename|runs| 10:04:26 INFO - PROCESS | 15233 | |0;dojo.html;3019.033909149073;3044.7716421268406;3057.923551911202;3091.196288964871;3115.4703700370933;5153.922691159626;5236.162214045753;5244.662611034181;5349.930013997202;5368.946310536893;5170.844874653757;5177.326947496829;5213.322268105141;5216.5826733861295;5248.21276808478;4691.90616187676;4725.6928299660585;4795.040991801636;4839.346688197101;4846.781894814724;4801.207800712896;4849.684770489925;4855.805767769285;4879;4883;4644.210484217691;4693.108309421199;4764.928526072112;4777.928331075037;4838.322634831126;4751;4752.287156926489;4759.833405830779;4762.190427627277;4768.974670445836;4706.905861882778;4720.315554244616;4722.456917454502;4727.479977202505;4727.574518293336;5177.430482646906;5194.844154675366;5273;5273.578113750891;5353.625246232766;5492.862678433031;5518.503334699856;5525.336959564878;5560.916586251209;5682.176084467729;5636.18275350072;5643.717814109278;5654.491095801356;5655.8586035349035;5658.858528536778;5096.694198348111;5105.489451054939;5205.427402985669;5259.316288882459;5265.684058956514;5733.684647344353;5767.048437007847;5825.097109947965;5837.3287071986415;5840.853978650568;5542.972285138549;5543.667379957215;5545;5546.944530554723;5549.972250138723;5447.972760136174;5500.1749737538885;5535.58483113768;5539.639923404966;5598;5542.085555883315;5545.916811247835;5554.08357620988;5571.554275657938;5622.915656265078;5587.189857470726;5593.692346920959;5594.832155035356;5596.38439771633;5599.216109744639;4242.766647834399;4272.209641216385;4342.261815491374;4359.411479450297;4393.20922234001;3853.9229215415535;3857.6528112470014;3860.0735823402183;3914.1388894443176;3922.2743792398496;5330.173823057432;5337.466253374631;5354.4645535446925;5359.919601205985;5402.405735369106;5535.059039963216;5557.861053473695;5593.972030139823;5625.353084395347;5658.207850900877;5336.1195402758885;5352.785888564492;5356.651817631841;5357.9819834231375;5407.567394608422;4841.201201801663;4850.927236091461;4852.781624826891;4853.733044682576;4905.362302900671;5603.831885043455;5755.280589926259;5775.826725198251;5777.422257774189;5810.622309549865;5641.887162256814;5657.2928383952;5661.122526008476;5662.518685911579;5713.714314284352;5796.652200867961;5803.158542011301;5805.796797112081;5806.9419305806405;5807.535397168301;5394.487523685244;5438.510534051954;5480.205370221375;5498.890022199454;5531.778728850801;5579.581531385081;5623.268975033219;5627.043402621646;5629.127485239795;5681;5483.862903427446;5487.176923461513;5493.752781124939;5493.945060549343;5497.230387745639;5272.868178295574;5438.347398312069;5461.808836690697;5511.58663100261;5518.448155184449;5542.889142217214;5543.25166102571;5543.611947163821;5546.168074788652;5602.327720673546;5499.3675727291875;5528.502434780889;5541.501264886179;5563.499285064364;5571.804986825442;5250.18622113573;5268.5258326749245;5269.71016594091;5349.759260833194;5482.780688772405 10:04:26 INFO - PROCESS | 15233 | |1;ext.html;550.5377938634499;573.9942600573994;599.4095815621613;628.5662892604103;640.6316368088351;32242.193945151383;44214.11571768563;44554.7772261139;44613.55386446135;44708.55291447085;45074.774626126826;45224.321635175496;45291.54708452914;45462.58942095715;45469.54530454695;8107.473014254084;9033.051529589397;9189.08109189079;9195.356325057248;10853.674389768319;10760;10901.83647245292;10918.126549875991;10919.672409827717;10923.071538919201;10968.670939871816;11015.118790496741;11035.282706624084;11047.613333533329;11052.613158539452;8360.958195208985;10780.676579702622;10874.18443616728;10931.672049838557;11028.724281892937;10703.304285221435;10782.245242833005;10782.784344313148;10785.460726963698;10787;43236.783816081035;43542.78228608868;43570.78214608907;43609.56390436119;43619.56380436187;3554.182538016245;3629.4374371972385;3696.2237930034726;3788.9810550947345;3808.257389808988;32232.35535289281;32301.35397292041;32808.3438331232;32918.177045573815;32945;3871.341871881787;4009.1380353223904;4019.7588144711117;4150.937735933963;4205.936910946339;361532;363680;363949;363950.9999999974;365315;52038.47961520412;56845.71577142088;57994.91053439328;59922.40077599168;60425;62172.68913655403;62900.37099628945;63016;63241;63295.6835215821;14721.26393680333;14891.776623350659;14894.627634309229;14902.70194596102;14911.254437278092;10022.047905448972;10833.891661083446;10944.507497162647;11004.614838480615;11032.172587056002;17454.770867389572;17461.38885139014;17539.82460175382;17561.297548097933;17663.293468261127;6100.450959413674;6119.173911521976;6138.907916381258;6184.721687524072;6244.875102497925;906.4108329585822;1007.3200589601989;1037.4812593703148;1051.9631812886664;1053.3100818963592;32187;32406.513902291485;32423.351532969682;32494;33156.66843331584;1097.237419993097;1118.4743170709753;1134.3760931487814;1136.2443974756695;1154.4227886056972;16461;16928.661426771396;17087.401940932006;17132.571685707957;17466.737998930028;524528;525350;529619;529902;532242;59197.40802591919;59460.70269648624;59466;59601.70199148977;59649.40350596525;1190.5535424215918;1257.5347121564896;1277.106025781938;1277.4762347437506;1295.5659853948844;28562.285942851595;32802;33474.497882531294;33661;34179.82910085434;51374;52280.73859630677;52325.47674523206;52362.21456678076;52378;498936;507616;507693;507855;508344;42266.788666057706;42345.576544234165;43556.782216088715;45690.77154614206;46057.76971115123;48303.75848120877;48948.51051489582;49142.26286605632;49393.75303123461;50048.24927626162;40812.38781418341;41172.38241426441;41969.37045944252;43028.13943721171;43744.562554374046;41774.58225417707;42249;42285.36571951362;43350.78324608357;44034;40393.79803101083;40930.590694093866;41520.169596607295;41664.3750343739;42529;36087.819560902026;37757.244855103294;37901;38357.424638631004;38407.61592384152;27230.183094506403;27618.895244190007;27641.585376219777;27736.306592335353;27809.304767380978 10:04:26 INFO - PROCESS | 15233 | |2;jquery.html;379.5881468606562;380.157950140439;399.67027202557887;402.6195245493008;415.3375366290767;15959.920200398996;18851.71722424165;18923.52691182721;19122.713159302602;19186.328478503256;18573.97843118628;18579.81420185798;18900.527486812804;18971.715424268612;19065.90467047663;5058.747062646871;5550.306211723535;5769;5775.740091695884;5831.912521312162;5701.600887937846;5735.655860648353;5763.9711801440935;5771.047777116792;5772.769089236425;5475.917861232085;5639.746211420475;5674.460926212003;5736.942630573703;5737.426257374271;5674.943250567483;5719.571032172604;5720.370759216483;5721.914171287413;5723.341815691187;4938.530839570271;5113.974430127862;5129.743512824344;5136.9743151284;5137.974310128463;23225.651615225786;23361.415964600852;24187.87906060476;24251.514969700682;24974.875125624436;2436.305652888936;2480.937976550583;2510.410053637394;2581.1353196679133;2638.1953504181215;14963.326650300764;15168.165750883696;15388.384464621402;15993.600159995976;16226;2018.3541266794632;2037.836973042168;2050.446379477533;2164.2641501889434;2338.3335749311364;95972;97946.51026744892;99060.50469747605;101068;103159;16413.42553010639;17152.914235428743;17154.571135721708;17239.74140387895;17569.472915812545;31118;31240.375192496023;31244.531332030037;31270.84364578208;31276;8926.86609700855;9130;9221.53892305382;9492.288078394147;9500.42997420157;7499.850003000019;7547.849043019109;7616.314531692175;7800.297973182441;7811.960940195263;8731.25784308341;8788.8681669775;8791.252743516745;8894;9020;3337.1490269981487;3345.1971526833386;3360;3377.560917080764;3471.2536804587135;950.4867371619248;952.2144231009445;966.709987003896;1007.7984403119406;1023.2604572227095;18293.81706182948;18509.167087481095;18640;18794.436166915013;19066.33267835619;950.1923365139576;956.039180623469;979.5591983607405;985.8718366612294;986.911177993984;9895.65365212214;10146.543405546769;10406.843897341394;10431.843522347172;10494.212934029978;485239;486098;488727;490291;492766;54869.45130548644;56220.15669764957;62969.68515157395;96454.51772741231;99058;971.5288085278635;989.8267803134422;992.1843027260097;995.8008398320364;1043.0508237503834;16340.918295408446;16488.422905198262;17308.480745577654;17343.132843358035;17631.647367052843;43418;43655.34516982184;44310;44899;45398.31902521531;59283.703581481815;60862.391376085674;61295.036984013575;61642.383576165455;61994.38005619886;8249.158249158107;8494.32045436376;8688.78278043054;8702.695405660772;8807.075257097913;11850.762984740084;13292.867071329163;13328.800067998794;13391.531296404579;13412.664683382603;10580.735481613021;11107.166962478008;11476.598319058792;11666.591669291534;12017.699557511132;11230.719232019264;11427.828582571434;11466.140039496904;11596.304221746723;11684.532618695157;11388.829167562328;11429.771404572028;11541.422928853692;11757.76484470323;12050.517979281081;8105.75682729519;8364.832703345777;8425.87361189595;8502.702405416028;8724.738257852274;5579.386267510652;8398.916010839814;8448.535330556879;8609.69866054685;10455.477226138815 10:04:26 INFO - PROCESS | 15233 | |3;mootools.html;1257.4844313831331;1416.8583141685829;1443.7473442147623;1565.5929458340836;1759.2874885671308;8061.39539534535;8499.555075637141;8516;8751;8783.165599268075;8528.147185281485;8606.311495080394;8628.827423451527;8636.568171591427;8648.91351086489;2262.5588010338033;2296.6899468571696;2300.0914638717695;2309.4111001694546;2310.757370476101;2225.9888700556558;2271.954560908781;2282.463621049052;2286.6912966749524;2299.574578702937;2210.0220302828957;2225.6327705928584;2225.9220927267547;2266.433391652087;2276.8178545716387;2181.476445653048;2196.8901554922268;2202.0861342542826;2203.6474164133742;2211.0160978364715;2180.9781902180935;2186.202036256771;2186.49710566569;2189.5292512109813;2193.6599827026835;8617.69838055665;8660.220580147818;8712.172343627346;8712.825743485158;8715.607797649058;5138.460461651547;5275.314209152785;5281.260623512711;5283.128283833163;5285.973570132125;3302.8678852845856;3305.5702758641464;3316.651751566099;3331.583552055993;3350.2964377480757;1005.0652892809684;1007.3653598233067;1009.152312057875;1031.9174466042773;1033.5194134727312;10580.047795698423;10776.622818201326;11186.720331991684;11323.20737548372;11410.372429516374;4197.706160568792;4310.935335969963;4379.4087798147475;4444.622207112432;4444.977775111169;9010.098990100938;9044.366894317334;9045.819083618291;9050;9056.728298151065;4995.925061124086;4996.70019798806;4998.300237966688;4999.675021123615;5003.499650034967;4327.394164816928;4575.016371480147;4681.250999840009;4737.810487580458;4761.976190119027;3712.5173727415263;3798.3163030654196;3865.536135663738;3876.341022026262;3913.8043097844993;1109.5506319940437;1115.938623375706;1131.6095946898472;1133.393634405589;1142.1662186603826;798.8841617965479;897.6588896219395;965.8406362950175;979.0992287095889;999.9450030248406;5816.331121921034;6030.819075427744;6068.878622427526;6078.361772013964;6110.358412366638;439.97580133092987;453.36981595582165;467.81988934259874;471.7429001194357;969.8884628267698;3951.4665520154986;4183.581641835853;4194.496660400771;4199.391088292242;4370.694051416434;10313.896861031293;10505.894941050645;10579.4710264488;10592.682219533426;10593.417362045007;10176.236782241362;10510.527026283835;10514.684559463229;10532.05211530966;10541.104006159409;7774.922250777533;8016.639251233709;8038.276555110068;8070.314023308085;8075.344554366458;5686.4029276926985;5698.857528561819;5764.279465066867;5804.796832110856;5932.228810254639;9781.41311521311;9860.26048046385;9885.15976142036;9942.652007180004;9960.651377201762;9506;9872.308938374244;9878.654247101316;9923.057309555581;10015.298929074896;6671.799846004627;6812.386885180159;6852.211995620568;7015.649217539205;7061.435085193275;8380.20388063133;8450.577471126542;8453.408261421642;8455.534945578052;8459.915400845914;7277.053982982178;7373.77878663641;7443.590602516697;7458.589777562069;7565.508241964255;7188.856222875618;7190.057895787666;7216.494845360774;7264.600446975467;7361.337479626859;6842.144731908512;6862.073620061228;6945.652717364213;6954.652267386711;6954.965225173842;5028.874278143076;5157.510036546522;5194.53249207558;5263.052650522943;5294.523492885504;5174.353205849269;5370.028695189509;5392.05639013179;5437.700926449083;5532.2254884317035 10:04:26 INFO - PROCESS | 15233 | |4;prototype.html;322.76276936451717;326.2772957898256;326.35381943751366;347.16679968076613;347.35045464980493;5256.2378455124035;5264.1051021326375;5316.617679403354;5325.467453254672;5325.4940780625875;5281.392639846419;5282.260483532308;5282.683039017662;5298.576113910887;5310.3893052299;3847.634474724897;3973.284808734427;4079.2861249281405;4090.6318431341174;4112.136451345221;4089.3865920111925;4097.426360309559;4107.507099148092;4111.48606424197;4111.958880411187;4067.877963661095;4070.1859628074358;4071;4075.6331930126285;4076.2255171517463;3991.5010623672188;4054.9594504054876;4070.4097905803787;4072.124493233939;4072.9796351018354;3628.4194528875255;3633.364161271767;3635.600083990759;3635.600083990759;3637.636236376368;4951.3810773653295;5000.62495312853;5008.1486147355035;5015.84952451427;5036.521530454601;4444.288913773813;4595.494495605481;4628.629709623222;4639.188142075157;4645.372874661945;5360.785568577252;5363.678179309254;5370.946290537084;5374.973125134388;5379.525418307583;3902.551206611219;3907.3943538751537;3910.3967373377063;3925.941110883339;3932.783696896698;5360.517553420172;5515.44253956204;5614.838287259394;5615.129654903456;5623.297087864017;4071.8371265149062;4077.8368865245056;4081.428599996003;4085.571015043437;4102.692298077656;4136.565660605654;4149.730267532661;4153.54311025787;4154.130641211467;4157.272477316457;4642.419697537808;4652.325412815123;4667.8366257181515;4672.462666793294;4678.345031695565;5167.870803229875;5450.828071964467;5452.727363631802;5454.318210223722;5506.972465137648;1384.6123085536067;1408.7675533537056;1409.6396976917324;1411.774116141433;1416.971660566783;862.1895418306772;893.8033632600817;902.1745103230602;914.8947870994788;923.1922068190333;5169.922451163236;5326.520613144836;5336.493033161843;5338.386085600206;5349.1976203569;5610.915836262459;5612.158176273591;5635.380108188096;5643.717814109278;5645.887082258332;5059.72171530562;5318.22885681574;5323.414424413311;5324.227986941872;5325.920111198335;2937.5153099738304;2988.5666578346454;2992.3865607550833;2993.371392007703;3003.0090070276756;5849.356570777211;5853.707314634251;5854.18041474194;5869.941300587025;5887.7056147193325;5529.612927095145;5615.798994573054;5732.595514098989;5733.627314224562;5799.594028417971;5753.769849206069;5779.855503612359;5781.653100813965;5797.159411885169;5803.129530570448;5397.865053373697;5571;5617.927002922848;5636.718164091861;5640.88718225625;5519.779208831763;5558.638688485235;5563.165525171256;5567.749451274622;5576.749046293007;5708.57185711065;5740.770369185186;5760.9054279686725;5804.94195058044;5819.214406055128;3675.338439080991;3678.124156680059;3832.1760821423527;4039.717219794586;4054.1891621675195;5606.719664016864;5613.316005198506;5614.5789065821045;5616.466435688603;5619.578531610227;5479.150731636602;5487.75305111263;5495.6153069286365;5525.198846167203;5526.005319042611;5207.3490813648295;5466.305445311966;5491.0939694951485;5513;5520.282363292747;5501.917471237854;5512.5314348280845;5515.365732940763;5515.986664867214;5522.199281104297;5278.522013836132;5292;5523.6409633373705;5537.36320323168;5538.6122971391615;5383.380911195262;5405.162199859028;5406.648567843077;5412.431694672003;5431.83704488866 10:04:26 INFO - PROCESS | 15233 | |5;yui.html;796.7609717084873;800.279748226596;815.2866242038218;823.4277177361736;847.309442804115;13415.798763018562;14427.350769215383;15428.305726242317;16240.675186496277;16268.674626507463;16020.679586408265;16030.679386412265;16217.432389866357;16228.43200487983;16254.43109491168;799.952002879829;826.8553003224441;831.5966756123275;832.5795473285982;832.5795473285982;673.8382788130863;794.5034353529045;798.1778767869104;821.9589020548979;824.2622852546967;852.0967774159379;855.5722138930535;856.4732689396039;856.648774002659;857;844.9662013519452;848.9533075680835;849.02362283374;849.477571293653;850.421713235;617.0897925559808;617.8239201827457;619.1826788638998;619.4084649160042;620.3610281410155;14009.159450433006;14019.859801401957;14027.71944561103;14040.438382464688;14047.43810247589;15083.24583770818;15100.471483498024;15102.848971510253;15129;15434.305456254495;12061.758764824654;12112.333821639806;12341.75316493665;12660.55688050923;13111.672208194776;3789.0716774390175;3860.7297489175767;3922.8430862765454;4025.9597404025876;4053.837846486137;81414;82859.58570207171;83581.58209208916;83779;83780.58109709474;11932.22440541362;11935.283882967049;11947.641570752892;12015.33915634631;12144.939275303566;23486;23509.529809403717;23513.88243058808;23514.294571162893;23522.64716029261;8129.187081291823;8307.958460207661;8391.160883911682;8670.653173873101;8879.067697891758;4501.189785838515;4528.343390208402;4660.883477913079;4677.368555245066;4833.782479788418;3472.461768425898;3616.457531370263;3626.020974336914;3630.546181727284;3630.945535816965;589.4842013238416;590.1118816181619;598.5660396212711;598.6378241164033;599.8020653184439;763.1262204775612;776;779.096248351909;782.9217078292239;785.5326080981806;9382.624695012122;9635.421874687541;10050.600948394951;10115.797684046278;10201.74495637615;604.280905722198;630.9935652634041;647.795944277551;760.6577040331873;764.8240904591975;4399.49405818335;4528.252838281713;4659.697119687209;4708.293755936568;4766.744839827691;132728.33635831758;134457;134487;134606;137229;88667;112077;114126;115660;115678;55754.16368754472;58708.11937820936;58735;59089.70455147697;90798.18248018403;8819.162179592928;9258.798347354434;9443.197328227177;9473.478958657064;9519.666811661558;35621;37507.81246093752;44864.10271794611;56973.47176469974;57626;74194.62902685453;74729.62635186789;75257.9690437151;76192;78533.21466785259;13236.338183090615;13412.530561430303;13630.86369136296;13793.24137172465;13825.51610693621;15586.220688965734;15614.45349412765;15790.684186315979;16121.596960076093;16406.015639061694;12909.677258068623;13539.932300338436;14079.0848594841;14377.9281103598;14932.328045237773;12451.190672606252;12844.165129266568;13263.66840828987;13571.93214033963;13838.238896860366;13279;13352;13825.239611821446;13919.23444210578;14420.85579144195;11744.94127529357;11924.880751192377;12427.502899883903;12550.686232843887;12718.364081796059;11938.58214962472;11970.281783093042;12273.938630307148;12450.564230251897;12557.748845022865 10:04:26 INFO - PROCESS | 15233 | __end_tp_report 10:04:26 INFO - PROCESS | 15233 | __start_cc_report 10:04:26 INFO - PROCESS | 15233 | _x_x_mozilla_cycle_collect,1059 10:04:26 INFO - PROCESS | 15233 | __end_cc_report 10:04:26 INFO - PROCESS | 15233 | __startTimestamp1472749466187__endTimestamp 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | ------- Summary: start ------- 10:04:26 INFO - PROCESS | 15233 | Number of tests: 6 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#0] dojo.html Cycles:165 Average:5215.78 Median:5438.51 stddev:582.41 (10.7%) stddev-sans-first:558.12 10:04:26 INFO - PROCESS | 15233 | Values: 3019.0 3044.8 3057.9 3091.2 3115.5 5153.9 5236.2 5244.7 5349.9 5368.9 5170.8 5177.3 5213.3 5216.6 5248.2 4691.9 4725.7 4795.0 4839.3 4846.8 4801.2 4849.7 4855.8 4879.0 4883.0 4644.2 4693.1 4764.9 4777.9 4838.3 4751.0 4752.3 4759.8 4762.2 4769.0 4706.9 4720.3 4722.5 4727.5 4727.6 5177.4 5194.8 5273.0 5273.6 5353.6 5492.9 5518.5 5525.3 5560.9 5682.2 5636.2 5643.7 5654.5 5655.9 5658.9 5096.7 5105.5 5205.4 5259.3 5265.7 5733.7 5767.0 5825.1 5837.3 5840.9 5543.0 5543.7 5545.0 5546.9 5550.0 5448.0 5500.2 5535.6 5539.6 5598.0 5542.1 5545.9 5554.1 5571.6 5622.9 5587.2 5593.7 5594.8 5596.4 5599.2 4242.8 4272.2 4342.3 4359.4 4393.2 3853.9 3857.7 3860.1 3914.1 3922.3 5330.2 5337.5 5354.5 5359.9 5402.4 5535.1 5557.9 5594.0 5625.4 5658.2 5336.1 5352.8 5356.7 5358.0 5407.6 4841.2 4850.9 4852.8 4853.7 4905.4 5603.8 5755.3 5775.8 5777.4 5810.6 5641.9 5657.3 5661.1 5662.5 5713.7 5796.7 5803.2 5805.8 5806.9 5807.5 5394.5 5438.5 5480.2 5498.9 5531.8 5579.6 5623.3 5627.0 5629.1 5681.0 5483.9 5487.2 5493.8 5493.9 5497.2 5272.9 5438.3 5461.8 5511.6 5518.4 5542.9 5543.3 5543.6 5546.2 5602.3 5499.4 5528.5 5541.5 5563.5 5571.8 5250.2 5268.5 5269.7 5349.8 5482.8 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#1] ext.html Cycles:180 Average:63163.18 Median:3940.24 stddev:125046.44 (3173.6%) stddev-sans-first:125308.86 10:04:26 INFO - PROCESS | 15233 | Values: 550.5 574.0 599.4 628.6 640.6 32242.2 44214.1 44554.8 44613.6 44708.6 45074.8 45224.3 45291.5 45462.6 45469.5 8107.5 9033.1 9189.1 9195.4 10853.7 10760.0 10901.8 10918.1 10919.7 10923.1 10968.7 11015.1 11035.3 11047.6 11052.6 8361.0 10780.7 10874.2 10931.7 11028.7 10703.3 10782.2 10782.8 10785.5 10787.0 43236.8 43542.8 43570.8 43609.6 43619.6 3554.2 3629.4 3696.2 3789.0 3808.3 32232.4 32301.4 32808.3 32918.2 32945.0 3871.3 4009.1 4019.8 4150.9 4205.9 361532.0 363680.0 363949.0 363951.0 365315.0 52038.5 56845.7 57994.9 59922.4 60425.0 62172.7 62900.4 63016.0 63241.0 63295.7 14721.3 14891.8 14894.6 14902.7 14911.3 10022.0 10833.9 10944.5 11004.6 11032.2 17454.8 17461.4 17539.8 17561.3 17663.3 6100.5 6119.2 6138.9 6184.7 6244.9 906.4 1007.3 1037.5 1052.0 1053.3 32187.0 32406.5 32423.4 32494.0 33156.7 1097.2 1118.5 1134.4 1136.2 1154.4 16461.0 16928.7 17087.4 17132.6 17466.7 524528.0 525350.0 529619.0 529902.0 532242.0 59197.4 59460.7 59466.0 59601.7 59649.4 1190.6 1257.5 1277.1 1277.5 1295.6 28562.3 32802.0 33474.5 33661.0 34179.8 51374.0 52280.7 52325.5 52362.2 52378.0 498936.0 507616.0 507693.0 507855.0 508344.0 42266.8 42345.6 43556.8 45690.8 46057.8 48303.8 48948.5 49142.3 49393.8 50048.2 40812.4 41172.4 41969.4 43028.1 43744.6 41774.6 42249.0 42285.4 43350.8 44034.0 40393.8 40930.6 41520.2 41664.4 42529.0 36087.8 37757.2 37901.0 38357.4 38407.6 27230.2 27618.9 27641.6 27736.3 27809.3 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#2] jquery.html Cycles:180 Average:29894.02 Median:43536.67 stddev:80628.90 (185.2%) stddev-sans-first:80824.64 10:04:26 INFO - PROCESS | 15233 | Values: 379.6 380.2 399.7 402.6 415.3 15959.9 18851.7 18923.5 19122.7 19186.3 18574.0 18579.8 18900.5 18971.7 19065.9 5058.7 5550.3 5769.0 5775.7 5831.9 5701.6 5735.7 5764.0 5771.0 5772.8 5475.9 5639.7 5674.5 5736.9 5737.4 5674.9 5719.6 5720.4 5721.9 5723.3 4938.5 5114.0 5129.7 5137.0 5138.0 23225.7 23361.4 24187.9 24251.5 24974.9 2436.3 2480.9 2510.4 2581.1 2638.2 14963.3 15168.2 15388.4 15993.6 16226.0 2018.4 2037.8 2050.4 2164.3 2338.3 95972.0 97946.5 99060.5 101068.0 103159.0 16413.4 17152.9 17154.6 17239.7 17569.5 31118.0 31240.4 31244.5 31270.8 31276.0 8926.9 9130.0 9221.5 9492.3 9500.4 7499.9 7547.8 7616.3 7800.3 7812.0 8731.3 8788.9 8791.3 8894.0 9020.0 3337.1 3345.2 3360.0 3377.6 3471.3 950.5 952.2 966.7 1007.8 1023.3 18293.8 18509.2 18640.0 18794.4 19066.3 950.2 956.0 979.6 985.9 986.9 9895.7 10146.5 10406.8 10431.8 10494.2 485239.0 486098.0 488727.0 490291.0 492766.0 54869.5 56220.2 62969.7 96454.5 99058.0 971.5 989.8 992.2 995.8 1043.1 16340.9 16488.4 17308.5 17343.1 17631.6 43418.0 43655.3 44310.0 44899.0 45398.3 59283.7 60862.4 61295.0 61642.4 61994.4 8249.2 8494.3 8688.8 8702.7 8807.1 11850.8 13292.9 13328.8 13391.5 13412.7 10580.7 11107.2 11476.6 11666.6 12017.7 11230.7 11427.8 11466.1 11596.3 11684.5 11388.8 11429.8 11541.4 11757.8 12050.5 8105.8 8364.8 8425.9 8502.7 8724.7 5579.4 8398.9 8448.5 8609.7 10455.5 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#3] mootools.html Cycles:180 Average:5576.41 Median:5083.67 stddev:3134.84 (61.7%) stddev-sans-first:3126.83 10:04:26 INFO - PROCESS | 15233 | Values: 1257.5 1416.9 1443.7 1565.6 1759.3 8061.4 8499.6 8516.0 8751.0 8783.2 8528.1 8606.3 8628.8 8636.6 8648.9 2262.6 2296.7 2300.1 2309.4 2310.8 2226.0 2272.0 2282.5 2286.7 2299.6 2210.0 2225.6 2225.9 2266.4 2276.8 2181.5 2196.9 2202.1 2203.6 2211.0 2181.0 2186.2 2186.5 2189.5 2193.7 8617.7 8660.2 8712.2 8712.8 8715.6 5138.5 5275.3 5281.3 5283.1 5286.0 3302.9 3305.6 3316.7 3331.6 3350.3 1005.1 1007.4 1009.2 1031.9 1033.5 10580.0 10776.6 11186.7 11323.2 11410.4 4197.7 4310.9 4379.4 4444.6 4445.0 9010.1 9044.4 9045.8 9050.0 9056.7 4995.9 4996.7 4998.3 4999.7 5003.5 4327.4 4575.0 4681.3 4737.8 4762.0 3712.5 3798.3 3865.5 3876.3 3913.8 1109.6 1115.9 1131.6 1133.4 1142.2 798.9 897.7 965.8 979.1 999.9 5816.3 6030.8 6068.9 6078.4 6110.4 440.0 453.4 467.8 471.7 969.9 3951.5 4183.6 4194.5 4199.4 4370.7 10313.9 10505.9 10579.5 10592.7 10593.4 10176.2 10510.5 10514.7 10532.1 10541.1 7774.9 8016.6 8038.3 8070.3 8075.3 5686.4 5698.9 5764.3 5804.8 5932.2 9781.4 9860.3 9885.2 9942.7 9960.7 9506.0 9872.3 9878.7 9923.1 10015.3 6671.8 6812.4 6852.2 7015.6 7061.4 8380.2 8450.6 8453.4 8455.5 8459.9 7277.1 7373.8 7443.6 7458.6 7565.5 7188.9 7190.1 7216.5 7264.6 7361.3 6842.1 6862.1 6945.7 6954.7 6955.0 5028.9 5157.5 5194.5 5263.1 5294.5 5174.4 5370.0 5392.1 5437.7 5532.2 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#4] prototype.html Cycles:180 Average:4611.65 Median:5323.82 stddev:1355.94 (25.5%) stddev-sans-first:1320.98 10:04:26 INFO - PROCESS | 15233 | Values: 322.8 326.3 326.4 347.2 347.4 5256.2 5264.1 5316.6 5325.5 5325.5 5281.4 5282.3 5282.7 5298.6 5310.4 3847.6 3973.3 4079.3 4090.6 4112.1 4089.4 4097.4 4107.5 4111.5 4112.0 4067.9 4070.2 4071.0 4075.6 4076.2 3991.5 4055.0 4070.4 4072.1 4073.0 3628.4 3633.4 3635.6 3635.6 3637.6 4951.4 5000.6 5008.1 5015.8 5036.5 4444.3 4595.5 4628.6 4639.2 4645.4 5360.8 5363.7 5370.9 5375.0 5379.5 3902.6 3907.4 3910.4 3925.9 3932.8 5360.5 5515.4 5614.8 5615.1 5623.3 4071.8 4077.8 4081.4 4085.6 4102.7 4136.6 4149.7 4153.5 4154.1 4157.3 4642.4 4652.3 4667.8 4672.5 4678.3 5167.9 5450.8 5452.7 5454.3 5507.0 1384.6 1408.8 1409.6 1411.8 1417.0 862.2 893.8 902.2 914.9 923.2 5169.9 5326.5 5336.5 5338.4 5349.2 5610.9 5612.2 5635.4 5643.7 5645.9 5059.7 5318.2 5323.4 5324.2 5325.9 2937.5 2988.6 2992.4 2993.4 3003.0 5849.4 5853.7 5854.2 5869.9 5887.7 5529.6 5615.8 5732.6 5733.6 5799.6 5753.8 5779.9 5781.7 5797.2 5803.1 5397.9 5571.0 5617.9 5636.7 5640.9 5519.8 5558.6 5563.2 5567.7 5576.7 5708.6 5740.8 5760.9 5804.9 5819.2 3675.3 3678.1 3832.2 4039.7 4054.2 5606.7 5613.3 5614.6 5616.5 5619.6 5479.2 5487.8 5495.6 5525.2 5526.0 5207.3 5466.3 5491.1 5513.0 5520.3 5501.9 5512.5 5515.4 5516.0 5522.2 5278.5 5292.0 5523.6 5537.4 5538.6 5383.4 5405.2 5406.6 5412.4 5431.8 10:04:26 INFO - PROCESS | 15233 | 10:04:26 INFO - PROCESS | 15233 | [#5] yui.html Cycles:180 Average:21348.94 Median:3891.79 stddev:31899.20 (819.7%) stddev-sans-first:31951.36 10:04:26 INFO - PROCESS | 15233 | Values: 796.8 800.3 815.3 823.4 847.3 13415.8 14427.4 15428.3 16240.7 16268.7 16020.7 16030.7 16217.4 16228.4 16254.4 800.0 826.9 831.6 832.6 832.6 673.8 794.5 798.2 822.0 824.3 852.1 855.6 856.5 856.6 857.0 845.0 849.0 849.0 849.5 850.4 617.1 617.8 619.2 619.4 620.4 14009.2 14019.9 14027.7 14040.4 14047.4 15083.2 15100.5 15102.8 15129.0 15434.3 12061.8 12112.3 12341.8 12660.6 13111.7 3789.1 3860.7 3922.8 4026.0 4053.8 81414.0 82859.6 83581.6 83779.0 83780.6 11932.2 11935.3 11947.6 12015.3 12144.9 23486.0 23509.5 23513.9 23514.3 23522.6 8129.2 8308.0 8391.2 8670.7 8879.1 4501.2 4528.3 4660.9 4677.4 4833.8 3472.5 3616.5 3626.0 3630.5 3630.9 589.5 590.1 598.6 598.6 599.8 763.1 776.0 779.1 782.9 785.5 9382.6 9635.4 10050.6 10115.8 10201.7 604.3 631.0 647.8 760.7 764.8 4399.5 4528.3 4659.7 4708.3 4766.7 132728.3 134457.0 134487.0 134606.0 137229.0 88667.0 112077.0 114126.0 115660.0 115678.0 55754.2 58708.1 58735.0 59089.7 90798.2 8819.2 9258.8 9443.2 9473.5 9519.7 35621.0 37507.8 44864.1 56973.5 57626.0 74194.6 74729.6 75258.0 76192.0 78533.2 13236.3 13412.5 13630.9 13793.2 13825.5 15586.2 15614.5 15790.7 16121.6 16406.0 12909.7 13539.9 14079.1 14377.9 14932.3 12451.2 12844.2 13263.7 13571.9 13838.2 13279.0 13352.0 13825.2 13919.2 14420.9 11744.9 11924.9 12427.5 12550.7 12718.4 11938.6 11970.3 12273.9 12450.6 12557.7 10:04:26 INFO - PROCESS | 15233 | -------- Summary: end -------- 10:04:26 INFO - PROCESS | 15233 | 10:04:27 INFO - TEST-INFO | 15233: exit 0 10:04:27 INFO - TEST-OK | dromaeo_css | took 1116826ms 10:04:27 INFO - TEST-START | kraken 10:04:27 INFO - operating with platform_type : linux_ 10:04:27 INFO - Initialising browser for kraken test... 10:04:27 INFO - TEST-INFO | started process 15543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0aiy1/profile http://localhost:47485/getInfo.html) 10:04:31 INFO - PROCESS | 15543 | __metrics Screen width/height:1600/1200 10:04:31 INFO - PROCESS | 15543 | colorDepth:24 10:04:31 INFO - PROCESS | 15543 | Browser inner width/height: 1024/697 10:04:31 INFO - PROCESS | 15543 | __metrics 10:04:31 INFO - PROCESS | 15543 | 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:04:31 INFO - PROCESS | 15543 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:32 INFO - PROCESS | 15543 | console.error: PushService: 10:04:32 INFO - PROCESS | 15543 | stateChangeProcessEnqueue: Error transitioning state 10:04:32 INFO - PROCESS | 15543 | UnknownError 10:04:33 INFO - TEST-INFO | 15543: exit 0 10:04:33 INFO - Browser initialized. 10:04:33 INFO - Running cycle 1/1 for kraken test... 10:04:33 INFO - TEST-INFO | started process 15630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0aiy1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:45 INFO - PROCESS | 15630 | RSS: Main: 180494336 10:04:45 INFO - PROCESS | 15630 | 10:04:47 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:48 INFO - PROCESS | 15630 | RSS: Main: 238530560 10:04:48 INFO - PROCESS | 15630 | 10:04:51 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-dft) 10:04:51 INFO - PROCESS | 15630 | RSS: Main: 225554432 10:04:51 INFO - PROCESS | 15630 | 10:04:54 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-fft) 10:04:55 INFO - PROCESS | 15630 | RSS: Main: 301015040 10:04:55 INFO - PROCESS | 15630 | 10:04:57 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-oscillator) 10:04:58 INFO - PROCESS | 15630 | RSS: Main: 211419136 10:04:58 INFO - PROCESS | 15630 | 10:05:00 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:00 INFO - PROCESS | 15630 | RSS: Main: 214589440 10:05:00 INFO - PROCESS | 15630 | 10:05:03 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:04 INFO - PROCESS | 15630 | RSS: Main: 252743680 10:05:04 INFO - PROCESS | 15630 | 10:05:07 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:08 INFO - PROCESS | 15630 | RSS: Main: 251568128 10:05:08 INFO - PROCESS | 15630 | 10:05:11 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47485/tests/kraken/driver.html?testName=json-parse-financial) 10:05:11 INFO - PROCESS | 15630 | RSS: Main: 251670528 10:05:11 INFO - PROCESS | 15630 | 10:05:13 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:13 INFO - PROCESS | 15630 | RSS: Main: 214253568 10:05:13 INFO - PROCESS | 15630 | 10:05:15 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:16 INFO - PROCESS | 15630 | RSS: Main: 220823552 10:05:16 INFO - PROCESS | 15630 | 10:05:18 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:19 INFO - PROCESS | 15630 | RSS: Main: 222404608 10:05:19 INFO - PROCESS | 15630 | 10:05:21 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:22 INFO - PROCESS | 15630 | RSS: Main: 223490048 10:05:22 INFO - PROCESS | 15630 | 10:05:24 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:25 INFO - PROCESS | 15630 | RSS: Main: 221560832 10:05:25 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47485/tests/kraken/driver.html?testName=ai-astar) 10:05:27 INFO - PROCESS | 15630 | RSS: Main: 272773120 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | __start_tp_report 10:05:27 INFO - PROCESS | 15630 | _x_x_mozilla_page_load 10:05:27 INFO - PROCESS | 15630 | _x_x_mozilla_page_load_details 10:05:27 INFO - PROCESS | 15630 | |i|pagename|runs| 10:05:27 INFO - PROCESS | 15630 | |0;ai-astar;112;112;129;111;111;110;113;112;111;113 10:05:27 INFO - PROCESS | 15630 | |1;audio-beat-detection;155;120;143;181;119;150;148;126;172;119 10:05:27 INFO - PROCESS | 15630 | |2;audio-dft;161;160;161;158;160;162;162;161;160;162 10:05:27 INFO - PROCESS | 15630 | |3;audio-fft;74;75;82;176;76;75;76;76;168;77 10:05:27 INFO - PROCESS | 15630 | |4;audio-oscillator;83;82;144;81;82;81;144;82;82;141 10:05:27 INFO - PROCESS | 15630 | |5;imaging-gaussian-blur;117;116;116;117;117;120;117;116;118;117 10:05:27 INFO - PROCESS | 15630 | |6;imaging-darkroom;147;149;146;147;147;148;148;147;147;147 10:05:27 INFO - PROCESS | 15630 | |7;imaging-desaturate;94;94;95;95;95;94;94;95;96;95 10:05:27 INFO - PROCESS | 15630 | |8;json-parse-financial;52;50;52;52;52;53;54;53;53;51 10:05:27 INFO - PROCESS | 15630 | |9;json-stringify-tinderbox;62;63;62;62;64;62;64;62;63;62 10:05:27 INFO - PROCESS | 15630 | |10;stanford-crypto-aes;78;77;78;79;79;78;78;78;78;78 10:05:27 INFO - PROCESS | 15630 | |11;stanford-crypto-ccm;132;124;124;126;133;128;123;125;163;124 10:05:27 INFO - PROCESS | 15630 | |12;stanford-crypto-pbkdf2;164;167;160;160;164;161;163;164;164;162 10:05:27 INFO - PROCESS | 15630 | |13;stanford-crypto-sha256-iterative;65;65;65;64;64;64;65;65;63;69 10:05:27 INFO - PROCESS | 15630 | __end_tp_report 10:05:27 INFO - PROCESS | 15630 | __start_cc_report 10:05:27 INFO - PROCESS | 15630 | _x_x_mozilla_cycle_collect,1693 10:05:27 INFO - PROCESS | 15630 | __end_cc_report 10:05:27 INFO - PROCESS | 15630 | __startTimestamp1472749527464__endTimestamp 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | ------- Summary: start ------- 10:05:27 INFO - PROCESS | 15630 | Number of tests: 14 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#0] ai-astar Cycles:10 Average:113.40 Median:112.00 stddev:5.56 (5.0%) stddev-sans-first:5.88 10:05:27 INFO - PROCESS | 15630 | Values: 112.0 112.0 129.0 111.0 111.0 110.0 113.0 112.0 111.0 113.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:22.29 (15.0%) stddev-sans-first:23.24 10:05:27 INFO - PROCESS | 15630 | Values: 155.0 120.0 143.0 181.0 119.0 150.0 148.0 126.0 172.0 119.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 10:05:27 INFO - PROCESS | 15630 | Values: 161.0 160.0 161.0 158.0 160.0 162.0 162.0 161.0 160.0 162.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:40.42 (53.2%) stddev-sans-first:42.12 10:05:27 INFO - PROCESS | 15630 | Values: 74.0 75.0 82.0 176.0 76.0 75.0 76.0 76.0 168.0 77.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:82.00 stddev:29.55 (36.0%) stddev-sans-first:30.68 10:05:27 INFO - PROCESS | 15630 | Values: 83.0 82.0 144.0 81.0 82.0 81.0 144.0 82.0 82.0 141.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 10:05:27 INFO - PROCESS | 15630 | Values: 117.0 116.0 116.0 117.0 117.0 120.0 117.0 116.0 118.0 117.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:05:27 INFO - PROCESS | 15630 | Values: 147.0 149.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:05:27 INFO - PROCESS | 15630 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.14 (2.2%) stddev-sans-first:1.20 10:05:27 INFO - PROCESS | 15630 | Values: 52.0 50.0 52.0 52.0 52.0 53.0 54.0 53.0 53.0 51.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:05:27 INFO - PROCESS | 15630 | Values: 62.0 63.0 62.0 62.0 64.0 62.0 64.0 62.0 63.0 62.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 10:05:27 INFO - PROCESS | 15630 | Values: 78.0 77.0 78.0 79.0 79.0 78.0 78.0 78.0 78.0 78.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.00 stddev:12.04 (9.5%) stddev-sans-first:12.75 10:05:27 INFO - PROCESS | 15630 | Values: 132.0 124.0 124.0 126.0 133.0 128.0 123.0 125.0 163.0 124.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.28 10:05:27 INFO - PROCESS | 15630 | Values: 164.0 167.0 160.0 160.0 164.0 161.0 163.0 164.0 164.0 162.0 10:05:27 INFO - PROCESS | 15630 | 10:05:27 INFO - PROCESS | 15630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.60 (2.5%) stddev-sans-first:1.69 10:05:27 INFO - PROCESS | 15630 | Values: 65.0 65.0 65.0 64.0 64.0 64.0 65.0 65.0 63.0 69.0 10:05:27 INFO - PROCESS | 15630 | -------- Summary: end -------- 10:05:27 INFO - PROCESS | 15630 | 10:05:28 INFO - TEST-INFO | 15630: exit 0 10:05:28 INFO - TEST-OK | kraken | took 61558ms 10:05:28 INFO - SUITE-END | took 1178s 10:05:29 INFO - Completed test suite (00:19:38) 10:05:29 INFO - javascript benchmark 10:05:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.033909149073, 3044.7716421268406, 3057.923551911202, 3091.196288964871, 3115.4703700370933, 5153.922691159626, 5236.162214045753, 5244.662611034181, 5349.930013997202, 5368.946310536893, 5170.844874653757, 5177.326947496829, 5213.322268105141, 5216.5826733861295, 5248.21276808478, 4691.90616187676, 4725.6928299660585, 4795.040991801636, 4839.346688197101, 4846.781894814724, 4801.207800712896, 4849.684770489925, 4855.805767769285, 4879.0, 4883.0, 4644.210484217691, 4693.108309421199, 4764.928526072112, 4777.928331075037, 4838.322634831126, 4751.0, 4752.287156926489, 4759.833405830779, 4762.190427627277, 4768.974670445836, 4706.905861882778, 4720.315554244616, 4722.456917454502, 4727.479977202505, 4727.574518293336, 5177.430482646906, 5194.844154675366, 5273.0, 5273.578113750891, 5353.625246232766, 5492.862678433031, 5518.503334699856, 5525.336959564878, 5560.916586251209, 5682.176084467729, 5636.18275350072, 5643.717814109278, 5654.491095801356, 5655.8586035349035, 5658.858528536778, 5096.694198348111, 5105.489451054939, 5205.427402985669, 5259.316288882459, 5265.684058956514, 5733.684647344353, 5767.048437007847, 5825.097109947965, 5837.3287071986415, 5840.853978650568, 5542.972285138549, 5543.667379957215, 5545.0, 5546.944530554723, 5549.972250138723, 5447.972760136174, 5500.1749737538885, 5535.58483113768, 5539.639923404966, 5598.0, 5542.085555883315, 5545.916811247835, 5554.08357620988, 5571.554275657938, 5622.915656265078, 5587.189857470726, 5593.692346920959, 5594.832155035356, 5596.38439771633, 5599.216109744639, 4242.766647834399, 4272.209641216385, 4342.261815491374, 4359.411479450297, 4393.20922234001, 3853.9229215415535, 3857.6528112470014, 3860.0735823402183, 3914.1388894443176, 3922.2743792398496, 5330.173823057432, 5337.466253374631, 5354.4645535446925, 5359.919601205985, 5402.405735369106, 5535.059039963216, 5557.861053473695, 5593.972030139823, 5625.353084395347, 5658.207850900877, 5336.1195402758885, 5352.785888564492, 5356.651817631841, 5357.9819834231375, 5407.567394608422, 4841.201201801663, 4850.927236091461, 4852.781624826891, 4853.733044682576, 4905.362302900671, 5603.831885043455, 5755.280589926259, 5775.826725198251, 5777.422257774189, 5810.622309549865, 5641.887162256814, 5657.2928383952, 5661.122526008476, 5662.518685911579, 5713.714314284352, 5796.652200867961, 5803.158542011301, 5805.796797112081, 5806.9419305806405, 5807.535397168301, 5394.487523685244, 5438.510534051954, 5480.205370221375, 5498.890022199454, 5531.778728850801, 5579.581531385081, 5623.268975033219, 5627.043402621646, 5629.127485239795, 5681.0, 5483.862903427446, 5487.176923461513, 5493.752781124939, 5493.945060549343, 5497.230387745639, 5272.868178295574, 5438.347398312069, 5461.808836690697, 5511.58663100261, 5518.448155184449, 5542.889142217214, 5543.25166102571, 5543.611947163821, 5546.168074788652, 5602.327720673546, 5499.3675727291875, 5528.502434780889, 5541.501264886179, 5563.499285064364, 5571.804986825442, 5250.18622113573, 5268.5258326749245, 5269.71016594091, 5349.759260833194, 5482.780688772405], "value": 5177.220466518442, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5377938634499, 573.9942600573994, 599.4095815621613, 628.5662892604103, 640.6316368088351, 32242.193945151383, 44214.11571768563, 44554.7772261139, 44613.55386446135, 44708.55291447085, 45074.774626126826, 45224.321635175496, 45291.54708452914, 45462.58942095715, 45469.54530454695, 8107.473014254084, 9033.051529589397, 9189.08109189079, 9195.356325057248, 10853.674389768319, 10760.0, 10901.83647245292, 10918.126549875991, 10919.672409827717, 10923.071538919201, 10968.670939871816, 11015.118790496741, 11035.282706624084, 11047.613333533329, 11052.613158539452, 8360.958195208985, 10780.676579702622, 10874.18443616728, 10931.672049838557, 11028.724281892937, 10703.304285221435, 10782.245242833005, 10782.784344313148, 10785.460726963698, 10787.0, 43236.783816081035, 43542.78228608868, 43570.78214608907, 43609.56390436119, 43619.56380436187, 3554.182538016245, 3629.4374371972385, 3696.2237930034726, 3788.9810550947345, 3808.257389808988, 32232.35535289281, 32301.35397292041, 32808.3438331232, 32918.177045573815, 32945.0, 3871.341871881787, 4009.1380353223904, 4019.7588144711117, 4150.937735933963, 4205.936910946339, 361532.0, 363680.0, 363949.0, 363950.9999999974, 365315.0, 52038.47961520412, 56845.71577142088, 57994.91053439328, 59922.40077599168, 60425.0, 62172.68913655403, 62900.37099628945, 63016.0, 63241.0, 63295.6835215821, 14721.26393680333, 14891.776623350659, 14894.627634309229, 14902.70194596102, 14911.254437278092, 10022.047905448972, 10833.891661083446, 10944.507497162647, 11004.614838480615, 11032.172587056002, 17454.770867389572, 17461.38885139014, 17539.82460175382, 17561.297548097933, 17663.293468261127, 6100.450959413674, 6119.173911521976, 6138.907916381258, 6184.721687524072, 6244.875102497925, 906.4108329585822, 1007.3200589601989, 1037.4812593703148, 1051.9631812886664, 1053.3100818963592, 32187.0, 32406.513902291485, 32423.351532969682, 32494.0, 33156.66843331584, 1097.237419993097, 1118.4743170709753, 1134.3760931487814, 1136.2443974756695, 1154.4227886056972, 16461.0, 16928.661426771396, 17087.401940932006, 17132.571685707957, 17466.737998930028, 524528.0, 525350.0, 529619.0, 529902.0, 532242.0, 59197.40802591919, 59460.70269648624, 59466.0, 59601.70199148977, 59649.40350596525, 1190.5535424215918, 1257.5347121564896, 1277.106025781938, 1277.4762347437506, 1295.5659853948844, 28562.285942851595, 32802.0, 33474.497882531294, 33661.0, 34179.82910085434, 51374.0, 52280.73859630677, 52325.47674523206, 52362.21456678076, 52378.0, 498936.0, 507616.0, 507693.0, 507855.0, 508344.0, 42266.788666057706, 42345.576544234165, 43556.782216088715, 45690.77154614206, 46057.76971115123, 48303.75848120877, 48948.51051489582, 49142.26286605632, 49393.75303123461, 50048.24927626162, 40812.38781418341, 41172.38241426441, 41969.37045944252, 43028.13943721171, 43744.562554374046, 41774.58225417707, 42249.0, 42285.36571951362, 43350.78324608357, 44034.0, 40393.79803101083, 40930.590694093866, 41520.169596607295, 41664.3750343739, 42529.0, 36087.819560902026, 37757.244855103294, 37901.0, 38357.424638631004, 38407.61592384152, 27230.183094506403, 27618.895244190007, 27641.585376219777, 27736.306592335353, 27809.304767380978], "value": 20727.163662705658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5881468606562, 380.157950140439, 399.67027202557887, 402.6195245493008, 415.3375366290767, 15959.920200398996, 18851.71722424165, 18923.52691182721, 19122.713159302602, 19186.328478503256, 18573.97843118628, 18579.81420185798, 18900.527486812804, 18971.715424268612, 19065.90467047663, 5058.747062646871, 5550.306211723535, 5769.0, 5775.740091695884, 5831.912521312162, 5701.600887937846, 5735.655860648353, 5763.9711801440935, 5771.047777116792, 5772.769089236425, 5475.917861232085, 5639.746211420475, 5674.460926212003, 5736.942630573703, 5737.426257374271, 5674.943250567483, 5719.571032172604, 5720.370759216483, 5721.914171287413, 5723.341815691187, 4938.530839570271, 5113.974430127862, 5129.743512824344, 5136.9743151284, 5137.974310128463, 23225.651615225786, 23361.415964600852, 24187.87906060476, 24251.514969700682, 24974.875125624436, 2436.305652888936, 2480.937976550583, 2510.410053637394, 2581.1353196679133, 2638.1953504181215, 14963.326650300764, 15168.165750883696, 15388.384464621402, 15993.600159995976, 16226.0, 2018.3541266794632, 2037.836973042168, 2050.446379477533, 2164.2641501889434, 2338.3335749311364, 95972.0, 97946.51026744892, 99060.50469747605, 101068.0, 103159.0, 16413.42553010639, 17152.914235428743, 17154.571135721708, 17239.74140387895, 17569.472915812545, 31118.0, 31240.375192496023, 31244.531332030037, 31270.84364578208, 31276.0, 8926.86609700855, 9130.0, 9221.53892305382, 9492.288078394147, 9500.42997420157, 7499.850003000019, 7547.849043019109, 7616.314531692175, 7800.297973182441, 7811.960940195263, 8731.25784308341, 8788.8681669775, 8791.252743516745, 8894.0, 9020.0, 3337.1490269981487, 3345.1971526833386, 3360.0, 3377.560917080764, 3471.2536804587135, 950.4867371619248, 952.2144231009445, 966.709987003896, 1007.7984403119406, 1023.2604572227095, 18293.81706182948, 18509.167087481095, 18640.0, 18794.436166915013, 19066.33267835619, 950.1923365139576, 956.039180623469, 979.5591983607405, 985.8718366612294, 986.911177993984, 9895.65365212214, 10146.543405546769, 10406.843897341394, 10431.843522347172, 10494.212934029978, 485239.0, 486098.0, 488727.0, 490291.0, 492766.0, 54869.45130548644, 56220.15669764957, 62969.68515157395, 96454.51772741231, 99058.0, 971.5288085278635, 989.8267803134422, 992.1843027260097, 995.8008398320364, 1043.0508237503834, 16340.918295408446, 16488.422905198262, 17308.480745577654, 17343.132843358035, 17631.647367052843, 43418.0, 43655.34516982184, 44310.0, 44899.0, 45398.31902521531, 59283.703581481815, 60862.391376085674, 61295.036984013575, 61642.383576165455, 61994.38005619886, 8249.158249158107, 8494.32045436376, 8688.78278043054, 8702.695405660772, 8807.075257097913, 11850.762984740084, 13292.867071329163, 13328.800067998794, 13391.531296404579, 13412.664683382603, 10580.735481613021, 11107.166962478008, 11476.598319058792, 11666.591669291534, 12017.699557511132, 11230.719232019264, 11427.828582571434, 11466.140039496904, 11596.304221746723, 11684.532618695157, 11388.829167562328, 11429.771404572028, 11541.422928853692, 11757.76484470323, 12050.517979281081, 8105.75682729519, 8364.832703345777, 8425.87361189595, 8502.702405416028, 8724.738257852274, 5579.386267510652, 8398.916010839814, 8448.535330556879, 8609.69866054685, 10455.477226138815], "value": 9855.674623381143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.4844313831331, 1416.8583141685829, 1443.7473442147623, 1565.5929458340836, 1759.2874885671308, 8061.39539534535, 8499.555075637141, 8516.0, 8751.0, 8783.165599268075, 8528.147185281485, 8606.311495080394, 8628.827423451527, 8636.568171591427, 8648.91351086489, 2262.5588010338033, 2296.6899468571696, 2300.0914638717695, 2309.4111001694546, 2310.757370476101, 2225.9888700556558, 2271.954560908781, 2282.463621049052, 2286.6912966749524, 2299.574578702937, 2210.0220302828957, 2225.6327705928584, 2225.9220927267547, 2266.433391652087, 2276.8178545716387, 2181.476445653048, 2196.8901554922268, 2202.0861342542826, 2203.6474164133742, 2211.0160978364715, 2180.9781902180935, 2186.202036256771, 2186.49710566569, 2189.5292512109813, 2193.6599827026835, 8617.69838055665, 8660.220580147818, 8712.172343627346, 8712.825743485158, 8715.607797649058, 5138.460461651547, 5275.314209152785, 5281.260623512711, 5283.128283833163, 5285.973570132125, 3302.8678852845856, 3305.5702758641464, 3316.651751566099, 3331.583552055993, 3350.2964377480757, 1005.0652892809684, 1007.3653598233067, 1009.152312057875, 1031.9174466042773, 1033.5194134727312, 10580.047795698423, 10776.622818201326, 11186.720331991684, 11323.20737548372, 11410.372429516374, 4197.706160568792, 4310.935335969963, 4379.4087798147475, 4444.622207112432, 4444.977775111169, 9010.098990100938, 9044.366894317334, 9045.819083618291, 9050.0, 9056.728298151065, 4995.925061124086, 4996.70019798806, 4998.300237966688, 4999.675021123615, 5003.499650034967, 4327.394164816928, 4575.016371480147, 4681.250999840009, 4737.810487580458, 4761.976190119027, 3712.5173727415263, 3798.3163030654196, 3865.536135663738, 3876.341022026262, 3913.8043097844993, 1109.5506319940437, 1115.938623375706, 1131.6095946898472, 1133.393634405589, 1142.1662186603826, 798.8841617965479, 897.6588896219395, 965.8406362950175, 979.0992287095889, 999.9450030248406, 5816.331121921034, 6030.819075427744, 6068.878622427526, 6078.361772013964, 6110.358412366638, 439.97580133092987, 453.36981595582165, 467.81988934259874, 471.7429001194357, 969.8884628267698, 3951.4665520154986, 4183.581641835853, 4194.496660400771, 4199.391088292242, 4370.694051416434, 10313.896861031293, 10505.894941050645, 10579.4710264488, 10592.682219533426, 10593.417362045007, 10176.236782241362, 10510.527026283835, 10514.684559463229, 10532.05211530966, 10541.104006159409, 7774.922250777533, 8016.639251233709, 8038.276555110068, 8070.314023308085, 8075.344554366458, 5686.4029276926985, 5698.857528561819, 5764.279465066867, 5804.796832110856, 5932.228810254639, 9781.41311521311, 9860.26048046385, 9885.15976142036, 9942.652007180004, 9960.651377201762, 9506.0, 9872.308938374244, 9878.654247101316, 9923.057309555581, 10015.298929074896, 6671.799846004627, 6812.386885180159, 6852.211995620568, 7015.649217539205, 7061.435085193275, 8380.20388063133, 8450.577471126542, 8453.408261421642, 8455.534945578052, 8459.915400845914, 7277.053982982178, 7373.77878663641, 7443.590602516697, 7458.589777562069, 7565.508241964255, 7188.856222875618, 7190.057895787666, 7216.494845360774, 7264.600446975467, 7361.337479626859, 6842.144731908512, 6862.073620061228, 6945.652717364213, 6954.652267386711, 6954.965225173842, 5028.874278143076, 5157.510036546522, 5194.53249207558, 5263.052650522943, 5294.523492885504, 5174.353205849269, 5370.028695189509, 5392.05639013179, 5437.700926449083, 5532.2254884317035], "value": 4411.86627050295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.76276936451717, 326.2772957898256, 326.35381943751366, 347.16679968076613, 347.35045464980493, 5256.2378455124035, 5264.1051021326375, 5316.617679403354, 5325.467453254672, 5325.4940780625875, 5281.392639846419, 5282.260483532308, 5282.683039017662, 5298.576113910887, 5310.3893052299, 3847.634474724897, 3973.284808734427, 4079.2861249281405, 4090.6318431341174, 4112.136451345221, 4089.3865920111925, 4097.426360309559, 4107.507099148092, 4111.48606424197, 4111.958880411187, 4067.877963661095, 4070.1859628074358, 4071.0, 4075.6331930126285, 4076.2255171517463, 3991.5010623672188, 4054.9594504054876, 4070.4097905803787, 4072.124493233939, 4072.9796351018354, 3628.4194528875255, 3633.364161271767, 3635.600083990759, 3635.600083990759, 3637.636236376368, 4951.3810773653295, 5000.62495312853, 5008.1486147355035, 5015.84952451427, 5036.521530454601, 4444.288913773813, 4595.494495605481, 4628.629709623222, 4639.188142075157, 4645.372874661945, 5360.785568577252, 5363.678179309254, 5370.946290537084, 5374.973125134388, 5379.525418307583, 3902.551206611219, 3907.3943538751537, 3910.3967373377063, 3925.941110883339, 3932.783696896698, 5360.517553420172, 5515.44253956204, 5614.838287259394, 5615.129654903456, 5623.297087864017, 4071.8371265149062, 4077.8368865245056, 4081.428599996003, 4085.571015043437, 4102.692298077656, 4136.565660605654, 4149.730267532661, 4153.54311025787, 4154.130641211467, 4157.272477316457, 4642.419697537808, 4652.325412815123, 4667.8366257181515, 4672.462666793294, 4678.345031695565, 5167.870803229875, 5450.828071964467, 5452.727363631802, 5454.318210223722, 5506.972465137648, 1384.6123085536067, 1408.7675533537056, 1409.6396976917324, 1411.774116141433, 1416.971660566783, 862.1895418306772, 893.8033632600817, 902.1745103230602, 914.8947870994788, 923.1922068190333, 5169.922451163236, 5326.520613144836, 5336.493033161843, 5338.386085600206, 5349.1976203569, 5610.915836262459, 5612.158176273591, 5635.380108188096, 5643.717814109278, 5645.887082258332, 5059.72171530562, 5318.22885681574, 5323.414424413311, 5324.227986941872, 5325.920111198335, 2937.5153099738304, 2988.5666578346454, 2992.3865607550833, 2993.371392007703, 3003.0090070276756, 5849.356570777211, 5853.707314634251, 5854.18041474194, 5869.941300587025, 5887.7056147193325, 5529.612927095145, 5615.798994573054, 5732.595514098989, 5733.627314224562, 5799.594028417971, 5753.769849206069, 5779.855503612359, 5781.653100813965, 5797.159411885169, 5803.129530570448, 5397.865053373697, 5571.0, 5617.927002922848, 5636.718164091861, 5640.88718225625, 5519.779208831763, 5558.638688485235, 5563.165525171256, 5567.749451274622, 5576.749046293007, 5708.57185711065, 5740.770369185186, 5760.9054279686725, 5804.94195058044, 5819.214406055128, 3675.338439080991, 3678.124156680059, 3832.1760821423527, 4039.717219794586, 4054.1891621675195, 5606.719664016864, 5613.316005198506, 5614.5789065821045, 5616.466435688603, 5619.578531610227, 5479.150731636602, 5487.75305111263, 5495.6153069286365, 5525.198846167203, 5526.005319042611, 5207.3490813648295, 5466.305445311966, 5491.0939694951485, 5513.0, 5520.282363292747, 5501.917471237854, 5512.5314348280845, 5515.365732940763, 5515.986664867214, 5522.199281104297, 5278.522013836132, 5292.0, 5523.6409633373705, 5537.36320323168, 5538.6122971391615, 5383.380911195262, 5405.162199859028, 5406.648567843077, 5412.431694672003, 5431.83704488866], "value": 4178.824999292068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.7609717084873, 800.279748226596, 815.2866242038218, 823.4277177361736, 847.309442804115, 13415.798763018562, 14427.350769215383, 15428.305726242317, 16240.675186496277, 16268.674626507463, 16020.679586408265, 16030.679386412265, 16217.432389866357, 16228.43200487983, 16254.43109491168, 799.952002879829, 826.8553003224441, 831.5966756123275, 832.5795473285982, 832.5795473285982, 673.8382788130863, 794.5034353529045, 798.1778767869104, 821.9589020548979, 824.2622852546967, 852.0967774159379, 855.5722138930535, 856.4732689396039, 856.648774002659, 857.0, 844.9662013519452, 848.9533075680835, 849.02362283374, 849.477571293653, 850.421713235, 617.0897925559808, 617.8239201827457, 619.1826788638998, 619.4084649160042, 620.3610281410155, 14009.159450433006, 14019.859801401957, 14027.71944561103, 14040.438382464688, 14047.43810247589, 15083.24583770818, 15100.471483498024, 15102.848971510253, 15129.0, 15434.305456254495, 12061.758764824654, 12112.333821639806, 12341.75316493665, 12660.55688050923, 13111.672208194776, 3789.0716774390175, 3860.7297489175767, 3922.8430862765454, 4025.9597404025876, 4053.837846486137, 81414.0, 82859.58570207171, 83581.58209208916, 83779.0, 83780.58109709474, 11932.22440541362, 11935.283882967049, 11947.641570752892, 12015.33915634631, 12144.939275303566, 23486.0, 23509.529809403717, 23513.88243058808, 23514.294571162893, 23522.64716029261, 8129.187081291823, 8307.958460207661, 8391.160883911682, 8670.653173873101, 8879.067697891758, 4501.189785838515, 4528.343390208402, 4660.883477913079, 4677.368555245066, 4833.782479788418, 3472.461768425898, 3616.457531370263, 3626.020974336914, 3630.546181727284, 3630.945535816965, 589.4842013238416, 590.1118816181619, 598.5660396212711, 598.6378241164033, 599.8020653184439, 763.1262204775612, 776.0, 779.096248351909, 782.9217078292239, 785.5326080981806, 9382.624695012122, 9635.421874687541, 10050.600948394951, 10115.797684046278, 10201.74495637615, 604.280905722198, 630.9935652634041, 647.795944277551, 760.6577040331873, 764.8240904591975, 4399.49405818335, 4528.252838281713, 4659.697119687209, 4708.293755936568, 4766.744839827691, 132728.33635831758, 134457.0, 134487.0, 134606.0, 137229.0, 88667.0, 112077.0, 114126.0, 115660.0, 115678.0, 55754.16368754472, 58708.11937820936, 58735.0, 59089.70455147697, 90798.18248018403, 8819.162179592928, 9258.798347354434, 9443.197328227177, 9473.478958657064, 9519.666811661558, 35621.0, 37507.81246093752, 44864.10271794611, 56973.47176469974, 57626.0, 74194.62902685453, 74729.62635186789, 75257.9690437151, 76192.0, 78533.21466785259, 13236.338183090615, 13412.530561430303, 13630.86369136296, 13793.24137172465, 13825.51610693621, 15586.220688965734, 15614.45349412765, 15790.684186315979, 16121.596960076093, 16406.015639061694, 12909.677258068623, 13539.932300338436, 14079.0848594841, 14377.9281103598, 14932.328045237773, 12451.190672606252, 12844.165129266568, 13263.66840828987, 13571.93214033963, 13838.238896860366, 13279.0, 13352.0, 13825.239611821446, 13919.23444210578, 14420.85579144195, 11744.94127529357, 11924.880751192377, 12427.502899883903, 12550.686232843887, 12718.364081796059, 11938.58214962472, 11970.281783093042, 12273.938630307148, 12450.564230251897, 12557.748845022865], "value": 7679.5158371936695, "unit": "score"}], "name": "dromaeo_css", "value": 7287.2541206879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 129.0, 111.0, 111.0, 110.0, 113.0, 112.0, 111.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 143.0, 181.0, 119.0, 150.0, 148.0, 126.0, 172.0, 119.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 158.0, 160.0, 162.0, 162.0, 161.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 82.0, 176.0, 76.0, 75.0, 76.0, 76.0, 168.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 144.0, 81.0, 82.0, 81.0, 144.0, 82.0, 82.0, 141.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 120.0, 117.0, 116.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 52.0, 52.0, 53.0, 54.0, 53.0, 53.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 64.0, 62.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 124.0, 124.0, 126.0, 133.0, 128.0, 123.0, 125.0, 163.0, 124.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 160.0, 160.0, 164.0, 161.0, 163.0, 164.0, 164.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 69.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1523.1000000000004, "alertThreshold": 2.0}]} 10:05:29 INFO - Return code: 0 10:05:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:29 INFO - # TBPL SUCCESS # 10:05:29 INFO - Running post-action listener: _resource_record_post_action 10:05:29 INFO - [mozharness: 2016-09-01 17:05:29.238859Z] Finished run-tests step (success) 10:05:29 INFO - Running post-run listener: _resource_record_post_run 10:05:29 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 413790208; Read time: 0; Write time: 321208 10:05:29 INFO - TinderboxPrint: CPU usage
13.1% 10:05:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:05:29 INFO - TinderboxPrint: I/O write bytes / time
413,790,208 / 321,208 10:05:29 INFO - TinderboxPrint: CPU idle
8,295.0 (86.9%) 10:05:29 INFO - TinderboxPrint: CPU user
1,196.2 (12.5%) 10:05:29 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 124297216; Read time: 0; Write time: 101096 10:05:29 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288964608; Read time: 0; Write time: 220084 10:05:29 INFO - Running post-run listener: _upload_blobber_files 10:05:29 INFO - Blob upload gear active. 10:05:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:29 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:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:05:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:05:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:31 INFO - (blobuploader) - INFO - Done attempting. 10:05:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:05:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:05:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:31 INFO - (blobuploader) - INFO - Done attempting. 10:05:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:35 INFO - (blobuploader) - INFO - Done attempting. 10:05:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:35 INFO - Return code: 0 10:05:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/626447a7815239068eb93579937e5d699ada6b47bc9248e4a010d062cbef8da24010fdab7847e059782d81f298756c2cc769dba2b226961f027fdf485c2ae835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4912127f3cc7f55eb2c28d169e224269a31500131f071022b32e8d7691baf21773245a2298b958c33b0261e8b969fd4fd5d88328e74971ed9731bc715c26aefe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5450cf799bfbc766f6c974462c5dae56d14bfc68c32e5ad3943d70c4d0d96c4a59a9d2efd49a61e3d148bf5402eccc35b58ce9d273fe559d2246bc6fb569224b"} 10:05:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:35 INFO - Contents: 10:05:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/626447a7815239068eb93579937e5d699ada6b47bc9248e4a010d062cbef8da24010fdab7847e059782d81f298756c2cc769dba2b226961f027fdf485c2ae835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4912127f3cc7f55eb2c28d169e224269a31500131f071022b32e8d7691baf21773245a2298b958c33b0261e8b969fd4fd5d88328e74971ed9731bc715c26aefe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5450cf799bfbc766f6c974462c5dae56d14bfc68c32e5ad3943d70c4d0d96c4a59a9d2efd49a61e3d148bf5402eccc35b58ce9d273fe559d2246bc6fb569224b"} 10:05:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:35 INFO - Copying logs to upload dir... 10:05:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.298645 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-01 10:05:35.642565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:05:35.646460) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/626447a7815239068eb93579937e5d699ada6b47bc9248e4a010d062cbef8da24010fdab7847e059782d81f298756c2cc769dba2b226961f027fdf485c2ae835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4912127f3cc7f55eb2c28d169e224269a31500131f071022b32e8d7691baf21773245a2298b958c33b0261e8b969fd4fd5d88328e74971ed9731bc715c26aefe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5450cf799bfbc766f6c974462c5dae56d14bfc68c32e5ad3943d70c4d0d96c4a59a9d2efd49a61e3d148bf5402eccc35b58ce9d273fe559d2246bc6fb569224b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1472736602/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/626447a7815239068eb93579937e5d699ada6b47bc9248e4a010d062cbef8da24010fdab7847e059782d81f298756c2cc769dba2b226961f027fdf485c2ae835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4912127f3cc7f55eb2c28d169e224269a31500131f071022b32e8d7691baf21773245a2298b958c33b0261e8b969fd4fd5d88328e74971ed9731bc715c26aefe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5450cf799bfbc766f6c974462c5dae56d14bfc68c32e5ad3943d70c4d0d96c4a59a9d2efd49a61e3d148bf5402eccc35b58ce9d273fe559d2246bc6fb569224b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:05:35.671978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:05:35.672325) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472748297.11024-1794690969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:05:35.757966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:05:35.758281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:05:35.758571) ========= ========= Total master_lag: 0.17 =========