builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1469466133.71 results: success (0) buildid: 20160725053009 builduid: d1604a1e5ea84d9697e95657efe31ddc revision: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.713667) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.714371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.714725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.730892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.731307) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 10:02:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.7M=0s 2016-07-25 10:02:14 (32.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.846473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.846820) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016790 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.896613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:13.897016) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f --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 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f --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=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 10:02:14,782 truncating revision to first 12 chars 2016-07-25 10:02:14,782 Setting DEBUG logging. 2016-07-25 10:02:14,783 attempt 1/10 2016-07-25 10:02:14,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bb05a19ff9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 10:02:15,085 unpacking tar archive at: fx-team-1bb05a19ff9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656468 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:14.567130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:14.567495) ========= script_repo_revision: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:14.567884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:14.568149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 10:02:14.580403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-25 10:02:14.580852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:02:15 INFO - MultiFileLogger online at 20160725 10:02:15 in /builds/slave/test 10:02:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:02:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:15 INFO - {'append_to_log': False, 10:02:15 INFO - 'base_work_dir': '/builds/slave/test', 10:02:15 INFO - 'blob_upload_branch': 'Fx-Team', 10:02:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:15 INFO - 'branch': 'Fx-Team', 10:02:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:15 INFO - 'config_files': ('talos/linux_config.py',), 10:02:15 INFO - 'default_actions': ('clobber', 10:02:15 INFO - 'read-buildbot-config', 10:02:15 INFO - 'download-and-extract', 10:02:15 INFO - 'populate-webroot', 10:02:15 INFO - 'create-virtualenv', 10:02:15 INFO - 'install', 10:02:15 INFO - 'run-tests'), 10:02:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:15 INFO - 'download_minidump_stackwalk': True, 10:02:15 INFO - 'download_symbols': 'ondemand', 10:02:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:15 INFO - 'installer_path': 'installer.exe', 10:02:15 INFO - 'log_level': 'info', 10:02:15 INFO - 'log_name': 'talos', 10:02:15 INFO - 'log_to_console': True, 10:02:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:02:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:02:15 INFO - 'opt_config_files': (), 10:02:15 INFO - 'pip_index': False, 10:02:15 INFO - 'sps_profile': False, 10:02:15 INFO - 'sps_profile_interval': 0, 10:02:15 INFO - 'suite': 'dromaeojs-e10s', 10:02:15 INFO - 'system_bits': '32', 10:02:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:15 INFO - 'title': 'talos-linux64-ix-041', 10:02:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:15 INFO - 'use_talos_json': True, 10:02:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:15 INFO - 'work_dir': 'build'} 10:02:15 INFO - [mozharness: 2016-07-25 17:02:15.562049Z] Running clobber step. 10:02:15 INFO - Running pre-action listener: _resource_record_pre_action 10:02:15 INFO - Running main action method: clobber 10:02:15 INFO - rmtree: /builds/slave/test/build 10:02:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:16 INFO - Running post-action listener: _resource_record_post_action 10:02:16 INFO - [mozharness: 2016-07-25 17:02:16.557435Z] Finished clobber step (success) 10:02:16 INFO - [mozharness: 2016-07-25 17:02:16.557534Z] Running read-buildbot-config step. 10:02:16 INFO - Running pre-action listener: _resource_record_pre_action 10:02:16 INFO - Running main action method: read_buildbot_config 10:02:16 INFO - Using buildbot properties: 10:02:16 INFO - { 10:02:16 INFO - "project": "", 10:02:16 INFO - "product": "firefox", 10:02:16 INFO - "script_repo_revision": "production", 10:02:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:02:16 INFO - "repository": "", 10:02:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:02:16 INFO - "buildid": "20160725053009", 10:02:16 INFO - "pgo_build": "True", 10:02:16 INFO - "basedir": "/builds/slave/test", 10:02:16 INFO - "buildnumber": 601, 10:02:16 INFO - "slavename": "talos-linux64-ix-041", 10:02:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:02:16 INFO - "platform": "ubuntu64_hw", 10:02:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:02:16 INFO - "branch": "fx-team", 10:02:16 INFO - "repo_path": "integration/fx-team", 10:02:16 INFO - "revision": "1bb05a19ff9d70ed1d858d526fdbe27a8408f19f", 10:02:16 INFO - "stage_platform": "linux64-pgo", 10:02:16 INFO - "builduid": "d1604a1e5ea84d9697e95657efe31ddc", 10:02:16 INFO - "slavebuilddir": "test" 10:02:16 INFO - } 10:02:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:02:16 INFO - Running post-action listener: _resource_record_post_action 10:02:16 INFO - [mozharness: 2016-07-25 17:02:16.559950Z] Finished read-buildbot-config step (success) 10:02:16 INFO - [mozharness: 2016-07-25 17:02:16.560038Z] Running download-and-extract step. 10:02:16 INFO - Running pre-action listener: _resource_record_pre_action 10:02:16 INFO - Running main action method: download_and_extract 10:02:16 INFO - mkdir: /builds/slave/test/build/tests 10:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:16 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:02:17 INFO - Downloaded 1361 bytes. 10:02:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:02:17 INFO - Using the following test package requirements: 10:02:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:02:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:02:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:02:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'jsshell-linux-x86_64.zip'], 10:02:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:02:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:02:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:02:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:02:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:02:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:02:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:17 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:02:18 INFO - Downloaded 24307890 bytes. 10:02:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:02:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:02:19 INFO - Return code: 0 10:02:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:19 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:02:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:02:20 INFO - Downloaded 24307890 bytes. 10:02:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:02:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:02:22 INFO - Return code: 0 10:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:22 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:02:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:02:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:02:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:02:24 INFO - Downloaded 14403289 bytes. 10:02:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:02:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:02:24 INFO - Return code: 0 10:02:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:24 INFO - https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:02:26 INFO - Downloaded 60837310 bytes. 10:02:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:02:26 INFO - mkdir: /builds/slave/test/properties 10:02:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:26 INFO - Contents: 10:02:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:02:27 INFO - Running post-action listener: _resource_record_post_action 10:02:27 INFO - Running post-action listener: set_extra_try_arguments 10:02:27 INFO - [mozharness: 2016-07-25 17:02:27.047292Z] Finished download-and-extract step (success) 10:02:27 INFO - [mozharness: 2016-07-25 17:02:27.047524Z] Running populate-webroot step. 10:02:27 INFO - Running pre-action listener: _resource_record_pre_action 10:02:27 INFO - Running main action method: populate_webroot 10:02:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:27 INFO - '--tppagecycles', 10:02:27 INFO - '7'], 10:02:27 INFO - 'tests': ['tsvgm']}}, 10:02:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:02:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['damp', 'tps']}, 10:02:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'tests': ['damp', 'tps']}, 10:02:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['dromaeo_dom']}, 10:02:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['basic_compositor_video']}, 10:02:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:02:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['a11yr', 10:02:27 INFO - 'ts_paint', 10:02:27 INFO - 'tpaint', 10:02:27 INFO - 'sessionrestore', 10:02:27 INFO - 'sessionrestore_no_auto_restore', 10:02:27 INFO - 'tabpaint']}, 10:02:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['tsvgx', 10:02:27 INFO - 'tsvgr_opacity', 10:02:27 INFO - 'tart', 10:02:27 INFO - 'tscrollx', 10:02:27 INFO - 'cart']}, 10:02:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:27 INFO - 'tsvgr_opacity', 10:02:27 INFO - 'tart', 10:02:27 INFO - 'tscrollx', 10:02:27 INFO - 'cart']}, 10:02:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'talos_options': ['--disable-e10s'], 10:02:27 INFO - 'tests': ['tp5o']}, 10:02:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'tests': ['tp5o']}, 10:02:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'talos_options': ['--disable-e10s', 10:02:27 INFO - '--xperf_path', 10:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:27 INFO - 'tests': ['tp5n']}, 10:02:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:27 INFO - 'talos_options': ['--xperf_path', 10:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:27 INFO - 'tests': ['tp5n']}}, 10:02:27 INFO - 'talos.zip': {'path': '', 10:02:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:27 INFO - Running post-action listener: _resource_record_post_action 10:02:27 INFO - [mozharness: 2016-07-25 17:02:27.066942Z] Finished populate-webroot step (success) 10:02:27 INFO - [mozharness: 2016-07-25 17:02:27.067031Z] Running create-virtualenv step. 10:02:27 INFO - Running pre-action listener: _resource_record_pre_action 10:02:27 INFO - Running main action method: create_virtualenv 10:02:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:27 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 10:02:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:27 INFO - Using real prefix '/usr' 10:02:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:29 INFO - Installing pip.................done. 10:02:29 INFO - Return code: 0 10:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:29 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 10:02:29 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 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:29 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 10:02:29 INFO - Cleaning up... 10:02:29 INFO - Return code: 0 10:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:29 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 10:02:29 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 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:30 INFO - Downloading/unpacking psutil>=3.1.1 10:02:30 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 10:02:30 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 10:02:30 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 10:02:30 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 10:02:30 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 10:02:30 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 10:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:32 INFO - Installing collected packages: psutil 10:02:32 INFO - Running setup.py install for psutil 10:02:32 INFO - building 'psutil._psutil_linux' extension 10:02:32 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 10:02:32 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 10:02:32 INFO - building 'psutil._psutil_posix' extension 10:02:32 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 10:02:32 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 10:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:32 INFO - Successfully installed psutil 10:02:32 INFO - Cleaning up... 10:02:32 INFO - Return code: 0 10:02:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:32 INFO - Using env: {'DISPLAY': ':0', 10:02:32 INFO - 'HOME': '/home/cltbld', 10:02:32 INFO - 'LANG': 'en_US.UTF-8', 10:02:32 INFO - 'LANGUAGE': 'en_US:en', 10:02:32 INFO - 'LOGNAME': 'cltbld', 10:02:32 INFO - 'MAIL': '/var/mail/cltbld', 10:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:32 INFO - 'MOZ_NO_REMOTE': '1', 10:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:32 INFO - 'NO_EM_RESTART': '1', 10:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:32 INFO - 'PWD': '/builds/slave/test', 10:02:32 INFO - 'SHELL': '/bin/bash', 10:02:32 INFO - 'SHLVL': '1', 10:02:32 INFO - 'TERM': 'linux', 10:02:32 INFO - 'TMOUT': '86400', 10:02:32 INFO - 'USER': 'cltbld', 10:02:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:32 INFO - '_': '/tools/buildbot/bin/python'} 10:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:32 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 10:02:32 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 10:02:32 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 10:02:32 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 10:02:32 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 10:02:32 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 10:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:34 INFO - Installing collected packages: mozsystemmonitor 10:02:34 INFO - Running setup.py install for mozsystemmonitor 10:02:34 INFO - Successfully installed mozsystemmonitor 10:02:34 INFO - Cleaning up... 10:02:34 INFO - Return code: 0 10:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02: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==2.5.1'] in /builds/slave/test/build 10:02: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==2.5.1 10:02:34 INFO - Using env: {'DISPLAY': ':0', 10:02:34 INFO - 'HOME': '/home/cltbld', 10:02:34 INFO - 'LANG': 'en_US.UTF-8', 10:02:34 INFO - 'LANGUAGE': 'en_US:en', 10:02:34 INFO - 'LOGNAME': 'cltbld', 10:02:34 INFO - 'MAIL': '/var/mail/cltbld', 10:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:34 INFO - 'MOZ_NO_REMOTE': '1', 10:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:34 INFO - 'NO_EM_RESTART': '1', 10:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:34 INFO - 'PWD': '/builds/slave/test', 10:02:34 INFO - 'SHELL': '/bin/bash', 10:02:34 INFO - 'SHLVL': '1', 10:02:34 INFO - 'TERM': 'linux', 10:02:34 INFO - 'TMOUT': '86400', 10:02:34 INFO - 'USER': 'cltbld', 10:02:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:34 INFO - '_': '/tools/buildbot/bin/python'} 10:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:35 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 10:02:35 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 10:02:35 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 10:02:35 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 10:02:35 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 10:02:35 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 10:02:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:37 INFO - warning: no files found matching '*.txt' 10:02:37 INFO - no previously-included directories found matching 'build' 10:02:37 INFO - no previously-included directories found matching 'dist' 10:02:37 INFO - no previously-included directories found matching '.git*' 10:02:37 INFO - Installing collected packages: jsonschema, functools32 10:02:37 INFO - Running setup.py install for functools32 10:02:37 INFO - warning: no files found matching '*.txt' 10:02:37 INFO - no previously-included directories found matching 'build' 10:02:37 INFO - no previously-included directories found matching 'dist' 10:02:37 INFO - no previously-included directories found matching '.git*' 10:02:37 INFO - Successfully installed jsonschema functools32 10:02:37 INFO - Cleaning up... 10:02:37 INFO - Return code: 0 10:02:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:37 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:37 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 10:02:37 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 10:02:37 INFO - Using env: {'DISPLAY': ':0', 10:02:37 INFO - 'HOME': '/home/cltbld', 10:02:37 INFO - 'LANG': 'en_US.UTF-8', 10:02:37 INFO - 'LANGUAGE': 'en_US:en', 10:02:37 INFO - 'LOGNAME': 'cltbld', 10:02:37 INFO - 'MAIL': '/var/mail/cltbld', 10:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:37 INFO - 'MOZ_NO_REMOTE': '1', 10:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:37 INFO - 'NO_EM_RESTART': '1', 10:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:37 INFO - 'PWD': '/builds/slave/test', 10:02:37 INFO - 'SHELL': '/bin/bash', 10:02:37 INFO - 'SHLVL': '1', 10:02:37 INFO - 'TERM': 'linux', 10:02:37 INFO - 'TMOUT': '86400', 10:02:37 INFO - 'USER': 'cltbld', 10:02:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:37 INFO - '_': '/tools/buildbot/bin/python'} 10:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:39 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 10:02:39 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 10:02:39 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 10:02:39 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 10:02:39 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 10:02:39 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 10:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:40 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 10:02:40 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 10:02:40 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 10:02:40 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 10:02:40 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 10:02:40 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 10:02:40 INFO - Downloading docopt-0.6.1.tar.gz 10:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:40 INFO - Running setup.py install for blobuploader 10:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:40 INFO - Running setup.py install for requests 10:02:40 INFO - Running setup.py install for docopt 10:02:40 INFO - Successfully installed blobuploader requests docopt 10:02:40 INFO - Cleaning up... 10:02:41 INFO - Return code: 0 10:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:41 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:41 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 10:02:41 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 10:02:41 INFO - Using env: {'DISPLAY': ':0', 10:02:41 INFO - 'HOME': '/home/cltbld', 10:02:41 INFO - 'LANG': 'en_US.UTF-8', 10:02:41 INFO - 'LANGUAGE': 'en_US:en', 10:02:41 INFO - 'LOGNAME': 'cltbld', 10:02:41 INFO - 'MAIL': '/var/mail/cltbld', 10:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:41 INFO - 'MOZ_NO_REMOTE': '1', 10:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:41 INFO - 'NO_EM_RESTART': '1', 10:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:41 INFO - 'PWD': '/builds/slave/test', 10:02:41 INFO - 'SHELL': '/bin/bash', 10:02:41 INFO - 'SHLVL': '1', 10:02:41 INFO - 'TERM': 'linux', 10:02:41 INFO - 'TMOUT': '86400', 10:02:41 INFO - 'USER': 'cltbld', 10:02:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:41 INFO - '_': '/tools/buildbot/bin/python'} 10:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:41 INFO - Running setup.py (path:/tmp/pip-FuUMfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:41 INFO - Running setup.py (path:/tmp/pip-qiNnNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:41 INFO - Running setup.py (path:/tmp/pip-iWeppy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:41 INFO - Running setup.py (path:/tmp/pip-6sUSSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:41 INFO - Running setup.py (path:/tmp/pip-2tktmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:41 INFO - Running setup.py (path:/tmp/pip-YosflJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:41 INFO - Running setup.py (path:/tmp/pip-aDLFYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:41 INFO - Running setup.py (path:/tmp/pip-7KPeKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:41 INFO - Running setup.py (path:/tmp/pip-0VmJMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:41 INFO - Running setup.py (path:/tmp/pip-84PyzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:41 INFO - Running setup.py (path:/tmp/pip-4I1S_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:42 INFO - Running setup.py (path:/tmp/pip-1lO0ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:42 INFO - Running setup.py (path:/tmp/pip-Pn9rTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:42 INFO - Running setup.py (path:/tmp/pip-yb9j8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:42 INFO - Running setup.py (path:/tmp/pip-X2aEjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:42 INFO - Running setup.py (path:/tmp/pip-T_kmyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:42 INFO - Running setup.py (path:/tmp/pip-55tFl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:42 INFO - Running setup.py install for manifestparser 10:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:42 INFO - Running setup.py install for mozcrash 10:02:42 INFO - Running setup.py install for mozdebug 10:02:42 INFO - Running setup.py install for mozdevice 10:02:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:42 INFO - Running setup.py install for mozfile 10:02:43 INFO - Running setup.py install for mozhttpd 10:02:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozinfo 10:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozInstall 10:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozleak 10:02:43 INFO - Running setup.py install for mozlog 10:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for moznetwork 10:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozprocess 10:02:43 INFO - Running setup.py install for mozprofile 10:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozrunner 10:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:43 INFO - Running setup.py install for mozscreenshot 10:02:44 INFO - Running setup.py install for moztest 10:02:44 INFO - Running setup.py install for mozversion 10:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:44 INFO - Cleaning up... 10:02:44 INFO - Return code: 0 10:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:44 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:44 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 10:02:44 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 10:02:44 INFO - Using env: {'DISPLAY': ':0', 10:02:44 INFO - 'HOME': '/home/cltbld', 10:02:44 INFO - 'LANG': 'en_US.UTF-8', 10:02:44 INFO - 'LANGUAGE': 'en_US:en', 10:02:44 INFO - 'LOGNAME': 'cltbld', 10:02:44 INFO - 'MAIL': '/var/mail/cltbld', 10:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:44 INFO - 'MOZ_NO_REMOTE': '1', 10:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:44 INFO - 'NO_EM_RESTART': '1', 10:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:44 INFO - 'PWD': '/builds/slave/test', 10:02:44 INFO - 'SHELL': '/bin/bash', 10:02:44 INFO - 'SHLVL': '1', 10:02:44 INFO - 'TERM': 'linux', 10:02:44 INFO - 'TMOUT': '86400', 10:02:44 INFO - 'USER': 'cltbld', 10:02:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:44 INFO - '_': '/tools/buildbot/bin/python'} 10:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:44 INFO - Running setup.py (path:/tmp/pip-cwH3vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:44 INFO - Running setup.py (path:/tmp/pip-2op5IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:44 INFO - Running setup.py (path:/tmp/pip-Q4uJcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:44 INFO - Running setup.py (path:/tmp/pip-tRoTes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:44 INFO - Running setup.py (path:/tmp/pip-fxFDxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:44 INFO - Running setup.py (path:/tmp/pip-7YhWFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:44 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)) 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:44 INFO - Running setup.py (path:/tmp/pip-ruS42w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:45 INFO - Running setup.py (path:/tmp/pip-9V0qqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:45 INFO - Running setup.py (path:/tmp/pip-ove52p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:45 INFO - Running setup.py (path:/tmp/pip-3PrpfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:45 INFO - Running setup.py (path:/tmp/pip-jkCMQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:45 INFO - Running setup.py (path:/tmp/pip-fJZEfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:45 INFO - Running setup.py (path:/tmp/pip-pQrOn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:45 INFO - Running setup.py (path:/tmp/pip-BTz6Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:45 INFO - Running setup.py (path:/tmp/pip-83eYGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:45 INFO - Running setup.py (path:/tmp/pip-JbG0rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:45 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)) 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:45 INFO - Running setup.py (path:/tmp/pip-FCkenr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:45 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 10:02:45 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 10:02:45 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 10:02:45 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 10:02:45 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 10:02:45 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 10:02:47 INFO - Downloading blessings-1.6.tar.gz 10:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:47 INFO - Installing collected packages: blessings 10:02:47 INFO - Running setup.py install for blessings 10:02:47 INFO - Successfully installed blessings 10:02:47 INFO - Cleaning up... 10:02:47 INFO - Return code: 0 10:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:48 INFO - Reading from file tmpfile_stdout 10:02:48 INFO - Current package versions: 10:02:48 INFO - argparse == 1.2.1 10:02:48 INFO - blessings == 1.6 10:02:48 INFO - blobuploader == 1.2.4 10:02:48 INFO - docopt == 0.6.1 10:02:48 INFO - functools32 == 3.2.3-2 10:02:48 INFO - jsonschema == 2.5.1 10:02:48 INFO - manifestparser == 1.1 10:02:48 INFO - mozInstall == 1.12 10:02:48 INFO - mozcrash == 0.17 10:02:48 INFO - mozdebug == 0.1 10:02:48 INFO - mozdevice == 0.48 10:02:48 INFO - mozfile == 1.2 10:02:48 INFO - mozhttpd == 0.7 10:02:48 INFO - mozinfo == 0.9 10:02:48 INFO - mozleak == 0.1 10:02:48 INFO - mozlog == 3.3 10:02:48 INFO - moznetwork == 0.27 10:02:48 INFO - mozprocess == 0.23 10:02:48 INFO - mozprofile == 0.28 10:02:48 INFO - mozrunner == 6.12 10:02:48 INFO - mozscreenshot == 0.1 10:02:48 INFO - mozsystemmonitor == 0.3 10:02:48 INFO - moztest == 0.7 10:02:48 INFO - mozversion == 1.4 10:02:48 INFO - psutil == 3.1.1 10:02:48 INFO - requests == 1.2.3 10:02:48 INFO - wsgiref == 0.1.2 10:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:48 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:48 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 10:02:48 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 10:02:48 INFO - Using env: {'DISPLAY': ':0', 10:02:48 INFO - 'HOME': '/home/cltbld', 10:02:48 INFO - 'LANG': 'en_US.UTF-8', 10:02:48 INFO - 'LANGUAGE': 'en_US:en', 10:02:48 INFO - 'LOGNAME': 'cltbld', 10:02:48 INFO - 'MAIL': '/var/mail/cltbld', 10:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:48 INFO - 'MOZ_NO_REMOTE': '1', 10:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:48 INFO - 'NO_EM_RESTART': '1', 10:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:48 INFO - 'PWD': '/builds/slave/test', 10:02:48 INFO - 'SHELL': '/bin/bash', 10:02:48 INFO - 'SHLVL': '1', 10:02:48 INFO - 'TERM': 'linux', 10:02:48 INFO - 'TMOUT': '86400', 10:02:48 INFO - 'USER': 'cltbld', 10:02:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:48 INFO - '_': '/tools/buildbot/bin/python'} 10:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 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)) 10:02:48 INFO - Cleaning up... 10:02:48 INFO - Return code: 0 10:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:48 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 0x20da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', '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 10:02:48 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 10:02:48 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 10:02:48 INFO - Using env: {'DISPLAY': ':0', 10:02:48 INFO - 'HOME': '/home/cltbld', 10:02:48 INFO - 'LANG': 'en_US.UTF-8', 10:02:48 INFO - 'LANGUAGE': 'en_US:en', 10:02:48 INFO - 'LOGNAME': 'cltbld', 10:02:48 INFO - 'MAIL': '/var/mail/cltbld', 10:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:48 INFO - 'MOZ_NO_REMOTE': '1', 10:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:48 INFO - 'NO_EM_RESTART': '1', 10:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:48 INFO - 'PWD': '/builds/slave/test', 10:02:48 INFO - 'SHELL': '/bin/bash', 10:02:48 INFO - 'SHLVL': '1', 10:02:48 INFO - 'TERM': 'linux', 10:02:48 INFO - 'TMOUT': '86400', 10:02:48 INFO - 'USER': 'cltbld', 10:02:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:48 INFO - '_': '/tools/buildbot/bin/python'} 10:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:48 INFO - Cleaning up... 10:02:48 INFO - Return code: 0 10:02:48 INFO - Running post-action listener: _resource_record_post_action 10:02:48 INFO - Running post-action listener: _start_resource_monitoring 10:02:48 INFO - Starting resource monitoring. 10:02:48 INFO - [mozharness: 2016-07-25 17:02:48.591076Z] Finished create-virtualenv step (success) 10:02:48 INFO - [mozharness: 2016-07-25 17:02:48.591554Z] Running install step. 10:02:48 INFO - Running pre-action listener: _resource_record_pre_action 10:02:48 INFO - Running main action method: install 10:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:48 INFO - Reading from file tmpfile_stdout 10:02:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:48 INFO - Reading from file tmpfile_stdout 10:02:48 INFO - Output received: 10:02:48 INFO - Usage: mozinstall [options] installer 10:02:48 INFO - Options: 10:02:48 INFO - -h, --help show this help message and exit 10:02:48 INFO - -d DEST, --destination=DEST 10:02:48 INFO - Directory to install application into. [default: 10:02:48 INFO - "/builds/slave/test"] 10:02:48 INFO - --app=APP Application being installed. [default: firefox] 10:02:48 INFO - mkdir: /builds/slave/test/build/application 10:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:03:06 INFO - Reading from file tmpfile_stdout 10:03:06 INFO - Output received: 10:03:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:03:06 INFO - Running post-action listener: _resource_record_post_action 10:03:06 INFO - [mozharness: 2016-07-25 17:03:06.468119Z] Finished install step (success) 10:03:06 INFO - [mozharness: 2016-07-25 17:03:06.468371Z] Running run-tests step. 10:03:06 INFO - Running pre-action listener: _resource_record_pre_action 10:03:06 INFO - Running main action method: run_tests 10:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:06 INFO - Python 2.7.3 10:03:06 INFO - Return code: 0 10:03:06 INFO - grabbing minidump binary from tooltool 10:03: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:06 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 0x23993b0>, '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 0x239a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:06 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 10:03:06 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 10:03:06 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 10:03:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:06 INFO - Return code: 0 10:03:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:03:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:03:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 10:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 10:03:06 INFO - Using env: {'DISPLAY': ':0', 10:03:06 INFO - 'HOME': '/home/cltbld', 10:03:06 INFO - 'LANG': 'en_US.UTF-8', 10:03:06 INFO - 'LANGUAGE': 'en_US:en', 10:03:06 INFO - 'LOGNAME': 'cltbld', 10:03:06 INFO - 'MAIL': '/var/mail/cltbld', 10:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:06 INFO - 'MOZ_NO_REMOTE': '1', 10:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:06 INFO - 'NO_EM_RESTART': '1', 10:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:06 INFO - 'PWD': '/builds/slave/test', 10:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:06 INFO - 'SHELL': '/bin/bash', 10:03:06 INFO - 'SHLVL': '1', 10:03:06 INFO - 'TERM': 'linux', 10:03:06 INFO - 'TMOUT': '86400', 10:03:06 INFO - 'USER': 'cltbld', 10:03:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229', 10:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:06 INFO - '_': '/tools/buildbot/bin/python'} 10:03:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 10:03:06 INFO - mozversion application_buildid: 20160725053009 10:03:06 INFO - mozversion application_changeset: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f 10:03:06 INFO - mozversion application_display_name: Nightly 10:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:06 INFO - mozversion application_name: Firefox 10:03:06 INFO - mozversion application_remotingname: firefox 10:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:03:06 INFO - mozversion application_vendor: Mozilla 10:03:06 INFO - mozversion application_version: 50.0a1 10:03:06 INFO - mozversion platform_buildid: 20160725053009 10:03:06 INFO - mozversion platform_changeset: 1bb05a19ff9d70ed1d858d526fdbe27a8408f19f 10:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:03:06 INFO - mozversion platform_version: 50.0a1 10:03:06 INFO - using testdate: 1469466186 10:03:06 INFO - actual date: 1469466186 10:03:06 INFO - starting webserver on 'localhost:56073' 10:03:06 INFO - SUITE-START | Running 2 tests 10:03:06 INFO - TEST-START | dromaeo_css 10:03:06 INFO - operating with platform_type : linux_ 10:03:06 INFO - Initialising browser for dromaeo_css test... 10:03:06 INFO - TEST-INFO | started process 22387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_2KAW/profile http://localhost:56073/getInfo.html) 10:03:10 INFO - PROCESS | 22387 | JavaScript error: , line 0: uncaught exception: undefined 10:03:11 INFO - PROCESS | 22387 | __metrics Screen width/height:1600/1200 10:03:11 INFO - PROCESS | 22387 | colorDepth:24 10:03:11 INFO - PROCESS | 22387 | Browser inner width/height: 1024/697 10:03:11 INFO - PROCESS | 22387 | __metrics 10:03:12 ERROR - PROCESS | 22387 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:03:12 INFO - TEST-INFO | 22387: exit 0 10:03:12 INFO - Browser initialized. 10:03:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:12 INFO - TEST-INFO | started process 22506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_2KAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:24 INFO - PROCESS | 22506 | RSS: Main: 167919616 10:03:24 INFO - PROCESS | 22506 | 10:04:14 INFO - PROCESS | 22506 | 1469466254420 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] 10:06:22 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56073/tests/dromaeo/cssquery-ext.html) 10:06:23 INFO - PROCESS | 22506 | RSS: Main: 171950080 10:06:23 INFO - PROCESS | 22506 | 10:09:26 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-ext.html (next: http://localhost:56073/tests/dromaeo/cssquery-jquery.html) 10:09:26 INFO - PROCESS | 22506 | RSS: Main: 170024960 10:09:26 INFO - PROCESS | 22506 | 10:12:28 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56073/tests/dromaeo/cssquery-mootools.html) 10:12:29 INFO - PROCESS | 22506 | RSS: Main: 173481984 10:12:29 INFO - PROCESS | 22506 | 10:15:30 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56073/tests/dromaeo/cssquery-prototype.html) 10:15:31 INFO - PROCESS | 22506 | RSS: Main: 168652800 10:15:31 INFO - PROCESS | 22506 | 10:18:34 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56073/tests/dromaeo/cssquery-yui.html) 10:18:34 INFO - PROCESS | 22506 | RSS: Main: 170487808 10:18:34 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | Cycle 1(1): loaded http://localhost:56073/tests/dromaeo/cssquery-yui.html (next: http://localhost:56073/tests/dromaeo/cssquery-dojo.html) 10:21:37 INFO - PROCESS | 22506 | RSS: Main: 173654016 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | __start_tp_report 10:21:37 INFO - PROCESS | 22506 | _x_x_mozilla_page_load 10:21:37 INFO - PROCESS | 22506 | _x_x_mozilla_page_load_details 10:21:37 INFO - PROCESS | 22506 | |i|pagename|runs| 10:21:37 INFO - PROCESS | 22506 | |0;dojo.html;3054.6029016227894;3114.392693424783;3132.3265497917955;3136.2316232523035;3141.890033848813;5575.665460072399;5583.944160558398;5597.916031259524;5617.747201375938;5626.043572592659;5398.352197736267;5545.972270138654;5546.805861794838;5616.466435688603;5663.122216056508;4994.42564105128;5035.169197082477;5131.307273518083;5154.6134039946965;5162.483751624826;5024.095662780698;5247.055530004598;5255.474452554733;5262;5269.2886460327745;4976.402831660188;4985.626078044161;5110.66780659256;5162.380514338284;5178.974105129488;5006.4743201964;5037.722925239111;5047.394312682502;5063.949360506384;5120.359955005624;5037.949620503785;5056.519630635121;5101.744912754348;5104.234364845266;5109.821156259513;5441.891162176774;5513;5594.804181853657;5631.774729010835;5645.8023969161295;5899.32157801854;5911.438413350725;5911.852203694899;5924.703764811785;5947.940520594825;5920.496757775594;5950.315713692938;5960.433758792951;5968.4031596840405;5971.492423144038;5385.192221166817;5527.889442211173;5548.750306236229;5581.0512212923495;5603.299587551556;6130.2030736004035;6138.756267604181;6165.907511387333;6172.537059720539;6173.660448675366;5913.58604897653;5915.349311575809;5919.112133179971;5926.911096333472;5928.644281343047;5753.769849205984;5784.4504772046585;5937.2578427696535;5987.221661184019;6012.759489620454;5782.537397008229;5911.261092363455;5995.430434108753;6054.182685337423;6059.0608455689435;5908.497777688945;5947.316058653224;5952.613080149863;5977.312609049928;6058.787942422082;4516.983678672338;4527.501974782771;4533.274676051816;4556.8177272908715;4558.8632341029825;3939.3106206413763;3942.8619998299923;3955.0705584187695;3999.960000400017;4041.595840415935;5567.721613919288;5618.550515958714;5632.436756324335;5640.069388550925;5644.604877658607;5904.940950590439;5921.822345329647;5925.644461332247;5928.318243402064;5933.614315069507;5533.723313834292;5638.154276858422;5685.232493613309;5706.258186435737;5778.653280803165;5142.382914050338;5143.691378517301;5145.3568303962;5155.871103222449;5191.377034755854;6142.754289828446;6182.752689892444;6196.667716440987;6225.470834978987;6227.346128656516;5864.0031194697;5902.940970590239;5906.143609176731;5913;6020.367861374492;6087.695615219132;6130;6134.171886795226;6135.723892424762;6147.385261473817;5811.070228763378;5845.883082338414;5847.210626565529;5854.970725146347;5871.853203669772;5804.448577385142;5932.110183472513;5990.550708696778;6002.759889604542;6054.788082417094;5814.622049566765;5847.1229315603;5847.532197424111;5856.385079566584;5863.824085277449;5848.473637372486;5876;5882.411758824083;5882.617629854046;5913.822585322448;5546.528545073714;5645.745941432728;5696.401877802937;5700.201971723879;5707.971460142839;5788.652680839163;5799.971000144972;5806.6806325650805;5816.331121920864;5843.415658434123;5547.7780888764;5710.685912274865;5713.171590119493;5726.284214473191;5731.856703582277 10:21:37 INFO - PROCESS | 22506 | |1;ext.html;547.3970327305674;583.8715482593831;584.4739734239184;602.4487593851625;625.4839757200311;38627.613723862756;43093.56906430935;43159.78420107899;43180;43232.78383608077;42783.35824962628;43272.567274327244;43331;43341.7832910835;43387.34918976218;8675.305975521944;8733.606987685538;8780.473171609692;8792.8681069784;8808.603612837405;8909.287257019423;8984.640614375417;8998;9005.774855628597;9011.54942252888;9038;9062.864057039149;9070.727878163665;9072.591733372014;9115.772105697344;8969.551522423853;9009.684661036865;9040.141186587263;9047.32145089121;9060.77348066297;8909.109089091104;8909.287257019423;8960.23837973773;8983.416077954913;8993.325500587416;39439.60560394388;39549.60450395517;39654.60345396567;39920.401193982114;40105.197896041915;3506.6142724300307;3516.244007538366;3586.444101164324;3636.5454318210222;3726.1802403471193;33156.33687326264;33161.3367732644;33244.66755332464;33440.49839252413;33464.16339591506;4328.956710432918;4412.889677758049;4417;4417.425734654506;4486.4840543337605;342238;343094;343110;343856;344449.27775361214;34084.659153408145;58366;58758.11862822061;58829;59085.70457147687;34647.65352346444;36623.4506482403;36728.816355918585;36802;36847.631523684955;14239.50161744334;14579.343929523196;14584.197869117088;14609.123452592878;14667.266636668124;11386;11579.247348922461;11647.941760291144;11650.941745291218;11659.475323610457;8332.041815191209;8362.916370836214;8389.07720150783;8437.662493500315;8446.239838414449;3220.2754380264255;3252.70725634694;3264.347130573895;3266.1181481;3330.4504756715355;1006.1849901579744;1050.0591092876084;1106.7952428800697;1121.243160866412;1134.160721066405;32438;32844.343113137606;32863.178420539676;32876.835615821765;33228.84012539177;1012.0436187802457;1070.6413351527326;1106.5794997900907;1122.2761318949233;1189.0024758405962;16586.834131658772;17188.742168867477;17255.74116388255;17278.22247998818;17292;609681;614834;615060;615480;615660;59096.40903590995;59351;59503;59505.70247148823;59716;1350.547566565192;1355.4442678501766;1376.9036167468382;1396.1134679478605;1397.3013493253577;30791.076267712004;31817.36365272635;31837.36325273528;32357.191070223435;33011.504827428085;51457.22814157866;51652.483475164765;51746;51835.2224716622;51873.48126518686;480271;485600;489714;489715.8599449002;490493;28045.859770701016;28199.859000704866;28393;28582.285442864093;28629.42741145207;45686.54313456956;48867.26699099445;49096.75451622719;49121.263181051596;49830;39945.60054399419;40671.59328406678;40811.79594102129;41378.586214137475;42939.57060429481;39867.80066099651;42449.78775106105;42523.78738106413;42726.78636606797;43333.56666433295;35656.4651530222;40803;41223.1755364885;41294.58705412907;41419;35865;37638.435423469215;37804.43293350547;38171.42742858804;38441;28722.712772872004;29155.85422072876;29196.978105766197;29336.706632933397;29772 10:21:37 INFO - PROCESS | 22506 | |2;jquery.html;365.4171596303896;384.0648022066268;385.3603018988478;390.50600989747954;414.444644176803;18527.5368115797;19425.22299108034;20412.285570005053;21202.787972120273;21288;12057.638270851867;12203.206791558543;12204.32876191809;12356.567520136798;12405.139229115615;5183.896322073556;5381.139017757159;5386.865328366803;5390.8921821563745;5406.8918621627545;3884.9527093452793;4000.719949603529;5301.416844147141;5345.839624811242;6531.0856480092825;6551.148350714424;6606.966965165191;6622.4370928471135;6633.834154146137;6637.435817955456;6500.284968653468;6565.606063636149;6592.505562082815;6609.074729537869;6623.867522649568;4928.33467481889;5700.201971723962;5858.091995740667;5858.677772722499;5864.384239654817;13556.728865422636;13601.523946661819;20299.883506407143;21751.56496870054;23703.525929481315;2266.2634643740685;2314.745378008418;2342.3090188394294;2384.9046038158453;2425.4178997040585;9961.402315861;10043.74890627733;10131.088202061776;10195.592176312939;10232.334898231666;1844.7417361569392;1862.748528948588;1878.5159723818167;1963.234338607944;1964.302672551238;83027;83834.58082709608;84551.57724211401;84625.57687211587;85189;10854.565817367216;10902.72743181411;10987.890121098686;11363.54545818158;11395.259308144945;15544.766828497355;15552.300146493435;15557.22213889301;15566.84433155654;15627.3749050039;7996.160403157701;8160.673573057011;8172.468789528662;8230.21812927771;8370.53962032094;7689.38484921205;7710;7934.484258523177;7976.641051152712;8010.879836802453;4559.202139625552;4624.121416930772;4632.490426053131;4790.0180463005;4864.659473836798;1945.8054194580711;1951.7267582538457;1970.5960278142945;1976.9901150494156;1977.8417726581838;894.1639567004871;998.4109375468508;998.6454808543008;1027.3579013116803;1073.7906108308962;19606.411807645793;19673.901630491757;21558.412990441248;21663.241786537397;21915.12339506402;979.8971108033696;996.7159359582485;1014.4369874719602;1018.4754851251612;1042.6819819954835;10796.51415686296;11109.83335249972;11120.165987550967;11133.944330278297;11166.720831979103;494171;498093;500342;516317;541003;96508;98854.50572747234;99849.58648776982;100268.4986575077;105483.94516054894;1015.5430056474469;1042.015295545702;1066.168388656849;1070.8661417322835;1071.5017516854543;16055.839441605434;17798.11009449548;17892.210778922003;18148.18333174984;18301.450956471326;32407.675923241408;39537.80231098826;40954.38568421416;41869.79065104655;44250;61748;62462;62810.685946569974;63702.04446933207;63880.36119638744;8067.717629882926;8241.50550966944;8288.83422331538;8307.501549906783;8603.741887743377;10324.845127322946;13739.381727822472;13762.518311859038;13816.378262977989;13832.930835345758;11369.204155709022;12013;12069.517219311128;12128.696782580506;12318.876811232132;11550.249233799776;11707.824382634097;11785.410729463321;11787.233829801036;11808.232464889754;11686.88313116892;11852.288862668267;12020.218685785396;12202.877971220529;12367.196132251374;7985.8402831944195;8036.67853285862;8043.276105150565;8229.753107406787;8625.69810056645;10636.30863993838;11115.610953616584;11497.425128743696;11907.285562866256;11988.64034078979 10:21:37 INFO - PROCESS | 22506 | |3;mootools.html;1476.3651629799185;1498.086167437863;1643.5726711055129;1774.2636805725624;1827.7258411238304;7848.568328741917;8705.695300664478;8800.955995220014;9399.81200375993;9404.529773511324;8846.867296990551;9242;9275.257979361651;9302.069793020695;9318;2353.5292941411744;2370.158593699238;2380.1550449590404;2391.772781585755;2396.6884305040408;2306.2043594959714;2311.0986715181093;2387.2480168746874;2388.450656349041;2388.4984153327737;2364.326167042393;2366.7278262999803;2373;2411.807055435561;2416.4079800448826;2360.527894421114;2365.515069410775;2366.6923299971068;2372.323887692008;2375.0618505690154;2318.7797159269844;2328.906843726249;2331.2889568681544;2338.38032921276;2345.3081341004445;9293;9338.813223735488;9376;9395.06049395055;9403.717888463358;5265.2628631991165;5369.167778994262;5404.162354835007;5415.350157981028;5438.945610543883;3204.5033019881957;3241.546183534307;3254.1213872254593;3254.658260882597;3332.800031998088;1081.8160912644792;1100.9229353945227;1110.2394859521253;1112.7830073135742;1145.2212495503054;12677.809832852514;12785.872141278562;12793.040521960796;12822.03834712391;12847.93576032114;4451.977740111279;4589.449266088091;4651.558101980374;4776;4783.473817880031;10734;10753.731156721145;10756.08573271265;10757.354558726345;10760.654918135233;5350.8127215547265;5362.705051222142;5368.382635996911;5373.301470808769;5382.67703937765;4336.392904993303;4811.49479304675;4918.458969513351;4934.9013019739405;4953.50464953509;3970.722049456568;4059.411385349108;4118.135191609796;4141.503019637603;4161.958380416218;1207.2394391533278;1225.6935766058486;1235.5366737473448;1236.7217376090487;1260.9243445393306;945.1776954049883;955.1069749783974;963.8120566489607;986.5757724178673;1004.0311099788593;6062.969685151635;6151.569390142737;6182.629042257479;6409.327020662857;6430.356964303626;422.5267700175823;430.1955343507661;430.6081465866047;461.0962513473562;472.55579755030163;4392;4419.65758148182;4423.73457592539;4432.312991486325;4557.567031132037;11158.609448669258;11473.254238474472;11507.194496385173;11546.422678866023;11550.364729939934;11571.132165087653;11573.537058517564;11574.826377604342;11602.245854019462;11607.6517704469;7921.128675845767;8126.228008339198;8162.877556836652;8435.283000944988;8446.61990210442;6253.530985176039;6336.841578960563;6477.4494167996245;6551.508636852351;6612.768553100618;10306.536205870603;10450.895491044992;10522.421266830397;10585.4707264638;10599.364038157735;10044.397336159855;10429.68710938673;10432.478376081317;10626.36241825493;10697.197710171924;6936.7225310987;7919.564423956737;8042.758717238492;8168.346532277523;8333.083360830426;9003.684871029482;9039.548022598976;9072.092790720875;9103.271738261055;9116.954415227881;8020.238077382639;8116.066652334821;8127.634256458592;8237.50574965504;8373.37199710012;7787.221277872394;7832.177621349904;7871.252231038042;7952.681892724227;8091.150429205084;6350.936490635035;6506.837329066811;6514;6517.250516190698;6594.373534514213;5362.276092727588;5372.167314066326;5374.059539580479;5448.509634132947;5478.096114141122;5495.697736624365;5603.915941260966;5667.696429821081;5682.494139053071;5711.086226203787 10:21:37 INFO - PROCESS | 22506 | |4;prototype.html;305.8868218759059;314.1611896237047;314.3555710792874;314.4763967993291;317.22280412988187;5630.662160270382;5693.6014478986535;5749.626274292178;5777.884442311157;5786.739596718147;5620.831375058745;5622.634528755628;5622.887542249153;5699.287589051369;5713.457221563945;4114.588541145891;4200.3069493533685;4323.308270676693;4326.701989403182;4374.868753937371;4264.765437900915;4288.16380805743;4302.827886884521;4318.546552611978;4372.693911426201;4332.090261045184;4333.155034768221;4373.803178856943;4384.97807510962;4387.868363949071;4296.562749800163;4317.287647538168;4325.891852703676;4331.155424692186;4375.0812329410865;3768.6796622286865;3782.546094468654;3796.126890815128;3801.2777572261184;3821.5605205401457;5499.175123731432;5504.623844038991;5544.91682624761;5553.16702494625;5562.86092847678;4867.245576935546;4932.5807306379;4948.604111671058;4975.880426903954;5000.67495612784;5802.448767367094;5820.5634577406445;5827.271591051119;5841.912371314434;5851.927737937574;4148;4188.225178342016;4202.201581699467;4203.62167404935;4205.726627769185;5830.387809280007;6055.878882422371;6115.816525504287;6124.693765311717;6130.846728831815;4197.202531519001;4251.277282861921;4258.297380932174;4258.936115958263;4261.446012018418;4305;4311.310190369526;4312.253537317391;4319.568043195655;4324.221640104748;4795.688280261772;4884.145274576935;4889.731064791471;4905.583025442806;5008.69947803133;5908.138936235072;5933.703314834241;5936.287645482484;5938.910916336258;5981.700914954322;1462.700146469971;1474.3070756744312;1479.8964072515037;1481.1187343530582;1484.9851501484848;937.2876613773445;938.4134915677702;972.4894430423942;975.2149519636619;1002.5839276700087;5689.975804355173;5759.1937128802;5765.625234359753;5778.219940308005;5798.217240672455;6054.424829641177;6131.719530051401;6143.877122457615;6150.292716337589;6170.56806023583;5556.77772889088;5695.401982791747;5701.287339082614;5719.571032172604;5796.536277097822;3218.6942240487115;3231.321422501254;3240.914293711633;3262.265990152197;3274.7216486598904;5987.970060149672;6215.595986260879;6243.500519958483;6288.937110628835;6291.811245662638;6081.148639190517;6107.328193898667;6114.5414093942245;6125.9693701531205;6154.415330543681;6207.5654704171175;6233.812985610439;6239.313675495692;6266.968665156736;6275.309715931153;5789.652620842763;5951.16683664296;5954.345022047658;6005.249343832021;6018.8194354169445;5915.733791979457;5977.967491053063;5996.4603185713495;6009.278886533644;6020.187274717857;6058.697065146813;6233.345498722569;6274.152989346379;6280.905786413299;6317.684115794284;4158.37624356349;4160.687948403821;4195.244855925841;4202.915941681211;4208.116295577963;6069.453749162597;6078.65971600928;6091.939080609137;6094.695265236809;6125.540584456273;5787;5803.47768700819;5817.970910145422;5831.970840145772;5877.502885782952;5844.12338149281;5856.560757943086;5861.413858614104;5901.557383196192;5942.870854537624;5287.735613219401;5746.885062298814;5819.970900145641;5852.326982397079;5857.824265272048;5934.169216309807;5944.3164036136395;5952.910706339495;5956.821295361146;5958.421018430033;5723.6851973141875;5748.54011679073;5815.069588865761;5824.330202026821;5850.736716847667 10:21:37 INFO - PROCESS | 22506 | |5;yui.html;700.7232143303395;717.5362260987586;790.1703211627793;853.4196746212573;861.1130535548385;13898.374573144194;13951.511697090604;14034.929825350871;14073.507427240049;14126.858731412683;14821.851781482183;14884.404623815062;14925.253737313118;14983.250837458138;15013.699726005474;679.3885503047247;804.2721337189853;814.5072231300052;819.4345901328095;821.4578378270343;815.9714409995652;820.9302209312216;821;823.6087858267305;824.8185399212164;879.687710862641;881.0528681667201;886.4814083761007;889.2174886100223;896.7489103051156;876.6011464783509;876.9605367758435;877.6708734224666;877.9692710755157;879.7184900831704;643.6652940470975;643.703896207745;644.2011905237518;645.0195702532171;646.1728986896779;14054;14085.084469509551;14095.929520352434;14148.858511414857;14170;16034.118123503202;16199.433019844366;16302.97367119225;16674.416395426102;16876.156192190465;12827.551035713705;12917.289549074798;12954.287514186715;13061.21632702041;13120.868791312156;3906.785126818024;4005.859794907193;4026.355783074723;4028.7784171870535;4093.385992101179;79771;80226.59886700587;80327.19672803256;80870.99999999942;81302;11514.827277590843;11625.18623696333;11693.473793679304;11734.413279335999;11738.413079345999;21033.78966210349;21129;21131.683024754642;21155.365339039854;21167.788322116583;8460.111688272766;8468.66125354979;8545.359098067545;8631.741047768577;8657.783555411164;4889.437714662859;4924.162892308316;4999.350084488993;5092.439831618519;5131.512506311894;3425.2293234022145;3482.564679415073;3485;3498.3353162898966;3511.5610548681416;661.1405173274724;674.824545618133;676.2932735291632;688.579966220605;711.9818659317226;698.0401947322432;712.768350286159;751.4927423988786;771.7530390275058;792.3938187286731;10048.899511004942;10274.589016439259;10278.22913281507;10278.33190842593;10365.957276662108;582.126809785322;586.5659412035063;636.6084857812505;744.8473063022176;750.7334896111802;4803.95196048042;5037.345145131109;5088.949110508922;5119.257707632372;5149.45930677281;128672.35663821621;130082;131292;133080.33459832834;133503.33248333697;88624;90919;115632;116787;118481;81336;85737.57131214305;86642.56678716566;87549;90978.09021909829;9990.850137248093;10164.79670406573;10405.739856503647;10692.1980851438;10764;49576.256356155405;50629.24056139087;51057.489425105276;51893.22160167676;52575;75789.3473728439;78042.2195778035;79058;79891.20108798837;82195.58902205451;13219.867801321863;13390.464381424634;13650.249236292098;13744.518941836988;13925.094868833494;14163.716725665636;15559.688806224038;16604;16675.166241687624;17688.115594220493;14793.11241325524;15143.318550665026;15440.84559154394;15503.379864805282;15553.222338883237;15214.467493637669;15233.3906643733;15302.846971530142;15846.207689615703;16160.272787724816;13776.764829365178;14035.228062456663;14160.079594826304;14404.495842645876;14439.278036097943;11579.363135027654;11834.171607987359;11853.229540079867;11894.464749086139;11898.524059037887;11762.529498819951;11803.409829508319;12073.818892716441;12184.939075304921;12352.303441798145 10:21:37 INFO - PROCESS | 22506 | __end_tp_report 10:21:37 INFO - PROCESS | 22506 | __start_cc_report 10:21:37 INFO - PROCESS | 22506 | _x_x_mozilla_cycle_collect,381 10:21:37 INFO - PROCESS | 22506 | __end_cc_report 10:21:37 INFO - PROCESS | 22506 | __startTimestamp1469467297659__endTimestamp 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | ------- Summary: start ------- 10:21:37 INFO - PROCESS | 22506 | Number of tests: 6 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#0] dojo.html Cycles:165 Average:5529.65 Median:5726.28 stddev:642.41 (11.2%) stddev-sans-first:614.34 10:21:37 INFO - PROCESS | 22506 | Values: 3054.6 3114.4 3132.3 3136.2 3141.9 5575.7 5583.9 5597.9 5617.7 5626.0 5398.4 5546.0 5546.8 5616.5 5663.1 4994.4 5035.2 5131.3 5154.6 5162.5 5024.1 5247.1 5255.5 5262.0 5269.3 4976.4 4985.6 5110.7 5162.4 5179.0 5006.5 5037.7 5047.4 5063.9 5120.4 5037.9 5056.5 5101.7 5104.2 5109.8 5441.9 5513.0 5594.8 5631.8 5645.8 5899.3 5911.4 5911.9 5924.7 5947.9 5920.5 5950.3 5960.4 5968.4 5971.5 5385.2 5527.9 5548.8 5581.1 5603.3 6130.2 6138.8 6165.9 6172.5 6173.7 5913.6 5915.3 5919.1 5926.9 5928.6 5753.8 5784.5 5937.3 5987.2 6012.8 5782.5 5911.3 5995.4 6054.2 6059.1 5908.5 5947.3 5952.6 5977.3 6058.8 4517.0 4527.5 4533.3 4556.8 4558.9 3939.3 3942.9 3955.1 4000.0 4041.6 5567.7 5618.6 5632.4 5640.1 5644.6 5904.9 5921.8 5925.6 5928.3 5933.6 5533.7 5638.2 5685.2 5706.3 5778.7 5142.4 5143.7 5145.4 5155.9 5191.4 6142.8 6182.8 6196.7 6225.5 6227.3 5864.0 5902.9 5906.1 5913.0 6020.4 6087.7 6130.0 6134.2 6135.7 6147.4 5811.1 5845.9 5847.2 5855.0 5871.9 5804.4 5932.1 5990.6 6002.8 6054.8 5814.6 5847.1 5847.5 5856.4 5863.8 5848.5 5876.0 5882.4 5882.6 5913.8 5546.5 5645.7 5696.4 5700.2 5708.0 5788.7 5800.0 5806.7 5816.3 5843.4 5547.8 5710.7 5713.2 5726.3 5731.9 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#1] ext.html Cycles:180 Average:62451.13 Median:40737.30 stddev:131879.54 (323.7%) stddev-sans-first:132167.60 10:21:37 INFO - PROCESS | 22506 | Values: 547.4 583.9 584.5 602.4 625.5 38627.6 43093.6 43159.8 43180.0 43232.8 42783.4 43272.6 43331.0 43341.8 43387.3 8675.3 8733.6 8780.5 8792.9 8808.6 8909.3 8984.6 8998.0 9005.8 9011.5 9038.0 9062.9 9070.7 9072.6 9115.8 8969.6 9009.7 9040.1 9047.3 9060.8 8909.1 8909.3 8960.2 8983.4 8993.3 39439.6 39549.6 39654.6 39920.4 40105.2 3506.6 3516.2 3586.4 3636.5 3726.2 33156.3 33161.3 33244.7 33440.5 33464.2 4329.0 4412.9 4417.0 4417.4 4486.5 342238.0 343094.0 343110.0 343856.0 344449.3 34084.7 58366.0 58758.1 58829.0 59085.7 34647.7 36623.5 36728.8 36802.0 36847.6 14239.5 14579.3 14584.2 14609.1 14667.3 11386.0 11579.2 11647.9 11650.9 11659.5 8332.0 8362.9 8389.1 8437.7 8446.2 3220.3 3252.7 3264.3 3266.1 3330.5 1006.2 1050.1 1106.8 1121.2 1134.2 32438.0 32844.3 32863.2 32876.8 33228.8 1012.0 1070.6 1106.6 1122.3 1189.0 16586.8 17188.7 17255.7 17278.2 17292.0 609681.0 614834.0 615060.0 615480.0 615660.0 59096.4 59351.0 59503.0 59505.7 59716.0 1350.5 1355.4 1376.9 1396.1 1397.3 30791.1 31817.4 31837.4 32357.2 33011.5 51457.2 51652.5 51746.0 51835.2 51873.5 480271.0 485600.0 489714.0 489715.9 490493.0 28045.9 28199.9 28393.0 28582.3 28629.4 45686.5 48867.3 49096.8 49121.3 49830.0 39945.6 40671.6 40811.8 41378.6 42939.6 39867.8 42449.8 42523.8 42726.8 43333.6 35656.5 40803.0 41223.2 41294.6 41419.0 35865.0 37638.4 37804.4 38171.4 38441.0 28722.7 29155.9 29197.0 29336.7 29772.0 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#2] jquery.html Cycles:180 Average:29746.24 Median:2290.50 stddev:84347.77 (3682.5%) stddev-sans-first:84555.54 10:21:37 INFO - PROCESS | 22506 | Values: 365.4 384.1 385.4 390.5 414.4 18527.5 19425.2 20412.3 21202.8 21288.0 12057.6 12203.2 12204.3 12356.6 12405.1 5183.9 5381.1 5386.9 5390.9 5406.9 3885.0 4000.7 5301.4 5345.8 6531.1 6551.1 6607.0 6622.4 6633.8 6637.4 6500.3 6565.6 6592.5 6609.1 6623.9 4928.3 5700.2 5858.1 5858.7 5864.4 13556.7 13601.5 20299.9 21751.6 23703.5 2266.3 2314.7 2342.3 2384.9 2425.4 9961.4 10043.7 10131.1 10195.6 10232.3 1844.7 1862.7 1878.5 1963.2 1964.3 83027.0 83834.6 84551.6 84625.6 85189.0 10854.6 10902.7 10987.9 11363.5 11395.3 15544.8 15552.3 15557.2 15566.8 15627.4 7996.2 8160.7 8172.5 8230.2 8370.5 7689.4 7710.0 7934.5 7976.6 8010.9 4559.2 4624.1 4632.5 4790.0 4864.7 1945.8 1951.7 1970.6 1977.0 1977.8 894.2 998.4 998.6 1027.4 1073.8 19606.4 19673.9 21558.4 21663.2 21915.1 979.9 996.7 1014.4 1018.5 1042.7 10796.5 11109.8 11120.2 11133.9 11166.7 494171.0 498093.0 500342.0 516317.0 541003.0 96508.0 98854.5 99849.6 100268.5 105483.9 1015.5 1042.0 1066.2 1070.9 1071.5 16055.8 17798.1 17892.2 18148.2 18301.5 32407.7 39537.8 40954.4 41869.8 44250.0 61748.0 62462.0 62810.7 63702.0 63880.4 8067.7 8241.5 8288.8 8307.5 8603.7 10324.8 13739.4 13762.5 13816.4 13832.9 11369.2 12013.0 12069.5 12128.7 12318.9 11550.2 11707.8 11785.4 11787.2 11808.2 11686.9 11852.3 12020.2 12202.9 12367.2 7985.8 8036.7 8043.3 8229.8 8625.7 10636.3 11115.6 11497.4 11907.3 11988.6 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#3] mootools.html Cycles:180 Average:5988.36 Median:4573.51 stddev:3476.37 (76.0%) stddev-sans-first:3469.59 10:21:37 INFO - PROCESS | 22506 | Values: 1476.4 1498.1 1643.6 1774.3 1827.7 7848.6 8705.7 8801.0 9399.8 9404.5 8846.9 9242.0 9275.3 9302.1 9318.0 2353.5 2370.2 2380.2 2391.8 2396.7 2306.2 2311.1 2387.2 2388.5 2388.5 2364.3 2366.7 2373.0 2411.8 2416.4 2360.5 2365.5 2366.7 2372.3 2375.1 2318.8 2328.9 2331.3 2338.4 2345.3 9293.0 9338.8 9376.0 9395.1 9403.7 5265.3 5369.2 5404.2 5415.4 5438.9 3204.5 3241.5 3254.1 3254.7 3332.8 1081.8 1100.9 1110.2 1112.8 1145.2 12677.8 12785.9 12793.0 12822.0 12847.9 4452.0 4589.4 4651.6 4776.0 4783.5 10734.0 10753.7 10756.1 10757.4 10760.7 5350.8 5362.7 5368.4 5373.3 5382.7 4336.4 4811.5 4918.5 4934.9 4953.5 3970.7 4059.4 4118.1 4141.5 4162.0 1207.2 1225.7 1235.5 1236.7 1260.9 945.2 955.1 963.8 986.6 1004.0 6063.0 6151.6 6182.6 6409.3 6430.4 422.5 430.2 430.6 461.1 472.6 4392.0 4419.7 4423.7 4432.3 4557.6 11158.6 11473.3 11507.2 11546.4 11550.4 11571.1 11573.5 11574.8 11602.2 11607.7 7921.1 8126.2 8162.9 8435.3 8446.6 6253.5 6336.8 6477.4 6551.5 6612.8 10306.5 10450.9 10522.4 10585.5 10599.4 10044.4 10429.7 10432.5 10626.4 10697.2 6936.7 7919.6 8042.8 8168.3 8333.1 9003.7 9039.5 9072.1 9103.3 9117.0 8020.2 8116.1 8127.6 8237.5 8373.4 7787.2 7832.2 7871.3 7952.7 8091.2 6350.9 6506.8 6514.0 6517.3 6594.4 5362.3 5372.2 5374.1 5448.5 5478.1 5495.7 5603.9 5667.7 5682.5 5711.1 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#4] prototype.html Cycles:180 Average:4948.28 Median:5747.71 stddev:1476.43 (25.7%) stddev-sans-first:1438.86 10:21:37 INFO - PROCESS | 22506 | Values: 305.9 314.2 314.4 314.5 317.2 5630.7 5693.6 5749.6 5777.9 5786.7 5620.8 5622.6 5622.9 5699.3 5713.5 4114.6 4200.3 4323.3 4326.7 4374.9 4264.8 4288.2 4302.8 4318.5 4372.7 4332.1 4333.2 4373.8 4385.0 4387.9 4296.6 4317.3 4325.9 4331.2 4375.1 3768.7 3782.5 3796.1 3801.3 3821.6 5499.2 5504.6 5544.9 5553.2 5562.9 4867.2 4932.6 4948.6 4975.9 5000.7 5802.4 5820.6 5827.3 5841.9 5851.9 4148.0 4188.2 4202.2 4203.6 4205.7 5830.4 6055.9 6115.8 6124.7 6130.8 4197.2 4251.3 4258.3 4258.9 4261.4 4305.0 4311.3 4312.3 4319.6 4324.2 4795.7 4884.1 4889.7 4905.6 5008.7 5908.1 5933.7 5936.3 5938.9 5981.7 1462.7 1474.3 1479.9 1481.1 1485.0 937.3 938.4 972.5 975.2 1002.6 5690.0 5759.2 5765.6 5778.2 5798.2 6054.4 6131.7 6143.9 6150.3 6170.6 5556.8 5695.4 5701.3 5719.6 5796.5 3218.7 3231.3 3240.9 3262.3 3274.7 5988.0 6215.6 6243.5 6288.9 6291.8 6081.1 6107.3 6114.5 6126.0 6154.4 6207.6 6233.8 6239.3 6267.0 6275.3 5789.7 5951.2 5954.3 6005.2 6018.8 5915.7 5978.0 5996.5 6009.3 6020.2 6058.7 6233.3 6274.2 6280.9 6317.7 4158.4 4160.7 4195.2 4202.9 4208.1 6069.5 6078.7 6091.9 6094.7 6125.5 5787.0 5803.5 5818.0 5832.0 5877.5 5844.1 5856.6 5861.4 5901.6 5942.9 5287.7 5746.9 5820.0 5852.3 5857.8 5934.2 5944.3 5952.9 5956.8 5958.4 5723.7 5748.5 5815.1 5824.3 5850.7 10:21:37 INFO - PROCESS | 22506 | 10:21:37 INFO - PROCESS | 22506 | [#5] yui.html Cycles:180 Average:21998.48 Median:3504.95 stddev:32366.46 (923.5%) stddev-sans-first:32417.75 10:21:37 INFO - PROCESS | 22506 | Values: 700.7 717.5 790.2 853.4 861.1 13898.4 13951.5 14034.9 14073.5 14126.9 14821.9 14884.4 14925.3 14983.3 15013.7 679.4 804.3 814.5 819.4 821.5 816.0 820.9 821.0 823.6 824.8 879.7 881.1 886.5 889.2 896.7 876.6 877.0 877.7 878.0 879.7 643.7 643.7 644.2 645.0 646.2 14054.0 14085.1 14095.9 14148.9 14170.0 16034.1 16199.4 16303.0 16674.4 16876.2 12827.6 12917.3 12954.3 13061.2 13120.9 3906.8 4005.9 4026.4 4028.8 4093.4 79771.0 80226.6 80327.2 80871.0 81302.0 11514.8 11625.2 11693.5 11734.4 11738.4 21033.8 21129.0 21131.7 21155.4 21167.8 8460.1 8468.7 8545.4 8631.7 8657.8 4889.4 4924.2 4999.4 5092.4 5131.5 3425.2 3482.6 3485.0 3498.3 3511.6 661.1 674.8 676.3 688.6 712.0 698.0 712.8 751.5 771.8 792.4 10048.9 10274.6 10278.2 10278.3 10366.0 582.1 586.6 636.6 744.8 750.7 4804.0 5037.3 5088.9 5119.3 5149.5 128672.4 130082.0 131292.0 133080.3 133503.3 88624.0 90919.0 115632.0 116787.0 118481.0 81336.0 85737.6 86642.6 87549.0 90978.1 9990.9 10164.8 10405.7 10692.2 10764.0 49576.3 50629.2 51057.5 51893.2 52575.0 75789.3 78042.2 79058.0 79891.2 82195.6 13219.9 13390.5 13650.2 13744.5 13925.1 14163.7 15559.7 16604.0 16675.2 17688.1 14793.1 15143.3 15440.8 15503.4 15553.2 15214.5 15233.4 15302.8 15846.2 16160.3 13776.8 14035.2 14160.1 14404.5 14439.3 11579.4 11834.2 11853.2 11894.5 11898.5 11762.5 11803.4 12073.8 12184.9 12352.3 10:21:37 INFO - PROCESS | 22506 | -------- Summary: end -------- 10:21:37 INFO - PROCESS | 22506 | 10:21:38 INFO - TEST-INFO | 22506: exit 0 10:21:38 INFO - TEST-OK | dromaeo_css | took 1111707ms 10:21:38 INFO - TEST-START | kraken 10:21:38 INFO - operating with platform_type : linux_ 10:21:38 INFO - Initialising browser for kraken test... 10:21:38 INFO - TEST-INFO | started process 22747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_TqKAE/profile http://localhost:56073/getInfo.html) 10:21:41 INFO - PROCESS | 22747 | JavaScript error: , line 0: uncaught exception: undefined 10:21:43 INFO - PROCESS | 22747 | __metrics Screen width/height:1600/1200 10:21:43 INFO - PROCESS | 22747 | colorDepth:24 10:21:43 INFO - PROCESS | 22747 | Browser inner width/height: 1024/697 10:21:43 INFO - PROCESS | 22747 | __metrics 10:21:43 ERROR - PROCESS | 22747 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:21:44 INFO - TEST-INFO | 22747: exit 0 10:21:44 INFO - Browser initialized. 10:21:44 INFO - Running cycle 1/1 for kraken test... 10:21:44 INFO - TEST-INFO | started process 22868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_TqKAE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:56 INFO - PROCESS | 22868 | RSS: Main: 167981056 10:21:56 INFO - PROCESS | 22868 | 10:21:58 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56073/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:59 INFO - PROCESS | 22868 | RSS: Main: 173236224 10:21:59 INFO - PROCESS | 22868 | 10:22:02 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56073/tests/kraken/driver.html?testName=audio-dft) 10:22:02 INFO - PROCESS | 22868 | RSS: Main: 172122112 10:22:02 INFO - PROCESS | 22868 | 10:22:05 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56073/tests/kraken/driver.html?testName=audio-fft) 10:22:06 INFO - PROCESS | 22868 | RSS: Main: 168075264 10:22:06 INFO - PROCESS | 22868 | 10:22:08 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56073/tests/kraken/driver.html?testName=audio-oscillator) 10:22:09 INFO - PROCESS | 22868 | RSS: Main: 169181184 10:22:09 INFO - PROCESS | 22868 | 10:22:11 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:11 INFO - PROCESS | 22868 | RSS: Main: 169549824 10:22:11 INFO - PROCESS | 22868 | 10:22:15 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56073/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:15 INFO - PROCESS | 22868 | RSS: Main: 169123840 10:22:15 INFO - PROCESS | 22868 | 10:22:19 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56073/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:19 INFO - PROCESS | 22868 | RSS: Main: 170541056 10:22:19 INFO - PROCESS | 22868 | 10:22:22 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56073/tests/kraken/driver.html?testName=json-parse-financial) 10:22:23 INFO - PROCESS | 22868 | RSS: Main: 170192896 10:22:23 INFO - PROCESS | 22868 | 10:22:24 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:25 INFO - PROCESS | 22868 | RSS: Main: 170311680 10:22:25 INFO - PROCESS | 22868 | 10:22:27 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:27 INFO - PROCESS | 22868 | RSS: Main: 170749952 10:22:27 INFO - PROCESS | 22868 | 10:22:29 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:30 INFO - PROCESS | 22868 | RSS: Main: 170860544 10:22:30 INFO - PROCESS | 22868 | 10:22:33 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:33 INFO - PROCESS | 22868 | RSS: Main: 171192320 10:22:33 INFO - PROCESS | 22868 | 10:22:36 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:37 INFO - PROCESS | 22868 | RSS: Main: 170733568 10:22:37 INFO - PROCESS | 22868 | 10:22:38 INFO - PROCESS | 22868 | Cycle 1(1): loaded http://localhost:56073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56073/tests/kraken/driver.html?testName=ai-astar) 10:22:39 INFO - PROCESS | 22868 | RSS: Main: 171356160 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | __start_tp_report 10:22:39 INFO - PROCESS | 22868 | _x_x_mozilla_page_load 10:22:39 INFO - PROCESS | 22868 | _x_x_mozilla_page_load_details 10:22:39 INFO - PROCESS | 22868 | |i|pagename|runs| 10:22:39 INFO - PROCESS | 22868 | |0;ai-astar;101;113;111;112;113;115;116;113;113;114 10:22:39 INFO - PROCESS | 22868 | |1;audio-beat-detection;146;117;154;181;119;146;149;121;182;119 10:22:39 INFO - PROCESS | 22868 | |2;audio-dft;162;163;162;162;163;164;175;164;162;166 10:22:39 INFO - PROCESS | 22868 | |3;audio-fft;74;75;76;141;79;76;76;77;171;76 10:22:39 INFO - PROCESS | 22868 | |4;audio-oscillator;84;85;144;85;85;84;131;84;84;154 10:22:39 INFO - PROCESS | 22868 | |5;imaging-gaussian-blur;117;117;118;118;118;117;117;117;118;118 10:22:39 INFO - PROCESS | 22868 | |6;imaging-darkroom;146;146;146;148;148;147;147;147;147;147 10:22:39 INFO - PROCESS | 22868 | |7;imaging-desaturate;95;97;95;95;95;95;96;98;98;95 10:22:39 INFO - PROCESS | 22868 | |8;json-parse-financial;52;54;54;53;54;52;54;54;55;55 10:22:39 INFO - PROCESS | 22868 | |9;json-stringify-tinderbox;61;63;62;61;62;62;63;62;61;62 10:22:39 INFO - PROCESS | 22868 | |10;stanford-crypto-aes;77;79;82;81;77;78;77;76;83;77 10:22:39 INFO - PROCESS | 22868 | |11;stanford-crypto-ccm;120;134;123;129;123;123;122;127;161;146 10:22:39 INFO - PROCESS | 22868 | |12;stanford-crypto-pbkdf2;163;161;163;158;157;158;159;161;154;157 10:22:39 INFO - PROCESS | 22868 | |13;stanford-crypto-sha256-iterative;64;65;64;63;64;63;65;63;64;63 10:22:39 INFO - PROCESS | 22868 | __end_tp_report 10:22:39 INFO - PROCESS | 22868 | __start_cc_report 10:22:39 INFO - PROCESS | 22868 | _x_x_mozilla_cycle_collect,914 10:22:39 INFO - PROCESS | 22868 | __end_cc_report 10:22:39 INFO - PROCESS | 22868 | __startTimestamp1469467359072__endTimestamp 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | ------- Summary: start ------- 10:22:39 INFO - PROCESS | 22868 | Number of tests: 14 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:4.15 (3.7%) stddev-sans-first:1.50 10:22:39 INFO - PROCESS | 22868 | Values: 101.0 113.0 111.0 112.0 113.0 115.0 116.0 113.0 113.0 114.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:147.50 stddev:24.61 (16.7%) stddev-sans-first:26.08 10:22:39 INFO - PROCESS | 22868 | Values: 146.0 117.0 154.0 181.0 119.0 146.0 149.0 121.0 182.0 119.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.97 (2.4%) stddev-sans-first:4.13 10:22:39 INFO - PROCESS | 22868 | Values: 162.0 163.0 162.0 162.0 163.0 164.0 175.0 164.0 162.0 166.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:34.44 (45.3%) stddev-sans-first:35.90 10:22:39 INFO - PROCESS | 22868 | Values: 74.0 75.0 76.0 141.0 79.0 76.0 76.0 77.0 171.0 76.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.00 stddev:28.81 (34.3%) stddev-sans-first:29.82 10:22:39 INFO - PROCESS | 22868 | Values: 84.0 85.0 144.0 85.0 85.0 84.0 131.0 84.0 84.0 154.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:22:39 INFO - PROCESS | 22868 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:22:39 INFO - PROCESS | 22868 | Values: 146.0 146.0 146.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.29 (1.3%) stddev-sans-first:1.32 10:22:39 INFO - PROCESS | 22868 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 96.0 98.0 98.0 95.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:0.93 10:22:39 INFO - PROCESS | 22868 | Values: 52.0 54.0 54.0 53.0 54.0 52.0 54.0 54.0 55.0 55.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 10:22:39 INFO - PROCESS | 22868 | Values: 61.0 63.0 62.0 61.0 62.0 62.0 63.0 62.0 61.0 62.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:2.45 (3.1%) stddev-sans-first:2.52 10:22:39 INFO - PROCESS | 22868 | Values: 77.0 79.0 82.0 81.0 77.0 78.0 77.0 76.0 83.0 77.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:128.00 stddev:13.11 (10.2%) stddev-sans-first:13.31 10:22:39 INFO - PROCESS | 22868 | Values: 120.0 134.0 123.0 129.0 123.0 123.0 122.0 127.0 161.0 146.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:2.88 (1.8%) stddev-sans-first:2.69 10:22:39 INFO - PROCESS | 22868 | Values: 163.0 161.0 163.0 158.0 157.0 158.0 159.0 161.0 154.0 157.0 10:22:39 INFO - PROCESS | 22868 | 10:22:39 INFO - PROCESS | 22868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 10:22:39 INFO - PROCESS | 22868 | Values: 64.0 65.0 64.0 63.0 64.0 63.0 65.0 63.0 64.0 63.0 10:22:39 INFO - PROCESS | 22868 | -------- Summary: end -------- 10:22:39 INFO - PROCESS | 22868 | 10:22:40 INFO - TEST-INFO | 22868: exit 0 10:22:40 INFO - TEST-OK | kraken | took 61680ms 10:22:40 INFO - SUITE-END | took 1173s 10:22:40 INFO - Completed test suite (00:19:33) 10:22:40 INFO - javascript benchmark 10:22:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7344.385752923471, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.6029016227894, 3114.392693424783, 3132.3265497917955, 3136.2316232523035, 3141.890033848813, 5575.665460072399, 5583.944160558398, 5597.916031259524, 5617.747201375938, 5626.043572592659, 5398.352197736267, 5545.972270138654, 5546.805861794838, 5616.466435688603, 5663.122216056508, 4994.42564105128, 5035.169197082477, 5131.307273518083, 5154.6134039946965, 5162.483751624826, 5024.095662780698, 5247.055530004598, 5255.474452554733, 5262.0, 5269.2886460327745, 4976.402831660188, 4985.626078044161, 5110.66780659256, 5162.380514338284, 5178.974105129488, 5006.4743201964, 5037.722925239111, 5047.394312682502, 5063.949360506384, 5120.359955005624, 5037.949620503785, 5056.519630635121, 5101.744912754348, 5104.234364845266, 5109.821156259513, 5441.891162176774, 5513.0, 5594.804181853657, 5631.774729010835, 5645.8023969161295, 5899.32157801854, 5911.438413350725, 5911.852203694899, 5924.703764811785, 5947.940520594825, 5920.496757775594, 5950.315713692938, 5960.433758792951, 5968.4031596840405, 5971.492423144038, 5385.192221166817, 5527.889442211173, 5548.750306236229, 5581.0512212923495, 5603.299587551556, 6130.2030736004035, 6138.756267604181, 6165.907511387333, 6172.537059720539, 6173.660448675366, 5913.58604897653, 5915.349311575809, 5919.112133179971, 5926.911096333472, 5928.644281343047, 5753.769849205984, 5784.4504772046585, 5937.2578427696535, 5987.221661184019, 6012.759489620454, 5782.537397008229, 5911.261092363455, 5995.430434108753, 6054.182685337423, 6059.0608455689435, 5908.497777688945, 5947.316058653224, 5952.613080149863, 5977.312609049928, 6058.787942422082, 4516.983678672338, 4527.501974782771, 4533.274676051816, 4556.8177272908715, 4558.8632341029825, 3939.3106206413763, 3942.8619998299923, 3955.0705584187695, 3999.960000400017, 4041.595840415935, 5567.721613919288, 5618.550515958714, 5632.436756324335, 5640.069388550925, 5644.604877658607, 5904.940950590439, 5921.822345329647, 5925.644461332247, 5928.318243402064, 5933.614315069507, 5533.723313834292, 5638.154276858422, 5685.232493613309, 5706.258186435737, 5778.653280803165, 5142.382914050338, 5143.691378517301, 5145.3568303962, 5155.871103222449, 5191.377034755854, 6142.754289828446, 6182.752689892444, 6196.667716440987, 6225.470834978987, 6227.346128656516, 5864.0031194697, 5902.940970590239, 5906.143609176731, 5913.0, 6020.367861374492, 6087.695615219132, 6130.0, 6134.171886795226, 6135.723892424762, 6147.385261473817, 5811.070228763378, 5845.883082338414, 5847.210626565529, 5854.970725146347, 5871.853203669772, 5804.448577385142, 5932.110183472513, 5990.550708696778, 6002.759889604542, 6054.788082417094, 5814.622049566765, 5847.1229315603, 5847.532197424111, 5856.385079566584, 5863.824085277449, 5848.473637372486, 5876.0, 5882.411758824083, 5882.617629854046, 5913.822585322448, 5546.528545073714, 5645.745941432728, 5696.401877802937, 5700.201971723879, 5707.971460142839, 5788.652680839163, 5799.971000144972, 5806.6806325650805, 5816.331121920864, 5843.415658434123, 5547.7780888764, 5710.685912274865, 5713.171590119493, 5726.284214473191, 5731.856703582277], "value": 5484.377937150553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3970327305674, 583.8715482593831, 584.4739734239184, 602.4487593851625, 625.4839757200311, 38627.613723862756, 43093.56906430935, 43159.78420107899, 43180.0, 43232.78383608077, 42783.35824962628, 43272.567274327244, 43331.0, 43341.7832910835, 43387.34918976218, 8675.305975521944, 8733.606987685538, 8780.473171609692, 8792.8681069784, 8808.603612837405, 8909.287257019423, 8984.640614375417, 8998.0, 9005.774855628597, 9011.54942252888, 9038.0, 9062.864057039149, 9070.727878163665, 9072.591733372014, 9115.772105697344, 8969.551522423853, 9009.684661036865, 9040.141186587263, 9047.32145089121, 9060.77348066297, 8909.109089091104, 8909.287257019423, 8960.23837973773, 8983.416077954913, 8993.325500587416, 39439.60560394388, 39549.60450395517, 39654.60345396567, 39920.401193982114, 40105.197896041915, 3506.6142724300307, 3516.244007538366, 3586.444101164324, 3636.5454318210222, 3726.1802403471193, 33156.33687326264, 33161.3367732644, 33244.66755332464, 33440.49839252413, 33464.16339591506, 4328.956710432918, 4412.889677758049, 4417.0, 4417.425734654506, 4486.4840543337605, 342238.0, 343094.0, 343110.0, 343856.0, 344449.27775361214, 34084.659153408145, 58366.0, 58758.11862822061, 58829.0, 59085.70457147687, 34647.65352346444, 36623.4506482403, 36728.816355918585, 36802.0, 36847.631523684955, 14239.50161744334, 14579.343929523196, 14584.197869117088, 14609.123452592878, 14667.266636668124, 11386.0, 11579.247348922461, 11647.941760291144, 11650.941745291218, 11659.475323610457, 8332.041815191209, 8362.916370836214, 8389.07720150783, 8437.662493500315, 8446.239838414449, 3220.2754380264255, 3252.70725634694, 3264.347130573895, 3266.1181481, 3330.4504756715355, 1006.1849901579744, 1050.0591092876084, 1106.7952428800697, 1121.243160866412, 1134.160721066405, 32438.0, 32844.343113137606, 32863.178420539676, 32876.835615821765, 33228.84012539177, 1012.0436187802457, 1070.6413351527326, 1106.5794997900907, 1122.2761318949233, 1189.0024758405962, 16586.834131658772, 17188.742168867477, 17255.74116388255, 17278.22247998818, 17292.0, 609681.0, 614834.0, 615060.0, 615480.0, 615660.0, 59096.40903590995, 59351.0, 59503.0, 59505.70247148823, 59716.0, 1350.547566565192, 1355.4442678501766, 1376.9036167468382, 1396.1134679478605, 1397.3013493253577, 30791.076267712004, 31817.36365272635, 31837.36325273528, 32357.191070223435, 33011.504827428085, 51457.22814157866, 51652.483475164765, 51746.0, 51835.2224716622, 51873.48126518686, 480271.0, 485600.0, 489714.0, 489715.8599449002, 490493.0, 28045.859770701016, 28199.859000704866, 28393.0, 28582.285442864093, 28629.42741145207, 45686.54313456956, 48867.26699099445, 49096.75451622719, 49121.263181051596, 49830.0, 39945.60054399419, 40671.59328406678, 40811.79594102129, 41378.586214137475, 42939.57060429481, 39867.80066099651, 42449.78775106105, 42523.78738106413, 42726.78636606797, 43333.56666433295, 35656.4651530222, 40803.0, 41223.1755364885, 41294.58705412907, 41419.0, 35865.0, 37638.435423469215, 37804.43293350547, 38171.42742858804, 38441.0, 28722.712772872004, 29155.85422072876, 29196.978105766197, 29336.706632933397, 29772.0], "value": 19033.489825580895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4171596303896, 384.0648022066268, 385.3603018988478, 390.50600989747954, 414.444644176803, 18527.5368115797, 19425.22299108034, 20412.285570005053, 21202.787972120273, 21288.0, 12057.638270851867, 12203.206791558543, 12204.32876191809, 12356.567520136798, 12405.139229115615, 5183.896322073556, 5381.139017757159, 5386.865328366803, 5390.8921821563745, 5406.8918621627545, 3884.9527093452793, 4000.719949603529, 5301.416844147141, 5345.839624811242, 6531.0856480092825, 6551.148350714424, 6606.966965165191, 6622.4370928471135, 6633.834154146137, 6637.435817955456, 6500.284968653468, 6565.606063636149, 6592.505562082815, 6609.074729537869, 6623.867522649568, 4928.33467481889, 5700.201971723962, 5858.091995740667, 5858.677772722499, 5864.384239654817, 13556.728865422636, 13601.523946661819, 20299.883506407143, 21751.56496870054, 23703.525929481315, 2266.2634643740685, 2314.745378008418, 2342.3090188394294, 2384.9046038158453, 2425.4178997040585, 9961.402315861, 10043.74890627733, 10131.088202061776, 10195.592176312939, 10232.334898231666, 1844.7417361569392, 1862.748528948588, 1878.5159723818167, 1963.234338607944, 1964.302672551238, 83027.0, 83834.58082709608, 84551.57724211401, 84625.57687211587, 85189.0, 10854.565817367216, 10902.72743181411, 10987.890121098686, 11363.54545818158, 11395.259308144945, 15544.766828497355, 15552.300146493435, 15557.22213889301, 15566.84433155654, 15627.3749050039, 7996.160403157701, 8160.673573057011, 8172.468789528662, 8230.21812927771, 8370.53962032094, 7689.38484921205, 7710.0, 7934.484258523177, 7976.641051152712, 8010.879836802453, 4559.202139625552, 4624.121416930772, 4632.490426053131, 4790.0180463005, 4864.659473836798, 1945.8054194580711, 1951.7267582538457, 1970.5960278142945, 1976.9901150494156, 1977.8417726581838, 894.1639567004871, 998.4109375468508, 998.6454808543008, 1027.3579013116803, 1073.7906108308962, 19606.411807645793, 19673.901630491757, 21558.412990441248, 21663.241786537397, 21915.12339506402, 979.8971108033696, 996.7159359582485, 1014.4369874719602, 1018.4754851251612, 1042.6819819954835, 10796.51415686296, 11109.83335249972, 11120.165987550967, 11133.944330278297, 11166.720831979103, 494171.0, 498093.0, 500342.0, 516317.0, 541003.0, 96508.0, 98854.50572747234, 99849.58648776982, 100268.4986575077, 105483.94516054894, 1015.5430056474469, 1042.015295545702, 1066.168388656849, 1070.8661417322835, 1071.5017516854543, 16055.839441605434, 17798.11009449548, 17892.210778922003, 18148.18333174984, 18301.450956471326, 32407.675923241408, 39537.80231098826, 40954.38568421416, 41869.79065104655, 44250.0, 61748.0, 62462.0, 62810.685946569974, 63702.04446933207, 63880.36119638744, 8067.717629882926, 8241.50550966944, 8288.83422331538, 8307.501549906783, 8603.741887743377, 10324.845127322946, 13739.381727822472, 13762.518311859038, 13816.378262977989, 13832.930835345758, 11369.204155709022, 12013.0, 12069.517219311128, 12128.696782580506, 12318.876811232132, 11550.249233799776, 11707.824382634097, 11785.410729463321, 11787.233829801036, 11808.232464889754, 11686.88313116892, 11852.288862668267, 12020.218685785396, 12202.877971220529, 12367.196132251374, 7985.8402831944195, 8036.67853285862, 8043.276105150565, 8229.753107406787, 8625.69810056645, 10636.30863993838, 11115.610953616584, 11497.425128743696, 11907.285562866256, 11988.64034078979], "value": 9167.783012635438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.3651629799185, 1498.086167437863, 1643.5726711055129, 1774.2636805725624, 1827.7258411238304, 7848.568328741917, 8705.695300664478, 8800.955995220014, 9399.81200375993, 9404.529773511324, 8846.867296990551, 9242.0, 9275.257979361651, 9302.069793020695, 9318.0, 2353.5292941411744, 2370.158593699238, 2380.1550449590404, 2391.772781585755, 2396.6884305040408, 2306.2043594959714, 2311.0986715181093, 2387.2480168746874, 2388.450656349041, 2388.4984153327737, 2364.326167042393, 2366.7278262999803, 2373.0, 2411.807055435561, 2416.4079800448826, 2360.527894421114, 2365.515069410775, 2366.6923299971068, 2372.323887692008, 2375.0618505690154, 2318.7797159269844, 2328.906843726249, 2331.2889568681544, 2338.38032921276, 2345.3081341004445, 9293.0, 9338.813223735488, 9376.0, 9395.06049395055, 9403.717888463358, 5265.2628631991165, 5369.167778994262, 5404.162354835007, 5415.350157981028, 5438.945610543883, 3204.5033019881957, 3241.546183534307, 3254.1213872254593, 3254.658260882597, 3332.800031998088, 1081.8160912644792, 1100.9229353945227, 1110.2394859521253, 1112.7830073135742, 1145.2212495503054, 12677.809832852514, 12785.872141278562, 12793.040521960796, 12822.03834712391, 12847.93576032114, 4451.977740111279, 4589.449266088091, 4651.558101980374, 4776.0, 4783.473817880031, 10734.0, 10753.731156721145, 10756.08573271265, 10757.354558726345, 10760.654918135233, 5350.8127215547265, 5362.705051222142, 5368.382635996911, 5373.301470808769, 5382.67703937765, 4336.392904993303, 4811.49479304675, 4918.458969513351, 4934.9013019739405, 4953.50464953509, 3970.722049456568, 4059.411385349108, 4118.135191609796, 4141.503019637603, 4161.958380416218, 1207.2394391533278, 1225.6935766058486, 1235.5366737473448, 1236.7217376090487, 1260.9243445393306, 945.1776954049883, 955.1069749783974, 963.8120566489607, 986.5757724178673, 1004.0311099788593, 6062.969685151635, 6151.569390142737, 6182.629042257479, 6409.327020662857, 6430.356964303626, 422.5267700175823, 430.1955343507661, 430.6081465866047, 461.0962513473562, 472.55579755030163, 4392.0, 4419.65758148182, 4423.73457592539, 4432.312991486325, 4557.567031132037, 11158.609448669258, 11473.254238474472, 11507.194496385173, 11546.422678866023, 11550.364729939934, 11571.132165087653, 11573.537058517564, 11574.826377604342, 11602.245854019462, 11607.6517704469, 7921.128675845767, 8126.228008339198, 8162.877556836652, 8435.283000944988, 8446.61990210442, 6253.530985176039, 6336.841578960563, 6477.4494167996245, 6551.508636852351, 6612.768553100618, 10306.536205870603, 10450.895491044992, 10522.421266830397, 10585.4707264638, 10599.364038157735, 10044.397336159855, 10429.68710938673, 10432.478376081317, 10626.36241825493, 10697.197710171924, 6936.7225310987, 7919.564423956737, 8042.758717238492, 8168.346532277523, 8333.083360830426, 9003.684871029482, 9039.548022598976, 9072.092790720875, 9103.271738261055, 9116.954415227881, 8020.238077382639, 8116.066652334821, 8127.634256458592, 8237.50574965504, 8373.37199710012, 7787.221277872394, 7832.177621349904, 7871.252231038042, 7952.681892724227, 8091.150429205084, 6350.936490635035, 6506.837329066811, 6514.0, 6517.250516190698, 6594.373534514213, 5362.276092727588, 5372.167314066326, 5374.059539580479, 5448.509634132947, 5478.096114141122, 5495.697736624365, 5603.915941260966, 5667.696429821081, 5682.494139053071, 5711.086226203787], "value": 4671.295995202091, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8868218759059, 314.1611896237047, 314.3555710792874, 314.4763967993291, 317.22280412988187, 5630.662160270382, 5693.6014478986535, 5749.626274292178, 5777.884442311157, 5786.739596718147, 5620.831375058745, 5622.634528755628, 5622.887542249153, 5699.287589051369, 5713.457221563945, 4114.588541145891, 4200.3069493533685, 4323.308270676693, 4326.701989403182, 4374.868753937371, 4264.765437900915, 4288.16380805743, 4302.827886884521, 4318.546552611978, 4372.693911426201, 4332.090261045184, 4333.155034768221, 4373.803178856943, 4384.97807510962, 4387.868363949071, 4296.562749800163, 4317.287647538168, 4325.891852703676, 4331.155424692186, 4375.0812329410865, 3768.6796622286865, 3782.546094468654, 3796.126890815128, 3801.2777572261184, 3821.5605205401457, 5499.175123731432, 5504.623844038991, 5544.91682624761, 5553.16702494625, 5562.86092847678, 4867.245576935546, 4932.5807306379, 4948.604111671058, 4975.880426903954, 5000.67495612784, 5802.448767367094, 5820.5634577406445, 5827.271591051119, 5841.912371314434, 5851.927737937574, 4148.0, 4188.225178342016, 4202.201581699467, 4203.62167404935, 4205.726627769185, 5830.387809280007, 6055.878882422371, 6115.816525504287, 6124.693765311717, 6130.846728831815, 4197.202531519001, 4251.277282861921, 4258.297380932174, 4258.936115958263, 4261.446012018418, 4305.0, 4311.310190369526, 4312.253537317391, 4319.568043195655, 4324.221640104748, 4795.688280261772, 4884.145274576935, 4889.731064791471, 4905.583025442806, 5008.69947803133, 5908.138936235072, 5933.703314834241, 5936.287645482484, 5938.910916336258, 5981.700914954322, 1462.700146469971, 1474.3070756744312, 1479.8964072515037, 1481.1187343530582, 1484.9851501484848, 937.2876613773445, 938.4134915677702, 972.4894430423942, 975.2149519636619, 1002.5839276700087, 5689.975804355173, 5759.1937128802, 5765.625234359753, 5778.219940308005, 5798.217240672455, 6054.424829641177, 6131.719530051401, 6143.877122457615, 6150.292716337589, 6170.56806023583, 5556.77772889088, 5695.401982791747, 5701.287339082614, 5719.571032172604, 5796.536277097822, 3218.6942240487115, 3231.321422501254, 3240.914293711633, 3262.265990152197, 3274.7216486598904, 5987.970060149672, 6215.595986260879, 6243.500519958483, 6288.937110628835, 6291.811245662638, 6081.148639190517, 6107.328193898667, 6114.5414093942245, 6125.9693701531205, 6154.415330543681, 6207.5654704171175, 6233.812985610439, 6239.313675495692, 6266.968665156736, 6275.309715931153, 5789.652620842763, 5951.16683664296, 5954.345022047658, 6005.249343832021, 6018.8194354169445, 5915.733791979457, 5977.967491053063, 5996.4603185713495, 6009.278886533644, 6020.187274717857, 6058.697065146813, 6233.345498722569, 6274.152989346379, 6280.905786413299, 6317.684115794284, 4158.37624356349, 4160.687948403821, 4195.244855925841, 4202.915941681211, 4208.116295577963, 6069.453749162597, 6078.65971600928, 6091.939080609137, 6094.695265236809, 6125.540584456273, 5787.0, 5803.47768700819, 5817.970910145422, 5831.970840145772, 5877.502885782952, 5844.12338149281, 5856.560757943086, 5861.413858614104, 5901.557383196192, 5942.870854537624, 5287.735613219401, 5746.885062298814, 5819.970900145641, 5852.326982397079, 5857.824265272048, 5934.169216309807, 5944.3164036136395, 5952.910706339495, 5956.821295361146, 5958.421018430033, 5723.6851973141875, 5748.54011679073, 5815.069588865761, 5824.330202026821, 5850.736716847667], "value": 4462.575898188662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7232143303395, 717.5362260987586, 790.1703211627793, 853.4196746212573, 861.1130535548385, 13898.374573144194, 13951.511697090604, 14034.929825350871, 14073.507427240049, 14126.858731412683, 14821.851781482183, 14884.404623815062, 14925.253737313118, 14983.250837458138, 15013.699726005474, 679.3885503047247, 804.2721337189853, 814.5072231300052, 819.4345901328095, 821.4578378270343, 815.9714409995652, 820.9302209312216, 821.0, 823.6087858267305, 824.8185399212164, 879.687710862641, 881.0528681667201, 886.4814083761007, 889.2174886100223, 896.7489103051156, 876.6011464783509, 876.9605367758435, 877.6708734224666, 877.9692710755157, 879.7184900831704, 643.6652940470975, 643.703896207745, 644.2011905237518, 645.0195702532171, 646.1728986896779, 14054.0, 14085.084469509551, 14095.929520352434, 14148.858511414857, 14170.0, 16034.118123503202, 16199.433019844366, 16302.97367119225, 16674.416395426102, 16876.156192190465, 12827.551035713705, 12917.289549074798, 12954.287514186715, 13061.21632702041, 13120.868791312156, 3906.785126818024, 4005.859794907193, 4026.355783074723, 4028.7784171870535, 4093.385992101179, 79771.0, 80226.59886700587, 80327.19672803256, 80870.99999999942, 81302.0, 11514.827277590843, 11625.18623696333, 11693.473793679304, 11734.413279335999, 11738.413079345999, 21033.78966210349, 21129.0, 21131.683024754642, 21155.365339039854, 21167.788322116583, 8460.111688272766, 8468.66125354979, 8545.359098067545, 8631.741047768577, 8657.783555411164, 4889.437714662859, 4924.162892308316, 4999.350084488993, 5092.439831618519, 5131.512506311894, 3425.2293234022145, 3482.564679415073, 3485.0, 3498.3353162898966, 3511.5610548681416, 661.1405173274724, 674.824545618133, 676.2932735291632, 688.579966220605, 711.9818659317226, 698.0401947322432, 712.768350286159, 751.4927423988786, 771.7530390275058, 792.3938187286731, 10048.899511004942, 10274.589016439259, 10278.22913281507, 10278.33190842593, 10365.957276662108, 582.126809785322, 586.5659412035063, 636.6084857812505, 744.8473063022176, 750.7334896111802, 4803.95196048042, 5037.345145131109, 5088.949110508922, 5119.257707632372, 5149.45930677281, 128672.35663821621, 130082.0, 131292.0, 133080.33459832834, 133503.33248333697, 88624.0, 90919.0, 115632.0, 116787.0, 118481.0, 81336.0, 85737.57131214305, 86642.56678716566, 87549.0, 90978.09021909829, 9990.850137248093, 10164.79670406573, 10405.739856503647, 10692.1980851438, 10764.0, 49576.256356155405, 50629.24056139087, 51057.489425105276, 51893.22160167676, 52575.0, 75789.3473728439, 78042.2195778035, 79058.0, 79891.20108798837, 82195.58902205451, 13219.867801321863, 13390.464381424634, 13650.249236292098, 13744.518941836988, 13925.094868833494, 14163.716725665636, 15559.688806224038, 16604.0, 16675.166241687624, 17688.115594220493, 14793.11241325524, 15143.318550665026, 15440.84559154394, 15503.379864805282, 15553.222338883237, 15214.467493637669, 15233.3906643733, 15302.846971530142, 15846.207689615703, 16160.272787724816, 13776.764829365178, 14035.228062456663, 14160.079594826304, 14404.495842645876, 14439.278036097943, 11579.363135027654, 11834.171607987359, 11853.229540079867, 11894.464749086139, 11898.524059037887, 11762.529498819951, 11803.409829508319, 12073.818892716441, 12184.939075304921, 12352.303441798145], "value": 7866.103910882188, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 112.0, 113.0, 115.0, 116.0, 113.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 154.0, 181.0, 119.0, 146.0, 149.0, 121.0, 182.0, 119.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 175.0, 164.0, 162.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 141.0, 79.0, 76.0, 76.0, 77.0, 171.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 144.0, 85.0, 85.0, 84.0, 131.0, 84.0, 84.0, 154.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 98.0, 98.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 53.0, 54.0, 52.0, 54.0, 54.0, 55.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 82.0, 81.0, 77.0, 78.0, 77.0, 76.0, 83.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 134.0, 123.0, 129.0, 123.0, 123.0, 122.0, 127.0, 161.0, 146.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 158.0, 157.0, 158.0, 159.0, 161.0, 154.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 63.0], "value": 63.8, "unit": "score"}]}]} 10:22:40 INFO - Return code: 0 10:22:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:40 ERROR - # TBPL SUCCESS # 10:22:40 INFO - Running post-action listener: _resource_record_post_action 10:22:40 INFO - [mozharness: 2016-07-25 17:22:40.401365Z] Finished run-tests step (success) 10:22:40 INFO - Running post-run listener: _resource_record_post_run 10:22:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 562720768; Read time: 48; Write time: 405236 10:22:40 INFO - TinderboxPrint: CPU usage
13.3% 10:22:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 48 10:22:40 INFO - TinderboxPrint: I/O write bytes / time
562,720,768 / 405,236 10:22:40 INFO - TinderboxPrint: CPU idle
8,239.4 (86.7%) 10:22:40 INFO - TinderboxPrint: CPU user
1,207.8 (12.7%) 10:22:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:40 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270663680; Read time: 0; Write time: 219912 10:22:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291442688; Read time: 48; Write time: 185324 10:22:41 INFO - Running post-run listener: _upload_blobber_files 10:22:41 INFO - Blob upload gear active. 10:22:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:48 INFO - (blobuploader) - INFO - Done attempting. 10:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:49 INFO - (blobuploader) - INFO - Done attempting. 10:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:50 INFO - (blobuploader) - INFO - Done attempting. 10:22:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:50 INFO - Return code: 0 10:22:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c02b023a88e9c7e89a17253a659d3513ae320a793527afb18af93ade92cf37fc3d7d8f1d7dfde5b70339ef81eafdd14e88617ebf3b8281b1bf008447106a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf3e3f1a283a39b3241ccea2d3a0ed6cae376117d5a64a3b9c9fabb6eabfbcf41f5c51ec2bf0f1980f3ae7e2336d25ed8e88b71d0b9df1924a5ff7045254cdf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92ce6081c307fb6a66b85f36b69105752d59c71acd07336de531610f032e88a29711caced3e219913df3164e583aaba25ac0dec84d03bfaf9f263e8b97109172"} 10:22:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:50 INFO - Contents: 10:22:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c02b023a88e9c7e89a17253a659d3513ae320a793527afb18af93ade92cf37fc3d7d8f1d7dfde5b70339ef81eafdd14e88617ebf3b8281b1bf008447106a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf3e3f1a283a39b3241ccea2d3a0ed6cae376117d5a64a3b9c9fabb6eabfbcf41f5c51ec2bf0f1980f3ae7e2336d25ed8e88b71d0b9df1924a5ff7045254cdf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92ce6081c307fb6a66b85f36b69105752d59c71acd07336de531610f032e88a29711caced3e219913df3164e583aaba25ac0dec84d03bfaf9f263e8b97109172"} 10:22:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:50 INFO - Copying logs to upload dir... 10:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.826074 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-25 10:22:49.420375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 10:22:49.423601) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c02b023a88e9c7e89a17253a659d3513ae320a793527afb18af93ade92cf37fc3d7d8f1d7dfde5b70339ef81eafdd14e88617ebf3b8281b1bf008447106a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf3e3f1a283a39b3241ccea2d3a0ed6cae376117d5a64a3b9c9fabb6eabfbcf41f5c51ec2bf0f1980f3ae7e2336d25ed8e88b71d0b9df1924a5ff7045254cdf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92ce6081c307fb6a66b85f36b69105752d59c71acd07336de531610f032e88a29711caced3e219913df3164e583aaba25ac0dec84d03bfaf9f263e8b97109172"} build_url:https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/KMJpB9-ZQbW-aCQbv1Wuhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c02b023a88e9c7e89a17253a659d3513ae320a793527afb18af93ade92cf37fc3d7d8f1d7dfde5b70339ef81eafdd14e88617ebf3b8281b1bf008447106a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf3e3f1a283a39b3241ccea2d3a0ed6cae376117d5a64a3b9c9fabb6eabfbcf41f5c51ec2bf0f1980f3ae7e2336d25ed8e88b71d0b9df1924a5ff7045254cdf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92ce6081c307fb6a66b85f36b69105752d59c71acd07336de531610f032e88a29711caced3e219913df3164e583aaba25ac0dec84d03bfaf9f263e8b97109172"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 10:22:49.448181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:22:49.448498) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469466133.690000-1251050229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:22:49.534081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 10:22:49.534402) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 10:22:49.534689) ========= ========= Total master_lag: 0.17 =========