builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1471890730.24 results: success (0) buildid: 20160822083013 builduid: 8eb2355976244bf5b62478ae7af1debf revision: 95e17b89b51955aabf9986ef9f2f973053630579 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.243567) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.243938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.244254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.255567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.255879) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 11:32:10-- 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% 224M=0s 2016-08-22 11:32:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.389983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.390438) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:10.441234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 11:32:10.441695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95e17b89b51955aabf9986ef9f2f973053630579 --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 95e17b89b51955aabf9986ef9f2f973053630579 --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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 11:32:10,936 truncating revision to first 12 chars 2016-08-22 11:32:10,936 Setting DEBUG logging. 2016-08-22 11:32:10,936 attempt 1/10 2016-08-22 11:32:10,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95e17b89b519?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 11:32:11,834 unpacking tar archive at: fx-team-95e17b89b519/testing/mozharness/ program finished with exit code 0 elapsedTime=1.216356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 11:32:11.678466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:11.679326) ========= script_repo_revision: 95e17b89b51955aabf9986ef9f2f973053630579 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:11.679827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:11.680324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 11:32:11.695190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-22 11:32:11.695523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:12 INFO - MultiFileLogger online at 20160822 11:32:12 in /builds/slave/test 11:32:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:32:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:12 INFO - {'append_to_log': False, 11:32:12 INFO - 'base_work_dir': '/builds/slave/test', 11:32:12 INFO - 'blob_upload_branch': 'Fx-Team', 11:32:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:12 INFO - 'branch': 'Fx-Team', 11:32:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:12 INFO - 'config_files': ('talos/linux_config.py',), 11:32:12 INFO - 'default_actions': ('clobber', 11:32:12 INFO - 'read-buildbot-config', 11:32:12 INFO - 'download-and-extract', 11:32:12 INFO - 'populate-webroot', 11:32:12 INFO - 'create-virtualenv', 11:32:12 INFO - 'install', 11:32:12 INFO - 'run-tests'), 11:32:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:12 INFO - 'download_minidump_stackwalk': True, 11:32:12 INFO - 'download_symbols': 'ondemand', 11:32:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:12 INFO - 'installer_path': 'installer.exe', 11:32:12 INFO - 'log_level': 'info', 11:32:12 INFO - 'log_name': 'talos', 11:32:12 INFO - 'log_to_console': True, 11:32:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:12 INFO - 'opt_config_files': (), 11:32:12 INFO - 'pip_index': False, 11:32:12 INFO - 'sps_profile': False, 11:32:12 INFO - 'sps_profile_interval': 0, 11:32:12 INFO - 'suite': 'dromaeojs', 11:32:12 INFO - 'system_bits': '32', 11:32:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:12 INFO - 'title': 'talos-linux64-ix-015', 11:32:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:12 INFO - 'use_talos_json': True, 11:32:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:12 INFO - 'work_dir': 'build'} 11:32:12 INFO - [mozharness: 2016-08-22 18:32:12.291425Z] Running clobber step. 11:32:12 INFO - Running pre-action listener: _resource_record_pre_action 11:32:12 INFO - Running main action method: clobber 11:32:12 INFO - rmtree: /builds/slave/test/build 11:32:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:13 INFO - Running post-action listener: _resource_record_post_action 11:32:13 INFO - [mozharness: 2016-08-22 18:32:13.279633Z] Finished clobber step (success) 11:32:13 INFO - [mozharness: 2016-08-22 18:32:13.279743Z] Running read-buildbot-config step. 11:32:13 INFO - Running pre-action listener: _resource_record_pre_action 11:32:13 INFO - Running main action method: read_buildbot_config 11:32:13 INFO - Using buildbot properties: 11:32:13 INFO - { 11:32:13 INFO - "project": "", 11:32:13 INFO - "product": "firefox", 11:32:13 INFO - "script_repo_revision": "production", 11:32:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:32:13 INFO - "repository": "", 11:32:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:32:13 INFO - "buildid": "20160822083013", 11:32:13 INFO - "pgo_build": "True", 11:32:13 INFO - "basedir": "/builds/slave/test", 11:32:13 INFO - "buildnumber": 381, 11:32:13 INFO - "slavename": "talos-linux64-ix-015", 11:32:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:32:13 INFO - "platform": "ubuntu64_hw", 11:32:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:32:13 INFO - "branch": "fx-team", 11:32:13 INFO - "repo_path": "integration/fx-team", 11:32:13 INFO - "revision": "95e17b89b51955aabf9986ef9f2f973053630579", 11:32:13 INFO - "stage_platform": "linux64-pgo", 11:32:13 INFO - "builduid": "8eb2355976244bf5b62478ae7af1debf", 11:32:13 INFO - "slavebuilddir": "test" 11:32:13 INFO - } 11:32:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:32:13 INFO - Running post-action listener: _resource_record_post_action 11:32:13 INFO - [mozharness: 2016-08-22 18:32:13.282497Z] Finished read-buildbot-config step (success) 11:32:13 INFO - [mozharness: 2016-08-22 18:32:13.282593Z] Running download-and-extract step. 11:32:13 INFO - Running pre-action listener: _resource_record_pre_action 11:32:13 INFO - Running main action method: download_and_extract 11:32:13 INFO - mkdir: /builds/slave/test/build/tests 11:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:13 INFO - trying https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:32:13 INFO - Downloading https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:32:13 INFO - Downloaded 1361 bytes. 11:32:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:32:13 INFO - Using the following test package requirements: 11:32:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:32:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:32:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'jsshell-linux-x86_64.zip'], 11:32:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:32:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:32:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:32:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:32:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:32:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:13 INFO - trying https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:32:13 INFO - Downloading https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:14 INFO - Downloaded 21921012 bytes. 11:32:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:32:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:19 INFO - trying https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:19 INFO - Downloaded 21921012 bytes. 11:32:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:24 INFO - trying https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:24 INFO - Downloading https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:32:25 INFO - Downloaded 14413981 bytes. 11:32:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:25 INFO - trying https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:32:26 INFO - Downloaded 59781649 bytes. 11:32:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:32:26 INFO - mkdir: /builds/slave/test/properties 11:32:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:26 INFO - Contents: 11:32:26 INFO - build_url:https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - Running post-action listener: set_extra_try_arguments 11:32:27 INFO - [mozharness: 2016-08-22 18:32:27.552517Z] Finished download-and-extract step (success) 11:32:27 INFO - [mozharness: 2016-08-22 18:32:27.552742Z] Running populate-webroot step. 11:32:27 INFO - Running pre-action listener: _resource_record_pre_action 11:32:27 INFO - Running main action method: populate_webroot 11:32:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:27 INFO - '--tppagecycles', 11:32:27 INFO - '7'], 11:32:27 INFO - 'tests': ['tsvgm']}}, 11:32:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['damp', 'tps']}, 11:32:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'tests': ['damp', 'tps']}, 11:32:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['dromaeo_dom']}, 11:32:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['basic_compositor_video']}, 11:32:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:32:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['a11yr', 11:32:27 INFO - 'ts_paint', 11:32:27 INFO - 'tpaint', 11:32:27 INFO - 'sessionrestore', 11:32:27 INFO - 'sessionrestore_no_auto_restore', 11:32:27 INFO - 'tabpaint']}, 11:32:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['tsvgx', 11:32:27 INFO - 'tsvgr_opacity', 11:32:27 INFO - 'tart', 11:32:27 INFO - 'tscrollx', 11:32:27 INFO - 'cart']}, 11:32:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:27 INFO - 'tsvgr_opacity', 11:32:27 INFO - 'tart', 11:32:27 INFO - 'tscrollx', 11:32:27 INFO - 'cart']}, 11:32:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'talos_options': ['--disable-e10s'], 11:32:27 INFO - 'tests': ['tp5o']}, 11:32:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'tests': ['tp5o']}, 11:32:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'talos_options': ['--disable-e10s', 11:32:27 INFO - '--xperf_path', 11:32:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:27 INFO - 'tests': ['tp5n']}, 11:32:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:27 INFO - 'talos_options': ['--xperf_path', 11:32:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:27 INFO - 'tests': ['tp5n']}}, 11:32:27 INFO - 'talos.zip': {'path': '', 11:32:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - [mozharness: 2016-08-22 18:32:27.572133Z] Finished populate-webroot step (success) 11:32:27 INFO - [mozharness: 2016-08-22 18:32:27.572220Z] Running create-virtualenv step. 11:32:27 INFO - Running pre-action listener: _resource_record_pre_action 11:32:27 INFO - Running main action method: create_virtualenv 11:32:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32: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 11:32:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:27 INFO - Using real prefix '/usr' 11:32:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:30 INFO - Installing pip.................done. 11:32:30 INFO - Return code: 0 11:32:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:30 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 11:32:30 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 11:32:30 INFO - Using env: {'DISPLAY': ':0', 11:32:30 INFO - 'HOME': '/home/cltbld', 11:32:30 INFO - 'LANG': 'en_US.UTF-8', 11:32:30 INFO - 'LANGUAGE': 'en_US:en', 11:32:30 INFO - 'LOGNAME': 'cltbld', 11:32:30 INFO - 'MAIL': '/var/mail/cltbld', 11:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:30 INFO - 'MOZ_NO_REMOTE': '1', 11:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:30 INFO - 'NO_EM_RESTART': '1', 11:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:30 INFO - 'PWD': '/builds/slave/test', 11:32:30 INFO - 'SHELL': '/bin/bash', 11:32:30 INFO - 'SHLVL': '1', 11:32:30 INFO - 'TERM': 'linux', 11:32:30 INFO - 'TMOUT': '86400', 11:32:30 INFO - 'USER': 'cltbld', 11:32:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:30 INFO - '_': '/tools/buildbot/bin/python'} 11:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:30 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 11:32:30 INFO - Cleaning up... 11:32:30 INFO - Return code: 0 11:32:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:30 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 11:32:30 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 11:32:30 INFO - Using env: {'DISPLAY': ':0', 11:32:30 INFO - 'HOME': '/home/cltbld', 11:32:30 INFO - 'LANG': 'en_US.UTF-8', 11:32:30 INFO - 'LANGUAGE': 'en_US:en', 11:32:30 INFO - 'LOGNAME': 'cltbld', 11:32:30 INFO - 'MAIL': '/var/mail/cltbld', 11:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:30 INFO - 'MOZ_NO_REMOTE': '1', 11:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:30 INFO - 'NO_EM_RESTART': '1', 11:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:30 INFO - 'PWD': '/builds/slave/test', 11:32:30 INFO - 'SHELL': '/bin/bash', 11:32:30 INFO - 'SHLVL': '1', 11:32:30 INFO - 'TERM': 'linux', 11:32:30 INFO - 'TMOUT': '86400', 11:32:30 INFO - 'USER': 'cltbld', 11:32:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:30 INFO - '_': '/tools/buildbot/bin/python'} 11:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:30 INFO - Downloading/unpacking psutil>=3.1.1 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:32 INFO - Installing collected packages: psutil 11:32:32 INFO - Running setup.py install for psutil 11:32:32 INFO - building 'psutil._psutil_linux' extension 11:32: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 11:32: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 11:32:32 INFO - building 'psutil._psutil_posix' extension 11:32: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 11:32: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 11:32:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:33 INFO - Successfully installed psutil 11:32:33 INFO - Cleaning up... 11:32:33 INFO - Return code: 0 11:32:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:33 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:33 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 11:32:33 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 11:32:33 INFO - Using env: {'DISPLAY': ':0', 11:32:33 INFO - 'HOME': '/home/cltbld', 11:32:33 INFO - 'LANG': 'en_US.UTF-8', 11:32:33 INFO - 'LANGUAGE': 'en_US:en', 11:32:33 INFO - 'LOGNAME': 'cltbld', 11:32:33 INFO - 'MAIL': '/var/mail/cltbld', 11:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:33 INFO - 'MOZ_NO_REMOTE': '1', 11:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:33 INFO - 'NO_EM_RESTART': '1', 11:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:33 INFO - 'PWD': '/builds/slave/test', 11:32:33 INFO - 'SHELL': '/bin/bash', 11:32:33 INFO - 'SHLVL': '1', 11:32:33 INFO - 'TERM': 'linux', 11:32:33 INFO - 'TMOUT': '86400', 11:32:33 INFO - 'USER': 'cltbld', 11:32:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:33 INFO - '_': '/tools/buildbot/bin/python'} 11:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:33 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 11:32:33 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 11:32:33 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 11:32:33 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 11:32:33 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 11:32:33 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 11:32:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:35 INFO - Installing collected packages: mozsystemmonitor 11:32:35 INFO - Running setup.py install for mozsystemmonitor 11:32:35 INFO - Successfully installed mozsystemmonitor 11:32:35 INFO - Cleaning up... 11:32:35 INFO - Return code: 0 11:32:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:35 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 11:32:35 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 11:32:35 INFO - Using env: {'DISPLAY': ':0', 11:32:35 INFO - 'HOME': '/home/cltbld', 11:32:35 INFO - 'LANG': 'en_US.UTF-8', 11:32:35 INFO - 'LANGUAGE': 'en_US:en', 11:32:35 INFO - 'LOGNAME': 'cltbld', 11:32:35 INFO - 'MAIL': '/var/mail/cltbld', 11:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:35 INFO - 'MOZ_NO_REMOTE': '1', 11:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:35 INFO - 'NO_EM_RESTART': '1', 11:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:35 INFO - 'PWD': '/builds/slave/test', 11:32:35 INFO - 'SHELL': '/bin/bash', 11:32:35 INFO - 'SHLVL': '1', 11:32:35 INFO - 'TERM': 'linux', 11:32:35 INFO - 'TMOUT': '86400', 11:32:35 INFO - 'USER': 'cltbld', 11:32:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:35 INFO - '_': '/tools/buildbot/bin/python'} 11:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:35 INFO - Downloading/unpacking jsonschema==2.5.1 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:37 INFO - warning: no files found matching '*.txt' 11:32:37 INFO - no previously-included directories found matching 'build' 11:32:37 INFO - no previously-included directories found matching 'dist' 11:32:37 INFO - no previously-included directories found matching '.git*' 11:32:37 INFO - Installing collected packages: jsonschema, functools32 11:32:38 INFO - Running setup.py install for functools32 11:32:38 INFO - warning: no files found matching '*.txt' 11:32:38 INFO - no previously-included directories found matching 'build' 11:32:38 INFO - no previously-included directories found matching 'dist' 11:32:38 INFO - no previously-included directories found matching '.git*' 11:32:38 INFO - Successfully installed jsonschema functools32 11:32:38 INFO - Cleaning up... 11:32:38 INFO - Return code: 0 11:32:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:32:38 INFO - Using env: {'DISPLAY': ':0', 11:32:38 INFO - 'HOME': '/home/cltbld', 11:32:38 INFO - 'LANG': 'en_US.UTF-8', 11:32:38 INFO - 'LANGUAGE': 'en_US:en', 11:32:38 INFO - 'LOGNAME': 'cltbld', 11:32:38 INFO - 'MAIL': '/var/mail/cltbld', 11:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:38 INFO - 'MOZ_NO_REMOTE': '1', 11:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:38 INFO - 'NO_EM_RESTART': '1', 11:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:38 INFO - 'PWD': '/builds/slave/test', 11:32:38 INFO - 'SHELL': '/bin/bash', 11:32:38 INFO - 'SHLVL': '1', 11:32:38 INFO - 'TERM': 'linux', 11:32:38 INFO - 'TMOUT': '86400', 11:32:38 INFO - 'USER': 'cltbld', 11:32:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:38 INFO - '_': '/tools/buildbot/bin/python'} 11:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:38 INFO - Cleaning up... 11:32:38 INFO - Return code: 0 11:32:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:38 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 11:32:38 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 11:32:38 INFO - Using env: {'DISPLAY': ':0', 11:32:38 INFO - 'HOME': '/home/cltbld', 11:32:38 INFO - 'LANG': 'en_US.UTF-8', 11:32:38 INFO - 'LANGUAGE': 'en_US:en', 11:32:38 INFO - 'LOGNAME': 'cltbld', 11:32:38 INFO - 'MAIL': '/var/mail/cltbld', 11:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:38 INFO - 'MOZ_NO_REMOTE': '1', 11:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:38 INFO - 'NO_EM_RESTART': '1', 11:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:38 INFO - 'PWD': '/builds/slave/test', 11:32:38 INFO - 'SHELL': '/bin/bash', 11:32:38 INFO - 'SHLVL': '1', 11:32:38 INFO - 'TERM': 'linux', 11:32:38 INFO - 'TMOUT': '86400', 11:32:38 INFO - 'USER': 'cltbld', 11:32:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:38 INFO - '_': '/tools/buildbot/bin/python'} 11:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:38 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 11:32:38 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 11:32:38 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 11:32:38 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 11:32:38 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 11:32:38 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 11:32:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:41 INFO - Downloading docopt-0.6.1.tar.gz 11:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:41 INFO - Running setup.py install for blobuploader 11:32:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:41 INFO - Running setup.py install for requests 11:32:41 INFO - Running setup.py install for docopt 11:32:41 INFO - Successfully installed blobuploader requests docopt 11:32:41 INFO - Cleaning up... 11:32:41 INFO - Return code: 0 11:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32: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 11:32: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 11:32:41 INFO - Using env: {'DISPLAY': ':0', 11:32:41 INFO - 'HOME': '/home/cltbld', 11:32:41 INFO - 'LANG': 'en_US.UTF-8', 11:32:41 INFO - 'LANGUAGE': 'en_US:en', 11:32:41 INFO - 'LOGNAME': 'cltbld', 11:32:41 INFO - 'MAIL': '/var/mail/cltbld', 11:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:41 INFO - 'MOZ_NO_REMOTE': '1', 11:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:41 INFO - 'NO_EM_RESTART': '1', 11:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:41 INFO - 'PWD': '/builds/slave/test', 11:32:41 INFO - 'SHELL': '/bin/bash', 11:32:41 INFO - 'SHLVL': '1', 11:32:41 INFO - 'TERM': 'linux', 11:32:41 INFO - 'TMOUT': '86400', 11:32:41 INFO - 'USER': 'cltbld', 11:32:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:41 INFO - '_': '/tools/buildbot/bin/python'} 11:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:42 INFO - Running setup.py (path:/tmp/pip-tY6rnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:42 INFO - Running setup.py (path:/tmp/pip-Qy3LbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:42 INFO - Running setup.py (path:/tmp/pip-wilLhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:42 INFO - Running setup.py (path:/tmp/pip-P1pSuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:42 INFO - Running setup.py (path:/tmp/pip-ONJSDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:42 INFO - Running setup.py (path:/tmp/pip-RbH8fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:42 INFO - Running setup.py (path:/tmp/pip-4AbPv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:42 INFO - Running setup.py (path:/tmp/pip-2Da21L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:42 INFO - Running setup.py (path:/tmp/pip-8jghfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:42 INFO - Running setup.py (path:/tmp/pip-DYI5Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:42 INFO - Running setup.py (path:/tmp/pip-fVfBKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:42 INFO - Running setup.py (path:/tmp/pip-9PplGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:42 INFO - Running setup.py (path:/tmp/pip-wA00Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:42 INFO - Running setup.py (path:/tmp/pip-ELor_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:43 INFO - Running setup.py (path:/tmp/pip-xq04Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:43 INFO - Running setup.py (path:/tmp/pip-WN0A5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:43 INFO - Running setup.py (path:/tmp/pip-Fgmdji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:43 INFO - Running setup.py install for manifestparser 11:32:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:43 INFO - Running setup.py install for mozcrash 11:32:43 INFO - Running setup.py install for mozdebug 11:32:43 INFO - Running setup.py install for mozdevice 11:32:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:43 INFO - Running setup.py install for mozfile 11:32:43 INFO - Running setup.py install for mozhttpd 11:32:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:43 INFO - Running setup.py install for mozinfo 11:32:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:43 INFO - Running setup.py install for mozInstall 11:32:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Running setup.py install for mozleak 11:32:44 INFO - Running setup.py install for mozlog 11:32:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Running setup.py install for moznetwork 11:32:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Running setup.py install for mozprocess 11:32:44 INFO - Running setup.py install for mozprofile 11:32:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Running setup.py install for mozrunner 11:32:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:44 INFO - Running setup.py install for mozscreenshot 11:32:44 INFO - Running setup.py install for moztest 11:32:44 INFO - Running setup.py install for mozversion 11:32:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:45 INFO - Cleaning up... 11:32:45 INFO - Return code: 0 11:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:45 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:45 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 11:32:45 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 11:32:45 INFO - Using env: {'DISPLAY': ':0', 11:32:45 INFO - 'HOME': '/home/cltbld', 11:32:45 INFO - 'LANG': 'en_US.UTF-8', 11:32:45 INFO - 'LANGUAGE': 'en_US:en', 11:32:45 INFO - 'LOGNAME': 'cltbld', 11:32:45 INFO - 'MAIL': '/var/mail/cltbld', 11:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:45 INFO - 'MOZ_NO_REMOTE': '1', 11:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:45 INFO - 'NO_EM_RESTART': '1', 11:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:45 INFO - 'PWD': '/builds/slave/test', 11:32:45 INFO - 'SHELL': '/bin/bash', 11:32:45 INFO - 'SHLVL': '1', 11:32:45 INFO - 'TERM': 'linux', 11:32:45 INFO - 'TMOUT': '86400', 11:32:45 INFO - 'USER': 'cltbld', 11:32:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:45 INFO - '_': '/tools/buildbot/bin/python'} 11:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:45 INFO - Running setup.py (path:/tmp/pip-MMypCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:45 INFO - Running setup.py (path:/tmp/pip-urPKUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:45 INFO - Running setup.py (path:/tmp/pip-PcoVIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:45 INFO - Running setup.py (path:/tmp/pip-hQL3Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:45 INFO - Running setup.py (path:/tmp/pip-njJmZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:45 INFO - Running setup.py (path:/tmp/pip-bDfyvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:45 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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:45 INFO - Running setup.py (path:/tmp/pip-wNHs5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32: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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:45 INFO - Running setup.py (path:/tmp/pip-bbQRXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32: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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:45 INFO - Running setup.py (path:/tmp/pip-Jvteq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32: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)) 11:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:45 INFO - Running setup.py (path:/tmp/pip-LGydGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:46 INFO - Running setup.py (path:/tmp/pip-P6974u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:46 INFO - Running setup.py (path:/tmp/pip-LehKaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:46 INFO - Running setup.py (path:/tmp/pip-d0f1X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:46 INFO - Running setup.py (path:/tmp/pip-uOX2SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:46 INFO - Running setup.py (path:/tmp/pip-Le5zKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:46 INFO - Running setup.py (path:/tmp/pip-FqzW0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:46 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)) 11:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:46 INFO - Running setup.py (path:/tmp/pip-CjbWdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:46 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 11:32:46 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 11:32:46 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 11:32:46 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 11:32:46 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 11:32:46 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 11:32:48 INFO - Downloading blessings-1.6.tar.gz 11:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:48 INFO - Installing collected packages: blessings 11:32:48 INFO - Running setup.py install for blessings 11:32:48 INFO - Successfully installed blessings 11:32:48 INFO - Cleaning up... 11:32:48 INFO - Return code: 0 11:32:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:48 INFO - Reading from file tmpfile_stdout 11:32:48 INFO - Current package versions: 11:32:48 INFO - argparse == 1.2.1 11:32:48 INFO - blessings == 1.6 11:32:48 INFO - blobuploader == 1.2.4 11:32:48 INFO - docopt == 0.6.1 11:32:48 INFO - functools32 == 3.2.3-2 11:32:48 INFO - jsonschema == 2.5.1 11:32:48 INFO - manifestparser == 1.1 11:32:48 INFO - mozInstall == 1.12 11:32:48 INFO - mozcrash == 0.17 11:32:48 INFO - mozdebug == 0.1 11:32:48 INFO - mozdevice == 0.48 11:32:48 INFO - mozfile == 1.2 11:32:48 INFO - mozhttpd == 0.7 11:32:48 INFO - mozinfo == 0.9 11:32:48 INFO - mozleak == 0.1 11:32:48 INFO - mozlog == 3.3 11:32:48 INFO - moznetwork == 0.27 11:32:48 INFO - mozprocess == 0.23 11:32:48 INFO - mozprofile == 0.28 11:32:48 INFO - mozrunner == 6.12 11:32:48 INFO - mozscreenshot == 0.1 11:32:48 INFO - mozsystemmonitor == 0.3 11:32:48 INFO - moztest == 0.7 11:32:48 INFO - mozversion == 1.4 11:32:48 INFO - psutil == 3.1.1 11:32:48 INFO - requests == 1.2.3 11:32:48 INFO - wsgiref == 0.1.2 11:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32: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 11:32: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 11:32:48 INFO - Using env: {'DISPLAY': ':0', 11:32:48 INFO - 'HOME': '/home/cltbld', 11:32:48 INFO - 'LANG': 'en_US.UTF-8', 11:32:48 INFO - 'LANGUAGE': 'en_US:en', 11:32:48 INFO - 'LOGNAME': 'cltbld', 11:32:48 INFO - 'MAIL': '/var/mail/cltbld', 11:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:48 INFO - 'MOZ_NO_REMOTE': '1', 11:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:48 INFO - 'NO_EM_RESTART': '1', 11:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:48 INFO - 'PWD': '/builds/slave/test', 11:32:48 INFO - 'SHELL': '/bin/bash', 11:32:48 INFO - 'SHLVL': '1', 11:32:48 INFO - 'TERM': 'linux', 11:32:48 INFO - 'TMOUT': '86400', 11:32:48 INFO - 'USER': 'cltbld', 11:32:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:48 INFO - '_': '/tools/buildbot/bin/python'} 11:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 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)) 11:32:49 INFO - Cleaning up... 11:32:49 INFO - Return code: 0 11:32:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:49 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 0x7fa8a1059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, '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': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', '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 11:32:49 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 11:32:49 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 11:32:49 INFO - Using env: {'DISPLAY': ':0', 11:32:49 INFO - 'HOME': '/home/cltbld', 11:32:49 INFO - 'LANG': 'en_US.UTF-8', 11:32:49 INFO - 'LANGUAGE': 'en_US:en', 11:32:49 INFO - 'LOGNAME': 'cltbld', 11:32:49 INFO - 'MAIL': '/var/mail/cltbld', 11:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:49 INFO - 'MOZ_NO_REMOTE': '1', 11:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:49 INFO - 'NO_EM_RESTART': '1', 11:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:49 INFO - 'PWD': '/builds/slave/test', 11:32:49 INFO - 'SHELL': '/bin/bash', 11:32:49 INFO - 'SHLVL': '1', 11:32:49 INFO - 'TERM': 'linux', 11:32:49 INFO - 'TMOUT': '86400', 11:32:49 INFO - 'USER': 'cltbld', 11:32:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:49 INFO - '_': '/tools/buildbot/bin/python'} 11:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:49 INFO - Cleaning up... 11:32:49 INFO - Return code: 0 11:32:49 INFO - Running post-action listener: _resource_record_post_action 11:32:49 INFO - Running post-action listener: _start_resource_monitoring 11:32:49 INFO - Starting resource monitoring. 11:32:49 INFO - [mozharness: 2016-08-22 18:32:49.347516Z] Finished create-virtualenv step (success) 11:32:49 INFO - [mozharness: 2016-08-22 18:32:49.347972Z] Running install step. 11:32:49 INFO - Running pre-action listener: _resource_record_pre_action 11:32:49 INFO - Running main action method: install 11:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:49 INFO - Reading from file tmpfile_stdout 11:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:49 INFO - Reading from file tmpfile_stdout 11:32:49 INFO - Output received: 11:32:49 INFO - Usage: mozinstall [options] installer 11:32:49 INFO - Options: 11:32:49 INFO - -h, --help show this help message and exit 11:32:49 INFO - -d DEST, --destination=DEST 11:32:49 INFO - Directory to install application into. [default: 11:32:49 INFO - "/builds/slave/test"] 11:32:49 INFO - --app=APP Application being installed. [default: firefox] 11:32:49 INFO - mkdir: /builds/slave/test/build/application 11:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:33:06 INFO - Reading from file tmpfile_stdout 11:33:06 INFO - Output received: 11:33:06 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:06 INFO - Running post-action listener: _resource_record_post_action 11:33:06 INFO - [mozharness: 2016-08-22 18:33:06.668038Z] Finished install step (success) 11:33:06 INFO - [mozharness: 2016-08-22 18:33:06.668284Z] Running run-tests step. 11:33:06 INFO - Running pre-action listener: _resource_record_pre_action 11:33:06 INFO - Running main action method: run_tests 11:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:06 INFO - Python 2.7.3 11:33:06 INFO - Return code: 0 11:33:06 INFO - grabbing minidump binary from tooltool 11:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33: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 0x1f02370>, '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 0x1f058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f05d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33: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 11:33: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 11:33: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 11:33:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:06 INFO - Return code: 0 11:33:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:33: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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:33:06 INFO - Using env: {'DISPLAY': ':0', 11:33:06 INFO - 'HOME': '/home/cltbld', 11:33:06 INFO - 'LANG': 'en_US.UTF-8', 11:33:06 INFO - 'LANGUAGE': 'en_US:en', 11:33:06 INFO - 'LOGNAME': 'cltbld', 11:33:06 INFO - 'MAIL': '/var/mail/cltbld', 11:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:06 INFO - 'MOZ_NO_REMOTE': '1', 11:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:06 INFO - 'NO_EM_RESTART': '1', 11:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:06 INFO - 'PWD': '/builds/slave/test', 11:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:06 INFO - 'SHELL': '/bin/bash', 11:33:06 INFO - 'SHLVL': '1', 11:33:06 INFO - 'TERM': 'linux', 11:33:06 INFO - 'TMOUT': '86400', 11:33:06 INFO - 'USER': 'cltbld', 11:33:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604', 11:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:06 INFO - '_': '/tools/buildbot/bin/python'} 11:33: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:33:06 INFO - mozversion application_buildid: 20160822083013 11:33:06 INFO - mozversion application_changeset: 95e17b89b51955aabf9986ef9f2f973053630579 11:33:06 INFO - mozversion application_display_name: Nightly 11:33:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:06 INFO - mozversion application_name: Firefox 11:33:06 INFO - mozversion application_remotingname: firefox 11:33:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:33:06 INFO - mozversion application_vendor: Mozilla 11:33:06 INFO - mozversion application_version: 51.0a1 11:33:06 INFO - mozversion platform_buildid: 20160822083013 11:33:06 INFO - mozversion platform_changeset: 95e17b89b51955aabf9986ef9f2f973053630579 11:33:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:33:06 INFO - mozversion platform_version: 51.0a1 11:33:06 INFO - using testdate: 1471890786 11:33:06 INFO - actual date: 1471890786 11:33:06 INFO - starting webserver on 'localhost:52812' 11:33:06 INFO - SUITE-START | Running 2 tests 11:33:06 INFO - TEST-START | dromaeo_css 11:33:06 INFO - operating with platform_type : linux_ 11:33:06 INFO - Initialising browser for dromaeo_css test... 11:33:06 INFO - TEST-INFO | started process 28780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFWfi5/profile http://localhost:52812/getInfo.html) 11:33:11 INFO - PROCESS | 28780 | __metrics Screen width/height:1600/1200 11:33:11 INFO - PROCESS | 28780 | colorDepth:24 11:33:11 INFO - PROCESS | 28780 | Browser inner width/height: 1024/697 11:33:11 INFO - PROCESS | 28780 | __metrics 11:33:11 INFO - PROCESS | 28780 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:33:11 INFO - PROCESS | 28780 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:12 INFO - PROCESS | 28780 | console.error: PushService: 11:33:12 INFO - PROCESS | 28780 | stateChangeProcessEnqueue: Error transitioning state 11:33:12 INFO - PROCESS | 28780 | UnknownError 11:33:12 INFO - TEST-INFO | 28780: exit 0 11:33:12 INFO - Browser initialized. 11:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:12 INFO - TEST-INFO | started process 28861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFWfi5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:24 INFO - PROCESS | 28861 | RSS: Main: 174309376 11:33:24 INFO - PROCESS | 28861 | 11:34:15 INFO - PROCESS | 28861 | 1471890855895 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] 11:36:25 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52812/tests/dromaeo/cssquery-ext.html) 11:36:26 INFO - PROCESS | 28861 | RSS: Main: 276619264 11:36:26 INFO - PROCESS | 28861 | 11:39:28 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-ext.html (next: http://localhost:52812/tests/dromaeo/cssquery-jquery.html) 11:39:29 INFO - PROCESS | 28861 | RSS: Main: 268173312 11:39:29 INFO - PROCESS | 28861 | 11:42:31 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52812/tests/dromaeo/cssquery-mootools.html) 11:42:31 INFO - PROCESS | 28861 | RSS: Main: 219328512 11:42:31 INFO - PROCESS | 28861 | 11:45:34 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52812/tests/dromaeo/cssquery-prototype.html) 11:45:34 INFO - PROCESS | 28861 | RSS: Main: 252067840 11:45:34 INFO - PROCESS | 28861 | 11:48:37 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52812/tests/dromaeo/cssquery-yui.html) 11:48:38 INFO - PROCESS | 28861 | RSS: Main: 220532736 11:48:38 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | Cycle 1(1): loaded http://localhost:52812/tests/dromaeo/cssquery-yui.html (next: http://localhost:52812/tests/dromaeo/cssquery-dojo.html) 11:51:41 INFO - PROCESS | 28861 | RSS: Main: 311578624 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | __start_tp_report 11:51:41 INFO - PROCESS | 28861 | _x_x_mozilla_page_load 11:51:41 INFO - PROCESS | 28861 | _x_x_mozilla_page_load_details 11:51:41 INFO - PROCESS | 28861 | |i|pagename|runs| 11:51:41 INFO - PROCESS | 28861 | |0;dojo.html;2931.6775154732977;2934.090431966091;2939.779516536259;2947.7347038766507;2954.3205062835546;5016.974915125428;5129.820456284031;5135.820246291371;5201.921971170435;5208.583313334933;5166.276721259027;5204.375474943012;5213.139831927728;5218.47815218478;5273.209018647205;4725.787339569711;4766.094442056007;4819.590334821527;4842.515748425165;4861;4847.369841920546;4870.512948705119;4887.437944636359;4888.291197776321;4892.0705066037335;4616.907661846744;4668.6265098792355;4684.508126646687;4837.371141751567;4850.248211527219;4708.0819240248165;4709.952900470986;4720.362751028601;4767;4767.952320476786;4665.766711664437;4687.929681054753;4704.670673052888;4707.71753694776;4714.6935449196035;5184.144616138333;5219.42586315505;5233.450487698775;5241.764120614544;5251.186066159751;5359.16932875401;5469.425710300401;5525.530329921921;5526.806561770319;5630.352509461382;5530.142827861688;5593.580481463907;5616.354119276295;5630.5495560355075;5632.155176723483;5251.632385733;5260.342457192851;5263.8420847374255;5264.289320941624;5266.183741520071;5501.779928802883;5621.775128994795;5680.176374425768;5681.091025435993;5778.075507918713;5510.752016159283;5511.779528818883;5521.089020311603;5532.3637781655625;5535.142052981794;5597.496225339739;5605.831825045255;5607.243022192033;5632.464915832989;5638.689872057076;5368.651037682538;5389.946100539023;5439.3200849893765;5443.237946687467;5518.006758783457;5528.55771538276;5535.972320138373;5538.667679939216;5539.473749993744;5542.0301447246575;4293.806778694966;4321.157374311979;4327.978360108179;4330.069035157457;4343.370211319341;3776.981115094407;3836.5396152461326;3862.208247309295;3897.512810898638;3909.5308562972054;5355.7054362009685;5363.544098751572;5371.328583927009;5376.865578360573;5379.488948549882;5367.838964831061;5655.208270842086;5656.660600363992;5664.54683625309;5668.234788303526;5240.161574148118;5259.710715910662;5280.128778751463;5324.760385782649;5339.492748188916;4845.709257444564;4861.6353773467135;4863.683860549053;4873.707577545359;4875.731834749052;5484.8354549363585;5753.079507278899;5765.538756899438;5766.221560089334;5795;5490.505854473116;5553.750081246434;5562.3047119110115;5663.575231857545;5663.66018038919;5807.883842323215;5812.680302583399;5819.447152520504;5823.5923485355615;5827.5337972961215;5337.199420087018;5563;5563.304586926634;5577.470140336662;5581.665100094007;5455.9454405455435;5464.28964234647;5471.50756431923;5548.445155484419;5548.889022219452;5365.356157261153;5402.405735369028;5405.108157154025;5413.40452550227;5416.783328666809;5197.480251974772;5420.972895135499;5422.566194704493;5433.402325744086;5433.8369848904595;5398;5423.864403389947;5448;5512.448755124456;5519.586031047767;5504.4770746778995;5509.641873278224;5531.03206938776;5541.556675465872;5541.695206763667;5135.512126347991;5393.352797664148;5410.729463526729;5413.160960051198;5422.539084177889 11:51:41 INFO - PROCESS | 28861 | |1;ext.html;522.9921551176732;563.0596903171705;567.9488846003859;607.5838050935113;608.6895683201566;36233.818830905875;37544;37550.0612484688;37642.24715505688;40092;38027.80986095073;38332;38515.80742096293;38534.807325963404;38540;8465.746027619165;8584.22741953224;8597.097304783001;8607.741767746978;8608.784780380509;8579.571021448934;8650.48097114172;8674.522901240429;8678.65285388587;8679.869801952977;8696.826063478728;8737.650493980233;8738.563071846414;8747.212750852423;8748.562571871382;8693.391462597621;8708.564571771449;8722.694705685271;8726;8726.781830454225;8600.397972141953;8673.609687564074;8686.913130868737;8697.434666746642;8698.869516957187;36488.81755591205;36651;36967;36973.33619987107;36974.63025369739;2356.9882150589137;2610.530104581175;2883.740463358308;3077.9076627701206;3138.1997590614474;29418.264543386587;30023.249418764488;30048.098557043322;30266.54600180999;30819.229519261975;3927.6465118139217;3976.940345894814;4087.6116768906904;4088.2436749201493;4229.534751177368;336698;337141;337714.91708287917;338607;339422.99999999756;45896.80393146882;46114.538854611026;46263.537364626594;46272.537274626826;46317;50245.49754502408;50735;50870.49129508732;50969;56905;12961.870381296256;13064.281464519543;13073.36582927134;13146.4084116215;13152.736945261233;10161.085502304828;10247.487625618838;10255;10255.230857685703;10257.333273337359;13454.730905381837;13560.389782459813;14718;15078.321475533627;15147.166905820286;5681.630694004959;5729;5802.332731735904;5890.646561206256;5957.076653118774;798.9520628762293;815.9877601835977;863.1713554987283;947.1759569174724;952.7046615549202;26761;28051.57922631162;28062.158135255973;28309;28484.287892802433;933.9766505837273;952.4047470331043;970.8543718442149;973.3429934793986;1018.7249442650443;14672.193029383487;14807.333669984877;14833.332500037308;14935.551933442013;15066.924665376822;476787;479598;479800;479878;481311;47251.76374118176;47292.487352276235;47340.28989565159;47426.5257347429;47431.5256847434;1101.4767985207122;1131.1064259235277;1176.823476478518;1178.6780043314657;1186.768580126867;26201.73798261993;26258.86870565635;27274.727252727218;27431.891184518572;28405;41788.164236715704;42106.57893421149;42162.78918605387;42163.578364215966;42193.578064218964;432231;433360;433484;435368;439539;24618.138365157134;24672.876635616707;25386.222964392316;25551.872240638677;25748.61377079383;39545.406818897165;39722.2055558893;39966.400503991885;40312.16254049416;40529;34227.14432139217;34954.47568286427;35069.82465087761;35239;35385.469217962265;34741.82629086838;34881.12797180091;34943.475847861795;35011;35121.297574047865;34858.825705871306;34976;35254.29491410209;37624;38485.230295394496;34502;36792.26415471729;37057.25885482329;37099.44350834793;38344.61655383522;26691.599626005238;28108.156755297372;28508.42983140367;28751.568726469537;28805.85597072001 11:51:41 INFO - PROCESS | 28861 | |2;jquery.html;356.6237619311625;361.75039222936164;365.0909236002354;377.0799249830415;378.34778204784453;17108.828911710894;18306;18493.53766155845;18617.81382186178;18659.533511662215;12420.875791242084;15260.694786104272;15538.145402002885;15671.29479173437;16221.270042848071;5037.622178336621;5275.0504909116535;5284.207368894658;5285.841424757245;5286.074936886049;3843.673287770543;4760.404949381327;5147.408048074463;5234.371875374942;6434.195725534309;6463.1274777904855;6470.417662410406;6475.449586785129;6476.352364763509;6481.125048118514;5517.944820551783;5575.1915972184215;5579.972100139474;6015.909761353583;6434.549581529295;5409.918851217235;5424.430434804328;5426.8914621707345;5429.484199001128;5433.673979561199;12117.091218158674;12224.633261002184;12343.629691109281;12399.566015189515;12488.750224995449;2297.2993237062688;2324.4421338878715;2340.368100612825;2360.480694247263;2929.871999280271;9345.252379809666;9471.242300615933;9723.124918757276;9758.219342452587;9973.601055957826;1821.9089045547803;1931.5557421793067;1939.767227932657;1979.158857485563;2034.8473864460225;81774.59112704458;83667;85141.14858851394;85227;86829;10325;10411.323263987817;10604.310719803188;10723.46382680863;10840;14503.419863205354;14519.491817786538;14531.200783956983;14540.563783086523;14549.85450145485;6984.720611175598;7209.35115839577;7245.239249878792;7427.925720742724;7441.925580744231;6734.865302693918;6738.258791532928;6927.238003819576;6953.79138625842;6958.269381714948;4391.824327026947;4502.302143167814;4547.431571053618;4626.282926146453;4686.671932964659;1690.5689049292353;1788.5886246163454;1833.2941817400397;1871.4292140897157;1925.3261358524685;818.7339114787718;826.1944604011042;868.1752335281508;869;886.5744442667556;16844.57888552796;17738.29046838138;18210.908945455187;18286.101208850392;18415;851;869.1265278395173;879.2281114020907;892.2237653241722;897.6005677473593;7343.4492413068165;9998.200143988464;10109.848352274721;10179.7455063624;10229.232807539463;475612;481253;487005;489103;489328;94274.52862735643;95001;95587;95737;96801.51599241959;868.0072447848797;891;894.789724414762;898.7977705016319;906.5965645287783;15777.763333550236;15952;15990.840091598935;16399.672006560042;16411.753823692892;40289.19421611493;41187.38218926779;42789.78605106955;43241.3513797287;43260.783696081315;59356;60296.39703602908;60344.474164436964;60901.47746306378;61740.07389889065;7924;8078.515289082674;8221.753347399588;8285.25432711059;8577.142285771373;12402.937985310016;12934.676633084247;13177;13526.05317627796;13621.38703758353;11455.770884582094;11551.306921584732;11589.362585057903;11726.70683232926;12434.75130497403;11598;11641.6507504775;11737.41312934367;11745.47145378477;11881.940590296994;11695.707607309885;11864.169508134693;11891.524339026342;12140.453679584263;12204.450799713857;7822.921770782219;7868.606569671608;8000.559969201517;8080.393970452122;8539.14608539141;9867.06262905023;11840.940795295968;12134.696632583902;12278.386080696107;12321.815172772236 11:51:41 INFO - PROCESS | 28861 | |3;mootools.html;1171.2855158353402;1202.2065436811706;1236.4003458322711;1321.8017297405395;1386.4662105089537;7897.40769442292;8277.048139463963;8298.460600060991;8432.367572432076;8463.449875758086;8266.669333226679;8341.666333346673;8352.582370881462;8364.079951205362;8364.539950302731;1932.4589115047738;2240.115154513966;2263.4907145892207;2264.377296243538;2270.375646697155;2210.5799898019327;2286.9885650571723;2291.186628746796;2292.7248730152405;2293.6330187170056;2192.3970908000347;2241.1595651630637;2242.293677491593;2244.517428752818;2245.438640339915;2145.7210562626915;2223.5997520446313;2227.6324406472995;2227.821774258072;2228.053077442081;2194.9451263718374;2234.7988681018624;2237.2952519956325;2240.7535171131162;2241.0923575951765;8388.496690198608;8394.622241999064;8414.663413463453;8433.03020152678;8433.831323373559;4645.744484053375;4754.453237877619;4761.35721677576;4763.452202996665;4763.666543341968;3010.5634682971067;3220.951685724716;3224.2423030587793;3228.596425446819;3238.8380580971093;1037.4397825174397;1078.229066217658;1091.7434402915308;1101.7410908436511;1114.554178328667;11280.379579123144;11608.30350178992;11638.59264925732;11879.643610691694;11916.225445346112;4013.8996525086523;4107.712460127822;4108.568600296986;4201.789910504463;4214.87355379333;8938.240249578728;8940.821183576292;8941.329400295004;8941.821163576822;8942.239909607757;4680.134175177603;4683.344331793552;4685.6017238535105;4687.882802929886;4688.57802797743;3906.3945088511327;3942.8619998300496;4394.956050439519;4401.801918913657;4405.977970110129;3431.6225215226304;3519.7360197985254;3532.523109380201;3538.097785064792;3649.9635003649623;985.8816941966867;1001.5643195210107;1007.1036777268237;1015.3248090020054;1024.8667673202435;818.5784321074651;835.5947365527715;844.4840915848993;857.7555396711907;860.165639329849;5503.889922201533;5647.774089036475;5677.545796336283;5730.770769169187;5808.477237048602;389.3983795036675;403.8788363490941;404.54286656078443;409.8749881286236;412.8637549608622;3789.242151569697;3803.201327721154;3844.4809950656304;3865.342891708416;3943.5662077171487;10155.543000564992;10763.19276054299;10835.566577336818;10843.891561084289;10846.78306433867;10613.628523001658;10793.08258798011;10813.459327033617;10818.24272300947;10827.621033263798;7851.2148785121035;8009.959950200212;8011.439199256112;8016.438849280611;8024.799380015546;5594.804181853616;5607.523360514402;5640.125780504029;5722.914156287576;5824.650520968756;9537.093976072261;9780.168685661798;9914.355566888418;10029.147522460673;10047.14599259042;8606;9751.756206094904;10014.248931330034;10147.898521014695;10156.085952264331;6968.930310696828;7067.646617668993;7129.180144283474;7332.633368331669;7378.815529611803;7523.172451030492;7705.383569314329;7746.961265193863;7766.805829854299;7882.684692612232;7038.120234970629;7209.927900720925;7264.382527485223;7306.086739157606;7328.596927168844;7169.749058782918;7206.783796486114;7241.782746517613;7258.927410725825;7271.236520165518;6363.172787537591;6455.515836312202;6456.225252969673;6461.773837915838;6464.997925321582;4727.267273572602;4795.808167673254;4822.734749588806;4891.559759621651;4910.852674419773;4858.63560232991;4912.631552633496;5048.141815891381;5081.136206844772;5175.068487672255 11:51:41 INFO - PROCESS | 28861 | |4;prototype.html;292.24892027489346;302.6761365339087;311.92825650100474;316.31517764040854;319.68927397669574;5035.647504674675;5125.564327032207;5161.406438259602;5227.529522342993;5239.694534404864;5160.974195129019;5185.403678576965;5189.377274727038;5193.428722840494;5211.635185537014;4099.754014759124;4109.527404348508;4117.238310912476;4127.690423218256;4132.462779838616;3931.6658084062888;4039.7778122203267;4120.423140760296;4125.773082480462;4125.793710314488;4012.5184977802705;4016.2168377166463;4018.4976877890263;4029.2545879012478;4031.496062992126;4004.8798536043964;4006.639402453793;4016.758994460327;4028.2547728669997;4039.8284497495692;3549.6272891346293;3550.7336949728874;3568.572570971606;3580.8925732228076;3584.5698516177963;4881.975590122027;5079.568236699885;5116.309298244727;5116.718580478072;5157.896842063138;4544.182047231497;4559.772011399416;4596.3794887690065;4599.908001839978;4602.286645569942;5353.715108373962;5380;5380.784768609251;5382.973085134549;5383.515483606455;3641.617630148849;3793.525809273841;3842.5773164951834;3856.2865869814173;3858.9614103858885;5568.805091821807;5584.832455026356;5588.6646801191655;5595.740958284394;5607.551395888319;3915.471411359487;3929.430232616312;3935.74417662851;3940.7241493095207;3957.683385329167;3910.904946614952;3963.504561929759;3996.2806694795217;4007.356983636695;4017.4777278953547;4552.294394368878;4557.5442455754155;4566.360709500673;4568.725876447424;4575.519570445055;5422.91865622016;5443.863903402367;5449.155380915885;5459.3994660587305;5460.126379779295;1252.6659108049898;1321.8744219299151;1345.2063282663275;1373.6085215713474;1375.4360712107987;921.4473611963863;922.8338898998245;943.104051151409;948.5020364308655;953.2802733935972;5190.81832135881;5215.452377500384;5216.530512253916;5234.1680411856305;5244.5279924806955;5499.285092937893;5506.64206826555;5528.170774383874;5534.640248383842;5546.77812887488;5087.97456012725;5235.136202526616;5250.7637156328055;5261.605379596469;5330.413654498002;2932;2946.543285790706;2949.3953739483354;2964.43675701616;2982.910512684623;5766.221560089334;5791.945638053379;5827.737751801179;5830.7959221427045;5849.766009359578;5581.214011516357;5583.413741557078;5606.327240731139;5632.436756324335;5653.462921022497;5672.205891175238;5694.430556944355;5696.287964004499;5704.828855134269;5706.686132262766;5346.6257361985845;5527.972360138335;5541.6120871540215;5567.832965011056;5606;5461.836144915659;5467.699276539828;5471.838623743679;5537.366476889408;5589.413111623221;5739.7417116229035;5747;5774.364819869895;5794.942050579441;5811.593188476766;3922.56851746302;3981.482407287034;3983.143624120828;4004.739691920016;4018.3972404139613;5289.2330612061805;5521.5306698931045;5534.4742249486235;5545.391836367408;5587.832365029056;5293.338332708411;5386.192071189353;5409.161579955114;5420.482264965816;5430.755615997368;5391.406945236099;5416.75624596902;5417.945820541744;5428.511433970962;5463.972680136574;5266.289050978069;5302.787888484418;5361.624686271924;5379.1662292344745;5400.918986215289;5424.457554244544;5434.266374039454;5462.317210348707;5468.015757163748;5486.396496385474;5313.760880760297;5345;5362.329708786402;5372.167314066326;5411.350637923474 11:51:41 INFO - PROCESS | 28861 | |5;yui.html;578.6643746626956;608.473670275212;649.4252586460981;649.6946435175468;653.8953767397218;12560.246385216893;12856.22862628243;13062.216267023974;14784.482543110993;15328.693426131471;14056.226907520082;14063.648408789786;14077.929610351934;14088.57734267971;14093.154410735364;571.8598943258886;571.9227904232916;574.5805561939776;582.7581553655228;661.4576047640936;562.2213234669971;671.8286836856595;681.3731367142241;683.3303362704553;684.1106561470094;601.419630056995;603.4327731931992;606.5966132521868;606.9666168360739;607.0196632438624;603.5352778360682;604.3865476541292;604.8306474187235;604.8548348396397;605.2887856768301;428.4366058632919;437.2261097856776;437.9671524635665;438.54610478154956;503.90173916086377;12474.18917770342;13107.541236056788;13113.409896554582;13123.081384303103;13127.737445251138;11975.580854670045;12514;12704.491820327175;12842.422091005834;13433.529826456124;11805.468753906094;12283.324417157053;12441.564545240873;12461.691542288558;12475.313857737821;4071.442481013425;4108.815103320358;4248.787560621957;4288.421063156465;4323.567643235683;82206.17793822045;82442;82992.17007829905;85145.57427212886;85913.14086859114;9992.65025724096;10043.497825108716;10120.443375614412;10173.694789156338;10372.948135259276;17335.56661083483;17336.739948900777;17345.56636084083;17370.739438908426;17380.739288910678;7871.252231038042;7906.683732650629;7967.442279040528;8075.3539716822515;8201.466904651179;4616.238320677051;4778.402699662543;4786.305985632064;4953.108440480676;5012.473690262543;2988.506896362076;3095.086949349947;3105.0374383941053;3107.5804766356705;3112.2219445138717;517.7644171901776;521.1765410651162;534.3747815056394;537.4276395638632;540.3650710415246;620.3437119705584;658.5686375424104;672.2922388918148;677.2110491277606;682.5904457325565;8565.18630730092;8977.147171018873;9086.070975603612;9146.54267286633;9288.814223715488;638.2022471910112;642.2389468479867;658.0885473619072;664.3389827121948;703.1948419060147;3917.138229589486;4140.0891803803115;4154.086101057763;4219.240536703362;4224.281872081753;65790.34209657938;66935.33064669388;110279;114216;122146.38926805308;62846;63324;85317.57341213254;96784;99619.50190249002;53855.19217211745;53932;80290.59854700688;82583;84357.57821210855;8700.303975682056;9267.907320926704;9278.257739380968;9301.767455813659;9313.208377288007;50232;50338;50340;51259.23111153261;53179;42522.78738606411;48448;49066;55079.724601376736;70833;11662.416879156179;11822.34977076269;11859.881401185878;11887.821682674594;12369.010479161825;12238.388080595756;12638.431270592662;13082.28047457399;13790.862091379358;14009.649758755704;12159.635210943687;12862;13205.141665791693;13211.405486752927;13214.537491187762;9290.767730806783;12051.276923384625;12369.505219791108;12547.24716517012;12785.80821287663;12766.17019893704;12838.29389383593;13017.739645207232;13193.670158246121;13339.466421343037;9884.802303954024;10133.442660653734;10354.792904142025;10685.19861010443;12135.878641213474;9433.386829856037;10295.17638588896;10929.398883061507;11259.493322800658;11267.436628168723 11:51:41 INFO - PROCESS | 28861 | __end_tp_report 11:51:41 INFO - PROCESS | 28861 | __start_cc_report 11:51:41 INFO - PROCESS | 28861 | _x_x_mozilla_cycle_collect,940 11:51:41 INFO - PROCESS | 28861 | __end_cc_report 11:51:41 INFO - PROCESS | 28861 | __startTimestamp1471891901536__endTimestamp 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | ------- Summary: start ------- 11:51:41 INFO - PROCESS | 28861 | Number of tests: 6 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#0] dojo.html Cycles:165 Average:5183.52 Median:5389.95 stddev:584.55 (10.8%) stddev-sans-first:559.01 11:51:41 INFO - PROCESS | 28861 | Values: 2931.7 2934.1 2939.8 2947.7 2954.3 5017.0 5129.8 5135.8 5201.9 5208.6 5166.3 5204.4 5213.1 5218.5 5273.2 4725.8 4766.1 4819.6 4842.5 4861.0 4847.4 4870.5 4887.4 4888.3 4892.1 4616.9 4668.6 4684.5 4837.4 4850.2 4708.1 4710.0 4720.4 4767.0 4768.0 4665.8 4687.9 4704.7 4707.7 4714.7 5184.1 5219.4 5233.5 5241.8 5251.2 5359.2 5469.4 5525.5 5526.8 5630.4 5530.1 5593.6 5616.4 5630.5 5632.2 5251.6 5260.3 5263.8 5264.3 5266.2 5501.8 5621.8 5680.2 5681.1 5778.1 5510.8 5511.8 5521.1 5532.4 5535.1 5597.5 5605.8 5607.2 5632.5 5638.7 5368.7 5389.9 5439.3 5443.2 5518.0 5528.6 5536.0 5538.7 5539.5 5542.0 4293.8 4321.2 4328.0 4330.1 4343.4 3777.0 3836.5 3862.2 3897.5 3909.5 5355.7 5363.5 5371.3 5376.9 5379.5 5367.8 5655.2 5656.7 5664.5 5668.2 5240.2 5259.7 5280.1 5324.8 5339.5 4845.7 4861.6 4863.7 4873.7 4875.7 5484.8 5753.1 5765.5 5766.2 5795.0 5490.5 5553.8 5562.3 5663.6 5663.7 5807.9 5812.7 5819.4 5823.6 5827.5 5337.2 5563.0 5563.3 5577.5 5581.7 5455.9 5464.3 5471.5 5548.4 5548.9 5365.4 5402.4 5405.1 5413.4 5416.8 5197.5 5421.0 5422.6 5433.4 5433.8 5398.0 5423.9 5448.0 5512.4 5519.6 5504.5 5509.6 5531.0 5541.6 5541.7 5135.5 5393.4 5410.7 5413.2 5422.5 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#1] ext.html Cycles:180 Average:55177.48 Median:38414.92 stddev:111910.29 (291.3%) stddev-sans-first:112148.99 11:51:41 INFO - PROCESS | 28861 | Values: 523.0 563.1 567.9 607.6 608.7 36233.8 37544.0 37550.1 37642.2 40092.0 38027.8 38332.0 38515.8 38534.8 38540.0 8465.7 8584.2 8597.1 8607.7 8608.8 8579.6 8650.5 8674.5 8678.7 8679.9 8696.8 8737.7 8738.6 8747.2 8748.6 8693.4 8708.6 8722.7 8726.0 8726.8 8600.4 8673.6 8686.9 8697.4 8698.9 36488.8 36651.0 36967.0 36973.3 36974.6 2357.0 2610.5 2883.7 3077.9 3138.2 29418.3 30023.2 30048.1 30266.5 30819.2 3927.6 3976.9 4087.6 4088.2 4229.5 336698.0 337141.0 337714.9 338607.0 339423.0 45896.8 46114.5 46263.5 46272.5 46317.0 50245.5 50735.0 50870.5 50969.0 56905.0 12961.9 13064.3 13073.4 13146.4 13152.7 10161.1 10247.5 10255.0 10255.2 10257.3 13454.7 13560.4 14718.0 15078.3 15147.2 5681.6 5729.0 5802.3 5890.6 5957.1 799.0 816.0 863.2 947.2 952.7 26761.0 28051.6 28062.2 28309.0 28484.3 934.0 952.4 970.9 973.3 1018.7 14672.2 14807.3 14833.3 14935.6 15066.9 476787.0 479598.0 479800.0 479878.0 481311.0 47251.8 47292.5 47340.3 47426.5 47431.5 1101.5 1131.1 1176.8 1178.7 1186.8 26201.7 26258.9 27274.7 27431.9 28405.0 41788.2 42106.6 42162.8 42163.6 42193.6 432231.0 433360.0 433484.0 435368.0 439539.0 24618.1 24672.9 25386.2 25551.9 25748.6 39545.4 39722.2 39966.4 40312.2 40529.0 34227.1 34954.5 35069.8 35239.0 35385.5 34741.8 34881.1 34943.5 35011.0 35121.3 34858.8 34976.0 35254.3 37624.0 38485.2 34502.0 36792.3 37057.3 37099.4 38344.6 26691.6 28108.2 28508.4 28751.6 28805.9 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#2] jquery.html Cycles:180 Average:28431.07 Median:4586.86 stddev:80205.05 (1748.6%) stddev-sans-first:80402.34 11:51:41 INFO - PROCESS | 28861 | Values: 356.6 361.8 365.1 377.1 378.3 17108.8 18306.0 18493.5 18617.8 18659.5 12420.9 15260.7 15538.1 15671.3 16221.3 5037.6 5275.1 5284.2 5285.8 5286.1 3843.7 4760.4 5147.4 5234.4 6434.2 6463.1 6470.4 6475.4 6476.4 6481.1 5517.9 5575.2 5580.0 6015.9 6434.5 5409.9 5424.4 5426.9 5429.5 5433.7 12117.1 12224.6 12343.6 12399.6 12488.8 2297.3 2324.4 2340.4 2360.5 2929.9 9345.3 9471.2 9723.1 9758.2 9973.6 1821.9 1931.6 1939.8 1979.2 2034.8 81774.6 83667.0 85141.1 85227.0 86829.0 10325.0 10411.3 10604.3 10723.5 10840.0 14503.4 14519.5 14531.2 14540.6 14549.9 6984.7 7209.4 7245.2 7427.9 7441.9 6734.9 6738.3 6927.2 6953.8 6958.3 4391.8 4502.3 4547.4 4626.3 4686.7 1690.6 1788.6 1833.3 1871.4 1925.3 818.7 826.2 868.2 869.0 886.6 16844.6 17738.3 18210.9 18286.1 18415.0 851.0 869.1 879.2 892.2 897.6 7343.4 9998.2 10109.8 10179.7 10229.2 475612.0 481253.0 487005.0 489103.0 489328.0 94274.5 95001.0 95587.0 95737.0 96801.5 868.0 891.0 894.8 898.8 906.6 15777.8 15952.0 15990.8 16399.7 16411.8 40289.2 41187.4 42789.8 43241.4 43260.8 59356.0 60296.4 60344.5 60901.5 61740.1 7924.0 8078.5 8221.8 8285.3 8577.1 12402.9 12934.7 13177.0 13526.1 13621.4 11455.8 11551.3 11589.4 11726.7 12434.8 11598.0 11641.7 11737.4 11745.5 11881.9 11695.7 11864.2 11891.5 12140.5 12204.5 7822.9 7868.6 8000.6 8080.4 8539.1 9867.1 11840.9 12134.7 12278.4 12321.8 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#3] mootools.html Cycles:180 Average:5437.35 Median:4681.74 stddev:3186.22 (68.1%) stddev-sans-first:3179.02 11:51:41 INFO - PROCESS | 28861 | Values: 1171.3 1202.2 1236.4 1321.8 1386.5 7897.4 8277.0 8298.5 8432.4 8463.4 8266.7 8341.7 8352.6 8364.1 8364.5 1932.5 2240.1 2263.5 2264.4 2270.4 2210.6 2287.0 2291.2 2292.7 2293.6 2192.4 2241.2 2242.3 2244.5 2245.4 2145.7 2223.6 2227.6 2227.8 2228.1 2194.9 2234.8 2237.3 2240.8 2241.1 8388.5 8394.6 8414.7 8433.0 8433.8 4645.7 4754.5 4761.4 4763.5 4763.7 3010.6 3221.0 3224.2 3228.6 3238.8 1037.4 1078.2 1091.7 1101.7 1114.6 11280.4 11608.3 11638.6 11879.6 11916.2 4013.9 4107.7 4108.6 4201.8 4214.9 8938.2 8940.8 8941.3 8941.8 8942.2 4680.1 4683.3 4685.6 4687.9 4688.6 3906.4 3942.9 4395.0 4401.8 4406.0 3431.6 3519.7 3532.5 3538.1 3650.0 985.9 1001.6 1007.1 1015.3 1024.9 818.6 835.6 844.5 857.8 860.2 5503.9 5647.8 5677.5 5730.8 5808.5 389.4 403.9 404.5 409.9 412.9 3789.2 3803.2 3844.5 3865.3 3943.6 10155.5 10763.2 10835.6 10843.9 10846.8 10613.6 10793.1 10813.5 10818.2 10827.6 7851.2 8010.0 8011.4 8016.4 8024.8 5594.8 5607.5 5640.1 5722.9 5824.7 9537.1 9780.2 9914.4 10029.1 10047.1 8606.0 9751.8 10014.2 10147.9 10156.1 6968.9 7067.6 7129.2 7332.6 7378.8 7523.2 7705.4 7747.0 7766.8 7882.7 7038.1 7209.9 7264.4 7306.1 7328.6 7169.7 7206.8 7241.8 7258.9 7271.2 6363.2 6455.5 6456.2 6461.8 6465.0 4727.3 4795.8 4822.7 4891.6 4910.9 4858.6 4912.6 5048.1 5081.1 5175.1 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#4] prototype.html Cycles:180 Average:4565.47 Median:5242.11 stddev:1345.91 (25.7%) stddev-sans-first:1310.91 11:51:41 INFO - PROCESS | 28861 | Values: 292.2 302.7 311.9 316.3 319.7 5035.6 5125.6 5161.4 5227.5 5239.7 5161.0 5185.4 5189.4 5193.4 5211.6 4099.8 4109.5 4117.2 4127.7 4132.5 3931.7 4039.8 4120.4 4125.8 4125.8 4012.5 4016.2 4018.5 4029.3 4031.5 4004.9 4006.6 4016.8 4028.3 4039.8 3549.6 3550.7 3568.6 3580.9 3584.6 4882.0 5079.6 5116.3 5116.7 5157.9 4544.2 4559.8 4596.4 4599.9 4602.3 5353.7 5380.0 5380.8 5383.0 5383.5 3641.6 3793.5 3842.6 3856.3 3859.0 5568.8 5584.8 5588.7 5595.7 5607.6 3915.5 3929.4 3935.7 3940.7 3957.7 3910.9 3963.5 3996.3 4007.4 4017.5 4552.3 4557.5 4566.4 4568.7 4575.5 5422.9 5443.9 5449.2 5459.4 5460.1 1252.7 1321.9 1345.2 1373.6 1375.4 921.4 922.8 943.1 948.5 953.3 5190.8 5215.5 5216.5 5234.2 5244.5 5499.3 5506.6 5528.2 5534.6 5546.8 5088.0 5235.1 5250.8 5261.6 5330.4 2932.0 2946.5 2949.4 2964.4 2982.9 5766.2 5791.9 5827.7 5830.8 5849.8 5581.2 5583.4 5606.3 5632.4 5653.5 5672.2 5694.4 5696.3 5704.8 5706.7 5346.6 5528.0 5541.6 5567.8 5606.0 5461.8 5467.7 5471.8 5537.4 5589.4 5739.7 5747.0 5774.4 5794.9 5811.6 3922.6 3981.5 3983.1 4004.7 4018.4 5289.2 5521.5 5534.5 5545.4 5587.8 5293.3 5386.2 5409.2 5420.5 5430.8 5391.4 5416.8 5417.9 5428.5 5464.0 5266.3 5302.8 5361.6 5379.2 5400.9 5424.5 5434.3 5462.3 5468.0 5486.4 5313.8 5345.0 5362.3 5372.2 5411.4 11:51:41 INFO - PROCESS | 28861 | 11:51:41 INFO - PROCESS | 28861 | [#5] yui.html Cycles:180 Average:18379.67 Median:4782.35 stddev:26379.07 (551.6%) stddev-sans-first:26419.21 11:51:41 INFO - PROCESS | 28861 | Values: 578.7 608.5 649.4 649.7 653.9 12560.2 12856.2 13062.2 14784.5 15328.7 14056.2 14063.6 14077.9 14088.6 14093.2 571.9 571.9 574.6 582.8 661.5 562.2 671.8 681.4 683.3 684.1 601.4 603.4 606.6 607.0 607.0 603.5 604.4 604.8 604.9 605.3 428.4 437.2 438.0 438.5 503.9 12474.2 13107.5 13113.4 13123.1 13127.7 11975.6 12514.0 12704.5 12842.4 13433.5 11805.5 12283.3 12441.6 12461.7 12475.3 4071.4 4108.8 4248.8 4288.4 4323.6 82206.2 82442.0 82992.2 85145.6 85913.1 9992.7 10043.5 10120.4 10173.7 10372.9 17335.6 17336.7 17345.6 17370.7 17380.7 7871.3 7906.7 7967.4 8075.4 8201.5 4616.2 4778.4 4786.3 4953.1 5012.5 2988.5 3095.1 3105.0 3107.6 3112.2 517.8 521.2 534.4 537.4 540.4 620.3 658.6 672.3 677.2 682.6 8565.2 8977.1 9086.1 9146.5 9288.8 638.2 642.2 658.1 664.3 703.2 3917.1 4140.1 4154.1 4219.2 4224.3 65790.3 66935.3 110279.0 114216.0 122146.4 62846.0 63324.0 85317.6 96784.0 99619.5 53855.2 53932.0 80290.6 82583.0 84357.6 8700.3 9267.9 9278.3 9301.8 9313.2 50232.0 50338.0 50340.0 51259.2 53179.0 42522.8 48448.0 49066.0 55079.7 70833.0 11662.4 11822.3 11859.9 11887.8 12369.0 12238.4 12638.4 13082.3 13790.9 14009.6 12159.6 12862.0 13205.1 13211.4 13214.5 9290.8 12051.3 12369.5 12547.2 12785.8 12766.2 12838.3 13017.7 13193.7 13339.5 9884.8 10133.4 10354.8 10685.2 12135.9 9433.4 10295.2 10929.4 11259.5 11267.4 11:51:41 INFO - PROCESS | 28861 | -------- Summary: end -------- 11:51:41 INFO - PROCESS | 28861 | 11:51:42 INFO - TEST-INFO | 28861: exit 0 11:51:42 INFO - TEST-OK | dromaeo_css | took 1115533ms 11:51:42 INFO - TEST-START | kraken 11:51:42 INFO - operating with platform_type : linux_ 11:51:42 INFO - Initialising browser for kraken test... 11:51:42 INFO - TEST-INFO | started process 29164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdSbJoV/profile http://localhost:52812/getInfo.html) 11:51:46 INFO - PROCESS | 29164 | __metrics Screen width/height:1600/1200 11:51:46 INFO - PROCESS | 29164 | colorDepth:24 11:51:46 INFO - PROCESS | 29164 | Browser inner width/height: 1024/697 11:51:46 INFO - PROCESS | 29164 | __metrics 11:51:46 INFO - PROCESS | 29164 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:51:46 INFO - PROCESS | 29164 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:47 INFO - PROCESS | 29164 | console.error: PushService: 11:51:47 INFO - PROCESS | 29164 | stateChangeProcessEnqueue: Error transitioning state 11:51:47 INFO - PROCESS | 29164 | UnknownError 11:51:48 INFO - TEST-INFO | 29164: exit 0 11:51:48 INFO - Browser initialized. 11:51:48 INFO - Running cycle 1/1 for kraken test... 11:51:48 INFO - TEST-INFO | started process 29247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdSbJoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:00 INFO - PROCESS | 29247 | RSS: Main: 174247936 11:52:00 INFO - PROCESS | 29247 | 11:52:02 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52812/tests/kraken/driver.html?testName=audio-beat-detection) 11:52:03 INFO - PROCESS | 29247 | RSS: Main: 234373120 11:52:03 INFO - PROCESS | 29247 | 11:52:06 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52812/tests/kraken/driver.html?testName=audio-dft) 11:52:06 INFO - PROCESS | 29247 | RSS: Main: 225812480 11:52:06 INFO - PROCESS | 29247 | 11:52:10 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52812/tests/kraken/driver.html?testName=audio-fft) 11:52:10 INFO - PROCESS | 29247 | RSS: Main: 302686208 11:52:10 INFO - PROCESS | 29247 | 11:52:12 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52812/tests/kraken/driver.html?testName=audio-oscillator) 11:52:13 INFO - PROCESS | 29247 | RSS: Main: 209637376 11:52:13 INFO - PROCESS | 29247 | 11:52:15 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:16 INFO - PROCESS | 29247 | RSS: Main: 213766144 11:52:16 INFO - PROCESS | 29247 | 11:52:19 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52812/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:19 INFO - PROCESS | 29247 | RSS: Main: 249843712 11:52:19 INFO - PROCESS | 29247 | 11:52:23 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52812/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:23 INFO - PROCESS | 29247 | RSS: Main: 248766464 11:52:23 INFO - PROCESS | 29247 | 11:52:26 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52812/tests/kraken/driver.html?testName=json-parse-financial) 11:52:27 INFO - PROCESS | 29247 | RSS: Main: 248692736 11:52:27 INFO - PROCESS | 29247 | 11:52:28 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:29 INFO - PROCESS | 29247 | RSS: Main: 211300352 11:52:29 INFO - PROCESS | 29247 | 11:52:31 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:31 INFO - PROCESS | 29247 | RSS: Main: 219291648 11:52:31 INFO - PROCESS | 29247 | 11:52:34 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:34 INFO - PROCESS | 29247 | RSS: Main: 224030720 11:52:34 INFO - PROCESS | 29247 | 11:52:37 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:38 INFO - PROCESS | 29247 | RSS: Main: 218640384 11:52:38 INFO - PROCESS | 29247 | 11:52:40 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:41 INFO - PROCESS | 29247 | RSS: Main: 222208000 11:52:41 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | Cycle 1(1): loaded http://localhost:52812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52812/tests/kraken/driver.html?testName=ai-astar) 11:52:43 INFO - PROCESS | 29247 | RSS: Main: 272515072 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | __start_tp_report 11:52:43 INFO - PROCESS | 29247 | _x_x_mozilla_page_load 11:52:43 INFO - PROCESS | 29247 | _x_x_mozilla_page_load_details 11:52:43 INFO - PROCESS | 29247 | |i|pagename|runs| 11:52:43 INFO - PROCESS | 29247 | |0;ai-astar;101;111;110;112;111;113;119;115;114;112 11:52:43 INFO - PROCESS | 29247 | |1;audio-beat-detection;151;118;144;189;117;156;150;118;187;118 11:52:43 INFO - PROCESS | 29247 | |2;audio-dft;161;160;162;159;161;160;160;160;161;160 11:52:43 INFO - PROCESS | 29247 | |3;audio-fft;75;76;76;181;76;76;75;76;162;75 11:52:43 INFO - PROCESS | 29247 | |4;audio-oscillator;86;86;152;85;86;86;142;85;85;147 11:52:43 INFO - PROCESS | 29247 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;117 11:52:43 INFO - PROCESS | 29247 | |6;imaging-darkroom;145;147;147;147;147;147;148;147;146;147 11:52:43 INFO - PROCESS | 29247 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;96;95 11:52:43 INFO - PROCESS | 29247 | |8;json-parse-financial;51;53;54;52;52;52;53;53;53;52 11:52:43 INFO - PROCESS | 29247 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;60;62;62 11:52:43 INFO - PROCESS | 29247 | |10;stanford-crypto-aes;80;82;84;79;83;88;83;78;78;80 11:52:43 INFO - PROCESS | 29247 | |11;stanford-crypto-ccm;125;124;124;123;134;121;128;139;151;126 11:52:43 INFO - PROCESS | 29247 | |12;stanford-crypto-pbkdf2;162;164;164;160;163;163;163;162;163;166 11:52:43 INFO - PROCESS | 29247 | |13;stanford-crypto-sha256-iterative;69;65;66;65;63;69;65;65;64;64 11:52:43 INFO - PROCESS | 29247 | __end_tp_report 11:52:43 INFO - PROCESS | 29247 | __start_cc_report 11:52:43 INFO - PROCESS | 29247 | _x_x_mozilla_cycle_collect,1701 11:52:43 INFO - PROCESS | 29247 | __end_cc_report 11:52:43 INFO - PROCESS | 29247 | __startTimestamp1471891963434__endTimestamp 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | ------- Summary: start ------- 11:52:43 INFO - PROCESS | 29247 | Number of tests: 14 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:4.59 (4.1%) stddev-sans-first:2.74 11:52:43 INFO - PROCESS | 29247 | Values: 101.0 111.0 110.0 112.0 111.0 113.0 119.0 115.0 114.0 112.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.50 stddev:27.60 (18.3%) stddev-sans-first:29.18 11:52:43 INFO - PROCESS | 29247 | Values: 151.0 118.0 144.0 189.0 117.0 156.0 150.0 118.0 187.0 118.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 11:52:43 INFO - PROCESS | 29247 | Values: 161.0 160.0 162.0 159.0 161.0 160.0 160.0 160.0 161.0 160.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:40.67 (53.5%) stddev-sans-first:42.51 11:52:43 INFO - PROCESS | 29247 | Values: 75.0 76.0 76.0 181.0 76.0 76.0 75.0 76.0 162.0 75.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.50 stddev:29.77 (34.8%) stddev-sans-first:30.85 11:52:43 INFO - PROCESS | 29247 | Values: 86.0 86.0 152.0 85.0 86.0 86.0 142.0 85.0 85.0 147.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:52:43 INFO - PROCESS | 29247 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.50 11:52:43 INFO - PROCESS | 29247 | Values: 145.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:52:43 INFO - PROCESS | 29247 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.71 11:52:43 INFO - PROCESS | 29247 | Values: 51.0 53.0 54.0 52.0 52.0 52.0 53.0 53.0 53.0 52.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:52:43 INFO - PROCESS | 29247 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 60.0 62.0 62.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.50 stddev:3.14 (3.8%) stddev-sans-first:3.28 11:52:43 INFO - PROCESS | 29247 | Values: 80.0 82.0 84.0 79.0 83.0 88.0 83.0 78.0 78.0 80.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.00 stddev:9.32 (7.3%) stddev-sans-first:9.75 11:52:43 INFO - PROCESS | 29247 | Values: 125.0 124.0 124.0 123.0 134.0 121.0 128.0 139.0 151.0 126.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:1.56 (1.0%) stddev-sans-first:1.62 11:52:43 INFO - PROCESS | 29247 | Values: 162.0 164.0 164.0 160.0 163.0 163.0 163.0 162.0 163.0 166.0 11:52:43 INFO - PROCESS | 29247 | 11:52:43 INFO - PROCESS | 29247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:1.69 11:52:43 INFO - PROCESS | 29247 | Values: 69.0 65.0 66.0 65.0 63.0 69.0 65.0 65.0 64.0 64.0 11:52:43 INFO - PROCESS | 29247 | -------- Summary: end -------- 11:52:43 INFO - PROCESS | 29247 | 11:52:44 INFO - TEST-INFO | 29247: exit 0 11:52:44 INFO - TEST-OK | kraken | took 62170ms 11:52:44 INFO - SUITE-END | took 1177s 11:52:45 INFO - Completed test suite (00:19:38) 11:52:45 INFO - javascript benchmark 11:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.6775154732977, 2934.090431966091, 2939.779516536259, 2947.7347038766507, 2954.3205062835546, 5016.974915125428, 5129.820456284031, 5135.820246291371, 5201.921971170435, 5208.583313334933, 5166.276721259027, 5204.375474943012, 5213.139831927728, 5218.47815218478, 5273.209018647205, 4725.787339569711, 4766.094442056007, 4819.590334821527, 4842.515748425165, 4861.0, 4847.369841920546, 4870.512948705119, 4887.437944636359, 4888.291197776321, 4892.0705066037335, 4616.907661846744, 4668.6265098792355, 4684.508126646687, 4837.371141751567, 4850.248211527219, 4708.0819240248165, 4709.952900470986, 4720.362751028601, 4767.0, 4767.952320476786, 4665.766711664437, 4687.929681054753, 4704.670673052888, 4707.71753694776, 4714.6935449196035, 5184.144616138333, 5219.42586315505, 5233.450487698775, 5241.764120614544, 5251.186066159751, 5359.16932875401, 5469.425710300401, 5525.530329921921, 5526.806561770319, 5630.352509461382, 5530.142827861688, 5593.580481463907, 5616.354119276295, 5630.5495560355075, 5632.155176723483, 5251.632385733, 5260.342457192851, 5263.8420847374255, 5264.289320941624, 5266.183741520071, 5501.779928802883, 5621.775128994795, 5680.176374425768, 5681.091025435993, 5778.075507918713, 5510.752016159283, 5511.779528818883, 5521.089020311603, 5532.3637781655625, 5535.142052981794, 5597.496225339739, 5605.831825045255, 5607.243022192033, 5632.464915832989, 5638.689872057076, 5368.651037682538, 5389.946100539023, 5439.3200849893765, 5443.237946687467, 5518.006758783457, 5528.55771538276, 5535.972320138373, 5538.667679939216, 5539.473749993744, 5542.0301447246575, 4293.806778694966, 4321.157374311979, 4327.978360108179, 4330.069035157457, 4343.370211319341, 3776.981115094407, 3836.5396152461326, 3862.208247309295, 3897.512810898638, 3909.5308562972054, 5355.7054362009685, 5363.544098751572, 5371.328583927009, 5376.865578360573, 5379.488948549882, 5367.838964831061, 5655.208270842086, 5656.660600363992, 5664.54683625309, 5668.234788303526, 5240.161574148118, 5259.710715910662, 5280.128778751463, 5324.760385782649, 5339.492748188916, 4845.709257444564, 4861.6353773467135, 4863.683860549053, 4873.707577545359, 4875.731834749052, 5484.8354549363585, 5753.079507278899, 5765.538756899438, 5766.221560089334, 5795.0, 5490.505854473116, 5553.750081246434, 5562.3047119110115, 5663.575231857545, 5663.66018038919, 5807.883842323215, 5812.680302583399, 5819.447152520504, 5823.5923485355615, 5827.5337972961215, 5337.199420087018, 5563.0, 5563.304586926634, 5577.470140336662, 5581.665100094007, 5455.9454405455435, 5464.28964234647, 5471.50756431923, 5548.445155484419, 5548.889022219452, 5365.356157261153, 5402.405735369028, 5405.108157154025, 5413.40452550227, 5416.783328666809, 5197.480251974772, 5420.972895135499, 5422.566194704493, 5433.402325744086, 5433.8369848904595, 5398.0, 5423.864403389947, 5448.0, 5512.448755124456, 5519.586031047767, 5504.4770746778995, 5509.641873278224, 5531.03206938776, 5541.556675465872, 5541.695206763667, 5135.512126347991, 5393.352797664148, 5410.729463526729, 5413.160960051198, 5422.539084177889], "value": 5143.733661392152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.9921551176732, 563.0596903171705, 567.9488846003859, 607.5838050935113, 608.6895683201566, 36233.818830905875, 37544.0, 37550.0612484688, 37642.24715505688, 40092.0, 38027.80986095073, 38332.0, 38515.80742096293, 38534.807325963404, 38540.0, 8465.746027619165, 8584.22741953224, 8597.097304783001, 8607.741767746978, 8608.784780380509, 8579.571021448934, 8650.48097114172, 8674.522901240429, 8678.65285388587, 8679.869801952977, 8696.826063478728, 8737.650493980233, 8738.563071846414, 8747.212750852423, 8748.562571871382, 8693.391462597621, 8708.564571771449, 8722.694705685271, 8726.0, 8726.781830454225, 8600.397972141953, 8673.609687564074, 8686.913130868737, 8697.434666746642, 8698.869516957187, 36488.81755591205, 36651.0, 36967.0, 36973.33619987107, 36974.63025369739, 2356.9882150589137, 2610.530104581175, 2883.740463358308, 3077.9076627701206, 3138.1997590614474, 29418.264543386587, 30023.249418764488, 30048.098557043322, 30266.54600180999, 30819.229519261975, 3927.6465118139217, 3976.940345894814, 4087.6116768906904, 4088.2436749201493, 4229.534751177368, 336698.0, 337141.0, 337714.91708287917, 338607.0, 339422.99999999756, 45896.80393146882, 46114.538854611026, 46263.537364626594, 46272.537274626826, 46317.0, 50245.49754502408, 50735.0, 50870.49129508732, 50969.0, 56905.0, 12961.870381296256, 13064.281464519543, 13073.36582927134, 13146.4084116215, 13152.736945261233, 10161.085502304828, 10247.487625618838, 10255.0, 10255.230857685703, 10257.333273337359, 13454.730905381837, 13560.389782459813, 14718.0, 15078.321475533627, 15147.166905820286, 5681.630694004959, 5729.0, 5802.332731735904, 5890.646561206256, 5957.076653118774, 798.9520628762293, 815.9877601835977, 863.1713554987283, 947.1759569174724, 952.7046615549202, 26761.0, 28051.57922631162, 28062.158135255973, 28309.0, 28484.287892802433, 933.9766505837273, 952.4047470331043, 970.8543718442149, 973.3429934793986, 1018.7249442650443, 14672.193029383487, 14807.333669984877, 14833.332500037308, 14935.551933442013, 15066.924665376822, 476787.0, 479598.0, 479800.0, 479878.0, 481311.0, 47251.76374118176, 47292.487352276235, 47340.28989565159, 47426.5257347429, 47431.5256847434, 1101.4767985207122, 1131.1064259235277, 1176.823476478518, 1178.6780043314657, 1186.768580126867, 26201.73798261993, 26258.86870565635, 27274.727252727218, 27431.891184518572, 28405.0, 41788.164236715704, 42106.57893421149, 42162.78918605387, 42163.578364215966, 42193.578064218964, 432231.0, 433360.0, 433484.0, 435368.0, 439539.0, 24618.138365157134, 24672.876635616707, 25386.222964392316, 25551.872240638677, 25748.61377079383, 39545.406818897165, 39722.2055558893, 39966.400503991885, 40312.16254049416, 40529.0, 34227.14432139217, 34954.47568286427, 35069.82465087761, 35239.0, 35385.469217962265, 34741.82629086838, 34881.12797180091, 34943.475847861795, 35011.0, 35121.297574047865, 34858.825705871306, 34976.0, 35254.29491410209, 37624.0, 38485.230295394496, 34502.0, 36792.26415471729, 37057.25885482329, 37099.44350834793, 38344.61655383522, 26691.599626005238, 28108.156755297372, 28508.42983140367, 28751.568726469537, 28805.85597072001], "value": 17782.695737516908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6237619311625, 361.75039222936164, 365.0909236002354, 377.0799249830415, 378.34778204784453, 17108.828911710894, 18306.0, 18493.53766155845, 18617.81382186178, 18659.533511662215, 12420.875791242084, 15260.694786104272, 15538.145402002885, 15671.29479173437, 16221.270042848071, 5037.622178336621, 5275.0504909116535, 5284.207368894658, 5285.841424757245, 5286.074936886049, 3843.673287770543, 4760.404949381327, 5147.408048074463, 5234.371875374942, 6434.195725534309, 6463.1274777904855, 6470.417662410406, 6475.449586785129, 6476.352364763509, 6481.125048118514, 5517.944820551783, 5575.1915972184215, 5579.972100139474, 6015.909761353583, 6434.549581529295, 5409.918851217235, 5424.430434804328, 5426.8914621707345, 5429.484199001128, 5433.673979561199, 12117.091218158674, 12224.633261002184, 12343.629691109281, 12399.566015189515, 12488.750224995449, 2297.2993237062688, 2324.4421338878715, 2340.368100612825, 2360.480694247263, 2929.871999280271, 9345.252379809666, 9471.242300615933, 9723.124918757276, 9758.219342452587, 9973.601055957826, 1821.9089045547803, 1931.5557421793067, 1939.767227932657, 1979.158857485563, 2034.8473864460225, 81774.59112704458, 83667.0, 85141.14858851394, 85227.0, 86829.0, 10325.0, 10411.323263987817, 10604.310719803188, 10723.46382680863, 10840.0, 14503.419863205354, 14519.491817786538, 14531.200783956983, 14540.563783086523, 14549.85450145485, 6984.720611175598, 7209.35115839577, 7245.239249878792, 7427.925720742724, 7441.925580744231, 6734.865302693918, 6738.258791532928, 6927.238003819576, 6953.79138625842, 6958.269381714948, 4391.824327026947, 4502.302143167814, 4547.431571053618, 4626.282926146453, 4686.671932964659, 1690.5689049292353, 1788.5886246163454, 1833.2941817400397, 1871.4292140897157, 1925.3261358524685, 818.7339114787718, 826.1944604011042, 868.1752335281508, 869.0, 886.5744442667556, 16844.57888552796, 17738.29046838138, 18210.908945455187, 18286.101208850392, 18415.0, 851.0, 869.1265278395173, 879.2281114020907, 892.2237653241722, 897.6005677473593, 7343.4492413068165, 9998.200143988464, 10109.848352274721, 10179.7455063624, 10229.232807539463, 475612.0, 481253.0, 487005.0, 489103.0, 489328.0, 94274.52862735643, 95001.0, 95587.0, 95737.0, 96801.51599241959, 868.0072447848797, 891.0, 894.789724414762, 898.7977705016319, 906.5965645287783, 15777.763333550236, 15952.0, 15990.840091598935, 16399.672006560042, 16411.753823692892, 40289.19421611493, 41187.38218926779, 42789.78605106955, 43241.3513797287, 43260.783696081315, 59356.0, 60296.39703602908, 60344.474164436964, 60901.47746306378, 61740.07389889065, 7924.0, 8078.515289082674, 8221.753347399588, 8285.25432711059, 8577.142285771373, 12402.937985310016, 12934.676633084247, 13177.0, 13526.05317627796, 13621.38703758353, 11455.770884582094, 11551.306921584732, 11589.362585057903, 11726.70683232926, 12434.75130497403, 11598.0, 11641.6507504775, 11737.41312934367, 11745.47145378477, 11881.940590296994, 11695.707607309885, 11864.169508134693, 11891.524339026342, 12140.453679584263, 12204.450799713857, 7822.921770782219, 7868.606569671608, 8000.559969201517, 8080.393970452122, 8539.14608539141, 9867.06262905023, 11840.940795295968, 12134.696632583902, 12278.386080696107, 12321.815172772236], "value": 8679.668953595434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1171.2855158353402, 1202.2065436811706, 1236.4003458322711, 1321.8017297405395, 1386.4662105089537, 7897.40769442292, 8277.048139463963, 8298.460600060991, 8432.367572432076, 8463.449875758086, 8266.669333226679, 8341.666333346673, 8352.582370881462, 8364.079951205362, 8364.539950302731, 1932.4589115047738, 2240.115154513966, 2263.4907145892207, 2264.377296243538, 2270.375646697155, 2210.5799898019327, 2286.9885650571723, 2291.186628746796, 2292.7248730152405, 2293.6330187170056, 2192.3970908000347, 2241.1595651630637, 2242.293677491593, 2244.517428752818, 2245.438640339915, 2145.7210562626915, 2223.5997520446313, 2227.6324406472995, 2227.821774258072, 2228.053077442081, 2194.9451263718374, 2234.7988681018624, 2237.2952519956325, 2240.7535171131162, 2241.0923575951765, 8388.496690198608, 8394.622241999064, 8414.663413463453, 8433.03020152678, 8433.831323373559, 4645.744484053375, 4754.453237877619, 4761.35721677576, 4763.452202996665, 4763.666543341968, 3010.5634682971067, 3220.951685724716, 3224.2423030587793, 3228.596425446819, 3238.8380580971093, 1037.4397825174397, 1078.229066217658, 1091.7434402915308, 1101.7410908436511, 1114.554178328667, 11280.379579123144, 11608.30350178992, 11638.59264925732, 11879.643610691694, 11916.225445346112, 4013.8996525086523, 4107.712460127822, 4108.568600296986, 4201.789910504463, 4214.87355379333, 8938.240249578728, 8940.821183576292, 8941.329400295004, 8941.821163576822, 8942.239909607757, 4680.134175177603, 4683.344331793552, 4685.6017238535105, 4687.882802929886, 4688.57802797743, 3906.3945088511327, 3942.8619998300496, 4394.956050439519, 4401.801918913657, 4405.977970110129, 3431.6225215226304, 3519.7360197985254, 3532.523109380201, 3538.097785064792, 3649.9635003649623, 985.8816941966867, 1001.5643195210107, 1007.1036777268237, 1015.3248090020054, 1024.8667673202435, 818.5784321074651, 835.5947365527715, 844.4840915848993, 857.7555396711907, 860.165639329849, 5503.889922201533, 5647.774089036475, 5677.545796336283, 5730.770769169187, 5808.477237048602, 389.3983795036675, 403.8788363490941, 404.54286656078443, 409.8749881286236, 412.8637549608622, 3789.242151569697, 3803.201327721154, 3844.4809950656304, 3865.342891708416, 3943.5662077171487, 10155.543000564992, 10763.19276054299, 10835.566577336818, 10843.891561084289, 10846.78306433867, 10613.628523001658, 10793.08258798011, 10813.459327033617, 10818.24272300947, 10827.621033263798, 7851.2148785121035, 8009.959950200212, 8011.439199256112, 8016.438849280611, 8024.799380015546, 5594.804181853616, 5607.523360514402, 5640.125780504029, 5722.914156287576, 5824.650520968756, 9537.093976072261, 9780.168685661798, 9914.355566888418, 10029.147522460673, 10047.14599259042, 8606.0, 9751.756206094904, 10014.248931330034, 10147.898521014695, 10156.085952264331, 6968.930310696828, 7067.646617668993, 7129.180144283474, 7332.633368331669, 7378.815529611803, 7523.172451030492, 7705.383569314329, 7746.961265193863, 7766.805829854299, 7882.684692612232, 7038.120234970629, 7209.927900720925, 7264.382527485223, 7306.086739157606, 7328.596927168844, 7169.749058782918, 7206.783796486114, 7241.782746517613, 7258.927410725825, 7271.236520165518, 6363.172787537591, 6455.515836312202, 6456.225252969673, 6461.773837915838, 6464.997925321582, 4727.267273572602, 4795.808167673254, 4822.734749588806, 4891.559759621651, 4910.852674419773, 4858.63560232991, 4912.631552633496, 5048.141815891381, 5081.136206844772, 5175.068487672255], "value": 4224.617913988242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.24892027489346, 302.6761365339087, 311.92825650100474, 316.31517764040854, 319.68927397669574, 5035.647504674675, 5125.564327032207, 5161.406438259602, 5227.529522342993, 5239.694534404864, 5160.974195129019, 5185.403678576965, 5189.377274727038, 5193.428722840494, 5211.635185537014, 4099.754014759124, 4109.527404348508, 4117.238310912476, 4127.690423218256, 4132.462779838616, 3931.6658084062888, 4039.7778122203267, 4120.423140760296, 4125.773082480462, 4125.793710314488, 4012.5184977802705, 4016.2168377166463, 4018.4976877890263, 4029.2545879012478, 4031.496062992126, 4004.8798536043964, 4006.639402453793, 4016.758994460327, 4028.2547728669997, 4039.8284497495692, 3549.6272891346293, 3550.7336949728874, 3568.572570971606, 3580.8925732228076, 3584.5698516177963, 4881.975590122027, 5079.568236699885, 5116.309298244727, 5116.718580478072, 5157.896842063138, 4544.182047231497, 4559.772011399416, 4596.3794887690065, 4599.908001839978, 4602.286645569942, 5353.715108373962, 5380.0, 5380.784768609251, 5382.973085134549, 5383.515483606455, 3641.617630148849, 3793.525809273841, 3842.5773164951834, 3856.2865869814173, 3858.9614103858885, 5568.805091821807, 5584.832455026356, 5588.6646801191655, 5595.740958284394, 5607.551395888319, 3915.471411359487, 3929.430232616312, 3935.74417662851, 3940.7241493095207, 3957.683385329167, 3910.904946614952, 3963.504561929759, 3996.2806694795217, 4007.356983636695, 4017.4777278953547, 4552.294394368878, 4557.5442455754155, 4566.360709500673, 4568.725876447424, 4575.519570445055, 5422.91865622016, 5443.863903402367, 5449.155380915885, 5459.3994660587305, 5460.126379779295, 1252.6659108049898, 1321.8744219299151, 1345.2063282663275, 1373.6085215713474, 1375.4360712107987, 921.4473611963863, 922.8338898998245, 943.104051151409, 948.5020364308655, 953.2802733935972, 5190.81832135881, 5215.452377500384, 5216.530512253916, 5234.1680411856305, 5244.5279924806955, 5499.285092937893, 5506.64206826555, 5528.170774383874, 5534.640248383842, 5546.77812887488, 5087.97456012725, 5235.136202526616, 5250.7637156328055, 5261.605379596469, 5330.413654498002, 2932.0, 2946.543285790706, 2949.3953739483354, 2964.43675701616, 2982.910512684623, 5766.221560089334, 5791.945638053379, 5827.737751801179, 5830.7959221427045, 5849.766009359578, 5581.214011516357, 5583.413741557078, 5606.327240731139, 5632.436756324335, 5653.462921022497, 5672.205891175238, 5694.430556944355, 5696.287964004499, 5704.828855134269, 5706.686132262766, 5346.6257361985845, 5527.972360138335, 5541.6120871540215, 5567.832965011056, 5606.0, 5461.836144915659, 5467.699276539828, 5471.838623743679, 5537.366476889408, 5589.413111623221, 5739.7417116229035, 5747.0, 5774.364819869895, 5794.942050579441, 5811.593188476766, 3922.56851746302, 3981.482407287034, 3983.143624120828, 4004.739691920016, 4018.3972404139613, 5289.2330612061805, 5521.5306698931045, 5534.4742249486235, 5545.391836367408, 5587.832365029056, 5293.338332708411, 5386.192071189353, 5409.161579955114, 5420.482264965816, 5430.755615997368, 5391.406945236099, 5416.75624596902, 5417.945820541744, 5428.511433970962, 5463.972680136574, 5266.289050978069, 5302.787888484418, 5361.624686271924, 5379.1662292344745, 5400.918986215289, 5424.457554244544, 5434.266374039454, 5462.317210348707, 5468.015757163748, 5486.396496385474, 5313.760880760297, 5345.0, 5362.329708786402, 5372.167314066326, 5411.350637923474], "value": 4130.460994159506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.6643746626956, 608.473670275212, 649.4252586460981, 649.6946435175468, 653.8953767397218, 12560.246385216893, 12856.22862628243, 13062.216267023974, 14784.482543110993, 15328.693426131471, 14056.226907520082, 14063.648408789786, 14077.929610351934, 14088.57734267971, 14093.154410735364, 571.8598943258886, 571.9227904232916, 574.5805561939776, 582.7581553655228, 661.4576047640936, 562.2213234669971, 671.8286836856595, 681.3731367142241, 683.3303362704553, 684.1106561470094, 601.419630056995, 603.4327731931992, 606.5966132521868, 606.9666168360739, 607.0196632438624, 603.5352778360682, 604.3865476541292, 604.8306474187235, 604.8548348396397, 605.2887856768301, 428.4366058632919, 437.2261097856776, 437.9671524635665, 438.54610478154956, 503.90173916086377, 12474.18917770342, 13107.541236056788, 13113.409896554582, 13123.081384303103, 13127.737445251138, 11975.580854670045, 12514.0, 12704.491820327175, 12842.422091005834, 13433.529826456124, 11805.468753906094, 12283.324417157053, 12441.564545240873, 12461.691542288558, 12475.313857737821, 4071.442481013425, 4108.815103320358, 4248.787560621957, 4288.421063156465, 4323.567643235683, 82206.17793822045, 82442.0, 82992.17007829905, 85145.57427212886, 85913.14086859114, 9992.65025724096, 10043.497825108716, 10120.443375614412, 10173.694789156338, 10372.948135259276, 17335.56661083483, 17336.739948900777, 17345.56636084083, 17370.739438908426, 17380.739288910678, 7871.252231038042, 7906.683732650629, 7967.442279040528, 8075.3539716822515, 8201.466904651179, 4616.238320677051, 4778.402699662543, 4786.305985632064, 4953.108440480676, 5012.473690262543, 2988.506896362076, 3095.086949349947, 3105.0374383941053, 3107.5804766356705, 3112.2219445138717, 517.7644171901776, 521.1765410651162, 534.3747815056394, 537.4276395638632, 540.3650710415246, 620.3437119705584, 658.5686375424104, 672.2922388918148, 677.2110491277606, 682.5904457325565, 8565.18630730092, 8977.147171018873, 9086.070975603612, 9146.54267286633, 9288.814223715488, 638.2022471910112, 642.2389468479867, 658.0885473619072, 664.3389827121948, 703.1948419060147, 3917.138229589486, 4140.0891803803115, 4154.086101057763, 4219.240536703362, 4224.281872081753, 65790.34209657938, 66935.33064669388, 110279.0, 114216.0, 122146.38926805308, 62846.0, 63324.0, 85317.57341213254, 96784.0, 99619.50190249002, 53855.19217211745, 53932.0, 80290.59854700688, 82583.0, 84357.57821210855, 8700.303975682056, 9267.907320926704, 9278.257739380968, 9301.767455813659, 9313.208377288007, 50232.0, 50338.0, 50340.0, 51259.23111153261, 53179.0, 42522.78738606411, 48448.0, 49066.0, 55079.724601376736, 70833.0, 11662.416879156179, 11822.34977076269, 11859.881401185878, 11887.821682674594, 12369.010479161825, 12238.388080595756, 12638.431270592662, 13082.28047457399, 13790.862091379358, 14009.649758755704, 12159.635210943687, 12862.0, 13205.141665791693, 13211.405486752927, 13214.537491187762, 9290.767730806783, 12051.276923384625, 12369.505219791108, 12547.24716517012, 12785.80821287663, 12766.17019893704, 12838.29389383593, 13017.739645207232, 13193.670158246121, 13339.466421343037, 9884.802303954024, 10133.442660653734, 10354.792904142025, 10685.19861010443, 12135.878641213474, 9433.386829856037, 10295.17638588896, 10929.398883061507, 11259.493322800658, 11267.436628168723], "value": 6681.611982317876, "unit": "score"}], "name": "dromaeo_css", "value": 6725.870073102253, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 112.0, 111.0, 113.0, 119.0, 115.0, 114.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 144.0, 189.0, 117.0, 156.0, 150.0, 118.0, 187.0, 118.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 181.0, 76.0, 76.0, 75.0, 76.0, 162.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 152.0, 85.0, 86.0, 86.0, 142.0, 85.0, 85.0, 147.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 54.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 62.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 84.0, 79.0, 83.0, 88.0, 83.0, 78.0, 78.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 124.0, 123.0, 134.0, 121.0, 128.0, 139.0, 151.0, 126.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 160.0, 163.0, 163.0, 163.0, 162.0, 163.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 65.0, 63.0, 69.0, 65.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1528.0, "alertThreshold": 2.0}]} 11:52:45 INFO - Return code: 0 11:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:45 INFO - # TBPL SUCCESS # 11:52:45 INFO - Running post-action listener: _resource_record_post_action 11:52:45 INFO - [mozharness: 2016-08-22 18:52:45.206917Z] Finished run-tests step (success) 11:52:45 INFO - Running post-run listener: _resource_record_post_run 11:52:45 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414384128; Read time: 12; Write time: 295148 11:52:45 INFO - TinderboxPrint: CPU usage
13.2% 11:52:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:52:45 INFO - TinderboxPrint: I/O write bytes / time
414,384,128 / 295,148 11:52:45 INFO - TinderboxPrint: CPU idle
8,273.8 (86.8%) 11:52:45 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 11:52:45 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 126349312; Read time: 0; Write time: 98896 11:52:45 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288034816; Read time: 0; Write time: 196252 11:52:45 INFO - Running post-run listener: _upload_blobber_files 11:52:45 INFO - Blob upload gear active. 11:52:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:45 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 11:52:45 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'] 11:52:45 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 11:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:50 INFO - (blobuploader) - INFO - Done attempting. 11:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:51 INFO - (blobuploader) - INFO - Done attempting. 11:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:51 INFO - (blobuploader) - INFO - Done attempting. 11:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:51 INFO - Return code: 0 11:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c900902e7577366c53429ed3b184b3e77451e6b65db18a732db44bb853942d4b8372ac0200bf35a240bc17accb960b817226027b5185a4b97df7a6529d3b0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2775cf5dc2fd992672c0d6c35df6aa5a52ef4cf2ff5bf6f3d1a16bc43b5e5ddeada8b9d4145d74731f464433906799fb734d45b3fcb78599659d25e2c421c738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/968c7b5829f68b9f7297dba8131873c1ccc4a113af838baf8d66b8454b0ba2f6ceacdc1e34a3bb2609b30ec5620a73faf8ddc4df1da13aecba5fa6bc8eecb95c"} 11:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:51 INFO - Contents: 11:52:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c900902e7577366c53429ed3b184b3e77451e6b65db18a732db44bb853942d4b8372ac0200bf35a240bc17accb960b817226027b5185a4b97df7a6529d3b0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2775cf5dc2fd992672c0d6c35df6aa5a52ef4cf2ff5bf6f3d1a16bc43b5e5ddeada8b9d4145d74731f464433906799fb734d45b3fcb78599659d25e2c421c738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/968c7b5829f68b9f7297dba8131873c1ccc4a113af838baf8d66b8454b0ba2f6ceacdc1e34a3bb2609b30ec5620a73faf8ddc4df1da13aecba5fa6bc8eecb95c"} 11:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:51 INFO - Copying logs to upload dir... 11:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.525680 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-22 11:52:51.241780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:52:51.245597) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c900902e7577366c53429ed3b184b3e77451e6b65db18a732db44bb853942d4b8372ac0200bf35a240bc17accb960b817226027b5185a4b97df7a6529d3b0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2775cf5dc2fd992672c0d6c35df6aa5a52ef4cf2ff5bf6f3d1a16bc43b5e5ddeada8b9d4145d74731f464433906799fb734d45b3fcb78599659d25e2c421c738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/968c7b5829f68b9f7297dba8131873c1ccc4a113af838baf8d66b8454b0ba2f6ceacdc1e34a3bb2609b30ec5620a73faf8ddc4df1da13aecba5fa6bc8eecb95c"} build_url:https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/V65O_wI9R9Otg5mrXSXD1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c900902e7577366c53429ed3b184b3e77451e6b65db18a732db44bb853942d4b8372ac0200bf35a240bc17accb960b817226027b5185a4b97df7a6529d3b0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2775cf5dc2fd992672c0d6c35df6aa5a52ef4cf2ff5bf6f3d1a16bc43b5e5ddeada8b9d4145d74731f464433906799fb734d45b3fcb78599659d25e2c421c738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/968c7b5829f68b9f7297dba8131873c1ccc4a113af838baf8d66b8454b0ba2f6ceacdc1e34a3bb2609b30ec5620a73faf8ddc4df1da13aecba5fa6bc8eecb95c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:52:51.271602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:52:51.271990) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471890710.444242-1147095604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:52:51.358867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:52:51.359566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:52:51.359995) ========= ========= Total master_lag: 0.19 =========