builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1468413678.29 results: success (0) buildid: 20160713030216 builduid: e4809dcd9077422d806aa716399f9e65 revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.294676) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.295111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.295432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.367904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.368174) ========= 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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 05:41:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-07-13 05:41:18 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094445 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.492721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.493258) ========= 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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014656 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.550214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:18.550789) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 04821a70c739a00d12e12df651c0989441e22728 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 04821a70c739a00d12e12df651c0989441e22728 --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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 05:41:19,104 truncating revision to first 12 chars 2016-07-13 05:41:19,104 Setting DEBUG logging. 2016-07-13 05:41:19,104 attempt 1/10 2016-07-13 05:41:19,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/04821a70c739?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 05:41:19,429 unpacking tar archive at: mozilla-central-04821a70c739/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:19.264413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:19.264725) ========= script_repo_revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:19.265147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:19.265438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 05:41:19.274497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 05:41:19.275118) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:19 INFO - MultiFileLogger online at 20160713 05:41:19 in /builds/slave/test 05:41:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:19 INFO - {'append_to_log': False, 05:41:19 INFO - 'base_work_dir': '/builds/slave/test', 05:41:19 INFO - 'blob_upload_branch': 'Firefox', 05:41:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:19 INFO - 'branch': 'Firefox', 05:41:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:19 INFO - 'config_files': ('talos/linux_config.py',), 05:41:19 INFO - 'default_actions': ('clobber', 05:41:19 INFO - 'read-buildbot-config', 05:41:19 INFO - 'download-and-extract', 05:41:19 INFO - 'populate-webroot', 05:41:19 INFO - 'create-virtualenv', 05:41:19 INFO - 'install', 05:41:19 INFO - 'run-tests'), 05:41:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:19 INFO - 'download_minidump_stackwalk': True, 05:41:19 INFO - 'download_symbols': 'ondemand', 05:41:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:19 INFO - 'installer_path': 'installer.exe', 05:41:19 INFO - 'log_level': 'info', 05:41:19 INFO - 'log_name': 'talos', 05:41:19 INFO - 'log_to_console': True, 05:41:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:19 INFO - 'opt_config_files': (), 05:41:19 INFO - 'pip_index': False, 05:41:19 INFO - 'sps_profile': False, 05:41:19 INFO - 'sps_profile_interval': 0, 05:41:19 INFO - 'suite': 'dromaeojs', 05:41:19 INFO - 'system_bits': '32', 05:41:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:19 INFO - 'title': 'talos-linux64-ix-052', 05:41:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:19 INFO - 'use_talos_json': True, 05:41:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:19 INFO - 'work_dir': 'build'} 05:41:19 INFO - ##### 05:41:19 INFO - ##### Running clobber step. 05:41:19 INFO - ##### 05:41:19 INFO - Running pre-action listener: _resource_record_pre_action 05:41:19 INFO - Running main action method: clobber 05:41:19 INFO - rmtree: /builds/slave/test/build 05:41:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:20 INFO - Running post-action listener: _resource_record_post_action 05:41:20 INFO - ##### 05:41:20 INFO - ##### Finished clobber step (success) 05:41:20 INFO - ##### 05:41:20 INFO - ##### 05:41:20 INFO - ##### Running read-buildbot-config step. 05:41:20 INFO - ##### 05:41:20 INFO - Running pre-action listener: _resource_record_pre_action 05:41:20 INFO - Running main action method: read_buildbot_config 05:41:20 INFO - Using buildbot properties: 05:41:20 INFO - { 05:41:20 INFO - "project": "", 05:41:20 INFO - "product": "firefox", 05:41:20 INFO - "script_repo_revision": "production", 05:41:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:41:20 INFO - "repository": "", 05:41:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:41:20 INFO - "buildid": "20160713030216", 05:41:20 INFO - "stage_platform": "linux64-pgo", 05:41:20 INFO - "basedir": "/builds/slave/test", 05:41:20 INFO - "nightly_build": "True", 05:41:20 INFO - "buildnumber": 501, 05:41:20 INFO - "slavename": "talos-linux64-ix-052", 05:41:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:41:20 INFO - "platform": "ubuntu64_hw", 05:41:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:20 INFO - "branch": "mozilla-central", 05:41:20 INFO - "repo_path": "mozilla-central", 05:41:20 INFO - "revision": "04821a70c739a00d12e12df651c0989441e22728", 05:41:20 INFO - "pgo_build": "True", 05:41:20 INFO - "builduid": "e4809dcd9077422d806aa716399f9e65", 05:41:20 INFO - "slavebuilddir": "test" 05:41:20 INFO - } 05:41:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:41:20 INFO - Running post-action listener: _resource_record_post_action 05:41:20 INFO - ##### 05:41:20 INFO - ##### Finished read-buildbot-config step (success) 05:41:20 INFO - ##### 05:41:20 INFO - ##### 05:41:20 INFO - ##### Running download-and-extract step. 05:41:20 INFO - ##### 05:41:20 INFO - Running pre-action listener: _resource_record_pre_action 05:41:20 INFO - Running main action method: download_and_extract 05:41:20 INFO - mkdir: /builds/slave/test/build/tests 05:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:20 INFO - https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:41:22 INFO - Downloaded 1361 bytes. 05:41:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:22 INFO - Using the following test package requirements: 05:41:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:41:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'jsshell-linux-x86_64.zip'], 05:41:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:22 INFO - https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:23 INFO - Downloaded 24321289 bytes. 05:41:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:24 INFO - Return code: 0 05:41:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:24 INFO - https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:26 INFO - Downloaded 24321289 bytes. 05:41:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:27 INFO - Return code: 0 05:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:27 INFO - https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:41:28 INFO - Downloaded 14403317 bytes. 05:41:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:41:28 INFO - Return code: 0 05:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:28 INFO - https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:41:30 INFO - Downloaded 60791007 bytes. 05:41:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:30 INFO - mkdir: /builds/slave/test/properties 05:41:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:30 INFO - Contents: 05:41:30 INFO - build_url:https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:30 INFO - Running post-action listener: _resource_record_post_action 05:41:30 INFO - Running post-action listener: set_extra_try_arguments 05:41:30 INFO - ##### 05:41:30 INFO - ##### Finished download-and-extract step (success) 05:41:30 INFO - ##### 05:41:30 INFO - ##### 05:41:30 INFO - ##### Running populate-webroot step. 05:41:30 INFO - ##### 05:41:30 INFO - Running pre-action listener: _resource_record_pre_action 05:41:30 INFO - Running main action method: populate_webroot 05:41:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:30 INFO - '--tppagecycles', 05:41:30 INFO - '7'], 05:41:30 INFO - 'tests': ['tsvgm']}}, 05:41:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['damp', 'tps']}, 05:41:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'tests': ['damp', 'tps']}, 05:41:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['dromaeo_dom']}, 05:41:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['basic_compositor_video']}, 05:41:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:41:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['a11yr', 05:41:30 INFO - 'ts_paint', 05:41:30 INFO - 'tpaint', 05:41:30 INFO - 'sessionrestore', 05:41:30 INFO - 'sessionrestore_no_auto_restore', 05:41:30 INFO - 'tabpaint']}, 05:41:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['tsvgx', 05:41:30 INFO - 'tsvgr_opacity', 05:41:30 INFO - 'tart', 05:41:30 INFO - 'tscrollx', 05:41:30 INFO - 'cart']}, 05:41:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:30 INFO - 'tsvgr_opacity', 05:41:30 INFO - 'tart', 05:41:30 INFO - 'tscrollx', 05:41:30 INFO - 'cart']}, 05:41:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'talos_options': ['--disable-e10s'], 05:41:30 INFO - 'tests': ['tp5o']}, 05:41:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'tests': ['tp5o']}, 05:41:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'talos_options': ['--disable-e10s', 05:41:30 INFO - '--xperf_path', 05:41:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:30 INFO - 'tests': ['tp5n']}, 05:41:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:30 INFO - 'talos_options': ['--xperf_path', 05:41:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:30 INFO - 'tests': ['tp5n']}}, 05:41:30 INFO - 'talos.zip': {'path': '', 05:41:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:30 INFO - Running post-action listener: _resource_record_post_action 05:41:30 INFO - ##### 05:41:30 INFO - ##### Finished populate-webroot step (success) 05:41:30 INFO - ##### 05:41:30 INFO - ##### 05:41:30 INFO - ##### Running create-virtualenv step. 05:41:30 INFO - ##### 05:41:30 INFO - Running pre-action listener: _resource_record_pre_action 05:41:30 INFO - Running main action method: create_virtualenv 05:41:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:30 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 05:41:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:30 INFO - Using real prefix '/usr' 05:41:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:33 INFO - Installing pip.................done. 05:41:33 INFO - Return code: 0 05:41:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41: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', 'pip>=1.5'] in /builds/slave/test/build 05:41: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 pip>=1.5 05:41:33 INFO - Using env: {'DISPLAY': ':0', 05:41:33 INFO - 'HOME': '/home/cltbld', 05:41:33 INFO - 'LANG': 'en_US.UTF-8', 05:41:33 INFO - 'LANGUAGE': 'en_US:en', 05:41:33 INFO - 'LOGNAME': 'cltbld', 05:41:33 INFO - 'MAIL': '/var/mail/cltbld', 05:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:33 INFO - 'MOZ_NO_REMOTE': '1', 05:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:33 INFO - 'NO_EM_RESTART': '1', 05:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:33 INFO - 'PWD': '/builds/slave/test', 05:41:33 INFO - 'SHELL': '/bin/bash', 05:41:33 INFO - 'SHLVL': '1', 05:41:33 INFO - 'TERM': 'linux', 05:41:33 INFO - 'TMOUT': '86400', 05:41:33 INFO - 'USER': 'cltbld', 05:41:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:33 INFO - '_': '/tools/buildbot/bin/python'} 05:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:33 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 05:41:33 INFO - Cleaning up... 05:41:33 INFO - Return code: 0 05:41:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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', '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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:41: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 psutil>=3.1.1 05:41:33 INFO - Using env: {'DISPLAY': ':0', 05:41:33 INFO - 'HOME': '/home/cltbld', 05:41:33 INFO - 'LANG': 'en_US.UTF-8', 05:41:33 INFO - 'LANGUAGE': 'en_US:en', 05:41:33 INFO - 'LOGNAME': 'cltbld', 05:41:33 INFO - 'MAIL': '/var/mail/cltbld', 05:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:33 INFO - 'MOZ_NO_REMOTE': '1', 05:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:33 INFO - 'NO_EM_RESTART': '1', 05:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:33 INFO - 'PWD': '/builds/slave/test', 05:41:33 INFO - 'SHELL': '/bin/bash', 05:41:33 INFO - 'SHLVL': '1', 05:41:33 INFO - 'TERM': 'linux', 05:41:33 INFO - 'TMOUT': '86400', 05:41:33 INFO - 'USER': 'cltbld', 05:41:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:33 INFO - '_': '/tools/buildbot/bin/python'} 05:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:33 INFO - Downloading/unpacking psutil>=3.1.1 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:35 INFO - Installing collected packages: psutil 05:41:35 INFO - Running setup.py install for psutil 05:41:36 INFO - building 'psutil._psutil_linux' extension 05:41:36 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 05:41:36 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 05:41:36 INFO - building 'psutil._psutil_posix' extension 05:41:36 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 05:41:36 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 05:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:36 INFO - Successfully installed psutil 05:41:36 INFO - Cleaning up... 05:41:36 INFO - Return code: 0 05:41:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:36 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 05:41:36 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 05:41:36 INFO - Using env: {'DISPLAY': ':0', 05:41:36 INFO - 'HOME': '/home/cltbld', 05:41:36 INFO - 'LANG': 'en_US.UTF-8', 05:41:36 INFO - 'LANGUAGE': 'en_US:en', 05:41:36 INFO - 'LOGNAME': 'cltbld', 05:41:36 INFO - 'MAIL': '/var/mail/cltbld', 05:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:36 INFO - 'MOZ_NO_REMOTE': '1', 05:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:36 INFO - 'NO_EM_RESTART': '1', 05:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:36 INFO - 'PWD': '/builds/slave/test', 05:41:36 INFO - 'SHELL': '/bin/bash', 05:41:36 INFO - 'SHLVL': '1', 05:41:36 INFO - 'TERM': 'linux', 05:41:36 INFO - 'TMOUT': '86400', 05:41:36 INFO - 'USER': 'cltbld', 05:41:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:36 INFO - '_': '/tools/buildbot/bin/python'} 05:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:36 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 05:41:36 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 05:41:36 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 05:41:36 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 05:41:36 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 05:41:36 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 05:41:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:38 INFO - Installing collected packages: mozsystemmonitor 05:41:38 INFO - Running setup.py install for mozsystemmonitor 05:41:38 INFO - Successfully installed mozsystemmonitor 05:41:38 INFO - Cleaning up... 05:41:38 INFO - Return code: 0 05:41:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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', '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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:41: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 jsonschema==2.5.1 05:41:38 INFO - Using env: {'DISPLAY': ':0', 05:41:38 INFO - 'HOME': '/home/cltbld', 05:41:38 INFO - 'LANG': 'en_US.UTF-8', 05:41:38 INFO - 'LANGUAGE': 'en_US:en', 05:41:38 INFO - 'LOGNAME': 'cltbld', 05:41:38 INFO - 'MAIL': '/var/mail/cltbld', 05:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:38 INFO - 'MOZ_NO_REMOTE': '1', 05:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:38 INFO - 'NO_EM_RESTART': '1', 05:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:38 INFO - 'PWD': '/builds/slave/test', 05:41:38 INFO - 'SHELL': '/bin/bash', 05:41:38 INFO - 'SHLVL': '1', 05:41:38 INFO - 'TERM': 'linux', 05:41:38 INFO - 'TMOUT': '86400', 05:41:38 INFO - 'USER': 'cltbld', 05:41:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:38 INFO - '_': '/tools/buildbot/bin/python'} 05:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:41 INFO - warning: no files found matching '*.txt' 05:41:41 INFO - no previously-included directories found matching 'build' 05:41:41 INFO - no previously-included directories found matching 'dist' 05:41:41 INFO - no previously-included directories found matching '.git*' 05:41:41 INFO - Installing collected packages: jsonschema, functools32 05:41:41 INFO - Running setup.py install for functools32 05:41:41 INFO - warning: no files found matching '*.txt' 05:41:41 INFO - no previously-included directories found matching 'build' 05:41:41 INFO - no previously-included directories found matching 'dist' 05:41:41 INFO - no previously-included directories found matching '.git*' 05:41:41 INFO - Successfully installed jsonschema functools32 05:41:41 INFO - Cleaning up... 05:41:41 INFO - Return code: 0 05:41:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:41 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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:41 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 05:41:41 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 05:41:41 INFO - Using env: {'DISPLAY': ':0', 05:41:41 INFO - 'HOME': '/home/cltbld', 05:41:41 INFO - 'LANG': 'en_US.UTF-8', 05:41:41 INFO - 'LANGUAGE': 'en_US:en', 05:41:41 INFO - 'LOGNAME': 'cltbld', 05:41:41 INFO - 'MAIL': '/var/mail/cltbld', 05:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:41 INFO - 'MOZ_NO_REMOTE': '1', 05:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:41 INFO - 'NO_EM_RESTART': '1', 05:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:41 INFO - 'PWD': '/builds/slave/test', 05:41:41 INFO - 'SHELL': '/bin/bash', 05:41:41 INFO - 'SHLVL': '1', 05:41:41 INFO - 'TERM': 'linux', 05:41:41 INFO - 'TMOUT': '86400', 05:41:41 INFO - 'USER': 'cltbld', 05:41:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:41 INFO - '_': '/tools/buildbot/bin/python'} 05:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:41 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 05:41:41 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 05:41:41 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 05:41:41 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 05:41:41 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 05:41:41 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 05:41:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:44 INFO - Downloading docopt-0.6.1.tar.gz 05:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:44 INFO - Running setup.py install for blobuploader 05:41:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:44 INFO - Running setup.py install for requests 05:41:44 INFO - Running setup.py install for docopt 05:41:44 INFO - Successfully installed blobuploader requests docopt 05:41:44 INFO - Cleaning up... 05:41:44 INFO - Return code: 0 05:41:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:44 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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:44 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 05:41:44 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 05:41:44 INFO - Using env: {'DISPLAY': ':0', 05:41:44 INFO - 'HOME': '/home/cltbld', 05:41:44 INFO - 'LANG': 'en_US.UTF-8', 05:41:44 INFO - 'LANGUAGE': 'en_US:en', 05:41:44 INFO - 'LOGNAME': 'cltbld', 05:41:44 INFO - 'MAIL': '/var/mail/cltbld', 05:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:44 INFO - 'MOZ_NO_REMOTE': '1', 05:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:44 INFO - 'NO_EM_RESTART': '1', 05:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:44 INFO - 'PWD': '/builds/slave/test', 05:41:44 INFO - 'SHELL': '/bin/bash', 05:41:44 INFO - 'SHLVL': '1', 05:41:44 INFO - 'TERM': 'linux', 05:41:44 INFO - 'TMOUT': '86400', 05:41:44 INFO - 'USER': 'cltbld', 05:41:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:44 INFO - '_': '/tools/buildbot/bin/python'} 05:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:45 INFO - Running setup.py (path:/tmp/pip-wnuwbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:45 INFO - Running setup.py (path:/tmp/pip-GpdFCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:45 INFO - Running setup.py (path:/tmp/pip-eEIvs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:45 INFO - Running setup.py (path:/tmp/pip-JLM1oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:45 INFO - Running setup.py (path:/tmp/pip-657XKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:45 INFO - Running setup.py (path:/tmp/pip-99ARdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:45 INFO - Running setup.py (path:/tmp/pip-Ez6uJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:45 INFO - Running setup.py (path:/tmp/pip-q9RBAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:45 INFO - Running setup.py (path:/tmp/pip-EJjBbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:45 INFO - Running setup.py (path:/tmp/pip-fy_vwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:45 INFO - Running setup.py (path:/tmp/pip-mkjf26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:45 INFO - Running setup.py (path:/tmp/pip-qtlMHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:45 INFO - Running setup.py (path:/tmp/pip-Yrh13W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:46 INFO - Running setup.py (path:/tmp/pip-3cefDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:46 INFO - Running setup.py (path:/tmp/pip-vWG9mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:46 INFO - Running setup.py (path:/tmp/pip-hBOgBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:46 INFO - Running setup.py (path:/tmp/pip-3JA1Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:46 INFO - Running setup.py install for manifestparser 05:41:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:46 INFO - Running setup.py install for mozcrash 05:41:46 INFO - Running setup.py install for mozdebug 05:41:46 INFO - Running setup.py install for mozdevice 05:41:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:46 INFO - Running setup.py install for mozfile 05:41:46 INFO - Running setup.py install for mozhttpd 05:41:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:46 INFO - Running setup.py install for mozinfo 05:41:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for mozInstall 05:41:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for mozleak 05:41:47 INFO - Running setup.py install for mozlog 05:41:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for moznetwork 05:41:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for mozprocess 05:41:47 INFO - Running setup.py install for mozprofile 05:41:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for mozrunner 05:41:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:47 INFO - Running setup.py install for mozscreenshot 05:41:47 INFO - Running setup.py install for moztest 05:41:47 INFO - Running setup.py install for mozversion 05:41:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:48 INFO - Cleaning up... 05:41:48 INFO - Return code: 0 05:41:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:48 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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:48 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 05:41:48 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 05:41:48 INFO - Using env: {'DISPLAY': ':0', 05:41:48 INFO - 'HOME': '/home/cltbld', 05:41:48 INFO - 'LANG': 'en_US.UTF-8', 05:41:48 INFO - 'LANGUAGE': 'en_US:en', 05:41:48 INFO - 'LOGNAME': 'cltbld', 05:41:48 INFO - 'MAIL': '/var/mail/cltbld', 05:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:48 INFO - 'MOZ_NO_REMOTE': '1', 05:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:48 INFO - 'NO_EM_RESTART': '1', 05:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:48 INFO - 'PWD': '/builds/slave/test', 05:41:48 INFO - 'SHELL': '/bin/bash', 05:41:48 INFO - 'SHLVL': '1', 05:41:48 INFO - 'TERM': 'linux', 05:41:48 INFO - 'TMOUT': '86400', 05:41:48 INFO - 'USER': 'cltbld', 05:41:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:48 INFO - '_': '/tools/buildbot/bin/python'} 05:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:48 INFO - Running setup.py (path:/tmp/pip-kcJFPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:48 INFO - Running setup.py (path:/tmp/pip-tTfc9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:48 INFO - Running setup.py (path:/tmp/pip-eJcloW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:48 INFO - Running setup.py (path:/tmp/pip-i5KL6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:48 INFO - Running setup.py (path:/tmp/pip-4wwjCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:48 INFO - Running setup.py (path:/tmp/pip-hRtAUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:48 INFO - Running setup.py (path:/tmp/pip-uk0rox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:48 INFO - Running setup.py (path:/tmp/pip-_v4ZMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:48 INFO - Running setup.py (path:/tmp/pip-EKNbZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:48 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)) 05:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:48 INFO - Running setup.py (path:/tmp/pip-QK0oEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:49 INFO - Running setup.py (path:/tmp/pip-LXb3CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:49 INFO - Running setup.py (path:/tmp/pip-vKjOjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:49 INFO - Running setup.py (path:/tmp/pip-cLY2gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:49 INFO - Running setup.py (path:/tmp/pip-CbdKru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:49 INFO - Running setup.py (path:/tmp/pip-_pd1cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:49 INFO - Running setup.py (path:/tmp/pip-euATb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:49 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)) 05:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:49 INFO - Running setup.py (path:/tmp/pip-ceXVm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:49 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)) 05:41:49 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)) 05:41:49 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)) 05:41:49 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)) 05:41:49 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)) 05:41:49 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)) 05:41:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:49 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 05:41:49 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 05:41:49 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 05:41:49 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 05:41:49 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 05:41:49 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 05:41:51 INFO - Downloading blessings-1.6.tar.gz 05:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:51 INFO - Installing collected packages: blessings 05:41:51 INFO - Running setup.py install for blessings 05:41:51 INFO - Successfully installed blessings 05:41:51 INFO - Cleaning up... 05:41:51 INFO - Return code: 0 05:41:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:51 INFO - Reading from file tmpfile_stdout 05:41:51 INFO - Current package versions: 05:41:51 INFO - argparse == 1.2.1 05:41:51 INFO - blessings == 1.6 05:41:51 INFO - blobuploader == 1.2.4 05:41:51 INFO - docopt == 0.6.1 05:41:51 INFO - functools32 == 3.2.3-2 05:41:51 INFO - jsonschema == 2.5.1 05:41:51 INFO - manifestparser == 1.1 05:41:51 INFO - mozInstall == 1.12 05:41:51 INFO - mozcrash == 0.17 05:41:51 INFO - mozdebug == 0.1 05:41:51 INFO - mozdevice == 0.48 05:41:51 INFO - mozfile == 1.2 05:41:51 INFO - mozhttpd == 0.7 05:41:51 INFO - mozinfo == 0.9 05:41:51 INFO - mozleak == 0.1 05:41:51 INFO - mozlog == 3.2 05:41:51 INFO - moznetwork == 0.27 05:41:51 INFO - mozprocess == 0.23 05:41:51 INFO - mozprofile == 0.28 05:41:51 INFO - mozrunner == 6.12 05:41:51 INFO - mozscreenshot == 0.1 05:41:51 INFO - mozsystemmonitor == 0.3 05:41:51 INFO - moztest == 0.7 05:41:51 INFO - mozversion == 1.4 05:41:51 INFO - psutil == 3.1.1 05:41:51 INFO - requests == 1.2.3 05:41:51 INFO - wsgiref == 0.1.2 05:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:51 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 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:51 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 05:41:51 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 05:41:51 INFO - Using env: {'DISPLAY': ':0', 05:41:51 INFO - 'HOME': '/home/cltbld', 05:41:51 INFO - 'LANG': 'en_US.UTF-8', 05:41:51 INFO - 'LANGUAGE': 'en_US:en', 05:41:51 INFO - 'LOGNAME': 'cltbld', 05:41:51 INFO - 'MAIL': '/var/mail/cltbld', 05:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:51 INFO - 'MOZ_NO_REMOTE': '1', 05:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:51 INFO - 'NO_EM_RESTART': '1', 05:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:51 INFO - 'PWD': '/builds/slave/test', 05:41:51 INFO - 'SHELL': '/bin/bash', 05:41:51 INFO - 'SHLVL': '1', 05:41:51 INFO - 'TERM': 'linux', 05:41:51 INFO - 'TMOUT': '86400', 05:41:51 INFO - 'USER': 'cltbld', 05:41:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:51 INFO - '_': '/tools/buildbot/bin/python'} 05:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 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)) 05:41:52 INFO - Cleaning up... 05:41:52 INFO - Return code: 0 05:41:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, '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': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', '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 05:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:41:52 INFO - Using env: {'DISPLAY': ':0', 05:41:52 INFO - 'HOME': '/home/cltbld', 05:41:52 INFO - 'LANG': 'en_US.UTF-8', 05:41:52 INFO - 'LANGUAGE': 'en_US:en', 05:41:52 INFO - 'LOGNAME': 'cltbld', 05:41:52 INFO - 'MAIL': '/var/mail/cltbld', 05:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:52 INFO - 'MOZ_NO_REMOTE': '1', 05:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:52 INFO - 'NO_EM_RESTART': '1', 05:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:52 INFO - 'PWD': '/builds/slave/test', 05:41:52 INFO - 'SHELL': '/bin/bash', 05:41:52 INFO - 'SHLVL': '1', 05:41:52 INFO - 'TERM': 'linux', 05:41:52 INFO - 'TMOUT': '86400', 05:41:52 INFO - 'USER': 'cltbld', 05:41:52 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:52 INFO - '_': '/tools/buildbot/bin/python'} 05:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:52 INFO - Cleaning up... 05:41:52 INFO - Return code: 0 05:41:52 INFO - Running post-action listener: _resource_record_post_action 05:41:52 INFO - Running post-action listener: _start_resource_monitoring 05:41:52 INFO - Starting resource monitoring. 05:41:52 INFO - ##### 05:41:52 INFO - ##### Finished create-virtualenv step (success) 05:41:52 INFO - ##### 05:41:52 INFO - ##### 05:41:52 INFO - ##### Running install step. 05:41:52 INFO - ##### 05:41:52 INFO - Running pre-action listener: _resource_record_pre_action 05:41:52 INFO - Running main action method: install 05:41:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:52 INFO - Reading from file tmpfile_stdout 05:41:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:52 INFO - Reading from file tmpfile_stdout 05:41:52 INFO - Output received: 05:41:52 INFO - Usage: mozinstall [options] installer 05:41:52 INFO - Options: 05:41:52 INFO - -h, --help show this help message and exit 05:41:52 INFO - -d DEST, --destination=DEST 05:41:52 INFO - Directory to install application into. [default: 05:41:52 INFO - "/builds/slave/test"] 05:41:52 INFO - --app=APP Application being installed. [default: firefox] 05:41:52 INFO - mkdir: /builds/slave/test/build/application 05:41:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:42:10 INFO - Reading from file tmpfile_stdout 05:42:10 INFO - Output received: 05:42:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:10 INFO - Running post-action listener: _resource_record_post_action 05:42:10 INFO - ##### 05:42:10 INFO - ##### Finished install step (success) 05:42:10 INFO - ##### 05:42:10 INFO - ##### 05:42:10 INFO - ##### Running run-tests step. 05:42:10 INFO - ##### 05:42:10 INFO - Running pre-action listener: _resource_record_pre_action 05:42:10 INFO - Running main action method: run_tests 05:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:10 INFO - Python 2.7.3 05:42:10 INFO - Return code: 0 05:42:10 INFO - grabbing minidump binary from tooltool 05:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:10 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 0xef43b0>, '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 0xef52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:10 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 05:42:10 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 05:42:10 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 05:42:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:10 INFO - Return code: 0 05:42:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 05:42:10 INFO - Using env: {'DISPLAY': ':0', 05:42:10 INFO - 'HOME': '/home/cltbld', 05:42:10 INFO - 'LANG': 'en_US.UTF-8', 05:42:10 INFO - 'LANGUAGE': 'en_US:en', 05:42:10 INFO - 'LOGNAME': 'cltbld', 05:42:10 INFO - 'MAIL': '/var/mail/cltbld', 05:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:10 INFO - 'MOZ_NO_REMOTE': '1', 05:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:10 INFO - 'NO_EM_RESTART': '1', 05:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:10 INFO - 'PWD': '/builds/slave/test', 05:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:10 INFO - 'SHELL': '/bin/bash', 05:42:10 INFO - 'SHLVL': '1', 05:42:10 INFO - 'TERM': 'linux', 05:42:10 INFO - 'TMOUT': '86400', 05:42:10 INFO - 'USER': 'cltbld', 05:42:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715', 05:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:10 INFO - '_': '/tools/buildbot/bin/python'} 05:42:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:42:10 INFO - mozversion application_buildid: 20160713030216 05:42:10 INFO - mozversion application_changeset: 04821a70c739a00d12e12df651c0989441e22728 05:42:10 INFO - mozversion application_display_name: Nightly 05:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:10 INFO - mozversion application_name: Firefox 05:42:10 INFO - mozversion application_remotingname: firefox 05:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:10 INFO - mozversion application_vendor: Mozilla 05:42:10 INFO - mozversion application_version: 50.0a1 05:42:10 INFO - mozversion platform_buildid: 20160713030216 05:42:10 INFO - mozversion platform_changeset: 04821a70c739a00d12e12df651c0989441e22728 05:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:10 INFO - mozversion platform_version: 50.0a1 05:42:10 INFO - using testdate: 1468413730 05:42:10 INFO - actual date: 1468413730 05:42:10 INFO - starting webserver on 'localhost:35494' 05:42:10 INFO - SUITE-START | Running 2 tests 05:42:10 INFO - TEST-START | dromaeo_css 05:42:10 INFO - operating with platform_type : linux_ 05:42:10 INFO - Initialising browser for dromaeo_css test... 05:42:10 INFO - TEST-INFO | started process 26373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2ikw3/profile http://localhost:35494/getInfo.html) 05:42:14 INFO - PROCESS | 26373 | __metrics Screen width/height:1600/1200 05:42:14 INFO - PROCESS | 26373 | colorDepth:24 05:42:14 INFO - PROCESS | 26373 | Browser inner width/height: 1024/697 05:42:14 INFO - PROCESS | 26373 | __metrics 05:42:15 INFO - PROCESS | 26373 | 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" 05:42:15 INFO - PROCESS | 26373 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:16 INFO - TEST-INFO | 26373: exit 0 05:42:16 INFO - Browser initialized. 05:42:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:16 INFO - TEST-INFO | started process 26455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2ikw3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:28 INFO - PROCESS | 26455 | RSS: Main: 157343744 05:42:28 INFO - PROCESS | 26455 | 05:43:19 INFO - PROCESS | 26455 | 1468413799628 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] 05:45:27 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35494/tests/dromaeo/cssquery-ext.html) 05:45:28 INFO - PROCESS | 26455 | RSS: Main: 246231040 05:45:28 INFO - PROCESS | 26455 | 05:48:30 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-ext.html (next: http://localhost:35494/tests/dromaeo/cssquery-jquery.html) 05:48:31 INFO - PROCESS | 26455 | RSS: Main: 250159104 05:48:31 INFO - PROCESS | 26455 | 05:51:33 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35494/tests/dromaeo/cssquery-mootools.html) 05:51:34 INFO - PROCESS | 26455 | RSS: Main: 245915648 05:51:34 INFO - PROCESS | 26455 | 05:54:36 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35494/tests/dromaeo/cssquery-prototype.html) 05:54:36 INFO - PROCESS | 26455 | RSS: Main: 250806272 05:54:36 INFO - PROCESS | 26455 | 05:57:39 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35494/tests/dromaeo/cssquery-yui.html) 05:57:40 INFO - PROCESS | 26455 | RSS: Main: 228941824 05:57:40 INFO - PROCESS | 26455 | 06:00:42 INFO - PROCESS | 26455 | Cycle 1(1): loaded http://localhost:35494/tests/dromaeo/cssquery-yui.html (next: http://localhost:35494/tests/dromaeo/cssquery-dojo.html) 06:00:43 INFO - PROCESS | 26455 | RSS: Main: 299401216 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | __start_tp_report 06:00:43 INFO - PROCESS | 26455 | _x_x_mozilla_page_load 06:00:43 INFO - PROCESS | 26455 | _x_x_mozilla_page_load_details 06:00:43 INFO - PROCESS | 26455 | |i|pagename|runs| 06:00:43 INFO - PROCESS | 26455 | |0;dojo.html;3017.8189308641495;3035.2715348316406;3055.5416687496886;3055.755539556835;3072.339447018892;5201.531862132417;5262.526372626463;5357.705326207062;5413.26920865683;5439.265699130621;5332.680039197651;5354.732263386825;5360.785568577252;5368.812091576796;5393.73031348432;4789.161896668078;4838.177509823321;4865.19724245499;4872.975635121819;5007.674501157431;4916.139675556781;4920.8277710280145;4927.827526036589;4981.252812078199;4990.775415106311;4733.502982186872;4785.545373189541;4807.711537307773;4849.369581954324;4855.295982082614;4835.806567737286;4860.392450943632;4881.585065269456;4910.508949105097;4955.132851750929;4872.196087645534;4890.021995600894;4893.804247830082;4894.192458244385;4899.975500122512;5251.369835619712;5309.097453432887;5358.2498450217;5428.212909128154;5445.156000819879;5794.304683438015;5799.855003624901;5814.912776308359;5819.9418005819825;5825.126231065332;5647.29408823897;5802.477777000048;5845.415458454163;5864.413558644102;5864.44287792659;5296.9735151324385;5322.361316641989;5336.066188417011;5403.108487099663;5408.161734931053;5900.734466948998;5906.084556893688;5906.911396329058;5907.291125064934;5915.674637894871;5481.890362192814;5577.386487486373;5682.176084467812;5707.600467967202;5719.2279042328755;5708.514776243983;5744.109663002241;5792.9710351447975;5794.188813566104;5802.071668533014;5676.318841739017;5731;5735.655860648374;5738.053221218535;5790.449907258803;5521.806736764274;5667.971660141673;5709.200711900255;5742.253507044057;5743.62666426681;4401.273789824643;4411.84558540456;4412.580804823537;4444.2444784386735;4451;3923;3943.8619648312747;3946.940795888064;3971.0667993021616;3971.6624086952356;5326.280952071421;5388.757505912244;5389.407165211824;5393.946060539422;5457.781688732406;5674.687892165888;5689.573282003867;5700.714964251771;5701.686407247558;5744.511716504144;5414.214938833926;5425.240466334716;5425.972870135624;5426.077566813651;5431.918521222185;4829.637777166727;4937.382827146606;4966.478519755446;4967.726775027336;5002.424721157041;5997.220361352996;6009.549283803733;6011.12838638395;6014.428629280212;6015.488683461867;5765.4811067004175;5778.884422311614;5780.190773291659;5781.335146458211;5781.479666830005;5753.309602847685;5832.9708351457975;5854.092615644582;5893.852653683693;5990.9700451497465;5565.526930210815;5607.915881261866;5627.380988091225;5629.971850140723;5630.352509461464;5703;5721.8569535761935;5723.713814309352;5726.828195154152;5731.7420716067045;5450.155225939986;5550.250716153268;5610.242617246783;5615.045442274742;5649.37856835756;5599.60802743804;5611.270534830446;5617;5618;5624.859378515406;5383.057964856056;5570.136628822539;5573.5819813513335;5575.275214222125;5577.6653400796085;5588.524975376976;5648.887022259614;5656.208130861765;5657.179708942263;5706.058500347396;5554.361248456317;5557.499825015768;5561.499465048165;5562.7774889005605;5569 06:00:43 INFO - PROCESS | 26455 | |1;ext.html;627.3506920337451;627.5826575327408;630.4042679667716;644.5037321262631;650.1677852348992;42799.57200427995;44167.999999999956;44181.77909110454;48449.273260901115;48455.51544484554;44856.775716121454;45493.31760023594;45534.77232613841;45563.54436455634;45605.7719711401;8953.552322383903;9144.268458523335;9173;9183.448993060438;9187.540622968858;9005.954970225139;9125.634974601007;9128.178463938244;9128.589213485377;9159.175674189322;9162.17540421362;9210.861837072416;9217.815643687121;9220.170184683377;9222.170004699576;9032.819343613091;9038.18656320931;9047.004829468786;9090.090990900922;9090.13643703847;9027.232685221765;9118.452892826384;9118.726438206864;9127.497987610679;9128.58921348541;43254.134917301795;43445;43660.12679746419;43714.78142609298;43736.343954840704;3530.682238598513;3553.822308884571;3603.40543810271;3818.369968955119;3825.464434979105;33126.6687333126;33659.6634033659;33734.493982590284;33843.15392115192;34945.30109397823;4442.2892337225885;4489.775511224426;4526.0495295987885;4709.058188362307;4710.505396933307;339144;339236;339983;340180;341207;61009.08486372708;61357;61669.38330616726;61723;61801;63151.36848631547;64071.67964160242;64100;64228.357716423176;64273.357266426734;17466.12669366552;17756.3785267515;17796.199171037075;17809.109544522722;17821.643567128584;13649.454021839214;13840.584782456543;13886.583402497941;13887.44450222;13893.79159312611;16800.13399546386;18740;18881;18963.81036189648;19085.80914190868;5526.889462210814;6160.907586386208;6488.221413430419;6498.057781621638;6531.412172904462;1024.6208902706046;1028.3058935218698;1039.0544604409952;1043.7129789308;1062.224516538943;33444.49833252503;33667.663323366454;33760;33954.66045339515;33974.49038264428;1141.1498433666804;1141.395060617874;1142.360278244186;1149.8907603777627;1184.8281999110081;17275.481735547954;17584.648307034044;17625.206865691074;17788.91105544464;17809.821901780815;489211;491089;493919;494386;497789;58725.412745871996;58900.7054964731;58942;58943.41056589465;59112;1209.4436559182698;1348.8313960754906;1363.590922723199;1370.5408688089403;1385.099685204625;31993;34723.30553388868;34995;35138.29723405466;35189.82405087958;51717.48282517127;51992;52254.21618675799;52417.7379113102;52444;311031;311322;311364.9885755192;311715;312733;37059.62940370562;42480.1503969925;43832.561674384124;43853;46748.532514674414;49204.75397622989;49358.25962610635;49687.50312496829;50069.49930500648;50562.49437505725;41826.58173418227;42162.57837421587;42506;43387.78306108449;43631.909202270195;42185.789071054445;42540.57459425366;42749;42867.785661071495;43561.782191088845;41150.1194916353;41275.793621031706;42625.36061959011;42810.35784463298;42837.785811070746;35067.29865402729;37297.440538391405;37479.25041499209;38039.42940855834;38057;27684.861575692797;27831.44337113206;28125.859370703834;28285.292867678472;28395.574066388606 06:00:43 INFO - PROCESS | 26455 | |2;jquery.html;386.2988675553871;391.5360298046813;395.29045363572385;406.3254996705469;415.35619789326535;13171.970241484554;18951.71572426413;20163.09266083026;20643.896780516076;20646.89676551617;14761.335739891703;17316.393926212586;18525.722114168297;18922;19292.3247686331;5665.3768085510565;5828.41715828418;5839.591228613998;5874.88250234995;5875.88248235035;5738.254026976487;5759.625624334426;5783.219265399181;5804.071348584227;5807.419258074201;4161.667066634677;6127.325994140641;6411;6417.550771445977;6527.053577231299;6289.056641503766;6474.223093228819;6488.188976377976;6506.674666266667;6532.248791389004;5701.942980570224;5711.485966263056;5732.5987180897355;5736.082226843727;5738.540916726652;23003.42491437711;23087;23298.53402931949;23680.1711940083;23940;2197.04428573571;2513.773760361576;2559.910403135881;2590.598457239112;2600.726923673006;10272.640457584024;10675.145988320915;10746.892531074667;14331;14990.475333363389;1894.1571000904603;1905.9904700476548;1908.9331873384504;1937.0024437414743;1949.4249196487071;74887.62556187238;74921.62539187324;76940.23059769387;79990;84884.57557712172;9351.953240233755;9648.951755241178;9960.950195248977;9964.153046990941;10258.58965641366;13189.670258243621;13233.139845909986;13271.601851944457;13284.601461956157;13297.66755831112;7895.210478952059;8190.467619604707;8226.42415030954;8247.587620618946;8304.418690691715;8422.705205317785;8486.0665326814;8554.230119289294;8609;8671.913280867237;4141.627253547195;4191.706580539333;4363.825446982149;4483.574060464251;4695.506971767915;1945.863789534719;1946.4939115829986;1984.7122167285952;2009.1159889648509;2019.2831544801677;927.4018258223408;977.398899676708;982.1798798003604;1046.5029111172132;1075.9623413180502;19487.22051117968;19787.20851165966;21206.15175392998;21256.574868502543;21374.893125534272;967.434051080126;996.5216695985822;1041.13065590233;1064.797688439194;1146.2434793036723;10773.138148948065;11260.324380537195;11395.829062564067;11402.600908968147;11416.830802147731;501021;504223.87328380207;511471;512985;518202;93687;95477;97241;98379;99331.50334248283;1017.4200705597739;1058.4020028683924;1066.9466526673634;1071.255477443185;1073.5974009746344;16779.412720554723;17907.194176261837;18085.457436276934;18091.81908180954;18220.36228731988;35715.678480898656;43671;44867.55132448764;45329.320060198464;46899.296510551685;57067.71466142643;57869.4213057864;59884.401155989624;66942.6652866752;67349.66325168342;7359.558426494427;7607.809804754704;8089.312408445113;8279.172082791672;8931.419457735226;11040.33757974524;14276.928615356857;14417.92791036038;14503.564893053226;14721.263936802903;12093.69765755828;12513.624591262276;12595.992320614145;12658.303793291458;12795.424205910942;11747.647570572897;12287.262764234174;12441.253524788543;12539.435725392561;12612;11718.355490447766;12939.611811645666;12945.54690585825;12975.675608109495;13072.084954053505;8970.775730606787;8983.191512763882;9007.414518056305;9017.323700722603;9329.973702892812;9223.815523689624;12351.135420520477;12400.503979840705;12677.239365638092;13046 06:00:43 INFO - PROCESS | 26455 | |3;mootools.html;1363.4409891944292;1483.584596313032;1520.6730552931122;1676.7401052836808;1815.1831675745918;8177.87733184002;8396.790080247996;8417.873731894026;8760;8788.2969362451;8519.446235994656;8716.128387161281;8721.127887211276;8724.47653140812;8727.0836562161;1986.701994700792;2128.1487405038033;2212.889355532225;2243.4727838957874;2263.592553340398;2259.604569200392;2270.648049552322;2272.6591011348346;2273.783990520898;2275.8179345652393;2241.574100920828;2268.319504148757;2272.2047283450825;2279.680844681746;2288.8969996350206;1947.4449781812186;2091.3203208957148;2126.670366093258;2176.793204645556;2186.4533866533366;2229.308914236592;2255.2783109404995;2272.4432514034;2273.795358417734;2278.214016164437;8739.388242823004;8763.386562940597;8795.032546419889;8797.6041078151;8801.955990220073;5003.774830132653;5133.717645529495;5242.8689282767855;5289.285946397225;5297.47025297471;3405.3529829332597;3410.7782994105305;3446.207372304359;3464.9826750866087;3486.041338631871;1254.6725823597187;1259.4080782032431;1274.8597654258024;1285.967850803728;1286.0097724751981;12240.693982650417;12240.877591224064;12241.69395765113;12247.326397048158;12259.264444133381;4408.603225709638;4501;4639.953600463952;4662.393888794435;4668.089722504079;10153.746156346151;10282.434466104436;10287.794244115226;10307.793844123076;10308.278420510642;5291.285676433709;5294.894102117936;5303.708296043755;5304.257403963448;5307.150855863043;4336.501302350207;4758.2386818108935;4864.537868902448;4877.853664390074;4947.6536642434685;3898.317794385971;3943.8619648312747;3981.442598036277;4033.4554835097474;4037.959620403817;1178.8762179971152;1219.268438936631;1251.1492185313891;1291.1671971578467;1291.4446787881113;925.6713866577403;967.5065716484644;1001.3491230700104;1005.7334806276342;1008.8032833597379;5833.970830145822;5874.530037596982;5981.312149102909;6034.728437220336;6049.758009679652;971.1017308989157;975.6048800235916;987.5852142100335;996.9202463802878;997.2869398380193;4303.33298338758;4515.322701594787;4582.908341833145;4620.491745907947;4621.653375996813;11039.116870650489;11069.225154239126;11129.888701112885;11247.268927519848;11272.943635281936;10210.693679189637;10684.252102352915;11050.392228427352;11053.17101217412;11073.280236784583;8225.424220304641;8307.210814972688;8389.580520973926;8403;8405.95797021011;6163.414475624809;6571.57284776488;6573.57271777333;6625.105610742488;6792.796216113525;9986.700398988041;10314.638987635397;10377.481125943823;10408.47957602132;10422.947885260524;10421.635242766466;10431.582736690447;10544.472776361305;10555.155587552823;10561.89438105609;7701.268379503938;7709.190534993745;7850.882236766339;7865.842683146419;7885.723999659985;8425.031121421114;8463.111373305714;8515.276201522693;8536.786580335542;8545.700900468453;7651.655675494505;7884.21157884207;7960.601969901598;7962.960185199268;8109.59452027408;7673.079230492377;7686.385089192963;7811.921880781347;7849;8119.350451963947;6929.237783843672;6939.306069393222;6980.685869136003;6982.6508674567085;6991;5203;5273.815416460406;5393.919091213556;5416.322959630046;5437.184422336682;5167.870803229949;5206.479352064764;5347.866303342447;5384.300040994645;5411.998780225671 06:00:43 INFO - PROCESS | 26455 | |4;prototype.html;322.7805092537074;326.7647293948357;332.1612927358421;334.22293168383504;338.038281090298;5288.9471105288985;5300.602454815885;5333.786648534059;5361.008213480504;5380.381256155543;4994.30079788829;5097.515736005073;5156.097682905486;5165.564899341943;5267.789288428467;4009.138035322405;4028.113814960704;4112.2803509385885;4116.711830171889;4162.604552567516;4115.876523704279;4137.151883863816;4148.191102734968;4149.232392007473;4159.646430053449;4051.858184963512;4066.552679205285;4069.572694867041;4111.280525907969;4154.563770804068;4082.6121518455698;4111.424400583921;4117.07365842686;4122.546519882811;4125.814338354781;3647.7993710345922;3656.3784156693428;3670.7797532148156;3675.3751862183494;3696.537932758405;5028.296038554606;5122.380148161423;5165.147750621143;5196.584273258168;5217.191335343028;4721.740304283263;4723.4568024677255;4726.432828060655;4729.462924549535;4745.881352966204;5462;5525.154545409117;5539.584531160139;5555.138953462219;5566.192902029224;3751.718621103401;4024.0744628735556;4036;4059.939100913489;4066.430699702044;5663.008973429633;5676.650776042155;5679.2739485047;5700.551166544223;5714.114312281603;4053.310937140693;4067.9389809152885;4070.4504891839224;4071.206114807584;4072.2873497138476;4126.773027483458;4133.793310334471;4134.090500089976;4138.151678905877;4140.751554906716;4471.7987690554;4677.789499472532;4680.789364478606;4714.269288260325;4741.5495527924795;5485.476680726831;5500.387316024856;5518.310211223597;5525.143602741581;5604.187392828098;1333.5265980576755;1361.857005014479;1399.2933568548021;1399.8040274361597;1410.1045835894076;932.9720108396759;948.8149810786969;957.1816097236901;964.9710508684751;972.3242346569208;5362.410134885159;5376.892462150735;5390.407055223922;5390.5742415913;5392.436193503919;5619.325680918316;5625.268715067097;5644.181593668895;5647.124695672177;5665.235193248941;5239.371275446971;5356.1697936819855;5364.22218778275;5393.1370980642905;5513.145462453326;3001.6247969003875;3031.9242018949703;3034.742046925992;3041.9239519012203;3048.1465189746905;5911.674857882772;5922.585419020714;5927.436893495111;5933.614315069507;5937.940620593825;5621.437856214346;5821.27234095738;5821.679807610537;5861.32594751609;5870.765169393177;5886.470217680429;5899.469047785634;5923.911141332884;5958.646334697857;6013.939860601513;5593.468620481211;5660.924424359358;5745.827625171251;5784.305883294031;5806.738696758741;5677.943220567741;5679.835633695166;5690.971545142248;5692.373838877637;5697.515711164598;5948.2862056553495;5952.404759524013;5972.044472884318;6004.339522652592;6023.186869772525;3912.491376121086;4003.8798836034966;4054.702495201507;4060.269151552749;4060.289449346412;5510.724463776875;5657.3776884543495;5676.914846277392;5698.800541981011;5706;5444.945550544444;5537.612367134423;5538.196961440488;5560.582956278215;5622.409646987171;5532.391436941853;5558.60979778699;5562.582806289463;5567.524605979338;5572.804951826666;5297.54970827484;5477.890442191214;5478.616496845182;5503.834884953458;5504.256925315031;5530.640508366943;5571.9442805571425;5591.888162236651;5595.356533998643;5620.4098569649595;5491.395946445808;5513.062779327604;5513.972430137824;5523.972380138073;5566.666000040011 06:00:43 INFO - PROCESS | 26455 | |5;yui.html;764.8699721047421;799.0970203669859;826.5536610230475;851.9659213631451;866.7009881590851;15495;16037.759433608506;16688.082155481443;16979.3208271669;17019.40432084877;15112.622184445394;15305.311260993254;15330;15337.769933451007;15354.46259380922;676.4182802789597;810.785141937387;832.9250367466926;837.417994493827;837.7779888329597;805.2993895311088;825.983480330396;830.8504469195542;835.6866175184306;837.401258100458;861.1001503428901;864.8616221404576;866.1252135343317;866.1338661338661;866.2809867809702;694.4652617484509;841.7769291137853;863.5811631358818;863.6329559937002;865.1996902864856;633.3349982518383;635.2218532297898;636.2555809702659;636.7039326713054;636.8853606350855;16120.919395403065;16239;16255.431059912846;16260.593485162966;16264.349426022945;14465.349059292357;14853.554393368217;14902.552923412315;14956.925215373962;15013.324400402009;13319.866801332057;13372.197668139943;13402.329883505883;13411.262380569065;13533.255670938193;4446.7998940047455;4469.396631454744;4484.8878778030485;4502.752348620825;4586.151561961048;65997.67001165012;77445.61277193634;77618.22381776167;77867.61066194632;78816.21183788146;11564.884351156381;11864.466099025565;12007.819882701591;12137.211081279866;12161.756764864653;21249.57500849974;21341.78658213429;21471.8926405367;21476.463088422915;22189.556208876056;7961.681532738626;8237.79405514867;8352.916470835335;8546.572671366532;9099.81800363989;4894.632902532324;4896.755162241873;4939.160342741742;4980.160900565855;5033.823816166417;3302.1909632140278;3426.109211605001;3426.9485957710654;3428.211511352353;3434.227298857787;596.3708287756372;596.6300893446091;599.5054080383613;606.0364021206215;614.1862032806549;679.751890559942;696.5611664651237;704.6793708862456;716.0583832260664;734.4271468254769;9301.813963720688;9489.715308540755;9708.448436909885;9820.950895245478;9843.655472058443;632.9239696355547;674.2515807453723;694.7707256605308;700.7477308169055;715.7208688611446;4583.793729282191;4714.834980775657;4740.5733483986605;4834.685745426536;4838.782254798542;96809.0319096814;104968;111974;112562;112674;60636;85445;97244;97464.51267743616;97475;85699.57150214334;86233.5688321567;86379;86638.56680716682;87063.56468217618;8886.86669699968;9213.447193168431;9223.907760922304;9427.670031548863;9457.43255404678;51801;52787.47212527979;53043.734781325846;53258;54998;71426;75873.24126758662;76311;76865;77448;11563.537458501902;11576.652700419001;11712;11855;12099.879001210227;12392.690182745142;12662;12796.808047879103;12810.972568578554;13097.934510327388;12064.577739779066;12308.507659693512;12308.876911231131;12590.559330423392;12745.235285882876;11810.350430726392;11975.64073077809;12022.27866328023;12211.938940305241;12566.748665026831;11641.301521908374;11672.941635291769;11704.122190835891;12009.516636656812;12073.335966521925;10137.543810528396;10535.947320263349;10588;10808;10812;9933.453660048766;10038.397696137963;10337.948310258702;10503.894961050291;10574.101201397967 06:00:43 INFO - PROCESS | 26455 | __end_tp_report 06:00:43 INFO - PROCESS | 26455 | __start_cc_report 06:00:43 INFO - PROCESS | 26455 | _x_x_mozilla_cycle_collect,762 06:00:43 INFO - PROCESS | 26455 | __end_cc_report 06:00:43 INFO - PROCESS | 26455 | __startTimestamp1468414843015__endTimestamp 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | ------- Summary: start ------- 06:00:43 INFO - PROCESS | 26455 | Number of tests: 6 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#0] dojo.html Cycles:165 Average:5332.03 Median:5561.50 stddev:610.10 (11.0%) stddev-sans-first:584.34 06:00:43 INFO - PROCESS | 26455 | Values: 3017.8 3035.3 3055.5 3055.8 3072.3 5201.5 5262.5 5357.7 5413.3 5439.3 5332.7 5354.7 5360.8 5368.8 5393.7 4789.2 4838.2 4865.2 4873.0 5007.7 4916.1 4920.8 4927.8 4981.3 4990.8 4733.5 4785.5 4807.7 4849.4 4855.3 4835.8 4860.4 4881.6 4910.5 4955.1 4872.2 4890.0 4893.8 4894.2 4900.0 5251.4 5309.1 5358.2 5428.2 5445.2 5794.3 5799.9 5814.9 5819.9 5825.1 5647.3 5802.5 5845.4 5864.4 5864.4 5297.0 5322.4 5336.1 5403.1 5408.2 5900.7 5906.1 5906.9 5907.3 5915.7 5481.9 5577.4 5682.2 5707.6 5719.2 5708.5 5744.1 5793.0 5794.2 5802.1 5676.3 5731.0 5735.7 5738.1 5790.4 5521.8 5668.0 5709.2 5742.3 5743.6 4401.3 4411.8 4412.6 4444.2 4451.0 3923.0 3943.9 3946.9 3971.1 3971.7 5326.3 5388.8 5389.4 5393.9 5457.8 5674.7 5689.6 5700.7 5701.7 5744.5 5414.2 5425.2 5426.0 5426.1 5431.9 4829.6 4937.4 4966.5 4967.7 5002.4 5997.2 6009.5 6011.1 6014.4 6015.5 5765.5 5778.9 5780.2 5781.3 5781.5 5753.3 5833.0 5854.1 5893.9 5991.0 5565.5 5607.9 5627.4 5630.0 5630.4 5703.0 5721.9 5723.7 5726.8 5731.7 5450.2 5550.3 5610.2 5615.0 5649.4 5599.6 5611.3 5617.0 5618.0 5624.9 5383.1 5570.1 5573.6 5575.3 5577.7 5588.5 5648.9 5656.2 5657.2 5706.1 5554.4 5557.5 5561.5 5562.8 5569.0 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#1] ext.html Cycles:180 Average:56539.36 Median:43320.96 stddev:102768.35 (237.2%) stddev-sans-first:102970.90 06:00:43 INFO - PROCESS | 26455 | Values: 627.4 627.6 630.4 644.5 650.2 42799.6 44168.0 44181.8 48449.3 48455.5 44856.8 45493.3 45534.8 45563.5 45605.8 8953.6 9144.3 9173.0 9183.4 9187.5 9006.0 9125.6 9128.2 9128.6 9159.2 9162.2 9210.9 9217.8 9220.2 9222.2 9032.8 9038.2 9047.0 9090.1 9090.1 9027.2 9118.5 9118.7 9127.5 9128.6 43254.1 43445.0 43660.1 43714.8 43736.3 3530.7 3553.8 3603.4 3818.4 3825.5 33126.7 33659.7 33734.5 33843.2 34945.3 4442.3 4489.8 4526.0 4709.1 4710.5 339144.0 339236.0 339983.0 340180.0 341207.0 61009.1 61357.0 61669.4 61723.0 61801.0 63151.4 64071.7 64100.0 64228.4 64273.4 17466.1 17756.4 17796.2 17809.1 17821.6 13649.5 13840.6 13886.6 13887.4 13893.8 16800.1 18740.0 18881.0 18963.8 19085.8 5526.9 6160.9 6488.2 6498.1 6531.4 1024.6 1028.3 1039.1 1043.7 1062.2 33444.5 33667.7 33760.0 33954.7 33974.5 1141.1 1141.4 1142.4 1149.9 1184.8 17275.5 17584.6 17625.2 17788.9 17809.8 489211.0 491089.0 493919.0 494386.0 497789.0 58725.4 58900.7 58942.0 58943.4 59112.0 1209.4 1348.8 1363.6 1370.5 1385.1 31993.0 34723.3 34995.0 35138.3 35189.8 51717.5 51992.0 52254.2 52417.7 52444.0 311031.0 311322.0 311365.0 311715.0 312733.0 37059.6 42480.2 43832.6 43853.0 46748.5 49204.8 49358.3 49687.5 50069.5 50562.5 41826.6 42162.6 42506.0 43387.8 43631.9 42185.8 42540.6 42749.0 42867.8 43561.8 41150.1 41275.8 42625.4 42810.4 42837.8 35067.3 37297.4 37479.3 38039.4 38057.0 27684.9 27831.4 28125.9 28285.3 28395.6 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#2] jquery.html Cycles:180 Average:29884.58 Median:18050.99 stddev:84007.29 (465.4%) stddev-sans-first:84213.75 06:00:43 INFO - PROCESS | 26455 | Values: 386.3 391.5 395.3 406.3 415.4 13172.0 18951.7 20163.1 20643.9 20646.9 14761.3 17316.4 18525.7 18922.0 19292.3 5665.4 5828.4 5839.6 5874.9 5875.9 5738.3 5759.6 5783.2 5804.1 5807.4 4161.7 6127.3 6411.0 6417.6 6527.1 6289.1 6474.2 6488.2 6506.7 6532.2 5701.9 5711.5 5732.6 5736.1 5738.5 23003.4 23087.0 23298.5 23680.2 23940.0 2197.0 2513.8 2559.9 2590.6 2600.7 10272.6 10675.1 10746.9 14331.0 14990.5 1894.2 1906.0 1908.9 1937.0 1949.4 74887.6 74921.6 76940.2 79990.0 84884.6 9352.0 9649.0 9961.0 9964.2 10258.6 13189.7 13233.1 13271.6 13284.6 13297.7 7895.2 8190.5 8226.4 8247.6 8304.4 8422.7 8486.1 8554.2 8609.0 8671.9 4141.6 4191.7 4363.8 4483.6 4695.5 1945.9 1946.5 1984.7 2009.1 2019.3 927.4 977.4 982.2 1046.5 1076.0 19487.2 19787.2 21206.2 21256.6 21374.9 967.4 996.5 1041.1 1064.8 1146.2 10773.1 11260.3 11395.8 11402.6 11416.8 501021.0 504223.9 511471.0 512985.0 518202.0 93687.0 95477.0 97241.0 98379.0 99331.5 1017.4 1058.4 1066.9 1071.3 1073.6 16779.4 17907.2 18085.5 18091.8 18220.4 35715.7 43671.0 44867.6 45329.3 46899.3 57067.7 57869.4 59884.4 66942.7 67349.7 7359.6 7607.8 8089.3 8279.2 8931.4 11040.3 14276.9 14417.9 14503.6 14721.3 12093.7 12513.6 12596.0 12658.3 12795.4 11747.6 12287.3 12441.3 12539.4 12612.0 11718.4 12939.6 12945.5 12975.7 13072.1 8970.8 8983.2 9007.4 9017.3 9330.0 9223.8 12351.1 12400.5 12677.2 13046.0 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#3] mootools.html Cycles:180 Average:5851.82 Median:4651.17 stddev:3320.85 (71.4%) stddev-sans-first:3313.04 06:00:43 INFO - PROCESS | 26455 | Values: 1363.4 1483.6 1520.7 1676.7 1815.2 8177.9 8396.8 8417.9 8760.0 8788.3 8519.4 8716.1 8721.1 8724.5 8727.1 1986.7 2128.1 2212.9 2243.5 2263.6 2259.6 2270.6 2272.7 2273.8 2275.8 2241.6 2268.3 2272.2 2279.7 2288.9 1947.4 2091.3 2126.7 2176.8 2186.5 2229.3 2255.3 2272.4 2273.8 2278.2 8739.4 8763.4 8795.0 8797.6 8802.0 5003.8 5133.7 5242.9 5289.3 5297.5 3405.4 3410.8 3446.2 3465.0 3486.0 1254.7 1259.4 1274.9 1286.0 1286.0 12240.7 12240.9 12241.7 12247.3 12259.3 4408.6 4501.0 4640.0 4662.4 4668.1 10153.7 10282.4 10287.8 10307.8 10308.3 5291.3 5294.9 5303.7 5304.3 5307.2 4336.5 4758.2 4864.5 4877.9 4947.7 3898.3 3943.9 3981.4 4033.5 4038.0 1178.9 1219.3 1251.1 1291.2 1291.4 925.7 967.5 1001.3 1005.7 1008.8 5834.0 5874.5 5981.3 6034.7 6049.8 971.1 975.6 987.6 996.9 997.3 4303.3 4515.3 4582.9 4620.5 4621.7 11039.1 11069.2 11129.9 11247.3 11272.9 10210.7 10684.3 11050.4 11053.2 11073.3 8225.4 8307.2 8389.6 8403.0 8406.0 6163.4 6571.6 6573.6 6625.1 6792.8 9986.7 10314.6 10377.5 10408.5 10422.9 10421.6 10431.6 10544.5 10555.2 10561.9 7701.3 7709.2 7850.9 7865.8 7885.7 8425.0 8463.1 8515.3 8536.8 8545.7 7651.7 7884.2 7960.6 7963.0 8109.6 7673.1 7686.4 7811.9 7849.0 8119.4 6929.2 6939.3 6980.7 6982.7 6991.0 5203.0 5273.8 5393.9 5416.3 5437.2 5167.9 5206.5 5347.9 5384.3 5412.0 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#4] prototype.html Cycles:180 Average:4680.59 Median:5385.39 stddev:1381.77 (25.7%) stddev-sans-first:1346.37 06:00:43 INFO - PROCESS | 26455 | Values: 322.8 326.8 332.2 334.2 338.0 5288.9 5300.6 5333.8 5361.0 5380.4 4994.3 5097.5 5156.1 5165.6 5267.8 4009.1 4028.1 4112.3 4116.7 4162.6 4115.9 4137.2 4148.2 4149.2 4159.6 4051.9 4066.6 4069.6 4111.3 4154.6 4082.6 4111.4 4117.1 4122.5 4125.8 3647.8 3656.4 3670.8 3675.4 3696.5 5028.3 5122.4 5165.1 5196.6 5217.2 4721.7 4723.5 4726.4 4729.5 4745.9 5462.0 5525.2 5539.6 5555.1 5566.2 3751.7 4024.1 4036.0 4059.9 4066.4 5663.0 5676.7 5679.3 5700.6 5714.1 4053.3 4067.9 4070.5 4071.2 4072.3 4126.8 4133.8 4134.1 4138.2 4140.8 4471.8 4677.8 4680.8 4714.3 4741.5 5485.5 5500.4 5518.3 5525.1 5604.2 1333.5 1361.9 1399.3 1399.8 1410.1 933.0 948.8 957.2 965.0 972.3 5362.4 5376.9 5390.4 5390.6 5392.4 5619.3 5625.3 5644.2 5647.1 5665.2 5239.4 5356.2 5364.2 5393.1 5513.1 3001.6 3031.9 3034.7 3041.9 3048.1 5911.7 5922.6 5927.4 5933.6 5937.9 5621.4 5821.3 5821.7 5861.3 5870.8 5886.5 5899.5 5923.9 5958.6 6013.9 5593.5 5660.9 5745.8 5784.3 5806.7 5677.9 5679.8 5691.0 5692.4 5697.5 5948.3 5952.4 5972.0 6004.3 6023.2 3912.5 4003.9 4054.7 4060.3 4060.3 5510.7 5657.4 5676.9 5698.8 5706.0 5444.9 5537.6 5538.2 5560.6 5622.4 5532.4 5558.6 5562.6 5567.5 5572.8 5297.5 5477.9 5478.6 5503.8 5504.3 5530.6 5571.9 5591.9 5595.4 5620.4 5491.4 5513.1 5514.0 5524.0 5566.7 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - PROCESS | 26455 | [#5] yui.html Cycles:180 Average:20256.85 Median:4959.66 stddev:28746.75 (579.6%) stddev-sans-first:28790.13 06:00:43 INFO - PROCESS | 26455 | Values: 764.9 799.1 826.6 852.0 866.7 15495.0 16037.8 16688.1 16979.3 17019.4 15112.6 15305.3 15330.0 15337.8 15354.5 676.4 810.8 832.9 837.4 837.8 805.3 826.0 830.9 835.7 837.4 861.1 864.9 866.1 866.1 866.3 694.5 841.8 863.6 863.6 865.2 633.3 635.2 636.3 636.7 636.9 16120.9 16239.0 16255.4 16260.6 16264.3 14465.3 14853.6 14902.6 14956.9 15013.3 13319.9 13372.2 13402.3 13411.3 13533.3 4446.8 4469.4 4484.9 4502.8 4586.2 65997.7 77445.6 77618.2 77867.6 78816.2 11564.9 11864.5 12007.8 12137.2 12161.8 21249.6 21341.8 21471.9 21476.5 22189.6 7961.7 8237.8 8352.9 8546.6 9099.8 4894.6 4896.8 4939.2 4980.2 5033.8 3302.2 3426.1 3426.9 3428.2 3434.2 596.4 596.6 599.5 606.0 614.2 679.8 696.6 704.7 716.1 734.4 9301.8 9489.7 9708.4 9821.0 9843.7 632.9 674.3 694.8 700.7 715.7 4583.8 4714.8 4740.6 4834.7 4838.8 96809.0 104968.0 111974.0 112562.0 112674.0 60636.0 85445.0 97244.0 97464.5 97475.0 85699.6 86233.6 86379.0 86638.6 87063.6 8886.9 9213.4 9223.9 9427.7 9457.4 51801.0 52787.5 53043.7 53258.0 54998.0 71426.0 75873.2 76311.0 76865.0 77448.0 11563.5 11576.7 11712.0 11855.0 12099.9 12392.7 12662.0 12796.8 12811.0 13097.9 12064.6 12308.5 12308.9 12590.6 12745.2 11810.4 11975.6 12022.3 12211.9 12566.7 11641.3 11672.9 11704.1 12009.5 12073.3 10137.5 10535.9 10588.0 10808.0 10812.0 9933.5 10038.4 10337.9 10503.9 10574.1 06:00:43 INFO - PROCESS | 26455 | -------- Summary: end -------- 06:00:43 INFO - PROCESS | 26455 | 06:00:43 INFO - TEST-INFO | 26455: exit 0 06:00:43 INFO - TEST-OK | dromaeo_css | took 1112933ms 06:00:43 INFO - TEST-START | kraken 06:00:43 INFO - operating with platform_type : linux_ 06:00:43 INFO - Initialising browser for kraken test... 06:00:43 INFO - TEST-INFO | started process 26642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi__Fmu/profile http://localhost:35494/getInfo.html) 06:00:47 INFO - PROCESS | 26642 | __metrics Screen width/height:1600/1200 06:00:47 INFO - PROCESS | 26642 | colorDepth:24 06:00:47 INFO - PROCESS | 26642 | Browser inner width/height: 1024/697 06:00:47 INFO - PROCESS | 26642 | __metrics 06:00:48 INFO - PROCESS | 26642 | 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" 06:00:48 INFO - PROCESS | 26642 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:49 INFO - TEST-INFO | 26642: exit 0 06:00:49 INFO - Browser initialized. 06:00:49 INFO - Running cycle 1/1 for kraken test... 06:00:49 INFO - TEST-INFO | started process 26727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi__Fmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:00 INFO - PROCESS | 26727 | RSS: Main: 157519872 06:01:00 INFO - PROCESS | 26727 | 06:01:03 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35494/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:04 INFO - PROCESS | 26727 | RSS: Main: 215187456 06:01:04 INFO - PROCESS | 26727 | 06:01:06 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35494/tests/kraken/driver.html?testName=audio-dft) 06:01:07 INFO - PROCESS | 26727 | RSS: Main: 203427840 06:01:07 INFO - PROCESS | 26727 | 06:01:10 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35494/tests/kraken/driver.html?testName=audio-fft) 06:01:10 INFO - PROCESS | 26727 | RSS: Main: 269365248 06:01:10 INFO - PROCESS | 26727 | 06:01:12 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35494/tests/kraken/driver.html?testName=audio-oscillator) 06:01:13 INFO - PROCESS | 26727 | RSS: Main: 180518912 06:01:13 INFO - PROCESS | 26727 | 06:01:15 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:16 INFO - PROCESS | 26727 | RSS: Main: 184422400 06:01:16 INFO - PROCESS | 26727 | 06:01:19 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35494/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:19 INFO - PROCESS | 26727 | RSS: Main: 220573696 06:01:19 INFO - PROCESS | 26727 | 06:01:23 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35494/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:23 INFO - PROCESS | 26727 | RSS: Main: 220979200 06:01:23 INFO - PROCESS | 26727 | 06:01:26 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35494/tests/kraken/driver.html?testName=json-parse-financial) 06:01:27 INFO - PROCESS | 26727 | RSS: Main: 221335552 06:01:27 INFO - PROCESS | 26727 | 06:01:28 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:29 INFO - PROCESS | 26727 | RSS: Main: 209391616 06:01:29 INFO - PROCESS | 26727 | 06:01:31 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:31 INFO - PROCESS | 26727 | RSS: Main: 213315584 06:01:31 INFO - PROCESS | 26727 | 06:01:33 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:34 INFO - PROCESS | 26727 | RSS: Main: 211046400 06:01:34 INFO - PROCESS | 26727 | 06:01:37 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:37 INFO - PROCESS | 26727 | RSS: Main: 225611776 06:01:37 INFO - PROCESS | 26727 | 06:01:40 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:40 INFO - PROCESS | 26727 | RSS: Main: 226078720 06:01:40 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | Cycle 1(1): loaded http://localhost:35494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35494/tests/kraken/driver.html?testName=ai-astar) 06:01:42 INFO - PROCESS | 26727 | RSS: Main: 267911168 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | __start_tp_report 06:01:42 INFO - PROCESS | 26727 | _x_x_mozilla_page_load 06:01:42 INFO - PROCESS | 26727 | _x_x_mozilla_page_load_details 06:01:42 INFO - PROCESS | 26727 | |i|pagename|runs| 06:01:42 INFO - PROCESS | 26727 | |0;ai-astar;100;110;112;113;111;109;110;111;111;110 06:01:42 INFO - PROCESS | 26727 | |1;audio-beat-detection;155;118;122;176;122;119;143;120;147;118 06:01:42 INFO - PROCESS | 26727 | |2;audio-dft;160;162;160;160;159;159;161;162;161;162 06:01:42 INFO - PROCESS | 26727 | |3;audio-fft;74;77;76;120;75;76;76;75;103;76 06:01:42 INFO - PROCESS | 26727 | |4;audio-oscillator;85;83;113;83;84;84;113;84;84;119 06:01:42 INFO - PROCESS | 26727 | |5;imaging-gaussian-blur;117;117;117;117;116;118;116;117;116;117 06:01:42 INFO - PROCESS | 26727 | |6;imaging-darkroom;145;146;146;145;145;145;145;146;145;146 06:01:42 INFO - PROCESS | 26727 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 06:01:42 INFO - PROCESS | 26727 | |8;json-parse-financial;54;54;54;54;53;54;54;56;53;54 06:01:42 INFO - PROCESS | 26727 | |9;json-stringify-tinderbox;60;61;61;60;61;62;61;61;61;61 06:01:42 INFO - PROCESS | 26727 | |10;stanford-crypto-aes;74;78;75;75;83;75;77;75;74;81 06:01:42 INFO - PROCESS | 26727 | |11;stanford-crypto-ccm;119;118;124;125;129;127;138;128;162;130 06:01:42 INFO - PROCESS | 26727 | |12;stanford-crypto-pbkdf2;158;158;159;160;165;159;156;157;159;158 06:01:42 INFO - PROCESS | 26727 | |13;stanford-crypto-sha256-iterative;64;62;63;63;66;63;62;62;63;60 06:01:42 INFO - PROCESS | 26727 | __end_tp_report 06:01:42 INFO - PROCESS | 26727 | __start_cc_report 06:01:42 INFO - PROCESS | 26727 | _x_x_mozilla_cycle_collect,1639 06:01:42 INFO - PROCESS | 26727 | __end_cc_report 06:01:42 INFO - PROCESS | 26727 | __startTimestamp1468414902819__endTimestamp 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | ------- Summary: start ------- 06:01:42 INFO - PROCESS | 26727 | Number of tests: 14 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.59 (3.2%) stddev-sans-first:1.20 06:01:42 INFO - PROCESS | 26727 | Values: 100.0 110.0 112.0 113.0 111.0 109.0 110.0 111.0 111.0 110.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:132.50 stddev:20.21 (15.3%) stddev-sans-first:19.96 06:01:42 INFO - PROCESS | 26727 | Values: 155.0 118.0 122.0 176.0 122.0 119.0 143.0 120.0 147.0 118.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 06:01:42 INFO - PROCESS | 26727 | Values: 160.0 162.0 160.0 160.0 159.0 159.0 161.0 162.0 161.0 162.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:15.67 (20.6%) stddev-sans-first:16.29 06:01:42 INFO - PROCESS | 26727 | Values: 74.0 77.0 76.0 120.0 75.0 76.0 76.0 75.0 103.0 76.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:15.14 (18.0%) stddev-sans-first:15.77 06:01:42 INFO - PROCESS | 26727 | Values: 85.0 83.0 113.0 83.0 84.0 84.0 113.0 84.0 84.0 119.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:01:42 INFO - PROCESS | 26727 | Values: 117.0 117.0 117.0 117.0 116.0 118.0 116.0 117.0 116.0 117.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:01:42 INFO - PROCESS | 26727 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:01:42 INFO - PROCESS | 26727 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 06:01:42 INFO - PROCESS | 26727 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 54.0 56.0 53.0 54.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:01:42 INFO - PROCESS | 26727 | Values: 60.0 61.0 61.0 60.0 61.0 62.0 61.0 61.0 61.0 61.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:3.09 (4.1%) stddev-sans-first:3.12 06:01:42 INFO - PROCESS | 26727 | Values: 74.0 78.0 75.0 75.0 83.0 75.0 77.0 75.0 74.0 81.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:128.50 stddev:12.60 (9.8%) stddev-sans-first:12.72 06:01:42 INFO - PROCESS | 26727 | Values: 119.0 118.0 124.0 125.0 129.0 127.0 138.0 128.0 162.0 130.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.42 (1.5%) stddev-sans-first:2.55 06:01:42 INFO - PROCESS | 26727 | Values: 158.0 158.0 159.0 160.0 165.0 159.0 156.0 157.0 159.0 158.0 06:01:42 INFO - PROCESS | 26727 | 06:01:42 INFO - PROCESS | 26727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.55 (2.5%) stddev-sans-first:1.58 06:01:42 INFO - PROCESS | 26727 | Values: 64.0 62.0 63.0 63.0 66.0 63.0 62.0 62.0 63.0 60.0 06:01:42 INFO - PROCESS | 26727 | -------- Summary: end -------- 06:01:42 INFO - PROCESS | 26727 | 06:01:43 INFO - TEST-INFO | 26727: exit 0 06:01:43 INFO - TEST-OK | kraken | took 60010ms 06:01:43 INFO - SUITE-END | took 1172s 06:01:43 INFO - Completed test suite (00:19:33) 06:01:43 INFO - javascript benchmark 06:01:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.8189308641495, 3035.2715348316406, 3055.5416687496886, 3055.755539556835, 3072.339447018892, 5201.531862132417, 5262.526372626463, 5357.705326207062, 5413.26920865683, 5439.265699130621, 5332.680039197651, 5354.732263386825, 5360.785568577252, 5368.812091576796, 5393.73031348432, 4789.161896668078, 4838.177509823321, 4865.19724245499, 4872.975635121819, 5007.674501157431, 4916.139675556781, 4920.8277710280145, 4927.827526036589, 4981.252812078199, 4990.775415106311, 4733.502982186872, 4785.545373189541, 4807.711537307773, 4849.369581954324, 4855.295982082614, 4835.806567737286, 4860.392450943632, 4881.585065269456, 4910.508949105097, 4955.132851750929, 4872.196087645534, 4890.021995600894, 4893.804247830082, 4894.192458244385, 4899.975500122512, 5251.369835619712, 5309.097453432887, 5358.2498450217, 5428.212909128154, 5445.156000819879, 5794.304683438015, 5799.855003624901, 5814.912776308359, 5819.9418005819825, 5825.126231065332, 5647.29408823897, 5802.477777000048, 5845.415458454163, 5864.413558644102, 5864.44287792659, 5296.9735151324385, 5322.361316641989, 5336.066188417011, 5403.108487099663, 5408.161734931053, 5900.734466948998, 5906.084556893688, 5906.911396329058, 5907.291125064934, 5915.674637894871, 5481.890362192814, 5577.386487486373, 5682.176084467812, 5707.600467967202, 5719.2279042328755, 5708.514776243983, 5744.109663002241, 5792.9710351447975, 5794.188813566104, 5802.071668533014, 5676.318841739017, 5731.0, 5735.655860648374, 5738.053221218535, 5790.449907258803, 5521.806736764274, 5667.971660141673, 5709.200711900255, 5742.253507044057, 5743.62666426681, 4401.273789824643, 4411.84558540456, 4412.580804823537, 4444.2444784386735, 4451.0, 3923.0, 3943.8619648312747, 3946.940795888064, 3971.0667993021616, 3971.6624086952356, 5326.280952071421, 5388.757505912244, 5389.407165211824, 5393.946060539422, 5457.781688732406, 5674.687892165888, 5689.573282003867, 5700.714964251771, 5701.686407247558, 5744.511716504144, 5414.214938833926, 5425.240466334716, 5425.972870135624, 5426.077566813651, 5431.918521222185, 4829.637777166727, 4937.382827146606, 4966.478519755446, 4967.726775027336, 5002.424721157041, 5997.220361352996, 6009.549283803733, 6011.12838638395, 6014.428629280212, 6015.488683461867, 5765.4811067004175, 5778.884422311614, 5780.190773291659, 5781.335146458211, 5781.479666830005, 5753.309602847685, 5832.9708351457975, 5854.092615644582, 5893.852653683693, 5990.9700451497465, 5565.526930210815, 5607.915881261866, 5627.380988091225, 5629.971850140723, 5630.352509461464, 5703.0, 5721.8569535761935, 5723.713814309352, 5726.828195154152, 5731.7420716067045, 5450.155225939986, 5550.250716153268, 5610.242617246783, 5615.045442274742, 5649.37856835756, 5599.60802743804, 5611.270534830446, 5617.0, 5618.0, 5624.859378515406, 5383.057964856056, 5570.136628822539, 5573.5819813513335, 5575.275214222125, 5577.6653400796085, 5588.524975376976, 5648.887022259614, 5656.208130861765, 5657.179708942263, 5706.058500347396, 5554.361248456317, 5557.499825015768, 5561.499465048165, 5562.7774889005605, 5569.0], "value": 5290.191079052944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3506920337451, 627.5826575327408, 630.4042679667716, 644.5037321262631, 650.1677852348992, 42799.57200427995, 44167.999999999956, 44181.77909110454, 48449.273260901115, 48455.51544484554, 44856.775716121454, 45493.31760023594, 45534.77232613841, 45563.54436455634, 45605.7719711401, 8953.552322383903, 9144.268458523335, 9173.0, 9183.448993060438, 9187.540622968858, 9005.954970225139, 9125.634974601007, 9128.178463938244, 9128.589213485377, 9159.175674189322, 9162.17540421362, 9210.861837072416, 9217.815643687121, 9220.170184683377, 9222.170004699576, 9032.819343613091, 9038.18656320931, 9047.004829468786, 9090.090990900922, 9090.13643703847, 9027.232685221765, 9118.452892826384, 9118.726438206864, 9127.497987610679, 9128.58921348541, 43254.134917301795, 43445.0, 43660.12679746419, 43714.78142609298, 43736.343954840704, 3530.682238598513, 3553.822308884571, 3603.40543810271, 3818.369968955119, 3825.464434979105, 33126.6687333126, 33659.6634033659, 33734.493982590284, 33843.15392115192, 34945.30109397823, 4442.2892337225885, 4489.775511224426, 4526.0495295987885, 4709.058188362307, 4710.505396933307, 339144.0, 339236.0, 339983.0, 340180.0, 341207.0, 61009.08486372708, 61357.0, 61669.38330616726, 61723.0, 61801.0, 63151.36848631547, 64071.67964160242, 64100.0, 64228.357716423176, 64273.357266426734, 17466.12669366552, 17756.3785267515, 17796.199171037075, 17809.109544522722, 17821.643567128584, 13649.454021839214, 13840.584782456543, 13886.583402497941, 13887.44450222, 13893.79159312611, 16800.13399546386, 18740.0, 18881.0, 18963.81036189648, 19085.80914190868, 5526.889462210814, 6160.907586386208, 6488.221413430419, 6498.057781621638, 6531.412172904462, 1024.6208902706046, 1028.3058935218698, 1039.0544604409952, 1043.7129789308, 1062.224516538943, 33444.49833252503, 33667.663323366454, 33760.0, 33954.66045339515, 33974.49038264428, 1141.1498433666804, 1141.395060617874, 1142.360278244186, 1149.8907603777627, 1184.8281999110081, 17275.481735547954, 17584.648307034044, 17625.206865691074, 17788.91105544464, 17809.821901780815, 489211.0, 491089.0, 493919.0, 494386.0, 497789.0, 58725.412745871996, 58900.7054964731, 58942.0, 58943.41056589465, 59112.0, 1209.4436559182698, 1348.8313960754906, 1363.590922723199, 1370.5408688089403, 1385.099685204625, 31993.0, 34723.30553388868, 34995.0, 35138.29723405466, 35189.82405087958, 51717.48282517127, 51992.0, 52254.21618675799, 52417.7379113102, 52444.0, 311031.0, 311322.0, 311364.9885755192, 311715.0, 312733.0, 37059.62940370562, 42480.1503969925, 43832.561674384124, 43853.0, 46748.532514674414, 49204.75397622989, 49358.25962610635, 49687.50312496829, 50069.49930500648, 50562.49437505725, 41826.58173418227, 42162.57837421587, 42506.0, 43387.78306108449, 43631.909202270195, 42185.789071054445, 42540.57459425366, 42749.0, 42867.785661071495, 43561.782191088845, 41150.1194916353, 41275.793621031706, 42625.36061959011, 42810.35784463298, 42837.785811070746, 35067.29865402729, 37297.440538391405, 37479.25041499209, 38039.42940855834, 38057.0, 27684.861575692797, 27831.44337113206, 28125.859370703834, 28285.292867678472, 28395.574066388606], "value": 20622.471634709385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2988675553871, 391.5360298046813, 395.29045363572385, 406.3254996705469, 415.35619789326535, 13171.970241484554, 18951.71572426413, 20163.09266083026, 20643.896780516076, 20646.89676551617, 14761.335739891703, 17316.393926212586, 18525.722114168297, 18922.0, 19292.3247686331, 5665.3768085510565, 5828.41715828418, 5839.591228613998, 5874.88250234995, 5875.88248235035, 5738.254026976487, 5759.625624334426, 5783.219265399181, 5804.071348584227, 5807.419258074201, 4161.667066634677, 6127.325994140641, 6411.0, 6417.550771445977, 6527.053577231299, 6289.056641503766, 6474.223093228819, 6488.188976377976, 6506.674666266667, 6532.248791389004, 5701.942980570224, 5711.485966263056, 5732.5987180897355, 5736.082226843727, 5738.540916726652, 23003.42491437711, 23087.0, 23298.53402931949, 23680.1711940083, 23940.0, 2197.04428573571, 2513.773760361576, 2559.910403135881, 2590.598457239112, 2600.726923673006, 10272.640457584024, 10675.145988320915, 10746.892531074667, 14331.0, 14990.475333363389, 1894.1571000904603, 1905.9904700476548, 1908.9331873384504, 1937.0024437414743, 1949.4249196487071, 74887.62556187238, 74921.62539187324, 76940.23059769387, 79990.0, 84884.57557712172, 9351.953240233755, 9648.951755241178, 9960.950195248977, 9964.153046990941, 10258.58965641366, 13189.670258243621, 13233.139845909986, 13271.601851944457, 13284.601461956157, 13297.66755831112, 7895.210478952059, 8190.467619604707, 8226.42415030954, 8247.587620618946, 8304.418690691715, 8422.705205317785, 8486.0665326814, 8554.230119289294, 8609.0, 8671.913280867237, 4141.627253547195, 4191.706580539333, 4363.825446982149, 4483.574060464251, 4695.506971767915, 1945.863789534719, 1946.4939115829986, 1984.7122167285952, 2009.1159889648509, 2019.2831544801677, 927.4018258223408, 977.398899676708, 982.1798798003604, 1046.5029111172132, 1075.9623413180502, 19487.22051117968, 19787.20851165966, 21206.15175392998, 21256.574868502543, 21374.893125534272, 967.434051080126, 996.5216695985822, 1041.13065590233, 1064.797688439194, 1146.2434793036723, 10773.138148948065, 11260.324380537195, 11395.829062564067, 11402.600908968147, 11416.830802147731, 501021.0, 504223.87328380207, 511471.0, 512985.0, 518202.0, 93687.0, 95477.0, 97241.0, 98379.0, 99331.50334248283, 1017.4200705597739, 1058.4020028683924, 1066.9466526673634, 1071.255477443185, 1073.5974009746344, 16779.412720554723, 17907.194176261837, 18085.457436276934, 18091.81908180954, 18220.36228731988, 35715.678480898656, 43671.0, 44867.55132448764, 45329.320060198464, 46899.296510551685, 57067.71466142643, 57869.4213057864, 59884.401155989624, 66942.6652866752, 67349.66325168342, 7359.558426494427, 7607.809804754704, 8089.312408445113, 8279.172082791672, 8931.419457735226, 11040.33757974524, 14276.928615356857, 14417.92791036038, 14503.564893053226, 14721.263936802903, 12093.69765755828, 12513.624591262276, 12595.992320614145, 12658.303793291458, 12795.424205910942, 11747.647570572897, 12287.262764234174, 12441.253524788543, 12539.435725392561, 12612.0, 11718.355490447766, 12939.611811645666, 12945.54690585825, 12975.675608109495, 13072.084954053505, 8970.775730606787, 8983.191512763882, 9007.414518056305, 9017.323700722603, 9329.973702892812, 9223.815523689624, 12351.135420520477, 12400.503979840705, 12677.239365638092, 13046.0], "value": 9424.454401607307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.4409891944292, 1483.584596313032, 1520.6730552931122, 1676.7401052836808, 1815.1831675745918, 8177.87733184002, 8396.790080247996, 8417.873731894026, 8760.0, 8788.2969362451, 8519.446235994656, 8716.128387161281, 8721.127887211276, 8724.47653140812, 8727.0836562161, 1986.701994700792, 2128.1487405038033, 2212.889355532225, 2243.4727838957874, 2263.592553340398, 2259.604569200392, 2270.648049552322, 2272.6591011348346, 2273.783990520898, 2275.8179345652393, 2241.574100920828, 2268.319504148757, 2272.2047283450825, 2279.680844681746, 2288.8969996350206, 1947.4449781812186, 2091.3203208957148, 2126.670366093258, 2176.793204645556, 2186.4533866533366, 2229.308914236592, 2255.2783109404995, 2272.4432514034, 2273.795358417734, 2278.214016164437, 8739.388242823004, 8763.386562940597, 8795.032546419889, 8797.6041078151, 8801.955990220073, 5003.774830132653, 5133.717645529495, 5242.8689282767855, 5289.285946397225, 5297.47025297471, 3405.3529829332597, 3410.7782994105305, 3446.207372304359, 3464.9826750866087, 3486.041338631871, 1254.6725823597187, 1259.4080782032431, 1274.8597654258024, 1285.967850803728, 1286.0097724751981, 12240.693982650417, 12240.877591224064, 12241.69395765113, 12247.326397048158, 12259.264444133381, 4408.603225709638, 4501.0, 4639.953600463952, 4662.393888794435, 4668.089722504079, 10153.746156346151, 10282.434466104436, 10287.794244115226, 10307.793844123076, 10308.278420510642, 5291.285676433709, 5294.894102117936, 5303.708296043755, 5304.257403963448, 5307.150855863043, 4336.501302350207, 4758.2386818108935, 4864.537868902448, 4877.853664390074, 4947.6536642434685, 3898.317794385971, 3943.8619648312747, 3981.442598036277, 4033.4554835097474, 4037.959620403817, 1178.8762179971152, 1219.268438936631, 1251.1492185313891, 1291.1671971578467, 1291.4446787881113, 925.6713866577403, 967.5065716484644, 1001.3491230700104, 1005.7334806276342, 1008.8032833597379, 5833.970830145822, 5874.530037596982, 5981.312149102909, 6034.728437220336, 6049.758009679652, 971.1017308989157, 975.6048800235916, 987.5852142100335, 996.9202463802878, 997.2869398380193, 4303.33298338758, 4515.322701594787, 4582.908341833145, 4620.491745907947, 4621.653375996813, 11039.116870650489, 11069.225154239126, 11129.888701112885, 11247.268927519848, 11272.943635281936, 10210.693679189637, 10684.252102352915, 11050.392228427352, 11053.17101217412, 11073.280236784583, 8225.424220304641, 8307.210814972688, 8389.580520973926, 8403.0, 8405.95797021011, 6163.414475624809, 6571.57284776488, 6573.57271777333, 6625.105610742488, 6792.796216113525, 9986.700398988041, 10314.638987635397, 10377.481125943823, 10408.47957602132, 10422.947885260524, 10421.635242766466, 10431.582736690447, 10544.472776361305, 10555.155587552823, 10561.89438105609, 7701.268379503938, 7709.190534993745, 7850.882236766339, 7865.842683146419, 7885.723999659985, 8425.031121421114, 8463.111373305714, 8515.276201522693, 8536.786580335542, 8545.700900468453, 7651.655675494505, 7884.21157884207, 7960.601969901598, 7962.960185199268, 8109.59452027408, 7673.079230492377, 7686.385089192963, 7811.921880781347, 7849.0, 8119.350451963947, 6929.237783843672, 6939.306069393222, 6980.685869136003, 6982.6508674567085, 6991.0, 5203.0, 5273.815416460406, 5393.919091213556, 5416.322959630046, 5437.184422336682, 5167.870803229949, 5206.479352064764, 5347.866303342447, 5384.300040994645, 5411.998780225671], "value": 4679.718740248582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.7805092537074, 326.7647293948357, 332.1612927358421, 334.22293168383504, 338.038281090298, 5288.9471105288985, 5300.602454815885, 5333.786648534059, 5361.008213480504, 5380.381256155543, 4994.30079788829, 5097.515736005073, 5156.097682905486, 5165.564899341943, 5267.789288428467, 4009.138035322405, 4028.113814960704, 4112.2803509385885, 4116.711830171889, 4162.604552567516, 4115.876523704279, 4137.151883863816, 4148.191102734968, 4149.232392007473, 4159.646430053449, 4051.858184963512, 4066.552679205285, 4069.572694867041, 4111.280525907969, 4154.563770804068, 4082.6121518455698, 4111.424400583921, 4117.07365842686, 4122.546519882811, 4125.814338354781, 3647.7993710345922, 3656.3784156693428, 3670.7797532148156, 3675.3751862183494, 3696.537932758405, 5028.296038554606, 5122.380148161423, 5165.147750621143, 5196.584273258168, 5217.191335343028, 4721.740304283263, 4723.4568024677255, 4726.432828060655, 4729.462924549535, 4745.881352966204, 5462.0, 5525.154545409117, 5539.584531160139, 5555.138953462219, 5566.192902029224, 3751.718621103401, 4024.0744628735556, 4036.0, 4059.939100913489, 4066.430699702044, 5663.008973429633, 5676.650776042155, 5679.2739485047, 5700.551166544223, 5714.114312281603, 4053.310937140693, 4067.9389809152885, 4070.4504891839224, 4071.206114807584, 4072.2873497138476, 4126.773027483458, 4133.793310334471, 4134.090500089976, 4138.151678905877, 4140.751554906716, 4471.7987690554, 4677.789499472532, 4680.789364478606, 4714.269288260325, 4741.5495527924795, 5485.476680726831, 5500.387316024856, 5518.310211223597, 5525.143602741581, 5604.187392828098, 1333.5265980576755, 1361.857005014479, 1399.2933568548021, 1399.8040274361597, 1410.1045835894076, 932.9720108396759, 948.8149810786969, 957.1816097236901, 964.9710508684751, 972.3242346569208, 5362.410134885159, 5376.892462150735, 5390.407055223922, 5390.5742415913, 5392.436193503919, 5619.325680918316, 5625.268715067097, 5644.181593668895, 5647.124695672177, 5665.235193248941, 5239.371275446971, 5356.1697936819855, 5364.22218778275, 5393.1370980642905, 5513.145462453326, 3001.6247969003875, 3031.9242018949703, 3034.742046925992, 3041.9239519012203, 3048.1465189746905, 5911.674857882772, 5922.585419020714, 5927.436893495111, 5933.614315069507, 5937.940620593825, 5621.437856214346, 5821.27234095738, 5821.679807610537, 5861.32594751609, 5870.765169393177, 5886.470217680429, 5899.469047785634, 5923.911141332884, 5958.646334697857, 6013.939860601513, 5593.468620481211, 5660.924424359358, 5745.827625171251, 5784.305883294031, 5806.738696758741, 5677.943220567741, 5679.835633695166, 5690.971545142248, 5692.373838877637, 5697.515711164598, 5948.2862056553495, 5952.404759524013, 5972.044472884318, 6004.339522652592, 6023.186869772525, 3912.491376121086, 4003.8798836034966, 4054.702495201507, 4060.269151552749, 4060.289449346412, 5510.724463776875, 5657.3776884543495, 5676.914846277392, 5698.800541981011, 5706.0, 5444.945550544444, 5537.612367134423, 5538.196961440488, 5560.582956278215, 5622.409646987171, 5532.391436941853, 5558.60979778699, 5562.582806289463, 5567.524605979338, 5572.804951826666, 5297.54970827484, 5477.890442191214, 5478.616496845182, 5503.834884953458, 5504.256925315031, 5530.640508366943, 5571.9442805571425, 5591.888162236651, 5595.356533998643, 5620.4098569649595, 5491.395946445808, 5513.062779327604, 5513.972430137824, 5523.972380138073, 5566.666000040011], "value": 4239.002893999742, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.8699721047421, 799.0970203669859, 826.5536610230475, 851.9659213631451, 866.7009881590851, 15495.0, 16037.759433608506, 16688.082155481443, 16979.3208271669, 17019.40432084877, 15112.622184445394, 15305.311260993254, 15330.0, 15337.769933451007, 15354.46259380922, 676.4182802789597, 810.785141937387, 832.9250367466926, 837.417994493827, 837.7779888329597, 805.2993895311088, 825.983480330396, 830.8504469195542, 835.6866175184306, 837.401258100458, 861.1001503428901, 864.8616221404576, 866.1252135343317, 866.1338661338661, 866.2809867809702, 694.4652617484509, 841.7769291137853, 863.5811631358818, 863.6329559937002, 865.1996902864856, 633.3349982518383, 635.2218532297898, 636.2555809702659, 636.7039326713054, 636.8853606350855, 16120.919395403065, 16239.0, 16255.431059912846, 16260.593485162966, 16264.349426022945, 14465.349059292357, 14853.554393368217, 14902.552923412315, 14956.925215373962, 15013.324400402009, 13319.866801332057, 13372.197668139943, 13402.329883505883, 13411.262380569065, 13533.255670938193, 4446.7998940047455, 4469.396631454744, 4484.8878778030485, 4502.752348620825, 4586.151561961048, 65997.67001165012, 77445.61277193634, 77618.22381776167, 77867.61066194632, 78816.21183788146, 11564.884351156381, 11864.466099025565, 12007.819882701591, 12137.211081279866, 12161.756764864653, 21249.57500849974, 21341.78658213429, 21471.8926405367, 21476.463088422915, 22189.556208876056, 7961.681532738626, 8237.79405514867, 8352.916470835335, 8546.572671366532, 9099.81800363989, 4894.632902532324, 4896.755162241873, 4939.160342741742, 4980.160900565855, 5033.823816166417, 3302.1909632140278, 3426.109211605001, 3426.9485957710654, 3428.211511352353, 3434.227298857787, 596.3708287756372, 596.6300893446091, 599.5054080383613, 606.0364021206215, 614.1862032806549, 679.751890559942, 696.5611664651237, 704.6793708862456, 716.0583832260664, 734.4271468254769, 9301.813963720688, 9489.715308540755, 9708.448436909885, 9820.950895245478, 9843.655472058443, 632.9239696355547, 674.2515807453723, 694.7707256605308, 700.7477308169055, 715.7208688611446, 4583.793729282191, 4714.834980775657, 4740.5733483986605, 4834.685745426536, 4838.782254798542, 96809.0319096814, 104968.0, 111974.0, 112562.0, 112674.0, 60636.0, 85445.0, 97244.0, 97464.51267743616, 97475.0, 85699.57150214334, 86233.5688321567, 86379.0, 86638.56680716682, 87063.56468217618, 8886.86669699968, 9213.447193168431, 9223.907760922304, 9427.670031548863, 9457.43255404678, 51801.0, 52787.47212527979, 53043.734781325846, 53258.0, 54998.0, 71426.0, 75873.24126758662, 76311.0, 76865.0, 77448.0, 11563.537458501902, 11576.652700419001, 11712.0, 11855.0, 12099.879001210227, 12392.690182745142, 12662.0, 12796.808047879103, 12810.972568578554, 13097.934510327388, 12064.577739779066, 12308.507659693512, 12308.876911231131, 12590.559330423392, 12745.235285882876, 11810.350430726392, 11975.64073077809, 12022.27866328023, 12211.938940305241, 12566.748665026831, 11641.301521908374, 11672.941635291769, 11704.122190835891, 12009.516636656812, 12073.335966521925, 10137.543810528396, 10535.947320263349, 10588.0, 10808.0, 10812.0, 9933.453660048766, 10038.397696137963, 10337.948310258702, 10503.894961050291, 10574.101201397967], "value": 7483.348092513649, "unit": "score"}], "name": "dromaeo_css", "value": 7310.531668712805, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 112.0, 113.0, 111.0, 109.0, 110.0, 111.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 122.0, 176.0, 122.0, 119.0, 143.0, 120.0, 147.0, 118.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 159.0, 159.0, 161.0, 162.0, 161.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 120.0, 75.0, 76.0, 76.0, 75.0, 103.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 113.0, 83.0, 84.0, 84.0, 113.0, 84.0, 84.0, 119.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "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, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 56.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 75.0, 83.0, 75.0, 77.0, 75.0, 74.0, 81.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 124.0, 125.0, 129.0, 127.0, 138.0, 128.0, 162.0, 130.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 159.0, 160.0, 165.0, 159.0, 156.0, 157.0, 159.0, 158.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 66.0, 63.0, 62.0, 62.0, 63.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1480.7, "alertThreshold": 2.0}]} 06:01:44 INFO - Return code: 0 06:01:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:44 INFO - # TBPL SUCCESS # 06:01:44 INFO - Running post-action listener: _resource_record_post_action 06:01:44 INFO - ##### 06:01:44 INFO - ##### Finished run-tests step (success) 06:01:44 INFO - ##### 06:01:44 INFO - Running post-run listener: _resource_record_post_run 06:01:44 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 567681024; Read time: 0; Write time: 748968 06:01:44 INFO - TinderboxPrint: CPU usage
13.0% 06:01:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:01:44 INFO - TinderboxPrint: I/O write bytes / time
567,681,024 / 748,968 06:01:44 INFO - TinderboxPrint: CPU idle
8,267.6 (87.0%) 06:01:44 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 06:01:44 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:44 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 268673024; Read time: 0; Write time: 374732 06:01:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298684416; Read time: 0; Write time: 374232 06:01:44 INFO - Running post-run listener: _upload_blobber_files 06:01:44 INFO - Blob upload gear active. 06:01:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:44 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 06:01:44 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:44 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:46 INFO - (blobuploader) - INFO - Done attempting. 06:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:50 INFO - (blobuploader) - INFO - Done attempting. 06:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:01:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:51 INFO - (blobuploader) - INFO - Done attempting. 06:01:51 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:51 INFO - Return code: 0 06:01:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba3b900e1377ac8e86db1f1e8c7faa9738b756a15f488376f95b518a4a42a6fbf17941b392cf6128d4345ead5c64744067656dd33904678b0a21597d57f399f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c11e25bce0213ed4b8a6b17e7a0a40ffb1e160531d3029246e5a5f201ac4c5f77619556f1bd8b99891bfac4c876acfc63056edcdd20b13e57e27b041f2a57e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdacb3c4a25c3b6dd916e782faceb225c12fea8a3a9000dd5a16ea2a0cfa09a39906b9a32a86966849eb0d1c302a74fd1acbe785bf88da6249860d21a9fdcc4"} 06:01:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:51 INFO - Contents: 06:01:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba3b900e1377ac8e86db1f1e8c7faa9738b756a15f488376f95b518a4a42a6fbf17941b392cf6128d4345ead5c64744067656dd33904678b0a21597d57f399f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c11e25bce0213ed4b8a6b17e7a0a40ffb1e160531d3029246e5a5f201ac4c5f77619556f1bd8b99891bfac4c876acfc63056edcdd20b13e57e27b041f2a57e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdacb3c4a25c3b6dd916e782faceb225c12fea8a3a9000dd5a16ea2a0cfa09a39906b9a32a86966849eb0d1c302a74fd1acbe785bf88da6249860d21a9fdcc4"} 06:01:51 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:51 INFO - Copying logs to upload dir... 06:01:51 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.560586 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 06:01:50.848338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 06:01:50.851727) ========= 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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba3b900e1377ac8e86db1f1e8c7faa9738b756a15f488376f95b518a4a42a6fbf17941b392cf6128d4345ead5c64744067656dd33904678b0a21597d57f399f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c11e25bce0213ed4b8a6b17e7a0a40ffb1e160531d3029246e5a5f201ac4c5f77619556f1bd8b99891bfac4c876acfc63056edcdd20b13e57e27b041f2a57e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdacb3c4a25c3b6dd916e782faceb225c12fea8a3a9000dd5a16ea2a0cfa09a39906b9a32a86966849eb0d1c302a74fd1acbe785bf88da6249860d21a9fdcc4"} build_url:https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/UgMxTD49Q0uWQ0obvL5tDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba3b900e1377ac8e86db1f1e8c7faa9738b756a15f488376f95b518a4a42a6fbf17941b392cf6128d4345ead5c64744067656dd33904678b0a21597d57f399f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c11e25bce0213ed4b8a6b17e7a0a40ffb1e160531d3029246e5a5f201ac4c5f77619556f1bd8b99891bfac4c876acfc63056edcdd20b13e57e27b041f2a57e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdacb3c4a25c3b6dd916e782faceb225c12fea8a3a9000dd5a16ea2a0cfa09a39906b9a32a86966849eb0d1c302a74fd1acbe785bf88da6249860d21a9fdcc4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 06:01:50.881615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 06:01:50.882393) ========= 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=826874ccc97bd7bf541b4875000001d5-1468410855.74637-582045715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 06:01:50.964825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 06:01:50.965563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 06:01:50.966193) ========= ========= Total master_lag: 0.20 =========