builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1470438301.13 results: success (0) buildid: 20160805140722 builduid: dc062ed617324e9da93c5acbb75d6fb9 revision: ba6d10b9a178a5700620a48b77b152908d4f8781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.130329) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.130840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.131151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.152706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.153057) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 16:05:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-08-05 16:05:01 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.295806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.296482) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:01.346765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 16:05:01.347178) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba6d10b9a178a5700620a48b77b152908d4f8781 --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 ba6d10b9a178a5700620a48b77b152908d4f8781 --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=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 16:05:02,035 truncating revision to first 12 chars 2016-08-05 16:05:02,035 Setting DEBUG logging. 2016-08-05 16:05:02,035 attempt 1/10 2016-08-05 16:05:02,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba6d10b9a178?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 16:05:02,660 unpacking tar archive at: fx-team-ba6d10b9a178/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 16:05:02.351780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:02.352149) ========= script_repo_revision: ba6d10b9a178a5700620a48b77b152908d4f8781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:02.352635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:02.352974) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 16:05:02.363382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-05 16:05:02.363740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:05:03 INFO - MultiFileLogger online at 20160805 16:05:03 in /builds/slave/test 16:05:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:05:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:03 INFO - {'append_to_log': False, 16:05:03 INFO - 'base_work_dir': '/builds/slave/test', 16:05:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:05:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:03 INFO - 'branch': 'Fx-Team-Non-PGO', 16:05:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:03 INFO - 'config_files': ('talos/linux_config.py',), 16:05:03 INFO - 'default_actions': ('clobber', 16:05:03 INFO - 'read-buildbot-config', 16:05:03 INFO - 'download-and-extract', 16:05:03 INFO - 'populate-webroot', 16:05:03 INFO - 'create-virtualenv', 16:05:03 INFO - 'install', 16:05:03 INFO - 'run-tests'), 16:05:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:03 INFO - 'download_minidump_stackwalk': True, 16:05:03 INFO - 'download_symbols': 'ondemand', 16:05:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:05:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:05:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:05:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:05:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:03 INFO - 'installer_path': 'installer.exe', 16:05:03 INFO - 'log_level': 'info', 16:05:03 INFO - 'log_name': 'talos', 16:05:03 INFO - 'log_to_console': True, 16:05:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:05:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:05:03 INFO - 'opt_config_files': (), 16:05:03 INFO - 'pip_index': False, 16:05:03 INFO - 'sps_profile': False, 16:05:03 INFO - 'sps_profile_interval': 0, 16:05:03 INFO - 'suite': 'dromaeojs-e10s', 16:05:03 INFO - 'system_bits': '32', 16:05:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:03 INFO - 'title': 'talos-linux64-ix-040', 16:05:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:03 INFO - 'use_talos_json': True, 16:05:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:03 INFO - 'work_dir': 'build'} 16:05:03 INFO - [mozharness: 2016-08-05 23:05:03.151297Z] Running clobber step. 16:05:03 INFO - Running pre-action listener: _resource_record_pre_action 16:05:03 INFO - Running main action method: clobber 16:05:03 INFO - rmtree: /builds/slave/test/build 16:05:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:03 INFO - Running post-action listener: _resource_record_post_action 16:05:03 INFO - [mozharness: 2016-08-05 23:05:03.610836Z] Finished clobber step (success) 16:05:03 INFO - [mozharness: 2016-08-05 23:05:03.610938Z] Running read-buildbot-config step. 16:05:03 INFO - Running pre-action listener: _resource_record_pre_action 16:05:03 INFO - Running main action method: read_buildbot_config 16:05:03 INFO - Using buildbot properties: 16:05:03 INFO - { 16:05:03 INFO - "project": "", 16:05:03 INFO - "product": "firefox", 16:05:03 INFO - "script_repo_revision": "production", 16:05:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:05:03 INFO - "repository": "", 16:05:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:05:03 INFO - "buildid": "20160805140722", 16:05:03 INFO - "pgo_build": "False", 16:05:03 INFO - "basedir": "/builds/slave/test", 16:05:03 INFO - "buildnumber": 1504, 16:05:03 INFO - "slavename": "talos-linux64-ix-040", 16:05:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:05:03 INFO - "platform": "ubuntu64_hw", 16:05:03 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 16:05:03 INFO - "branch": "fx-team", 16:05:03 INFO - "repo_path": "integration/fx-team", 16:05:03 INFO - "revision": "ba6d10b9a178a5700620a48b77b152908d4f8781", 16:05:03 INFO - "stage_platform": "linux64", 16:05:03 INFO - "builduid": "dc062ed617324e9da93c5acbb75d6fb9", 16:05:03 INFO - "slavebuilddir": "test" 16:05:03 INFO - } 16:05:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:05:03 INFO - Running post-action listener: _resource_record_post_action 16:05:03 INFO - [mozharness: 2016-08-05 23:05:03.613374Z] Finished read-buildbot-config step (success) 16:05:03 INFO - [mozharness: 2016-08-05 23:05:03.613464Z] Running download-and-extract step. 16:05:03 INFO - Running pre-action listener: _resource_record_pre_action 16:05:03 INFO - Running main action method: download_and_extract 16:05:03 INFO - mkdir: /builds/slave/test/build/tests 16:05:03 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')]} 16:05:03 INFO - trying https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:05:03 INFO - Downloading https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:04 INFO - Downloaded 1361 bytes. 16:05:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:05:04 INFO - Using the following test package requirements: 16:05:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:05:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:05:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'jsshell-linux-x86_64.zip'], 16:05:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:05:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:05:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:05:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:05:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:05:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:04 INFO - trying https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:05 INFO - Downloaded 20254079 bytes. 16:05:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:05:06 INFO - Return code: 0 16:05:06 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 16:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:06 INFO - trying https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:07 INFO - Downloaded 20254079 bytes. 16:05:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:05:08 INFO - Return code: 0 16:05:08 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')]} 16:05:08 INFO - trying https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:05:08 INFO - Downloading https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:09 INFO - Downloaded 14413723 bytes. 16:05:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:05:09 INFO - Return code: 0 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - trying https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:05:09 INFO - Downloading https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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 16:05:12 INFO - Downloaded 56128974 bytes. 16:05:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:05:12 INFO - mkdir: /builds/slave/test/properties 16:05:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:12 INFO - Contents: 16:05:12 INFO - build_url:https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:05:12 INFO - Running post-action listener: _resource_record_post_action 16:05:12 INFO - Running post-action listener: set_extra_try_arguments 16:05:12 INFO - [mozharness: 2016-08-05 23:05:12.702562Z] Finished download-and-extract step (success) 16:05:12 INFO - [mozharness: 2016-08-05 23:05:12.702796Z] Running populate-webroot step. 16:05:12 INFO - Running pre-action listener: _resource_record_pre_action 16:05:12 INFO - Running main action method: populate_webroot 16:05:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:12 INFO - '--tppagecycles', 16:05:12 INFO - '7'], 16:05:12 INFO - 'tests': ['tsvgm']}}, 16:05:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['damp', 'tps']}, 16:05:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'tests': ['damp', 'tps']}, 16:05:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['dromaeo_dom']}, 16:05:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['basic_compositor_video']}, 16:05:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['a11yr', 16:05:12 INFO - 'ts_paint', 16:05:12 INFO - 'tpaint', 16:05:12 INFO - 'sessionrestore', 16:05:12 INFO - 'sessionrestore_no_auto_restore', 16:05:12 INFO - 'tabpaint']}, 16:05:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['tsvgx', 16:05:12 INFO - 'tsvgr_opacity', 16:05:12 INFO - 'tart', 16:05:12 INFO - 'tscrollx', 16:05:12 INFO - 'cart']}, 16:05:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:12 INFO - 'tsvgr_opacity', 16:05:12 INFO - 'tart', 16:05:12 INFO - 'tscrollx', 16:05:12 INFO - 'cart']}, 16:05:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'talos_options': ['--disable-e10s'], 16:05:12 INFO - 'tests': ['tp5o']}, 16:05:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'tests': ['tp5o']}, 16:05:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'talos_options': ['--disable-e10s', 16:05:12 INFO - '--xperf_path', 16:05:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:12 INFO - 'tests': ['tp5n']}, 16:05:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:12 INFO - 'talos_options': ['--xperf_path', 16:05:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:12 INFO - 'tests': ['tp5n']}}, 16:05:12 INFO - 'talos.zip': {'path': '', 16:05:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:12 INFO - Running post-action listener: _resource_record_post_action 16:05:12 INFO - [mozharness: 2016-08-05 23:05:12.723975Z] Finished populate-webroot step (success) 16:05:12 INFO - [mozharness: 2016-08-05 23:05:12.724064Z] Running create-virtualenv step. 16:05:12 INFO - Running pre-action listener: _resource_record_pre_action 16:05:12 INFO - Running main action method: create_virtualenv 16:05:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:12 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 16:05:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:12 INFO - Using real prefix '/usr' 16:05:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:15 INFO - Installing pip.................done. 16:05:15 INFO - Return code: 0 16:05:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:15 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')]} 16:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:15 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')]} 16:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:15 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:15 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 16:05:15 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 16:05:15 INFO - Using env: {'DISPLAY': ':0', 16:05:15 INFO - 'HOME': '/home/cltbld', 16:05:15 INFO - 'LANG': 'en_US.UTF-8', 16:05:15 INFO - 'LANGUAGE': 'en_US:en', 16:05:15 INFO - 'LOGNAME': 'cltbld', 16:05:15 INFO - 'MAIL': '/var/mail/cltbld', 16:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:15 INFO - 'MOZ_NO_REMOTE': '1', 16:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:15 INFO - 'NO_EM_RESTART': '1', 16:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:15 INFO - 'PWD': '/builds/slave/test', 16:05:15 INFO - 'SHELL': '/bin/bash', 16:05:15 INFO - 'SHLVL': '1', 16:05:15 INFO - 'TERM': 'linux', 16:05:15 INFO - 'TMOUT': '86400', 16:05:15 INFO - 'USER': 'cltbld', 16:05:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:15 INFO - '_': '/tools/buildbot/bin/python'} 16:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:15 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 16:05:15 INFO - Cleaning up... 16:05:15 INFO - Return code: 0 16:05:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:15 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')]} 16:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:15 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')]} 16:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:15 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:15 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 16:05:15 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 16:05:15 INFO - Using env: {'DISPLAY': ':0', 16:05:15 INFO - 'HOME': '/home/cltbld', 16:05:15 INFO - 'LANG': 'en_US.UTF-8', 16:05:15 INFO - 'LANGUAGE': 'en_US:en', 16:05:15 INFO - 'LOGNAME': 'cltbld', 16:05:15 INFO - 'MAIL': '/var/mail/cltbld', 16:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:15 INFO - 'MOZ_NO_REMOTE': '1', 16:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:15 INFO - 'NO_EM_RESTART': '1', 16:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:15 INFO - 'PWD': '/builds/slave/test', 16:05:15 INFO - 'SHELL': '/bin/bash', 16:05:15 INFO - 'SHLVL': '1', 16:05:15 INFO - 'TERM': 'linux', 16:05:15 INFO - 'TMOUT': '86400', 16:05:15 INFO - 'USER': 'cltbld', 16:05:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:15 INFO - '_': '/tools/buildbot/bin/python'} 16:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:15 INFO - Downloading/unpacking psutil>=3.1.1 16:05:15 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 16:05:15 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 16:05:15 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 16:05:15 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 16:05:15 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 16:05:15 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 16:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:17 INFO - Installing collected packages: psutil 16:05:17 INFO - Running setup.py install for psutil 16:05:17 INFO - building 'psutil._psutil_linux' extension 16:05:17 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 16:05:17 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 16:05:18 INFO - building 'psutil._psutil_posix' extension 16:05:18 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 16:05:18 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 16:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:18 INFO - Successfully installed psutil 16:05:18 INFO - Cleaning up... 16:05:18 INFO - Return code: 0 16:05:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:05: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 mozsystemmonitor==0.3 16:05:18 INFO - Using env: {'DISPLAY': ':0', 16:05:18 INFO - 'HOME': '/home/cltbld', 16:05:18 INFO - 'LANG': 'en_US.UTF-8', 16:05:18 INFO - 'LANGUAGE': 'en_US:en', 16:05:18 INFO - 'LOGNAME': 'cltbld', 16:05:18 INFO - 'MAIL': '/var/mail/cltbld', 16:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:18 INFO - 'MOZ_NO_REMOTE': '1', 16:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:18 INFO - 'NO_EM_RESTART': '1', 16:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:18 INFO - 'PWD': '/builds/slave/test', 16:05:18 INFO - 'SHELL': '/bin/bash', 16:05:18 INFO - 'SHLVL': '1', 16:05:18 INFO - 'TERM': 'linux', 16:05:18 INFO - 'TMOUT': '86400', 16:05:18 INFO - 'USER': 'cltbld', 16:05:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:18 INFO - '_': '/tools/buildbot/bin/python'} 16:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:20 INFO - Installing collected packages: mozsystemmonitor 16:05:20 INFO - Running setup.py install for mozsystemmonitor 16:05:20 INFO - Successfully installed mozsystemmonitor 16:05:20 INFO - Cleaning up... 16:05:20 INFO - Return code: 0 16:05:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:05:20 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')]} 16:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:20 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')]} 16:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:20 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:20 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 16:05:20 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 16:05:20 INFO - Using env: {'DISPLAY': ':0', 16:05:20 INFO - 'HOME': '/home/cltbld', 16:05:20 INFO - 'LANG': 'en_US.UTF-8', 16:05:20 INFO - 'LANGUAGE': 'en_US:en', 16:05:20 INFO - 'LOGNAME': 'cltbld', 16:05:20 INFO - 'MAIL': '/var/mail/cltbld', 16:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:20 INFO - 'MOZ_NO_REMOTE': '1', 16:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:20 INFO - 'NO_EM_RESTART': '1', 16:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:20 INFO - 'PWD': '/builds/slave/test', 16:05:20 INFO - 'SHELL': '/bin/bash', 16:05:20 INFO - 'SHLVL': '1', 16:05:20 INFO - 'TERM': 'linux', 16:05:20 INFO - 'TMOUT': '86400', 16:05:20 INFO - 'USER': 'cltbld', 16:05:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:20 INFO - '_': '/tools/buildbot/bin/python'} 16:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:20 INFO - Downloading/unpacking jsonschema==2.5.1 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:22 INFO - warning: no files found matching '*.txt' 16:05:22 INFO - no previously-included directories found matching 'build' 16:05:22 INFO - no previously-included directories found matching 'dist' 16:05:22 INFO - no previously-included directories found matching '.git*' 16:05:22 INFO - Installing collected packages: jsonschema, functools32 16:05:23 INFO - Running setup.py install for functools32 16:05:23 INFO - warning: no files found matching '*.txt' 16:05:23 INFO - no previously-included directories found matching 'build' 16:05:23 INFO - no previously-included directories found matching 'dist' 16:05:23 INFO - no previously-included directories found matching '.git*' 16:05:23 INFO - Successfully installed jsonschema functools32 16:05:23 INFO - Cleaning up... 16:05:23 INFO - Return code: 0 16:05:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:05:23 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')]} 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:23 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')]} 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:23 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:23 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 16:05:23 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 16:05:23 INFO - Using env: {'DISPLAY': ':0', 16:05:23 INFO - 'HOME': '/home/cltbld', 16:05:23 INFO - 'LANG': 'en_US.UTF-8', 16:05:23 INFO - 'LANGUAGE': 'en_US:en', 16:05:23 INFO - 'LOGNAME': 'cltbld', 16:05:23 INFO - 'MAIL': '/var/mail/cltbld', 16:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:23 INFO - 'MOZ_NO_REMOTE': '1', 16:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:23 INFO - 'NO_EM_RESTART': '1', 16:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:23 INFO - 'PWD': '/builds/slave/test', 16:05:23 INFO - 'SHELL': '/bin/bash', 16:05:23 INFO - 'SHLVL': '1', 16:05:23 INFO - 'TERM': 'linux', 16:05:23 INFO - 'TMOUT': '86400', 16:05:23 INFO - 'USER': 'cltbld', 16:05:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:23 INFO - '_': '/tools/buildbot/bin/python'} 16:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:05:23 INFO - Cleaning up... 16:05:23 INFO - Return code: 0 16:05:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:23 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')]} 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:23 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')]} 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:23 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:23 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 16:05:23 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 16:05:23 INFO - Using env: {'DISPLAY': ':0', 16:05:23 INFO - 'HOME': '/home/cltbld', 16:05:23 INFO - 'LANG': 'en_US.UTF-8', 16:05:23 INFO - 'LANGUAGE': 'en_US:en', 16:05:23 INFO - 'LOGNAME': 'cltbld', 16:05:23 INFO - 'MAIL': '/var/mail/cltbld', 16:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:23 INFO - 'MOZ_NO_REMOTE': '1', 16:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:23 INFO - 'NO_EM_RESTART': '1', 16:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:23 INFO - 'PWD': '/builds/slave/test', 16:05:23 INFO - 'SHELL': '/bin/bash', 16:05:23 INFO - 'SHLVL': '1', 16:05:23 INFO - 'TERM': 'linux', 16:05:23 INFO - 'TMOUT': '86400', 16:05:23 INFO - 'USER': 'cltbld', 16:05:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:23 INFO - '_': '/tools/buildbot/bin/python'} 16:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:25 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 16:05:26 INFO - Downloading docopt-0.6.1.tar.gz 16:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:26 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:26 INFO - Running setup.py install for blobuploader 16:05:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:26 INFO - Running setup.py install for requests 16:05:26 INFO - Running setup.py install for docopt 16:05:26 INFO - Successfully installed blobuploader requests docopt 16:05:26 INFO - Cleaning up... 16:05:26 INFO - Return code: 0 16:05:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:26 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')]} 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:26 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')]} 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:26 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:26 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 16:05:26 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 16:05:26 INFO - Using env: {'DISPLAY': ':0', 16:05:26 INFO - 'HOME': '/home/cltbld', 16:05:26 INFO - 'LANG': 'en_US.UTF-8', 16:05:26 INFO - 'LANGUAGE': 'en_US:en', 16:05:26 INFO - 'LOGNAME': 'cltbld', 16:05:26 INFO - 'MAIL': '/var/mail/cltbld', 16:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:26 INFO - 'MOZ_NO_REMOTE': '1', 16:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:26 INFO - 'NO_EM_RESTART': '1', 16:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:26 INFO - 'PWD': '/builds/slave/test', 16:05:26 INFO - 'SHELL': '/bin/bash', 16:05:26 INFO - 'SHLVL': '1', 16:05:26 INFO - 'TERM': 'linux', 16:05:26 INFO - 'TMOUT': '86400', 16:05:26 INFO - 'USER': 'cltbld', 16:05:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:26 INFO - '_': '/tools/buildbot/bin/python'} 16:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:27 INFO - Running setup.py (path:/tmp/pip-K4C_4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:27 INFO - Running setup.py (path:/tmp/pip-HD0lqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:27 INFO - Running setup.py (path:/tmp/pip-rnO_ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:27 INFO - Running setup.py (path:/tmp/pip-7cmec2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:27 INFO - Running setup.py (path:/tmp/pip-mnxklw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:27 INFO - Running setup.py (path:/tmp/pip-SziUZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:27 INFO - Running setup.py (path:/tmp/pip-_4dHDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:27 INFO - Running setup.py (path:/tmp/pip-OBA6Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:27 INFO - Running setup.py (path:/tmp/pip-JGDAqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:27 INFO - Running setup.py (path:/tmp/pip-XO6kBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:27 INFO - Running setup.py (path:/tmp/pip-PB3Ep6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:27 INFO - Running setup.py (path:/tmp/pip-tgeBKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:27 INFO - Running setup.py (path:/tmp/pip-SFmWRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:27 INFO - Running setup.py (path:/tmp/pip-3189lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:28 INFO - Running setup.py (path:/tmp/pip-z4Er1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:28 INFO - Running setup.py (path:/tmp/pip-crex93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:28 INFO - Running setup.py (path:/tmp/pip-96TD38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:28 INFO - Running setup.py install for manifestparser 16:05:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozcrash 16:05:28 INFO - Running setup.py install for mozdebug 16:05:28 INFO - Running setup.py install for mozdevice 16:05:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozfile 16:05:28 INFO - Running setup.py install for mozhttpd 16:05:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozinfo 16:05:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozInstall 16:05:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozleak 16:05:29 INFO - Running setup.py install for mozlog 16:05:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for moznetwork 16:05:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozprocess 16:05:29 INFO - Running setup.py install for mozprofile 16:05:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozrunner 16:05:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozscreenshot 16:05:29 INFO - Running setup.py install for moztest 16:05:29 INFO - Running setup.py install for mozversion 16:05:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:30 INFO - Cleaning up... 16:05:30 INFO - Return code: 0 16:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:30 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:30 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 16:05:30 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 16:05:30 INFO - Using env: {'DISPLAY': ':0', 16:05:30 INFO - 'HOME': '/home/cltbld', 16:05:30 INFO - 'LANG': 'en_US.UTF-8', 16:05:30 INFO - 'LANGUAGE': 'en_US:en', 16:05:30 INFO - 'LOGNAME': 'cltbld', 16:05:30 INFO - 'MAIL': '/var/mail/cltbld', 16:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:30 INFO - 'MOZ_NO_REMOTE': '1', 16:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:30 INFO - 'NO_EM_RESTART': '1', 16:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:30 INFO - 'PWD': '/builds/slave/test', 16:05:30 INFO - 'SHELL': '/bin/bash', 16:05:30 INFO - 'SHLVL': '1', 16:05:30 INFO - 'TERM': 'linux', 16:05:30 INFO - 'TMOUT': '86400', 16:05:30 INFO - 'USER': 'cltbld', 16:05:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:30 INFO - '_': '/tools/buildbot/bin/python'} 16:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:30 INFO - Running setup.py (path:/tmp/pip-F4SdXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:30 INFO - Running setup.py (path:/tmp/pip-mNLHF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:30 INFO - Running setup.py (path:/tmp/pip-e6vvWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:30 INFO - Running setup.py (path:/tmp/pip-K75FIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:30 INFO - Running setup.py (path:/tmp/pip-GHuRJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:30 INFO - Running setup.py (path:/tmp/pip-4bkIB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:30 INFO - Running setup.py (path:/tmp/pip-4XEI6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:30 INFO - Running setup.py (path:/tmp/pip-Ll6rwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:30 INFO - Running setup.py (path:/tmp/pip-qvalbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:30 INFO - Running setup.py (path:/tmp/pip-I_DbTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:31 INFO - Running setup.py (path:/tmp/pip-17Ar9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:31 INFO - Running setup.py (path:/tmp/pip-85seLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:31 INFO - Running setup.py (path:/tmp/pip-M0O02j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:31 INFO - Running setup.py (path:/tmp/pip-poS0Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:31 INFO - Running setup.py (path:/tmp/pip-ZIzwfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:31 INFO - Running setup.py (path:/tmp/pip-sXrI5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:31 INFO - Running setup.py (path:/tmp/pip-y5RYHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:31 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)) 16:05:31 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)) 16:05:31 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)) 16:05:31 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)) 16:05:31 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)) 16:05:31 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)) 16:05:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:31 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 16:05:31 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 16:05:31 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 16:05:31 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 16:05:31 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 16:05:31 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 16:05:33 INFO - Downloading blessings-1.6.tar.gz 16:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:33 INFO - Installing collected packages: blessings 16:05:33 INFO - Running setup.py install for blessings 16:05:33 INFO - Successfully installed blessings 16:05:33 INFO - Cleaning up... 16:05:33 INFO - Return code: 0 16:05:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:33 INFO - Reading from file tmpfile_stdout 16:05:33 INFO - Current package versions: 16:05:33 INFO - argparse == 1.2.1 16:05:33 INFO - blessings == 1.6 16:05:33 INFO - blobuploader == 1.2.4 16:05:33 INFO - docopt == 0.6.1 16:05:33 INFO - functools32 == 3.2.3-2 16:05:33 INFO - jsonschema == 2.5.1 16:05:33 INFO - manifestparser == 1.1 16:05:33 INFO - mozInstall == 1.12 16:05:33 INFO - mozcrash == 0.17 16:05:33 INFO - mozdebug == 0.1 16:05:33 INFO - mozdevice == 0.48 16:05:33 INFO - mozfile == 1.2 16:05:33 INFO - mozhttpd == 0.7 16:05:33 INFO - mozinfo == 0.9 16:05:33 INFO - mozleak == 0.1 16:05:33 INFO - mozlog == 3.3 16:05:33 INFO - moznetwork == 0.27 16:05:33 INFO - mozprocess == 0.23 16:05:33 INFO - mozprofile == 0.28 16:05:33 INFO - mozrunner == 6.12 16:05:33 INFO - mozscreenshot == 0.1 16:05:33 INFO - mozsystemmonitor == 0.3 16:05:33 INFO - moztest == 0.7 16:05:33 INFO - mozversion == 1.4 16:05:33 INFO - psutil == 3.1.1 16:05:33 INFO - requests == 1.2.3 16:05:33 INFO - wsgiref == 0.1.2 16:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:33 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')]} 16:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:33 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')]} 16:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:33 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:33 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 16:05:33 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 16:05:33 INFO - Using env: {'DISPLAY': ':0', 16:05:33 INFO - 'HOME': '/home/cltbld', 16:05:33 INFO - 'LANG': 'en_US.UTF-8', 16:05:33 INFO - 'LANGUAGE': 'en_US:en', 16:05:33 INFO - 'LOGNAME': 'cltbld', 16:05:33 INFO - 'MAIL': '/var/mail/cltbld', 16:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:33 INFO - 'MOZ_NO_REMOTE': '1', 16:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:33 INFO - 'NO_EM_RESTART': '1', 16:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:33 INFO - 'PWD': '/builds/slave/test', 16:05:33 INFO - 'SHELL': '/bin/bash', 16:05:33 INFO - 'SHLVL': '1', 16:05:33 INFO - 'TERM': 'linux', 16:05:33 INFO - 'TMOUT': '86400', 16:05:33 INFO - 'USER': 'cltbld', 16:05:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:33 INFO - '_': '/tools/buildbot/bin/python'} 16:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 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)) 16:05:34 INFO - Cleaning up... 16:05:34 INFO - Return code: 0 16:05:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05:34 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')]} 16:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:34 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')]} 16:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:34 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 0x119b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', '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 16:05:34 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 16:05:34 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 16:05:34 INFO - Using env: {'DISPLAY': ':0', 16:05:34 INFO - 'HOME': '/home/cltbld', 16:05:34 INFO - 'LANG': 'en_US.UTF-8', 16:05:34 INFO - 'LANGUAGE': 'en_US:en', 16:05:34 INFO - 'LOGNAME': 'cltbld', 16:05:34 INFO - 'MAIL': '/var/mail/cltbld', 16:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:34 INFO - 'MOZ_NO_REMOTE': '1', 16:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:34 INFO - 'NO_EM_RESTART': '1', 16:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:34 INFO - 'PWD': '/builds/slave/test', 16:05:34 INFO - 'SHELL': '/bin/bash', 16:05:34 INFO - 'SHLVL': '1', 16:05:34 INFO - 'TERM': 'linux', 16:05:34 INFO - 'TMOUT': '86400', 16:05:34 INFO - 'USER': 'cltbld', 16:05:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:34 INFO - '_': '/tools/buildbot/bin/python'} 16:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:05:34 INFO - Cleaning up... 16:05:34 INFO - Return code: 0 16:05:34 INFO - Running post-action listener: _resource_record_post_action 16:05:34 INFO - Running post-action listener: _start_resource_monitoring 16:05:34 INFO - Starting resource monitoring. 16:05:34 INFO - [mozharness: 2016-08-05 23:05:34.373100Z] Finished create-virtualenv step (success) 16:05:34 INFO - [mozharness: 2016-08-05 23:05:34.373577Z] Running install step. 16:05:34 INFO - Running pre-action listener: _resource_record_pre_action 16:05:34 INFO - Running main action method: install 16:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:34 INFO - Reading from file tmpfile_stdout 16:05:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:34 INFO - Reading from file tmpfile_stdout 16:05:34 INFO - Output received: 16:05:34 INFO - Usage: mozinstall [options] installer 16:05:34 INFO - Options: 16:05:34 INFO - -h, --help show this help message and exit 16:05:34 INFO - -d DEST, --destination=DEST 16:05:34 INFO - Directory to install application into. [default: 16:05:34 INFO - "/builds/slave/test"] 16:05:34 INFO - --app=APP Application being installed. [default: firefox] 16:05:34 INFO - mkdir: /builds/slave/test/build/application 16:05:34 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'] 16:05:34 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 16:05:50 INFO - Reading from file tmpfile_stdout 16:05:50 INFO - Output received: 16:05:50 INFO - /builds/slave/test/build/application/firefox/firefox 16:05:50 INFO - Running post-action listener: _resource_record_post_action 16:05:50 INFO - [mozharness: 2016-08-05 23:05:50.837567Z] Finished install step (success) 16:05:50 INFO - [mozharness: 2016-08-05 23:05:50.837816Z] Running run-tests step. 16:05:50 INFO - Running pre-action listener: _resource_record_pre_action 16:05:50 INFO - Running main action method: run_tests 16:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:05:50 INFO - Python 2.7.3 16:05:50 INFO - Return code: 0 16:05:50 INFO - grabbing minidump binary from tooltool 16:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459570>, '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 0x145a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:05:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:05:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:05:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:05:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:05:50 INFO - Return code: 0 16:05:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:05:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:05:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:05:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:05:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 16:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 16:05:50 INFO - Using env: {'DISPLAY': ':0', 16:05:50 INFO - 'HOME': '/home/cltbld', 16:05:50 INFO - 'LANG': 'en_US.UTF-8', 16:05:50 INFO - 'LANGUAGE': 'en_US:en', 16:05:50 INFO - 'LOGNAME': 'cltbld', 16:05:50 INFO - 'MAIL': '/var/mail/cltbld', 16:05:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:05:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:50 INFO - 'MOZ_NO_REMOTE': '1', 16:05:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:50 INFO - 'NO_EM_RESTART': '1', 16:05:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:50 INFO - 'PWD': '/builds/slave/test', 16:05:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:05:50 INFO - 'SHELL': '/bin/bash', 16:05:50 INFO - 'SHLVL': '1', 16:05:50 INFO - 'TERM': 'linux', 16:05:50 INFO - 'TMOUT': '86400', 16:05:50 INFO - 'USER': 'cltbld', 16:05:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388', 16:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:50 INFO - '_': '/tools/buildbot/bin/python'} 16:05:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 16:05:51 INFO - mozversion application_buildid: 20160805140722 16:05:51 INFO - mozversion application_changeset: ba6d10b9a178a5700620a48b77b152908d4f8781 16:05:51 INFO - mozversion application_display_name: Nightly 16:05:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:51 INFO - mozversion application_name: Firefox 16:05:51 INFO - mozversion application_remotingname: firefox 16:05:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:05:51 INFO - mozversion application_vendor: Mozilla 16:05:51 INFO - mozversion application_version: 51.0a1 16:05:51 INFO - mozversion platform_buildid: 20160805140722 16:05:51 INFO - mozversion platform_changeset: ba6d10b9a178a5700620a48b77b152908d4f8781 16:05:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:05:51 INFO - mozversion platform_version: 51.0a1 16:05:51 INFO - using testdate: 1470438351 16:05:51 INFO - actual date: 1470438351 16:05:51 INFO - starting webserver on 'localhost:52595' 16:05:51 INFO - SUITE-START | Running 2 tests 16:05:51 INFO - TEST-START | dromaeo_css 16:05:51 INFO - operating with platform_type : linux_ 16:05:51 INFO - Initialising browser for dromaeo_css test... 16:05:51 INFO - TEST-INFO | started process 25986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkxzqA/profile http://localhost:52595/getInfo.html) 16:05:55 INFO - PROCESS | 25986 | __metrics Screen width/height:1600/1200 16:05:55 INFO - PROCESS | 25986 | colorDepth:24 16:05:55 INFO - PROCESS | 25986 | Browser inner width/height: 1024/697 16:05:55 INFO - PROCESS | 25986 | __metrics 16:05:56 ERROR - PROCESS | 25986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:05:57 INFO - TEST-INFO | 25986: exit 0 16:05:57 INFO - Browser initialized. 16:05:57 INFO - Running cycle 1/1 for dromaeo_css test... 16:05:57 INFO - TEST-INFO | started process 26105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkxzqA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:09 INFO - PROCESS | 26105 | RSS: Main: 165203968 16:06:09 INFO - PROCESS | 26105 | 16:06:59 INFO - PROCESS | 26105 | 1470438419193 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] 16:09:11 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52595/tests/dromaeo/cssquery-ext.html) 16:09:12 INFO - PROCESS | 26105 | RSS: Main: 166858752 16:09:12 INFO - PROCESS | 26105 | 16:12:15 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-ext.html (next: http://localhost:52595/tests/dromaeo/cssquery-jquery.html) 16:12:15 INFO - PROCESS | 26105 | RSS: Main: 166998016 16:12:15 INFO - PROCESS | 26105 | 16:15:17 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52595/tests/dromaeo/cssquery-mootools.html) 16:15:18 INFO - PROCESS | 26105 | RSS: Main: 169480192 16:15:18 INFO - PROCESS | 26105 | 16:18:20 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52595/tests/dromaeo/cssquery-prototype.html) 16:18:21 INFO - PROCESS | 26105 | RSS: Main: 164724736 16:18:21 INFO - PROCESS | 26105 | 16:21:24 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52595/tests/dromaeo/cssquery-yui.html) 16:21:24 INFO - PROCESS | 26105 | RSS: Main: 166313984 16:21:24 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | Cycle 1(1): loaded http://localhost:52595/tests/dromaeo/cssquery-yui.html (next: http://localhost:52595/tests/dromaeo/cssquery-dojo.html) 16:24:27 INFO - PROCESS | 26105 | RSS: Main: 169955328 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | __start_tp_report 16:24:27 INFO - PROCESS | 26105 | _x_x_mozilla_page_load 16:24:27 INFO - PROCESS | 26105 | _x_x_mozilla_page_load_details 16:24:27 INFO - PROCESS | 26105 | |i|pagename|runs| 16:24:27 INFO - PROCESS | 26105 | |0;dojo.html;2627.47450509898;2639.1158961747815;2640.524705553002;2662.8535430551324;2678.5044766718147;4587;4612.238980568206;4691.718496890185;4713.670043096985;4723.834665786698;4655.208614535529;4670.97664511677;4684.320773487842;4730.148573256813;4734.266188740742;4275.914481710372;4336.371226172203;4427.845025424111;4458.799354029076;4476.418065651477;4352.064306174172;4382.12357528494;4417.624501917341;4426.756528390937;4427.734335939837;4173.3114036184;4295.935560966588;4311.223979683656;4315.395844581761;4333.198358303708;4295.14097180562;4303.655707543389;4308.569143085698;4417.425734654506;4443.044745379759;4327.480702315711;4334.219840428722;4352.281873490871;4368.257396242647;4369.169857727054;4660.883477913046;4682.297655351725;4684.929726054112;4705.035467729107;4714.057188562301;5071.492850714936;5092.567131793802;5099.490050994871;5102.132637451642;5119.539241468248;5101.770420331094;5113.156329205676;5122.820701275437;5123;5123.513266239701;4719.410073740817;4738.573528382393;4756.143894099096;4783.880402989953;4829.806807727651;5190.97404512975;5232.73836308183;5236.450172731885;5238.240455133984;5295.099833028395;4744.905101897943;5022.296878437021;5027.321311622957;5028.899422011539;5031.622628302892;4878;4973.726445045557;4977.054359671651;5018.4730603286125;5039.546440820271;4970.652054356233;4988.925166122511;5016.774245158977;5039.244113383022;5045.41977672565;4976.303317535548;4998.2502624606595;4999.825006124768;5013.147764879979;5053.444121146671;4101.487314085739;4221.261279276115;4245.299525578307;4258.87223383299;4259.914801703949;3734.7012239020814;3734.9066273343383;3743.344914639927;3776.754510956779;3778;4384.583464570861;4400.801963911567;4418.182636212311;4441.533638967927;4448.733076015449;4900.117978763857;4941.382327209099;4969.552740253394;4983.800647974041;5109.718965456936;4333.978330108329;4335.913281734348;4348.021695118573;4362.781860906942;4382.517923028464;4473.932891006638;4497.9325310120375;4498.257787465097;4498.347739577743;4556.544345565483;4577.725336479822;4768.7615619218905;4774.30772537987;4797.472278049481;4802.903941921212;5112.565431938327;5123.487651234846;5126.154184559506;5126.820561280338;5180.197069454241;4807.471178170328;4820.2287633979795;4835.226363781778;4841.394825646794;4858.955324605226;4818;4918.1393256180745;4919.852404427873;4921.778519966539;5101.20931255656;5012.6240531960975;5014.398272207359;5018.598512119095;5028.1200789860895;5035.748212589429;4878.243872199815;4883.731394773322;4894.241392584155;4896.387951506062;4906.067847109038;4692.061587682545;4842.080004799077;4859.343988561641;4889;4941.135301322182;4782.641301902302;4836.95163048365;4896.6572339935865;4914.8771280718265;4931.7040977541465;4978.551930326288;4980.352554167935;4992.950070499249;5006.299118123393;5023.773930173078;4680.063987202641;4804.567588917014;4849.80600775965;4859.2954021667365;4907.435644900882 16:24:27 INFO - PROCESS | 26105 | |1;ext.html;560.834553806627;561.2199043329772;570.1732487892557;581.7527550790916;595.627732667083;35363.823180884094;38906;39020.82937511872;39284.01789955253;39359.21281574367;38906.22187556247;39474.210515789666;39631.80184099075;39748.205035899264;39770.403443948366;7701.114371847253;7796.41526885483;7869.331106855924;7875.763727088197;7883.645235964366;7728.7681369559;7811.765647030598;7815.687372505122;7822.726204582841;7845.568493732842;7843.686252549891;7861.056673199224;7867.881981770278;7904.446688731791;7910.248526389983;7763.72826951054;7804.414668899827;7813.140554538996;7857.253560911704;7862.449628525948;7729.420293478011;7854.528728276322;7854.764357069297;7863.606819658994;7877.527348359117;37833.24333513314;38518.037049073995;38528.614713853065;38543;38605.227895442215;2457.668214791016;2806.1441260415563;2896.3772788850497;2950.822950622948;3061.3112049788842;26105.477890442275;27461.31346716328;27994;28412.857935710188;28734.137975860758;2965.0660042086674;3277.1970867137466;3315.9171020724434;3386.9153271168416;3403.7617366784334;268358;270249;271029.6448517764;272092;273013;31857.84071079676;33107.172320691694;55929.7203513988;56449.15326270109;56495.37312462847;33960.32079358399;33989;34209.48685769716;34246.31507369839;34361.656383435846;12943.935280323727;13040.282784446757;13106.541271055466;13124.540641077516;13131.803022954664;11292.040176585082;11375.26060806045;11392.715182120513;11395.886041139649;11419.257748246504;7822.413319001098;7833.7466005438855;7883.842323153504;7929.286364227247;7943.682252709827;3103.4568950434036;3112.4553203189353;3116.766242531819;3151.8739250430185;3154.6056742907135;856.1823458597025;872.2803686958284;886.2289807867068;957.1337939165066;973.8247115519133;28196.43607127846;28934.855325723238;28955.42089158205;29116.41767164645;29498.115056548337;935.9251259899191;1014.2798612984716;1015.2994433840627;1017.811704834608;1021.5862575656871;14749.483768068067;15406.866935724207;15474.458393956382;15529.378824847106;15606.609834754221;376552;379762;380144;380716;382259;50938.23592646113;50956.49043509592;51139.74430127825;51146.74426627843;51399.48600513947;1088.5972190289644;1110.6945589962663;1120.394986707169;1155.3760969076604;1157.5543415784814;27274.590881137196;28336.85831570829;28916.855415722788;28944.131676049754;29102.417951641273;44057.55942440663;44357.33463997978;44381;44384;44452.777736111115;315161;317316;317643;317851;318092;25297.343778903687;25827.225183244533;27674;27764.30589235285;27973.160805175878;41926.37110443407;42260.788696057556;42544.78727606342;42587.148257035304;43138.78430607827;36706.4494032595;37104.44343334798;37336.43995340018;37693.01452228277;38467.80766096264;37384.252314954094;37522.81238593899;37831.43252851265;38012;38261.617383825804;34682.47976280408;36175.81912090423;36468.81765591155;39130;39361.606383935796;32153.35693286168;34407.65592344045;34425;34808.82595587006;34861.30277394387;26039.73960260373;26374.86812565925;26440.603390948767;26583.69570650257;26686 16:24:27 INFO - PROCESS | 26105 | |2;jquery.html;359.2169071424294;360.67178867230825;362.9183433727411;378.6213786213786;384.552324454845;15973.760393594092;16895.408660696863;17721.556961075963;17873.82126178738;17914.193861276242;16112.516624501255;16788.328466861312;17458.21438035288;17544;17591.208395622227;4946.282788995593;5125.615578831584;5167.302414174076;5172.586193104543;5173.146430838926;3797.164623782777;5177.171652535595;5748.770049198027;6028.0957856321465;6076.6050206736645;6065.757369705207;6079.148919151322;6117.785877494289;6123.081537769348;6139.662318572477;5000.32495613093;5251.973740131294;5295.258663787073;5309.681419114865;5348.946510534884;5055.064813009605;5201.375834899836;5333.626646134772;5387.461253874581;5443.972780136113;12502.562410315686;12538.435770390355;12548;12563.937180314131;12652.493900243979;1853.1753369750465;1878.924843006278;1945.2705235536673;2050.0672194151625;2219.212179676224;9214;9263;9292.070792920722;9501.524923753785;9539.52302384878;1682.6887025900248;1692.7968643762704;1736.5398169485097;1767.646470705864;1778.439791465697;70431;72322.63838680825;73049;74373;75306;9933.900660993297;10125.696229113139;10218.489075546193;10402.167826573856;10488.947555262328;14208.289585520683;14208.715825683428;14235;14247.145171289756;14303.927205459424;7446.925530744623;7556.1310449299035;7582.203868593829;7693;7758.456908016385;6954.79135625932;6994.265602111806;7134.357907788324;7213.89179162313;7387.630618469055;4251.252469224006;4328.567143285646;4363.2800587903275;4423.60187583119;4482.125985432809;1446.464808021039;1488.9329980150703;1518.772184172361;1782.3316256403848;1881.7647794025747;798.8961435013412;843.0389356134012;894.7628878347243;917.788908551037;927.6614035876856;16836;16956;17419.303227870743;17688.55778605545;17789;802.2138304461661;859.9226069653636;861.388414225894;888.5690440136528;900.8603666431713;9255.352125351295;9276.257899368034;9277.536123193813;9305.209057230077;9442.10300021497;346311;346435;362406;371038;378773;73658.63170684113;75205.24794752093;75325.62337188279;76794;80198;887.1793590928365;889.7731078574922;915.9954200228956;919.3977944446399;921.138735282513;14269.785953210918;15245.771313430085;15397.769033464283;15556.455524056604;15846.207689615243;34687;35977.64022359743;36951.44572831463;37101.6289837109;37900.81049594845;52967;53961.19058214209;54096.45903540914;55752;56133.43866561282;6897.827554311182;7333;7359.264073592598;7462.514936529108;7516.285952834472;7787.92212077872;10169.89830101719;10960.12319014461;11258.211925165488;11708.297502149899;9613.855792163264;9763.121319081316;10028.348157369748;10082.29423940317;10266.743331416774;10240.385576865412;10396.324238924446;10432.843507347548;10577.788444231226;10679.359238445408;9443.754767495688;9513.66702165421;9550.474723889974;9651.179649729851;9862.901370986485;6252.812415627538;7384.741534046498;7689.269519395649;7692;7729.4202934779;7766.766996990099;9351.205147562534;9732.708018759165;9995.70012899614;10261.640842570474 16:24:27 INFO - PROCESS | 26105 | |3;mootools.html;1406.542873566091;1423.3025817349499;1514.409380341667;1658.1263172614943;1700.030982340066;6747.12287402637;7288.234735352791;7539.811504712371;8054.718084867023;8060.919390806091;7620.390368770499;7945.801354966129;7963.248085421213;7988.121306656263;7993.360531157508;2121.798429149232;2129.339904629562;2133.168064454856;2138.4012476506605;2141.8607790493647;2097.7063211150453;2135.7757435469284;2179.095675294751;2181.1711549611127;2182.1053368119074;2157.1587081038406;2166.144372972675;2171.7176767020264;2173.880436575988;2177.9455513612206;2042.4893776555862;2050.4668786115644;2053.835693144545;2054.1680619349186;2054.7739748627714;2007.3977806657945;2076.646970015101;2084.291340944086;2094.6124966881175;2105.26315789474;7960.522368657841;8002.759917202493;8016.158303378178;8026.277635012819;8040.557769322685;4382.233109205877;4510.548945105496;4515.774211289455;4519.841805536823;4521.728696278201;2759.5860620906824;2793.9441211175867;2856.7714582833323;2940.794144409892;2966.8961586344376;843.4475418600827;863.6977058029702;868.405142477405;889.204162274767;890.6615486115235;10559.41923194224;10618.681439556749;10684.679459616145;10717.892821071768;10722.571097156104;3779.1874746929543;3964.7621142731527;4062.111118329991;4063.2076745035024;4088.6115818997146;8901.866472002925;8949.418287811272;8960.910390896139;9153.084691530794;9158.40470369424;4414.602685758297;4430.800613972379;4441.711288766284;4442.444694413199;4442.73343599385;3436.415809312423;3850.8652197173524;3972.2651309507833;4000.3399439092805;4005.459262999516;3562.5368702068563;3601.891943241707;3710.777353358807;3732.794696291676;3752.75607085544;1153.8903804138592;1155.381870699172;1158.3397463445924;1173.3957012138756;1177.4407156600716;857.2499063319596;867.648602316063;886.259972922604;887.4630848336664;892.723255790707;5467.316585426822;5494.890102198014;5541.5843811714285;5756.510696590753;5798.797042103506;892.4689809563299;932.9626814927462;979.1383582447401;980.4215512847454;980.597954838527;3568.589612194579;3708.42519409492;3808.8666896658483;3810.599887011879;3846.288436639231;9321.766955826159;9663.661771837951;9670.70987870365;9713.562889669982;9746.9025309746;9562.426254424758;9652.083052110038;9658.468784216795;9674.22606191503;9683.080107389927;6868;7049.68276427562;7070.434365250768;7368.557886526718;7375.594342311224;5521.812810245817;5643.984082865124;5734.7132643368495;5792.362840087671;5870.706464676664;8728.345374096842;8889.4666320021;8948.776280593038;8980.191782739585;8996.325275604226;9019.639214431612;9132.771680708036;9233.492157931378;9266.583003764981;9323.207527359978;6087.695615219132;6644.83387915306;6674.132362792806;6695.263521012782;6816.795496135124;7537.057867766529;7593.848123037619;7605.543667379754;7630.1606823248285;7636.08366995964;6651.368120028589;6752.696128674123;6763.086983257394;6790.7623233186605;7025.086738723933;6446.8388290293115;6518.250401203923;6676.165479315086;6702.798916032527;6834.2482326943;6502.967485162544;6547.214334279917;6550.115734375799;6552.443042341264;6570.441512471493;4360.651147908096;4363.54182810813;4384;4511.3458548509625;4515.322701594787;4502.122086193161;4534.569215924482;4570.337301091389;4629.398178236807;4696.835610753607 16:24:27 INFO - PROCESS | 26105 | |4;prototype.html;297.7231175007243;301.3520930000499;301.49499588189775;304.5918469251203;306.78371747917714;4876.146674331991;4969.527894849988;4970.850874473763;4982.754311422144;5012.924806127911;4910.803567857291;4921.80312787488;4935.950640493594;4943.555080042795;4963.950360496394;3699.7595156314756;3761.7178711596603;3846.0961674006585;3857.787821669807;3862.748921320105;3843.577206507282;3855.51806024247;3858.84564617415;3869.8452061917487;3876.1666241758016;3830.731848770587;3840.1743625120594;3846.769193848378;3879.262940041397;3880.5149356330458;3760.7179461540495;3828.25349056934;3846.442265871461;3874.670652994485;3874.9225015499815;3395.422778127724;3396;3400.846961886696;3408.1309266137223;3428.2629234714404;4783.641226907996;4802.879928001793;4805.639577031737;4811.927821082687;4840.927386089212;4405.1850407674365;4410.448693913261;4413.8234470621455;4433.290673492225;4470.776461176928;4920.729359885205;5144.588432925357;5161.29677206521;5179;5189.143791274435;3676.6690997810324;3678.1540245743363;3680.429533422324;3686.8525258989876;3689.8524059037604;5430.8099216527235;5440.292761940962;5441.673499589998;5450.645708029005;5456.508914197701;3637.7635453695425;3670.3943849265106;3688.2070354873294;3701.4632878232505;3718.3307004738867;3754.136548593784;3773.1699026214737;3779.543296857065;3790.1093243087853;3796.5823759386444;4314.288142456459;4326.718763280377;4350.825966961286;4357.651387888961;4383.824647014084;5022.347094877716;5175.404828444702;5209.713465759344;5221.530062294411;5291.470852914677;1278.130871007705;1291.6835375333103;1297.1049975516862;1297.3902265935185;1298.2924306253115;809.6639894443857;840.4621042532784;848.3382961290204;851.5614458553849;861.9224269815746;4343.414653651457;4381.518033016366;4561.1492816989385;4570.085982803453;4582.427196600425;5385.299911011543;5390.460953904657;5395.973020134953;5398;5412.673894895775;4541.636669066466;4566.949601591586;4579.313103034571;4579.473360563511;4586.312053192048;2656.5483867742146;2805.2285621453857;2842.275219818933;2843.4881721289953;2845.061129827152;4987.179679416987;5031.22016087507;5035.144025515671;5049.318342023853;5050;5297.364316282071;5471.398146203915;5492.423295553909;5507.201455788888;5510.972445137749;5002.74986250686;5010.5240002199735;5034.471380505068;5048.16705243638;5066.4680208577565;5407.567394608343;5408.3509978802795;5410.78356865721;5415.756290966837;5433.8369848904595;5066.9746651266505;5217.321748172713;5259.237410575522;5281.392639846466;5311.468853114812;5014.893744627192;5035;5037.722925239001;5038.622103342191;5068.442471328077;3428.3143371325336;3459.636738142459;3468.705160061322;3480.6157781919464;3488.8430020648625;4564.88587785308;4735.692180008288;4817.397825271841;4834.147852766884;4862.92705609409;4576.931346029745;4611.861644150681;4634.675572710013;4642.53574642533;4667.579917807414;4594.7702614869795;4616.6075883550275;4622.098690755271;4665.346851440733;4672.836450724209;4563.322594340827;4570.565796249351;4599.5400459953735;4671.271629497108;4738.31294462308;5003;5091.236314552699;5192.402873669425;5230.869228269324;5236.952609478196;5102.821401250939;5108.872278193075;5118.181091025418;5138.07514647367;5143.254228136974 16:24:27 INFO - PROCESS | 26105 | |5;yui.html;630.464105510316;642.7493277621726;658.187138883479;726.3462883404935;747.7158679701711;10960.12319014479;11617.070634349253;11623.941880290608;11654;11670.299782013086;13007.34963251836;13143.079984401096;13150.868491315085;13268.469261229564;13315.866841331608;622.1787240842091;755.2824816424405;757.8067592763838;768.8039549914764;778.4861991085885;768.642581199742;773.3542492019143;776.5496012312846;776.7553220735479;777.4790890103644;832.1304237072244;833.2792134803382;834.0783434305097;834.1325021977136;835.0146826744439;819.8565251081037;825.5376988886213;828.1428721273484;828.8135169586825;829.3821103278036;603.8490377405649;603.9003564411867;606.4844881850391;609.7926704920349;610.5237914426755;12647.87352126476;12659.936700316532;12682.682932926658;12689.365531723377;12717.936410317889;13668.179909205479;13841.446342146402;13999.440022399092;14304.356303966346;14385;10026.849597255974;10149.594016239342;10252;10320.79358412835;10437.947810260976;3183.761217908643;3290.3090351026312;3372.37611041958;3465.220325426784;3470.826458677056;61585.6920715398;62771;62777.058344124875;65292.67353663249;65698.3430165697;10254.846177307347;10315.765368857614;10369.844452333222;10489.685309440729;10521.684349469528;18154.455366339032;18309.816901831076;18363.72454413185;18367.35714249995;18435.631287374177;6712.060311556386;6719.227288861745;6792.150981127359;6832.59004459734;6916.446684265246;3504.6144924058335;3656.5612126544984;3726.925461490809;3764.4249900516875;3894.1043559980794;2985.477541430241;3066.8006579572257;3090.8300043497375;3094.2883136878195;3100.8449577521483;499.51796516361884;503.6147347279334;506.98479045627954;514.0490093327314;515.7395515264842;486.5888324365905;566.4505429733152;596.2100217212125;596.6420147911306;607.2136583124864;8240.13478584752;8530.616122274512;8788.714934117175;8796.736097917073;8903.777405564913;491.76395330241684;521.4889408379809;578.1270281874316;615.1142355008863;615.7875532941129;3912.295786758411;4016.779077150785;4105.89735256615;4165.645920096765;4184.372344148342;71232.64383678048;94989;100194;101643;103381.48309258556;87066;89937;95980;96213.26507144433;96347;77536.61231693918;78747;80499.59750201095;80892.19107808964;81141.59429202935;7639.541627502367;7850.528968261922;7958;7979.9601001994615;8055.194480551898;42736.87157541115;46258.30612540747;47385.52614473811;47584.286235707186;48216.27675584799;51525.7423712879;66972;67197.66401168158;68049;69633.30366696269;9724.562394692397;10238.385696858213;10333.34666453364;10341.586336546454;10410.739731506774;10767.946160269148;10838.078763305208;11136.610218642309;11168.106551476025;11173.888261117285;10959.726006849893;11022.890235798026;11209.495572699085;11260.831087533857;11338.489767960627;10652.147828173573;10672;10686.83969740439;10806.35161890289;10814.675559733221;10295.94852025735;10807.729806754895;12105.576304829288;12339;12542.937285313516;9622.278329125484;9658.263639390392;10111.494425278854;10461.843072354073;10775.515101820594;10387.792244155225;10419.843702344622;10510.421926793793;10673.199510036933;10738.892611073788 16:24:27 INFO - PROCESS | 26105 | __end_tp_report 16:24:27 INFO - PROCESS | 26105 | __start_cc_report 16:24:27 INFO - PROCESS | 26105 | _x_x_mozilla_cycle_collect,397 16:24:27 INFO - PROCESS | 26105 | __end_cc_report 16:24:27 INFO - PROCESS | 26105 | __startTimestamp1470439467474__endTimestamp 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | ------- Summary: start ------- 16:24:27 INFO - PROCESS | 26105 | Number of tests: 6 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#0] dojo.html Cycles:165 Average:4666.52 Median:4802.90 stddev:488.21 (10.2%) stddev-sans-first:462.76 16:24:27 INFO - PROCESS | 26105 | Values: 2627.5 2639.1 2640.5 2662.9 2678.5 4587.0 4612.2 4691.7 4713.7 4723.8 4655.2 4671.0 4684.3 4730.1 4734.3 4275.9 4336.4 4427.8 4458.8 4476.4 4352.1 4382.1 4417.6 4426.8 4427.7 4173.3 4295.9 4311.2 4315.4 4333.2 4295.1 4303.7 4308.6 4417.4 4443.0 4327.5 4334.2 4352.3 4368.3 4369.2 4660.9 4682.3 4684.9 4705.0 4714.1 5071.5 5092.6 5099.5 5102.1 5119.5 5101.8 5113.2 5122.8 5123.0 5123.5 4719.4 4738.6 4756.1 4783.9 4829.8 5191.0 5232.7 5236.5 5238.2 5295.1 4744.9 5022.3 5027.3 5028.9 5031.6 4878.0 4973.7 4977.1 5018.5 5039.5 4970.7 4988.9 5016.8 5039.2 5045.4 4976.3 4998.3 4999.8 5013.1 5053.4 4101.5 4221.3 4245.3 4258.9 4259.9 3734.7 3734.9 3743.3 3776.8 3778.0 4384.6 4400.8 4418.2 4441.5 4448.7 4900.1 4941.4 4969.6 4983.8 5109.7 4334.0 4335.9 4348.0 4362.8 4382.5 4473.9 4497.9 4498.3 4498.3 4556.5 4577.7 4768.8 4774.3 4797.5 4802.9 5112.6 5123.5 5126.2 5126.8 5180.2 4807.5 4820.2 4835.2 4841.4 4859.0 4818.0 4918.1 4919.9 4921.8 5101.2 5012.6 5014.4 5018.6 5028.1 5035.7 4878.2 4883.7 4894.2 4896.4 4906.1 4692.1 4842.1 4859.3 4889.0 4941.1 4782.6 4837.0 4896.7 4914.9 4931.7 4978.6 4980.4 4993.0 5006.3 5023.8 4680.1 4804.6 4849.8 4859.3 4907.4 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#1] ext.html Cycles:180 Average:46888.23 Median:36905.45 stddev:85835.07 (232.6%) stddev-sans-first:86005.39 16:24:27 INFO - PROCESS | 26105 | Values: 560.8 561.2 570.2 581.8 595.6 35363.8 38906.0 39020.8 39284.0 39359.2 38906.2 39474.2 39631.8 39748.2 39770.4 7701.1 7796.4 7869.3 7875.8 7883.6 7728.8 7811.8 7815.7 7822.7 7845.6 7843.7 7861.1 7867.9 7904.4 7910.2 7763.7 7804.4 7813.1 7857.3 7862.4 7729.4 7854.5 7854.8 7863.6 7877.5 37833.2 38518.0 38528.6 38543.0 38605.2 2457.7 2806.1 2896.4 2950.8 3061.3 26105.5 27461.3 27994.0 28412.9 28734.1 2965.1 3277.2 3315.9 3386.9 3403.8 268358.0 270249.0 271029.6 272092.0 273013.0 31857.8 33107.2 55929.7 56449.2 56495.4 33960.3 33989.0 34209.5 34246.3 34361.7 12943.9 13040.3 13106.5 13124.5 13131.8 11292.0 11375.3 11392.7 11395.9 11419.3 7822.4 7833.7 7883.8 7929.3 7943.7 3103.5 3112.5 3116.8 3151.9 3154.6 856.2 872.3 886.2 957.1 973.8 28196.4 28934.9 28955.4 29116.4 29498.1 935.9 1014.3 1015.3 1017.8 1021.6 14749.5 15406.9 15474.5 15529.4 15606.6 376552.0 379762.0 380144.0 380716.0 382259.0 50938.2 50956.5 51139.7 51146.7 51399.5 1088.6 1110.7 1120.4 1155.4 1157.6 27274.6 28336.9 28916.9 28944.1 29102.4 44057.6 44357.3 44381.0 44384.0 44452.8 315161.0 317316.0 317643.0 317851.0 318092.0 25297.3 25827.2 27674.0 27764.3 27973.2 41926.4 42260.8 42544.8 42587.1 43138.8 36706.4 37104.4 37336.4 37693.0 38467.8 37384.3 37522.8 37831.4 38012.0 38261.6 34682.5 36175.8 36468.8 39130.0 39361.6 32153.4 34407.7 34425.0 34808.8 34861.3 26039.7 26374.9 26440.6 26583.7 26686.0 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#2] jquery.html Cycles:180 Average:23421.80 Median:5189.27 stddev:59999.17 (1156.2%) stddev-sans-first:60142.50 16:24:27 INFO - PROCESS | 26105 | Values: 359.2 360.7 362.9 378.6 384.6 15973.8 16895.4 17721.6 17873.8 17914.2 16112.5 16788.3 17458.2 17544.0 17591.2 4946.3 5125.6 5167.3 5172.6 5173.1 3797.2 5177.2 5748.8 6028.1 6076.6 6065.8 6079.1 6117.8 6123.1 6139.7 5000.3 5252.0 5295.3 5309.7 5348.9 5055.1 5201.4 5333.6 5387.5 5444.0 12502.6 12538.4 12548.0 12563.9 12652.5 1853.2 1878.9 1945.3 2050.1 2219.2 9214.0 9263.0 9292.1 9501.5 9539.5 1682.7 1692.8 1736.5 1767.6 1778.4 70431.0 72322.6 73049.0 74373.0 75306.0 9933.9 10125.7 10218.5 10402.2 10488.9 14208.3 14208.7 14235.0 14247.1 14303.9 7446.9 7556.1 7582.2 7693.0 7758.5 6954.8 6994.3 7134.4 7213.9 7387.6 4251.3 4328.6 4363.3 4423.6 4482.1 1446.5 1488.9 1518.8 1782.3 1881.8 798.9 843.0 894.8 917.8 927.7 16836.0 16956.0 17419.3 17688.6 17789.0 802.2 859.9 861.4 888.6 900.9 9255.4 9276.3 9277.5 9305.2 9442.1 346311.0 346435.0 362406.0 371038.0 378773.0 73658.6 75205.2 75325.6 76794.0 80198.0 887.2 889.8 916.0 919.4 921.1 14269.8 15245.8 15397.8 15556.5 15846.2 34687.0 35977.6 36951.4 37101.6 37900.8 52967.0 53961.2 54096.5 55752.0 56133.4 6897.8 7333.0 7359.3 7462.5 7516.3 7787.9 10169.9 10960.1 11258.2 11708.3 9613.9 9763.1 10028.3 10082.3 10266.7 10240.4 10396.3 10432.8 10577.8 10679.4 9443.8 9513.7 9550.5 9651.2 9862.9 6252.8 7384.7 7689.3 7692.0 7729.4 7766.8 9351.2 9732.7 9995.7 10261.6 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#3] mootools.html Cycles:180 Average:5144.34 Median:5745.61 stddev:2899.16 (50.5%) stddev-sans-first:2893.69 16:24:27 INFO - PROCESS | 26105 | Values: 1406.5 1423.3 1514.4 1658.1 1700.0 6747.1 7288.2 7539.8 8054.7 8060.9 7620.4 7945.8 7963.2 7988.1 7993.4 2121.8 2129.3 2133.2 2138.4 2141.9 2097.7 2135.8 2179.1 2181.2 2182.1 2157.2 2166.1 2171.7 2173.9 2177.9 2042.5 2050.5 2053.8 2054.2 2054.8 2007.4 2076.6 2084.3 2094.6 2105.3 7960.5 8002.8 8016.2 8026.3 8040.6 4382.2 4510.5 4515.8 4519.8 4521.7 2759.6 2793.9 2856.8 2940.8 2966.9 843.4 863.7 868.4 889.2 890.7 10559.4 10618.7 10684.7 10717.9 10722.6 3779.2 3964.8 4062.1 4063.2 4088.6 8901.9 8949.4 8960.9 9153.1 9158.4 4414.6 4430.8 4441.7 4442.4 4442.7 3436.4 3850.9 3972.3 4000.3 4005.5 3562.5 3601.9 3710.8 3732.8 3752.8 1153.9 1155.4 1158.3 1173.4 1177.4 857.2 867.6 886.3 887.5 892.7 5467.3 5494.9 5541.6 5756.5 5798.8 892.5 933.0 979.1 980.4 980.6 3568.6 3708.4 3808.9 3810.6 3846.3 9321.8 9663.7 9670.7 9713.6 9746.9 9562.4 9652.1 9658.5 9674.2 9683.1 6868.0 7049.7 7070.4 7368.6 7375.6 5521.8 5644.0 5734.7 5792.4 5870.7 8728.3 8889.5 8948.8 8980.2 8996.3 9019.6 9132.8 9233.5 9266.6 9323.2 6087.7 6644.8 6674.1 6695.3 6816.8 7537.1 7593.8 7605.5 7630.2 7636.1 6651.4 6752.7 6763.1 6790.8 7025.1 6446.8 6518.3 6676.2 6702.8 6834.2 6503.0 6547.2 6550.1 6552.4 6570.4 4360.7 4363.5 4384.0 4511.3 4515.3 4502.1 4534.6 4570.3 4629.4 4696.8 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#4] prototype.html Cycles:180 Average:4233.84 Median:4653.94 stddev:1236.48 (26.6%) stddev-sans-first:1204.14 16:24:27 INFO - PROCESS | 26105 | Values: 297.7 301.4 301.5 304.6 306.8 4876.1 4969.5 4970.9 4982.8 5012.9 4910.8 4921.8 4936.0 4943.6 4964.0 3699.8 3761.7 3846.1 3857.8 3862.7 3843.6 3855.5 3858.8 3869.8 3876.2 3830.7 3840.2 3846.8 3879.3 3880.5 3760.7 3828.3 3846.4 3874.7 3874.9 3395.4 3396.0 3400.8 3408.1 3428.3 4783.6 4802.9 4805.6 4811.9 4840.9 4405.2 4410.4 4413.8 4433.3 4470.8 4920.7 5144.6 5161.3 5179.0 5189.1 3676.7 3678.2 3680.4 3686.9 3689.9 5430.8 5440.3 5441.7 5450.6 5456.5 3637.8 3670.4 3688.2 3701.5 3718.3 3754.1 3773.2 3779.5 3790.1 3796.6 4314.3 4326.7 4350.8 4357.7 4383.8 5022.3 5175.4 5209.7 5221.5 5291.5 1278.1 1291.7 1297.1 1297.4 1298.3 809.7 840.5 848.3 851.6 861.9 4343.4 4381.5 4561.1 4570.1 4582.4 5385.3 5390.5 5396.0 5398.0 5412.7 4541.6 4566.9 4579.3 4579.5 4586.3 2656.5 2805.2 2842.3 2843.5 2845.1 4987.2 5031.2 5035.1 5049.3 5050.0 5297.4 5471.4 5492.4 5507.2 5511.0 5002.7 5010.5 5034.5 5048.2 5066.5 5407.6 5408.4 5410.8 5415.8 5433.8 5067.0 5217.3 5259.2 5281.4 5311.5 5014.9 5035.0 5037.7 5038.6 5068.4 3428.3 3459.6 3468.7 3480.6 3488.8 4564.9 4735.7 4817.4 4834.1 4862.9 4576.9 4611.9 4634.7 4642.5 4667.6 4594.8 4616.6 4622.1 4665.3 4672.8 4563.3 4570.6 4599.5 4671.3 4738.3 5003.0 5091.2 5192.4 5230.9 5237.0 5102.8 5108.9 5118.2 5138.1 5143.3 16:24:27 INFO - PROCESS | 26105 | 16:24:27 INFO - PROCESS | 26105 | [#5] yui.html Cycles:180 Average:18091.93 Median:44497.59 stddev:26425.98 (59.4%) stddev-sans-first:26467.59 16:24:27 INFO - PROCESS | 26105 | Values: 630.5 642.7 658.2 726.3 747.7 10960.1 11617.1 11623.9 11654.0 11670.3 13007.3 13143.1 13150.9 13268.5 13315.9 622.2 755.3 757.8 768.8 778.5 768.6 773.4 776.5 776.8 777.5 832.1 833.3 834.1 834.1 835.0 819.9 825.5 828.1 828.8 829.4 603.8 603.9 606.5 609.8 610.5 12647.9 12659.9 12682.7 12689.4 12717.9 13668.2 13841.4 13999.4 14304.4 14385.0 10026.8 10149.6 10252.0 10320.8 10437.9 3183.8 3290.3 3372.4 3465.2 3470.8 61585.7 62771.0 62777.1 65292.7 65698.3 10254.8 10315.8 10369.8 10489.7 10521.7 18154.5 18309.8 18363.7 18367.4 18435.6 6712.1 6719.2 6792.2 6832.6 6916.4 3504.6 3656.6 3726.9 3764.4 3894.1 2985.5 3066.8 3090.8 3094.3 3100.8 499.5 503.6 507.0 514.0 515.7 486.6 566.5 596.2 596.6 607.2 8240.1 8530.6 8788.7 8796.7 8903.8 491.8 521.5 578.1 615.1 615.8 3912.3 4016.8 4105.9 4165.6 4184.4 71232.6 94989.0 100194.0 101643.0 103381.5 87066.0 89937.0 95980.0 96213.3 96347.0 77536.6 78747.0 80499.6 80892.2 81141.6 7639.5 7850.5 7958.0 7980.0 8055.2 42736.9 46258.3 47385.5 47584.3 48216.3 51525.7 66972.0 67197.7 68049.0 69633.3 9724.6 10238.4 10333.3 10341.6 10410.7 10767.9 10838.1 11136.6 11168.1 11173.9 10959.7 11022.9 11209.5 11260.8 11338.5 10652.1 10672.0 10686.8 10806.4 10814.7 10295.9 10807.7 12105.6 12339.0 12542.9 9622.3 9658.3 10111.5 10461.8 10775.5 10387.8 10419.8 10510.4 10673.2 10738.9 16:24:27 INFO - PROCESS | 26105 | -------- Summary: end -------- 16:24:27 INFO - PROCESS | 26105 | 16:24:28 INFO - TEST-INFO | 26105: exit 0 16:24:28 INFO - TEST-OK | dromaeo_css | took 1117195ms 16:24:28 INFO - TEST-START | kraken 16:24:28 INFO - operating with platform_type : linux_ 16:24:28 INFO - Initialising browser for kraken test... 16:24:28 INFO - TEST-INFO | started process 26351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpduL71k/profile http://localhost:52595/getInfo.html) 16:24:32 INFO - PROCESS | 26351 | __metrics Screen width/height:1600/1200 16:24:32 INFO - PROCESS | 26351 | colorDepth:24 16:24:32 INFO - PROCESS | 26351 | Browser inner width/height: 1024/697 16:24:32 INFO - PROCESS | 26351 | __metrics 16:24:33 ERROR - PROCESS | 26351 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:24:34 INFO - TEST-INFO | 26351: exit 0 16:24:34 INFO - Browser initialized. 16:24:34 INFO - Running cycle 1/1 for kraken test... 16:24:34 INFO - TEST-INFO | started process 26470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpduL71k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:46 INFO - PROCESS | 26470 | RSS: Main: 165208064 16:24:46 INFO - PROCESS | 26470 | 16:24:49 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52595/tests/kraken/driver.html?testName=audio-beat-detection) 16:24:50 INFO - PROCESS | 26470 | RSS: Main: 170516480 16:24:50 INFO - PROCESS | 26470 | 16:24:53 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52595/tests/kraken/driver.html?testName=audio-dft) 16:24:53 INFO - PROCESS | 26470 | RSS: Main: 169324544 16:24:53 INFO - PROCESS | 26470 | 16:24:56 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52595/tests/kraken/driver.html?testName=audio-fft) 16:24:57 INFO - PROCESS | 26470 | RSS: Main: 165031936 16:24:57 INFO - PROCESS | 26470 | 16:24:59 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52595/tests/kraken/driver.html?testName=audio-oscillator) 16:25:00 INFO - PROCESS | 26470 | RSS: Main: 165507072 16:25:00 INFO - PROCESS | 26470 | 16:25:02 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:02 INFO - PROCESS | 26470 | RSS: Main: 165920768 16:25:02 INFO - PROCESS | 26470 | 16:25:06 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52595/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:06 INFO - PROCESS | 26470 | RSS: Main: 166699008 16:25:06 INFO - PROCESS | 26470 | 16:25:10 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52595/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:10 INFO - PROCESS | 26470 | RSS: Main: 164012032 16:25:10 INFO - PROCESS | 26470 | 16:25:13 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52595/tests/kraken/driver.html?testName=json-parse-financial) 16:25:14 INFO - PROCESS | 26470 | RSS: Main: 165191680 16:25:14 INFO - PROCESS | 26470 | 16:25:16 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:16 INFO - PROCESS | 26470 | RSS: Main: 165380096 16:25:16 INFO - PROCESS | 26470 | 16:25:18 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:19 INFO - PROCESS | 26470 | RSS: Main: 165535744 16:25:19 INFO - PROCESS | 26470 | 16:25:21 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:22 INFO - PROCESS | 26470 | RSS: Main: 165863424 16:25:22 INFO - PROCESS | 26470 | 16:25:25 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:25 INFO - PROCESS | 26470 | RSS: Main: 167165952 16:25:25 INFO - PROCESS | 26470 | 16:25:28 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:29 INFO - PROCESS | 26470 | RSS: Main: 166346752 16:25:29 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | Cycle 1(1): loaded http://localhost:52595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52595/tests/kraken/driver.html?testName=ai-astar) 16:25:31 INFO - PROCESS | 26470 | RSS: Main: 167456768 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | __start_tp_report 16:25:31 INFO - PROCESS | 26470 | _x_x_mozilla_page_load 16:25:31 INFO - PROCESS | 26470 | _x_x_mozilla_page_load_details 16:25:31 INFO - PROCESS | 26470 | |i|pagename|runs| 16:25:31 INFO - PROCESS | 26470 | |0;ai-astar;104;117;109;116;116;118;115;115;114;114 16:25:31 INFO - PROCESS | 26470 | |1;audio-beat-detection;159;129;152;172;125;157;148;126;182;123 16:25:31 INFO - PROCESS | 26470 | |2;audio-dft;173;164;165;173;164;165;162;162;163;165 16:25:31 INFO - PROCESS | 26470 | |3;audio-fft;75;76;77;173;77;78;75;77;155;76 16:25:31 INFO - PROCESS | 26470 | |4;audio-oscillator;88;87;143;88;89;86;129;85;88;146 16:25:31 INFO - PROCESS | 26470 | |5;imaging-gaussian-blur;119;117;117;118;117;117;118;118;118;118 16:25:31 INFO - PROCESS | 26470 | |6;imaging-darkroom;148;146;147;147;147;147;148;149;148;147 16:25:31 INFO - PROCESS | 26470 | |7;imaging-desaturate;95;96;97;95;95;96;95;97;96;96 16:25:31 INFO - PROCESS | 26470 | |8;json-parse-financial;63;63;64;63;65;63;62;63;63;63 16:25:31 INFO - PROCESS | 26470 | |9;json-stringify-tinderbox;65;66;69;67;65;65;66;66;66;65 16:25:31 INFO - PROCESS | 26470 | |10;stanford-crypto-aes;83;81;81;81;86;81;85;86;86;80 16:25:31 INFO - PROCESS | 26470 | |11;stanford-crypto-ccm;146;134;138;138;138;132;150;142;149;130 16:25:31 INFO - PROCESS | 26470 | |12;stanford-crypto-pbkdf2;173;171;170;176;169;169;169;175;171;177 16:25:31 INFO - PROCESS | 26470 | |13;stanford-crypto-sha256-iterative;69;72;70;69;68;69;68;67;72;67 16:25:31 INFO - PROCESS | 26470 | __end_tp_report 16:25:31 INFO - PROCESS | 26470 | __start_cc_report 16:25:31 INFO - PROCESS | 26470 | _x_x_mozilla_cycle_collect,936 16:25:31 INFO - PROCESS | 26470 | __end_cc_report 16:25:31 INFO - PROCESS | 26470 | __startTimestamp1470439531407__endTimestamp 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | ------- Summary: start ------- 16:25:31 INFO - PROCESS | 26470 | Number of tests: 14 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.50 stddev:4.21 (3.6%) stddev-sans-first:2.57 16:25:31 INFO - PROCESS | 26470 | Values: 104.0 117.0 109.0 116.0 116.0 118.0 115.0 115.0 114.0 114.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.50 stddev:20.93 (13.5%) stddev-sans-first:21.77 16:25:31 INFO - PROCESS | 26470 | Values: 159.0 129.0 152.0 172.0 125.0 157.0 148.0 126.0 182.0 123.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.06 (2.5%) stddev-sans-first:3.31 16:25:31 INFO - PROCESS | 26470 | Values: 173.0 164.0 165.0 173.0 164.0 165.0 162.0 162.0 163.0 165.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:37.20 (48.6%) stddev-sans-first:38.82 16:25:31 INFO - PROCESS | 26470 | Values: 75.0 76.0 77.0 173.0 77.0 78.0 75.0 77.0 155.0 76.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:87.50 stddev:25.53 (29.2%) stddev-sans-first:26.50 16:25:31 INFO - PROCESS | 26470 | Values: 88.0 87.0 143.0 88.0 89.0 86.0 129.0 85.0 88.0 146.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:25:31 INFO - PROCESS | 26470 | Values: 119.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 16:25:31 INFO - PROCESS | 26470 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 148.0 149.0 148.0 147.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 16:25:31 INFO - PROCESS | 26470 | Values: 95.0 96.0 97.0 95.0 95.0 96.0 95.0 97.0 96.0 96.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 16:25:31 INFO - PROCESS | 26470 | Values: 63.0 63.0 64.0 63.0 65.0 63.0 62.0 63.0 63.0 63.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 16:25:31 INFO - PROCESS | 26470 | Values: 65.0 66.0 69.0 67.0 65.0 65.0 66.0 66.0 66.0 65.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:2.49 (3.0%) stddev-sans-first:2.65 16:25:31 INFO - PROCESS | 26470 | Values: 83.0 81.0 81.0 81.0 86.0 81.0 85.0 86.0 86.0 80.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:140.00 stddev:6.93 (4.9%) stddev-sans-first:6.96 16:25:31 INFO - PROCESS | 26470 | Values: 146.0 134.0 138.0 138.0 138.0 132.0 150.0 142.0 149.0 130.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:3.06 (1.8%) stddev-sans-first:3.22 16:25:31 INFO - PROCESS | 26470 | Values: 173.0 171.0 170.0 176.0 169.0 169.0 169.0 175.0 171.0 177.0 16:25:31 INFO - PROCESS | 26470 | 16:25:31 INFO - PROCESS | 26470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 16:25:31 INFO - PROCESS | 26470 | Values: 69.0 72.0 70.0 69.0 68.0 69.0 68.0 67.0 72.0 67.0 16:25:31 INFO - PROCESS | 26470 | -------- Summary: end -------- 16:25:31 INFO - PROCESS | 26470 | 16:25:32 INFO - TEST-INFO | 26470: exit 0 16:25:32 INFO - TEST-OK | kraken | took 64236ms 16:25:32 INFO - SUITE-END | took 1181s 16:25:32 INFO - Completed test suite (00:19:41) 16:25:32 INFO - javascript benchmark 16:25:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6328.934815281748, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.47450509898, 2639.1158961747815, 2640.524705553002, 2662.8535430551324, 2678.5044766718147, 4587.0, 4612.238980568206, 4691.718496890185, 4713.670043096985, 4723.834665786698, 4655.208614535529, 4670.97664511677, 4684.320773487842, 4730.148573256813, 4734.266188740742, 4275.914481710372, 4336.371226172203, 4427.845025424111, 4458.799354029076, 4476.418065651477, 4352.064306174172, 4382.12357528494, 4417.624501917341, 4426.756528390937, 4427.734335939837, 4173.3114036184, 4295.935560966588, 4311.223979683656, 4315.395844581761, 4333.198358303708, 4295.14097180562, 4303.655707543389, 4308.569143085698, 4417.425734654506, 4443.044745379759, 4327.480702315711, 4334.219840428722, 4352.281873490871, 4368.257396242647, 4369.169857727054, 4660.883477913046, 4682.297655351725, 4684.929726054112, 4705.035467729107, 4714.057188562301, 5071.492850714936, 5092.567131793802, 5099.490050994871, 5102.132637451642, 5119.539241468248, 5101.770420331094, 5113.156329205676, 5122.820701275437, 5123.0, 5123.513266239701, 4719.410073740817, 4738.573528382393, 4756.143894099096, 4783.880402989953, 4829.806807727651, 5190.97404512975, 5232.73836308183, 5236.450172731885, 5238.240455133984, 5295.099833028395, 4744.905101897943, 5022.296878437021, 5027.321311622957, 5028.899422011539, 5031.622628302892, 4878.0, 4973.726445045557, 4977.054359671651, 5018.4730603286125, 5039.546440820271, 4970.652054356233, 4988.925166122511, 5016.774245158977, 5039.244113383022, 5045.41977672565, 4976.303317535548, 4998.2502624606595, 4999.825006124768, 5013.147764879979, 5053.444121146671, 4101.487314085739, 4221.261279276115, 4245.299525578307, 4258.87223383299, 4259.914801703949, 3734.7012239020814, 3734.9066273343383, 3743.344914639927, 3776.754510956779, 3778.0, 4384.583464570861, 4400.801963911567, 4418.182636212311, 4441.533638967927, 4448.733076015449, 4900.117978763857, 4941.382327209099, 4969.552740253394, 4983.800647974041, 5109.718965456936, 4333.978330108329, 4335.913281734348, 4348.021695118573, 4362.781860906942, 4382.517923028464, 4473.932891006638, 4497.9325310120375, 4498.257787465097, 4498.347739577743, 4556.544345565483, 4577.725336479822, 4768.7615619218905, 4774.30772537987, 4797.472278049481, 4802.903941921212, 5112.565431938327, 5123.487651234846, 5126.154184559506, 5126.820561280338, 5180.197069454241, 4807.471178170328, 4820.2287633979795, 4835.226363781778, 4841.394825646794, 4858.955324605226, 4818.0, 4918.1393256180745, 4919.852404427873, 4921.778519966539, 5101.20931255656, 5012.6240531960975, 5014.398272207359, 5018.598512119095, 5028.1200789860895, 5035.748212589429, 4878.243872199815, 4883.731394773322, 4894.241392584155, 4896.387951506062, 4906.067847109038, 4692.061587682545, 4842.080004799077, 4859.343988561641, 4889.0, 4941.135301322182, 4782.641301902302, 4836.95163048365, 4896.6572339935865, 4914.8771280718265, 4931.7040977541465, 4978.551930326288, 4980.352554167935, 4992.950070499249, 5006.299118123393, 5023.773930173078, 4680.063987202641, 4804.567588917014, 4849.80600775965, 4859.2954021667365, 4907.435644900882], "value": 4635.574940515936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.834553806627, 561.2199043329772, 570.1732487892557, 581.7527550790916, 595.627732667083, 35363.823180884094, 38906.0, 39020.82937511872, 39284.01789955253, 39359.21281574367, 38906.22187556247, 39474.210515789666, 39631.80184099075, 39748.205035899264, 39770.403443948366, 7701.114371847253, 7796.41526885483, 7869.331106855924, 7875.763727088197, 7883.645235964366, 7728.7681369559, 7811.765647030598, 7815.687372505122, 7822.726204582841, 7845.568493732842, 7843.686252549891, 7861.056673199224, 7867.881981770278, 7904.446688731791, 7910.248526389983, 7763.72826951054, 7804.414668899827, 7813.140554538996, 7857.253560911704, 7862.449628525948, 7729.420293478011, 7854.528728276322, 7854.764357069297, 7863.606819658994, 7877.527348359117, 37833.24333513314, 38518.037049073995, 38528.614713853065, 38543.0, 38605.227895442215, 2457.668214791016, 2806.1441260415563, 2896.3772788850497, 2950.822950622948, 3061.3112049788842, 26105.477890442275, 27461.31346716328, 27994.0, 28412.857935710188, 28734.137975860758, 2965.0660042086674, 3277.1970867137466, 3315.9171020724434, 3386.9153271168416, 3403.7617366784334, 268358.0, 270249.0, 271029.6448517764, 272092.0, 273013.0, 31857.84071079676, 33107.172320691694, 55929.7203513988, 56449.15326270109, 56495.37312462847, 33960.32079358399, 33989.0, 34209.48685769716, 34246.31507369839, 34361.656383435846, 12943.935280323727, 13040.282784446757, 13106.541271055466, 13124.540641077516, 13131.803022954664, 11292.040176585082, 11375.26060806045, 11392.715182120513, 11395.886041139649, 11419.257748246504, 7822.413319001098, 7833.7466005438855, 7883.842323153504, 7929.286364227247, 7943.682252709827, 3103.4568950434036, 3112.4553203189353, 3116.766242531819, 3151.8739250430185, 3154.6056742907135, 856.1823458597025, 872.2803686958284, 886.2289807867068, 957.1337939165066, 973.8247115519133, 28196.43607127846, 28934.855325723238, 28955.42089158205, 29116.41767164645, 29498.115056548337, 935.9251259899191, 1014.2798612984716, 1015.2994433840627, 1017.811704834608, 1021.5862575656871, 14749.483768068067, 15406.866935724207, 15474.458393956382, 15529.378824847106, 15606.609834754221, 376552.0, 379762.0, 380144.0, 380716.0, 382259.0, 50938.23592646113, 50956.49043509592, 51139.74430127825, 51146.74426627843, 51399.48600513947, 1088.5972190289644, 1110.6945589962663, 1120.394986707169, 1155.3760969076604, 1157.5543415784814, 27274.590881137196, 28336.85831570829, 28916.855415722788, 28944.131676049754, 29102.417951641273, 44057.55942440663, 44357.33463997978, 44381.0, 44384.0, 44452.777736111115, 315161.0, 317316.0, 317643.0, 317851.0, 318092.0, 25297.343778903687, 25827.225183244533, 27674.0, 27764.30589235285, 27973.160805175878, 41926.37110443407, 42260.788696057556, 42544.78727606342, 42587.148257035304, 43138.78430607827, 36706.4494032595, 37104.44343334798, 37336.43995340018, 37693.01452228277, 38467.80766096264, 37384.252314954094, 37522.81238593899, 37831.43252851265, 38012.0, 38261.617383825804, 34682.47976280408, 36175.81912090423, 36468.81765591155, 39130.0, 39361.606383935796, 32153.35693286168, 34407.65592344045, 34425.0, 34808.82595587006, 34861.30277394387, 26039.73960260373, 26374.86812565925, 26440.603390948767, 26583.69570650257, 26686.0], "value": 16564.802196743156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2169071424294, 360.67178867230825, 362.9183433727411, 378.6213786213786, 384.552324454845, 15973.760393594092, 16895.408660696863, 17721.556961075963, 17873.82126178738, 17914.193861276242, 16112.516624501255, 16788.328466861312, 17458.21438035288, 17544.0, 17591.208395622227, 4946.282788995593, 5125.615578831584, 5167.302414174076, 5172.586193104543, 5173.146430838926, 3797.164623782777, 5177.171652535595, 5748.770049198027, 6028.0957856321465, 6076.6050206736645, 6065.757369705207, 6079.148919151322, 6117.785877494289, 6123.081537769348, 6139.662318572477, 5000.32495613093, 5251.973740131294, 5295.258663787073, 5309.681419114865, 5348.946510534884, 5055.064813009605, 5201.375834899836, 5333.626646134772, 5387.461253874581, 5443.972780136113, 12502.562410315686, 12538.435770390355, 12548.0, 12563.937180314131, 12652.493900243979, 1853.1753369750465, 1878.924843006278, 1945.2705235536673, 2050.0672194151625, 2219.212179676224, 9214.0, 9263.0, 9292.070792920722, 9501.524923753785, 9539.52302384878, 1682.6887025900248, 1692.7968643762704, 1736.5398169485097, 1767.646470705864, 1778.439791465697, 70431.0, 72322.63838680825, 73049.0, 74373.0, 75306.0, 9933.900660993297, 10125.696229113139, 10218.489075546193, 10402.167826573856, 10488.947555262328, 14208.289585520683, 14208.715825683428, 14235.0, 14247.145171289756, 14303.927205459424, 7446.925530744623, 7556.1310449299035, 7582.203868593829, 7693.0, 7758.456908016385, 6954.79135625932, 6994.265602111806, 7134.357907788324, 7213.89179162313, 7387.630618469055, 4251.252469224006, 4328.567143285646, 4363.2800587903275, 4423.60187583119, 4482.125985432809, 1446.464808021039, 1488.9329980150703, 1518.772184172361, 1782.3316256403848, 1881.7647794025747, 798.8961435013412, 843.0389356134012, 894.7628878347243, 917.788908551037, 927.6614035876856, 16836.0, 16956.0, 17419.303227870743, 17688.55778605545, 17789.0, 802.2138304461661, 859.9226069653636, 861.388414225894, 888.5690440136528, 900.8603666431713, 9255.352125351295, 9276.257899368034, 9277.536123193813, 9305.209057230077, 9442.10300021497, 346311.0, 346435.0, 362406.0, 371038.0, 378773.0, 73658.63170684113, 75205.24794752093, 75325.62337188279, 76794.0, 80198.0, 887.1793590928365, 889.7731078574922, 915.9954200228956, 919.3977944446399, 921.138735282513, 14269.785953210918, 15245.771313430085, 15397.769033464283, 15556.455524056604, 15846.207689615243, 34687.0, 35977.64022359743, 36951.44572831463, 37101.6289837109, 37900.81049594845, 52967.0, 53961.19058214209, 54096.45903540914, 55752.0, 56133.43866561282, 6897.827554311182, 7333.0, 7359.264073592598, 7462.514936529108, 7516.285952834472, 7787.92212077872, 10169.89830101719, 10960.12319014461, 11258.211925165488, 11708.297502149899, 9613.855792163264, 9763.121319081316, 10028.348157369748, 10082.29423940317, 10266.743331416774, 10240.385576865412, 10396.324238924446, 10432.843507347548, 10577.788444231226, 10679.359238445408, 9443.754767495688, 9513.66702165421, 9550.474723889974, 9651.179649729851, 9862.901370986485, 6252.812415627538, 7384.741534046498, 7689.269519395649, 7692.0, 7729.4202934779, 7766.766996990099, 9351.205147562534, 9732.708018759165, 9995.70012899614, 10261.640842570474], "value": 8053.509135086403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.542873566091, 1423.3025817349499, 1514.409380341667, 1658.1263172614943, 1700.030982340066, 6747.12287402637, 7288.234735352791, 7539.811504712371, 8054.718084867023, 8060.919390806091, 7620.390368770499, 7945.801354966129, 7963.248085421213, 7988.121306656263, 7993.360531157508, 2121.798429149232, 2129.339904629562, 2133.168064454856, 2138.4012476506605, 2141.8607790493647, 2097.7063211150453, 2135.7757435469284, 2179.095675294751, 2181.1711549611127, 2182.1053368119074, 2157.1587081038406, 2166.144372972675, 2171.7176767020264, 2173.880436575988, 2177.9455513612206, 2042.4893776555862, 2050.4668786115644, 2053.835693144545, 2054.1680619349186, 2054.7739748627714, 2007.3977806657945, 2076.646970015101, 2084.291340944086, 2094.6124966881175, 2105.26315789474, 7960.522368657841, 8002.759917202493, 8016.158303378178, 8026.277635012819, 8040.557769322685, 4382.233109205877, 4510.548945105496, 4515.774211289455, 4519.841805536823, 4521.728696278201, 2759.5860620906824, 2793.9441211175867, 2856.7714582833323, 2940.794144409892, 2966.8961586344376, 843.4475418600827, 863.6977058029702, 868.405142477405, 889.204162274767, 890.6615486115235, 10559.41923194224, 10618.681439556749, 10684.679459616145, 10717.892821071768, 10722.571097156104, 3779.1874746929543, 3964.7621142731527, 4062.111118329991, 4063.2076745035024, 4088.6115818997146, 8901.866472002925, 8949.418287811272, 8960.910390896139, 9153.084691530794, 9158.40470369424, 4414.602685758297, 4430.800613972379, 4441.711288766284, 4442.444694413199, 4442.73343599385, 3436.415809312423, 3850.8652197173524, 3972.2651309507833, 4000.3399439092805, 4005.459262999516, 3562.5368702068563, 3601.891943241707, 3710.777353358807, 3732.794696291676, 3752.75607085544, 1153.8903804138592, 1155.381870699172, 1158.3397463445924, 1173.3957012138756, 1177.4407156600716, 857.2499063319596, 867.648602316063, 886.259972922604, 887.4630848336664, 892.723255790707, 5467.316585426822, 5494.890102198014, 5541.5843811714285, 5756.510696590753, 5798.797042103506, 892.4689809563299, 932.9626814927462, 979.1383582447401, 980.4215512847454, 980.597954838527, 3568.589612194579, 3708.42519409492, 3808.8666896658483, 3810.599887011879, 3846.288436639231, 9321.766955826159, 9663.661771837951, 9670.70987870365, 9713.562889669982, 9746.9025309746, 9562.426254424758, 9652.083052110038, 9658.468784216795, 9674.22606191503, 9683.080107389927, 6868.0, 7049.68276427562, 7070.434365250768, 7368.557886526718, 7375.594342311224, 5521.812810245817, 5643.984082865124, 5734.7132643368495, 5792.362840087671, 5870.706464676664, 8728.345374096842, 8889.4666320021, 8948.776280593038, 8980.191782739585, 8996.325275604226, 9019.639214431612, 9132.771680708036, 9233.492157931378, 9266.583003764981, 9323.207527359978, 6087.695615219132, 6644.83387915306, 6674.132362792806, 6695.263521012782, 6816.795496135124, 7537.057867766529, 7593.848123037619, 7605.543667379754, 7630.1606823248285, 7636.08366995964, 6651.368120028589, 6752.696128674123, 6763.086983257394, 6790.7623233186605, 7025.086738723933, 6446.8388290293115, 6518.250401203923, 6676.165479315086, 6702.798916032527, 6834.2482326943, 6502.967485162544, 6547.214334279917, 6550.115734375799, 6552.443042341264, 6570.441512471493, 4360.651147908096, 4363.54182810813, 4384.0, 4511.3458548509625, 4515.322701594787, 4502.122086193161, 4534.569215924482, 4570.337301091389, 4629.398178236807, 4696.835610753607], "value": 4138.617306774149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7231175007243, 301.3520930000499, 301.49499588189775, 304.5918469251203, 306.78371747917714, 4876.146674331991, 4969.527894849988, 4970.850874473763, 4982.754311422144, 5012.924806127911, 4910.803567857291, 4921.80312787488, 4935.950640493594, 4943.555080042795, 4963.950360496394, 3699.7595156314756, 3761.7178711596603, 3846.0961674006585, 3857.787821669807, 3862.748921320105, 3843.577206507282, 3855.51806024247, 3858.84564617415, 3869.8452061917487, 3876.1666241758016, 3830.731848770587, 3840.1743625120594, 3846.769193848378, 3879.262940041397, 3880.5149356330458, 3760.7179461540495, 3828.25349056934, 3846.442265871461, 3874.670652994485, 3874.9225015499815, 3395.422778127724, 3396.0, 3400.846961886696, 3408.1309266137223, 3428.2629234714404, 4783.641226907996, 4802.879928001793, 4805.639577031737, 4811.927821082687, 4840.927386089212, 4405.1850407674365, 4410.448693913261, 4413.8234470621455, 4433.290673492225, 4470.776461176928, 4920.729359885205, 5144.588432925357, 5161.29677206521, 5179.0, 5189.143791274435, 3676.6690997810324, 3678.1540245743363, 3680.429533422324, 3686.8525258989876, 3689.8524059037604, 5430.8099216527235, 5440.292761940962, 5441.673499589998, 5450.645708029005, 5456.508914197701, 3637.7635453695425, 3670.3943849265106, 3688.2070354873294, 3701.4632878232505, 3718.3307004738867, 3754.136548593784, 3773.1699026214737, 3779.543296857065, 3790.1093243087853, 3796.5823759386444, 4314.288142456459, 4326.718763280377, 4350.825966961286, 4357.651387888961, 4383.824647014084, 5022.347094877716, 5175.404828444702, 5209.713465759344, 5221.530062294411, 5291.470852914677, 1278.130871007705, 1291.6835375333103, 1297.1049975516862, 1297.3902265935185, 1298.2924306253115, 809.6639894443857, 840.4621042532784, 848.3382961290204, 851.5614458553849, 861.9224269815746, 4343.414653651457, 4381.518033016366, 4561.1492816989385, 4570.085982803453, 4582.427196600425, 5385.299911011543, 5390.460953904657, 5395.973020134953, 5398.0, 5412.673894895775, 4541.636669066466, 4566.949601591586, 4579.313103034571, 4579.473360563511, 4586.312053192048, 2656.5483867742146, 2805.2285621453857, 2842.275219818933, 2843.4881721289953, 2845.061129827152, 4987.179679416987, 5031.22016087507, 5035.144025515671, 5049.318342023853, 5050.0, 5297.364316282071, 5471.398146203915, 5492.423295553909, 5507.201455788888, 5510.972445137749, 5002.74986250686, 5010.5240002199735, 5034.471380505068, 5048.16705243638, 5066.4680208577565, 5407.567394608343, 5408.3509978802795, 5410.78356865721, 5415.756290966837, 5433.8369848904595, 5066.9746651266505, 5217.321748172713, 5259.237410575522, 5281.392639846466, 5311.468853114812, 5014.893744627192, 5035.0, 5037.722925239001, 5038.622103342191, 5068.442471328077, 3428.3143371325336, 3459.636738142459, 3468.705160061322, 3480.6157781919464, 3488.8430020648625, 4564.88587785308, 4735.692180008288, 4817.397825271841, 4834.147852766884, 4862.92705609409, 4576.931346029745, 4611.861644150681, 4634.675572710013, 4642.53574642533, 4667.579917807414, 4594.7702614869795, 4616.6075883550275, 4622.098690755271, 4665.346851440733, 4672.836450724209, 4563.322594340827, 4570.565796249351, 4599.5400459953735, 4671.271629497108, 4738.31294462308, 5003.0, 5091.236314552699, 5192.402873669425, 5230.869228269324, 5236.952609478196, 5102.821401250939, 5108.872278193075, 5118.181091025418, 5138.07514647367, 5143.254228136974], "value": 3839.6090396314594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.464105510316, 642.7493277621726, 658.187138883479, 726.3462883404935, 747.7158679701711, 10960.12319014479, 11617.070634349253, 11623.941880290608, 11654.0, 11670.299782013086, 13007.34963251836, 13143.079984401096, 13150.868491315085, 13268.469261229564, 13315.866841331608, 622.1787240842091, 755.2824816424405, 757.8067592763838, 768.8039549914764, 778.4861991085885, 768.642581199742, 773.3542492019143, 776.5496012312846, 776.7553220735479, 777.4790890103644, 832.1304237072244, 833.2792134803382, 834.0783434305097, 834.1325021977136, 835.0146826744439, 819.8565251081037, 825.5376988886213, 828.1428721273484, 828.8135169586825, 829.3821103278036, 603.8490377405649, 603.9003564411867, 606.4844881850391, 609.7926704920349, 610.5237914426755, 12647.87352126476, 12659.936700316532, 12682.682932926658, 12689.365531723377, 12717.936410317889, 13668.179909205479, 13841.446342146402, 13999.440022399092, 14304.356303966346, 14385.0, 10026.849597255974, 10149.594016239342, 10252.0, 10320.79358412835, 10437.947810260976, 3183.761217908643, 3290.3090351026312, 3372.37611041958, 3465.220325426784, 3470.826458677056, 61585.6920715398, 62771.0, 62777.058344124875, 65292.67353663249, 65698.3430165697, 10254.846177307347, 10315.765368857614, 10369.844452333222, 10489.685309440729, 10521.684349469528, 18154.455366339032, 18309.816901831076, 18363.72454413185, 18367.35714249995, 18435.631287374177, 6712.060311556386, 6719.227288861745, 6792.150981127359, 6832.59004459734, 6916.446684265246, 3504.6144924058335, 3656.5612126544984, 3726.925461490809, 3764.4249900516875, 3894.1043559980794, 2985.477541430241, 3066.8006579572257, 3090.8300043497375, 3094.2883136878195, 3100.8449577521483, 499.51796516361884, 503.6147347279334, 506.98479045627954, 514.0490093327314, 515.7395515264842, 486.5888324365905, 566.4505429733152, 596.2100217212125, 596.6420147911306, 607.2136583124864, 8240.13478584752, 8530.616122274512, 8788.714934117175, 8796.736097917073, 8903.777405564913, 491.76395330241684, 521.4889408379809, 578.1270281874316, 615.1142355008863, 615.7875532941129, 3912.295786758411, 4016.779077150785, 4105.89735256615, 4165.645920096765, 4184.372344148342, 71232.64383678048, 94989.0, 100194.0, 101643.0, 103381.48309258556, 87066.0, 89937.0, 95980.0, 96213.26507144433, 96347.0, 77536.61231693918, 78747.0, 80499.59750201095, 80892.19107808964, 81141.59429202935, 7639.541627502367, 7850.528968261922, 7958.0, 7979.9601001994615, 8055.194480551898, 42736.87157541115, 46258.30612540747, 47385.52614473811, 47584.286235707186, 48216.27675584799, 51525.7423712879, 66972.0, 67197.66401168158, 68049.0, 69633.30366696269, 9724.562394692397, 10238.385696858213, 10333.34666453364, 10341.586336546454, 10410.739731506774, 10767.946160269148, 10838.078763305208, 11136.610218642309, 11168.106551476025, 11173.888261117285, 10959.726006849893, 11022.890235798026, 11209.495572699085, 11260.831087533857, 11338.489767960627, 10652.147828173573, 10672.0, 10686.83969740439, 10806.35161890289, 10814.675559733221, 10295.94852025735, 10807.729806754895, 12105.576304829288, 12339.0, 12542.937285313516, 9622.278329125484, 9658.263639390392, 10111.494425278854, 10461.843072354073, 10775.515101820594, 10387.792244155225, 10419.843702344622, 10510.421926793793, 10673.199510036933, 10738.892611073788], "value": 6539.128769340991, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 109.0, 116.0, 116.0, 118.0, 115.0, 115.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 152.0, 172.0, 125.0, 157.0, 148.0, 126.0, 182.0, 123.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 165.0, 173.0, 164.0, 165.0, 162.0, 162.0, 163.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 173.0, 77.0, 78.0, 75.0, 77.0, 155.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 143.0, 88.0, 89.0, 86.0, 129.0, 85.0, 88.0, 146.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 69.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 81.0, 86.0, 81.0, 85.0, 86.0, 86.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 134.0, 138.0, 138.0, 138.0, 132.0, 150.0, 142.0, 149.0, 130.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 176.0, 169.0, 169.0, 169.0, 175.0, 171.0, 177.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 69.0, 68.0, 69.0, 68.0, 67.0, 72.0, 67.0], "value": 69.1, "unit": "score"}]}]} 16:25:32 INFO - Return code: 0 16:25:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:25:32 ERROR - # TBPL SUCCESS # 16:25:32 INFO - Running post-action listener: _resource_record_post_action 16:25:32 INFO - [mozharness: 2016-08-05 23:25:32.714648Z] Finished run-tests step (success) 16:25:32 INFO - Running post-run listener: _resource_record_post_run 16:25:32 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 549691392; Read time: 0; Write time: 454264 16:25:32 INFO - TinderboxPrint: CPU usage
13.4% 16:25:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:25:32 INFO - TinderboxPrint: I/O write bytes / time
549,691,392 / 454,264 16:25:32 INFO - TinderboxPrint: CPU idle
8,280.1 (86.6%) 16:25:32 INFO - TinderboxPrint: CPU user
1,222.1 (12.8%) 16:25:32 INFO - TinderboxPrint: Swap in / out
0 / 0 16:25:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250650624; Read time: 0; Write time: 267692 16:25:32 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 299040768; Read time: 0; Write time: 186572 16:25:33 INFO - Running post-run listener: _upload_blobber_files 16:25:33 INFO - Blob upload gear active. 16:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:33 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 16:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:25:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:34 INFO - (blobuploader) - INFO - Done attempting. 16:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:37 INFO - (blobuploader) - INFO - Done attempting. 16:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:38 INFO - (blobuploader) - INFO - Done attempting. 16:25:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:38 INFO - Return code: 0 16:25:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561cd74a89bdad0996c2063f1357aa2394884b071dab9b6be2bce3592a1ca9aca9c5dba93f15401175a6d03dc2bb418364eb454d05a9c2f45deacc1a114aec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e7ec65c01c6a6fde58854dfd76507a6f50e85d4f5edc31e3d9c3d5f40fc7e9bb63309d2aaa805627422e82dcf52ee41e6d01ef024bd5be49fa93086fdb55dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96b7be81a70a36bc77784218da01675fe36959d63134c13ff1b685038578f05d94bc9f462bd24b3bb028fc8ac935adff72f2eca695db584772b9c196b18fcb62"} 16:25:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:38 INFO - Contents: 16:25:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561cd74a89bdad0996c2063f1357aa2394884b071dab9b6be2bce3592a1ca9aca9c5dba93f15401175a6d03dc2bb418364eb454d05a9c2f45deacc1a114aec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e7ec65c01c6a6fde58854dfd76507a6f50e85d4f5edc31e3d9c3d5f40fc7e9bb63309d2aaa805627422e82dcf52ee41e6d01ef024bd5be49fa93086fdb55dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96b7be81a70a36bc77784218da01675fe36959d63134c13ff1b685038578f05d94bc9f462bd24b3bb028fc8ac935adff72f2eca695db584772b9c196b18fcb62"} 16:25:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:38 INFO - Copying logs to upload dir... 16:25:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.660682 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-05 16:25:38.040890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:25:38.044728) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 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-Non-PGO/sha512/561cd74a89bdad0996c2063f1357aa2394884b071dab9b6be2bce3592a1ca9aca9c5dba93f15401175a6d03dc2bb418364eb454d05a9c2f45deacc1a114aec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e7ec65c01c6a6fde58854dfd76507a6f50e85d4f5edc31e3d9c3d5f40fc7e9bb63309d2aaa805627422e82dcf52ee41e6d01ef024bd5be49fa93086fdb55dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96b7be81a70a36bc77784218da01675fe36959d63134c13ff1b685038578f05d94bc9f462bd24b3bb028fc8ac935adff72f2eca695db584772b9c196b18fcb62"} build_url:https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/U6l9AgrPQr6pzsAkgPYfdA/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-Non-PGO/sha512/561cd74a89bdad0996c2063f1357aa2394884b071dab9b6be2bce3592a1ca9aca9c5dba93f15401175a6d03dc2bb418364eb454d05a9c2f45deacc1a114aec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e7ec65c01c6a6fde58854dfd76507a6f50e85d4f5edc31e3d9c3d5f40fc7e9bb63309d2aaa805627422e82dcf52ee41e6d01ef024bd5be49fa93086fdb55dfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96b7be81a70a36bc77784218da01675fe36959d63134c13ff1b685038578f05d94bc9f462bd24b3bb028fc8ac935adff72f2eca695db584772b9c196b18fcb62"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:25:38.070796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:25:38.071159) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470437962.267221-422170388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:25:38.155454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:25:38.155799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:25:38.156131) ========= ========= Total master_lag: 0.17 =========