builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1472030500.59 results: success (0) buildid: 20160823233011 builduid: 1a4d250dcce44e6ba825556523370c77 revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.586550) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.586983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.587302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.604974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.605308) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 02:21:40-- 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% 227M=0s 2016-08-24 02:21:40 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094178 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.768711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.769375) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023240 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:40.810188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 02:21:40.810676) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 02:21:41,089 truncating revision to first 12 chars 2016-08-24 02:21:41,089 Setting DEBUG logging. 2016-08-24 02:21:41,089 attempt 1/10 2016-08-24 02:21:41,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb8d56badefe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 02:21:42,361 unpacking tar archive at: fx-team-eb8d56badefe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.550359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 02:21:42.379597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:42.380361) ========= script_repo_revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:42.381275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:42.381811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 02:21:42.393259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-24 02:21:42.393572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:21:42 INFO - MultiFileLogger online at 20160824 02:21:42 in /builds/slave/test 02:21:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:21:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:21:42 INFO - {'append_to_log': False, 02:21:42 INFO - 'base_work_dir': '/builds/slave/test', 02:21:42 INFO - 'blob_upload_branch': 'Fx-Team', 02:21:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:21:42 INFO - 'branch': 'Fx-Team', 02:21:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:21:42 INFO - 'config_files': ('talos/linux_config.py',), 02:21:42 INFO - 'default_actions': ('clobber', 02:21:42 INFO - 'read-buildbot-config', 02:21:42 INFO - 'download-and-extract', 02:21:42 INFO - 'populate-webroot', 02:21:42 INFO - 'create-virtualenv', 02:21:42 INFO - 'install', 02:21:42 INFO - 'run-tests'), 02:21:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:21:42 INFO - 'download_minidump_stackwalk': True, 02:21:42 INFO - 'download_symbols': 'ondemand', 02:21:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:21:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:21:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:21:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:21:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:21:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:21:42 INFO - 'installer_path': 'installer.exe', 02:21:42 INFO - 'log_level': 'info', 02:21:42 INFO - 'log_name': 'talos', 02:21:42 INFO - 'log_to_console': True, 02:21:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:21:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:21:42 INFO - 'opt_config_files': (), 02:21:42 INFO - 'pip_index': False, 02:21:42 INFO - 'sps_profile': False, 02:21:42 INFO - 'sps_profile_interval': 0, 02:21:42 INFO - 'suite': 'dromaeojs-e10s', 02:21:42 INFO - 'system_bits': '32', 02:21:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:21:42 INFO - 'title': 'talos-linux64-ix-066', 02:21:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:21:42 INFO - 'use_talos_json': True, 02:21:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:21:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:21:42 INFO - 'work_dir': 'build'} 02:21:42 INFO - [mozharness: 2016-08-24 09:21:42.769974Z] Running clobber step. 02:21:42 INFO - Running pre-action listener: _resource_record_pre_action 02:21:42 INFO - Running main action method: clobber 02:21:42 INFO - rmtree: /builds/slave/test/build 02:21:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:21:43 INFO - Running post-action listener: _resource_record_post_action 02:21:43 INFO - [mozharness: 2016-08-24 09:21:43.222203Z] Finished clobber step (success) 02:21:43 INFO - [mozharness: 2016-08-24 09:21:43.222304Z] Running read-buildbot-config step. 02:21:43 INFO - Running pre-action listener: _resource_record_pre_action 02:21:43 INFO - Running main action method: read_buildbot_config 02:21:43 INFO - Using buildbot properties: 02:21:43 INFO - { 02:21:43 INFO - "project": "", 02:21:43 INFO - "product": "firefox", 02:21:43 INFO - "script_repo_revision": "production", 02:21:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:21:43 INFO - "repository": "", 02:21:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:21:43 INFO - "buildid": "20160823233011", 02:21:43 INFO - "pgo_build": "True", 02:21:43 INFO - "basedir": "/builds/slave/test", 02:21:43 INFO - "buildnumber": 706, 02:21:43 INFO - "slavename": "talos-linux64-ix-066", 02:21:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:21:43 INFO - "platform": "ubuntu64_hw", 02:21:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:21:43 INFO - "branch": "fx-team", 02:21:43 INFO - "repo_path": "integration/fx-team", 02:21:43 INFO - "revision": "eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc", 02:21:43 INFO - "stage_platform": "linux64-pgo", 02:21:43 INFO - "builduid": "1a4d250dcce44e6ba825556523370c77", 02:21:43 INFO - "slavebuilddir": "test" 02:21:43 INFO - } 02:21:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:21:43 INFO - Running post-action listener: _resource_record_post_action 02:21:43 INFO - [mozharness: 2016-08-24 09:21:43.224705Z] Finished read-buildbot-config step (success) 02:21:43 INFO - [mozharness: 2016-08-24 09:21:43.224794Z] Running download-and-extract step. 02:21:43 INFO - Running pre-action listener: _resource_record_pre_action 02:21:43 INFO - Running main action method: download_and_extract 02:21:43 INFO - mkdir: /builds/slave/test/build/tests 02:21:43 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')]} 02:21:43 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:21:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:43 INFO - Downloaded 1361 bytes. 02:21:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:21:43 INFO - Using the following test package requirements: 02:21:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:21:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:21:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:21:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'jsshell-linux-x86_64.zip'], 02:21:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:21:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:21:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:21:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:21:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:21:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:21:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:21:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:21:43 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')]} 02:21:43 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:21:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:44 INFO - Downloaded 21913467 bytes. 02:21:44 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 02:21:48 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 02:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:48 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:21:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:49 INFO - Downloaded 21913467 bytes. 02:21:49 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 02:21: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')]} 02:21:54 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:55 INFO - Downloaded 14413981 bytes. 02:21:55 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 02:21: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')]} 02:21:55 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:55 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/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 02:21:56 INFO - Downloaded 59587475 bytes. 02:21:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:56 INFO - mkdir: /builds/slave/test/properties 02:21:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:56 INFO - Contents: 02:21:56 INFO - build_url:https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:57 INFO - Running post-action listener: _resource_record_post_action 02:21:57 INFO - Running post-action listener: set_extra_try_arguments 02:21:57 INFO - [mozharness: 2016-08-24 09:21:57.126849Z] Finished download-and-extract step (success) 02:21:57 INFO - [mozharness: 2016-08-24 09:21:57.127071Z] Running populate-webroot step. 02:21:57 INFO - Running pre-action listener: _resource_record_pre_action 02:21:57 INFO - Running main action method: populate_webroot 02:21:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:57 INFO - '--tppagecycles', 02:21:57 INFO - '7'], 02:21:57 INFO - 'tests': ['tsvgm']}}, 02:21:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['damp', 'tps']}, 02:21:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'tests': ['damp', 'tps']}, 02:21:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['dromaeo_dom']}, 02:21:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['basic_compositor_video']}, 02:21:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['a11yr', 02:21:57 INFO - 'ts_paint', 02:21:57 INFO - 'tpaint', 02:21:57 INFO - 'sessionrestore', 02:21:57 INFO - 'sessionrestore_no_auto_restore', 02:21:57 INFO - 'tabpaint']}, 02:21:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['tsvgx', 02:21:57 INFO - 'tsvgr_opacity', 02:21:57 INFO - 'tart', 02:21:57 INFO - 'tscrollx', 02:21:57 INFO - 'cart']}, 02:21:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:57 INFO - 'tsvgr_opacity', 02:21:57 INFO - 'tart', 02:21:57 INFO - 'tscrollx', 02:21:57 INFO - 'cart']}, 02:21:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'talos_options': ['--disable-e10s'], 02:21:57 INFO - 'tests': ['tp5o']}, 02:21:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'tests': ['tp5o']}, 02:21:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'talos_options': ['--disable-e10s', 02:21:57 INFO - '--xperf_path', 02:21:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:57 INFO - 'tests': ['tp5n']}, 02:21:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:57 INFO - 'talos_options': ['--xperf_path', 02:21:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:57 INFO - 'tests': ['tp5n']}}, 02:21:57 INFO - 'talos.zip': {'path': '', 02:21:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:57 INFO - Running post-action listener: _resource_record_post_action 02:21:57 INFO - [mozharness: 2016-08-24 09:21:57.143967Z] Finished populate-webroot step (success) 02:21:57 INFO - [mozharness: 2016-08-24 09:21:57.144055Z] Running create-virtualenv step. 02:21:57 INFO - Running pre-action listener: _resource_record_pre_action 02:21:57 INFO - Running main action method: create_virtualenv 02:21:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:57 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 02:21:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:57 INFO - Using real prefix '/usr' 02:21:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:59 INFO - Installing pip.................done. 02:21:59 INFO - Return code: 0 02:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:21:59 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 02:21:59 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 02:21:59 INFO - Using env: {'DISPLAY': ':0', 02:21:59 INFO - 'HOME': '/home/cltbld', 02:21:59 INFO - 'LANG': 'en_US.UTF-8', 02:21:59 INFO - 'LANGUAGE': 'en_US:en', 02:21:59 INFO - 'LOGNAME': 'cltbld', 02:21:59 INFO - 'MAIL': '/var/mail/cltbld', 02:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:59 INFO - 'MOZ_NO_REMOTE': '1', 02:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:59 INFO - 'NO_EM_RESTART': '1', 02:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:59 INFO - 'PWD': '/builds/slave/test', 02:21:59 INFO - 'SHELL': '/bin/bash', 02:21:59 INFO - 'SHLVL': '1', 02:21:59 INFO - 'TERM': 'linux', 02:21:59 INFO - 'TMOUT': '86400', 02:21:59 INFO - 'USER': 'cltbld', 02:21:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:59 INFO - '_': '/tools/buildbot/bin/python'} 02:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:59 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 02:21:59 INFO - Cleaning up... 02:21:59 INFO - Return code: 0 02:21:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:21:59 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 02:21:59 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 02:21:59 INFO - Using env: {'DISPLAY': ':0', 02:21:59 INFO - 'HOME': '/home/cltbld', 02:21:59 INFO - 'LANG': 'en_US.UTF-8', 02:21:59 INFO - 'LANGUAGE': 'en_US:en', 02:21:59 INFO - 'LOGNAME': 'cltbld', 02:21:59 INFO - 'MAIL': '/var/mail/cltbld', 02:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:59 INFO - 'MOZ_NO_REMOTE': '1', 02:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:59 INFO - 'NO_EM_RESTART': '1', 02:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:59 INFO - 'PWD': '/builds/slave/test', 02:21:59 INFO - 'SHELL': '/bin/bash', 02:21:59 INFO - 'SHLVL': '1', 02:21:59 INFO - 'TERM': 'linux', 02:21:59 INFO - 'TMOUT': '86400', 02:21:59 INFO - 'USER': 'cltbld', 02:21:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:59 INFO - '_': '/tools/buildbot/bin/python'} 02:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:00 INFO - Downloading/unpacking psutil>=3.1.1 02:22:00 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 02:22:00 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 02:22:00 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 02:22:00 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 02:22:00 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 02:22:00 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 02:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:02 INFO - Installing collected packages: psutil 02:22:02 INFO - Running setup.py install for psutil 02:22:02 INFO - building 'psutil._psutil_linux' extension 02:22:02 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 02:22:02 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 02:22:02 INFO - building 'psutil._psutil_posix' extension 02:22:02 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 02:22:02 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 02:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:02 INFO - Successfully installed psutil 02:22:02 INFO - Cleaning up... 02:22:02 INFO - Return code: 0 02:22:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:02 INFO - Using env: {'DISPLAY': ':0', 02:22:02 INFO - 'HOME': '/home/cltbld', 02:22:02 INFO - 'LANG': 'en_US.UTF-8', 02:22:02 INFO - 'LANGUAGE': 'en_US:en', 02:22:02 INFO - 'LOGNAME': 'cltbld', 02:22:02 INFO - 'MAIL': '/var/mail/cltbld', 02:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:02 INFO - 'MOZ_NO_REMOTE': '1', 02:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:02 INFO - 'NO_EM_RESTART': '1', 02:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:02 INFO - 'PWD': '/builds/slave/test', 02:22:02 INFO - 'SHELL': '/bin/bash', 02:22:02 INFO - 'SHLVL': '1', 02:22:02 INFO - 'TERM': 'linux', 02:22:02 INFO - 'TMOUT': '86400', 02:22:02 INFO - 'USER': 'cltbld', 02:22:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:02 INFO - '_': '/tools/buildbot/bin/python'} 02:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:04 INFO - Installing collected packages: mozsystemmonitor 02:22:04 INFO - Running setup.py install for mozsystemmonitor 02:22:04 INFO - Successfully installed mozsystemmonitor 02:22:04 INFO - Cleaning up... 02:22:05 INFO - Return code: 0 02:22:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22: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==2.5.1'] in /builds/slave/test/build 02:22: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==2.5.1 02:22:05 INFO - Using env: {'DISPLAY': ':0', 02:22:05 INFO - 'HOME': '/home/cltbld', 02:22:05 INFO - 'LANG': 'en_US.UTF-8', 02:22:05 INFO - 'LANGUAGE': 'en_US:en', 02:22:05 INFO - 'LOGNAME': 'cltbld', 02:22:05 INFO - 'MAIL': '/var/mail/cltbld', 02:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:05 INFO - 'MOZ_NO_REMOTE': '1', 02:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:05 INFO - 'NO_EM_RESTART': '1', 02:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:05 INFO - 'PWD': '/builds/slave/test', 02:22:05 INFO - 'SHELL': '/bin/bash', 02:22:05 INFO - 'SHLVL': '1', 02:22:05 INFO - 'TERM': 'linux', 02:22:05 INFO - 'TMOUT': '86400', 02:22:05 INFO - 'USER': 'cltbld', 02:22:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:05 INFO - '_': '/tools/buildbot/bin/python'} 02:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:05 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:07 INFO - warning: no files found matching '*.txt' 02:22:07 INFO - no previously-included directories found matching 'build' 02:22:07 INFO - no previously-included directories found matching 'dist' 02:22:07 INFO - no previously-included directories found matching '.git*' 02:22:07 INFO - Installing collected packages: jsonschema, functools32 02:22:07 INFO - Running setup.py install for functools32 02:22:07 INFO - warning: no files found matching '*.txt' 02:22:07 INFO - no previously-included directories found matching 'build' 02:22:07 INFO - no previously-included directories found matching 'dist' 02:22:07 INFO - no previously-included directories found matching '.git*' 02:22:07 INFO - Successfully installed jsonschema functools32 02:22:07 INFO - Cleaning up... 02:22:07 INFO - Return code: 0 02:22:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:22:07 INFO - Using env: {'DISPLAY': ':0', 02:22:07 INFO - 'HOME': '/home/cltbld', 02:22:07 INFO - 'LANG': 'en_US.UTF-8', 02:22:07 INFO - 'LANGUAGE': 'en_US:en', 02:22:07 INFO - 'LOGNAME': 'cltbld', 02:22:07 INFO - 'MAIL': '/var/mail/cltbld', 02:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:07 INFO - 'MOZ_NO_REMOTE': '1', 02:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:07 INFO - 'NO_EM_RESTART': '1', 02:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:07 INFO - 'PWD': '/builds/slave/test', 02:22:07 INFO - 'SHELL': '/bin/bash', 02:22:07 INFO - 'SHLVL': '1', 02:22:07 INFO - 'TERM': 'linux', 02:22:07 INFO - 'TMOUT': '86400', 02:22:07 INFO - 'USER': 'cltbld', 02:22:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:07 INFO - '_': '/tools/buildbot/bin/python'} 02:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:22:07 INFO - Cleaning up... 02:22:07 INFO - Return code: 0 02:22:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:22:07 INFO - Using env: {'DISPLAY': ':0', 02:22:07 INFO - 'HOME': '/home/cltbld', 02:22:07 INFO - 'LANG': 'en_US.UTF-8', 02:22:07 INFO - 'LANGUAGE': 'en_US:en', 02:22:07 INFO - 'LOGNAME': 'cltbld', 02:22:07 INFO - 'MAIL': '/var/mail/cltbld', 02:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:07 INFO - 'MOZ_NO_REMOTE': '1', 02:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:07 INFO - 'NO_EM_RESTART': '1', 02:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:07 INFO - 'PWD': '/builds/slave/test', 02:22:07 INFO - 'SHELL': '/bin/bash', 02:22:07 INFO - 'SHLVL': '1', 02:22:07 INFO - 'TERM': 'linux', 02:22:07 INFO - 'TMOUT': '86400', 02:22:07 INFO - 'USER': 'cltbld', 02:22:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:07 INFO - '_': '/tools/buildbot/bin/python'} 02:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:08 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 02:22:08 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 02:22:08 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 02:22:08 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 02:22:08 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 02:22:08 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 02:22:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:10 INFO - Downloading docopt-0.6.1.tar.gz 02:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:10 INFO - Running setup.py install for blobuploader 02:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:10 INFO - Running setup.py install for requests 02:22:11 INFO - Running setup.py install for docopt 02:22:11 INFO - Successfully installed blobuploader requests docopt 02:22:11 INFO - Cleaning up... 02:22:11 INFO - Return code: 0 02:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:11 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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:11 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 02:22:11 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 02:22:11 INFO - Using env: {'DISPLAY': ':0', 02:22:11 INFO - 'HOME': '/home/cltbld', 02:22:11 INFO - 'LANG': 'en_US.UTF-8', 02:22:11 INFO - 'LANGUAGE': 'en_US:en', 02:22:11 INFO - 'LOGNAME': 'cltbld', 02:22:11 INFO - 'MAIL': '/var/mail/cltbld', 02:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:11 INFO - 'MOZ_NO_REMOTE': '1', 02:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:11 INFO - 'NO_EM_RESTART': '1', 02:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:11 INFO - 'PWD': '/builds/slave/test', 02:22:11 INFO - 'SHELL': '/bin/bash', 02:22:11 INFO - 'SHLVL': '1', 02:22:11 INFO - 'TERM': 'linux', 02:22:11 INFO - 'TMOUT': '86400', 02:22:11 INFO - 'USER': 'cltbld', 02:22:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:11 INFO - '_': '/tools/buildbot/bin/python'} 02:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:11 INFO - Running setup.py (path:/tmp/pip-CVBnhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:11 INFO - Running setup.py (path:/tmp/pip-udCxvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:11 INFO - Running setup.py (path:/tmp/pip-sV2ADd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:11 INFO - Running setup.py (path:/tmp/pip-4UmUOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:11 INFO - Running setup.py (path:/tmp/pip-ZVvcw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:11 INFO - Running setup.py (path:/tmp/pip-PgM296-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:11 INFO - Running setup.py (path:/tmp/pip-d0jPd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:12 INFO - Running setup.py (path:/tmp/pip-2AA9P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:12 INFO - Running setup.py (path:/tmp/pip-p0NciB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:12 INFO - Running setup.py (path:/tmp/pip-b0g4mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:12 INFO - Running setup.py (path:/tmp/pip-NDZhGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:12 INFO - Running setup.py (path:/tmp/pip-4HIGeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:12 INFO - Running setup.py (path:/tmp/pip-24VItR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:12 INFO - Running setup.py (path:/tmp/pip-IHCsCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:12 INFO - Running setup.py (path:/tmp/pip-0EVUo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:12 INFO - Running setup.py (path:/tmp/pip-iLlSMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:12 INFO - Running setup.py (path:/tmp/pip-qsf0Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:12 INFO - Running setup.py install for manifestparser 02:22:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:12 INFO - Running setup.py install for mozcrash 02:22:12 INFO - Running setup.py install for mozdebug 02:22:13 INFO - Running setup.py install for mozdevice 02:22:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozfile 02:22:13 INFO - Running setup.py install for mozhttpd 02:22:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozinfo 02:22:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozInstall 02:22:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozleak 02:22:13 INFO - Running setup.py install for mozlog 02:22:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for moznetwork 02:22:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozprocess 02:22:14 INFO - Running setup.py install for mozprofile 02:22:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Running setup.py install for mozrunner 02:22:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Running setup.py install for mozscreenshot 02:22:14 INFO - Running setup.py install for moztest 02:22:14 INFO - Running setup.py install for mozversion 02:22:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:14 INFO - Cleaning up... 02:22:14 INFO - Return code: 0 02:22:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:14 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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:14 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 02:22:14 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 02:22:14 INFO - Using env: {'DISPLAY': ':0', 02:22:14 INFO - 'HOME': '/home/cltbld', 02:22:14 INFO - 'LANG': 'en_US.UTF-8', 02:22:14 INFO - 'LANGUAGE': 'en_US:en', 02:22:14 INFO - 'LOGNAME': 'cltbld', 02:22:14 INFO - 'MAIL': '/var/mail/cltbld', 02:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:14 INFO - 'MOZ_NO_REMOTE': '1', 02:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:14 INFO - 'NO_EM_RESTART': '1', 02:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:14 INFO - 'PWD': '/builds/slave/test', 02:22:14 INFO - 'SHELL': '/bin/bash', 02:22:14 INFO - 'SHLVL': '1', 02:22:14 INFO - 'TERM': 'linux', 02:22:14 INFO - 'TMOUT': '86400', 02:22:14 INFO - 'USER': 'cltbld', 02:22:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:14 INFO - '_': '/tools/buildbot/bin/python'} 02:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:14 INFO - Running setup.py (path:/tmp/pip-5Qfcz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:14 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)) 02:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:14 INFO - Running setup.py (path:/tmp/pip-g75iX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:14 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)) 02:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:14 INFO - Running setup.py (path:/tmp/pip-JSBor5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:15 INFO - Running setup.py (path:/tmp/pip-TmYFqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:15 INFO - Running setup.py (path:/tmp/pip-ANv7s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:15 INFO - Running setup.py (path:/tmp/pip-XhYYOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:15 INFO - Running setup.py (path:/tmp/pip-xNXasg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:15 INFO - Running setup.py (path:/tmp/pip-5oI3v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:15 INFO - Running setup.py (path:/tmp/pip-V3DIid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:15 INFO - Running setup.py (path:/tmp/pip-jafje8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:15 INFO - Running setup.py (path:/tmp/pip-yQnHoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:15 INFO - Running setup.py (path:/tmp/pip-oiEgCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:15 INFO - Running setup.py (path:/tmp/pip-HWaRaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:15 INFO - Running setup.py (path:/tmp/pip-pQmCtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:15 INFO - Running setup.py (path:/tmp/pip-XYMkV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:15 INFO - Running setup.py (path:/tmp/pip-XXahzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:15 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)) 02:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:15 INFO - Running setup.py (path:/tmp/pip-Np2lA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:16 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)) 02:22:16 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)) 02:22:16 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)) 02:22:16 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)) 02:22:16 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)) 02:22:16 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)) 02:22:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:17 INFO - Downloading blessings-1.6.tar.gz 02:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:18 INFO - Installing collected packages: blessings 02:22:18 INFO - Running setup.py install for blessings 02:22:18 INFO - Successfully installed blessings 02:22:18 INFO - Cleaning up... 02:22:18 INFO - Return code: 0 02:22:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:18 INFO - Reading from file tmpfile_stdout 02:22:18 INFO - Current package versions: 02:22:18 INFO - argparse == 1.2.1 02:22:18 INFO - blessings == 1.6 02:22:18 INFO - blobuploader == 1.2.4 02:22:18 INFO - docopt == 0.6.1 02:22:18 INFO - functools32 == 3.2.3-2 02:22:18 INFO - jsonschema == 2.5.1 02:22:18 INFO - manifestparser == 1.1 02:22:18 INFO - mozInstall == 1.12 02:22:18 INFO - mozcrash == 0.17 02:22:18 INFO - mozdebug == 0.1 02:22:18 INFO - mozdevice == 0.48 02:22:18 INFO - mozfile == 1.2 02:22:18 INFO - mozhttpd == 0.7 02:22:18 INFO - mozinfo == 0.9 02:22:18 INFO - mozleak == 0.1 02:22:18 INFO - mozlog == 3.3 02:22:18 INFO - moznetwork == 0.27 02:22:18 INFO - mozprocess == 0.23 02:22:18 INFO - mozprofile == 0.28 02:22:18 INFO - mozrunner == 6.12 02:22:18 INFO - mozscreenshot == 0.1 02:22:18 INFO - mozsystemmonitor == 0.3 02:22:18 INFO - moztest == 0.7 02:22:18 INFO - mozversion == 1.4 02:22:18 INFO - psutil == 3.1.1 02:22:18 INFO - requests == 1.2.3 02:22:18 INFO - wsgiref == 0.1.2 02:22:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:18 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 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:18 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 02:22:18 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 02:22:18 INFO - Using env: {'DISPLAY': ':0', 02:22:18 INFO - 'HOME': '/home/cltbld', 02:22:18 INFO - 'LANG': 'en_US.UTF-8', 02:22:18 INFO - 'LANGUAGE': 'en_US:en', 02:22:18 INFO - 'LOGNAME': 'cltbld', 02:22:18 INFO - 'MAIL': '/var/mail/cltbld', 02:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:18 INFO - 'MOZ_NO_REMOTE': '1', 02:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:18 INFO - 'NO_EM_RESTART': '1', 02:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:18 INFO - 'PWD': '/builds/slave/test', 02:22:18 INFO - 'SHELL': '/bin/bash', 02:22:18 INFO - 'SHLVL': '1', 02:22:18 INFO - 'TERM': 'linux', 02:22:18 INFO - 'TMOUT': '86400', 02:22:18 INFO - 'USER': 'cltbld', 02:22:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:18 INFO - '_': '/tools/buildbot/bin/python'} 02:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 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)) 02:22:18 INFO - Cleaning up... 02:22:18 INFO - Return code: 0 02:22:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e318af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16538d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', '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 02:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:18 INFO - Using env: {'DISPLAY': ':0', 02:22:18 INFO - 'HOME': '/home/cltbld', 02:22:18 INFO - 'LANG': 'en_US.UTF-8', 02:22:18 INFO - 'LANGUAGE': 'en_US:en', 02:22:18 INFO - 'LOGNAME': 'cltbld', 02:22:18 INFO - 'MAIL': '/var/mail/cltbld', 02:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:18 INFO - 'MOZ_NO_REMOTE': '1', 02:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:18 INFO - 'NO_EM_RESTART': '1', 02:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:18 INFO - 'PWD': '/builds/slave/test', 02:22:18 INFO - 'SHELL': '/bin/bash', 02:22:18 INFO - 'SHLVL': '1', 02:22:18 INFO - 'TERM': 'linux', 02:22:18 INFO - 'TMOUT': '86400', 02:22:18 INFO - 'USER': 'cltbld', 02:22:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:18 INFO - '_': '/tools/buildbot/bin/python'} 02:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:18 INFO - Cleaning up... 02:22:18 INFO - Return code: 0 02:22:18 INFO - Running post-action listener: _resource_record_post_action 02:22:18 INFO - Running post-action listener: _start_resource_monitoring 02:22:18 INFO - Starting resource monitoring. 02:22:18 INFO - [mozharness: 2016-08-24 09:22:18.845609Z] Finished create-virtualenv step (success) 02:22:18 INFO - [mozharness: 2016-08-24 09:22:18.846069Z] Running install step. 02:22:18 INFO - Running pre-action listener: _resource_record_pre_action 02:22:18 INFO - Running main action method: install 02:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:19 INFO - Reading from file tmpfile_stdout 02:22:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:19 INFO - Reading from file tmpfile_stdout 02:22:19 INFO - Output received: 02:22:19 INFO - Usage: mozinstall [options] installer 02:22:19 INFO - Options: 02:22:19 INFO - -h, --help show this help message and exit 02:22:19 INFO - -d DEST, --destination=DEST 02:22:19 INFO - Directory to install application into. [default: 02:22:19 INFO - "/builds/slave/test"] 02:22:19 INFO - --app=APP Application being installed. [default: firefox] 02:22:19 INFO - mkdir: /builds/slave/test/build/application 02:22:19 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'] 02:22:19 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 02:22:36 INFO - Reading from file tmpfile_stdout 02:22:36 INFO - Output received: 02:22:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:22:36 INFO - Running post-action listener: _resource_record_post_action 02:22:36 INFO - [mozharness: 2016-08-24 09:22:36.093731Z] Finished install step (success) 02:22:36 INFO - [mozharness: 2016-08-24 09:22:36.093976Z] Running run-tests step. 02:22:36 INFO - Running pre-action listener: _resource_record_pre_action 02:22:36 INFO - Running main action method: run_tests 02:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:36 INFO - Python 2.7.3 02:22:36 INFO - Return code: 0 02:22:36 INFO - grabbing minidump binary from tooltool 02:22: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')]} 02:22:36 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 0x16e2760>, '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 0x16e3660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:36 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 02:22:36 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 02:22:36 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 02:22:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:36 INFO - Return code: 0 02:22:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:22:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:22:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:22:36 INFO - Using env: {'DISPLAY': ':0', 02:22:36 INFO - 'HOME': '/home/cltbld', 02:22:36 INFO - 'LANG': 'en_US.UTF-8', 02:22:36 INFO - 'LANGUAGE': 'en_US:en', 02:22:36 INFO - 'LOGNAME': 'cltbld', 02:22:36 INFO - 'MAIL': '/var/mail/cltbld', 02:22:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:36 INFO - 'MOZ_NO_REMOTE': '1', 02:22:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:36 INFO - 'NO_EM_RESTART': '1', 02:22:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:36 INFO - 'PWD': '/builds/slave/test', 02:22:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:36 INFO - 'SHELL': '/bin/bash', 02:22:36 INFO - 'SHLVL': '1', 02:22:36 INFO - 'TERM': 'linux', 02:22:36 INFO - 'TMOUT': '86400', 02:22:36 INFO - 'USER': 'cltbld', 02:22:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556', 02:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:36 INFO - '_': '/tools/buildbot/bin/python'} 02:22:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:22:36 INFO - mozversion application_buildid: 20160823233011 02:22:36 INFO - mozversion application_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 02:22:36 INFO - mozversion application_display_name: Nightly 02:22:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:36 INFO - mozversion application_name: Firefox 02:22:36 INFO - mozversion application_remotingname: firefox 02:22:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:22:36 INFO - mozversion application_vendor: Mozilla 02:22:36 INFO - mozversion application_version: 51.0a1 02:22:36 INFO - mozversion platform_buildid: 20160823233011 02:22:36 INFO - mozversion platform_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 02:22:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:22:36 INFO - mozversion platform_version: 51.0a1 02:22:36 INFO - using testdate: 1472030556 02:22:36 INFO - actual date: 1472030556 02:22:36 INFO - starting webserver on 'localhost:37409' 02:22:36 INFO - SUITE-START | Running 2 tests 02:22:36 INFO - TEST-START | dromaeo_css 02:22:36 INFO - operating with platform_type : linux_ 02:22:36 INFO - Initialising browser for dromaeo_css test... 02:22:36 INFO - TEST-INFO | started process 19266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwHeH_A/profile http://localhost:37409/getInfo.html) 02:22:41 INFO - PROCESS | 19266 | __metrics Screen width/height:1600/1200 02:22:41 INFO - PROCESS | 19266 | colorDepth:24 02:22:41 INFO - PROCESS | 19266 | Browser inner width/height: 1024/697 02:22:41 INFO - PROCESS | 19266 | __metrics 02:22:42 ERROR - PROCESS | 19266 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 02:22:43 INFO - TEST-INFO | 19266: exit 0 02:22:43 INFO - Browser initialized. 02:22:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:22:43 INFO - TEST-INFO | started process 19387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwHeH_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:55 INFO - PROCESS | 19387 | RSS: Main: 191537152 02:22:55 INFO - PROCESS | 19387 | 02:23:44 INFO - PROCESS | 19387 | 1472030624900 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] 02:25:55 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37409/tests/dromaeo/cssquery-ext.html) 02:25:56 INFO - PROCESS | 19387 | RSS: Main: 211156992 02:25:56 INFO - PROCESS | 19387 | 02:28:58 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-ext.html (next: http://localhost:37409/tests/dromaeo/cssquery-jquery.html) 02:28:59 INFO - PROCESS | 19387 | RSS: Main: 205967360 02:28:59 INFO - PROCESS | 19387 | 02:32:01 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37409/tests/dromaeo/cssquery-mootools.html) 02:32:01 INFO - PROCESS | 19387 | RSS: Main: 201928704 02:32:01 INFO - PROCESS | 19387 | 02:35:03 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37409/tests/dromaeo/cssquery-prototype.html) 02:35:04 INFO - PROCESS | 19387 | RSS: Main: 194506752 02:35:04 INFO - PROCESS | 19387 | 02:38:06 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37409/tests/dromaeo/cssquery-yui.html) 02:38:07 INFO - PROCESS | 19387 | RSS: Main: 197971968 02:38:07 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-yui.html (next: http://localhost:37409/tests/dromaeo/cssquery-dojo.html) 02:41:10 INFO - PROCESS | 19387 | RSS: Main: 198553600 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | __start_tp_report 02:41:10 INFO - PROCESS | 19387 | _x_x_mozilla_page_load 02:41:10 INFO - PROCESS | 19387 | _x_x_mozilla_page_load_details 02:41:10 INFO - PROCESS | 19387 | |i|pagename|runs| 02:41:10 INFO - PROCESS | 19387 | |0;dojo.html;3111.128883912504;3133.7649676274273;3149.590553228081;3172.4131035758373;3183.411068952244;5356.223347614594;5468.972655136724;5503.532199763025;5533.695646739433;5586.13414920687;5468;5493.093639549479;5519.724013799304;5527.613067085305;5543.390227075019;4890.731009794469;4995.35060442142;5027.547520723134;5045.672031317971;5069.214271787879;4613.607843333304;5095.031943930641;5161.045206636784;5163.612729045318;5189.325387699594;4908.8281910133155;4956.231784073474;4983.401991761012;5058.898822023576;5078.923816142761;4982.950170498285;5003.974980125113;5011.448740638527;5012.573931215851;5079.517445842639;4898.53463920927;4974.054929563371;4975.179095449246;4992.276119962621;5076.771545280471;5367.597430192712;5403.945960540384;5430.0768869292315;5487.64330318532;5527.861803454905;5749.798757043525;5809.448102430262;5820.476157145878;5895;5919.1417244499735;5896.1450589664255;5938.940610593882;5948.167256584082;5949;5949.2266005419015;5568.220449137124;5636.098224284095;5638.2670252866865;5643.068893632587;5648.632838865502;6103.6032657877095;6172.197614310201;6179.3820617937845;6181.96909015461;6194.473469755031;5668.319801623831;5750.389890830575;5938;5939.940600594025;5954.970225148933;5738.684372359477;5855.209546711139;5906.645601263938;5934.732937017845;5971.462568368781;5873.765049397976;5939.109133629903;5943;5956.493698035715;6036.486898613579;5949.553783466257;5954.136650185699;5957.255343082114;5965.463108320272;5970.49250813677;4349.456317960255;4529.071540334289;4546.04533048057;4559.156556037144;4563.133004729091;4049.493813273341;4062.73592216505;4071.1654110907784;4079.0618157823865;4108.260513107669;5643.887122257532;5686.857828554236;5694.772209111672;5700.8859822803315;5712.457316554921;5690.174924635905;5752.597318187771;5797.652140871562;6039.5470339723815;6045.516358691382;5513.889722205534;5525.613207075547;5573.303337082864;5591.217229587861;5676.176954341598;5095.566876815512;5102.846914592568;5107.668001579886;5110.182370820651;5115.7442127893455;6073.726682299307;6083.361247068994;6098.512119030467;6107.969460152671;6113.23584551931;5712.857178570569;5840.153177789111;5862.355140934579;5885.588008839341;5913.58604897653;6136.796294538256;6136.85608443425;6140.293866205444;6147.907781383194;6158.876822463615;5743.282089738783;5789.247397838254;5789.710514474344;5796.594238403271;5902.734376952962;5709;5864.824055278348;5865.208196893364;5892.204552385373;5929.822105336847;5814.476697097281;5815.4184581543195;5822.388649191943;5837.970810145922;5867.853303667443;5555.3333599966645;5760.452756988079;5817.7963771267805;5821.38875418075;5827.825165245049;5737.827865164052;5781.219535362672;5791.276090488689;5858.414158584107;5861.120831875252;5834.124881267844;5930.229070220844;5932.2584676915385;5946.613470124428;5947.583669143119;5495.2856128703015;5635.520980716685;5777.9133313001175;5790.826275211751;5794.7102644866745 02:41:10 INFO - PROCESS | 19387 | |1;ext.html;562.9887402251956;587.4536680886777;601.9939800601995;602.5812060617869;623.2987888625297;39339.409908851354;44226.778866105706;44230.55769442305;44241.33637995433;44491.77754111225;43681;44188;44190;44215.33676994839;44274;8769.079246679086;8804.075572064938;8959.552022398886;8960.820783584324;8989.460632362046;8822.735317940473;8862.06948270432;8867.645294188225;8873.3344999125;8898.911010889873;8848.380613357067;9009.189172974431;9047.728568142966;9048.457092574434;9053.366264361497;8827.69103081389;8931.41945773526;8982.416142950688;8982.595783189772;9015.413998090104;8756.255718263956;8787.516686582236;8838.469691818447;8914.50970196639;8932.19610235082;42162.57837421617;42239.788801055794;42459.57540424587;42599.148017039486;42780.572194278284;3392.2028323343993;3411.9488207676904;3644.9271014579826;3852.4413959975645;3968;32092.679073209438;32705.6729432705;32776.67223327784;32823.83588082068;32926.34147317064;4149.813258403379;4276.850310239158;4299.204647140289;4314.331278651814;4324.740515569076;346352;348553;349553.99999999744;349577;351026;58752.70623646854;59238.29902112698;59371.70314148402;59405.40594593999;59557;36562.806231626186;61258.69370653118;61286.38713612807;61353.69323153356;61378.38621613816;15538.689226215638;16255.59361015984;16343.019418834909;16387.508374748777;16393.6721265574;13015.869841301655;13036.608901732963;13046.086773925734;13117.409716562777;13118.475260989644;18976.146073426728;19080.522986925436;19108.904455477634;19133.904330478257;19185.712214316798;6951.756688515979;7319.780406587811;7342.15565209997;7376.852462950711;7532.887006694904;995.4823491784232;1128.0539091026073;1129.0121143999002;1146;1160.4313886195703;33332.50001249983;33817.15457113543;33937;33974.980750577524;34011.48982765261;1012.5696578953915;1113.6603335982604;1124.2018167101287;1155.485808815086;1198.2151690642643;16557.254923528228;16904.154792260582;16906.74639880403;16967.406140785013;17118.743218851727;564360;567292;571872;572292;579668;57984.4201557979;57994.13008804871;58375;58451.41548584545;58554.12168817386;1326.4826717580152;1379.9724005519834;1382.4884792626792;1382.5506710319187;1391.4016972701634;29755.256118597208;30844.383112338077;31508.842455787573;31768.881289206132;31846.363072738877;49177;49188;49431.25853112278;49472.25791613057;49523.50476495189;472514;474068;474407;478187;478810;28549.857250713612;28639.713602863703;28796.856015719786;28910.42179156363;29099;44601.776991114835;47193.29210061783;48116.759416202694;49143;49486.75256623694;37711.559012848214;40012.399814003395;40988.79505602453;41495;42964.35553466638;41184.79407602943;41234.38148427836;41509.58490415178;41733;41845.79077104595;39353.2129357417;40297.395539066354;43086.35370469508;43139.352909705754;43159;31098.378032439676;35257.118572035906;36911.44632830563;37177.62822371742;37264.25471490609;28131.296717582223;28204;28222.576661349685;28381.716182837907;28487 02:41:10 INFO - PROCESS | 19387 | |2;jquery.html;385.4815273457199;391.8726413915478;398.53172522286314;405.9147579008407;413.20664324496965;18828.811711882896;19502.317418890343;19703.31038413656;20549.794502054974;20565.794342056575;18866.622667546642;19013.42959711211;19094.33169839056;19178;19183.418654014233;5600.851825375788;5632.549396048326;5721.599488035839;5792.565557583177;5806.767729290823;5731.541476681877;5783.479486846183;5810.622309549887;5818.854528636775;5821.301443826746;5579.832605021856;5750.079987202049;5768.221290125821;5773.422657734235;5783.103618939072;5543.750531226105;5744.913826292567;5762.1068734346245;5798.304203495586;5820.097884827858;5124.692518448905;5151.150060240056;5179.249008893727;5179.2749015137915;5180;24166.275011749676;24443;24597.87701061501;24709;24811.25566233016;2304.5506126305377;2419.588669926099;2551.5662337402687;2964.5108557088056;3146.748260139206;14662.120272783666;14829.440934175827;14953.261768770926;15161.393544258217;15486.303116359792;1918.2231196365494;1945.7178709087245;1992.213075835037;1998.2606435618768;2044.580860923507;74494.25505744928;77123.61438192773;78128;82678.17321826765;88751.55624221903;11204;11286.379249141211;11294.322340659586;11434.885651143548;11547.191696581327;15751.527454176394;15761.369545218293;15813.288402021937;15876.364945402054;15879.761803572956;7730.92269077302;7870.960645196852;8010.3992200584025;8086.555239461768;8219.876701849476;7586.317231449196;7644.159142494321;7734.419918506134;7821.061472623322;7855.567943763148;4692.4603670577635;4716.316134160596;4776.8566942991765;4880.829170978998;4905.068037072945;1989.7811240763504;1993.0732209522641;1993.5913137806715;2026.9594608107755;2072.875627462357;998.7453199434098;1020.8158536098091;1043.3114144664485;1044.4986406524758;1060.8833028366873;20444.897775511028;20913.58172836535;21022.579548408947;21084.894575527025;21233.469163271042;961.0869673809908;963.1379914976197;1012.6050840172338;1021.4331046269392;1072.286929192094;10941.23411361197;11550.306981581132;11602.593909213138;11748.530058797724;11770;431441;440837;442623;452264;499258;90347;91378;97516.51241743747;98186.5090674542;101516.49241753743;1011.0950699124243;1036.6993571864225;1054.1040115901576;1058.2592185470048;1061.7027232374946;18287.725684115016;18312.542186445444;19199.424017279503;19453.51366215856;19561.510962226057;43764.56235437605;44208.68434867462;44257.557424425344;44573.55426445694;44874;63213.683931580046;63459.36540634719;64635;65055;65281;8376.706815261437;8578.871316930126;8760.123987601444;8986.59560319774;9067.455952642862;12772.872271277169;12938.223706577635;13667.38496767628;13861.019880725693;14088;11527.654170374903;11643;11712.355820429959;11767;11990.520379185084;11370.488328025423;11418.029467495357;11539.480723367637;11816.291022538331;11979.880201197877;11051.557937682403;11198.272112312674;11541.826872597087;12045.036397088037;12127.818082728943;8526.445781024213;8607.655693772429;8678.175573320525;8729.476231426135;8874.378793484395;10255.743606409602;11521.94239028833;11562.537498500302;11807.76384472323;12101.636950891487 02:41:10 INFO - PROCESS | 19387 | |3;mootools.html;1494.7907292978982;1495.6859059597487;1623.4480276705924;1745.7643218165545;1749.5801007758141;7931;8444.831103377928;8925.821483570324;9057.547122643866;9218.35471516994;9210.078992100804;9293.72118836436;9372.203362714177;9397.154256116948;9445;2361.4686695493506;2384.8807559622037;2387.271882075966;2391.497785465054;2393.1265088242753;2342.929712108631;2344.4842134730334;2416.299273210767;2425.6967879015124;2426.9029238830426;2376.0733314007553;2383.856968581882;2383.9046438142454;2392.521495700858;2404.6633471313944;2325.05835136769;2340.32130682102;2350.4946436516148;2352.6588644646517;2386.749391313904;2293.86236825791;2308.365199570115;2311.3874823171873;2314.9652755208685;2317.455397981473;9510.09654082861;9538.380005299634;9568.95215523918;9570.952145239298;9573.234141268682;5368.543673787733;5446.455354464561;5515.538382328686;5529.529989950859;5532.889342213133;3287.3918325109694;3347.397468455677;3363.630000699921;3365.4278772608714;3375.476801095834;1092.0990183098975;1118.7091356247354;1125.6106140324766;1131.6718151735986;1170.7834050700649;13163.73672526544;13197.076204665676;13214.33928303581;13227.140235884734;13276.46894124234;4678.76606169697;4754.194806268215;4799.712017278975;4887.462379138292;4911.852644420673;11009.2843965142;11084.833727494093;11095.334279943228;11107;11110.333379997226;5523.088690366045;5567.749451274703;5573.804916827973;5609.354924183689;5626.43735626434;4389.934150987738;4896.045271172158;4984.202527595639;5043.9747801260755;5094.2103973884105;4075.126616523759;4125.422440858282;4132.276851550967;4170.457840480718;4208.810603522848;1275.3177050278057;1301.4338762638283;1319.0371029148776;1321.8678132186703;1322.3983087695076;835.9289460395813;875.03745879532;975.8828940527183;982.5725809272989;989.4360214677708;5952.136940143741;6050.939490605126;6109.480694140959;6142.754289828446;6150.446459818638;459.8643400196883;468.28820193305984;471.1119539667751;472.5274725274725;476.9792643742394;4088;4089.9182016359505;4108.876733697994;4116.115035267432;4120.990357362465;11112.16658750597;11420.143489238175;11534.59628912984;11610.825837612274;11630.53477860876;11375.31748095117;11420.42897855104;11485.712857178638;11512.712182195512;11600.88399116015;8191.631376587949;8213.219744124299;8267.958660206781;8321.958390208132;8503.744887653504;6009.969950150221;6225.782097626561;6298.842528936813;6344.68276586178;6398.200224971879;10358.274920755475;10724.302920310467;10776.407297598707;10819.08037816763;10863.565457381932;11179.441027948407;11190.776184476428;11223.326600404002;11237.269577477438;11254.21220514556;7200.819979500555;7869.567173805495;7980.08229053643;8014.438989270695;8026.558539280162;9186.770330741518;9262.259019278306;9287.303452240974;9296.488693121943;9297.349185556946;7807.609619519115;7943.642536086006;8044.2760151586635;8209.343252539902;8225.424220304521;7665.003549538747;7726.652300646372;7750.728724494616;7785.727499537716;7810.179931107379;6681.665916704048;6776.220734615582;6776.96611516959;6779.288174741581;6788.253292137762;4743.217369134054;4873.244647079709;4922.778474968707;5057.190849464068;5284.180951952453;5194.22086687;5227.947720522746;5271.472852714698;5347.919781203363;5370.812021579226 02:41:10 INFO - PROCESS | 19387 | |4;prototype.html;326.5167552023006;329.0982707381774;335.11863798210703;336.46334097115107;338.1950956722999;5469.234307196991;5488.506034456903;5493.285872836525;5505.917411238835;5556.444355564447;5414.539764120044;5426.538744206747;5428.5928555358405;5435.972820135904;5436;4048.8785336439955;4144.5026596808275;4221.535631080578;4267;4268;4224.366345048236;4256.531781504032;4273.679474039444;4273.9358909616385;4294.119705460389;4263.381809637601;4266.807993640294;4292.798016555354;4302.161078589676;4303.505096913864;3991.7006224533275;4160.875173744793;4166.33338665812;4214.325707886724;4295.613394794468;3685.5761587417524;3686.926261474782;3689.1330537323706;3693.4829123922673;3715.5912849586525;5331.706756128411;5342.839714808562;5363;5364.7317634118135;5380.408155102936;4530.116627257686;4759.8814278644495;4843.806247750086;4891.413030436335;4899.461059283476;5668.829935101912;5686.877014164739;5689.544836413118;5696.544276457915;5697.77208911643;4043.413705012786;4055.229506393776;4062.248484030434;4069.857554985591;4074.5517993020744;5774.409344571076;5869.941300586982;5900.704964751745;5932.169496270526;6002.249718785152;4164.583541645811;4180.143070670505;4183.769892655872;4184.456020717287;4198.9370159447635;4220.303649897733;4227.809748561261;4239.47006624172;4245.787710614457;4249.405083288342;4754.573627911613;4808.927866082012;4868.2210846264425;4874.122657921608;4874.4150701916;5774.1129435282355;5777.45114214149;5788.18965344852;5788.21859049023;5791.536677065909;1400.4818217259678;1411.1885665742034;1411.5906387147613;1416.419268100074;1417.688108616103;919.1727445299284;927.7726956895604;960.3085778239656;987.7185002274317;1013.6097602422973;5510.669359838343;5519.31008623922;5521;5533.22534845122;5547.223388725582;5823.5341172706085;5836.591438599342;5848.941510584839;5851.853703657443;5859.5019423349495;5364.570834333244;5485.930243602459;5499.50504454601;5499.890002200013;5562.276904002535;3068.723814856629;3104.1463597510415;3111.113332700215;3115.2679120406688;3121.6566177720433;5703.372629010805;6041.154238406627;6050.42520960508;6060.515158787286;6073.817785466443;6082.361352058058;6119.816405507842;6123.663198524124;6130.233720784902;6149.200603921551;6079.240094988127;6127.2647282325515;6141.416565426277;6187.566870319124;6197.566170368031;5687.829365119053;5875.794347197828;5938.465538101419;5950.821475355746;5993.760249589967;5878.735456904535;5899.528037756883;5905.320888097752;5939.524838012862;5941.1385349125;5840.707964601838;6158.753649854135;6205.565610407409;6209.895052473763;6223.190985171898;4190.434291370626;4242.727181845372;4244.639205667429;4258.318669012943;4280.935785963151;5940.940590594038;5984.940150598438;5996.940030599812;6010.7295171716505;6015.518758499397;5618.157276408571;5739.9139012915675;5747.971260143672;5764.682942438206;5819.388964158702;5733.71331433435;5765.56758243125;5784.82645520635;5789.478946894799;5789.681567513827;5128.66645676209;5706.514946229451;5721.942780572307;5742.540596752333;5758.366579676316;5753.712314384347;5787.276590426197;5793.449622285876;5799.449052340021;5804.883902322014;5647.813959068641;5660;5664.886702265849;5691.402402747652;5695.202671625892 02:41:10 INFO - PROCESS | 19387 | |5;yui.html;657.5561495990207;665.5441022899314;677.3328271652422;712.3375261007264;743.773149189497;13170.736585268289;14238.786418203736;14353.856461435382;14382.065165764245;14432.639184020392;12775.552855650054;12779.680507987305;13037.73924521509;13042;13055.41250643721;797.3461761355676;816.4733746733353;823.7240524424325;824.3981893217955;825.1583384947351;795.8328750962276;814.3932770086294;815.3314282288526;815.5269943432825;815.6778072661295;868.8696695495695;878.4685265414396;880.4189235104832;880.454118446564;880.5993273060774;860.3977215948829;861.8534849075672;863.1239292118505;871.5816408124105;872.6814712629877;633.3096924352432;635.1013316157678;635.5392340553108;637.1462240597622;640.0750914927931;13985.090969086978;13994.30028498571;14088.366023528863;14092.506762263374;14235.78646320306;13982.230977296245;14168.716625667532;14427.278636068155;14507.854921450757;14646.853531464656;11499;11603.361815100166;11704.707382315424;11712.765744685144;11889.881101188965;3712.3317802795486;3807.562130355017;3812.275667623143;3827.789471579062;3836.712246581518;84276.57861710714;85514.57242713809;87201;87409.56295218483;87663.56168219118;10398;10487.632932847313;10570.471476426148;10763.892361076445;10997.835032474519;20386.69419958672;20593.485162870747;20758.377248682562;20758.481037974172;20764.792352076285;7540.849183016309;7727.459077864495;7748.845023099507;7819.609019549;7824.765257042298;4662.090892275974;4672.135654903854;4710.175719249118;4753.952460475421;4759.143354196278;3364.9663503364654;3473.635268296792;3476.721862251014;3481.1993241554583;3490.424080026767;638.5657752728097;668.5220067651652;673.2426020726682;682.5392859819602;688.5421194905432;604.5254475236918;656.0978654350268;701.77182475585;707.7098389660215;775.961201939912;9182.90817091834;9645.131938125462;9660.227181825438;9699.903000970042;9866.753331166778;691.5919607431539;750.3996802558041;763.7097902797012;789.8696715041954;791.7743443118799;4487.955120448819;4714.245720684674;4786.635808794477;4902.313676085351;4909.828156014522;94957.5252123735;117763.41118294524;127141.36429317795;128535;133074;65137.674311628136;76399;97988.51005745068;98897.50551247198;99068.99999999856;60614;62689.37310626927;79940.60029699815;82508;99217.99999999856;9115.544222788967;9125.726228213165;9235.12266334697;9328.253739700673;9511.143997040022;54999;55812.13972532988;55812.16281755696;55848.72075639596;56049.71975140098;79507.60246198963;81691.5915420419;83705.58147209225;84691.57654211689;84929.57535212285;11700.239484433485;11757.470913808727;11798.469068891749;11882.168248222888;12168;13041.869581304065;13080.151988382086;13240.602781916557;13326.733465330833;13540.729185416434;12554.246745195318;12945.611631651065;12976.15654982423;13052;13467.191968481922;12372;12483.625491235278;12748.235105893677;12765.489380424679;12773.680657983625;11953.342566158944;12161.939190304345;12206.389680515762;12280.81578776337;12325.198862073936;9911.851322230028;10164.695059148238;10342.431166285927;10637.14902807758;10637.734056648645;9911.074860246319;9917.256205784739;10897.12822974176;10901;10998.780024399628 02:41:10 INFO - PROCESS | 19387 | __end_tp_report 02:41:10 INFO - PROCESS | 19387 | __start_cc_report 02:41:10 INFO - PROCESS | 19387 | _x_x_mozilla_cycle_collect,321 02:41:10 INFO - PROCESS | 19387 | __end_cc_report 02:41:10 INFO - PROCESS | 19387 | __startTimestamp1472031670793__endTimestamp 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | ------- Summary: start ------- 02:41:10 INFO - PROCESS | 19387 | Number of tests: 6 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#0] dojo.html Cycles:165 Average:5497.59 Median:5737.83 stddev:636.35 (11.1%) stddev-sans-first:610.14 02:41:10 INFO - PROCESS | 19387 | Values: 3111.1 3133.8 3149.6 3172.4 3183.4 5356.2 5469.0 5503.5 5533.7 5586.1 5468.0 5493.1 5519.7 5527.6 5543.4 4890.7 4995.4 5027.5 5045.7 5069.2 4613.6 5095.0 5161.0 5163.6 5189.3 4908.8 4956.2 4983.4 5058.9 5078.9 4983.0 5004.0 5011.4 5012.6 5079.5 4898.5 4974.1 4975.2 4992.3 5076.8 5367.6 5403.9 5430.1 5487.6 5527.9 5749.8 5809.4 5820.5 5895.0 5919.1 5896.1 5938.9 5948.2 5949.0 5949.2 5568.2 5636.1 5638.3 5643.1 5648.6 6103.6 6172.2 6179.4 6182.0 6194.5 5668.3 5750.4 5938.0 5939.9 5955.0 5738.7 5855.2 5906.6 5934.7 5971.5 5873.8 5939.1 5943.0 5956.5 6036.5 5949.6 5954.1 5957.3 5965.5 5970.5 4349.5 4529.1 4546.0 4559.2 4563.1 4049.5 4062.7 4071.2 4079.1 4108.3 5643.9 5686.9 5694.8 5700.9 5712.5 5690.2 5752.6 5797.7 6039.5 6045.5 5513.9 5525.6 5573.3 5591.2 5676.2 5095.6 5102.8 5107.7 5110.2 5115.7 6073.7 6083.4 6098.5 6108.0 6113.2 5712.9 5840.2 5862.4 5885.6 5913.6 6136.8 6136.9 6140.3 6147.9 6158.9 5743.3 5789.2 5789.7 5796.6 5902.7 5709.0 5864.8 5865.2 5892.2 5929.8 5814.5 5815.4 5822.4 5838.0 5867.9 5555.3 5760.5 5817.8 5821.4 5827.8 5737.8 5781.2 5791.3 5858.4 5861.1 5834.1 5930.2 5932.3 5946.6 5947.6 5495.3 5635.5 5777.9 5790.8 5794.7 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#1] ext.html Cycles:180 Average:62221.20 Median:42529.36 stddev:125973.13 (296.2%) stddev-sans-first:126241.45 02:41:10 INFO - PROCESS | 19387 | Values: 563.0 587.5 602.0 602.6 623.3 39339.4 44226.8 44230.6 44241.3 44491.8 43681.0 44188.0 44190.0 44215.3 44274.0 8769.1 8804.1 8959.6 8960.8 8989.5 8822.7 8862.1 8867.6 8873.3 8898.9 8848.4 9009.2 9047.7 9048.5 9053.4 8827.7 8931.4 8982.4 8982.6 9015.4 8756.3 8787.5 8838.5 8914.5 8932.2 42162.6 42239.8 42459.6 42599.1 42780.6 3392.2 3411.9 3644.9 3852.4 3968.0 32092.7 32705.7 32776.7 32823.8 32926.3 4149.8 4276.9 4299.2 4314.3 4324.7 346352.0 348553.0 349554.0 349577.0 351026.0 58752.7 59238.3 59371.7 59405.4 59557.0 36562.8 61258.7 61286.4 61353.7 61378.4 15538.7 16255.6 16343.0 16387.5 16393.7 13015.9 13036.6 13046.1 13117.4 13118.5 18976.1 19080.5 19108.9 19133.9 19185.7 6951.8 7319.8 7342.2 7376.9 7532.9 995.5 1128.1 1129.0 1146.0 1160.4 33332.5 33817.2 33937.0 33975.0 34011.5 1012.6 1113.7 1124.2 1155.5 1198.2 16557.3 16904.2 16906.7 16967.4 17118.7 564360.0 567292.0 571872.0 572292.0 579668.0 57984.4 57994.1 58375.0 58451.4 58554.1 1326.5 1380.0 1382.5 1382.6 1391.4 29755.3 30844.4 31508.8 31768.9 31846.4 49177.0 49188.0 49431.3 49472.3 49523.5 472514.0 474068.0 474407.0 478187.0 478810.0 28549.9 28639.7 28796.9 28910.4 29099.0 44601.8 47193.3 48116.8 49143.0 49486.8 37711.6 40012.4 40988.8 41495.0 42964.4 41184.8 41234.4 41509.6 41733.0 41845.8 39353.2 40297.4 43086.4 43139.4 43159.0 31098.4 35257.1 36911.4 37177.6 37264.3 28131.3 28204.0 28222.6 28381.7 28487.0 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#2] jquery.html Cycles:180 Average:28642.26 Median:13431.29 stddev:75182.92 (559.8%) stddev-sans-first:75363.89 02:41:10 INFO - PROCESS | 19387 | Values: 385.5 391.9 398.5 405.9 413.2 18828.8 19502.3 19703.3 20549.8 20565.8 18866.6 19013.4 19094.3 19178.0 19183.4 5600.9 5632.5 5721.6 5792.6 5806.8 5731.5 5783.5 5810.6 5818.9 5821.3 5579.8 5750.1 5768.2 5773.4 5783.1 5543.8 5744.9 5762.1 5798.3 5820.1 5124.7 5151.2 5179.2 5179.3 5180.0 24166.3 24443.0 24597.9 24709.0 24811.3 2304.6 2419.6 2551.6 2964.5 3146.7 14662.1 14829.4 14953.3 15161.4 15486.3 1918.2 1945.7 1992.2 1998.3 2044.6 74494.3 77123.6 78128.0 82678.2 88751.6 11204.0 11286.4 11294.3 11434.9 11547.2 15751.5 15761.4 15813.3 15876.4 15879.8 7730.9 7871.0 8010.4 8086.6 8219.9 7586.3 7644.2 7734.4 7821.1 7855.6 4692.5 4716.3 4776.9 4880.8 4905.1 1989.8 1993.1 1993.6 2027.0 2072.9 998.7 1020.8 1043.3 1044.5 1060.9 20444.9 20913.6 21022.6 21084.9 21233.5 961.1 963.1 1012.6 1021.4 1072.3 10941.2 11550.3 11602.6 11748.5 11770.0 431441.0 440837.0 442623.0 452264.0 499258.0 90347.0 91378.0 97516.5 98186.5 101516.5 1011.1 1036.7 1054.1 1058.3 1061.7 18287.7 18312.5 19199.4 19453.5 19561.5 43764.6 44208.7 44257.6 44573.6 44874.0 63213.7 63459.4 64635.0 65055.0 65281.0 8376.7 8578.9 8760.1 8986.6 9067.5 12772.9 12938.2 13667.4 13861.0 14088.0 11527.7 11643.0 11712.4 11767.0 11990.5 11370.5 11418.0 11539.5 11816.3 11979.9 11051.6 11198.3 11541.8 12045.0 12127.8 8526.4 8607.7 8678.2 8729.5 8874.4 10255.7 11521.9 11562.5 11807.8 12101.6 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#3] mootools.html Cycles:180 Average:6025.90 Median:2607.87 stddev:3553.55 (136.3%) stddev-sans-first:3547.21 02:41:10 INFO - PROCESS | 19387 | Values: 1494.8 1495.7 1623.4 1745.8 1749.6 7931.0 8444.8 8925.8 9057.5 9218.4 9210.1 9293.7 9372.2 9397.2 9445.0 2361.5 2384.9 2387.3 2391.5 2393.1 2342.9 2344.5 2416.3 2425.7 2426.9 2376.1 2383.9 2383.9 2392.5 2404.7 2325.1 2340.3 2350.5 2352.7 2386.7 2293.9 2308.4 2311.4 2315.0 2317.5 9510.1 9538.4 9569.0 9571.0 9573.2 5368.5 5446.5 5515.5 5529.5 5532.9 3287.4 3347.4 3363.6 3365.4 3375.5 1092.1 1118.7 1125.6 1131.7 1170.8 13163.7 13197.1 13214.3 13227.1 13276.5 4678.8 4754.2 4799.7 4887.5 4911.9 11009.3 11084.8 11095.3 11107.0 11110.3 5523.1 5567.7 5573.8 5609.4 5626.4 4389.9 4896.0 4984.2 5044.0 5094.2 4075.1 4125.4 4132.3 4170.5 4208.8 1275.3 1301.4 1319.0 1321.9 1322.4 835.9 875.0 975.9 982.6 989.4 5952.1 6050.9 6109.5 6142.8 6150.4 459.9 468.3 471.1 472.5 477.0 4088.0 4089.9 4108.9 4116.1 4121.0 11112.2 11420.1 11534.6 11610.8 11630.5 11375.3 11420.4 11485.7 11512.7 11600.9 8191.6 8213.2 8268.0 8322.0 8503.7 6010.0 6225.8 6298.8 6344.7 6398.2 10358.3 10724.3 10776.4 10819.1 10863.6 11179.4 11190.8 11223.3 11237.3 11254.2 7200.8 7869.6 7980.1 8014.4 8026.6 9186.8 9262.3 9287.3 9296.5 9297.3 7807.6 7943.6 8044.3 8209.3 8225.4 7665.0 7726.7 7750.7 7785.7 7810.2 6681.7 6776.2 6777.0 6779.3 6788.3 4743.2 4873.2 4922.8 5057.2 5284.2 5194.2 5227.9 5271.5 5347.9 5370.8 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#4] prototype.html Cycles:180 Average:4833.84 Median:5514.99 stddev:1440.71 (26.1%) stddev-sans-first:1404.47 02:41:10 INFO - PROCESS | 19387 | Values: 326.5 329.1 335.1 336.5 338.2 5469.2 5488.5 5493.3 5505.9 5556.4 5414.5 5426.5 5428.6 5436.0 5436.0 4048.9 4144.5 4221.5 4267.0 4268.0 4224.4 4256.5 4273.7 4273.9 4294.1 4263.4 4266.8 4292.8 4302.2 4303.5 3991.7 4160.9 4166.3 4214.3 4295.6 3685.6 3686.9 3689.1 3693.5 3715.6 5331.7 5342.8 5363.0 5364.7 5380.4 4530.1 4759.9 4843.8 4891.4 4899.5 5668.8 5686.9 5689.5 5696.5 5697.8 4043.4 4055.2 4062.2 4069.9 4074.6 5774.4 5869.9 5900.7 5932.2 6002.2 4164.6 4180.1 4183.8 4184.5 4198.9 4220.3 4227.8 4239.5 4245.8 4249.4 4754.6 4808.9 4868.2 4874.1 4874.4 5774.1 5777.5 5788.2 5788.2 5791.5 1400.5 1411.2 1411.6 1416.4 1417.7 919.2 927.8 960.3 987.7 1013.6 5510.7 5519.3 5521.0 5533.2 5547.2 5823.5 5836.6 5848.9 5851.9 5859.5 5364.6 5485.9 5499.5 5499.9 5562.3 3068.7 3104.1 3111.1 3115.3 3121.7 5703.4 6041.2 6050.4 6060.5 6073.8 6082.4 6119.8 6123.7 6130.2 6149.2 6079.2 6127.3 6141.4 6187.6 6197.6 5687.8 5875.8 5938.5 5950.8 5993.8 5878.7 5899.5 5905.3 5939.5 5941.1 5840.7 6158.8 6205.6 6209.9 6223.2 4190.4 4242.7 4244.6 4258.3 4280.9 5940.9 5984.9 5996.9 6010.7 6015.5 5618.2 5739.9 5748.0 5764.7 5819.4 5733.7 5765.6 5784.8 5789.5 5789.7 5128.7 5706.5 5721.9 5742.5 5758.4 5753.7 5787.3 5793.4 5799.4 5804.9 5647.8 5660.0 5664.9 5691.4 5695.2 02:41:10 INFO - PROCESS | 19387 | 02:41:10 INFO - PROCESS | 19387 | [#5] yui.html Cycles:180 Average:20616.74 Median:29954.41 stddev:30618.17 (102.2%) stddev-sans-first:30667.39 02:41:10 INFO - PROCESS | 19387 | Values: 657.6 665.5 677.3 712.3 743.8 13170.7 14238.8 14353.9 14382.1 14432.6 12775.6 12779.7 13037.7 13042.0 13055.4 797.3 816.5 823.7 824.4 825.2 795.8 814.4 815.3 815.5 815.7 868.9 878.5 880.4 880.5 880.6 860.4 861.9 863.1 871.6 872.7 633.3 635.1 635.5 637.1 640.1 13985.1 13994.3 14088.4 14092.5 14235.8 13982.2 14168.7 14427.3 14507.9 14646.9 11499.0 11603.4 11704.7 11712.8 11889.9 3712.3 3807.6 3812.3 3827.8 3836.7 84276.6 85514.6 87201.0 87409.6 87663.6 10398.0 10487.6 10570.5 10763.9 10997.8 20386.7 20593.5 20758.4 20758.5 20764.8 7540.8 7727.5 7748.8 7819.6 7824.8 4662.1 4672.1 4710.2 4754.0 4759.1 3365.0 3473.6 3476.7 3481.2 3490.4 638.6 668.5 673.2 682.5 688.5 604.5 656.1 701.8 707.7 776.0 9182.9 9645.1 9660.2 9699.9 9866.8 691.6 750.4 763.7 789.9 791.8 4488.0 4714.2 4786.6 4902.3 4909.8 94957.5 117763.4 127141.4 128535.0 133074.0 65137.7 76399.0 97988.5 98897.5 99069.0 60614.0 62689.4 79940.6 82508.0 99218.0 9115.5 9125.7 9235.1 9328.3 9511.1 54999.0 55812.1 55812.2 55848.7 56049.7 79507.6 81691.6 83705.6 84691.6 84929.6 11700.2 11757.5 11798.5 11882.2 12168.0 13041.9 13080.2 13240.6 13326.7 13540.7 12554.2 12945.6 12976.2 13052.0 13467.2 12372.0 12483.6 12748.2 12765.5 12773.7 11953.3 12161.9 12206.4 12280.8 12325.2 9911.9 10164.7 10342.4 10637.1 10637.7 9911.1 9917.3 10897.1 10901.0 10998.8 02:41:10 INFO - PROCESS | 19387 | -------- Summary: end -------- 02:41:10 INFO - PROCESS | 19387 | 02:41:11 INFO - TEST-INFO | 19387: exit 0 02:41:11 INFO - TEST-OK | dromaeo_css | took 1115493ms 02:41:11 INFO - TEST-START | kraken 02:41:11 INFO - operating with platform_type : linux_ 02:41:11 INFO - Initialising browser for kraken test... 02:41:11 INFO - TEST-INFO | started process 19750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwLvh1/profile http://localhost:37409/getInfo.html) 02:41:16 INFO - PROCESS | 19750 | __metrics Screen width/height:1600/1200 02:41:16 INFO - PROCESS | 19750 | colorDepth:24 02:41:16 INFO - PROCESS | 19750 | Browser inner width/height: 1024/697 02:41:16 INFO - PROCESS | 19750 | __metrics 02:41:17 ERROR - PROCESS | 19750 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 02:41:18 INFO - TEST-INFO | 19750: exit 0 02:41:18 INFO - Browser initialized. 02:41:18 INFO - Running cycle 1/1 for kraken test... 02:41:18 INFO - TEST-INFO | started process 19870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwLvh1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:30 INFO - PROCESS | 19870 | RSS: Main: 192425984 02:41:30 INFO - PROCESS | 19870 | 02:41:33 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:33 INFO - PROCESS | 19870 | RSS: Main: 205508608 02:41:33 INFO - PROCESS | 19870 | 02:41:36 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-dft) 02:41:37 INFO - PROCESS | 19870 | RSS: Main: 204406784 02:41:37 INFO - PROCESS | 19870 | 02:41:40 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-fft) 02:41:40 INFO - PROCESS | 19870 | RSS: Main: 195096576 02:41:40 INFO - PROCESS | 19870 | 02:41:42 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-oscillator) 02:41:43 INFO - PROCESS | 19870 | RSS: Main: 196149248 02:41:43 INFO - PROCESS | 19870 | 02:41:45 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:46 INFO - PROCESS | 19870 | RSS: Main: 196132864 02:41:46 INFO - PROCESS | 19870 | 02:41:49 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:50 INFO - PROCESS | 19870 | RSS: Main: 197017600 02:41:50 INFO - PROCESS | 19870 | 02:41:53 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:54 INFO - PROCESS | 19870 | RSS: Main: 193728512 02:41:54 INFO - PROCESS | 19870 | 02:41:57 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37409/tests/kraken/driver.html?testName=json-parse-financial) 02:41:57 INFO - PROCESS | 19870 | RSS: Main: 196251648 02:41:57 INFO - PROCESS | 19870 | 02:41:59 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:00 INFO - PROCESS | 19870 | RSS: Main: 196694016 02:42:00 INFO - PROCESS | 19870 | 02:42:01 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:02 INFO - PROCESS | 19870 | RSS: Main: 196509696 02:42:02 INFO - PROCESS | 19870 | 02:42:04 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:05 INFO - PROCESS | 19870 | RSS: Main: 197214208 02:42:05 INFO - PROCESS | 19870 | 02:42:08 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:08 INFO - PROCESS | 19870 | RSS: Main: 196956160 02:42:08 INFO - PROCESS | 19870 | 02:42:11 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:12 INFO - PROCESS | 19870 | RSS: Main: 197120000 02:42:12 INFO - PROCESS | 19870 | 02:42:13 INFO - PROCESS | 19870 | Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37409/tests/kraken/driver.html?testName=ai-astar) 02:42:14 INFO - PROCESS | 19870 | RSS: Main: 198791168 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | __start_tp_report 02:42:14 INFO - PROCESS | 19870 | _x_x_mozilla_page_load 02:42:14 INFO - PROCESS | 19870 | _x_x_mozilla_page_load_details 02:42:14 INFO - PROCESS | 19870 | |i|pagename|runs| 02:42:14 INFO - PROCESS | 19870 | |0;ai-astar;108;114;113;115;114;114;114;113;114;128 02:42:14 INFO - PROCESS | 19870 | |1;audio-beat-detection;152;127;151;176;123;150;153;125;181;124 02:42:14 INFO - PROCESS | 19870 | |2;audio-dft;165;166;166;181;165;164;165;164;164;161 02:42:14 INFO - PROCESS | 19870 | |3;audio-fft;77;78;77;177;78;82;75;76;177;78 02:42:14 INFO - PROCESS | 19870 | |4;audio-oscillator;88;102;148;98;87;87;133;86;86;143 02:42:14 INFO - PROCESS | 19870 | |5;imaging-gaussian-blur;118;117;120;119;118;118;118;118;118;118 02:42:14 INFO - PROCESS | 19870 | |6;imaging-darkroom;148;147;148;148;147;147;147;148;147;147 02:42:14 INFO - PROCESS | 19870 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;97;98 02:42:14 INFO - PROCESS | 19870 | |8;json-parse-financial;54;55;55;55;54;58;75;53;54;53 02:42:14 INFO - PROCESS | 19870 | |9;json-stringify-tinderbox;62;75;63;67;64;62;62;62;64;63 02:42:14 INFO - PROCESS | 19870 | |10;stanford-crypto-aes;89;86;80;83;81;80;80;81;87;80 02:42:14 INFO - PROCESS | 19870 | |11;stanford-crypto-ccm;128;131;140;132;127;126;131;132;144;130 02:42:14 INFO - PROCESS | 19870 | |12;stanford-crypto-pbkdf2;174;170;170;172;167;168;170;165;167;172 02:42:14 INFO - PROCESS | 19870 | |13;stanford-crypto-sha256-iterative;71;70;68;73;67;68;71;65;74;66 02:42:14 INFO - PROCESS | 19870 | __end_tp_report 02:42:14 INFO - PROCESS | 19870 | __start_cc_report 02:42:14 INFO - PROCESS | 19870 | _x_x_mozilla_cycle_collect,845 02:42:14 INFO - PROCESS | 19870 | __end_cc_report 02:42:14 INFO - PROCESS | 19870 | __startTimestamp1472031734174__endTimestamp 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | ------- Summary: start ------- 02:42:14 INFO - PROCESS | 19870 | Number of tests: 14 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:5.06 (4.4%) stddev-sans-first:4.75 02:42:14 INFO - PROCESS | 19870 | Values: 108.0 114.0 113.0 115.0 114.0 114.0 114.0 113.0 114.0 128.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:21.25 (14.0%) stddev-sans-first:22.44 02:42:14 INFO - PROCESS | 19870 | Values: 152.0 127.0 151.0 176.0 123.0 150.0 153.0 125.0 181.0 124.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:5.43 (3.3%) stddev-sans-first:5.74 02:42:14 INFO - PROCESS | 19870 | Values: 165.0 166.0 166.0 181.0 165.0 164.0 165.0 164.0 164.0 161.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#3] audio-fft Cycles:10 Average:97.50 Median:77.50 stddev:41.94 (54.1%) stddev-sans-first:43.82 02:42:14 INFO - PROCESS | 19870 | Values: 77.0 78.0 77.0 177.0 78.0 82.0 75.0 76.0 177.0 78.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:86.50 stddev:25.36 (29.3%) stddev-sans-first:26.07 02:42:14 INFO - PROCESS | 19870 | Values: 88.0 102.0 148.0 98.0 87.0 87.0 133.0 86.0 86.0 143.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 02:42:14 INFO - PROCESS | 19870 | Values: 118.0 117.0 120.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:42:14 INFO - PROCESS | 19870 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 02:42:14 INFO - PROCESS | 19870 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 98.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.00 stddev:6.62 (12.0%) stddev-sans-first:6.95 02:42:14 INFO - PROCESS | 19870 | Values: 54.0 55.0 55.0 55.0 54.0 58.0 75.0 53.0 54.0 53.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:63.50 stddev:4.03 (6.4%) stddev-sans-first:4.18 02:42:14 INFO - PROCESS | 19870 | Values: 62.0 75.0 63.0 67.0 64.0 62.0 62.0 62.0 64.0 63.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:3.40 (4.1%) stddev-sans-first:2.74 02:42:14 INFO - PROCESS | 19870 | Values: 89.0 86.0 80.0 83.0 81.0 80.0 80.0 81.0 87.0 80.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.50 stddev:5.69 (4.3%) stddev-sans-first:5.83 02:42:14 INFO - PROCESS | 19870 | Values: 128.0 131.0 140.0 132.0 127.0 126.0 131.0 132.0 144.0 130.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:2.76 (1.6%) stddev-sans-first:2.40 02:42:14 INFO - PROCESS | 19870 | Values: 174.0 170.0 170.0 172.0 167.0 168.0 170.0 165.0 167.0 172.0 02:42:14 INFO - PROCESS | 19870 | 02:42:14 INFO - PROCESS | 19870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.50 stddev:2.98 (4.2%) stddev-sans-first:3.10 02:42:14 INFO - PROCESS | 19870 | Values: 71.0 70.0 68.0 73.0 67.0 68.0 71.0 65.0 74.0 66.0 02:42:14 INFO - PROCESS | 19870 | -------- Summary: end -------- 02:42:14 INFO - PROCESS | 19870 | 02:42:15 INFO - TEST-INFO | 19870: exit 0 02:42:15 INFO - TEST-OK | kraken | took 63391ms 02:42:15 INFO - SUITE-END | took 1178s 02:42:15 INFO - Completed test suite (00:19:38) 02:42:15 INFO - javascript benchmark 02:42:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7357.545017204586, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.128883912504, 3133.7649676274273, 3149.590553228081, 3172.4131035758373, 3183.411068952244, 5356.223347614594, 5468.972655136724, 5503.532199763025, 5533.695646739433, 5586.13414920687, 5468.0, 5493.093639549479, 5519.724013799304, 5527.613067085305, 5543.390227075019, 4890.731009794469, 4995.35060442142, 5027.547520723134, 5045.672031317971, 5069.214271787879, 4613.607843333304, 5095.031943930641, 5161.045206636784, 5163.612729045318, 5189.325387699594, 4908.8281910133155, 4956.231784073474, 4983.401991761012, 5058.898822023576, 5078.923816142761, 4982.950170498285, 5003.974980125113, 5011.448740638527, 5012.573931215851, 5079.517445842639, 4898.53463920927, 4974.054929563371, 4975.179095449246, 4992.276119962621, 5076.771545280471, 5367.597430192712, 5403.945960540384, 5430.0768869292315, 5487.64330318532, 5527.861803454905, 5749.798757043525, 5809.448102430262, 5820.476157145878, 5895.0, 5919.1417244499735, 5896.1450589664255, 5938.940610593882, 5948.167256584082, 5949.0, 5949.2266005419015, 5568.220449137124, 5636.098224284095, 5638.2670252866865, 5643.068893632587, 5648.632838865502, 6103.6032657877095, 6172.197614310201, 6179.3820617937845, 6181.96909015461, 6194.473469755031, 5668.319801623831, 5750.389890830575, 5938.0, 5939.940600594025, 5954.970225148933, 5738.684372359477, 5855.209546711139, 5906.645601263938, 5934.732937017845, 5971.462568368781, 5873.765049397976, 5939.109133629903, 5943.0, 5956.493698035715, 6036.486898613579, 5949.553783466257, 5954.136650185699, 5957.255343082114, 5965.463108320272, 5970.49250813677, 4349.456317960255, 4529.071540334289, 4546.04533048057, 4559.156556037144, 4563.133004729091, 4049.493813273341, 4062.73592216505, 4071.1654110907784, 4079.0618157823865, 4108.260513107669, 5643.887122257532, 5686.857828554236, 5694.772209111672, 5700.8859822803315, 5712.457316554921, 5690.174924635905, 5752.597318187771, 5797.652140871562, 6039.5470339723815, 6045.516358691382, 5513.889722205534, 5525.613207075547, 5573.303337082864, 5591.217229587861, 5676.176954341598, 5095.566876815512, 5102.846914592568, 5107.668001579886, 5110.182370820651, 5115.7442127893455, 6073.726682299307, 6083.361247068994, 6098.512119030467, 6107.969460152671, 6113.23584551931, 5712.857178570569, 5840.153177789111, 5862.355140934579, 5885.588008839341, 5913.58604897653, 6136.796294538256, 6136.85608443425, 6140.293866205444, 6147.907781383194, 6158.876822463615, 5743.282089738783, 5789.247397838254, 5789.710514474344, 5796.594238403271, 5902.734376952962, 5709.0, 5864.824055278348, 5865.208196893364, 5892.204552385373, 5929.822105336847, 5814.476697097281, 5815.4184581543195, 5822.388649191943, 5837.970810145922, 5867.853303667443, 5555.3333599966645, 5760.452756988079, 5817.7963771267805, 5821.38875418075, 5827.825165245049, 5737.827865164052, 5781.219535362672, 5791.276090488689, 5858.414158584107, 5861.120831875252, 5834.124881267844, 5930.229070220844, 5932.2584676915385, 5946.613470124428, 5947.583669143119, 5495.2856128703015, 5635.520980716685, 5777.9133313001175, 5790.826275211751, 5794.7102644866745], "value": 5453.880796228314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9887402251956, 587.4536680886777, 601.9939800601995, 602.5812060617869, 623.2987888625297, 39339.409908851354, 44226.778866105706, 44230.55769442305, 44241.33637995433, 44491.77754111225, 43681.0, 44188.0, 44190.0, 44215.33676994839, 44274.0, 8769.079246679086, 8804.075572064938, 8959.552022398886, 8960.820783584324, 8989.460632362046, 8822.735317940473, 8862.06948270432, 8867.645294188225, 8873.3344999125, 8898.911010889873, 8848.380613357067, 9009.189172974431, 9047.728568142966, 9048.457092574434, 9053.366264361497, 8827.69103081389, 8931.41945773526, 8982.416142950688, 8982.595783189772, 9015.413998090104, 8756.255718263956, 8787.516686582236, 8838.469691818447, 8914.50970196639, 8932.19610235082, 42162.57837421617, 42239.788801055794, 42459.57540424587, 42599.148017039486, 42780.572194278284, 3392.2028323343993, 3411.9488207676904, 3644.9271014579826, 3852.4413959975645, 3968.0, 32092.679073209438, 32705.6729432705, 32776.67223327784, 32823.83588082068, 32926.34147317064, 4149.813258403379, 4276.850310239158, 4299.204647140289, 4314.331278651814, 4324.740515569076, 346352.0, 348553.0, 349553.99999999744, 349577.0, 351026.0, 58752.70623646854, 59238.29902112698, 59371.70314148402, 59405.40594593999, 59557.0, 36562.806231626186, 61258.69370653118, 61286.38713612807, 61353.69323153356, 61378.38621613816, 15538.689226215638, 16255.59361015984, 16343.019418834909, 16387.508374748777, 16393.6721265574, 13015.869841301655, 13036.608901732963, 13046.086773925734, 13117.409716562777, 13118.475260989644, 18976.146073426728, 19080.522986925436, 19108.904455477634, 19133.904330478257, 19185.712214316798, 6951.756688515979, 7319.780406587811, 7342.15565209997, 7376.852462950711, 7532.887006694904, 995.4823491784232, 1128.0539091026073, 1129.0121143999002, 1146.0, 1160.4313886195703, 33332.50001249983, 33817.15457113543, 33937.0, 33974.980750577524, 34011.48982765261, 1012.5696578953915, 1113.6603335982604, 1124.2018167101287, 1155.485808815086, 1198.2151690642643, 16557.254923528228, 16904.154792260582, 16906.74639880403, 16967.406140785013, 17118.743218851727, 564360.0, 567292.0, 571872.0, 572292.0, 579668.0, 57984.4201557979, 57994.13008804871, 58375.0, 58451.41548584545, 58554.12168817386, 1326.4826717580152, 1379.9724005519834, 1382.4884792626792, 1382.5506710319187, 1391.4016972701634, 29755.256118597208, 30844.383112338077, 31508.842455787573, 31768.881289206132, 31846.363072738877, 49177.0, 49188.0, 49431.25853112278, 49472.25791613057, 49523.50476495189, 472514.0, 474068.0, 474407.0, 478187.0, 478810.0, 28549.857250713612, 28639.713602863703, 28796.856015719786, 28910.42179156363, 29099.0, 44601.776991114835, 47193.29210061783, 48116.759416202694, 49143.0, 49486.75256623694, 37711.559012848214, 40012.399814003395, 40988.79505602453, 41495.0, 42964.35553466638, 41184.79407602943, 41234.38148427836, 41509.58490415178, 41733.0, 41845.79077104595, 39353.2129357417, 40297.395539066354, 43086.35370469508, 43139.352909705754, 43159.0, 31098.378032439676, 35257.118572035906, 36911.44632830563, 37177.62822371742, 37264.25471490609, 28131.296717582223, 28204.0, 28222.576661349685, 28381.716182837907, 28487.0], "value": 20266.502334320936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4815273457199, 391.8726413915478, 398.53172522286314, 405.9147579008407, 413.20664324496965, 18828.811711882896, 19502.317418890343, 19703.31038413656, 20549.794502054974, 20565.794342056575, 18866.622667546642, 19013.42959711211, 19094.33169839056, 19178.0, 19183.418654014233, 5600.851825375788, 5632.549396048326, 5721.599488035839, 5792.565557583177, 5806.767729290823, 5731.541476681877, 5783.479486846183, 5810.622309549887, 5818.854528636775, 5821.301443826746, 5579.832605021856, 5750.079987202049, 5768.221290125821, 5773.422657734235, 5783.103618939072, 5543.750531226105, 5744.913826292567, 5762.1068734346245, 5798.304203495586, 5820.097884827858, 5124.692518448905, 5151.150060240056, 5179.249008893727, 5179.2749015137915, 5180.0, 24166.275011749676, 24443.0, 24597.87701061501, 24709.0, 24811.25566233016, 2304.5506126305377, 2419.588669926099, 2551.5662337402687, 2964.5108557088056, 3146.748260139206, 14662.120272783666, 14829.440934175827, 14953.261768770926, 15161.393544258217, 15486.303116359792, 1918.2231196365494, 1945.7178709087245, 1992.213075835037, 1998.2606435618768, 2044.580860923507, 74494.25505744928, 77123.61438192773, 78128.0, 82678.17321826765, 88751.55624221903, 11204.0, 11286.379249141211, 11294.322340659586, 11434.885651143548, 11547.191696581327, 15751.527454176394, 15761.369545218293, 15813.288402021937, 15876.364945402054, 15879.761803572956, 7730.92269077302, 7870.960645196852, 8010.3992200584025, 8086.555239461768, 8219.876701849476, 7586.317231449196, 7644.159142494321, 7734.419918506134, 7821.061472623322, 7855.567943763148, 4692.4603670577635, 4716.316134160596, 4776.8566942991765, 4880.829170978998, 4905.068037072945, 1989.7811240763504, 1993.0732209522641, 1993.5913137806715, 2026.9594608107755, 2072.875627462357, 998.7453199434098, 1020.8158536098091, 1043.3114144664485, 1044.4986406524758, 1060.8833028366873, 20444.897775511028, 20913.58172836535, 21022.579548408947, 21084.894575527025, 21233.469163271042, 961.0869673809908, 963.1379914976197, 1012.6050840172338, 1021.4331046269392, 1072.286929192094, 10941.23411361197, 11550.306981581132, 11602.593909213138, 11748.530058797724, 11770.0, 431441.0, 440837.0, 442623.0, 452264.0, 499258.0, 90347.0, 91378.0, 97516.51241743747, 98186.5090674542, 101516.49241753743, 1011.0950699124243, 1036.6993571864225, 1054.1040115901576, 1058.2592185470048, 1061.7027232374946, 18287.725684115016, 18312.542186445444, 19199.424017279503, 19453.51366215856, 19561.510962226057, 43764.56235437605, 44208.68434867462, 44257.557424425344, 44573.55426445694, 44874.0, 63213.683931580046, 63459.36540634719, 64635.0, 65055.0, 65281.0, 8376.706815261437, 8578.871316930126, 8760.123987601444, 8986.59560319774, 9067.455952642862, 12772.872271277169, 12938.223706577635, 13667.38496767628, 13861.019880725693, 14088.0, 11527.654170374903, 11643.0, 11712.355820429959, 11767.0, 11990.520379185084, 11370.488328025423, 11418.029467495357, 11539.480723367637, 11816.291022538331, 11979.880201197877, 11051.557937682403, 11198.272112312674, 11541.826872597087, 12045.036397088037, 12127.818082728943, 8526.445781024213, 8607.655693772429, 8678.175573320525, 8729.476231426135, 8874.378793484395, 10255.743606409602, 11521.94239028833, 11562.537498500302, 11807.76384472323, 12101.636950891487], "value": 9508.447451930822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7907292978982, 1495.6859059597487, 1623.4480276705924, 1745.7643218165545, 1749.5801007758141, 7931.0, 8444.831103377928, 8925.821483570324, 9057.547122643866, 9218.35471516994, 9210.078992100804, 9293.72118836436, 9372.203362714177, 9397.154256116948, 9445.0, 2361.4686695493506, 2384.8807559622037, 2387.271882075966, 2391.497785465054, 2393.1265088242753, 2342.929712108631, 2344.4842134730334, 2416.299273210767, 2425.6967879015124, 2426.9029238830426, 2376.0733314007553, 2383.856968581882, 2383.9046438142454, 2392.521495700858, 2404.6633471313944, 2325.05835136769, 2340.32130682102, 2350.4946436516148, 2352.6588644646517, 2386.749391313904, 2293.86236825791, 2308.365199570115, 2311.3874823171873, 2314.9652755208685, 2317.455397981473, 9510.09654082861, 9538.380005299634, 9568.95215523918, 9570.952145239298, 9573.234141268682, 5368.543673787733, 5446.455354464561, 5515.538382328686, 5529.529989950859, 5532.889342213133, 3287.3918325109694, 3347.397468455677, 3363.630000699921, 3365.4278772608714, 3375.476801095834, 1092.0990183098975, 1118.7091356247354, 1125.6106140324766, 1131.6718151735986, 1170.7834050700649, 13163.73672526544, 13197.076204665676, 13214.33928303581, 13227.140235884734, 13276.46894124234, 4678.76606169697, 4754.194806268215, 4799.712017278975, 4887.462379138292, 4911.852644420673, 11009.2843965142, 11084.833727494093, 11095.334279943228, 11107.0, 11110.333379997226, 5523.088690366045, 5567.749451274703, 5573.804916827973, 5609.354924183689, 5626.43735626434, 4389.934150987738, 4896.045271172158, 4984.202527595639, 5043.9747801260755, 5094.2103973884105, 4075.126616523759, 4125.422440858282, 4132.276851550967, 4170.457840480718, 4208.810603522848, 1275.3177050278057, 1301.4338762638283, 1319.0371029148776, 1321.8678132186703, 1322.3983087695076, 835.9289460395813, 875.03745879532, 975.8828940527183, 982.5725809272989, 989.4360214677708, 5952.136940143741, 6050.939490605126, 6109.480694140959, 6142.754289828446, 6150.446459818638, 459.8643400196883, 468.28820193305984, 471.1119539667751, 472.5274725274725, 476.9792643742394, 4088.0, 4089.9182016359505, 4108.876733697994, 4116.115035267432, 4120.990357362465, 11112.16658750597, 11420.143489238175, 11534.59628912984, 11610.825837612274, 11630.53477860876, 11375.31748095117, 11420.42897855104, 11485.712857178638, 11512.712182195512, 11600.88399116015, 8191.631376587949, 8213.219744124299, 8267.958660206781, 8321.958390208132, 8503.744887653504, 6009.969950150221, 6225.782097626561, 6298.842528936813, 6344.68276586178, 6398.200224971879, 10358.274920755475, 10724.302920310467, 10776.407297598707, 10819.08037816763, 10863.565457381932, 11179.441027948407, 11190.776184476428, 11223.326600404002, 11237.269577477438, 11254.21220514556, 7200.819979500555, 7869.567173805495, 7980.08229053643, 8014.438989270695, 8026.558539280162, 9186.770330741518, 9262.259019278306, 9287.303452240974, 9296.488693121943, 9297.349185556946, 7807.609619519115, 7943.642536086006, 8044.2760151586635, 8209.343252539902, 8225.424220304521, 7665.003549538747, 7726.652300646372, 7750.728724494616, 7785.727499537716, 7810.179931107379, 6681.665916704048, 6776.220734615582, 6776.96611516959, 6779.288174741581, 6788.253292137762, 4743.217369134054, 4873.244647079709, 4922.778474968707, 5057.190849464068, 5284.180951952453, 5194.22086687, 5227.947720522746, 5271.472852714698, 5347.919781203363, 5370.812021579226], "value": 4689.475659770501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5167552023006, 329.0982707381774, 335.11863798210703, 336.46334097115107, 338.1950956722999, 5469.234307196991, 5488.506034456903, 5493.285872836525, 5505.917411238835, 5556.444355564447, 5414.539764120044, 5426.538744206747, 5428.5928555358405, 5435.972820135904, 5436.0, 4048.8785336439955, 4144.5026596808275, 4221.535631080578, 4267.0, 4268.0, 4224.366345048236, 4256.531781504032, 4273.679474039444, 4273.9358909616385, 4294.119705460389, 4263.381809637601, 4266.807993640294, 4292.798016555354, 4302.161078589676, 4303.505096913864, 3991.7006224533275, 4160.875173744793, 4166.33338665812, 4214.325707886724, 4295.613394794468, 3685.5761587417524, 3686.926261474782, 3689.1330537323706, 3693.4829123922673, 3715.5912849586525, 5331.706756128411, 5342.839714808562, 5363.0, 5364.7317634118135, 5380.408155102936, 4530.116627257686, 4759.8814278644495, 4843.806247750086, 4891.413030436335, 4899.461059283476, 5668.829935101912, 5686.877014164739, 5689.544836413118, 5696.544276457915, 5697.77208911643, 4043.413705012786, 4055.229506393776, 4062.248484030434, 4069.857554985591, 4074.5517993020744, 5774.409344571076, 5869.941300586982, 5900.704964751745, 5932.169496270526, 6002.249718785152, 4164.583541645811, 4180.143070670505, 4183.769892655872, 4184.456020717287, 4198.9370159447635, 4220.303649897733, 4227.809748561261, 4239.47006624172, 4245.787710614457, 4249.405083288342, 4754.573627911613, 4808.927866082012, 4868.2210846264425, 4874.122657921608, 4874.4150701916, 5774.1129435282355, 5777.45114214149, 5788.18965344852, 5788.21859049023, 5791.536677065909, 1400.4818217259678, 1411.1885665742034, 1411.5906387147613, 1416.419268100074, 1417.688108616103, 919.1727445299284, 927.7726956895604, 960.3085778239656, 987.7185002274317, 1013.6097602422973, 5510.669359838343, 5519.31008623922, 5521.0, 5533.22534845122, 5547.223388725582, 5823.5341172706085, 5836.591438599342, 5848.941510584839, 5851.853703657443, 5859.5019423349495, 5364.570834333244, 5485.930243602459, 5499.50504454601, 5499.890002200013, 5562.276904002535, 3068.723814856629, 3104.1463597510415, 3111.113332700215, 3115.2679120406688, 3121.6566177720433, 5703.372629010805, 6041.154238406627, 6050.42520960508, 6060.515158787286, 6073.817785466443, 6082.361352058058, 6119.816405507842, 6123.663198524124, 6130.233720784902, 6149.200603921551, 6079.240094988127, 6127.2647282325515, 6141.416565426277, 6187.566870319124, 6197.566170368031, 5687.829365119053, 5875.794347197828, 5938.465538101419, 5950.821475355746, 5993.760249589967, 5878.735456904535, 5899.528037756883, 5905.320888097752, 5939.524838012862, 5941.1385349125, 5840.707964601838, 6158.753649854135, 6205.565610407409, 6209.895052473763, 6223.190985171898, 4190.434291370626, 4242.727181845372, 4244.639205667429, 4258.318669012943, 4280.935785963151, 5940.940590594038, 5984.940150598438, 5996.940030599812, 6010.7295171716505, 6015.518758499397, 5618.157276408571, 5739.9139012915675, 5747.971260143672, 5764.682942438206, 5819.388964158702, 5733.71331433435, 5765.56758243125, 5784.82645520635, 5789.478946894799, 5789.681567513827, 5128.66645676209, 5706.514946229451, 5721.942780572307, 5742.540596752333, 5758.366579676316, 5753.712314384347, 5787.276590426197, 5793.449622285876, 5799.449052340021, 5804.883902322014, 5647.813959068641, 5660.0, 5664.886702265849, 5691.402402747652, 5695.202671625892], "value": 4368.958665931494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.5561495990207, 665.5441022899314, 677.3328271652422, 712.3375261007264, 743.773149189497, 13170.736585268289, 14238.786418203736, 14353.856461435382, 14382.065165764245, 14432.639184020392, 12775.552855650054, 12779.680507987305, 13037.73924521509, 13042.0, 13055.41250643721, 797.3461761355676, 816.4733746733353, 823.7240524424325, 824.3981893217955, 825.1583384947351, 795.8328750962276, 814.3932770086294, 815.3314282288526, 815.5269943432825, 815.6778072661295, 868.8696695495695, 878.4685265414396, 880.4189235104832, 880.454118446564, 880.5993273060774, 860.3977215948829, 861.8534849075672, 863.1239292118505, 871.5816408124105, 872.6814712629877, 633.3096924352432, 635.1013316157678, 635.5392340553108, 637.1462240597622, 640.0750914927931, 13985.090969086978, 13994.30028498571, 14088.366023528863, 14092.506762263374, 14235.78646320306, 13982.230977296245, 14168.716625667532, 14427.278636068155, 14507.854921450757, 14646.853531464656, 11499.0, 11603.361815100166, 11704.707382315424, 11712.765744685144, 11889.881101188965, 3712.3317802795486, 3807.562130355017, 3812.275667623143, 3827.789471579062, 3836.712246581518, 84276.57861710714, 85514.57242713809, 87201.0, 87409.56295218483, 87663.56168219118, 10398.0, 10487.632932847313, 10570.471476426148, 10763.892361076445, 10997.835032474519, 20386.69419958672, 20593.485162870747, 20758.377248682562, 20758.481037974172, 20764.792352076285, 7540.849183016309, 7727.459077864495, 7748.845023099507, 7819.609019549, 7824.765257042298, 4662.090892275974, 4672.135654903854, 4710.175719249118, 4753.952460475421, 4759.143354196278, 3364.9663503364654, 3473.635268296792, 3476.721862251014, 3481.1993241554583, 3490.424080026767, 638.5657752728097, 668.5220067651652, 673.2426020726682, 682.5392859819602, 688.5421194905432, 604.5254475236918, 656.0978654350268, 701.77182475585, 707.7098389660215, 775.961201939912, 9182.90817091834, 9645.131938125462, 9660.227181825438, 9699.903000970042, 9866.753331166778, 691.5919607431539, 750.3996802558041, 763.7097902797012, 789.8696715041954, 791.7743443118799, 4487.955120448819, 4714.245720684674, 4786.635808794477, 4902.313676085351, 4909.828156014522, 94957.5252123735, 117763.41118294524, 127141.36429317795, 128535.0, 133074.0, 65137.674311628136, 76399.0, 97988.51005745068, 98897.50551247198, 99068.99999999856, 60614.0, 62689.37310626927, 79940.60029699815, 82508.0, 99217.99999999856, 9115.544222788967, 9125.726228213165, 9235.12266334697, 9328.253739700673, 9511.143997040022, 54999.0, 55812.13972532988, 55812.16281755696, 55848.72075639596, 56049.71975140098, 79507.60246198963, 81691.5915420419, 83705.58147209225, 84691.57654211689, 84929.57535212285, 11700.239484433485, 11757.470913808727, 11798.469068891749, 11882.168248222888, 12168.0, 13041.869581304065, 13080.151988382086, 13240.602781916557, 13326.733465330833, 13540.729185416434, 12554.246745195318, 12945.611631651065, 12976.15654982423, 13052.0, 13467.191968481922, 12372.0, 12483.625491235278, 12748.235105893677, 12765.489380424679, 12773.680657983625, 11953.342566158944, 12161.939190304345, 12206.389680515762, 12280.81578776337, 12325.198862073936, 9911.851322230028, 10164.695059148238, 10342.431166285927, 10637.14902807758, 10637.734056648645, 9911.074860246319, 9917.256205784739, 10897.12822974176, 10901.0, 10998.780024399628], "value": 7366.4417640610845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 128.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 151.0, 176.0, 123.0, 150.0, 153.0, 125.0, 181.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 181.0, 165.0, 164.0, 165.0, 164.0, 164.0, 161.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 177.0, 78.0, 82.0, 75.0, 76.0, 177.0, 78.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 102.0, 148.0, 98.0, 87.0, 87.0, 133.0, 86.0, 86.0, 143.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 120.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 98.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 58.0, 75.0, 53.0, 54.0, 53.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 75.0, 63.0, 67.0, 64.0, 62.0, 62.0, 62.0, 64.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 80.0, 83.0, 81.0, 80.0, 80.0, 81.0, 87.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 140.0, 132.0, 127.0, 126.0, 131.0, 132.0, 144.0, 130.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 170.0, 172.0, 167.0, 168.0, 170.0, 165.0, 167.0, 172.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 68.0, 73.0, 67.0, 68.0, 71.0, 65.0, 74.0, 66.0], "value": 69.3, "unit": "score"}]}]} 02:42:15 INFO - Return code: 0 02:42:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:15 ERROR - # TBPL SUCCESS # 02:42:15 INFO - Running post-action listener: _resource_record_post_action 02:42:15 INFO - [mozharness: 2016-08-24 09:42:15.448333Z] Finished run-tests step (success) 02:42:15 INFO - Running post-run listener: _resource_record_post_run 02:42:15 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 4096; Write bytes: 406487040; Read time: 16; Write time: 303568 02:42:15 INFO - TinderboxPrint: CPU usage
13.8% 02:42:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:42:15 INFO - TinderboxPrint: I/O write bytes / time
406,487,040 / 303,568 02:42:15 INFO - TinderboxPrint: CPU idle
8,216.3 (86.1%) 02:42:15 INFO - TinderboxPrint: CPU user
1,222.5 (12.8%) 02:42:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:42:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117620736; Read time: 0; Write time: 94480 02:42:15 INFO - run-tests - Wall time: 1179s; CPU: 14.0%; Read bytes: 0; Write bytes: 287928320; Read time: 0; Write time: 209088 02:42:16 INFO - Running post-run listener: _upload_blobber_files 02:42:16 INFO - Blob upload gear active. 02:42:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:16 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 02:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:42:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:42:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:17 INFO - (blobuploader) - INFO - Done attempting. 02:42:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:29 INFO - (blobuploader) - INFO - Done attempting. 02:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:30 INFO - (blobuploader) - INFO - Done attempting. 02:42:30 INFO - (blobuploader) - INFO - Iteration through files over. 02:42:30 INFO - Return code: 0 02:42:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:42:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:42:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/491f95045120ec5f7694fe43b6d2c1c615fd51f6d22b0736c319c690af50e2b0a089491ef843c28af38a2d4f58b487792342f4b1496efc83df672408ebc5a104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f57fb72e6f92ec355cd3dcc1bb63aab2e2b10091ef7871d483104267c86a4947d1ee4fc9e8bda68d8f0349d3f6f645eee98d778326f4598882a2fd06c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/259855146b555d238001bd5040a2449905a6cec4e193ae3386cbfc7324a4c96cb3c9158f881eea19444a696d6be0b0e6ef5d55f5003a363b4119911d7ba3ad33"} 02:42:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:42:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:42:30 INFO - Contents: 02:42:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/491f95045120ec5f7694fe43b6d2c1c615fd51f6d22b0736c319c690af50e2b0a089491ef843c28af38a2d4f58b487792342f4b1496efc83df672408ebc5a104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f57fb72e6f92ec355cd3dcc1bb63aab2e2b10091ef7871d483104267c86a4947d1ee4fc9e8bda68d8f0349d3f6f645eee98d778326f4598882a2fd06c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/259855146b555d238001bd5040a2449905a6cec4e193ae3386cbfc7324a4c96cb3c9158f881eea19444a696d6be0b0e6ef5d55f5003a363b4119911d7ba3ad33"} 02:42:30 INFO - Running post-run listener: copy_logs_to_upload_dir 02:42:30 INFO - Copying logs to upload dir... 02:42:30 INFO - mkdir: /builds/slave/test/build/upload/logs 02:42:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.015573 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-24 02:42:30.404570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 02:42:30.408525) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/491f95045120ec5f7694fe43b6d2c1c615fd51f6d22b0736c319c690af50e2b0a089491ef843c28af38a2d4f58b487792342f4b1496efc83df672408ebc5a104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f57fb72e6f92ec355cd3dcc1bb63aab2e2b10091ef7871d483104267c86a4947d1ee4fc9e8bda68d8f0349d3f6f645eee98d778326f4598882a2fd06c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/259855146b555d238001bd5040a2449905a6cec4e193ae3386cbfc7324a4c96cb3c9158f881eea19444a696d6be0b0e6ef5d55f5003a363b4119911d7ba3ad33"} build_url:https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/491f95045120ec5f7694fe43b6d2c1c615fd51f6d22b0736c319c690af50e2b0a089491ef843c28af38a2d4f58b487792342f4b1496efc83df672408ebc5a104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f57fb72e6f92ec355cd3dcc1bb63aab2e2b10091ef7871d483104267c86a4947d1ee4fc9e8bda68d8f0349d3f6f645eee98d778326f4598882a2fd06c724a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/259855146b555d238001bd5040a2449905a6cec4e193ae3386cbfc7324a4c96cb3c9158f881eea19444a696d6be0b0e6ef5d55f5003a363b4119911d7ba3ad33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 02:42:30.434299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:42:30.434667) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472029963.363935-878801556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:42:30.517454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 02:42:30.517828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 02:42:30.518170) ========= ========= Total master_lag: 0.19 =========