builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1472195668.08 results: success (0) buildid: 20160825225016 builduid: da04bcf324f541cd81e3f190bc04c2df revision: cdcbb0707964623df33270654bd8600155607e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.081403) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.081874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.082148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.108486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.108776) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 00:14:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 17.3M=0.001s 2016-08-26 00:14:29 (17.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.327255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.449925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.450223) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.499490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:28.499853) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cdcbb0707964623df33270654bd8600155607e77 --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 cdcbb0707964623df33270654bd8600155607e77 --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=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 00:14:29,211 truncating revision to first 12 chars 2016-08-26 00:14:29,212 Setting DEBUG logging. 2016-08-26 00:14:29,212 attempt 1/10 2016-08-26 00:14:29,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cdcbb0707964?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 00:14:29,512 unpacking tar archive at: autoland-cdcbb0707964/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:29.132179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:29.132481) ========= script_repo_revision: cdcbb0707964623df33270654bd8600155607e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:29.132918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:29.133180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:14:29.141657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 00:14:29.141982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:14:29 INFO - MultiFileLogger online at 20160826 00:14:29 in /builds/slave/test 00:14:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 00:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:14:29 INFO - {'append_to_log': False, 00:14:29 INFO - 'base_work_dir': '/builds/slave/test', 00:14:29 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:14:29 INFO - 'branch': 'Autoland-Non-PGO', 00:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 00:14:29 INFO - 'config_files': ('talos/linux_config.py',), 00:14:29 INFO - 'default_actions': ('clobber', 00:14:29 INFO - 'read-buildbot-config', 00:14:29 INFO - 'download-and-extract', 00:14:29 INFO - 'populate-webroot', 00:14:29 INFO - 'create-virtualenv', 00:14:29 INFO - 'install', 00:14:29 INFO - 'run-tests'), 00:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:14:29 INFO - 'download_minidump_stackwalk': True, 00:14:29 INFO - 'download_symbols': 'ondemand', 00:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 00:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 00:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:14:29 INFO - 'installer_path': 'installer.exe', 00:14:29 INFO - 'log_level': 'info', 00:14:29 INFO - 'log_name': 'talos', 00:14:29 INFO - 'log_to_console': True, 00:14:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:14:29 INFO - 'opt_config_files': (), 00:14:29 INFO - 'pip_index': False, 00:14:29 INFO - 'sps_profile': False, 00:14:29 INFO - 'sps_profile_interval': 0, 00:14:29 INFO - 'suite': 'dromaeojs', 00:14:29 INFO - 'system_bits': '32', 00:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:14:29 INFO - 'title': 'talos-linux64-ix-029', 00:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:14:29 INFO - 'use_talos_json': True, 00:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:14:29 INFO - 'work_dir': 'build'} 00:14:29 INFO - [mozharness: 2016-08-26 07:14:29.940720Z] Running clobber step. 00:14:29 INFO - Running pre-action listener: _resource_record_pre_action 00:14:29 INFO - Running main action method: clobber 00:14:29 INFO - rmtree: /builds/slave/test/build 00:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:14:30 INFO - Running post-action listener: _resource_record_post_action 00:14:30 INFO - [mozharness: 2016-08-26 07:14:30.408037Z] Finished clobber step (success) 00:14:30 INFO - [mozharness: 2016-08-26 07:14:30.408141Z] Running read-buildbot-config step. 00:14:30 INFO - Running pre-action listener: _resource_record_pre_action 00:14:30 INFO - Running main action method: read_buildbot_config 00:14:30 INFO - Using buildbot properties: 00:14:30 INFO - { 00:14:30 INFO - "project": "", 00:14:30 INFO - "product": "firefox", 00:14:30 INFO - "script_repo_revision": "production", 00:14:30 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:14:30 INFO - "repository": "", 00:14:30 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:14:30 INFO - "buildid": "20160825225016", 00:14:30 INFO - "pgo_build": "False", 00:14:30 INFO - "basedir": "/builds/slave/test", 00:14:30 INFO - "buildnumber": 369, 00:14:30 INFO - "slavename": "talos-linux64-ix-029", 00:14:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:14:30 INFO - "platform": "ubuntu64_hw", 00:14:30 INFO - "scheduler": "tests-autoland-linux64-talos", 00:14:30 INFO - "branch": "autoland", 00:14:30 INFO - "repo_path": "integration/autoland", 00:14:30 INFO - "revision": "cdcbb0707964623df33270654bd8600155607e77", 00:14:30 INFO - "stage_platform": "linux64", 00:14:30 INFO - "builduid": "da04bcf324f541cd81e3f190bc04c2df", 00:14:30 INFO - "slavebuilddir": "test" 00:14:30 INFO - } 00:14:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:14:30 INFO - Running post-action listener: _resource_record_post_action 00:14:30 INFO - [mozharness: 2016-08-26 07:14:30.410608Z] Finished read-buildbot-config step (success) 00:14:30 INFO - [mozharness: 2016-08-26 07:14:30.410699Z] Running download-and-extract step. 00:14:30 INFO - Running pre-action listener: _resource_record_pre_action 00:14:30 INFO - Running main action method: download_and_extract 00:14:30 INFO - mkdir: /builds/slave/test/build/tests 00:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:30 INFO - trying https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:14:30 INFO - Downloaded 1361 bytes. 00:14:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:14:30 INFO - Using the following test package requirements: 00:14:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:14:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:14:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:14:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'jsshell-linux-x86_64.zip'], 00:14:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:14:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:14:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:14:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:14:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:14:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:14:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:30 INFO - trying https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:14:31 INFO - Downloaded 20302935 bytes. 00:14:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 00:14:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:36 INFO - trying https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:14:36 INFO - Downloaded 20302935 bytes. 00:14:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 00:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:41 INFO - trying https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:14:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:14:42 INFO - Downloaded 14413998 bytes. 00:14:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 00:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:42 INFO - trying https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:14:42 INFO - Downloading https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:14:43 INFO - Downloaded 55906961 bytes. 00:14:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:14:43 INFO - mkdir: /builds/slave/test/properties 00:14:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:14:43 INFO - Writing to file /builds/slave/test/properties/build_url 00:14:43 INFO - Contents: 00:14:43 INFO - build_url:https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:14:44 INFO - Running post-action listener: _resource_record_post_action 00:14:44 INFO - Running post-action listener: set_extra_try_arguments 00:14:44 INFO - [mozharness: 2016-08-26 07:14:44.451214Z] Finished download-and-extract step (success) 00:14:44 INFO - [mozharness: 2016-08-26 07:14:44.451442Z] Running populate-webroot step. 00:14:44 INFO - Running pre-action listener: _resource_record_pre_action 00:14:44 INFO - Running main action method: populate_webroot 00:14:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:14:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:14:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:14:44 INFO - '--tppagecycles', 00:14:44 INFO - '7'], 00:14:44 INFO - 'tests': ['tsvgm']}}, 00:14:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:14:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:14:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:14:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:14:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:14:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:14:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['damp', 'tps']}, 00:14:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'tests': ['damp', 'tps']}, 00:14:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['dromaeo_dom']}, 00:14:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:14:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['basic_compositor_video']}, 00:14:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:14:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'other-e10s': {'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['a11yr', 00:14:44 INFO - 'ts_paint', 00:14:44 INFO - 'tpaint', 00:14:44 INFO - 'sessionrestore', 00:14:44 INFO - 'sessionrestore_no_auto_restore', 00:14:44 INFO - 'tabpaint']}, 00:14:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['tsvgx', 00:14:44 INFO - 'tsvgr_opacity', 00:14:44 INFO - 'tart', 00:14:44 INFO - 'tscrollx', 00:14:44 INFO - 'cart']}, 00:14:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:14:44 INFO - 'tsvgr_opacity', 00:14:44 INFO - 'tart', 00:14:44 INFO - 'tscrollx', 00:14:44 INFO - 'cart']}, 00:14:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'talos_options': ['--disable-e10s'], 00:14:44 INFO - 'tests': ['tp5o']}, 00:14:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'tests': ['tp5o']}, 00:14:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'talos_options': ['--disable-e10s', 00:14:44 INFO - '--xperf_path', 00:14:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:14:44 INFO - 'tests': ['tp5n']}, 00:14:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:44 INFO - 'talos_options': ['--xperf_path', 00:14:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:14:44 INFO - 'tests': ['tp5n']}}, 00:14:44 INFO - 'talos.zip': {'path': '', 00:14:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:14:44 INFO - Running post-action listener: _resource_record_post_action 00:14:44 INFO - [mozharness: 2016-08-26 07:14:44.469527Z] Finished populate-webroot step (success) 00:14:44 INFO - [mozharness: 2016-08-26 07:14:44.469618Z] Running create-virtualenv step. 00:14:44 INFO - Running pre-action listener: _resource_record_pre_action 00:14:44 INFO - Running main action method: create_virtualenv 00:14:44 INFO - Creating virtualenv /builds/slave/test/build/venv 00:14:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:14:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:14:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:14:44 INFO - Using real prefix '/usr' 00:14:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:14:45 INFO - Installing distribute.............................................................................................................................................................................................done. 00:14:47 INFO - Installing pip.................done. 00:14:47 INFO - Return code: 0 00:14:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:47 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 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:14:47 INFO - Using env: {'DISPLAY': ':0', 00:14:47 INFO - 'HOME': '/home/cltbld', 00:14:47 INFO - 'LANG': 'en_US.UTF-8', 00:14:47 INFO - 'LANGUAGE': 'en_US:en', 00:14:47 INFO - 'LOGNAME': 'cltbld', 00:14:47 INFO - 'MAIL': '/var/mail/cltbld', 00:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:47 INFO - 'MOZ_NO_REMOTE': '1', 00:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:47 INFO - 'NO_EM_RESTART': '1', 00:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:47 INFO - 'PWD': '/builds/slave/test', 00:14:47 INFO - 'SHELL': '/bin/bash', 00:14:47 INFO - 'SHLVL': '1', 00:14:47 INFO - 'TERM': 'linux', 00:14:47 INFO - 'TMOUT': '86400', 00:14:47 INFO - 'USER': 'cltbld', 00:14:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:47 INFO - '_': '/tools/buildbot/bin/python'} 00:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:14:47 INFO - Cleaning up... 00:14:47 INFO - Return code: 0 00:14:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:47 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 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:14:47 INFO - Using env: {'DISPLAY': ':0', 00:14:47 INFO - 'HOME': '/home/cltbld', 00:14:47 INFO - 'LANG': 'en_US.UTF-8', 00:14:47 INFO - 'LANGUAGE': 'en_US:en', 00:14:47 INFO - 'LOGNAME': 'cltbld', 00:14:47 INFO - 'MAIL': '/var/mail/cltbld', 00:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:47 INFO - 'MOZ_NO_REMOTE': '1', 00:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:47 INFO - 'NO_EM_RESTART': '1', 00:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:47 INFO - 'PWD': '/builds/slave/test', 00:14:47 INFO - 'SHELL': '/bin/bash', 00:14:47 INFO - 'SHLVL': '1', 00:14:47 INFO - 'TERM': 'linux', 00:14:47 INFO - 'TMOUT': '86400', 00:14:47 INFO - 'USER': 'cltbld', 00:14:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:47 INFO - '_': '/tools/buildbot/bin/python'} 00:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:47 INFO - Downloading/unpacking psutil>=3.1.1 00:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:14:49 INFO - Installing collected packages: psutil 00:14:49 INFO - Running setup.py install for psutil 00:14:49 INFO - building 'psutil._psutil_linux' extension 00:14:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:14:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:14:49 INFO - building 'psutil._psutil_posix' extension 00:14:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:14:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:14:49 INFO - Successfully installed psutil 00:14:49 INFO - Cleaning up... 00:14:50 INFO - Return code: 0 00:14:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:14: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')]} 00:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14: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')]} 00:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:50 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 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:14:50 INFO - Using env: {'DISPLAY': ':0', 00:14:50 INFO - 'HOME': '/home/cltbld', 00:14:50 INFO - 'LANG': 'en_US.UTF-8', 00:14:50 INFO - 'LANGUAGE': 'en_US:en', 00:14:50 INFO - 'LOGNAME': 'cltbld', 00:14:50 INFO - 'MAIL': '/var/mail/cltbld', 00:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:50 INFO - 'MOZ_NO_REMOTE': '1', 00:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:50 INFO - 'NO_EM_RESTART': '1', 00:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:50 INFO - 'PWD': '/builds/slave/test', 00:14:50 INFO - 'SHELL': '/bin/bash', 00:14:50 INFO - 'SHLVL': '1', 00:14:50 INFO - 'TERM': 'linux', 00:14:50 INFO - 'TMOUT': '86400', 00:14:50 INFO - 'USER': 'cltbld', 00:14:50 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:50 INFO - '_': '/tools/buildbot/bin/python'} 00:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:14:52 INFO - Installing collected packages: mozsystemmonitor 00:14:52 INFO - Running setup.py install for mozsystemmonitor 00:14:52 INFO - Successfully installed mozsystemmonitor 00:14:52 INFO - Cleaning up... 00:14:52 INFO - Return code: 0 00:14:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:52 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 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:14:52 INFO - Using env: {'DISPLAY': ':0', 00:14:52 INFO - 'HOME': '/home/cltbld', 00:14:52 INFO - 'LANG': 'en_US.UTF-8', 00:14:52 INFO - 'LANGUAGE': 'en_US:en', 00:14:52 INFO - 'LOGNAME': 'cltbld', 00:14:52 INFO - 'MAIL': '/var/mail/cltbld', 00:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:52 INFO - 'MOZ_NO_REMOTE': '1', 00:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:52 INFO - 'NO_EM_RESTART': '1', 00:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:52 INFO - 'PWD': '/builds/slave/test', 00:14:52 INFO - 'SHELL': '/bin/bash', 00:14:52 INFO - 'SHLVL': '1', 00:14:52 INFO - 'TERM': 'linux', 00:14:52 INFO - 'TMOUT': '86400', 00:14:52 INFO - 'USER': 'cltbld', 00:14:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:52 INFO - '_': '/tools/buildbot/bin/python'} 00:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:52 INFO - Downloading/unpacking jsonschema==2.5.1 00:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:14:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:54 INFO - Downloading functools32-3.2.3-2.tar.gz 00:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:14:54 INFO - warning: no files found matching '*.txt' 00:14:54 INFO - no previously-included directories found matching 'build' 00:14:54 INFO - no previously-included directories found matching 'dist' 00:14:54 INFO - no previously-included directories found matching '.git*' 00:14:54 INFO - Installing collected packages: jsonschema, functools32 00:14:54 INFO - Running setup.py install for functools32 00:14:54 INFO - warning: no files found matching '*.txt' 00:14:54 INFO - no previously-included directories found matching 'build' 00:14:54 INFO - no previously-included directories found matching 'dist' 00:14:54 INFO - no previously-included directories found matching '.git*' 00:14:54 INFO - Successfully installed jsonschema functools32 00:14:54 INFO - Cleaning up... 00:14:54 INFO - Return code: 0 00:14:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:14:54 INFO - Using env: {'DISPLAY': ':0', 00:14:54 INFO - 'HOME': '/home/cltbld', 00:14:54 INFO - 'LANG': 'en_US.UTF-8', 00:14:54 INFO - 'LANGUAGE': 'en_US:en', 00:14:54 INFO - 'LOGNAME': 'cltbld', 00:14:54 INFO - 'MAIL': '/var/mail/cltbld', 00:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:54 INFO - 'MOZ_NO_REMOTE': '1', 00:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:54 INFO - 'NO_EM_RESTART': '1', 00:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:54 INFO - 'PWD': '/builds/slave/test', 00:14:54 INFO - 'SHELL': '/bin/bash', 00:14:54 INFO - 'SHLVL': '1', 00:14:54 INFO - 'TERM': 'linux', 00:14:54 INFO - 'TMOUT': '86400', 00:14:54 INFO - 'USER': 'cltbld', 00:14:54 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:54 INFO - '_': '/tools/buildbot/bin/python'} 00:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:14:55 INFO - Cleaning up... 00:14:55 INFO - Return code: 0 00:14:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:55 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 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:14:55 INFO - Using env: {'DISPLAY': ':0', 00:14:55 INFO - 'HOME': '/home/cltbld', 00:14:55 INFO - 'LANG': 'en_US.UTF-8', 00:14:55 INFO - 'LANGUAGE': 'en_US:en', 00:14:55 INFO - 'LOGNAME': 'cltbld', 00:14:55 INFO - 'MAIL': '/var/mail/cltbld', 00:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:55 INFO - 'MOZ_NO_REMOTE': '1', 00:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:55 INFO - 'NO_EM_RESTART': '1', 00:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:55 INFO - 'PWD': '/builds/slave/test', 00:14:55 INFO - 'SHELL': '/bin/bash', 00:14:55 INFO - 'SHLVL': '1', 00:14:55 INFO - 'TERM': 'linux', 00:14:55 INFO - 'TMOUT': '86400', 00:14:55 INFO - 'USER': 'cltbld', 00:14:55 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:55 INFO - '_': '/tools/buildbot/bin/python'} 00:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:55 INFO - Downloading/unpacking blobuploader==1.2.4 00:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:57 INFO - Downloading blobuploader-1.2.4.tar.gz 00:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:14:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:57 INFO - Downloading docopt-0.6.1.tar.gz 00:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 00:14:57 INFO - Running setup.py install for blobuploader 00:14:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:14:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:14:58 INFO - Running setup.py install for requests 00:14:58 INFO - Running setup.py install for docopt 00:14:58 INFO - Successfully installed blobuploader requests docopt 00:14:58 INFO - Cleaning up... 00:14:58 INFO - Return code: 0 00:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:14:58 INFO - Using env: {'DISPLAY': ':0', 00:14:58 INFO - 'HOME': '/home/cltbld', 00:14:58 INFO - 'LANG': 'en_US.UTF-8', 00:14:58 INFO - 'LANGUAGE': 'en_US:en', 00:14:58 INFO - 'LOGNAME': 'cltbld', 00:14:58 INFO - 'MAIL': '/var/mail/cltbld', 00:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:58 INFO - 'MOZ_NO_REMOTE': '1', 00:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:58 INFO - 'NO_EM_RESTART': '1', 00:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:58 INFO - 'PWD': '/builds/slave/test', 00:14:58 INFO - 'SHELL': '/bin/bash', 00:14:58 INFO - 'SHLVL': '1', 00:14:58 INFO - 'TERM': 'linux', 00:14:58 INFO - 'TMOUT': '86400', 00:14:58 INFO - 'USER': 'cltbld', 00:14:58 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:58 INFO - '_': '/tools/buildbot/bin/python'} 00:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:14:58 INFO - Running setup.py (path:/tmp/pip-fd374x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:14:58 INFO - Running setup.py (path:/tmp/pip-mZmtiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:14:58 INFO - Running setup.py (path:/tmp/pip-jDT6xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:14:59 INFO - Running setup.py (path:/tmp/pip-SjkGHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:14:59 INFO - Running setup.py (path:/tmp/pip-WiHbz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:14:59 INFO - Running setup.py (path:/tmp/pip-3xpJiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:14:59 INFO - Running setup.py (path:/tmp/pip-RKAx2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:14:59 INFO - Running setup.py (path:/tmp/pip-H63qfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:14:59 INFO - Running setup.py (path:/tmp/pip-KC0N3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:14:59 INFO - Running setup.py (path:/tmp/pip-Sb839I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:14:59 INFO - Running setup.py (path:/tmp/pip-n5mtm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:14:59 INFO - Running setup.py (path:/tmp/pip-rrePIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:14:59 INFO - Running setup.py (path:/tmp/pip-A6_nnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:14:59 INFO - Running setup.py (path:/tmp/pip-Zv8k3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:59 INFO - Running setup.py (path:/tmp/pip-4eB2WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:14:59 INFO - Running setup.py (path:/tmp/pip-gVr19i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:14:59 INFO - Running setup.py (path:/tmp/pip-0w0lFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:15:00 INFO - Running setup.py install for manifestparser 00:15:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Running setup.py install for mozcrash 00:15:00 INFO - Running setup.py install for mozdebug 00:15:00 INFO - Running setup.py install for mozdevice 00:15:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Running setup.py install for mozfile 00:15:00 INFO - Running setup.py install for mozhttpd 00:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Running setup.py install for mozinfo 00:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Running setup.py install for mozInstall 00:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:15:00 INFO - Running setup.py install for mozleak 00:15:00 INFO - Running setup.py install for mozlog 00:15:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Running setup.py install for moznetwork 00:15:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Running setup.py install for mozprocess 00:15:01 INFO - Running setup.py install for mozprofile 00:15:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Running setup.py install for mozrunner 00:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Running setup.py install for mozscreenshot 00:15:01 INFO - Running setup.py install for moztest 00:15:01 INFO - Running setup.py install for mozversion 00:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:15:01 INFO - Cleaning up... 00:15:01 INFO - Return code: 0 00:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:15:01 INFO - Using env: {'DISPLAY': ':0', 00:15:01 INFO - 'HOME': '/home/cltbld', 00:15:01 INFO - 'LANG': 'en_US.UTF-8', 00:15:01 INFO - 'LANGUAGE': 'en_US:en', 00:15:01 INFO - 'LOGNAME': 'cltbld', 00:15:01 INFO - 'MAIL': '/var/mail/cltbld', 00:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:01 INFO - 'MOZ_NO_REMOTE': '1', 00:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:01 INFO - 'NO_EM_RESTART': '1', 00:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:01 INFO - 'PWD': '/builds/slave/test', 00:15:01 INFO - 'SHELL': '/bin/bash', 00:15:01 INFO - 'SHLVL': '1', 00:15:01 INFO - 'TERM': 'linux', 00:15:01 INFO - 'TMOUT': '86400', 00:15:01 INFO - 'USER': 'cltbld', 00:15:01 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:01 INFO - '_': '/tools/buildbot/bin/python'} 00:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:02 INFO - Running setup.py (path:/tmp/pip-IDyauo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:02 INFO - Running setup.py (path:/tmp/pip-pLggiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:02 INFO - Running setup.py (path:/tmp/pip-PIsOnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:02 INFO - Running setup.py (path:/tmp/pip-vQNd0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:02 INFO - Running setup.py (path:/tmp/pip-dnscHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:02 INFO - Running setup.py (path:/tmp/pip-WNvqCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:02 INFO - Running setup.py (path:/tmp/pip-5Dc670-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:02 INFO - Running setup.py (path:/tmp/pip-Et6Lzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:02 INFO - Running setup.py (path:/tmp/pip-aqVdun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:02 INFO - Running setup.py (path:/tmp/pip-HFxOvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:02 INFO - Running setup.py (path:/tmp/pip-rRNC3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:02 INFO - Running setup.py (path:/tmp/pip-rVv1Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:02 INFO - Running setup.py (path:/tmp/pip-hazoR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:02 INFO - Running setup.py (path:/tmp/pip-FJRrSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:03 INFO - Running setup.py (path:/tmp/pip-YX5vzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:03 INFO - Running setup.py (path:/tmp/pip-x4dTxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:03 INFO - Running setup.py (path:/tmp/pip-CSx61G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:05 INFO - Downloading blessings-1.6.tar.gz 00:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:15:05 INFO - Installing collected packages: blessings 00:15:05 INFO - Running setup.py install for blessings 00:15:05 INFO - Successfully installed blessings 00:15:05 INFO - Cleaning up... 00:15:05 INFO - Return code: 0 00:15:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:05 INFO - Reading from file tmpfile_stdout 00:15:05 INFO - Current package versions: 00:15:05 INFO - argparse == 1.2.1 00:15:05 INFO - blessings == 1.6 00:15:05 INFO - blobuploader == 1.2.4 00:15:05 INFO - docopt == 0.6.1 00:15:05 INFO - functools32 == 3.2.3-2 00:15:05 INFO - jsonschema == 2.5.1 00:15:05 INFO - manifestparser == 1.1 00:15:05 INFO - mozInstall == 1.12 00:15:05 INFO - mozcrash == 0.17 00:15:05 INFO - mozdebug == 0.1 00:15:05 INFO - mozdevice == 0.48 00:15:05 INFO - mozfile == 1.2 00:15:05 INFO - mozhttpd == 0.7 00:15:05 INFO - mozinfo == 0.9 00:15:05 INFO - mozleak == 0.1 00:15:05 INFO - mozlog == 3.3 00:15:05 INFO - moznetwork == 0.27 00:15:05 INFO - mozprocess == 0.23 00:15:05 INFO - mozprofile == 0.28 00:15:05 INFO - mozrunner == 6.12 00:15:05 INFO - mozscreenshot == 0.1 00:15:05 INFO - mozsystemmonitor == 0.3 00:15:05 INFO - moztest == 0.7 00:15:05 INFO - mozversion == 1.4 00:15:05 INFO - psutil == 3.1.1 00:15:05 INFO - requests == 1.2.3 00:15:05 INFO - wsgiref == 0.1.2 00:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:15:05 INFO - Using env: {'DISPLAY': ':0', 00:15:05 INFO - 'HOME': '/home/cltbld', 00:15:05 INFO - 'LANG': 'en_US.UTF-8', 00:15:05 INFO - 'LANGUAGE': 'en_US:en', 00:15:05 INFO - 'LOGNAME': 'cltbld', 00:15:05 INFO - 'MAIL': '/var/mail/cltbld', 00:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:05 INFO - 'MOZ_NO_REMOTE': '1', 00:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:05 INFO - 'NO_EM_RESTART': '1', 00:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:05 INFO - 'PWD': '/builds/slave/test', 00:15:05 INFO - 'SHELL': '/bin/bash', 00:15:05 INFO - 'SHLVL': '1', 00:15:05 INFO - 'TERM': 'linux', 00:15:05 INFO - 'TMOUT': '86400', 00:15:05 INFO - 'USER': 'cltbld', 00:15:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:05 INFO - '_': '/tools/buildbot/bin/python'} 00:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:15:05 INFO - Cleaning up... 00:15:05 INFO - Return code: 0 00:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f104d1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:15:05 INFO - Using env: {'DISPLAY': ':0', 00:15:05 INFO - 'HOME': '/home/cltbld', 00:15:05 INFO - 'LANG': 'en_US.UTF-8', 00:15:05 INFO - 'LANGUAGE': 'en_US:en', 00:15:05 INFO - 'LOGNAME': 'cltbld', 00:15:05 INFO - 'MAIL': '/var/mail/cltbld', 00:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:05 INFO - 'MOZ_NO_REMOTE': '1', 00:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:05 INFO - 'NO_EM_RESTART': '1', 00:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:05 INFO - 'PWD': '/builds/slave/test', 00:15:05 INFO - 'SHELL': '/bin/bash', 00:15:05 INFO - 'SHLVL': '1', 00:15:05 INFO - 'TERM': 'linux', 00:15:05 INFO - 'TMOUT': '86400', 00:15:05 INFO - 'USER': 'cltbld', 00:15:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:05 INFO - '_': '/tools/buildbot/bin/python'} 00:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:15:06 INFO - Cleaning up... 00:15:06 INFO - Return code: 0 00:15:06 INFO - Running post-action listener: _resource_record_post_action 00:15:06 INFO - Running post-action listener: _start_resource_monitoring 00:15:06 INFO - Starting resource monitoring. 00:15:06 INFO - [mozharness: 2016-08-26 07:15:06.081771Z] Finished create-virtualenv step (success) 00:15:06 INFO - [mozharness: 2016-08-26 07:15:06.082272Z] Running install step. 00:15:06 INFO - Running pre-action listener: _resource_record_pre_action 00:15:06 INFO - Running main action method: install 00:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:06 INFO - Reading from file tmpfile_stdout 00:15:06 INFO - Detecting whether we're running mozinstall >=1.0... 00:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:15:06 INFO - Reading from file tmpfile_stdout 00:15:06 INFO - Output received: 00:15:06 INFO - Usage: mozinstall [options] installer 00:15:06 INFO - Options: 00:15:06 INFO - -h, --help show this help message and exit 00:15:06 INFO - -d DEST, --destination=DEST 00:15:06 INFO - Directory to install application into. [default: 00:15:06 INFO - "/builds/slave/test"] 00:15:06 INFO - --app=APP Application being installed. [default: firefox] 00:15:06 INFO - mkdir: /builds/slave/test/build/application 00:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:15:22 INFO - Reading from file tmpfile_stdout 00:15:22 INFO - Output received: 00:15:22 INFO - /builds/slave/test/build/application/firefox/firefox 00:15:22 INFO - Running post-action listener: _resource_record_post_action 00:15:22 INFO - [mozharness: 2016-08-26 07:15:22.544839Z] Finished install step (success) 00:15:22 INFO - [mozharness: 2016-08-26 07:15:22.545187Z] Running run-tests step. 00:15:22 INFO - Running pre-action listener: _resource_record_pre_action 00:15:22 INFO - Running main action method: run_tests 00:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:15:22 INFO - Python 2.7.3 00:15:22 INFO - Return code: 0 00:15:22 INFO - grabbing minidump binary from tooltool 00:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d090>, '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 0xfa09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa0e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:15:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:15:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:15:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:15:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:15:22 INFO - Return code: 0 00:15:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:15:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:15:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:15:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:15:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:15:22 INFO - Using env: {'DISPLAY': ':0', 00:15:22 INFO - 'HOME': '/home/cltbld', 00:15:22 INFO - 'LANG': 'en_US.UTF-8', 00:15:22 INFO - 'LANGUAGE': 'en_US:en', 00:15:22 INFO - 'LOGNAME': 'cltbld', 00:15:22 INFO - 'MAIL': '/var/mail/cltbld', 00:15:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:15:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:22 INFO - 'MOZ_NO_REMOTE': '1', 00:15:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:22 INFO - 'NO_EM_RESTART': '1', 00:15:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:22 INFO - 'PWD': '/builds/slave/test', 00:15:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:15:22 INFO - 'SHELL': '/bin/bash', 00:15:22 INFO - 'SHLVL': '1', 00:15:22 INFO - 'TERM': 'linux', 00:15:22 INFO - 'TMOUT': '86400', 00:15:22 INFO - 'USER': 'cltbld', 00:15:22 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430', 00:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:22 INFO - '_': '/tools/buildbot/bin/python'} 00:15:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:15:22 INFO - mozversion application_buildid: 20160825225016 00:15:22 INFO - mozversion application_changeset: cdcbb0707964623df33270654bd8600155607e77 00:15:22 INFO - mozversion application_display_name: Nightly 00:15:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:15:22 INFO - mozversion application_name: Firefox 00:15:22 INFO - mozversion application_remotingname: firefox 00:15:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:15:22 INFO - mozversion application_vendor: Mozilla 00:15:22 INFO - mozversion application_version: 51.0a1 00:15:22 INFO - mozversion platform_buildid: 20160825225016 00:15:22 INFO - mozversion platform_changeset: cdcbb0707964623df33270654bd8600155607e77 00:15:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:15:22 INFO - mozversion platform_version: 51.0a1 00:15:22 INFO - using testdate: 1472195722 00:15:22 INFO - actual date: 1472195722 00:15:22 INFO - starting webserver on 'localhost:41572' 00:15:22 INFO - SUITE-START | Running 2 tests 00:15:22 INFO - TEST-START | dromaeo_css 00:15:22 INFO - operating with platform_type : linux_ 00:15:22 INFO - Initialising browser for dromaeo_css test... 00:15:22 INFO - TEST-INFO | started process 22419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BaZVU/profile http://localhost:41572/getInfo.html) 00:15:27 INFO - PROCESS | 22419 | __metrics Screen width/height:1600/1200 00:15:27 INFO - PROCESS | 22419 | colorDepth:24 00:15:27 INFO - PROCESS | 22419 | Browser inner width/height: 1024/697 00:15:27 INFO - PROCESS | 22419 | __metrics 00:15:28 INFO - PROCESS | 22419 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:15:28 INFO - PROCESS | 22419 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:15:28 INFO - PROCESS | 22419 | console.error: PushService: 00:15:28 INFO - PROCESS | 22419 | stateChangeProcessEnqueue: Error transitioning state 00:15:28 INFO - PROCESS | 22419 | UnknownError 00:15:29 INFO - TEST-INFO | 22419: exit 0 00:15:29 INFO - Browser initialized. 00:15:29 INFO - Running cycle 1/1 for dromaeo_css test... 00:15:29 INFO - TEST-INFO | started process 22498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BaZVU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:41 INFO - PROCESS | 22498 | RSS: Main: 180445184 00:15:41 INFO - PROCESS | 22498 | 00:16:32 INFO - PROCESS | 22498 | 1472195792696 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:18:45 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41572/tests/dromaeo/cssquery-ext.html) 00:18:46 INFO - PROCESS | 22498 | RSS: Main: 291311616 00:18:46 INFO - PROCESS | 22498 | 00:21:49 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-ext.html (next: http://localhost:41572/tests/dromaeo/cssquery-jquery.html) 00:21:50 INFO - PROCESS | 22498 | RSS: Main: 280170496 00:21:50 INFO - PROCESS | 22498 | 00:24:52 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41572/tests/dromaeo/cssquery-mootools.html) 00:24:53 INFO - PROCESS | 22498 | RSS: Main: 218271744 00:24:53 INFO - PROCESS | 22498 | 00:27:55 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41572/tests/dromaeo/cssquery-prototype.html) 00:27:56 INFO - PROCESS | 22498 | RSS: Main: 220024832 00:27:56 INFO - PROCESS | 22498 | 00:30:59 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41572/tests/dromaeo/cssquery-yui.html) 00:30:59 INFO - PROCESS | 22498 | RSS: Main: 218013696 00:30:59 INFO - PROCESS | 22498 | 00:34:02 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:41572/tests/dromaeo/cssquery-yui.html (next: http://localhost:41572/tests/dromaeo/cssquery-dojo.html) 00:34:03 INFO - PROCESS | 22498 | RSS: Main: 306782208 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | __start_tp_report 00:34:03 INFO - PROCESS | 22498 | _x_x_mozilla_page_load 00:34:03 INFO - PROCESS | 22498 | _x_x_mozilla_page_load_details 00:34:03 INFO - PROCESS | 22498 | |i|pagename|runs| 00:34:03 INFO - PROCESS | 22498 | |0;dojo.html;2599.6490473786034;2610.8433493990356;2621.3184572011273;2653.9203823885277;2667.30650030992;4524.9095018099615;4595.218812801823;4606.262997920333;4675.3688252086;4732.148213321605;4594.655400844933;4614.792334344954;4623.329617205503;4641.7214967102;4643.698159619631;4232.301670224417;4268.701190916637;4291.249031419505;4300.741955482681;4303;4323.1353729254115;4332.675049371294;4345.543717909622;4350.499692535367;4385.561443855605;4275.315949448089;4419;4424.380586717862;4425.911481770363;4428.424304840366;4183.037901282692;4321.351797230409;4325;4376.737395756233;4379.277419225824;4184.644305234059;4222.451081359403;4223.97888010558;4286.357046443059;4292.785360731951;4588.357629931812;4608.308753686973;4615.560720453508;4688.249880019181;4737;4923.77842997066;4950.381202349707;4969;4971.477994810529;5033.144365457881;4783.4977327380475;4895.730734809584;4976.726280054596;4978.9751051244875;4990.87522811929;4604.539546045436;4643.8374656886845;4647.047355292157;4647.581717645428;4706.858794236178;4918.778654960535;5082.974585127051;5086.516780905808;5092.312537807423;5146.794128234904;4815.15734746418;4858.611311095104;4859.757012149378;4944.851654450372;4946.455889852114;4972.4033116025585;4974.950250497521;4975.253711943237;4978.551930326288;5001.7499125043605;4932.926006109911;4934.111859865258;4936.111499930047;4943.332650092263;4985.700857948535;4696.131215725101;4742.241241401428;4827.782749776268;4866.172750632401;4964.106460837084;4165.875023749292;4169.979150104291;4211.43145675336;4218.114196018871;4220.409142720022;3661.3958696814725;3676.613955534684;3682.3371793077504;3722.7207959403154;3727.38498147808;4193.287141186006;4234.957650423518;4274;4277.358396240589;4284.335927931175;4956.603471722254;4974.850754477371;4976.954839483749;5006.674566153189;5022.773975171126;4265.829366825292;4272.594103560157;4279.101388708344;4312.986448184674;4332.068605249887;4322.502912165079;4428.579284967987;4443.555644435595;4457.2199865023495;4461.486929003141;4739.549742774431;4753.334533165291;4759.42886853566;4759.6668233223345;4771.355866958055;4983.227599722049;4989.60083193351;4993.825216117419;4999.625028122978;5055.090083784807;4671.883202919818;4683.508231635629;4706.835260765994;4719.551642593948;4771.95228047715;4685.67200295976;4852.73309967941;4903.754812259444;4919.85240442773;4978.701277923336;4964.35463389757;4972.701637901593;4974.427940786856;4982.601391888713;5026.874328141679;4820.783064762164;4823.445303790109;4831.178699621002;4837.346958160603;4889.584385327287;4629.976850115728;4741.454732705645;4787.8563643090765;4792.041591681747;4874.268859671078;4729.266963620645;4757.452892917358;4758.381410416624;4794.5924596409695;4847.733374664427;4711.858644240679;4725.5983241424865;4736.644751643709;4856.39295088114;4881.438634557071;4700.55344742249;4731.101090792738;4747.335373047845;4749.952500475089;4829.058333624909 00:34:03 INFO - PROCESS | 22498 | |1;ext.html;562.0473297760295;572.1532132443986;573.0945106731365;579.4061087385429;580.2196046317703;27240.72759272409;29864.850675746646;29925.850370748143;30115;37664;36017.45973810395;39616.40575391364;39636.40545391821;39691.80154099225;39698.206035879266;7603.467757256981;7789.688412463494;7802.8439431211345;7806.570638614874;7808.336291415237;7620.314171724572;7715.922840771576;7716.074071111474;7721.768346949572;7723.575203363813;7708.6916523339;7733.033370828646;7743.806404839896;7743.922560774405;7775.1447340792465;7692.576908270043;7741.961290193569;7744.496607720536;7745.225477452294;7746.573938433384;7658.310752032344;7711.2288771123;7713.807154821118;7728.613569321511;7730.497517661391;36897.63102368969;37034;37109.62890371089;37358.62641373579;37405;2884.2645125492863;2995.7303842654264;3046.7714921380984;3142.1673256587023;3235.8382080896095;27167.320816979536;27985.440291194267;28159.577606335923;28409.71590284112;29313.267168320748;3004.4141392428487;3025.5461680747844;3037.635483741943;3089;3136.8902088427026;246592;246848;247043;247150;248428;29989.850050749606;31290.84354578258;47526.287105693445;47902.760486197345;47924;31904.521432178535;32202;32220.516692249636;32261.35477290441;32381;12566.434510447052;12622.368881556069;12625.116241862981;12625.684357891127;12632.2420654761;10424.166066714644;10438.269321147447;10467.371957682564;10492.213084018576;10494.790104197873;7566.621668916642;7603.543787372775;7655.1962043985695;7655.1962043985695;7672;3029.4849875521213;3031.317953460498;3053.114596766957;3054.465468542996;3064.2798942248555;875.8642410426394;878.767126711422;907.7503686486137;916.4638686368415;955.1260596554214;26230.475390492084;26468.60297095545;26904.192874213804;26964.191074267805;27219.863900680764;768.3776141325544;943.773494361362;944.5607792376578;956.6077908057663;999.5801763259449;13962.720745585235;14651.633709157357;14764.852351476562;14837.332320045623;15071.924640376728;354396;357366;357400.75089862535;358074;358176;47314.290285645744;47715;47808.76095619569;47873.281900771515;47944.520554794704;1053.9578416863394;1116.9162312826409;1154.520873837348;1162.1167912386816;1183.2249876331016;25882.35294117662;27711.30721731973;27988.44023119567;28182.43635127245;28249.293767655974;39034;39480.80259598799;39606.40590391204;39621.60378396294;39694.2061158781;274236;275894;277221;277394;277467;23854;24533.87733061395;24874;24912.252632421056;26106.86946565255;39980;40177.598224018555;40499.797501012305;40686.79656601698;41504;33279;33324.333513330086;33390.83304583462;33459.49810752792;33800.1549961253;33170.336593267515;33171.83414082914;33600.327993440485;34104.829475852464;34116.14709632279;33765.155871103416;33918.321633566695;33927.66072339245;34021.65978340185;34427.31145377128;27924.58113128264;30458.086257412313;32135.67864321327;34058.14854628654;34676.65323346734;24582.63126053075;24659.136930207358;24784.25647230586;25115;25200.74799251984 00:34:03 INFO - PROCESS | 22498 | |2;jquery.html;342.17023717485125;359.61341557825347;367.3534579140712;372.90677330667336;380.38567713143266;12327;14247;16140.596485087879;16359.754603680954;17085.40201092962;13300.667483312922;14302.213378264218;15137.621559461018;15269.618259543517;15271.77092343613;4909.582685471739;4931.358923339979;5138.948610513903;5152.871178220537;5168.508991645787;3616.222512159885;5098.490150984909;5102.387713474388;5594.664320140804;5930.911036334458;5973.910391344133;5975.43233392827;5989.8802023959715;6008.96995515024;6020.909686354708;5026.798928042892;5263.473652634744;5263.736813159365;5363.141897296453;6063.363346848561;5233.9738301308635;5239.659422137587;5240.580753539708;5241.056609810233;5248.317718696583;16865.409710660068;19167.712484312746;19708.113134908963;19764.70352944707;19851.90074049635;1820.863435242349;1854.3509771579975;1924.1533725160884;2117.089651449876;2301.2175860207444;8232.711855085103;8683.2185103341;8685.652573897036;8791.516466594334;10529.105026072793;1625.3336132185866;1685.2669088946225;1710.1278348042463;1762.1629725880232;1786.2587026384035;65454;68608.6569567149;68979.31020689779;69756;69832.30167698309;9527;9612.279079069098;9656.179224765974;9902.752431189278;9913.603455861828;13164.868351316365;13192.604221873358;13194.538191163456;13209.867901321057;13213.933930330288;7155;7333.266673332624;7385.483016188815;7543.547387156788;7549.7357592483995;7049.7885063448175;7073;7327.0841144856895;7344.485885988036;7362.668679909417;3775.4525593789294;3867.2458870519977;3893.7274390792372;3955.149642826806;3971.0866500705;1797.7932537758325;1802.3871883559652;1803.3147403986402;1833.3949796567101;1865.9626807464047;803.9397045221632;805.5851236613149;825.3204728377723;860.4321148042262;959.2421986630484;15698.529044128694;16321.939073960155;17026.659466810594;17068.2319295632;17134.742978855327;816.5141740664295;817.8568750468644;818.7707441916273;821.6261600971544;821.7822277096574;6698.83252918681;8645.221930026202;9012.819743605221;9580.329376943686;9656.37233579815;337302;345751;346884;347482;347758;43271.567284327386;46392.304115438295;72623;73020;74019;815.2703330519153;826.8842362069315;842.5534466732641;857.3012994409661;879.564615515324;15109.39562417491;15166.545003649908;15782.368705251662;16040.278187481825;16122.596935076717;24289.27132186037;25613.871930640227;32681;34130.82934585311;34237.65762342444;41197.28269229853;43505.34741978809;45863.77068114772;46712.53287467082;47571.76214118907;7188.820279493055;7347.66935487915;7367.963160184165;7518.135414427411;7649.158592554703;7692.923070769444;10776.137908967106;10997.395143267197;11554.711132221762;11666;10014.899851001397;10043.799124017625;10232.130268926927;10315.793684126425;10530.262881598215;9635.951820241135;9674.806503870024;9741.707748767549;9788.510574471391;10322.071013608811;9684.467354295299;10332.225083118647;10386.48067596602;10842.403667798348;10866.78266434651;7296.087989001375;7596.316331530189;7619.65711542993;7674.961625192062;7997.680092796456;8865;9921.40471571708;10042.799144017225;10165.288429809842;10175.84736228972 00:34:03 INFO - PROCESS | 22498 | |3;mootools.html;1346.7777816660248;1370.3696299702137;1433.3191733926387;1644.2600829626672;1661.9311101141523;7519.097708275001;8185.877211841827;8199.508029518232;8203.58982050898;8208.425410221287;6576.96711516443;7632.618369081538;7891.723789667363;7895;8051.114377418479;2146.0986385717997;2177.368563116694;2181.334692918659;2185.8360622953264;2188.7154669892893;2092.9221450952696;2122.7240458740343;2160.9567808643897;2166.1335465813645;2169.034779523113;2139.3902737719754;2144.5067634444085;2158.686990386393;2162.0703097667997;2171.381156370435;2124.6706760452153;2128.829693624522;2131.136889559723;2139.657654775236;2141.1114387529155;2075.5018795489127;2135.7757435469207;2141.4004078857943;2141.635921893266;2142.2609199826034;7664.271894170045;7747.767566973;7751.302382785577;8105.594720263964;8178.100408955011;4434.556544345572;4579.267317229261;4581.473130589991;4586.518415566351;4599.034202817413;2753.3116720819794;2850.800443968923;2900.8114472559214;2907.912762617125;2918.430905973336;823.798169448483;877.412133870302;879.116487929633;891.6522556203086;892.7902691852511;10942.890571094267;10956.12351011925;10986.945065274622;11025.558977640885;11036.392998385085;4018.3771515415156;4099.077707515785;4285.5928686774705;4302.096559722493;4334.241507736134;9345.532723363805;9352.205062569758;9355.391899526508;9357.251419886392;9370.95314523423;4630.282306242538;4640.095181439587;4643.582077613031;4647.024124933734;4651.930221046687;3599.082234030358;4004.6395824375363;4086.7547947123267;4254;4265.53079161292;3619;3644.161842776123;3707.721920855947;3753.3806921858136;3758.661720445173;1138.9829152562718;1151.027381862325;1161.7560312334335;1186.4127257007835;1191.326900301327;706.8550947055944;818.2308629887887;823.2549542663899;826.1366871619173;830.4187069051688;5112.488751124858;5212.765425555859;5228.405336372367;5291.259223708684;5458.754356053987;394.5482422626077;395.83572817280503;396.7678907838889;401.47005952143473;406.5710675237594;3562.6437356264164;3793.2982398256413;4157.625813676784;4194.538600753915;4202.138561594866;9774.853377199348;9789.363691360039;9903.25725570585;9934.304598678167;9935.105840474393;9854.260930430246;9861.260405469618;9870.851937220947;9900.306978511435;9901.653442129491;7347.338739513362;7555.206703296185;7571.3942884569105;7571.432142589218;7572.697092116364;5447.863803404946;5462.590305727166;5639.9718001411375;5667.838093190969;5744.109663002241;8901.376903616685;9015.233705135137;9068.047854975133;9083.137101975302;9163.083691630784;9029.819403612022;9242.260619150586;9339.48632825174;9360.625574976924;9476.147146756824;6328.398802113792;6526.24948130971;6577.309382514958;6662.666866656745;6829.282925292773;7630.16068232505;7662.080550333995;7663.88504172449;7664.770056898302;7680.80797980055;6781.457483401415;6891.862162756616;6939.132608423947;6954.47841411886;7025.6487175639995;6810.965945170243;6878.415334696607;6881.243063262937;6885.345892140239;6887.758928437481;6521.054447105238;6522.5760325578685;6523.3150519194805;6540.607563546202;6579.276279609335;4517.254652982221;4543.318502224561;4606.470255920612;4665.533446655308;4825.686330388514;4567.954320456753;4577.633789296781;4598.21830288845;4625.976870115628;4670.019295947889 00:34:03 INFO - PROCESS | 22498 | |4;prototype.html;280.69404349259315;284.13764225575375;287.7094134923726;290.77029146973894;291.83802989340916;4684.437867455906;4733.313669517918;4762.618990480758;4764.547368000043;4769.856904292872;4692.882677933045;4694.4601370842365;4696.530346965302;4696.812127514895;4706.458757242918;3507.7725644215916;3578.3022310649435;3682.3739964206147;3697.426898830672;3720.674578388507;3708.647678470541;3718.572364178127;3719.9070023249365;3721.2371463849845;3730.2912446635187;3671.834767435472;3676.7977761223124;3687.8709245176424;3694.482772411851;3699.1307042845046;3501.5272938153407;3507.8947631571095;3630.564332280117;3644.817759112034;3655.94516082259;3195.952060719091;3198.856051477689;3205.2627895583914;3211.277462570926;3212;4557.77211139445;4568.908621827578;4576.816927322936;4598.494165641777;4609.078184363141;3947.210557888434;4162.41726158338;4168.6039826216465;4175.62419382257;4185.434966279574;4921.50784921505;4927.457979622239;4927.704337739747;4945.7774400152075;4954.9009019819405;3502.176988407722;3505.3339865425487;3509.2630547585036;3514.894553163409;3515.244222492151;4987.177115775893;5163.406208286057;5178.922316165223;5190.558802501791;5202.375714914197;3501.9824900875333;3543.6279190685123;3549.680528752373;3552.769070010441;3563.3051554946537;3585.766925149857;3588.964110358915;3593.5508061492314;3599.38810402227;3609.7653652512504;4130.56629053945;4130.669546436338;4131.058402550796;4133.751974881517;4140.109876376593;4681.555252251031;4928.260760885824;4937.308776771255;4937.851864444073;4943.90112197754;1235.0983781839307;1242.1180961517423;1245.3212998915612;1248.6066888929959;1253.7617852607975;766.52858492027;773.2190487607556;789.8538770327508;804.3283857978537;811.3874025111004;4255.3829694694095;4403.361512580658;4422.867313980586;4438.822447102144;4445.977770111193;5143.434222235551;5153.3815942087185;5156;5156.484351564814;5162.97418512905;4423.469183697976;4424.823007079745;4433;4439.356293337448;4441.955580444154;2564.499922515092;2685.3018215264174;2712.159230638469;2712.620233167358;2723.1422102037795;4773.236282194832;4793.592544633675;4806.735629540339;4811.831585894477;4818.759062046884;4985.227289770091;5141.226276934452;5176.1459359206065;5186.740662966837;5198.454162312978;4760.024589795196;4776.665633405628;4780.976095119572;4785.665003449725;4799.1601469743355;5083.491650834887;5090.2364645303505;5090.287359769709;5094.541491265803;5107.361579802525;4779.450363208275;4992.5756310714;5002.799328161288;5003.249512572997;5003.499650034967;4760.59534939534;4773.403324584427;4773.594244489257;4775.140474714584;4776.259679749644;3550.2366991097037;3552.7690700105445;3555.484454754098;3557.092941299952;3561.982190089033;5071.92392114126;5075.898482030265;5076.6446348755235;5077.949220507748;5088.185890257541;4687.812487500598;4957.702537847741;4972.204447288416;4978.975105124596;4984.476629953948;4956.89332033877;4959.628027897994;4967.627427942846;4974.626902982219;4974.7512624369365;4840.169549368602;4909.288153217834;4927.901441971212;4935.432425271139;4937.77779999908;4730.408698912636;4884.78018489176;4910.8772280693265;4972.900541989067;4973.900521989613;4878.292647566154;4886.021161429627;4887.706737595756;4894.608431325557;4902.754862256944 00:34:03 INFO - PROCESS | 22498 | |5;yui.html;565.4458630542069;578.228065532514;587.3773799772239;598.064029793373;650.9414152726259;11543.826842597357;12098.516059357615;12484.438200280987;12510.999120070384;12520.499180032799;12423.937880310608;12522.749545009094;12607.306598137098;12610.117291789578;12616.936915315433;588.123695693418;713.7537549545411;733.9889901651479;736.5838301359742;737.8266107464741;604.6825416656246;615.3016326469467;615.5906322295668;708.1785129250071;738.3797610007592;767.1024900865972;772.382094324541;772.9149793522708;773.408342617895;773.7872085176593;770.5800338815332;771.1324759645399;771.7607541662103;771.9498232614862;772.0619447371471;455.8017262490827;540.6918056707678;560.9467100625434;566.0405612486836;567.5686478276498;12120.757584848341;12124.211926224767;12144.635660930186;12157.756844863141;12162.452689628988;11318.151138664633;11894.88105118955;12356.62930112098;12368.876311236863;12439.096301552634;10681.626143085032;10762.73093172677;10932.890671093266;11036.503357348858;11037.392943388111;4034.253663072341;4077.55146933837;4093.038136038029;4157.5010998680045;4234.957650423487;52198;55501;55784.442155578334;63566.68216658934;63994.3600563993;9930.801383972424;10023.348482348623;10253.179745620482;10383.84424233637;10474.73813154662;19271.325503607306;19332.71000934987;19332.71000934987;19338.516537086405;19359.709604355947;7105.2894710528535;7126.714931402686;7126.857462850714;7276.490645654859;7462.888056679154;3117.747253294529;3317.349108418839;3328.084776686431;3576.2311103112434;3718.3121122592406;2835.4187391585087;2979.1658335666048;2983.8508074596184;2986.3877905029854;2987.9551806722916;498.3795175007139;507.7765783055444;515.579802460993;515.6107139109948;524.3812301484285;455.50122615735717;541.2719891745596;557.4258513730864;566.9461401166883;568.8464114689011;7696.7306144284685;8007.759767206993;8016.879746803803;8516.701915433054;8605.741827745178;501.72655902533205;504.8132191089247;528.7990563585813;548.9451351591947;549.4642723344707;3913.5108111486065;3916.549596796405;3920.7059470539252;4014.2573623879675;4085.9795701021303;97119.51440242754;99619.50190249002;101891.79190289062;101939.49030254802;103925.48037259765;83698;84114.15885841186;84744;85289.57355213184;86645;47260.7636961813;51276.74361628168;77185;80282;81044.3791124186;7621.0582655624485;7654.923450765421;7767.961160194162;8076.919230807852;8152;45951.77024114858;46122.07755844932;46144.538554614024;46466.53533464622;46810.29784553166;38817.805910970266;47345.28982065341;50943.235851462996;51005;53553.464465354846;10570.841437378293;10748.83876741865;11020.338779673246;11587.420628968686;11699.590514331958;12984.805227921777;13204.537841175512;13734.793978090136;13871.098378605358;14079.225642589347;12434.253944763343;12645.430955607204;12861.421236044212;13317.400716967953;13743;11735.178537502294;12107.152499324962;12301.692457688629;12821.166624169398;13239.801402979156;12221.327826969602;12259.203151795105;12337.629871103882;12716.682082948;13123.231193878422;9853.852192216978;9898.802023959337;9931.602735890772;10907.727306817393;10968.287061340987;9339.813203736023;10002.649907253211;10772.353658780497;10940.835887461535;11039.172062095535 00:34:03 INFO - PROCESS | 22498 | __end_tp_report 00:34:03 INFO - PROCESS | 22498 | __start_cc_report 00:34:03 INFO - PROCESS | 22498 | _x_x_mozilla_cycle_collect,1019 00:34:03 INFO - PROCESS | 22498 | __end_cc_report 00:34:03 INFO - PROCESS | 22498 | __startTimestamp1472196843224__endTimestamp 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | ------- Summary: start ------- 00:34:03 INFO - PROCESS | 22498 | Number of tests: 6 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#0] dojo.html Cycles:165 Average:4589.04 Median:4725.60 stddev:468.67 (9.9%) stddev-sans-first:443.37 00:34:03 INFO - PROCESS | 22498 | Values: 2599.6 2610.8 2621.3 2653.9 2667.3 4524.9 4595.2 4606.3 4675.4 4732.1 4594.7 4614.8 4623.3 4641.7 4643.7 4232.3 4268.7 4291.2 4300.7 4303.0 4323.1 4332.7 4345.5 4350.5 4385.6 4275.3 4419.0 4424.4 4425.9 4428.4 4183.0 4321.4 4325.0 4376.7 4379.3 4184.6 4222.5 4224.0 4286.4 4292.8 4588.4 4608.3 4615.6 4688.2 4737.0 4923.8 4950.4 4969.0 4971.5 5033.1 4783.5 4895.7 4976.7 4979.0 4990.9 4604.5 4643.8 4647.0 4647.6 4706.9 4918.8 5083.0 5086.5 5092.3 5146.8 4815.2 4858.6 4859.8 4944.9 4946.5 4972.4 4975.0 4975.3 4978.6 5001.7 4932.9 4934.1 4936.1 4943.3 4985.7 4696.1 4742.2 4827.8 4866.2 4964.1 4165.9 4170.0 4211.4 4218.1 4220.4 3661.4 3676.6 3682.3 3722.7 3727.4 4193.3 4235.0 4274.0 4277.4 4284.3 4956.6 4974.9 4977.0 5006.7 5022.8 4265.8 4272.6 4279.1 4313.0 4332.1 4322.5 4428.6 4443.6 4457.2 4461.5 4739.5 4753.3 4759.4 4759.7 4771.4 4983.2 4989.6 4993.8 4999.6 5055.1 4671.9 4683.5 4706.8 4719.6 4772.0 4685.7 4852.7 4903.8 4919.9 4978.7 4964.4 4972.7 4974.4 4982.6 5026.9 4820.8 4823.4 4831.2 4837.3 4889.6 4630.0 4741.5 4787.9 4792.0 4874.3 4729.3 4757.5 4758.4 4794.6 4847.7 4711.9 4725.6 4736.6 4856.4 4881.4 4700.6 4731.1 4747.3 4750.0 4829.1 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#1] ext.html Cycles:180 Average:43073.71 Median:33682.74 stddev:78249.14 (232.3%) stddev-sans-first:78403.55 00:34:03 INFO - PROCESS | 22498 | Values: 562.0 572.2 573.1 579.4 580.2 27240.7 29864.9 29925.9 30115.0 37664.0 36017.5 39616.4 39636.4 39691.8 39698.2 7603.5 7789.7 7802.8 7806.6 7808.3 7620.3 7715.9 7716.1 7721.8 7723.6 7708.7 7733.0 7743.8 7743.9 7775.1 7692.6 7742.0 7744.5 7745.2 7746.6 7658.3 7711.2 7713.8 7728.6 7730.5 36897.6 37034.0 37109.6 37358.6 37405.0 2884.3 2995.7 3046.8 3142.2 3235.8 27167.3 27985.4 28159.6 28409.7 29313.3 3004.4 3025.5 3037.6 3089.0 3136.9 246592.0 246848.0 247043.0 247150.0 248428.0 29989.9 31290.8 47526.3 47902.8 47924.0 31904.5 32202.0 32220.5 32261.4 32381.0 12566.4 12622.4 12625.1 12625.7 12632.2 10424.2 10438.3 10467.4 10492.2 10494.8 7566.6 7603.5 7655.2 7655.2 7672.0 3029.5 3031.3 3053.1 3054.5 3064.3 875.9 878.8 907.8 916.5 955.1 26230.5 26468.6 26904.2 26964.2 27219.9 768.4 943.8 944.6 956.6 999.6 13962.7 14651.6 14764.9 14837.3 15071.9 354396.0 357366.0 357400.8 358074.0 358176.0 47314.3 47715.0 47808.8 47873.3 47944.5 1054.0 1116.9 1154.5 1162.1 1183.2 25882.4 27711.3 27988.4 28182.4 28249.3 39034.0 39480.8 39606.4 39621.6 39694.2 274236.0 275894.0 277221.0 277394.0 277467.0 23854.0 24533.9 24874.0 24912.3 26106.9 39980.0 40177.6 40499.8 40686.8 41504.0 33279.0 33324.3 33390.8 33459.5 33800.2 33170.3 33171.8 33600.3 34104.8 34116.1 33765.2 33918.3 33927.7 34021.7 34427.3 27924.6 30458.1 32135.7 34058.1 34676.7 24582.6 24659.1 24784.3 25115.0 25200.7 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#2] jquery.html Cycles:180 Average:22001.70 Median:26240.67 stddev:56921.59 (216.9%) stddev-sans-first:57058.04 00:34:03 INFO - PROCESS | 22498 | Values: 342.2 359.6 367.4 372.9 380.4 12327.0 14247.0 16140.6 16359.8 17085.4 13300.7 14302.2 15137.6 15269.6 15271.8 4909.6 4931.4 5138.9 5152.9 5168.5 3616.2 5098.5 5102.4 5594.7 5930.9 5973.9 5975.4 5989.9 6009.0 6020.9 5026.8 5263.5 5263.7 5363.1 6063.4 5234.0 5239.7 5240.6 5241.1 5248.3 16865.4 19167.7 19708.1 19764.7 19851.9 1820.9 1854.4 1924.2 2117.1 2301.2 8232.7 8683.2 8685.7 8791.5 10529.1 1625.3 1685.3 1710.1 1762.2 1786.3 65454.0 68608.7 68979.3 69756.0 69832.3 9527.0 9612.3 9656.2 9902.8 9913.6 13164.9 13192.6 13194.5 13209.9 13213.9 7155.0 7333.3 7385.5 7543.5 7549.7 7049.8 7073.0 7327.1 7344.5 7362.7 3775.5 3867.2 3893.7 3955.1 3971.1 1797.8 1802.4 1803.3 1833.4 1866.0 803.9 805.6 825.3 860.4 959.2 15698.5 16321.9 17026.7 17068.2 17134.7 816.5 817.9 818.8 821.6 821.8 6698.8 8645.2 9012.8 9580.3 9656.4 337302.0 345751.0 346884.0 347482.0 347758.0 43271.6 46392.3 72623.0 73020.0 74019.0 815.3 826.9 842.6 857.3 879.6 15109.4 15166.5 15782.4 16040.3 16122.6 24289.3 25613.9 32681.0 34130.8 34237.7 41197.3 43505.3 45863.8 46712.5 47571.8 7188.8 7347.7 7368.0 7518.1 7649.2 7692.9 10776.1 10997.4 11554.7 11666.0 10014.9 10043.8 10232.1 10315.8 10530.3 9636.0 9674.8 9741.7 9788.5 10322.1 9684.5 10332.2 10386.5 10842.4 10866.8 7296.1 7596.3 7619.7 7675.0 7997.7 8865.0 9921.4 10042.8 10165.3 10175.8 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#3] mootools.html Cycles:180 Average:5212.02 Median:5162.63 stddev:2988.06 (57.9%) stddev-sans-first:2982.33 00:34:03 INFO - PROCESS | 22498 | Values: 1346.8 1370.4 1433.3 1644.3 1661.9 7519.1 8185.9 8199.5 8203.6 8208.4 6577.0 7632.6 7891.7 7895.0 8051.1 2146.1 2177.4 2181.3 2185.8 2188.7 2092.9 2122.7 2161.0 2166.1 2169.0 2139.4 2144.5 2158.7 2162.1 2171.4 2124.7 2128.8 2131.1 2139.7 2141.1 2075.5 2135.8 2141.4 2141.6 2142.3 7664.3 7747.8 7751.3 8105.6 8178.1 4434.6 4579.3 4581.5 4586.5 4599.0 2753.3 2850.8 2900.8 2907.9 2918.4 823.8 877.4 879.1 891.7 892.8 10942.9 10956.1 10986.9 11025.6 11036.4 4018.4 4099.1 4285.6 4302.1 4334.2 9345.5 9352.2 9355.4 9357.3 9371.0 4630.3 4640.1 4643.6 4647.0 4651.9 3599.1 4004.6 4086.8 4254.0 4265.5 3619.0 3644.2 3707.7 3753.4 3758.7 1139.0 1151.0 1161.8 1186.4 1191.3 706.9 818.2 823.3 826.1 830.4 5112.5 5212.8 5228.4 5291.3 5458.8 394.5 395.8 396.8 401.5 406.6 3562.6 3793.3 4157.6 4194.5 4202.1 9774.9 9789.4 9903.3 9934.3 9935.1 9854.3 9861.3 9870.9 9900.3 9901.7 7347.3 7555.2 7571.4 7571.4 7572.7 5447.9 5462.6 5640.0 5667.8 5744.1 8901.4 9015.2 9068.0 9083.1 9163.1 9029.8 9242.3 9339.5 9360.6 9476.1 6328.4 6526.2 6577.3 6662.7 6829.3 7630.2 7662.1 7663.9 7664.8 7680.8 6781.5 6891.9 6939.1 6954.5 7025.6 6811.0 6878.4 6881.2 6885.3 6887.8 6521.1 6522.6 6523.3 6540.6 6579.3 4517.3 4543.3 4606.5 4665.5 4825.7 4568.0 4577.6 4598.2 4626.0 4670.0 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#4] prototype.html Cycles:180 Average:4096.24 Median:4696.67 stddev:1202.48 (25.6%) stddev-sans-first:1171.26 00:34:03 INFO - PROCESS | 22498 | Values: 280.7 284.1 287.7 290.8 291.8 4684.4 4733.3 4762.6 4764.5 4769.9 4692.9 4694.5 4696.5 4696.8 4706.5 3507.8 3578.3 3682.4 3697.4 3720.7 3708.6 3718.6 3719.9 3721.2 3730.3 3671.8 3676.8 3687.9 3694.5 3699.1 3501.5 3507.9 3630.6 3644.8 3655.9 3196.0 3198.9 3205.3 3211.3 3212.0 4557.8 4568.9 4576.8 4598.5 4609.1 3947.2 4162.4 4168.6 4175.6 4185.4 4921.5 4927.5 4927.7 4945.8 4954.9 3502.2 3505.3 3509.3 3514.9 3515.2 4987.2 5163.4 5178.9 5190.6 5202.4 3502.0 3543.6 3549.7 3552.8 3563.3 3585.8 3589.0 3593.6 3599.4 3609.8 4130.6 4130.7 4131.1 4133.8 4140.1 4681.6 4928.3 4937.3 4937.9 4943.9 1235.1 1242.1 1245.3 1248.6 1253.8 766.5 773.2 789.9 804.3 811.4 4255.4 4403.4 4422.9 4438.8 4446.0 5143.4 5153.4 5156.0 5156.5 5163.0 4423.5 4424.8 4433.0 4439.4 4442.0 2564.5 2685.3 2712.2 2712.6 2723.1 4773.2 4793.6 4806.7 4811.8 4818.8 4985.2 5141.2 5176.1 5186.7 5198.5 4760.0 4776.7 4781.0 4785.7 4799.2 5083.5 5090.2 5090.3 5094.5 5107.4 4779.5 4992.6 5002.8 5003.2 5003.5 4760.6 4773.4 4773.6 4775.1 4776.3 3550.2 3552.8 3555.5 3557.1 3562.0 5071.9 5075.9 5076.6 5077.9 5088.2 4687.8 4957.7 4972.2 4979.0 4984.5 4956.9 4959.6 4967.6 4974.6 4974.8 4840.2 4909.3 4927.9 4935.4 4937.8 4730.4 4884.8 4910.9 4972.9 4973.9 4878.3 4886.0 4887.7 4894.6 4902.8 00:34:03 INFO - PROCESS | 22498 | 00:34:03 INFO - PROCESS | 22498 | [#5] yui.html Cycles:180 Average:17283.33 Median:23203.79 stddev:24656.91 (106.3%) stddev-sans-first:24694.12 00:34:03 INFO - PROCESS | 22498 | Values: 565.4 578.2 587.4 598.1 650.9 11543.8 12098.5 12484.4 12511.0 12520.5 12423.9 12522.7 12607.3 12610.1 12616.9 588.1 713.8 734.0 736.6 737.8 604.7 615.3 615.6 708.2 738.4 767.1 772.4 772.9 773.4 773.8 770.6 771.1 771.8 771.9 772.1 455.8 540.7 560.9 566.0 567.6 12120.8 12124.2 12144.6 12157.8 12162.5 11318.2 11894.9 12356.6 12368.9 12439.1 10681.6 10762.7 10932.9 11036.5 11037.4 4034.3 4077.6 4093.0 4157.5 4235.0 52198.0 55501.0 55784.4 63566.7 63994.4 9930.8 10023.3 10253.2 10383.8 10474.7 19271.3 19332.7 19332.7 19338.5 19359.7 7105.3 7126.7 7126.9 7276.5 7462.9 3117.7 3317.3 3328.1 3576.2 3718.3 2835.4 2979.2 2983.9 2986.4 2988.0 498.4 507.8 515.6 515.6 524.4 455.5 541.3 557.4 566.9 568.8 7696.7 8007.8 8016.9 8516.7 8605.7 501.7 504.8 528.8 548.9 549.5 3913.5 3916.5 3920.7 4014.3 4086.0 97119.5 99619.5 101891.8 101939.5 103925.5 83698.0 84114.2 84744.0 85289.6 86645.0 47260.8 51276.7 77185.0 80282.0 81044.4 7621.1 7654.9 7768.0 8076.9 8152.0 45951.8 46122.1 46144.5 46466.5 46810.3 38817.8 47345.3 50943.2 51005.0 53553.5 10570.8 10748.8 11020.3 11587.4 11699.6 12984.8 13204.5 13734.8 13871.1 14079.2 12434.3 12645.4 12861.4 13317.4 13743.0 11735.2 12107.2 12301.7 12821.2 13239.8 12221.3 12259.2 12337.6 12716.7 13123.2 9853.9 9898.8 9931.6 10907.7 10968.3 9339.8 10002.6 10772.4 10940.8 11039.2 00:34:03 INFO - PROCESS | 22498 | -------- Summary: end -------- 00:34:03 INFO - PROCESS | 22498 | 00:34:04 INFO - TEST-INFO | 22498: exit 0 00:34:04 INFO - TEST-OK | dromaeo_css | took 1121421ms 00:34:04 INFO - TEST-START | kraken 00:34:04 INFO - operating with platform_type : linux_ 00:34:04 INFO - Initialising browser for kraken test... 00:34:04 INFO - TEST-INFO | started process 22803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyAH_iY/profile http://localhost:41572/getInfo.html) 00:34:08 INFO - PROCESS | 22803 | __metrics Screen width/height:1600/1200 00:34:08 INFO - PROCESS | 22803 | colorDepth:24 00:34:08 INFO - PROCESS | 22803 | Browser inner width/height: 1024/697 00:34:08 INFO - PROCESS | 22803 | __metrics 00:34:09 INFO - PROCESS | 22803 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:34:09 INFO - PROCESS | 22803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:34:10 INFO - PROCESS | 22803 | console.error: PushService: 00:34:10 INFO - PROCESS | 22803 | stateChangeProcessEnqueue: Error transitioning state 00:34:10 INFO - PROCESS | 22803 | UnknownError 00:34:10 INFO - TEST-INFO | 22803: exit 0 00:34:10 INFO - Browser initialized. 00:34:10 INFO - Running cycle 1/1 for kraken test... 00:34:10 INFO - TEST-INFO | started process 22884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyAH_iY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:34:23 INFO - PROCESS | 22884 | RSS: Main: 180383744 00:34:23 INFO - PROCESS | 22884 | 00:34:25 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41572/tests/kraken/driver.html?testName=audio-beat-detection) 00:34:26 INFO - PROCESS | 22884 | RSS: Main: 234024960 00:34:26 INFO - PROCESS | 22884 | 00:34:29 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41572/tests/kraken/driver.html?testName=audio-dft) 00:34:30 INFO - PROCESS | 22884 | RSS: Main: 224202752 00:34:30 INFO - PROCESS | 22884 | 00:34:33 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41572/tests/kraken/driver.html?testName=audio-fft) 00:34:34 INFO - PROCESS | 22884 | RSS: Main: 302698496 00:34:34 INFO - PROCESS | 22884 | 00:34:36 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41572/tests/kraken/driver.html?testName=audio-oscillator) 00:34:36 INFO - PROCESS | 22884 | RSS: Main: 212963328 00:34:36 INFO - PROCESS | 22884 | 00:34:39 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:34:39 INFO - PROCESS | 22884 | RSS: Main: 214683648 00:34:39 INFO - PROCESS | 22884 | 00:34:42 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41572/tests/kraken/driver.html?testName=imaging-darkroom) 00:34:43 INFO - PROCESS | 22884 | RSS: Main: 253267968 00:34:43 INFO - PROCESS | 22884 | 00:34:46 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41572/tests/kraken/driver.html?testName=imaging-desaturate) 00:34:47 INFO - PROCESS | 22884 | RSS: Main: 247767040 00:34:47 INFO - PROCESS | 22884 | 00:34:50 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41572/tests/kraken/driver.html?testName=json-parse-financial) 00:34:51 INFO - PROCESS | 22884 | RSS: Main: 250036224 00:34:51 INFO - PROCESS | 22884 | 00:34:52 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:34:53 INFO - PROCESS | 22884 | RSS: Main: 214208512 00:34:53 INFO - PROCESS | 22884 | 00:34:55 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:34:55 INFO - PROCESS | 22884 | RSS: Main: 221978624 00:34:55 INFO - PROCESS | 22884 | 00:34:58 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:34:58 INFO - PROCESS | 22884 | RSS: Main: 222310400 00:34:58 INFO - PROCESS | 22884 | 00:35:01 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:35:02 INFO - PROCESS | 22884 | RSS: Main: 223354880 00:35:02 INFO - PROCESS | 22884 | 00:35:05 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:35:05 INFO - PROCESS | 22884 | RSS: Main: 221392896 00:35:05 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | Cycle 1(1): loaded http://localhost:41572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41572/tests/kraken/driver.html?testName=ai-astar) 00:35:07 INFO - PROCESS | 22884 | RSS: Main: 271454208 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | __start_tp_report 00:35:07 INFO - PROCESS | 22884 | _x_x_mozilla_page_load 00:35:07 INFO - PROCESS | 22884 | _x_x_mozilla_page_load_details 00:35:07 INFO - PROCESS | 22884 | |i|pagename|runs| 00:35:07 INFO - PROCESS | 22884 | |0;ai-astar;117;116;130;116;115;117;115;115;115;115 00:35:07 INFO - PROCESS | 22884 | |1;audio-beat-detection;150;129;153;195;126;154;148;126;183;122 00:35:07 INFO - PROCESS | 22884 | |2;audio-dft;162;162;162;163;161;160;161;162;161;160 00:35:07 INFO - PROCESS | 22884 | |3;audio-fft;75;75;77;161;77;77;76;79;167;79 00:35:07 INFO - PROCESS | 22884 | |4;audio-oscillator;84;85;155;85;83;84;132;82;83;139 00:35:07 INFO - PROCESS | 22884 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 00:35:07 INFO - PROCESS | 22884 | |6;imaging-darkroom;147;147;146;146;146;146;147;145;146;147 00:35:07 INFO - PROCESS | 22884 | |7;imaging-desaturate;95;95;95;96;95;96;96;95;96;95 00:35:07 INFO - PROCESS | 22884 | |8;json-parse-financial;63;64;65;74;65;65;66;66;66;65 00:35:07 INFO - PROCESS | 22884 | |9;json-stringify-tinderbox;66;66;66;66;65;65;66;65;67;66 00:35:07 INFO - PROCESS | 22884 | |10;stanford-crypto-aes;83;82;82;82;85;82;83;85;82;83 00:35:07 INFO - PROCESS | 22884 | |11;stanford-crypto-ccm;133;133;131;139;133;133;142;132;168;134 00:35:07 INFO - PROCESS | 22884 | |12;stanford-crypto-pbkdf2;174;174;173;172;171;178;172;173;184;172 00:35:07 INFO - PROCESS | 22884 | |13;stanford-crypto-sha256-iterative;70;68;73;70;68;69;69;70;68;71 00:35:07 INFO - PROCESS | 22884 | __end_tp_report 00:35:07 INFO - PROCESS | 22884 | __start_cc_report 00:35:07 INFO - PROCESS | 22884 | _x_x_mozilla_cycle_collect,1993 00:35:07 INFO - PROCESS | 22884 | __end_cc_report 00:35:07 INFO - PROCESS | 22884 | __startTimestamp1472196907870__endTimestamp 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | ------- Summary: start ------- 00:35:07 INFO - PROCESS | 22884 | Number of tests: 14 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#0] ai-astar Cycles:10 Average:117.10 Median:116.00 stddev:4.61 (4.0%) stddev-sans-first:4.88 00:35:07 INFO - PROCESS | 22884 | Values: 117.0 116.0 130.0 116.0 115.0 117.0 115.0 115.0 115.0 115.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:151.50 stddev:24.72 (16.3%) stddev-sans-first:26.22 00:35:07 INFO - PROCESS | 22884 | Values: 150.0 129.0 153.0 195.0 126.0 154.0 148.0 126.0 183.0 122.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 00:35:07 INFO - PROCESS | 22884 | Values: 162.0 162.0 162.0 163.0 161.0 160.0 161.0 162.0 161.0 160.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#3] audio-fft Cycles:10 Average:94.30 Median:77.00 stddev:36.79 (47.8%) stddev-sans-first:38.35 00:35:07 INFO - PROCESS | 22884 | Values: 75.0 75.0 77.0 161.0 77.0 77.0 76.0 79.0 167.0 79.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.50 stddev:28.71 (34.4%) stddev-sans-first:29.77 00:35:07 INFO - PROCESS | 22884 | Values: 84.0 85.0 155.0 85.0 83.0 84.0 132.0 82.0 83.0 139.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:35:07 INFO - PROCESS | 22884 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 00:35:07 INFO - PROCESS | 22884 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 147.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:35:07 INFO - PROCESS | 22884 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.50 stddev:3.00 (4.6%) stddev-sans-first:2.99 00:35:07 INFO - PROCESS | 22884 | Values: 63.0 64.0 65.0 74.0 65.0 65.0 66.0 66.0 66.0 65.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 00:35:07 INFO - PROCESS | 22884 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 67.0 66.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 00:35:07 INFO - PROCESS | 22884 | Values: 83.0 82.0 82.0 82.0 85.0 82.0 83.0 85.0 82.0 83.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:133.50 stddev:11.14 (8.3%) stddev-sans-first:11.68 00:35:07 INFO - PROCESS | 22884 | Values: 133.0 133.0 131.0 139.0 133.0 133.0 142.0 132.0 168.0 134.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:173.50 stddev:3.92 (2.3%) stddev-sans-first:4.15 00:35:07 INFO - PROCESS | 22884 | Values: 174.0 174.0 173.0 172.0 171.0 178.0 172.0 173.0 184.0 172.0 00:35:07 INFO - PROCESS | 22884 | 00:35:07 INFO - PROCESS | 22884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 00:35:07 INFO - PROCESS | 22884 | Values: 70.0 68.0 73.0 70.0 68.0 69.0 69.0 70.0 68.0 71.0 00:35:07 INFO - PROCESS | 22884 | -------- Summary: end -------- 00:35:07 INFO - PROCESS | 22884 | 00:35:09 INFO - TEST-INFO | 22884: exit 0 00:35:09 INFO - TEST-OK | kraken | took 64944ms 00:35:09 INFO - SUITE-END | took 1186s 00:35:09 INFO - Completed test suite (00:19:46) 00:35:09 INFO - javascript benchmark 00:35:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.6490473786034, 2610.8433493990356, 2621.3184572011273, 2653.9203823885277, 2667.30650030992, 4524.9095018099615, 4595.218812801823, 4606.262997920333, 4675.3688252086, 4732.148213321605, 4594.655400844933, 4614.792334344954, 4623.329617205503, 4641.7214967102, 4643.698159619631, 4232.301670224417, 4268.701190916637, 4291.249031419505, 4300.741955482681, 4303.0, 4323.1353729254115, 4332.675049371294, 4345.543717909622, 4350.499692535367, 4385.561443855605, 4275.315949448089, 4419.0, 4424.380586717862, 4425.911481770363, 4428.424304840366, 4183.037901282692, 4321.351797230409, 4325.0, 4376.737395756233, 4379.277419225824, 4184.644305234059, 4222.451081359403, 4223.97888010558, 4286.357046443059, 4292.785360731951, 4588.357629931812, 4608.308753686973, 4615.560720453508, 4688.249880019181, 4737.0, 4923.77842997066, 4950.381202349707, 4969.0, 4971.477994810529, 5033.144365457881, 4783.4977327380475, 4895.730734809584, 4976.726280054596, 4978.9751051244875, 4990.87522811929, 4604.539546045436, 4643.8374656886845, 4647.047355292157, 4647.581717645428, 4706.858794236178, 4918.778654960535, 5082.974585127051, 5086.516780905808, 5092.312537807423, 5146.794128234904, 4815.15734746418, 4858.611311095104, 4859.757012149378, 4944.851654450372, 4946.455889852114, 4972.4033116025585, 4974.950250497521, 4975.253711943237, 4978.551930326288, 5001.7499125043605, 4932.926006109911, 4934.111859865258, 4936.111499930047, 4943.332650092263, 4985.700857948535, 4696.131215725101, 4742.241241401428, 4827.782749776268, 4866.172750632401, 4964.106460837084, 4165.875023749292, 4169.979150104291, 4211.43145675336, 4218.114196018871, 4220.409142720022, 3661.3958696814725, 3676.613955534684, 3682.3371793077504, 3722.7207959403154, 3727.38498147808, 4193.287141186006, 4234.957650423518, 4274.0, 4277.358396240589, 4284.335927931175, 4956.603471722254, 4974.850754477371, 4976.954839483749, 5006.674566153189, 5022.773975171126, 4265.829366825292, 4272.594103560157, 4279.101388708344, 4312.986448184674, 4332.068605249887, 4322.502912165079, 4428.579284967987, 4443.555644435595, 4457.2199865023495, 4461.486929003141, 4739.549742774431, 4753.334533165291, 4759.42886853566, 4759.6668233223345, 4771.355866958055, 4983.227599722049, 4989.60083193351, 4993.825216117419, 4999.625028122978, 5055.090083784807, 4671.883202919818, 4683.508231635629, 4706.835260765994, 4719.551642593948, 4771.95228047715, 4685.67200295976, 4852.73309967941, 4903.754812259444, 4919.85240442773, 4978.701277923336, 4964.35463389757, 4972.701637901593, 4974.427940786856, 4982.601391888713, 5026.874328141679, 4820.783064762164, 4823.445303790109, 4831.178699621002, 4837.346958160603, 4889.584385327287, 4629.976850115728, 4741.454732705645, 4787.8563643090765, 4792.041591681747, 4874.268859671078, 4729.266963620645, 4757.452892917358, 4758.381410416624, 4794.5924596409695, 4847.733374664427, 4711.858644240679, 4725.5983241424865, 4736.644751643709, 4856.39295088114, 4881.438634557071, 4700.55344742249, 4731.101090792738, 4747.335373047845, 4749.952500475089, 4829.058333624909], "value": 4559.998108890542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.0473297760295, 572.1532132443986, 573.0945106731365, 579.4061087385429, 580.2196046317703, 27240.72759272409, 29864.850675746646, 29925.850370748143, 30115.0, 37664.0, 36017.45973810395, 39616.40575391364, 39636.40545391821, 39691.80154099225, 39698.206035879266, 7603.467757256981, 7789.688412463494, 7802.8439431211345, 7806.570638614874, 7808.336291415237, 7620.314171724572, 7715.922840771576, 7716.074071111474, 7721.768346949572, 7723.575203363813, 7708.6916523339, 7733.033370828646, 7743.806404839896, 7743.922560774405, 7775.1447340792465, 7692.576908270043, 7741.961290193569, 7744.496607720536, 7745.225477452294, 7746.573938433384, 7658.310752032344, 7711.2288771123, 7713.807154821118, 7728.613569321511, 7730.497517661391, 36897.63102368969, 37034.0, 37109.62890371089, 37358.62641373579, 37405.0, 2884.2645125492863, 2995.7303842654264, 3046.7714921380984, 3142.1673256587023, 3235.8382080896095, 27167.320816979536, 27985.440291194267, 28159.577606335923, 28409.71590284112, 29313.267168320748, 3004.4141392428487, 3025.5461680747844, 3037.635483741943, 3089.0, 3136.8902088427026, 246592.0, 246848.0, 247043.0, 247150.0, 248428.0, 29989.850050749606, 31290.84354578258, 47526.287105693445, 47902.760486197345, 47924.0, 31904.521432178535, 32202.0, 32220.516692249636, 32261.35477290441, 32381.0, 12566.434510447052, 12622.368881556069, 12625.116241862981, 12625.684357891127, 12632.2420654761, 10424.166066714644, 10438.269321147447, 10467.371957682564, 10492.213084018576, 10494.790104197873, 7566.621668916642, 7603.543787372775, 7655.1962043985695, 7655.1962043985695, 7672.0, 3029.4849875521213, 3031.317953460498, 3053.114596766957, 3054.465468542996, 3064.2798942248555, 875.8642410426394, 878.767126711422, 907.7503686486137, 916.4638686368415, 955.1260596554214, 26230.475390492084, 26468.60297095545, 26904.192874213804, 26964.191074267805, 27219.863900680764, 768.3776141325544, 943.773494361362, 944.5607792376578, 956.6077908057663, 999.5801763259449, 13962.720745585235, 14651.633709157357, 14764.852351476562, 14837.332320045623, 15071.924640376728, 354396.0, 357366.0, 357400.75089862535, 358074.0, 358176.0, 47314.290285645744, 47715.0, 47808.76095619569, 47873.281900771515, 47944.520554794704, 1053.9578416863394, 1116.9162312826409, 1154.520873837348, 1162.1167912386816, 1183.2249876331016, 25882.35294117662, 27711.30721731973, 27988.44023119567, 28182.43635127245, 28249.293767655974, 39034.0, 39480.80259598799, 39606.40590391204, 39621.60378396294, 39694.2061158781, 274236.0, 275894.0, 277221.0, 277394.0, 277467.0, 23854.0, 24533.87733061395, 24874.0, 24912.252632421056, 26106.86946565255, 39980.0, 40177.598224018555, 40499.797501012305, 40686.79656601698, 41504.0, 33279.0, 33324.333513330086, 33390.83304583462, 33459.49810752792, 33800.1549961253, 33170.336593267515, 33171.83414082914, 33600.327993440485, 34104.829475852464, 34116.14709632279, 33765.155871103416, 33918.321633566695, 33927.66072339245, 34021.65978340185, 34427.31145377128, 27924.58113128264, 30458.086257412313, 32135.67864321327, 34058.14854628654, 34676.65323346734, 24582.63126053075, 24659.136930207358, 24784.25647230586, 25115.0, 25200.74799251984], "value": 15688.032392557525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.17023717485125, 359.61341557825347, 367.3534579140712, 372.90677330667336, 380.38567713143266, 12327.0, 14247.0, 16140.596485087879, 16359.754603680954, 17085.40201092962, 13300.667483312922, 14302.213378264218, 15137.621559461018, 15269.618259543517, 15271.77092343613, 4909.582685471739, 4931.358923339979, 5138.948610513903, 5152.871178220537, 5168.508991645787, 3616.222512159885, 5098.490150984909, 5102.387713474388, 5594.664320140804, 5930.911036334458, 5973.910391344133, 5975.43233392827, 5989.8802023959715, 6008.96995515024, 6020.909686354708, 5026.798928042892, 5263.473652634744, 5263.736813159365, 5363.141897296453, 6063.363346848561, 5233.9738301308635, 5239.659422137587, 5240.580753539708, 5241.056609810233, 5248.317718696583, 16865.409710660068, 19167.712484312746, 19708.113134908963, 19764.70352944707, 19851.90074049635, 1820.863435242349, 1854.3509771579975, 1924.1533725160884, 2117.089651449876, 2301.2175860207444, 8232.711855085103, 8683.2185103341, 8685.652573897036, 8791.516466594334, 10529.105026072793, 1625.3336132185866, 1685.2669088946225, 1710.1278348042463, 1762.1629725880232, 1786.2587026384035, 65454.0, 68608.6569567149, 68979.31020689779, 69756.0, 69832.30167698309, 9527.0, 9612.279079069098, 9656.179224765974, 9902.752431189278, 9913.603455861828, 13164.868351316365, 13192.604221873358, 13194.538191163456, 13209.867901321057, 13213.933930330288, 7155.0, 7333.266673332624, 7385.483016188815, 7543.547387156788, 7549.7357592483995, 7049.7885063448175, 7073.0, 7327.0841144856895, 7344.485885988036, 7362.668679909417, 3775.4525593789294, 3867.2458870519977, 3893.7274390792372, 3955.149642826806, 3971.0866500705, 1797.7932537758325, 1802.3871883559652, 1803.3147403986402, 1833.3949796567101, 1865.9626807464047, 803.9397045221632, 805.5851236613149, 825.3204728377723, 860.4321148042262, 959.2421986630484, 15698.529044128694, 16321.939073960155, 17026.659466810594, 17068.2319295632, 17134.742978855327, 816.5141740664295, 817.8568750468644, 818.7707441916273, 821.6261600971544, 821.7822277096574, 6698.83252918681, 8645.221930026202, 9012.819743605221, 9580.329376943686, 9656.37233579815, 337302.0, 345751.0, 346884.0, 347482.0, 347758.0, 43271.567284327386, 46392.304115438295, 72623.0, 73020.0, 74019.0, 815.2703330519153, 826.8842362069315, 842.5534466732641, 857.3012994409661, 879.564615515324, 15109.39562417491, 15166.545003649908, 15782.368705251662, 16040.278187481825, 16122.596935076717, 24289.27132186037, 25613.871930640227, 32681.0, 34130.82934585311, 34237.65762342444, 41197.28269229853, 43505.34741978809, 45863.77068114772, 46712.53287467082, 47571.76214118907, 7188.820279493055, 7347.66935487915, 7367.963160184165, 7518.135414427411, 7649.158592554703, 7692.923070769444, 10776.137908967106, 10997.395143267197, 11554.711132221762, 11666.0, 10014.899851001397, 10043.799124017625, 10232.130268926927, 10315.793684126425, 10530.262881598215, 9635.951820241135, 9674.806503870024, 9741.707748767549, 9788.510574471391, 10322.071013608811, 9684.467354295299, 10332.225083118647, 10386.48067596602, 10842.403667798348, 10866.78266434651, 7296.087989001375, 7596.316331530189, 7619.65711542993, 7674.961625192062, 7997.680092796456, 8865.0, 9921.40471571708, 10042.799144017225, 10165.288429809842, 10175.84736228972], "value": 7852.700502716693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.7777816660248, 1370.3696299702137, 1433.3191733926387, 1644.2600829626672, 1661.9311101141523, 7519.097708275001, 8185.877211841827, 8199.508029518232, 8203.58982050898, 8208.425410221287, 6576.96711516443, 7632.618369081538, 7891.723789667363, 7895.0, 8051.114377418479, 2146.0986385717997, 2177.368563116694, 2181.334692918659, 2185.8360622953264, 2188.7154669892893, 2092.9221450952696, 2122.7240458740343, 2160.9567808643897, 2166.1335465813645, 2169.034779523113, 2139.3902737719754, 2144.5067634444085, 2158.686990386393, 2162.0703097667997, 2171.381156370435, 2124.6706760452153, 2128.829693624522, 2131.136889559723, 2139.657654775236, 2141.1114387529155, 2075.5018795489127, 2135.7757435469207, 2141.4004078857943, 2141.635921893266, 2142.2609199826034, 7664.271894170045, 7747.767566973, 7751.302382785577, 8105.594720263964, 8178.100408955011, 4434.556544345572, 4579.267317229261, 4581.473130589991, 4586.518415566351, 4599.034202817413, 2753.3116720819794, 2850.800443968923, 2900.8114472559214, 2907.912762617125, 2918.430905973336, 823.798169448483, 877.412133870302, 879.116487929633, 891.6522556203086, 892.7902691852511, 10942.890571094267, 10956.12351011925, 10986.945065274622, 11025.558977640885, 11036.392998385085, 4018.3771515415156, 4099.077707515785, 4285.5928686774705, 4302.096559722493, 4334.241507736134, 9345.532723363805, 9352.205062569758, 9355.391899526508, 9357.251419886392, 9370.95314523423, 4630.282306242538, 4640.095181439587, 4643.582077613031, 4647.024124933734, 4651.930221046687, 3599.082234030358, 4004.6395824375363, 4086.7547947123267, 4254.0, 4265.53079161292, 3619.0, 3644.161842776123, 3707.721920855947, 3753.3806921858136, 3758.661720445173, 1138.9829152562718, 1151.027381862325, 1161.7560312334335, 1186.4127257007835, 1191.326900301327, 706.8550947055944, 818.2308629887887, 823.2549542663899, 826.1366871619173, 830.4187069051688, 5112.488751124858, 5212.765425555859, 5228.405336372367, 5291.259223708684, 5458.754356053987, 394.5482422626077, 395.83572817280503, 396.7678907838889, 401.47005952143473, 406.5710675237594, 3562.6437356264164, 3793.2982398256413, 4157.625813676784, 4194.538600753915, 4202.138561594866, 9774.853377199348, 9789.363691360039, 9903.25725570585, 9934.304598678167, 9935.105840474393, 9854.260930430246, 9861.260405469618, 9870.851937220947, 9900.306978511435, 9901.653442129491, 7347.338739513362, 7555.206703296185, 7571.3942884569105, 7571.432142589218, 7572.697092116364, 5447.863803404946, 5462.590305727166, 5639.9718001411375, 5667.838093190969, 5744.109663002241, 8901.376903616685, 9015.233705135137, 9068.047854975133, 9083.137101975302, 9163.083691630784, 9029.819403612022, 9242.260619150586, 9339.48632825174, 9360.625574976924, 9476.147146756824, 6328.398802113792, 6526.24948130971, 6577.309382514958, 6662.666866656745, 6829.282925292773, 7630.16068232505, 7662.080550333995, 7663.88504172449, 7664.770056898302, 7680.80797980055, 6781.457483401415, 6891.862162756616, 6939.132608423947, 6954.47841411886, 7025.6487175639995, 6810.965945170243, 6878.415334696607, 6881.243063262937, 6885.345892140239, 6887.758928437481, 6521.054447105238, 6522.5760325578685, 6523.3150519194805, 6540.607563546202, 6579.276279609335, 4517.254652982221, 4543.318502224561, 4606.470255920612, 4665.533446655308, 4825.686330388514, 4567.954320456753, 4577.633789296781, 4598.21830288845, 4625.976870115628, 4670.019295947889], "value": 4086.221104791736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.69404349259315, 284.13764225575375, 287.7094134923726, 290.77029146973894, 291.83802989340916, 4684.437867455906, 4733.313669517918, 4762.618990480758, 4764.547368000043, 4769.856904292872, 4692.882677933045, 4694.4601370842365, 4696.530346965302, 4696.812127514895, 4706.458757242918, 3507.7725644215916, 3578.3022310649435, 3682.3739964206147, 3697.426898830672, 3720.674578388507, 3708.647678470541, 3718.572364178127, 3719.9070023249365, 3721.2371463849845, 3730.2912446635187, 3671.834767435472, 3676.7977761223124, 3687.8709245176424, 3694.482772411851, 3699.1307042845046, 3501.5272938153407, 3507.8947631571095, 3630.564332280117, 3644.817759112034, 3655.94516082259, 3195.952060719091, 3198.856051477689, 3205.2627895583914, 3211.277462570926, 3212.0, 4557.77211139445, 4568.908621827578, 4576.816927322936, 4598.494165641777, 4609.078184363141, 3947.210557888434, 4162.41726158338, 4168.6039826216465, 4175.62419382257, 4185.434966279574, 4921.50784921505, 4927.457979622239, 4927.704337739747, 4945.7774400152075, 4954.9009019819405, 3502.176988407722, 3505.3339865425487, 3509.2630547585036, 3514.894553163409, 3515.244222492151, 4987.177115775893, 5163.406208286057, 5178.922316165223, 5190.558802501791, 5202.375714914197, 3501.9824900875333, 3543.6279190685123, 3549.680528752373, 3552.769070010441, 3563.3051554946537, 3585.766925149857, 3588.964110358915, 3593.5508061492314, 3599.38810402227, 3609.7653652512504, 4130.56629053945, 4130.669546436338, 4131.058402550796, 4133.751974881517, 4140.109876376593, 4681.555252251031, 4928.260760885824, 4937.308776771255, 4937.851864444073, 4943.90112197754, 1235.0983781839307, 1242.1180961517423, 1245.3212998915612, 1248.6066888929959, 1253.7617852607975, 766.52858492027, 773.2190487607556, 789.8538770327508, 804.3283857978537, 811.3874025111004, 4255.3829694694095, 4403.361512580658, 4422.867313980586, 4438.822447102144, 4445.977770111193, 5143.434222235551, 5153.3815942087185, 5156.0, 5156.484351564814, 5162.97418512905, 4423.469183697976, 4424.823007079745, 4433.0, 4439.356293337448, 4441.955580444154, 2564.499922515092, 2685.3018215264174, 2712.159230638469, 2712.620233167358, 2723.1422102037795, 4773.236282194832, 4793.592544633675, 4806.735629540339, 4811.831585894477, 4818.759062046884, 4985.227289770091, 5141.226276934452, 5176.1459359206065, 5186.740662966837, 5198.454162312978, 4760.024589795196, 4776.665633405628, 4780.976095119572, 4785.665003449725, 4799.1601469743355, 5083.491650834887, 5090.2364645303505, 5090.287359769709, 5094.541491265803, 5107.361579802525, 4779.450363208275, 4992.5756310714, 5002.799328161288, 5003.249512572997, 5003.499650034967, 4760.59534939534, 4773.403324584427, 4773.594244489257, 4775.140474714584, 4776.259679749644, 3550.2366991097037, 3552.7690700105445, 3555.484454754098, 3557.092941299952, 3561.982190089033, 5071.92392114126, 5075.898482030265, 5076.6446348755235, 5077.949220507748, 5088.185890257541, 4687.812487500598, 4957.702537847741, 4972.204447288416, 4978.975105124596, 4984.476629953948, 4956.89332033877, 4959.628027897994, 4967.627427942846, 4974.626902982219, 4974.7512624369365, 4840.169549368602, 4909.288153217834, 4927.901441971212, 4935.432425271139, 4937.77779999908, 4730.408698912636, 4884.78018489176, 4910.8772280693265, 4972.900541989067, 4973.900521989613, 4878.292647566154, 4886.021161429627, 4887.706737595756, 4894.608431325557, 4902.754862256944], "value": 3708.6081876476956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4458630542069, 578.228065532514, 587.3773799772239, 598.064029793373, 650.9414152726259, 11543.826842597357, 12098.516059357615, 12484.438200280987, 12510.999120070384, 12520.499180032799, 12423.937880310608, 12522.749545009094, 12607.306598137098, 12610.117291789578, 12616.936915315433, 588.123695693418, 713.7537549545411, 733.9889901651479, 736.5838301359742, 737.8266107464741, 604.6825416656246, 615.3016326469467, 615.5906322295668, 708.1785129250071, 738.3797610007592, 767.1024900865972, 772.382094324541, 772.9149793522708, 773.408342617895, 773.7872085176593, 770.5800338815332, 771.1324759645399, 771.7607541662103, 771.9498232614862, 772.0619447371471, 455.8017262490827, 540.6918056707678, 560.9467100625434, 566.0405612486836, 567.5686478276498, 12120.757584848341, 12124.211926224767, 12144.635660930186, 12157.756844863141, 12162.452689628988, 11318.151138664633, 11894.88105118955, 12356.62930112098, 12368.876311236863, 12439.096301552634, 10681.626143085032, 10762.73093172677, 10932.890671093266, 11036.503357348858, 11037.392943388111, 4034.253663072341, 4077.55146933837, 4093.038136038029, 4157.5010998680045, 4234.957650423487, 52198.0, 55501.0, 55784.442155578334, 63566.68216658934, 63994.3600563993, 9930.801383972424, 10023.348482348623, 10253.179745620482, 10383.84424233637, 10474.73813154662, 19271.325503607306, 19332.71000934987, 19332.71000934987, 19338.516537086405, 19359.709604355947, 7105.2894710528535, 7126.714931402686, 7126.857462850714, 7276.490645654859, 7462.888056679154, 3117.747253294529, 3317.349108418839, 3328.084776686431, 3576.2311103112434, 3718.3121122592406, 2835.4187391585087, 2979.1658335666048, 2983.8508074596184, 2986.3877905029854, 2987.9551806722916, 498.3795175007139, 507.7765783055444, 515.579802460993, 515.6107139109948, 524.3812301484285, 455.50122615735717, 541.2719891745596, 557.4258513730864, 566.9461401166883, 568.8464114689011, 7696.7306144284685, 8007.759767206993, 8016.879746803803, 8516.701915433054, 8605.741827745178, 501.72655902533205, 504.8132191089247, 528.7990563585813, 548.9451351591947, 549.4642723344707, 3913.5108111486065, 3916.549596796405, 3920.7059470539252, 4014.2573623879675, 4085.9795701021303, 97119.51440242754, 99619.50190249002, 101891.79190289062, 101939.49030254802, 103925.48037259765, 83698.0, 84114.15885841186, 84744.0, 85289.57355213184, 86645.0, 47260.7636961813, 51276.74361628168, 77185.0, 80282.0, 81044.3791124186, 7621.0582655624485, 7654.923450765421, 7767.961160194162, 8076.919230807852, 8152.0, 45951.77024114858, 46122.07755844932, 46144.538554614024, 46466.53533464622, 46810.29784553166, 38817.805910970266, 47345.28982065341, 50943.235851462996, 51005.0, 53553.464465354846, 10570.841437378293, 10748.83876741865, 11020.338779673246, 11587.420628968686, 11699.590514331958, 12984.805227921777, 13204.537841175512, 13734.793978090136, 13871.098378605358, 14079.225642589347, 12434.253944763343, 12645.430955607204, 12861.421236044212, 13317.400716967953, 13743.0, 11735.178537502294, 12107.152499324962, 12301.692457688629, 12821.166624169398, 13239.801402979156, 12221.327826969602, 12259.203151795105, 12337.629871103882, 12716.682082948, 13123.231193878422, 9853.852192216978, 9898.802023959337, 9931.602735890772, 10907.727306817393, 10968.287061340987, 9339.813203736023, 10002.649907253211, 10772.353658780497, 10940.835887461535, 11039.172062095535], "value": 6420.691717343261, "unit": "score"}], "name": "dromaeo_css", "value": 6160.540900010516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 130.0, 116.0, 115.0, 117.0, 115.0, 115.0, 115.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 153.0, 195.0, 126.0, 154.0, 148.0, 126.0, 183.0, 122.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 160.0, 161.0, 162.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 161.0, 77.0, 77.0, 76.0, 79.0, 167.0, 79.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 155.0, 85.0, 83.0, 84.0, 132.0, 82.0, 83.0, 139.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 74.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 85.0, 82.0, 83.0, 85.0, 82.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 131.0, 139.0, 133.0, 133.0, 142.0, 132.0, 168.0, 134.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 173.0, 172.0, 171.0, 178.0, 172.0, 173.0, 184.0, 172.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 73.0, 70.0, 68.0, 69.0, 69.0, 70.0, 68.0, 71.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1577.4999999999998, "alertThreshold": 2.0}]} 00:35:09 INFO - Return code: 0 00:35:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:35:09 INFO - # TBPL SUCCESS # 00:35:09 INFO - Running post-action listener: _resource_record_post_action 00:35:09 INFO - [mozharness: 2016-08-26 07:35:09.677963Z] Finished run-tests step (success) 00:35:09 INFO - Running post-run listener: _resource_record_post_run 00:35:09 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 405991424; Read time: 0; Write time: 401848 00:35:09 INFO - TinderboxPrint: CPU usage
13.0% 00:35:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:35:09 INFO - TinderboxPrint: I/O write bytes / time
405,991,424 / 401,848 00:35:09 INFO - TinderboxPrint: CPU idle
8,347.3 (87.0%) 00:35:09 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 00:35:09 INFO - TinderboxPrint: Swap in / out
0 / 0 00:35:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113741824; Read time: 0; Write time: 125512 00:35:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292249600; Read time: 0; Write time: 276336 00:35:10 INFO - Running post-run listener: _upload_blobber_files 00:35:10 INFO - Blob upload gear active. 00:35:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:35:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:35:10 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:35:10 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:35:10 INFO - (blobuploader) - INFO - Open directory for files ... 00:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:14 INFO - (blobuploader) - INFO - Done attempting. 00:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:15 INFO - (blobuploader) - INFO - Done attempting. 00:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:16 INFO - (blobuploader) - INFO - Done attempting. 00:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 00:35:16 INFO - Return code: 0 00:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/76bfc87747ae952dc585a797d8269b1b8ae37fbc8aed444f7f85700e852032a44764d095ea3b9d03823a1fe6577bd85e99dbaff5cac02536ff0069e3f781711b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d50f6d569d7b233cd9fcfabc5f3e7f9162cd3deaf2c805ba1eb1a5ca972ef85025663ba6644667b15a0eb419d961704869b1f9261dc2f20d7ec66a05d85d4981", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624f67290e29c8b559a4e334cfeee6bd02213d23bdcdb298e25b1b1e1ee7deb5ac340cde1fbdf349d68f4eb0104face80c79572c607a872f39bdef9cffb7517b"} 00:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:35:16 INFO - Contents: 00:35:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/76bfc87747ae952dc585a797d8269b1b8ae37fbc8aed444f7f85700e852032a44764d095ea3b9d03823a1fe6577bd85e99dbaff5cac02536ff0069e3f781711b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d50f6d569d7b233cd9fcfabc5f3e7f9162cd3deaf2c805ba1eb1a5ca972ef85025663ba6644667b15a0eb419d961704869b1f9261dc2f20d7ec66a05d85d4981", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624f67290e29c8b559a4e334cfeee6bd02213d23bdcdb298e25b1b1e1ee7deb5ac340cde1fbdf349d68f4eb0104face80c79572c607a872f39bdef9cffb7517b"} 00:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 00:35:16 INFO - Copying logs to upload dir... 00:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 00:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.714315 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 00:35:15.866120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 00:35:15.870047) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 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-Non-PGO/sha512/76bfc87747ae952dc585a797d8269b1b8ae37fbc8aed444f7f85700e852032a44764d095ea3b9d03823a1fe6577bd85e99dbaff5cac02536ff0069e3f781711b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d50f6d569d7b233cd9fcfabc5f3e7f9162cd3deaf2c805ba1eb1a5ca972ef85025663ba6644667b15a0eb419d961704869b1f9261dc2f20d7ec66a05d85d4981", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624f67290e29c8b559a4e334cfeee6bd02213d23bdcdb298e25b1b1e1ee7deb5ac340cde1fbdf349d68f4eb0104face80c79572c607a872f39bdef9cffb7517b"} build_url:https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/JhaQ4zRLR7SDtvwNhMTh-w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/76bfc87747ae952dc585a797d8269b1b8ae37fbc8aed444f7f85700e852032a44764d095ea3b9d03823a1fe6577bd85e99dbaff5cac02536ff0069e3f781711b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d50f6d569d7b233cd9fcfabc5f3e7f9162cd3deaf2c805ba1eb1a5ca972ef85025663ba6644667b15a0eb419d961704869b1f9261dc2f20d7ec66a05d85d4981", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624f67290e29c8b559a4e334cfeee6bd02213d23bdcdb298e25b1b1e1ee7deb5ac340cde1fbdf349d68f4eb0104face80c79572c607a872f39bdef9cffb7517b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 00:35:15.895814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:35:15.896169) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1472195137.639170-1506865430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:35:15.982410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 00:35:15.983129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 00:35:15.983460) ========= ========= Total master_lag: 0.16 =========