builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1470921074.01 results: success (0) buildid: 20160811030201 builduid: 6173cbea8b2e4ff587fd734487ae46da revision: 0502bd9e025edde29777ba1de4280f9b52af4663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.011826) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.012316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.012606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.027669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.028047) ========= 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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 06:11:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.1M=0s 2016-08-11 06:11:14 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.151872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.152218) ========= 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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016517 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:14.202242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 06:11:14.202624) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0502bd9e025edde29777ba1de4280f9b52af4663 --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 0502bd9e025edde29777ba1de4280f9b52af4663 --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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 06:11:15,000 truncating revision to first 12 chars 2016-08-11 06:11:15,000 Setting DEBUG logging. 2016-08-11 06:11:15,000 attempt 1/10 2016-08-11 06:11:15,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0502bd9e025e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 06:11:16,189 unpacking tar archive at: mozilla-central-0502bd9e025e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 06:11:15.763051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:15.763423) ========= script_repo_revision: 0502bd9e025edde29777ba1de4280f9b52af4663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:15.763862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:15.764159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 06:11:15.774175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-11 06:11:15.774480) ========= /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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:16 INFO - MultiFileLogger online at 20160811 06:11:16 in /builds/slave/test 06:11:16 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 06:11:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:16 INFO - {'append_to_log': False, 06:11:16 INFO - 'base_work_dir': '/builds/slave/test', 06:11:16 INFO - 'blob_upload_branch': 'Firefox', 06:11:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:16 INFO - 'branch': 'Firefox', 06:11:16 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:16 INFO - 'config_files': ('talos/linux_config.py',), 06:11:16 INFO - 'default_actions': ('clobber', 06:11:16 INFO - 'read-buildbot-config', 06:11:16 INFO - 'download-and-extract', 06:11:16 INFO - 'populate-webroot', 06:11:16 INFO - 'create-virtualenv', 06:11:16 INFO - 'install', 06:11:16 INFO - 'run-tests'), 06:11:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:16 INFO - 'download_minidump_stackwalk': True, 06:11:16 INFO - 'download_symbols': 'ondemand', 06:11:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:16 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:16 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:16 INFO - 'installer_path': 'installer.exe', 06:11:16 INFO - 'log_level': 'info', 06:11:16 INFO - 'log_name': 'talos', 06:11:16 INFO - 'log_to_console': True, 06:11:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:16 INFO - 'opt_config_files': (), 06:11:16 INFO - 'pip_index': False, 06:11:16 INFO - 'sps_profile': False, 06:11:16 INFO - 'sps_profile_interval': 0, 06:11:16 INFO - 'suite': 'dromaeojs', 06:11:16 INFO - 'system_bits': '32', 06:11:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:16 INFO - 'title': 'talos-linux64-ix-003', 06:11:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:16 INFO - 'use_talos_json': True, 06:11:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:16 INFO - 'work_dir': 'build'} 06:11:16 INFO - [mozharness: 2016-08-11 13:11:16.661044Z] Running clobber step. 06:11:16 INFO - Running pre-action listener: _resource_record_pre_action 06:11:16 INFO - Running main action method: clobber 06:11:16 INFO - rmtree: /builds/slave/test/build 06:11:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:17 INFO - Running post-action listener: _resource_record_post_action 06:11:17 INFO - [mozharness: 2016-08-11 13:11:17.631561Z] Finished clobber step (success) 06:11:17 INFO - [mozharness: 2016-08-11 13:11:17.631663Z] Running read-buildbot-config step. 06:11:17 INFO - Running pre-action listener: _resource_record_pre_action 06:11:17 INFO - Running main action method: read_buildbot_config 06:11:17 INFO - Using buildbot properties: 06:11:17 INFO - { 06:11:17 INFO - "project": "", 06:11:17 INFO - "product": "firefox", 06:11:17 INFO - "script_repo_revision": "production", 06:11:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:11:17 INFO - "repository": "", 06:11:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:11:17 INFO - "buildid": "20160811030201", 06:11:17 INFO - "stage_platform": "linux64-pgo", 06:11:17 INFO - "basedir": "/builds/slave/test", 06:11:17 INFO - "nightly_build": "True", 06:11:17 INFO - "buildnumber": 420, 06:11:17 INFO - "slavename": "talos-linux64-ix-003", 06:11:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:11:17 INFO - "platform": "ubuntu64_hw", 06:11:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:11:17 INFO - "branch": "mozilla-central", 06:11:17 INFO - "repo_path": "mozilla-central", 06:11:17 INFO - "revision": "0502bd9e025edde29777ba1de4280f9b52af4663", 06:11:17 INFO - "pgo_build": "True", 06:11:17 INFO - "builduid": "6173cbea8b2e4ff587fd734487ae46da", 06:11:17 INFO - "slavebuilddir": "test" 06:11:17 INFO - } 06:11:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:11:17 INFO - Running post-action listener: _resource_record_post_action 06:11:17 INFO - [mozharness: 2016-08-11 13:11:17.634182Z] Finished read-buildbot-config step (success) 06:11:17 INFO - [mozharness: 2016-08-11 13:11:17.634271Z] Running download-and-extract step. 06:11:17 INFO - Running pre-action listener: _resource_record_pre_action 06:11:17 INFO - Running main action method: download_and_extract 06:11:17 INFO - mkdir: /builds/slave/test/build/tests 06:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:17 INFO - trying https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:11:17 INFO - Downloading https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:11:18 INFO - Downloaded 1361 bytes. 06:11:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:11:18 INFO - Using the following test package requirements: 06:11:18 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:11:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:11:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:11:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'jsshell-linux-x86_64.zip'], 06:11:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:11:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:11:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:11:18 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:11:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:11:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:11:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:11:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:18 INFO - trying https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:11:18 INFO - Downloading https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:19 INFO - Downloaded 21833879 bytes. 06:11:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:11:20 INFO - Return code: 0 06:11:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:20 INFO - trying https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:11:20 INFO - Downloading https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:21 INFO - Downloaded 21833879 bytes. 06:11:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:11:22 INFO - Return code: 0 06:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:22 INFO - trying https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:11:22 INFO - Downloading https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:11:23 INFO - Downloaded 14413719 bytes. 06:11:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:11:23 INFO - Return code: 0 06:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:23 INFO - trying https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:11:25 INFO - Downloaded 59336580 bytes. 06:11:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:11:25 INFO - mkdir: /builds/slave/test/properties 06:11:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:25 INFO - Contents: 06:11:25 INFO - build_url:https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:11:25 INFO - Running post-action listener: _resource_record_post_action 06:11:25 INFO - Running post-action listener: set_extra_try_arguments 06:11:25 INFO - [mozharness: 2016-08-11 13:11:25.877107Z] Finished download-and-extract step (success) 06:11:25 INFO - [mozharness: 2016-08-11 13:11:25.877340Z] Running populate-webroot step. 06:11:25 INFO - Running pre-action listener: _resource_record_pre_action 06:11:25 INFO - Running main action method: populate_webroot 06:11:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:11:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:11:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:11:25 INFO - '--tppagecycles', 06:11:25 INFO - '7'], 06:11:25 INFO - 'tests': ['tsvgm']}}, 06:11:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:11:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:11:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['damp', 'tps']}, 06:11:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'tests': ['damp', 'tps']}, 06:11:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['dromaeo_dom']}, 06:11:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['basic_compositor_video']}, 06:11:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:11:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['a11yr', 06:11:25 INFO - 'ts_paint', 06:11:25 INFO - 'tpaint', 06:11:25 INFO - 'sessionrestore', 06:11:25 INFO - 'sessionrestore_no_auto_restore', 06:11:25 INFO - 'tabpaint']}, 06:11:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['tsvgx', 06:11:25 INFO - 'tsvgr_opacity', 06:11:25 INFO - 'tart', 06:11:25 INFO - 'tscrollx', 06:11:25 INFO - 'cart']}, 06:11:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:25 INFO - 'tsvgr_opacity', 06:11:25 INFO - 'tart', 06:11:25 INFO - 'tscrollx', 06:11:25 INFO - 'cart']}, 06:11:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'talos_options': ['--disable-e10s'], 06:11:25 INFO - 'tests': ['tp5o']}, 06:11:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'tests': ['tp5o']}, 06:11:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'talos_options': ['--disable-e10s', 06:11:25 INFO - '--xperf_path', 06:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:25 INFO - 'tests': ['tp5n']}, 06:11:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:25 INFO - 'talos_options': ['--xperf_path', 06:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:25 INFO - 'tests': ['tp5n']}}, 06:11:25 INFO - 'talos.zip': {'path': '', 06:11:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:11:25 INFO - Running post-action listener: _resource_record_post_action 06:11:25 INFO - [mozharness: 2016-08-11 13:11:25.897112Z] Finished populate-webroot step (success) 06:11:25 INFO - [mozharness: 2016-08-11 13:11:25.897201Z] Running create-virtualenv step. 06:11:25 INFO - Running pre-action listener: _resource_record_pre_action 06:11:25 INFO - Running main action method: create_virtualenv 06:11:25 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:25 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 06:11:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:25 INFO - Using real prefix '/usr' 06:11:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:28 INFO - Installing pip.................done. 06:11:28 INFO - Return code: 0 06:11:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:28 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:28 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 06:11:28 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 06:11:28 INFO - Using env: {'DISPLAY': ':0', 06:11:28 INFO - 'HOME': '/home/cltbld', 06:11:28 INFO - 'LANG': 'en_US.UTF-8', 06:11:28 INFO - 'LANGUAGE': 'en_US:en', 06:11:28 INFO - 'LOGNAME': 'cltbld', 06:11:28 INFO - 'MAIL': '/var/mail/cltbld', 06:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:28 INFO - 'MOZ_NO_REMOTE': '1', 06:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:28 INFO - 'NO_EM_RESTART': '1', 06:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:28 INFO - 'PWD': '/builds/slave/test', 06:11:28 INFO - 'SHELL': '/bin/bash', 06:11:28 INFO - 'SHLVL': '1', 06:11:28 INFO - 'TERM': 'linux', 06:11:28 INFO - 'TMOUT': '86400', 06:11:28 INFO - 'USER': 'cltbld', 06:11:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:28 INFO - '_': '/tools/buildbot/bin/python'} 06:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:28 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 06:11:28 INFO - Cleaning up... 06:11:28 INFO - Return code: 0 06:11:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:28 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:28 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 06:11:28 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 06:11:28 INFO - Using env: {'DISPLAY': ':0', 06:11:28 INFO - 'HOME': '/home/cltbld', 06:11:28 INFO - 'LANG': 'en_US.UTF-8', 06:11:28 INFO - 'LANGUAGE': 'en_US:en', 06:11:28 INFO - 'LOGNAME': 'cltbld', 06:11:28 INFO - 'MAIL': '/var/mail/cltbld', 06:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:28 INFO - 'MOZ_NO_REMOTE': '1', 06:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:28 INFO - 'NO_EM_RESTART': '1', 06:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:28 INFO - 'PWD': '/builds/slave/test', 06:11:28 INFO - 'SHELL': '/bin/bash', 06:11:28 INFO - 'SHLVL': '1', 06:11:28 INFO - 'TERM': 'linux', 06:11:28 INFO - 'TMOUT': '86400', 06:11:28 INFO - 'USER': 'cltbld', 06:11:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:28 INFO - '_': '/tools/buildbot/bin/python'} 06:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:29 INFO - Downloading/unpacking psutil>=3.1.1 06:11:29 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 06:11:29 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 06:11:29 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 06:11:29 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 06:11:29 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 06:11:29 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 06:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:31 INFO - Installing collected packages: psutil 06:11:31 INFO - Running setup.py install for psutil 06:11:31 INFO - building 'psutil._psutil_linux' extension 06:11:31 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 06:11:31 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 06:11:31 INFO - building 'psutil._psutil_posix' extension 06:11:31 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 06:11:31 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 06:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:31 INFO - Successfully installed psutil 06:11:31 INFO - Cleaning up... 06:11:31 INFO - Return code: 0 06:11:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:31 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:31 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 06:11:31 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 06:11:31 INFO - Using env: {'DISPLAY': ':0', 06:11:31 INFO - 'HOME': '/home/cltbld', 06:11:31 INFO - 'LANG': 'en_US.UTF-8', 06:11:31 INFO - 'LANGUAGE': 'en_US:en', 06:11:31 INFO - 'LOGNAME': 'cltbld', 06:11:31 INFO - 'MAIL': '/var/mail/cltbld', 06:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:31 INFO - 'MOZ_NO_REMOTE': '1', 06:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:31 INFO - 'NO_EM_RESTART': '1', 06:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:31 INFO - 'PWD': '/builds/slave/test', 06:11:31 INFO - 'SHELL': '/bin/bash', 06:11:31 INFO - 'SHLVL': '1', 06:11:31 INFO - 'TERM': 'linux', 06:11:31 INFO - 'TMOUT': '86400', 06:11:31 INFO - 'USER': 'cltbld', 06:11:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:31 INFO - '_': '/tools/buildbot/bin/python'} 06:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:33 INFO - Installing collected packages: mozsystemmonitor 06:11:33 INFO - Running setup.py install for mozsystemmonitor 06:11:33 INFO - Successfully installed mozsystemmonitor 06:11:33 INFO - Cleaning up... 06:11:33 INFO - Return code: 0 06:11:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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', '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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:11: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 jsonschema==2.5.1 06:11:33 INFO - Using env: {'DISPLAY': ':0', 06:11:33 INFO - 'HOME': '/home/cltbld', 06:11:33 INFO - 'LANG': 'en_US.UTF-8', 06:11:33 INFO - 'LANGUAGE': 'en_US:en', 06:11:33 INFO - 'LOGNAME': 'cltbld', 06:11:33 INFO - 'MAIL': '/var/mail/cltbld', 06:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:33 INFO - 'MOZ_NO_REMOTE': '1', 06:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:33 INFO - 'NO_EM_RESTART': '1', 06:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:33 INFO - 'PWD': '/builds/slave/test', 06:11:33 INFO - 'SHELL': '/bin/bash', 06:11:33 INFO - 'SHLVL': '1', 06:11:33 INFO - 'TERM': 'linux', 06:11:33 INFO - 'TMOUT': '86400', 06:11:33 INFO - 'USER': 'cltbld', 06:11:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:33 INFO - '_': '/tools/buildbot/bin/python'} 06:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:34 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 06:11:34 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 06:11:34 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 06:11:34 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 06:11:34 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 06:11:34 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 06:11:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:36 INFO - warning: no files found matching '*.txt' 06:11:36 INFO - no previously-included directories found matching 'build' 06:11:36 INFO - no previously-included directories found matching 'dist' 06:11:36 INFO - no previously-included directories found matching '.git*' 06:11:36 INFO - Installing collected packages: jsonschema, functools32 06:11:36 INFO - Running setup.py install for functools32 06:11:36 INFO - warning: no files found matching '*.txt' 06:11:36 INFO - no previously-included directories found matching 'build' 06:11:36 INFO - no previously-included directories found matching 'dist' 06:11:36 INFO - no previously-included directories found matching '.git*' 06:11:36 INFO - Successfully installed jsonschema functools32 06:11:36 INFO - Cleaning up... 06:11:36 INFO - Return code: 0 06:11:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:11: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 functools32==3.2.3-2 06:11:36 INFO - Using env: {'DISPLAY': ':0', 06:11:36 INFO - 'HOME': '/home/cltbld', 06:11:36 INFO - 'LANG': 'en_US.UTF-8', 06:11:36 INFO - 'LANGUAGE': 'en_US:en', 06:11:36 INFO - 'LOGNAME': 'cltbld', 06:11:36 INFO - 'MAIL': '/var/mail/cltbld', 06:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:36 INFO - 'MOZ_NO_REMOTE': '1', 06:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:36 INFO - 'NO_EM_RESTART': '1', 06:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:36 INFO - 'PWD': '/builds/slave/test', 06:11:36 INFO - 'SHELL': '/bin/bash', 06:11:36 INFO - 'SHLVL': '1', 06:11:36 INFO - 'TERM': 'linux', 06:11:36 INFO - 'TMOUT': '86400', 06:11:36 INFO - 'USER': 'cltbld', 06:11:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:36 INFO - '_': '/tools/buildbot/bin/python'} 06:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:11:36 INFO - Cleaning up... 06:11:36 INFO - Return code: 0 06:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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', '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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:11: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 blobuploader==1.2.4 06:11:36 INFO - Using env: {'DISPLAY': ':0', 06:11:36 INFO - 'HOME': '/home/cltbld', 06:11:36 INFO - 'LANG': 'en_US.UTF-8', 06:11:36 INFO - 'LANGUAGE': 'en_US:en', 06:11:36 INFO - 'LOGNAME': 'cltbld', 06:11:36 INFO - 'MAIL': '/var/mail/cltbld', 06:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:36 INFO - 'MOZ_NO_REMOTE': '1', 06:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:36 INFO - 'NO_EM_RESTART': '1', 06:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:36 INFO - 'PWD': '/builds/slave/test', 06:11:36 INFO - 'SHELL': '/bin/bash', 06:11:36 INFO - 'SHLVL': '1', 06:11:36 INFO - 'TERM': 'linux', 06:11:36 INFO - 'TMOUT': '86400', 06:11:36 INFO - 'USER': 'cltbld', 06:11:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:36 INFO - '_': '/tools/buildbot/bin/python'} 06:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:36 INFO - Downloading/unpacking blobuploader==1.2.4 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11:39 INFO - Downloading docopt-0.6.1.tar.gz 06:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:39 INFO - Running setup.py install for blobuploader 06:11:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:39 INFO - Running setup.py install for requests 06:11:39 INFO - Running setup.py install for docopt 06:11:40 INFO - Successfully installed blobuploader requests docopt 06:11:40 INFO - Cleaning up... 06:11:40 INFO - Return code: 0 06:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:40 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:40 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 06:11:40 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 06:11:40 INFO - Using env: {'DISPLAY': ':0', 06:11:40 INFO - 'HOME': '/home/cltbld', 06:11:40 INFO - 'LANG': 'en_US.UTF-8', 06:11:40 INFO - 'LANGUAGE': 'en_US:en', 06:11:40 INFO - 'LOGNAME': 'cltbld', 06:11:40 INFO - 'MAIL': '/var/mail/cltbld', 06:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:40 INFO - 'MOZ_NO_REMOTE': '1', 06:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:40 INFO - 'NO_EM_RESTART': '1', 06:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:40 INFO - 'PWD': '/builds/slave/test', 06:11:40 INFO - 'SHELL': '/bin/bash', 06:11:40 INFO - 'SHLVL': '1', 06:11:40 INFO - 'TERM': 'linux', 06:11:40 INFO - 'TMOUT': '86400', 06:11:40 INFO - 'USER': 'cltbld', 06:11:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:40 INFO - '_': '/tools/buildbot/bin/python'} 06:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:40 INFO - Running setup.py (path:/tmp/pip-sego6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:40 INFO - Running setup.py (path:/tmp/pip-pDiMs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:40 INFO - Running setup.py (path:/tmp/pip-4a0bSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:40 INFO - Running setup.py (path:/tmp/pip-NqTZUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:40 INFO - Running setup.py (path:/tmp/pip-sYuI3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:40 INFO - Running setup.py (path:/tmp/pip-BbdG1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:40 INFO - Running setup.py (path:/tmp/pip-JMOsls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:40 INFO - Running setup.py (path:/tmp/pip-MqnIJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:40 INFO - Running setup.py (path:/tmp/pip-IV_5Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:40 INFO - Running setup.py (path:/tmp/pip-TLTRAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:41 INFO - Running setup.py (path:/tmp/pip-R9F_nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:41 INFO - Running setup.py (path:/tmp/pip-UoltFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:41 INFO - Running setup.py (path:/tmp/pip-Hn2F83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:41 INFO - Running setup.py (path:/tmp/pip-mcaNyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:41 INFO - Running setup.py (path:/tmp/pip-twcyQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:41 INFO - Running setup.py (path:/tmp/pip-UUbY1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:41 INFO - Running setup.py (path:/tmp/pip-BSKl0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:11:41 INFO - Running setup.py install for manifestparser 06:11:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:11:41 INFO - Running setup.py install for mozcrash 06:11:41 INFO - Running setup.py install for mozdebug 06:11:41 INFO - Running setup.py install for mozdevice 06:11:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:11:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:11:41 INFO - Running setup.py install for mozfile 06:11:42 INFO - Running setup.py install for mozhttpd 06:11:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozinfo 06:11:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozInstall 06:11:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozleak 06:11:42 INFO - Running setup.py install for mozlog 06:11:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for moznetwork 06:11:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozprocess 06:11:42 INFO - Running setup.py install for mozprofile 06:11:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozrunner 06:11:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Running setup.py install for mozscreenshot 06:11:43 INFO - Running setup.py install for moztest 06:11:43 INFO - Running setup.py install for mozversion 06:11:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:11:43 INFO - Cleaning up... 06:11:43 INFO - Return code: 0 06:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:43 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:43 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 06:11:43 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 06:11:43 INFO - Using env: {'DISPLAY': ':0', 06:11:43 INFO - 'HOME': '/home/cltbld', 06:11:43 INFO - 'LANG': 'en_US.UTF-8', 06:11:43 INFO - 'LANGUAGE': 'en_US:en', 06:11:43 INFO - 'LOGNAME': 'cltbld', 06:11:43 INFO - 'MAIL': '/var/mail/cltbld', 06:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:43 INFO - 'MOZ_NO_REMOTE': '1', 06:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:43 INFO - 'NO_EM_RESTART': '1', 06:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:43 INFO - 'PWD': '/builds/slave/test', 06:11:43 INFO - 'SHELL': '/bin/bash', 06:11:43 INFO - 'SHLVL': '1', 06:11:43 INFO - 'TERM': 'linux', 06:11:43 INFO - 'TMOUT': '86400', 06:11:43 INFO - 'USER': 'cltbld', 06:11:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:43 INFO - '_': '/tools/buildbot/bin/python'} 06:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:43 INFO - Running setup.py (path:/tmp/pip-_e6Pgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:43 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)) 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:43 INFO - Running setup.py (path:/tmp/pip-YD0LqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:43 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)) 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:43 INFO - Running setup.py (path:/tmp/pip-IY3wbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:43 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)) 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:43 INFO - Running setup.py (path:/tmp/pip-O4lR3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:43 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)) 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:43 INFO - Running setup.py (path:/tmp/pip-8qWKFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:43 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)) 06:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:43 INFO - Running setup.py (path:/tmp/pip-paEp0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:44 INFO - Running setup.py (path:/tmp/pip-n2edxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:44 INFO - Running setup.py (path:/tmp/pip-X6LZcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:44 INFO - Running setup.py (path:/tmp/pip-EIZ0uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:44 INFO - Running setup.py (path:/tmp/pip-ltpquI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:44 INFO - Running setup.py (path:/tmp/pip-bvI3ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:44 INFO - Running setup.py (path:/tmp/pip-qgJaci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:44 INFO - Running setup.py (path:/tmp/pip-LDKIxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:44 INFO - Running setup.py (path:/tmp/pip-M52PZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:44 INFO - Running setup.py (path:/tmp/pip-aR2I4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:44 INFO - Running setup.py (path:/tmp/pip-IxT9Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:44 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)) 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:44 INFO - Running setup.py (path:/tmp/pip-EukZl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:44 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)) 06:11:44 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)) 06:11:44 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)) 06:11:44 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)) 06:11:44 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)) 06:11:44 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)) 06:11:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:44 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 06:11:44 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 06:11:44 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 06:11:44 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 06:11:44 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 06:11:44 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 06:11:46 INFO - Downloading blessings-1.6.tar.gz 06:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:11:46 INFO - Installing collected packages: blessings 06:11:46 INFO - Running setup.py install for blessings 06:11:46 INFO - Successfully installed blessings 06:11:46 INFO - Cleaning up... 06:11:46 INFO - Return code: 0 06:11:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:47 INFO - Reading from file tmpfile_stdout 06:11:47 INFO - Current package versions: 06:11:47 INFO - argparse == 1.2.1 06:11:47 INFO - blessings == 1.6 06:11:47 INFO - blobuploader == 1.2.4 06:11:47 INFO - docopt == 0.6.1 06:11:47 INFO - functools32 == 3.2.3-2 06:11:47 INFO - jsonschema == 2.5.1 06:11:47 INFO - manifestparser == 1.1 06:11:47 INFO - mozInstall == 1.12 06:11:47 INFO - mozcrash == 0.17 06:11:47 INFO - mozdebug == 0.1 06:11:47 INFO - mozdevice == 0.48 06:11:47 INFO - mozfile == 1.2 06:11:47 INFO - mozhttpd == 0.7 06:11:47 INFO - mozinfo == 0.9 06:11:47 INFO - mozleak == 0.1 06:11:47 INFO - mozlog == 3.3 06:11:47 INFO - moznetwork == 0.27 06:11:47 INFO - mozprocess == 0.23 06:11:47 INFO - mozprofile == 0.28 06:11:47 INFO - mozrunner == 6.12 06:11:47 INFO - mozscreenshot == 0.1 06:11:47 INFO - mozsystemmonitor == 0.3 06:11:47 INFO - moztest == 0.7 06:11:47 INFO - mozversion == 1.4 06:11:47 INFO - psutil == 3.1.1 06:11:47 INFO - requests == 1.2.3 06:11:47 INFO - wsgiref == 0.1.2 06:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:47 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:47 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 06:11:47 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 06:11:47 INFO - Using env: {'DISPLAY': ':0', 06:11:47 INFO - 'HOME': '/home/cltbld', 06:11:47 INFO - 'LANG': 'en_US.UTF-8', 06:11:47 INFO - 'LANGUAGE': 'en_US:en', 06:11:47 INFO - 'LOGNAME': 'cltbld', 06:11:47 INFO - 'MAIL': '/var/mail/cltbld', 06:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:47 INFO - 'MOZ_NO_REMOTE': '1', 06:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:47 INFO - 'NO_EM_RESTART': '1', 06:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:47 INFO - 'PWD': '/builds/slave/test', 06:11:47 INFO - 'SHELL': '/bin/bash', 06:11:47 INFO - 'SHLVL': '1', 06:11:47 INFO - 'TERM': 'linux', 06:11:47 INFO - 'TMOUT': '86400', 06:11:47 INFO - 'USER': 'cltbld', 06:11:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:47 INFO - '_': '/tools/buildbot/bin/python'} 06:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 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)) 06:11:47 INFO - Cleaning up... 06:11:47 INFO - Return code: 0 06:11:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:47 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 0x218c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, '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': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', '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 06:11:47 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 06:11:47 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 06:11:47 INFO - Using env: {'DISPLAY': ':0', 06:11:47 INFO - 'HOME': '/home/cltbld', 06:11:47 INFO - 'LANG': 'en_US.UTF-8', 06:11:47 INFO - 'LANGUAGE': 'en_US:en', 06:11:47 INFO - 'LOGNAME': 'cltbld', 06:11:47 INFO - 'MAIL': '/var/mail/cltbld', 06:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:47 INFO - 'MOZ_NO_REMOTE': '1', 06:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:47 INFO - 'NO_EM_RESTART': '1', 06:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:47 INFO - 'PWD': '/builds/slave/test', 06:11:47 INFO - 'SHELL': '/bin/bash', 06:11:47 INFO - 'SHLVL': '1', 06:11:47 INFO - 'TERM': 'linux', 06:11:47 INFO - 'TMOUT': '86400', 06:11:47 INFO - 'USER': 'cltbld', 06:11:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:47 INFO - '_': '/tools/buildbot/bin/python'} 06:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:11:47 INFO - Cleaning up... 06:11:47 INFO - Return code: 0 06:11:47 INFO - Running post-action listener: _resource_record_post_action 06:11:47 INFO - Running post-action listener: _start_resource_monitoring 06:11:47 INFO - Starting resource monitoring. 06:11:47 INFO - [mozharness: 2016-08-11 13:11:47.636913Z] Finished create-virtualenv step (success) 06:11:47 INFO - [mozharness: 2016-08-11 13:11:47.637348Z] Running install step. 06:11:47 INFO - Running pre-action listener: _resource_record_pre_action 06:11:47 INFO - Running main action method: install 06:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:47 INFO - Reading from file tmpfile_stdout 06:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 06:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:11:47 INFO - Reading from file tmpfile_stdout 06:11:47 INFO - Output received: 06:11:47 INFO - Usage: mozinstall [options] installer 06:11:47 INFO - Options: 06:11:47 INFO - -h, --help show this help message and exit 06:11:47 INFO - -d DEST, --destination=DEST 06:11:47 INFO - Directory to install application into. [default: 06:11:47 INFO - "/builds/slave/test"] 06:11:47 INFO - --app=APP Application being installed. [default: firefox] 06:11:47 INFO - mkdir: /builds/slave/test/build/application 06:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:12:04 INFO - Reading from file tmpfile_stdout 06:12:04 INFO - Output received: 06:12:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:04 INFO - Running post-action listener: _resource_record_post_action 06:12:04 INFO - [mozharness: 2016-08-11 13:12:04.830368Z] Finished install step (success) 06:12:04 INFO - [mozharness: 2016-08-11 13:12:04.830702Z] Running run-tests step. 06:12:04 INFO - Running pre-action listener: _resource_record_pre_action 06:12:04 INFO - Running main action method: run_tests 06:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:04 INFO - Python 2.7.3 06:12:04 INFO - Return code: 0 06:12:04 INFO - grabbing minidump binary from tooltool 06:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:04 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 0x244b3b0>, '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 0x244c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:04 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 06:12:04 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 06:12:04 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 06:12:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:04 INFO - Return code: 0 06:12:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:04 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/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:12:04 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/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 06:12:04 INFO - Using env: {'DISPLAY': ':0', 06:12:04 INFO - 'HOME': '/home/cltbld', 06:12:04 INFO - 'LANG': 'en_US.UTF-8', 06:12:04 INFO - 'LANGUAGE': 'en_US:en', 06:12:04 INFO - 'LOGNAME': 'cltbld', 06:12:04 INFO - 'MAIL': '/var/mail/cltbld', 06:12:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:04 INFO - 'MOZ_NO_REMOTE': '1', 06:12:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:04 INFO - 'NO_EM_RESTART': '1', 06:12:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:04 INFO - 'PWD': '/builds/slave/test', 06:12:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:04 INFO - 'SHELL': '/bin/bash', 06:12:04 INFO - 'SHLVL': '1', 06:12:04 INFO - 'TERM': 'linux', 06:12:04 INFO - 'TMOUT': '86400', 06:12:04 INFO - 'USER': 'cltbld', 06:12:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470921074.100390-1790252715', 06:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:04 INFO - '_': '/tools/buildbot/bin/python'} 06:12:04 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/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:12:05 INFO - mozversion application_buildid: 20160811030201 06:12:05 INFO - mozversion application_changeset: 0502bd9e025edde29777ba1de4280f9b52af4663 06:12:05 INFO - mozversion application_display_name: Nightly 06:12:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:05 INFO - mozversion application_name: Firefox 06:12:05 INFO - mozversion application_remotingname: firefox 06:12:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:12:05 INFO - mozversion application_vendor: Mozilla 06:12:05 INFO - mozversion application_version: 51.0a1 06:12:05 INFO - mozversion platform_buildid: 20160811030201 06:12:05 INFO - mozversion platform_changeset: 0502bd9e025edde29777ba1de4280f9b52af4663 06:12:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:12:05 INFO - mozversion platform_version: 51.0a1 06:12:05 INFO - using testdate: 1470921125 06:12:05 INFO - actual date: 1470921125 06:12:05 INFO - starting webserver on 'localhost:40102' 06:12:05 INFO - SUITE-START | Running 2 tests 06:12:05 INFO - TEST-START | dromaeo_css 06:12:05 INFO - operating with platform_type : linux_ 06:12:05 INFO - Initialising browser for dromaeo_css test... 06:12:05 INFO - TEST-INFO | started process 25618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZ_XkL/profile http://localhost:40102/getInfo.html) 06:12:09 INFO - PROCESS | 25618 | __metrics Screen width/height:1600/1200 06:12:09 INFO - PROCESS | 25618 | colorDepth:24 06:12:09 INFO - PROCESS | 25618 | Browser inner width/height: 1024/697 06:12:09 INFO - PROCESS | 25618 | __metrics 06:12:10 INFO - PROCESS | 25618 | 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:12:10 INFO - PROCESS | 25618 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:11 INFO - TEST-INFO | 25618: exit 0 06:12:11 INFO - Browser initialized. 06:12:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:11 INFO - TEST-INFO | started process 25700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZ_XkL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:23 INFO - PROCESS | 25700 | RSS: Main: 155611136 06:12:23 INFO - PROCESS | 25700 | 06:13:14 INFO - PROCESS | 25700 | 1470921194318 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] 06:15:24 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40102/tests/dromaeo/cssquery-ext.html) 06:15:25 INFO - PROCESS | 25700 | RSS: Main: 288862208 06:15:25 INFO - PROCESS | 25700 | 06:18:27 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-ext.html (next: http://localhost:40102/tests/dromaeo/cssquery-jquery.html) 06:18:28 INFO - PROCESS | 25700 | RSS: Main: 244285440 06:18:28 INFO - PROCESS | 25700 | 06:21:30 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40102/tests/dromaeo/cssquery-mootools.html) 06:21:30 INFO - PROCESS | 25700 | RSS: Main: 183128064 06:21:30 INFO - PROCESS | 25700 | 06:24:32 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40102/tests/dromaeo/cssquery-prototype.html) 06:24:33 INFO - PROCESS | 25700 | RSS: Main: 215343104 06:24:33 INFO - PROCESS | 25700 | 06:27:36 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40102/tests/dromaeo/cssquery-yui.html) 06:27:36 INFO - PROCESS | 25700 | RSS: Main: 184270848 06:27:36 INFO - PROCESS | 25700 | 06:30:39 INFO - PROCESS | 25700 | Cycle 1(1): loaded http://localhost:40102/tests/dromaeo/cssquery-yui.html (next: http://localhost:40102/tests/dromaeo/cssquery-dojo.html) 06:30:40 INFO - PROCESS | 25700 | RSS: Main: 276119552 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | __start_tp_report 06:30:40 INFO - PROCESS | 25700 | _x_x_mozilla_page_load 06:30:40 INFO - PROCESS | 25700 | _x_x_mozilla_page_load_details 06:30:40 INFO - PROCESS | 25700 | |i|pagename|runs| 06:30:40 INFO - PROCESS | 25700 | |0;dojo.html;3065.3256283617607;3086.8456577171137;3111.1288839125054;3112.3775244951007;3126.5310203469476;5334.333208348957;5387.622866399353;5430.75561599728;5453.154761012044;5471.945280547188;5324.600654950875;5426.050441172799;5454.7272636368225;5478.369987451444;5512.834614961557;4830.6135509159185;4862.635302352338;4863.270509423588;4897.2898929655175;5052.418971818232;4980.402351717799;4980.576650984671;4998.60011199105;4999.4250661174065;4999.8000079996755;4708.152532544141;4745.359376484165;4746.620270378361;4964.106460837048;4981.626378021645;4784.928226076611;4784.976075119637;4787.0904528139545;4790.6886052406835;4793.400824896888;4755.714657120584;4765.928511072337;4799.28010798383;4829.637777166727;4864;5319.840404787824;5325.147976323769;5371.57027437804;5395.406505284415;5445.401005889349;5709.971450142764;5765.423457654243;5821.67980761058;5831.2127862738835;5836.474717275466;5737.08206686928;5765.798197063083;5816.360200377955;5912.615679980788;5920.822375328704;5443.673379597237;5486.067368547357;5501.477359650827;5506.614536982373;5507.284053073075;5829.76680932758;6014.0678194879865;6026.789062382795;6028.336882942873;6031.035034394564;5598.608097433141;5608.1027035674915;5625.521830644359;5704.71476426177;5738.512226460798;5717.456841600041;5788.855278618068;5801.593888427769;5801.6519008859605;5804.593678442553;5728.484436400744;5734.111212762028;5743.712814359349;5748.080307150836;5755.597108202385;5632.493075623213;5651.463111004448;5701.572382071361;5741.88516229673;5751.367349591542;4330.891727706769;4370.169667763115;4374.5625437456;4389.802458889358;4414.933775993362;3902;3916.686665066788;3926.3521518949624;3937.724359294822;3952.8616498422416;5310.893782124336;5348.598855085884;5438.265834112423;5453.15476101205;5511.173324001352;5895.911561326584;5896.204012458264;5902.2327097477055;5922.318933322723;5927.8221653350465;5518.255035570227;5522.22688823565;5526.613137080446;5529.640573362719;5532.419095994943;4851.854444366674;4910.680805747615;4931.3589233399425;4972.875678108004;5023.372078490189;6060.878782424239;6061.454469097803;6094.11635312886;6095;6112.786052488231;5847.26909136358;5850.678212698343;5858.150568167677;5861.560382971379;5875.441833025856;5844.327902291291;6001.9496588096035;6068.696565171812;6072.635641861502;6079.452849243589;5747.023006088892;5787.826365209051;5789.986752318412;5814.418558144321;5828.562857785599;5852.385499522659;5891.116332550152;5906.793262235801;5907.3501914790195;5919.733611987384;5593.524550413098;5657.32112146545;5674.886502270014;5787.94212057874;5810.854728631818;5728.513076388554;5730.312362516524;5734.3978882218435;5758.366579676316;5781.103928891029;5713.857153571194;5726.656400615976;5729.312482502127;5729.627574207663;5741.598088133791;5493.313335833021;5686.374498805046;5692.373838877637;5817.738201780845;5824.912626310694;5633.549316054624;5640;5644.548436125182;5644.548436125182;5694.715264236689 06:30:40 INFO - PROCESS | 25700 | |1;ext.html;586.299372250161;604.1511676095085;608.5283904973645;614.4469977020678;628.1080865171456;32073.67926320739;43018.78490607547;43733.12533749323;43971.99999999996;44022;45764;46104.76947615257;46111.76944115283;46187;46192.3071153933;9007.414518056321;9159.954200228989;9160.816783664322;9166.312526560501;9167.541622918861;9028.729138125867;9091.454512729224;9122.452652840851;9123.498207598579;9123.498207598579;9105.590248438835;9142;9151.816963660724;9156.8626470603;9158;9080.182783549479;9125.406848554823;9126.13301736334;9134;9138.588763505591;8897.688580899638;8911.064338244521;8987.955060224722;8995.100489951017;9036;43629.345559816626;43729.344059839124;43912.780436097935;43945.12109757787;44107.338389924174;3658.70730341572;3707.888763337104;3785.6403641653997;3786.5266841644793;3896.7467114637457;33151;33726.66273337285;33951.6604833951;33989.320213595835;34187;3329.9833500832583;3364.2094107884627;3430.8627654893776;3434.5019972103905;3698.7965661888584;331999;333387;333942;334203;335100.3244983784;60244.69877650584;60564;60701.696491518145;60740.69629651823;60837.391626083176;64252.357476425575;64313.67843160754;64319.356806432275;64348;64364;15024.17367044823;15280.541583752505;15327.080375177526;15330.233488325539;15330.770038449433;11760.353180574979;11951.820722689166;11982.700432489084;12034.398280085961;12035.217710848767;17102.57956695681;18227.908860455613;18636.813631863508;18704.719429208573;18874.716879246822;5706.4864162225595;6419.5876907080365;6631.23740769808;6716.764913228014;6720.899186512206;1039.302353362811;1050.495762034228;1118.0384869012642;1147.386148410613;1239.0521251242806;32795;33102.3379532408;33275.33449331;33298.500522492184;33529.83235083809;1110.5779803674552;1121.2991880074953;1140.1164097824087;1182.3674334231146;1273.1724379153625;17372.131393430278;17424.303027878996;17573.560660983578;17574.29702811899;17619.647607047787;521474;526113;527882;527897;529839;60871;61040.38959610436;61183;61269;61340.07989880155;1243.738814848892;1277.5464710027993;1325.2379881567945;1363.9931800341133;1414.5261337451864;29997.666903285834;34373;34456.31087378289;34458.31083378368;34654.306913862085;50800;51408.22887656763;51449;51528;51535.226971594704;395483;396460;397084;397246;397958;29076.982305619204;29813.850930745208;30002.399952001273;31684.36631267408;41226.58773412347;47261;47417;48461.5153848457;51133.7443312781;51314.74342628263;40148.598514014484;41804.372934406616;43027.784861075495;44530.55469445264;45171.7741411304;42428.787856060524;45016.0996780056;45773.77113114413;46014.769926150155;46507;45763;46250.53749462462;46956.530434696586;47092.7645361771;47117.52882471131;41727.37408938929;43670.56329436665;44088.338674920546;45267.320990185835;45405.54594454145;27189.456210876066;29158.562621560268;30042;30052.398952021274;30284.394312114076 06:30:40 INFO - PROCESS | 25700 | |2;jquery.html;365.7476341324484;381.6660770606729;383.313868175965;384.73453317211124;410.5094412177447;17492.825071749277;19752.209911603535;19786.10962506687;19917.10373033213;20123.19507219713;15987.200639968014;16319.10244936528;16338.918305408457;17763.46709598714;20045.699314510293;5699.116636921263;5704.3154821421385;5919.822405327847;5927.703614819242;5932.495737862287;5780.4797568218855;5901.4098590141075;5903.852403689921;5904.7342869570975;5909.11363295507;5566.081596536566;5746.109353050263;5822.039363505017;5833.416658334154;5838.649681019152;5775.537956963432;5800.013997620394;5834.97082514589;5841.620294680833;5850.6782126983;5021.799128034874;5099.4900509949075;5169.586433085344;5216.947830521684;5218.739063046833;24165.758342416702;24185.758142418526;24448.87775561111;24581.38546536351;24655.630165547533;2462.4090218347646;2555.642210090589;2581;3025.848707564635;3122.8438578071004;15172.924135379362;15273.541793746093;15420.836955171986;15427.768583471257;15872.20638968047;1899.705545640428;1951.756030496188;1959.657060014506;2000.21991423345;2040.36748607932;78752;79986.20013799846;80671.59664201642;81426;92754.53622731843;11409.858325262872;11575.942120289514;11810.76378472443;11835.704107397383;11972.102092342935;16407;16417.58956026109;16438;16447.424340148038;16457;8105.554194519358;8339.916600834036;8353.916460835313;8507.65969361231;8569.442986206;7837.843243135106;7915.12933577306;7915.564643944638;8138.145494722969;8170.14213507585;4899.657024008286;4949.381327334083;5006.874828129326;5057.544820966131;5118.129917913963;1931.642646110474;2024.9797502025085;2046.2326627514683;2061.9587608247753;2085.697573851783;899.7210864631985;985.2315194148575;1036.259074761549;1044.8798388185303;1068.1294744782977;20338.237426076223;20894.895525522275;20999.16003359879;21090.261840835497;21259.46851328729;993.2600212841479;994.3636072913341;1002.04304888831;1043.4834756795283;1096.1450068946235;11024.393658348868;11390.943045284721;11601.07191424684;11663.59177428786;11673.124515661359;474177;476831;477757;478120;490721;80548;90005.54997224972;91310.54344728366;91730.54134729283;93073;953.1993125774244;987.086944576264;1002.5939494504737;1003.8745156855393;1014.5333146752429;17665.558361041076;18184.727229091837;18446.81553184451;18484.907575462035;18528.258869645062;36900;37588.62411375851;40799.38800918048;42067.36898946457;43744.34383484314;54928.17607735967;55257;55413.44586554083;55622.54599087204;56852.1472177926;8432.662693492191;8463.66145354179;8551.444156129832;8653.61058752345;8762.474251544927;9403.34176607631;12932.612021639367;13078.80381794293;13227.272500012592;13397.196168229937;11427.257228280136;11437.331322432172;11648.475818588353;11760.411979400824;12125.81811272814;11105.666829995112;11462.885371146182;11536.192466527262;11590.594329198437;11848.170628055954;11474.827877581676;11870.347130907883;12128.393580320771;12238.02095832349;12424.316662583284;7732.420068494998;8009.959950200445;8040.798980025546;8433.241008309282;8565.443246188977;10822.980981427694;11936.880631193577;12095.334756588472;12107.878921211028;12165.45255463524 06:30:40 INFO - PROCESS | 25700 | |3;mootools.html;1301.1932601786893;1434.7417464856328;1502.5191938579655;1642.162497126465;1784.6341499992502;8240.217179367957;8354.540500272482;8398.20217079378;8685.47887126773;8728.127187281269;8367.623456944437;8493.065762766106;8494.702685406011;8500.61747221375;8526.616302266397;2342.180236917078;2367.4791545859885;2367.7987371073477;2368.3723813189517;2370.5969985102574;2246.1913711064003;2285.702858628376;2306.9653955190684;2308.7922087012166;2308.9191878284264;2306.5041016181603;2326.697529321186;2333.731620863597;2345.483993521431;2350.083467447697;2270.0579259607325;2274.0108052996834;2278.4417817634703;2278.624027035537;2281.8973146208377;2277.6697378880135;2282.132789539964;2284.7601001894727;2284.977150228493;2285.6685780561725;8424.031236407769;8495.74512764618;8497.447665901696;8505.149485051506;8779.868301975412;5063.569596584295;5260.8684782880355;5266.815661451831;5267.0256002639635;5271.472852714736;3395.3718562066097;3460.619331873492;3460.8269586520573;3498.247876706495;3500.842462089212;1099.087757161562;1108.107973081669;1119.8208286674094;1124.3085502416036;1125.983110253347;12074.939625301906;12121.575744848977;12124.090693198046;12183.269003859798;12199.939000304941;4203.873883783492;4471.955280447154;4482.013956929471;4586.587207151372;4607.193741095295;9710.514474276259;9728.61085556584;9735.367201131903;9735.951320243354;9738.074882886114;5132.666376685504;5139.974300128475;5142.922856157161;5144.254083157921;5144.665596736275;4113.8971525712095;4210.389493523422;4342.196693611692;4765.547273009059;4813.855584332476;3586.1393265616584;3593.9101522462147;3688.299223147647;3698.1679122197293;3778.527684039495;1073.7745073534645;1103.9834402483968;1107.4905543449943;1114.2089116727052;1121.159130652011;951.900050494702;983.1250187333279;984.3847595252967;997.2819569909653;1012.3824467075078;5771.595988280864;5917.497012753965;5957.6127551709;5979.730912108878;6029.517638588903;947.1049857884371;959.947202903833;980.8185485685171;993.2103977337889;1033.751899544119;4070.287699652549;4338.219120558267;4346.152500262482;4364.956350436519;4483.641308695296;10779;11030.944845275722;11109;11149.21955463126;11198.552057917592;10224.28430009907;10513.57945682164;11031.613893513688;11050.778984420267;11051.17116216287;8199.508029518249;8328.333733301442;8377.45546539473;8409.789755256168;8416.074231834493;6151.108089327112;6175.197224360804;6255.218097737783;6317;6322.083297921684;9596.088371604686;9861.901380986099;10051.949740251544;10210.43842588635;10354.068133867988;10180.083792458418;10277.81805092424;10339.327943683636;10437.68686939393;10444.216683748597;6843.213030501357;7666.884996724942;7934.20657934202;8027.39794515402;8120.187981201832;8506.74479765608;8787.472751634923;8788.07725188846;8799.868001980103;8824.073472285318;7550.471466997257;7721.227877212234;7824.139344671968;7845.843083138419;7944;7545.584992825227;7661.540307581563;7680.69277228927;7710.1133369660965;7919.920800791919;7034.5427547209265;7126.857462850818;7129.215786263403;7131.25121862197;7133.39366153862;5207.505286997729;5264.921026184534;5407.540359069366;5418.864528386822;5709.34342550612;5359.356877174764;5388.784448622011;5436.211749296251;5460.453954604508;5601.411851755507 06:30:40 INFO - PROCESS | 25700 | |4;prototype.html;325.2097403309956;329.99340013199736;337.29000454044234;337.87836378903603;341.6208009109889;5184.429712731597;5264.89470210596;5266.631335806495;5305.867353316169;5319.760610772515;5265.526102650761;5291.153415453528;5297.099493086175;5305.310309659739;5311.097113490716;4131.0911599448145;4146.5853414658595;4166.354215096665;4173.227952828721;4217.493900731916;3988.9202215955665;4149.792510374485;4169.603887630686;4195.307774217251;4197.677731514563;4134.50385953686;4134.813933373005;4137.565555616662;4154.127633197032;4155.937660935073;4106.733062350938;4115.670746340285;4118.588141185887;4138.4413104231;4155.958440415588;3656.122530592665;3662.8717994870317;3673.5775385830702;3677.8161091945294;3681.2821499807546;5138.845834624967;5179.326687530634;5190.11767999441;5213.635045546814;5217.16525355945;4702.106599746037;4716.9292460613115;4727.692699974491;4741.336212930192;4754;5480.438075148563;5486.643368181056;5502.312210973629;5509.614326997112;5539.833804985857;3794.772313661189;3974.7813870237123;3985.3025720498795;4003.939940900889;4006.1787333596544;5687.118496633028;5716.885662286731;5718.485336319751;5723.313202415695;5734.942650573483;4059.6955228357992;4084.7753373564146;4085.1216988347055;4085.3463445849115;4087.9984403821254;4023.9195216095513;4128.256913755553;4199.958000420018;4209.368594710818;4240.38514415408;4737.478877323491;4744.1934871072;4757.215059515142;4760.429058410716;4768.7615619218905;5557.6109672323355;5576.498115169654;5591.574148592164;5609.970615867386;5626.662400255997;1329.654289884637;1388.2503448138095;1457.0966001079398;1460.4231328625347;1473.4990103364908;1017.2116609627598;1021.8875923648542;1033.4109557552274;1046.5813674530098;1049.4992161209543;5280.3663560373;5288.2596436498925;5320.388155362183;5325.786968521294;5328.387235467893;5643.971780141155;5646.463585959327;5657.51911087554;5679.5172410345585;5736.942630573724;5135.666181698178;5214.374275087014;5264.868378290496;5325.387580428301;5371.435999220103;2626.448445826398;2637.7470701416673;2638.7465953672236;2658.534756417619;2669.2125822882294;5056.82301119459;5143.331366922351;5189.949969761923;5195.272661827347;5205.583553315726;5083.186690129562;5093.388793344822;5429.859729456858;5820.563457740602;5850;5882.382349853289;5883.9703051965735;5904.852378690482;5907.940920590739;5915.201447804491;5479.726013699379;5691.203231547669;5711;5711.457411545896;5716.399778023248;5570.192322113352;5610.943890561205;5637.182608521824;5645.322561292671;5673.319201695823;5829.921464529076;5901.0558310670085;5925.348211696796;5933.258342707161;5940.79207227745;3821.4840996466232;3928.7053470990363;4043.433919251366;4063.9796801016987;4086.6526345260986;5621.8594535136945;5638.2670252866865;5689.914651280317;5705.971470142623;5713;5582.720863956867;5603.917845185213;5605.439456054362;5605.467480589337;5642.548596112383;5330.8933821324135;5571.916421253765;5587.547237718141;5593.804216852391;5603.719814009365;5545.805896793593;5548.890221955544;5565.693886836263;5571.303587051619;5593.776248950159;5341.943351809504;5602.971985140048;5605.383407825055;5634.661920284796;5646.576506761927;5496.422875598005;5517.117261238182;5518.558515318685;5527.751251193626;5531.3362396512675 06:30:40 INFO - PROCESS | 25700 | |5;yui.html;761.1969372312212;764.9847003059939;771.2287712287712;804.3725893802834;858.5621333120115;15606.531804045882;16792.412265570707;16797.412090576832;16816.32734690614;16818.747718784212;15285.388584456608;15393.615159620987;15407.84592154081;15409.614759631015;15461.845381546209;643.2731013954225;758.5827794712914;796.9521828690283;810.9594520273993;813.8168911994784;801.3669201330941;804.5012092502657;810.0441479054713;810.5744484145841;810.7689308547066;860.6213266162869;862.6678728689437;862.9223369896708;863.3093525179862;863.5509535041774;689.2246222999152;825.5913322905141;856.374846362156;857.1899554920602;859.660434128522;633.66732465456;633.936606339367;634.0710858592184;634.0805831544279;634.112242859995;14395.352209150613;14419.35112919921;14443.927780361137;14449.855501444956;14471.42114315426;14382.92808535961;14684.559463216014;14962.850371496255;14992.850071499255;15146.621334466616;13759.518416855462;13815.930920345434;13845.307734613229;13920.09519381247;14089.225092619901;4387.736735795863;4400.581944715247;4433.689641725081;4567.406237189144;4588.88527786808;80780.59609701972;80791.59604202;82339.5883020587;82339.5883020587;87552.56223718841;11120.38837863909;11513.827292590619;11519.596814111466;11601.303921764722;11847.348395838311;20234.494137646383;20254.69617955732;20286.797132028492;20302.390928272176;20345.084471198832;8939.150780675825;8953.59708813105;9001.504917229615;9088.81822363549;9156.359054866096;4784.497627749036;4802.399700037496;4862.5380588844;5013.699178049329;5147.356580427447;3372.106391806173;3467.6358982306997;3492.318997795456;3494.930101397958;3497.632748561415;560.6019725994589;573.5812856614612;576.7635269539553;583.201014609987;583.2243116654839;693.8022663540968;704.8731228378941;725.5175308419947;737.9631018449056;744.6909532544042;9669.468179250209;9681.757956051155;9811.656592019244;9816.128276570147;10010.299279050396;583.7139801497236;596.7659456158634;639.3861892583079;649.3344322069917;716.1299021688674;4524.932126018112;4613.95386046142;4741.5495527924795;4779.5220477951925;4783.306420568998;67481.3251867475;91607.54196228976;120116;123468;127050;108232.4588377053;110319.44840275747;111138.44430777956;111645;115876.42061789805;62708;89602.55198723964;91412.54293728489;91774;96107;8524.9343832021;8701.695440659547;8800.339974502065;8807;8879.866801997847;54941;55102.173467398825;56498.71750641385;56836;57559.71220143873;78518.6074069626;81172;83529.58235208785;83741;85996;11752.060909949763;12055;12061.758764824479;12315.13794034409;12514.639617285566;14433.566992990227;14685.48600798967;14901.701965960838;15598.454054108051;15659.217039148225;14676.119432833637;14784.852151478348;15003.774943376076;15285.847141528442;15485.767713484533;14588.927055364655;14754.778678320048;14875.851241487446;15205.239738012833;15647.921760391126;13919.512817051354;13966.1936165656;14046.508372206923;14075.788863167265;14407.927960360132;11739.765204696028;11985.580504682293;12060;12377.306439038144;12570.371481426075;12116.21244619097;12417.557876975829;12532.749345013232;12718;12746.808797867854 06:30:40 INFO - PROCESS | 25700 | __end_tp_report 06:30:40 INFO - PROCESS | 25700 | __start_cc_report 06:30:40 INFO - PROCESS | 25700 | _x_x_mozilla_cycle_collect,1210 06:30:40 INFO - PROCESS | 25700 | __end_cc_report 06:30:40 INFO - PROCESS | 25700 | __startTimestamp1470922240023__endTimestamp 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | ------- Summary: start ------- 06:30:40 INFO - PROCESS | 25700 | Number of tests: 6 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#0] dojo.html Cycles:165 Average:5390.38 Median:5640.00 stddev:643.89 (11.4%) stddev-sans-first:619.50 06:30:40 INFO - PROCESS | 25700 | Values: 3065.3 3086.8 3111.1 3112.4 3126.5 5334.3 5387.6 5430.8 5453.2 5471.9 5324.6 5426.1 5454.7 5478.4 5512.8 4830.6 4862.6 4863.3 4897.3 5052.4 4980.4 4980.6 4998.6 4999.4 4999.8 4708.2 4745.4 4746.6 4964.1 4981.6 4784.9 4785.0 4787.1 4790.7 4793.4 4755.7 4765.9 4799.3 4829.6 4864.0 5319.8 5325.1 5371.6 5395.4 5445.4 5710.0 5765.4 5821.7 5831.2 5836.5 5737.1 5765.8 5816.4 5912.6 5920.8 5443.7 5486.1 5501.5 5506.6 5507.3 5829.8 6014.1 6026.8 6028.3 6031.0 5598.6 5608.1 5625.5 5704.7 5738.5 5717.5 5788.9 5801.6 5801.7 5804.6 5728.5 5734.1 5743.7 5748.1 5755.6 5632.5 5651.5 5701.6 5741.9 5751.4 4330.9 4370.2 4374.6 4389.8 4414.9 3902.0 3916.7 3926.4 3937.7 3952.9 5310.9 5348.6 5438.3 5453.2 5511.2 5895.9 5896.2 5902.2 5922.3 5927.8 5518.3 5522.2 5526.6 5529.6 5532.4 4851.9 4910.7 4931.4 4972.9 5023.4 6060.9 6061.5 6094.1 6095.0 6112.8 5847.3 5850.7 5858.2 5861.6 5875.4 5844.3 6001.9 6068.7 6072.6 6079.5 5747.0 5787.8 5790.0 5814.4 5828.6 5852.4 5891.1 5906.8 5907.4 5919.7 5593.5 5657.3 5674.9 5787.9 5810.9 5728.5 5730.3 5734.4 5758.4 5781.1 5713.9 5726.7 5729.3 5729.6 5741.6 5493.3 5686.4 5692.4 5817.7 5824.9 5633.5 5640.0 5644.5 5644.5 5694.7 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#1] ext.html Cycles:180 Average:59513.07 Median:43822.95 stddev:112849.12 (257.5%) stddev-sans-first:113078.96 06:30:40 INFO - PROCESS | 25700 | Values: 586.3 604.2 608.5 614.4 628.1 32073.7 43018.8 43733.1 43972.0 44022.0 45764.0 46104.8 46111.8 46187.0 46192.3 9007.4 9160.0 9160.8 9166.3 9167.5 9028.7 9091.5 9122.5 9123.5 9123.5 9105.6 9142.0 9151.8 9156.9 9158.0 9080.2 9125.4 9126.1 9134.0 9138.6 8897.7 8911.1 8988.0 8995.1 9036.0 43629.3 43729.3 43912.8 43945.1 44107.3 3658.7 3707.9 3785.6 3786.5 3896.7 33151.0 33726.7 33951.7 33989.3 34187.0 3330.0 3364.2 3430.9 3434.5 3698.8 331999.0 333387.0 333942.0 334203.0 335100.3 60244.7 60564.0 60701.7 60740.7 60837.4 64252.4 64313.7 64319.4 64348.0 64364.0 15024.2 15280.5 15327.1 15330.2 15330.8 11760.4 11951.8 11982.7 12034.4 12035.2 17102.6 18227.9 18636.8 18704.7 18874.7 5706.5 6419.6 6631.2 6716.8 6720.9 1039.3 1050.5 1118.0 1147.4 1239.1 32795.0 33102.3 33275.3 33298.5 33529.8 1110.6 1121.3 1140.1 1182.4 1273.2 17372.1 17424.3 17573.6 17574.3 17619.6 521474.0 526113.0 527882.0 527897.0 529839.0 60871.0 61040.4 61183.0 61269.0 61340.1 1243.7 1277.5 1325.2 1364.0 1414.5 29997.7 34373.0 34456.3 34458.3 34654.3 50800.0 51408.2 51449.0 51528.0 51535.2 395483.0 396460.0 397084.0 397246.0 397958.0 29077.0 29813.9 30002.4 31684.4 41226.6 47261.0 47417.0 48461.5 51133.7 51314.7 40148.6 41804.4 43027.8 44530.6 45171.8 42428.8 45016.1 45773.8 46014.8 46507.0 45763.0 46250.5 46956.5 47092.8 47117.5 41727.4 43670.6 44088.3 45267.3 45405.5 27189.5 29158.6 30042.0 30052.4 30284.4 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#2] jquery.html Cycles:180 Average:28858.78 Median:2803.42 stddev:79029.15 (2819.0%) stddev-sans-first:79221.89 06:30:40 INFO - PROCESS | 25700 | Values: 365.7 381.7 383.3 384.7 410.5 17492.8 19752.2 19786.1 19917.1 20123.2 15987.2 16319.1 16338.9 17763.5 20045.7 5699.1 5704.3 5919.8 5927.7 5932.5 5780.5 5901.4 5903.9 5904.7 5909.1 5566.1 5746.1 5822.0 5833.4 5838.6 5775.5 5800.0 5835.0 5841.6 5850.7 5021.8 5099.5 5169.6 5216.9 5218.7 24165.8 24185.8 24448.9 24581.4 24655.6 2462.4 2555.6 2581.0 3025.8 3122.8 15172.9 15273.5 15420.8 15427.8 15872.2 1899.7 1951.8 1959.7 2000.2 2040.4 78752.0 79986.2 80671.6 81426.0 92754.5 11409.9 11575.9 11810.8 11835.7 11972.1 16407.0 16417.6 16438.0 16447.4 16457.0 8105.6 8339.9 8353.9 8507.7 8569.4 7837.8 7915.1 7915.6 8138.1 8170.1 4899.7 4949.4 5006.9 5057.5 5118.1 1931.6 2025.0 2046.2 2062.0 2085.7 899.7 985.2 1036.3 1044.9 1068.1 20338.2 20894.9 20999.2 21090.3 21259.5 993.3 994.4 1002.0 1043.5 1096.1 11024.4 11390.9 11601.1 11663.6 11673.1 474177.0 476831.0 477757.0 478120.0 490721.0 80548.0 90005.5 91310.5 91730.5 93073.0 953.2 987.1 1002.6 1003.9 1014.5 17665.6 18184.7 18446.8 18484.9 18528.3 36900.0 37588.6 40799.4 42067.4 43744.3 54928.2 55257.0 55413.4 55622.5 56852.1 8432.7 8463.7 8551.4 8653.6 8762.5 9403.3 12932.6 13078.8 13227.3 13397.2 11427.3 11437.3 11648.5 11760.4 12125.8 11105.7 11462.9 11536.2 11590.6 11848.2 11474.8 11870.3 12128.4 12238.0 12424.3 7732.4 8010.0 8040.8 8433.2 8565.4 10823.0 11936.9 12095.3 12107.9 12165.5 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#3] mootools.html Cycles:180 Average:5777.17 Median:5098.12 stddev:3273.20 (64.2%) stddev-sans-first:3265.10 06:30:40 INFO - PROCESS | 25700 | Values: 1301.2 1434.7 1502.5 1642.2 1784.6 8240.2 8354.5 8398.2 8685.5 8728.1 8367.6 8493.1 8494.7 8500.6 8526.6 2342.2 2367.5 2367.8 2368.4 2370.6 2246.2 2285.7 2307.0 2308.8 2308.9 2306.5 2326.7 2333.7 2345.5 2350.1 2270.1 2274.0 2278.4 2278.6 2281.9 2277.7 2282.1 2284.8 2285.0 2285.7 8424.0 8495.7 8497.4 8505.1 8779.9 5063.6 5260.9 5266.8 5267.0 5271.5 3395.4 3460.6 3460.8 3498.2 3500.8 1099.1 1108.1 1119.8 1124.3 1126.0 12074.9 12121.6 12124.1 12183.3 12199.9 4203.9 4472.0 4482.0 4586.6 4607.2 9710.5 9728.6 9735.4 9736.0 9738.1 5132.7 5140.0 5142.9 5144.3 5144.7 4113.9 4210.4 4342.2 4765.5 4813.9 3586.1 3593.9 3688.3 3698.2 3778.5 1073.8 1104.0 1107.5 1114.2 1121.2 951.9 983.1 984.4 997.3 1012.4 5771.6 5917.5 5957.6 5979.7 6029.5 947.1 959.9 980.8 993.2 1033.8 4070.3 4338.2 4346.2 4365.0 4483.6 10779.0 11030.9 11109.0 11149.2 11198.6 10224.3 10513.6 11031.6 11050.8 11051.2 8199.5 8328.3 8377.5 8409.8 8416.1 6151.1 6175.2 6255.2 6317.0 6322.1 9596.1 9861.9 10051.9 10210.4 10354.1 10180.1 10277.8 10339.3 10437.7 10444.2 6843.2 7666.9 7934.2 8027.4 8120.2 8506.7 8787.5 8788.1 8799.9 8824.1 7550.5 7721.2 7824.1 7845.8 7944.0 7545.6 7661.5 7680.7 7710.1 7919.9 7034.5 7126.9 7129.2 7131.3 7133.4 5207.5 5264.9 5407.5 5418.9 5709.3 5359.4 5388.8 5436.2 5460.5 5601.4 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#4] prototype.html Cycles:180 Average:4648.12 Median:5264.88 stddev:1365.25 (25.9%) stddev-sans-first:1329.96 06:30:40 INFO - PROCESS | 25700 | Values: 325.2 330.0 337.3 337.9 341.6 5184.4 5264.9 5266.6 5305.9 5319.8 5265.5 5291.2 5297.1 5305.3 5311.1 4131.1 4146.6 4166.4 4173.2 4217.5 3988.9 4149.8 4169.6 4195.3 4197.7 4134.5 4134.8 4137.6 4154.1 4155.9 4106.7 4115.7 4118.6 4138.4 4156.0 3656.1 3662.9 3673.6 3677.8 3681.3 5138.8 5179.3 5190.1 5213.6 5217.2 4702.1 4716.9 4727.7 4741.3 4754.0 5480.4 5486.6 5502.3 5509.6 5539.8 3794.8 3974.8 3985.3 4003.9 4006.2 5687.1 5716.9 5718.5 5723.3 5734.9 4059.7 4084.8 4085.1 4085.3 4088.0 4023.9 4128.3 4200.0 4209.4 4240.4 4737.5 4744.2 4757.2 4760.4 4768.8 5557.6 5576.5 5591.6 5610.0 5626.7 1329.7 1388.3 1457.1 1460.4 1473.5 1017.2 1021.9 1033.4 1046.6 1049.5 5280.4 5288.3 5320.4 5325.8 5328.4 5644.0 5646.5 5657.5 5679.5 5736.9 5135.7 5214.4 5264.9 5325.4 5371.4 2626.4 2637.7 2638.7 2658.5 2669.2 5056.8 5143.3 5189.9 5195.3 5205.6 5083.2 5093.4 5429.9 5820.6 5850.0 5882.4 5884.0 5904.9 5907.9 5915.2 5479.7 5691.2 5711.0 5711.5 5716.4 5570.2 5610.9 5637.2 5645.3 5673.3 5829.9 5901.1 5925.3 5933.3 5940.8 3821.5 3928.7 4043.4 4064.0 4086.7 5621.9 5638.3 5689.9 5706.0 5713.0 5582.7 5603.9 5605.4 5605.5 5642.5 5330.9 5571.9 5587.5 5593.8 5603.7 5545.8 5548.9 5565.7 5571.3 5593.8 5341.9 5603.0 5605.4 5634.7 5646.6 5496.4 5517.1 5518.6 5527.8 5531.3 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - PROCESS | 25700 | [#5] yui.html Cycles:180 Average:21663.67 Median:4677.75 stddev:31295.24 (669.0%) stddev-sans-first:31343.68 06:30:40 INFO - PROCESS | 25700 | Values: 761.2 765.0 771.2 804.4 858.6 15606.5 16792.4 16797.4 16816.3 16818.7 15285.4 15393.6 15407.8 15409.6 15461.8 643.3 758.6 797.0 811.0 813.8 801.4 804.5 810.0 810.6 810.8 860.6 862.7 862.9 863.3 863.6 689.2 825.6 856.4 857.2 859.7 633.7 633.9 634.1 634.1 634.1 14395.4 14419.4 14443.9 14449.9 14471.4 14382.9 14684.6 14962.9 14992.9 15146.6 13759.5 13815.9 13845.3 13920.1 14089.2 4387.7 4400.6 4433.7 4567.4 4588.9 80780.6 80791.6 82339.6 82339.6 87552.6 11120.4 11513.8 11519.6 11601.3 11847.3 20234.5 20254.7 20286.8 20302.4 20345.1 8939.2 8953.6 9001.5 9088.8 9156.4 4784.5 4802.4 4862.5 5013.7 5147.4 3372.1 3467.6 3492.3 3494.9 3497.6 560.6 573.6 576.8 583.2 583.2 693.8 704.9 725.5 738.0 744.7 9669.5 9681.8 9811.7 9816.1 10010.3 583.7 596.8 639.4 649.3 716.1 4524.9 4614.0 4741.5 4779.5 4783.3 67481.3 91607.5 120116.0 123468.0 127050.0 108232.5 110319.4 111138.4 111645.0 115876.4 62708.0 89602.6 91412.5 91774.0 96107.0 8524.9 8701.7 8800.3 8807.0 8879.9 54941.0 55102.2 56498.7 56836.0 57559.7 78518.6 81172.0 83529.6 83741.0 85996.0 11752.1 12055.0 12061.8 12315.1 12514.6 14433.6 14685.5 14901.7 15598.5 15659.2 14676.1 14784.9 15003.8 15285.8 15485.8 14588.9 14754.8 14875.9 15205.2 15647.9 13919.5 13966.2 14046.5 14075.8 14407.9 11739.8 11985.6 12060.0 12377.3 12570.4 12116.2 12417.6 12532.7 12718.0 12746.8 06:30:40 INFO - PROCESS | 25700 | -------- Summary: end -------- 06:30:40 INFO - PROCESS | 25700 | 06:30:40 INFO - TEST-INFO | 25700: exit 0 06:30:40 INFO - TEST-OK | dromaeo_css | took 1115726ms 06:30:40 INFO - TEST-START | kraken 06:30:40 INFO - operating with platform_type : linux_ 06:30:40 INFO - Initialising browser for kraken test... 06:30:40 INFO - TEST-INFO | started process 25898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFuoG8j/profile http://localhost:40102/getInfo.html) 06:30:45 INFO - PROCESS | 25898 | __metrics Screen width/height:1600/1200 06:30:45 INFO - PROCESS | 25898 | colorDepth:24 06:30:45 INFO - PROCESS | 25898 | Browser inner width/height: 1024/697 06:30:45 INFO - PROCESS | 25898 | __metrics 06:30:45 INFO - PROCESS | 25898 | 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:30:45 INFO - PROCESS | 25898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:30:46 INFO - TEST-INFO | 25898: exit 0 06:30:46 INFO - Browser initialized. 06:30:46 INFO - Running cycle 1/1 for kraken test... 06:30:46 INFO - TEST-INFO | started process 25981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFuoG8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:58 INFO - PROCESS | 25981 | RSS: Main: 155279360 06:30:58 INFO - PROCESS | 25981 | 06:31:01 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40102/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:02 INFO - PROCESS | 25981 | RSS: Main: 211230720 06:31:02 INFO - PROCESS | 25981 | 06:31:04 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40102/tests/kraken/driver.html?testName=audio-dft) 06:31:05 INFO - PROCESS | 25981 | RSS: Main: 186724352 06:31:05 INFO - PROCESS | 25981 | 06:31:08 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40102/tests/kraken/driver.html?testName=audio-fft) 06:31:09 INFO - PROCESS | 25981 | RSS: Main: 268394496 06:31:09 INFO - PROCESS | 25981 | 06:31:11 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40102/tests/kraken/driver.html?testName=audio-oscillator) 06:31:11 INFO - PROCESS | 25981 | RSS: Main: 178216960 06:31:11 INFO - PROCESS | 25981 | 06:31:13 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:14 INFO - PROCESS | 25981 | RSS: Main: 182898688 06:31:14 INFO - PROCESS | 25981 | 06:31:17 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40102/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:18 INFO - PROCESS | 25981 | RSS: Main: 217788416 06:31:18 INFO - PROCESS | 25981 | 06:31:21 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40102/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:22 INFO - PROCESS | 25981 | RSS: Main: 218394624 06:31:22 INFO - PROCESS | 25981 | 06:31:24 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40102/tests/kraken/driver.html?testName=json-parse-financial) 06:31:25 INFO - PROCESS | 25981 | RSS: Main: 217563136 06:31:25 INFO - PROCESS | 25981 | 06:31:26 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:27 INFO - PROCESS | 25981 | RSS: Main: 182370304 06:31:27 INFO - PROCESS | 25981 | 06:31:29 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:29 INFO - PROCESS | 25981 | RSS: Main: 187682816 06:31:29 INFO - PROCESS | 25981 | 06:31:31 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:32 INFO - PROCESS | 25981 | RSS: Main: 192532480 06:31:32 INFO - PROCESS | 25981 | 06:31:35 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:35 INFO - PROCESS | 25981 | RSS: Main: 186474496 06:31:35 INFO - PROCESS | 25981 | 06:31:38 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:39 INFO - PROCESS | 25981 | RSS: Main: 190496768 06:31:39 INFO - PROCESS | 25981 | 06:31:40 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:40102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40102/tests/kraken/driver.html?testName=ai-astar) 06:31:41 INFO - PROCESS | 25981 | RSS: Main: 241704960 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | __start_tp_report 06:31:41 INFO - PROCESS | 25981 | _x_x_mozilla_page_load 06:31:41 INFO - PROCESS | 25981 | _x_x_mozilla_page_load_details 06:31:41 INFO - PROCESS | 25981 | |i|pagename|runs| 06:31:41 INFO - PROCESS | 25981 | |0;ai-astar;104;110;110;111;111;110;111;112;111;111 06:31:41 INFO - PROCESS | 25981 | |1;audio-beat-detection;147;119;120;182;120;119;147;117;159;118 06:31:41 INFO - PROCESS | 25981 | |2;audio-dft;160;160;161;161;160;160;161;163;162;162 06:31:41 INFO - PROCESS | 25981 | |3;audio-fft;74;75;75;102;75;76;76;74;101;75 06:31:41 INFO - PROCESS | 25981 | |4;audio-oscillator;84;84;119;84;86;85;125;84;85;129 06:31:41 INFO - PROCESS | 25981 | |5;imaging-gaussian-blur;117;117;116;116;117;116;116;117;117;117 06:31:41 INFO - PROCESS | 25981 | |6;imaging-darkroom;146;145;145;145;145;146;146;146;145;145 06:31:41 INFO - PROCESS | 25981 | |7;imaging-desaturate;94;94;95;96;95;94;95;94;95;95 06:31:41 INFO - PROCESS | 25981 | |8;json-parse-financial;51;49;50;50;52;59;53;50;49;50 06:31:41 INFO - PROCESS | 25981 | |9;json-stringify-tinderbox;62;61;61;60;62;61;60;61;60;61 06:31:41 INFO - PROCESS | 25981 | |10;stanford-crypto-aes;81;77;74;81;76;74;76;81;84;75 06:31:41 INFO - PROCESS | 25981 | |11;stanford-crypto-ccm;123;132;122;121;119;119;127;120;140;120 06:31:41 INFO - PROCESS | 25981 | |12;stanford-crypto-pbkdf2;165;166;163;157;164;161;157;162;158;160 06:31:41 INFO - PROCESS | 25981 | |13;stanford-crypto-sha256-iterative;64;70;64;62;63;67;63;67;62;61 06:31:41 INFO - PROCESS | 25981 | __end_tp_report 06:31:41 INFO - PROCESS | 25981 | __start_cc_report 06:31:41 INFO - PROCESS | 25981 | _x_x_mozilla_cycle_collect,1762 06:31:41 INFO - PROCESS | 25981 | __end_cc_report 06:31:41 INFO - PROCESS | 25981 | __startTimestamp1470922301095__endTimestamp 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | ------- Summary: start ------- 06:31:41 INFO - PROCESS | 25981 | Number of tests: 14 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:0.67 06:31:41 INFO - PROCESS | 25981 | Values: 104.0 110.0 110.0 111.0 111.0 110.0 111.0 112.0 111.0 111.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:133.50 stddev:22.72 (17.0%) stddev-sans-first:23.67 06:31:41 INFO - PROCESS | 25981 | Values: 147.0 119.0 120.0 182.0 120.0 119.0 147.0 117.0 159.0 118.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 06:31:41 INFO - PROCESS | 25981 | Values: 160.0 160.0 161.0 161.0 160.0 160.0 161.0 163.0 162.0 162.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.20 (14.9%) stddev-sans-first:11.64 06:31:41 INFO - PROCESS | 25981 | Values: 74.0 75.0 75.0 102.0 75.0 76.0 76.0 74.0 101.0 75.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:19.36 (23.1%) stddev-sans-first:20.00 06:31:41 INFO - PROCESS | 25981 | Values: 84.0 84.0 119.0 84.0 86.0 85.0 125.0 84.0 85.0 129.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:31:41 INFO - PROCESS | 25981 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:31:41 INFO - PROCESS | 25981 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:31:41 INFO - PROCESS | 25981 | Values: 94.0 94.0 95.0 96.0 95.0 94.0 95.0 94.0 95.0 95.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:50.50 stddev:2.98 (5.9%) stddev-sans-first:3.16 06:31:41 INFO - PROCESS | 25981 | Values: 51.0 49.0 50.0 50.0 52.0 59.0 53.0 50.0 49.0 50.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 06:31:41 INFO - PROCESS | 25981 | Values: 62.0 61.0 61.0 60.0 62.0 61.0 60.0 61.0 60.0 61.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:79.00 stddev:3.54 (4.5%) stddev-sans-first:3.57 06:31:41 INFO - PROCESS | 25981 | Values: 81.0 77.0 74.0 81.0 76.0 74.0 76.0 81.0 84.0 75.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:122.50 stddev:6.86 (5.6%) stddev-sans-first:7.26 06:31:41 INFO - PROCESS | 25981 | Values: 123.0 132.0 122.0 121.0 119.0 119.0 127.0 120.0 140.0 120.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.18 06:31:41 INFO - PROCESS | 25981 | Values: 165.0 166.0 163.0 157.0 164.0 161.0 157.0 162.0 158.0 160.0 06:31:41 INFO - PROCESS | 25981 | 06:31:41 INFO - PROCESS | 25981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.83 (4.4%) stddev-sans-first:3.00 06:31:41 INFO - PROCESS | 25981 | Values: 64.0 70.0 64.0 62.0 63.0 67.0 63.0 67.0 62.0 61.0 06:31:41 INFO - PROCESS | 25981 | -------- Summary: end -------- 06:31:41 INFO - PROCESS | 25981 | 06:31:42 INFO - TEST-INFO | 25981: exit 0 06:31:42 INFO - TEST-OK | kraken | took 61282ms 06:31:42 INFO - SUITE-END | took 1177s 06:31:42 INFO - Completed test suite (00:19:37) 06:31:42 INFO - javascript benchmark 06:31:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.3256283617607, 3086.8456577171137, 3111.1288839125054, 3112.3775244951007, 3126.5310203469476, 5334.333208348957, 5387.622866399353, 5430.75561599728, 5453.154761012044, 5471.945280547188, 5324.600654950875, 5426.050441172799, 5454.7272636368225, 5478.369987451444, 5512.834614961557, 4830.6135509159185, 4862.635302352338, 4863.270509423588, 4897.2898929655175, 5052.418971818232, 4980.402351717799, 4980.576650984671, 4998.60011199105, 4999.4250661174065, 4999.8000079996755, 4708.152532544141, 4745.359376484165, 4746.620270378361, 4964.106460837048, 4981.626378021645, 4784.928226076611, 4784.976075119637, 4787.0904528139545, 4790.6886052406835, 4793.400824896888, 4755.714657120584, 4765.928511072337, 4799.28010798383, 4829.637777166727, 4864.0, 5319.840404787824, 5325.147976323769, 5371.57027437804, 5395.406505284415, 5445.401005889349, 5709.971450142764, 5765.423457654243, 5821.67980761058, 5831.2127862738835, 5836.474717275466, 5737.08206686928, 5765.798197063083, 5816.360200377955, 5912.615679980788, 5920.822375328704, 5443.673379597237, 5486.067368547357, 5501.477359650827, 5506.614536982373, 5507.284053073075, 5829.76680932758, 6014.0678194879865, 6026.789062382795, 6028.336882942873, 6031.035034394564, 5598.608097433141, 5608.1027035674915, 5625.521830644359, 5704.71476426177, 5738.512226460798, 5717.456841600041, 5788.855278618068, 5801.593888427769, 5801.6519008859605, 5804.593678442553, 5728.484436400744, 5734.111212762028, 5743.712814359349, 5748.080307150836, 5755.597108202385, 5632.493075623213, 5651.463111004448, 5701.572382071361, 5741.88516229673, 5751.367349591542, 4330.891727706769, 4370.169667763115, 4374.5625437456, 4389.802458889358, 4414.933775993362, 3902.0, 3916.686665066788, 3926.3521518949624, 3937.724359294822, 3952.8616498422416, 5310.893782124336, 5348.598855085884, 5438.265834112423, 5453.15476101205, 5511.173324001352, 5895.911561326584, 5896.204012458264, 5902.2327097477055, 5922.318933322723, 5927.8221653350465, 5518.255035570227, 5522.22688823565, 5526.613137080446, 5529.640573362719, 5532.419095994943, 4851.854444366674, 4910.680805747615, 4931.3589233399425, 4972.875678108004, 5023.372078490189, 6060.878782424239, 6061.454469097803, 6094.11635312886, 6095.0, 6112.786052488231, 5847.26909136358, 5850.678212698343, 5858.150568167677, 5861.560382971379, 5875.441833025856, 5844.327902291291, 6001.9496588096035, 6068.696565171812, 6072.635641861502, 6079.452849243589, 5747.023006088892, 5787.826365209051, 5789.986752318412, 5814.418558144321, 5828.562857785599, 5852.385499522659, 5891.116332550152, 5906.793262235801, 5907.3501914790195, 5919.733611987384, 5593.524550413098, 5657.32112146545, 5674.886502270014, 5787.94212057874, 5810.854728631818, 5728.513076388554, 5730.312362516524, 5734.3978882218435, 5758.366579676316, 5781.103928891029, 5713.857153571194, 5726.656400615976, 5729.312482502127, 5729.627574207663, 5741.598088133791, 5493.313335833021, 5686.374498805046, 5692.373838877637, 5817.738201780845, 5824.912626310694, 5633.549316054624, 5640.0, 5644.548436125182, 5644.548436125182, 5694.715264236689], "value": 5344.842539046236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.299372250161, 604.1511676095085, 608.5283904973645, 614.4469977020678, 628.1080865171456, 32073.67926320739, 43018.78490607547, 43733.12533749323, 43971.99999999996, 44022.0, 45764.0, 46104.76947615257, 46111.76944115283, 46187.0, 46192.3071153933, 9007.414518056321, 9159.954200228989, 9160.816783664322, 9166.312526560501, 9167.541622918861, 9028.729138125867, 9091.454512729224, 9122.452652840851, 9123.498207598579, 9123.498207598579, 9105.590248438835, 9142.0, 9151.816963660724, 9156.8626470603, 9158.0, 9080.182783549479, 9125.406848554823, 9126.13301736334, 9134.0, 9138.588763505591, 8897.688580899638, 8911.064338244521, 8987.955060224722, 8995.100489951017, 9036.0, 43629.345559816626, 43729.344059839124, 43912.780436097935, 43945.12109757787, 44107.338389924174, 3658.70730341572, 3707.888763337104, 3785.6403641653997, 3786.5266841644793, 3896.7467114637457, 33151.0, 33726.66273337285, 33951.6604833951, 33989.320213595835, 34187.0, 3329.9833500832583, 3364.2094107884627, 3430.8627654893776, 3434.5019972103905, 3698.7965661888584, 331999.0, 333387.0, 333942.0, 334203.0, 335100.3244983784, 60244.69877650584, 60564.0, 60701.696491518145, 60740.69629651823, 60837.391626083176, 64252.357476425575, 64313.67843160754, 64319.356806432275, 64348.0, 64364.0, 15024.17367044823, 15280.541583752505, 15327.080375177526, 15330.233488325539, 15330.770038449433, 11760.353180574979, 11951.820722689166, 11982.700432489084, 12034.398280085961, 12035.217710848767, 17102.57956695681, 18227.908860455613, 18636.813631863508, 18704.719429208573, 18874.716879246822, 5706.4864162225595, 6419.5876907080365, 6631.23740769808, 6716.764913228014, 6720.899186512206, 1039.302353362811, 1050.495762034228, 1118.0384869012642, 1147.386148410613, 1239.0521251242806, 32795.0, 33102.3379532408, 33275.33449331, 33298.500522492184, 33529.83235083809, 1110.5779803674552, 1121.2991880074953, 1140.1164097824087, 1182.3674334231146, 1273.1724379153625, 17372.131393430278, 17424.303027878996, 17573.560660983578, 17574.29702811899, 17619.647607047787, 521474.0, 526113.0, 527882.0, 527897.0, 529839.0, 60871.0, 61040.38959610436, 61183.0, 61269.0, 61340.07989880155, 1243.738814848892, 1277.5464710027993, 1325.2379881567945, 1363.9931800341133, 1414.5261337451864, 29997.666903285834, 34373.0, 34456.31087378289, 34458.31083378368, 34654.306913862085, 50800.0, 51408.22887656763, 51449.0, 51528.0, 51535.226971594704, 395483.0, 396460.0, 397084.0, 397246.0, 397958.0, 29076.982305619204, 29813.850930745208, 30002.399952001273, 31684.36631267408, 41226.58773412347, 47261.0, 47417.0, 48461.5153848457, 51133.7443312781, 51314.74342628263, 40148.598514014484, 41804.372934406616, 43027.784861075495, 44530.55469445264, 45171.7741411304, 42428.787856060524, 45016.0996780056, 45773.77113114413, 46014.769926150155, 46507.0, 45763.0, 46250.53749462462, 46956.530434696586, 47092.7645361771, 47117.52882471131, 41727.37408938929, 43670.56329436665, 44088.338674920546, 45267.320990185835, 45405.54594454145, 27189.456210876066, 29158.562621560268, 30042.0, 30052.398952021274, 30284.394312114076], "value": 20476.322087224125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7476341324484, 381.6660770606729, 383.313868175965, 384.73453317211124, 410.5094412177447, 17492.825071749277, 19752.209911603535, 19786.10962506687, 19917.10373033213, 20123.19507219713, 15987.200639968014, 16319.10244936528, 16338.918305408457, 17763.46709598714, 20045.699314510293, 5699.116636921263, 5704.3154821421385, 5919.822405327847, 5927.703614819242, 5932.495737862287, 5780.4797568218855, 5901.4098590141075, 5903.852403689921, 5904.7342869570975, 5909.11363295507, 5566.081596536566, 5746.109353050263, 5822.039363505017, 5833.416658334154, 5838.649681019152, 5775.537956963432, 5800.013997620394, 5834.97082514589, 5841.620294680833, 5850.6782126983, 5021.799128034874, 5099.4900509949075, 5169.586433085344, 5216.947830521684, 5218.739063046833, 24165.758342416702, 24185.758142418526, 24448.87775561111, 24581.38546536351, 24655.630165547533, 2462.4090218347646, 2555.642210090589, 2581.0, 3025.848707564635, 3122.8438578071004, 15172.924135379362, 15273.541793746093, 15420.836955171986, 15427.768583471257, 15872.20638968047, 1899.705545640428, 1951.756030496188, 1959.657060014506, 2000.21991423345, 2040.36748607932, 78752.0, 79986.20013799846, 80671.59664201642, 81426.0, 92754.53622731843, 11409.858325262872, 11575.942120289514, 11810.76378472443, 11835.704107397383, 11972.102092342935, 16407.0, 16417.58956026109, 16438.0, 16447.424340148038, 16457.0, 8105.554194519358, 8339.916600834036, 8353.916460835313, 8507.65969361231, 8569.442986206, 7837.843243135106, 7915.12933577306, 7915.564643944638, 8138.145494722969, 8170.14213507585, 4899.657024008286, 4949.381327334083, 5006.874828129326, 5057.544820966131, 5118.129917913963, 1931.642646110474, 2024.9797502025085, 2046.2326627514683, 2061.9587608247753, 2085.697573851783, 899.7210864631985, 985.2315194148575, 1036.259074761549, 1044.8798388185303, 1068.1294744782977, 20338.237426076223, 20894.895525522275, 20999.16003359879, 21090.261840835497, 21259.46851328729, 993.2600212841479, 994.3636072913341, 1002.04304888831, 1043.4834756795283, 1096.1450068946235, 11024.393658348868, 11390.943045284721, 11601.07191424684, 11663.59177428786, 11673.124515661359, 474177.0, 476831.0, 477757.0, 478120.0, 490721.0, 80548.0, 90005.54997224972, 91310.54344728366, 91730.54134729283, 93073.0, 953.1993125774244, 987.086944576264, 1002.5939494504737, 1003.8745156855393, 1014.5333146752429, 17665.558361041076, 18184.727229091837, 18446.81553184451, 18484.907575462035, 18528.258869645062, 36900.0, 37588.62411375851, 40799.38800918048, 42067.36898946457, 43744.34383484314, 54928.17607735967, 55257.0, 55413.44586554083, 55622.54599087204, 56852.1472177926, 8432.662693492191, 8463.66145354179, 8551.444156129832, 8653.61058752345, 8762.474251544927, 9403.34176607631, 12932.612021639367, 13078.80381794293, 13227.272500012592, 13397.196168229937, 11427.257228280136, 11437.331322432172, 11648.475818588353, 11760.411979400824, 12125.81811272814, 11105.666829995112, 11462.885371146182, 11536.192466527262, 11590.594329198437, 11848.170628055954, 11474.827877581676, 11870.347130907883, 12128.393580320771, 12238.02095832349, 12424.316662583284, 7732.420068494998, 8009.959950200445, 8040.798980025546, 8433.241008309282, 8565.443246188977, 10822.980981427694, 11936.880631193577, 12095.334756588472, 12107.878921211028, 12165.45255463524], "value": 9431.559590952616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.1932601786893, 1434.7417464856328, 1502.5191938579655, 1642.162497126465, 1784.6341499992502, 8240.217179367957, 8354.540500272482, 8398.20217079378, 8685.47887126773, 8728.127187281269, 8367.623456944437, 8493.065762766106, 8494.702685406011, 8500.61747221375, 8526.616302266397, 2342.180236917078, 2367.4791545859885, 2367.7987371073477, 2368.3723813189517, 2370.5969985102574, 2246.1913711064003, 2285.702858628376, 2306.9653955190684, 2308.7922087012166, 2308.9191878284264, 2306.5041016181603, 2326.697529321186, 2333.731620863597, 2345.483993521431, 2350.083467447697, 2270.0579259607325, 2274.0108052996834, 2278.4417817634703, 2278.624027035537, 2281.8973146208377, 2277.6697378880135, 2282.132789539964, 2284.7601001894727, 2284.977150228493, 2285.6685780561725, 8424.031236407769, 8495.74512764618, 8497.447665901696, 8505.149485051506, 8779.868301975412, 5063.569596584295, 5260.8684782880355, 5266.815661451831, 5267.0256002639635, 5271.472852714736, 3395.3718562066097, 3460.619331873492, 3460.8269586520573, 3498.247876706495, 3500.842462089212, 1099.087757161562, 1108.107973081669, 1119.8208286674094, 1124.3085502416036, 1125.983110253347, 12074.939625301906, 12121.575744848977, 12124.090693198046, 12183.269003859798, 12199.939000304941, 4203.873883783492, 4471.955280447154, 4482.013956929471, 4586.587207151372, 4607.193741095295, 9710.514474276259, 9728.61085556584, 9735.367201131903, 9735.951320243354, 9738.074882886114, 5132.666376685504, 5139.974300128475, 5142.922856157161, 5144.254083157921, 5144.665596736275, 4113.8971525712095, 4210.389493523422, 4342.196693611692, 4765.547273009059, 4813.855584332476, 3586.1393265616584, 3593.9101522462147, 3688.299223147647, 3698.1679122197293, 3778.527684039495, 1073.7745073534645, 1103.9834402483968, 1107.4905543449943, 1114.2089116727052, 1121.159130652011, 951.900050494702, 983.1250187333279, 984.3847595252967, 997.2819569909653, 1012.3824467075078, 5771.595988280864, 5917.497012753965, 5957.6127551709, 5979.730912108878, 6029.517638588903, 947.1049857884371, 959.947202903833, 980.8185485685171, 993.2103977337889, 1033.751899544119, 4070.287699652549, 4338.219120558267, 4346.152500262482, 4364.956350436519, 4483.641308695296, 10779.0, 11030.944845275722, 11109.0, 11149.21955463126, 11198.552057917592, 10224.28430009907, 10513.57945682164, 11031.613893513688, 11050.778984420267, 11051.17116216287, 8199.508029518249, 8328.333733301442, 8377.45546539473, 8409.789755256168, 8416.074231834493, 6151.108089327112, 6175.197224360804, 6255.218097737783, 6317.0, 6322.083297921684, 9596.088371604686, 9861.901380986099, 10051.949740251544, 10210.43842588635, 10354.068133867988, 10180.083792458418, 10277.81805092424, 10339.327943683636, 10437.68686939393, 10444.216683748597, 6843.213030501357, 7666.884996724942, 7934.20657934202, 8027.39794515402, 8120.187981201832, 8506.74479765608, 8787.472751634923, 8788.07725188846, 8799.868001980103, 8824.073472285318, 7550.471466997257, 7721.227877212234, 7824.139344671968, 7845.843083138419, 7944.0, 7545.584992825227, 7661.540307581563, 7680.69277228927, 7710.1133369660965, 7919.920800791919, 7034.5427547209265, 7126.857462850818, 7129.215786263403, 7131.25121862197, 7133.39366153862, 5207.505286997729, 5264.921026184534, 5407.540359069366, 5418.864528386822, 5709.34342550612, 5359.356877174764, 5388.784448622011, 5436.211749296251, 5460.453954604508, 5601.411851755507], "value": 4617.047202997735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2097403309956, 329.99340013199736, 337.29000454044234, 337.87836378903603, 341.6208009109889, 5184.429712731597, 5264.89470210596, 5266.631335806495, 5305.867353316169, 5319.760610772515, 5265.526102650761, 5291.153415453528, 5297.099493086175, 5305.310309659739, 5311.097113490716, 4131.0911599448145, 4146.5853414658595, 4166.354215096665, 4173.227952828721, 4217.493900731916, 3988.9202215955665, 4149.792510374485, 4169.603887630686, 4195.307774217251, 4197.677731514563, 4134.50385953686, 4134.813933373005, 4137.565555616662, 4154.127633197032, 4155.937660935073, 4106.733062350938, 4115.670746340285, 4118.588141185887, 4138.4413104231, 4155.958440415588, 3656.122530592665, 3662.8717994870317, 3673.5775385830702, 3677.8161091945294, 3681.2821499807546, 5138.845834624967, 5179.326687530634, 5190.11767999441, 5213.635045546814, 5217.16525355945, 4702.106599746037, 4716.9292460613115, 4727.692699974491, 4741.336212930192, 4754.0, 5480.438075148563, 5486.643368181056, 5502.312210973629, 5509.614326997112, 5539.833804985857, 3794.772313661189, 3974.7813870237123, 3985.3025720498795, 4003.939940900889, 4006.1787333596544, 5687.118496633028, 5716.885662286731, 5718.485336319751, 5723.313202415695, 5734.942650573483, 4059.6955228357992, 4084.7753373564146, 4085.1216988347055, 4085.3463445849115, 4087.9984403821254, 4023.9195216095513, 4128.256913755553, 4199.958000420018, 4209.368594710818, 4240.38514415408, 4737.478877323491, 4744.1934871072, 4757.215059515142, 4760.429058410716, 4768.7615619218905, 5557.6109672323355, 5576.498115169654, 5591.574148592164, 5609.970615867386, 5626.662400255997, 1329.654289884637, 1388.2503448138095, 1457.0966001079398, 1460.4231328625347, 1473.4990103364908, 1017.2116609627598, 1021.8875923648542, 1033.4109557552274, 1046.5813674530098, 1049.4992161209543, 5280.3663560373, 5288.2596436498925, 5320.388155362183, 5325.786968521294, 5328.387235467893, 5643.971780141155, 5646.463585959327, 5657.51911087554, 5679.5172410345585, 5736.942630573724, 5135.666181698178, 5214.374275087014, 5264.868378290496, 5325.387580428301, 5371.435999220103, 2626.448445826398, 2637.7470701416673, 2638.7465953672236, 2658.534756417619, 2669.2125822882294, 5056.82301119459, 5143.331366922351, 5189.949969761923, 5195.272661827347, 5205.583553315726, 5083.186690129562, 5093.388793344822, 5429.859729456858, 5820.563457740602, 5850.0, 5882.382349853289, 5883.9703051965735, 5904.852378690482, 5907.940920590739, 5915.201447804491, 5479.726013699379, 5691.203231547669, 5711.0, 5711.457411545896, 5716.399778023248, 5570.192322113352, 5610.943890561205, 5637.182608521824, 5645.322561292671, 5673.319201695823, 5829.921464529076, 5901.0558310670085, 5925.348211696796, 5933.258342707161, 5940.79207227745, 3821.4840996466232, 3928.7053470990363, 4043.433919251366, 4063.9796801016987, 4086.6526345260986, 5621.8594535136945, 5638.2670252866865, 5689.914651280317, 5705.971470142623, 5713.0, 5582.720863956867, 5603.917845185213, 5605.439456054362, 5605.467480589337, 5642.548596112383, 5330.8933821324135, 5571.916421253765, 5587.547237718141, 5593.804216852391, 5603.719814009365, 5545.805896793593, 5548.890221955544, 5565.693886836263, 5571.303587051619, 5593.776248950159, 5341.943351809504, 5602.971985140048, 5605.383407825055, 5634.661920284796, 5646.576506761927, 5496.422875598005, 5517.117261238182, 5518.558515318685, 5527.751251193626, 5531.3362396512675], "value": 4219.28590120149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.1969372312212, 764.9847003059939, 771.2287712287712, 804.3725893802834, 858.5621333120115, 15606.531804045882, 16792.412265570707, 16797.412090576832, 16816.32734690614, 16818.747718784212, 15285.388584456608, 15393.615159620987, 15407.84592154081, 15409.614759631015, 15461.845381546209, 643.2731013954225, 758.5827794712914, 796.9521828690283, 810.9594520273993, 813.8168911994784, 801.3669201330941, 804.5012092502657, 810.0441479054713, 810.5744484145841, 810.7689308547066, 860.6213266162869, 862.6678728689437, 862.9223369896708, 863.3093525179862, 863.5509535041774, 689.2246222999152, 825.5913322905141, 856.374846362156, 857.1899554920602, 859.660434128522, 633.66732465456, 633.936606339367, 634.0710858592184, 634.0805831544279, 634.112242859995, 14395.352209150613, 14419.35112919921, 14443.927780361137, 14449.855501444956, 14471.42114315426, 14382.92808535961, 14684.559463216014, 14962.850371496255, 14992.850071499255, 15146.621334466616, 13759.518416855462, 13815.930920345434, 13845.307734613229, 13920.09519381247, 14089.225092619901, 4387.736735795863, 4400.581944715247, 4433.689641725081, 4567.406237189144, 4588.88527786808, 80780.59609701972, 80791.59604202, 82339.5883020587, 82339.5883020587, 87552.56223718841, 11120.38837863909, 11513.827292590619, 11519.596814111466, 11601.303921764722, 11847.348395838311, 20234.494137646383, 20254.69617955732, 20286.797132028492, 20302.390928272176, 20345.084471198832, 8939.150780675825, 8953.59708813105, 9001.504917229615, 9088.81822363549, 9156.359054866096, 4784.497627749036, 4802.399700037496, 4862.5380588844, 5013.699178049329, 5147.356580427447, 3372.106391806173, 3467.6358982306997, 3492.318997795456, 3494.930101397958, 3497.632748561415, 560.6019725994589, 573.5812856614612, 576.7635269539553, 583.201014609987, 583.2243116654839, 693.8022663540968, 704.8731228378941, 725.5175308419947, 737.9631018449056, 744.6909532544042, 9669.468179250209, 9681.757956051155, 9811.656592019244, 9816.128276570147, 10010.299279050396, 583.7139801497236, 596.7659456158634, 639.3861892583079, 649.3344322069917, 716.1299021688674, 4524.932126018112, 4613.95386046142, 4741.5495527924795, 4779.5220477951925, 4783.306420568998, 67481.3251867475, 91607.54196228976, 120116.0, 123468.0, 127050.0, 108232.4588377053, 110319.44840275747, 111138.44430777956, 111645.0, 115876.42061789805, 62708.0, 89602.55198723964, 91412.54293728489, 91774.0, 96107.0, 8524.9343832021, 8701.695440659547, 8800.339974502065, 8807.0, 8879.866801997847, 54941.0, 55102.173467398825, 56498.71750641385, 56836.0, 57559.71220143873, 78518.6074069626, 81172.0, 83529.58235208785, 83741.0, 85996.0, 11752.060909949763, 12055.0, 12061.758764824479, 12315.13794034409, 12514.639617285566, 14433.566992990227, 14685.48600798967, 14901.701965960838, 15598.454054108051, 15659.217039148225, 14676.119432833637, 14784.852151478348, 15003.774943376076, 15285.847141528442, 15485.767713484533, 14588.927055364655, 14754.778678320048, 14875.851241487446, 15205.239738012833, 15647.921760391126, 13919.512817051354, 13966.1936165656, 14046.508372206923, 14075.788863167265, 14407.927960360132, 11739.765204696028, 11985.580504682293, 12060.0, 12377.306439038144, 12570.371481426075, 12116.21244619097, 12417.557876975829, 12532.749345013232, 12718.0, 12746.808797867854], "value": 7740.620471835465, "unit": "score"}], "name": "dromaeo_css", "value": 7334.4230639336, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 120.0, 182.0, 120.0, 119.0, 147.0, 117.0, 159.0, 118.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 163.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 102.0, 75.0, 76.0, 76.0, 74.0, 101.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 84.0, 86.0, 85.0, 125.0, 84.0, 85.0, 129.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 50.0, 52.0, 59.0, 53.0, 50.0, 49.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 62.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 74.0, 81.0, 76.0, 74.0, 76.0, 81.0, 84.0, 75.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 122.0, 121.0, 119.0, 119.0, 127.0, 120.0, 140.0, 120.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 157.0, 164.0, 161.0, 157.0, 162.0, 158.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 64.0, 62.0, 63.0, 67.0, 63.0, 67.0, 62.0, 61.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1479.4, "alertThreshold": 2.0}]} 06:31:42 INFO - Return code: 0 06:31:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:31:42 INFO - # TBPL SUCCESS # 06:31:42 INFO - Running post-action listener: _resource_record_post_action 06:31:42 INFO - [mozharness: 2016-08-11 13:31:42.402307Z] Finished run-tests step (success) 06:31:42 INFO - Running post-run listener: _resource_record_post_run 06:31:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 549584896; Read time: 0; Write time: 531756 06:31:42 INFO - TinderboxPrint: CPU usage
13.0% 06:31:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:31:42 INFO - TinderboxPrint: I/O write bytes / time
549,584,896 / 531,756 06:31:42 INFO - TinderboxPrint: CPU idle
8,287.6 (87.0%) 06:31:42 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 06:31:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:31:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261984256; Read time: 0; Write time: 254500 06:31:42 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287223808; Read time: 0; Write time: 277192 06:31:43 INFO - Running post-run listener: _upload_blobber_files 06:31:43 INFO - Blob upload gear active. 06:31:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:31:43 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:31:43 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:31:43 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:31:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:44 INFO - (blobuploader) - INFO - Done attempting. 06:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:45 INFO - (blobuploader) - INFO - Done attempting. 06:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:48 INFO - (blobuploader) - INFO - Done attempting. 06:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:31:48 INFO - Return code: 0 06:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:31:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c7218ae9d461de20d50e547028a8d9427f54b25c013121f2b34ffa59e08f2d57855f0c9dc266c38d6e8fcf49c4b22bca3caea441f8cfa0aecfa666be71ec3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/450d80326e1e5c796e38321c332c40efccc857722846758696a317c751d02f1fa58a7ab95ec6c14be522413ec78b39dc563fa7cd16021bbd474fbed89e293aa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5ab511dc6960c5433d3ec29dcaf27ec2e36a9c6545afff4b0565ed066cebff200a7442683e9b000860ec1345d960cfc758f7d3cdd5438ede886e38392551d2b"} 06:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:31:48 INFO - Contents: 06:31:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c7218ae9d461de20d50e547028a8d9427f54b25c013121f2b34ffa59e08f2d57855f0c9dc266c38d6e8fcf49c4b22bca3caea441f8cfa0aecfa666be71ec3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/450d80326e1e5c796e38321c332c40efccc857722846758696a317c751d02f1fa58a7ab95ec6c14be522413ec78b39dc563fa7cd16021bbd474fbed89e293aa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5ab511dc6960c5433d3ec29dcaf27ec2e36a9c6545afff4b0565ed066cebff200a7442683e9b000860ec1345d960cfc758f7d3cdd5438ede886e38392551d2b"} 06:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:31:48 INFO - Copying logs to upload dir... 06:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.377033 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-11 06:31:48.167047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 06:31:48.170700) ========= 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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 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/0c7218ae9d461de20d50e547028a8d9427f54b25c013121f2b34ffa59e08f2d57855f0c9dc266c38d6e8fcf49c4b22bca3caea441f8cfa0aecfa666be71ec3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/450d80326e1e5c796e38321c332c40efccc857722846758696a317c751d02f1fa58a7ab95ec6c14be522413ec78b39dc563fa7cd16021bbd474fbed89e293aa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5ab511dc6960c5433d3ec29dcaf27ec2e36a9c6545afff4b0565ed066cebff200a7442683e9b000860ec1345d960cfc758f7d3cdd5438ede886e38392551d2b"} build_url:https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/e2QgZvOKT6u99VDiHq9sLQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c7218ae9d461de20d50e547028a8d9427f54b25c013121f2b34ffa59e08f2d57855f0c9dc266c38d6e8fcf49c4b22bca3caea441f8cfa0aecfa666be71ec3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/450d80326e1e5c796e38321c332c40efccc857722846758696a317c751d02f1fa58a7ab95ec6c14be522413ec78b39dc563fa7cd16021bbd474fbed89e293aa8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5ab511dc6960c5433d3ec29dcaf27ec2e36a9c6545afff4b0565ed066cebff200a7442683e9b000860ec1345d960cfc758f7d3cdd5438ede886e38392551d2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 06:31:48.196624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:31:48.196949) ========= 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=7de08804244eb36560b44971000001c3-1470921074.100390-1790252715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 06:31:48.280139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 06:31:48.280511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 06:31:48.280808) ========= ========= Total master_lag: 0.17 =========