builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1471620291.33 results: success (0) buildid: 20160819071322 builduid: b803af76101747faa15b6a2026d7be44 revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.325624) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.326032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.326339) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.340703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.341001) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 08:24:52-- 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.5M=0s 2016-08-19 08:24:52 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123552 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.478362) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.478674) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.528887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:51.529259) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --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 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --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=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 08:24:52,296 truncating revision to first 12 chars 2016-08-19 08:24:52,296 Setting DEBUG logging. 2016-08-19 08:24:52,296 attempt 1/10 2016-08-19 08:24:52,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23c2ec5544b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:24:52,611 unpacking tar archive at: mozilla-central-23c2ec5544b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:52.229445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:52.229768) ========= script_repo_revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:52.230203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:52.230471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:52.241736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-19 08:24:52.242151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:53 INFO - MultiFileLogger online at 20160819 08:24:53 in /builds/slave/test 08:24:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:24:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:53 INFO - {'append_to_log': False, 08:24:53 INFO - 'base_work_dir': '/builds/slave/test', 08:24:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:24:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:53 INFO - 'branch': 'Firefox-Non-PGO', 08:24:53 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:53 INFO - 'config_files': ('talos/linux_config.py',), 08:24:53 INFO - 'default_actions': ('clobber', 08:24:53 INFO - 'read-buildbot-config', 08:24:53 INFO - 'download-and-extract', 08:24:53 INFO - 'populate-webroot', 08:24:53 INFO - 'create-virtualenv', 08:24:53 INFO - 'install', 08:24:53 INFO - 'run-tests'), 08:24:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:53 INFO - 'download_minidump_stackwalk': True, 08:24:53 INFO - 'download_symbols': 'ondemand', 08:24:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:53 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:53 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:53 INFO - 'installer_path': 'installer.exe', 08:24:53 INFO - 'log_level': 'info', 08:24:53 INFO - 'log_name': 'talos', 08:24:53 INFO - 'log_to_console': True, 08:24:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:53 INFO - 'opt_config_files': (), 08:24:53 INFO - 'pip_index': False, 08:24:53 INFO - 'sps_profile': False, 08:24:53 INFO - 'sps_profile_interval': 0, 08:24:53 INFO - 'suite': 'dromaeojs', 08:24:53 INFO - 'system_bits': '32', 08:24:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:53 INFO - 'title': 'talos-linux64-ix-066', 08:24:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:53 INFO - 'use_talos_json': True, 08:24:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:53 INFO - 'work_dir': 'build'} 08:24:53 INFO - [mozharness: 2016-08-19 15:24:53.096222Z] Running clobber step. 08:24:53 INFO - Running pre-action listener: _resource_record_pre_action 08:24:53 INFO - Running main action method: clobber 08:24:53 INFO - rmtree: /builds/slave/test/build 08:24:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:53 INFO - Running post-action listener: _resource_record_post_action 08:24:53 INFO - [mozharness: 2016-08-19 15:24:53.557255Z] Finished clobber step (success) 08:24:53 INFO - [mozharness: 2016-08-19 15:24:53.557367Z] Running read-buildbot-config step. 08:24:53 INFO - Running pre-action listener: _resource_record_pre_action 08:24:53 INFO - Running main action method: read_buildbot_config 08:24:53 INFO - Using buildbot properties: 08:24:53 INFO - { 08:24:53 INFO - "project": "", 08:24:53 INFO - "product": "firefox", 08:24:53 INFO - "script_repo_revision": "production", 08:24:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:24:53 INFO - "repository": "", 08:24:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:24:53 INFO - "buildid": "20160819071322", 08:24:53 INFO - "pgo_build": "False", 08:24:53 INFO - "basedir": "/builds/slave/test", 08:24:53 INFO - "buildnumber": 182, 08:24:53 INFO - "slavename": "talos-linux64-ix-066", 08:24:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:24:53 INFO - "platform": "ubuntu64_hw", 08:24:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:24:53 INFO - "branch": "mozilla-central", 08:24:53 INFO - "repo_path": "mozilla-central", 08:24:53 INFO - "revision": "23c2ec5544b9e0a74a047b87b594e4c36a8fe95c", 08:24:53 INFO - "stage_platform": "linux64", 08:24:53 INFO - "builduid": "b803af76101747faa15b6a2026d7be44", 08:24:53 INFO - "slavebuilddir": "test" 08:24:53 INFO - } 08:24:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:24:53 INFO - Running post-action listener: _resource_record_post_action 08:24:53 INFO - [mozharness: 2016-08-19 15:24:53.559825Z] Finished read-buildbot-config step (success) 08:24:53 INFO - [mozharness: 2016-08-19 15:24:53.559915Z] Running download-and-extract step. 08:24:53 INFO - Running pre-action listener: _resource_record_pre_action 08:24:53 INFO - Running main action method: download_and_extract 08:24:53 INFO - mkdir: /builds/slave/test/build/tests 08:24:53 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')]} 08:24:53 INFO - trying https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:24:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:24:54 INFO - Downloaded 1361 bytes. 08:24:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:24:54 INFO - Using the following test package requirements: 08:24:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:24:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'jsshell-linux-x86_64.zip'], 08:24:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:54 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')]} 08:24:54 INFO - trying https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:24:54 INFO - Downloaded 20328338 bytes. 08:24:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:24:59 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 08:24:59 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')]} 08:24:59 INFO - trying https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:25:00 INFO - Downloaded 20328338 bytes. 08:25:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:25: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')]} 08:25:04 INFO - trying https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:25:05 INFO - Downloaded 14413981 bytes. 08:25:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:25:05 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')]} 08:25:05 INFO - trying https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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 08:25:07 INFO - Downloaded 55769658 bytes. 08:25:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:07 INFO - mkdir: /builds/slave/test/properties 08:25:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:07 INFO - Contents: 08:25:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:07 INFO - Running post-action listener: _resource_record_post_action 08:25:07 INFO - Running post-action listener: set_extra_try_arguments 08:25:07 INFO - [mozharness: 2016-08-19 15:25:07.733825Z] Finished download-and-extract step (success) 08:25:07 INFO - [mozharness: 2016-08-19 15:25:07.734052Z] Running populate-webroot step. 08:25:07 INFO - Running pre-action listener: _resource_record_pre_action 08:25:07 INFO - Running main action method: populate_webroot 08:25:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:07 INFO - '--tppagecycles', 08:25:07 INFO - '7'], 08:25:07 INFO - 'tests': ['tsvgm']}}, 08:25:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['damp', 'tps']}, 08:25:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'tests': ['damp', 'tps']}, 08:25:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['dromaeo_dom']}, 08:25:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['basic_compositor_video']}, 08:25:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:25:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['a11yr', 08:25:07 INFO - 'ts_paint', 08:25:07 INFO - 'tpaint', 08:25:07 INFO - 'sessionrestore', 08:25:07 INFO - 'sessionrestore_no_auto_restore', 08:25:07 INFO - 'tabpaint']}, 08:25:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['tsvgx', 08:25:07 INFO - 'tsvgr_opacity', 08:25:07 INFO - 'tart', 08:25:07 INFO - 'tscrollx', 08:25:07 INFO - 'cart']}, 08:25:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:07 INFO - 'tsvgr_opacity', 08:25:07 INFO - 'tart', 08:25:07 INFO - 'tscrollx', 08:25:07 INFO - 'cart']}, 08:25:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'talos_options': ['--disable-e10s'], 08:25:07 INFO - 'tests': ['tp5o']}, 08:25:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'tests': ['tp5o']}, 08:25:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'talos_options': ['--disable-e10s', 08:25:07 INFO - '--xperf_path', 08:25:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:07 INFO - 'tests': ['tp5n']}, 08:25:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:07 INFO - 'talos_options': ['--xperf_path', 08:25:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:07 INFO - 'tests': ['tp5n']}}, 08:25:07 INFO - 'talos.zip': {'path': '', 08:25:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:07 INFO - Running post-action listener: _resource_record_post_action 08:25:07 INFO - [mozharness: 2016-08-19 15:25:07.754722Z] Finished populate-webroot step (success) 08:25:07 INFO - [mozharness: 2016-08-19 15:25:07.754812Z] Running create-virtualenv step. 08:25:07 INFO - Running pre-action listener: _resource_record_pre_action 08:25:07 INFO - Running main action method: create_virtualenv 08:25:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:07 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 08:25:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:07 INFO - Using real prefix '/usr' 08:25:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:10 INFO - Installing pip.................done. 08:25:10 INFO - Return code: 0 08:25:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:10 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 08:25:10 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 08:25:10 INFO - Using env: {'DISPLAY': ':0', 08:25:10 INFO - 'HOME': '/home/cltbld', 08:25:10 INFO - 'LANG': 'en_US.UTF-8', 08:25:10 INFO - 'LANGUAGE': 'en_US:en', 08:25:10 INFO - 'LOGNAME': 'cltbld', 08:25:10 INFO - 'MAIL': '/var/mail/cltbld', 08:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:10 INFO - 'MOZ_NO_REMOTE': '1', 08:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:10 INFO - 'NO_EM_RESTART': '1', 08:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:10 INFO - 'PWD': '/builds/slave/test', 08:25:10 INFO - 'SHELL': '/bin/bash', 08:25:10 INFO - 'SHLVL': '1', 08:25:10 INFO - 'TERM': 'linux', 08:25:10 INFO - 'TMOUT': '86400', 08:25:10 INFO - 'USER': 'cltbld', 08:25:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:10 INFO - '_': '/tools/buildbot/bin/python'} 08:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:10 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 08:25:10 INFO - Cleaning up... 08:25:10 INFO - Return code: 0 08:25:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:10 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:10 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 08:25:10 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 08:25:10 INFO - Using env: {'DISPLAY': ':0', 08:25:10 INFO - 'HOME': '/home/cltbld', 08:25:10 INFO - 'LANG': 'en_US.UTF-8', 08:25:10 INFO - 'LANGUAGE': 'en_US:en', 08:25:10 INFO - 'LOGNAME': 'cltbld', 08:25:10 INFO - 'MAIL': '/var/mail/cltbld', 08:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:10 INFO - 'MOZ_NO_REMOTE': '1', 08:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:10 INFO - 'NO_EM_RESTART': '1', 08:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:10 INFO - 'PWD': '/builds/slave/test', 08:25:10 INFO - 'SHELL': '/bin/bash', 08:25:10 INFO - 'SHLVL': '1', 08:25:10 INFO - 'TERM': 'linux', 08:25:10 INFO - 'TMOUT': '86400', 08:25:10 INFO - 'USER': 'cltbld', 08:25:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:10 INFO - '_': '/tools/buildbot/bin/python'} 08:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:10 INFO - Downloading/unpacking psutil>=3.1.1 08:25:10 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 08:25:10 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 08:25:10 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 08:25:10 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 08:25:10 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 08:25:10 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 08:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:13 INFO - Installing collected packages: psutil 08:25:13 INFO - Running setup.py install for psutil 08:25:13 INFO - building 'psutil._psutil_linux' extension 08:25:13 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 08:25:13 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 08:25:13 INFO - building 'psutil._psutil_posix' extension 08:25:13 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 08:25:13 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 08:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:13 INFO - Successfully installed psutil 08:25:13 INFO - Cleaning up... 08:25:13 INFO - Return code: 0 08:25:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:13 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 08:25:13 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 08:25:13 INFO - Using env: {'DISPLAY': ':0', 08:25:13 INFO - 'HOME': '/home/cltbld', 08:25:13 INFO - 'LANG': 'en_US.UTF-8', 08:25:13 INFO - 'LANGUAGE': 'en_US:en', 08:25:13 INFO - 'LOGNAME': 'cltbld', 08:25:13 INFO - 'MAIL': '/var/mail/cltbld', 08:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:13 INFO - 'MOZ_NO_REMOTE': '1', 08:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:13 INFO - 'NO_EM_RESTART': '1', 08:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:13 INFO - 'PWD': '/builds/slave/test', 08:25:13 INFO - 'SHELL': '/bin/bash', 08:25:13 INFO - 'SHLVL': '1', 08:25:13 INFO - 'TERM': 'linux', 08:25:13 INFO - 'TMOUT': '86400', 08:25:13 INFO - 'USER': 'cltbld', 08:25:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:13 INFO - '_': '/tools/buildbot/bin/python'} 08:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:13 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 08:25:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:16 INFO - Installing collected packages: mozsystemmonitor 08:25:16 INFO - Running setup.py install for mozsystemmonitor 08:25:16 INFO - Successfully installed mozsystemmonitor 08:25:16 INFO - Cleaning up... 08:25:16 INFO - Return code: 0 08:25:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:16 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 08:25:16 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 08:25:16 INFO - Using env: {'DISPLAY': ':0', 08:25:16 INFO - 'HOME': '/home/cltbld', 08:25:16 INFO - 'LANG': 'en_US.UTF-8', 08:25:16 INFO - 'LANGUAGE': 'en_US:en', 08:25:16 INFO - 'LOGNAME': 'cltbld', 08:25:16 INFO - 'MAIL': '/var/mail/cltbld', 08:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:16 INFO - 'MOZ_NO_REMOTE': '1', 08:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:16 INFO - 'NO_EM_RESTART': '1', 08:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:16 INFO - 'PWD': '/builds/slave/test', 08:25:16 INFO - 'SHELL': '/bin/bash', 08:25:16 INFO - 'SHLVL': '1', 08:25:16 INFO - 'TERM': 'linux', 08:25:16 INFO - 'TMOUT': '86400', 08:25:16 INFO - 'USER': 'cltbld', 08:25:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:16 INFO - '_': '/tools/buildbot/bin/python'} 08:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:16 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:16 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 08:25:16 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 08:25:16 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 08:25:16 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 08:25:16 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 08:25:16 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 08:25:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:18 INFO - warning: no files found matching '*.txt' 08:25:18 INFO - no previously-included directories found matching 'build' 08:25:18 INFO - no previously-included directories found matching 'dist' 08:25:18 INFO - no previously-included directories found matching '.git*' 08:25:18 INFO - Installing collected packages: jsonschema, functools32 08:25:19 INFO - Running setup.py install for functools32 08:25:19 INFO - warning: no files found matching '*.txt' 08:25:19 INFO - no previously-included directories found matching 'build' 08:25:19 INFO - no previously-included directories found matching 'dist' 08:25:19 INFO - no previously-included directories found matching '.git*' 08:25:19 INFO - Successfully installed jsonschema functools32 08:25:19 INFO - Cleaning up... 08:25:19 INFO - Return code: 0 08:25:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:19 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 08:25:19 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 08:25:19 INFO - Using env: {'DISPLAY': ':0', 08:25:19 INFO - 'HOME': '/home/cltbld', 08:25:19 INFO - 'LANG': 'en_US.UTF-8', 08:25:19 INFO - 'LANGUAGE': 'en_US:en', 08:25:19 INFO - 'LOGNAME': 'cltbld', 08:25:19 INFO - 'MAIL': '/var/mail/cltbld', 08:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:19 INFO - 'MOZ_NO_REMOTE': '1', 08:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:19 INFO - 'NO_EM_RESTART': '1', 08:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:19 INFO - 'PWD': '/builds/slave/test', 08:25:19 INFO - 'SHELL': '/bin/bash', 08:25:19 INFO - 'SHLVL': '1', 08:25:19 INFO - 'TERM': 'linux', 08:25:19 INFO - 'TMOUT': '86400', 08:25:19 INFO - 'USER': 'cltbld', 08:25:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:19 INFO - '_': '/tools/buildbot/bin/python'} 08:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:19 INFO - Cleaning up... 08:25:19 INFO - Return code: 0 08:25:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:19 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 08:25:19 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 08:25:19 INFO - Using env: {'DISPLAY': ':0', 08:25:19 INFO - 'HOME': '/home/cltbld', 08:25:19 INFO - 'LANG': 'en_US.UTF-8', 08:25:19 INFO - 'LANGUAGE': 'en_US:en', 08:25:19 INFO - 'LOGNAME': 'cltbld', 08:25:19 INFO - 'MAIL': '/var/mail/cltbld', 08:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:19 INFO - 'MOZ_NO_REMOTE': '1', 08:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:19 INFO - 'NO_EM_RESTART': '1', 08:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:19 INFO - 'PWD': '/builds/slave/test', 08:25:19 INFO - 'SHELL': '/bin/bash', 08:25:19 INFO - 'SHLVL': '1', 08:25:19 INFO - 'TERM': 'linux', 08:25:19 INFO - 'TMOUT': '86400', 08:25:19 INFO - 'USER': 'cltbld', 08:25:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:19 INFO - '_': '/tools/buildbot/bin/python'} 08:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:19 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 08:25:19 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 08:25:19 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 08:25:19 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 08:25:19 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 08:25:19 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 08:25:22 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:23 INFO - Downloading docopt-0.6.1.tar.gz 08:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:23 INFO - Running setup.py install for blobuploader 08:25:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:23 INFO - Running setup.py install for requests 08:25:23 INFO - Running setup.py install for docopt 08:25:24 INFO - Successfully installed blobuploader requests docopt 08:25:24 INFO - Cleaning up... 08:25:24 INFO - Return code: 0 08:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:24 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:24 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 08:25:24 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 08:25:24 INFO - Using env: {'DISPLAY': ':0', 08:25:24 INFO - 'HOME': '/home/cltbld', 08:25:24 INFO - 'LANG': 'en_US.UTF-8', 08:25:24 INFO - 'LANGUAGE': 'en_US:en', 08:25:24 INFO - 'LOGNAME': 'cltbld', 08:25:24 INFO - 'MAIL': '/var/mail/cltbld', 08:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:24 INFO - 'MOZ_NO_REMOTE': '1', 08:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:24 INFO - 'NO_EM_RESTART': '1', 08:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:24 INFO - 'PWD': '/builds/slave/test', 08:25:24 INFO - 'SHELL': '/bin/bash', 08:25:24 INFO - 'SHLVL': '1', 08:25:24 INFO - 'TERM': 'linux', 08:25:24 INFO - 'TMOUT': '86400', 08:25:24 INFO - 'USER': 'cltbld', 08:25:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:24 INFO - '_': '/tools/buildbot/bin/python'} 08:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:24 INFO - Running setup.py (path:/tmp/pip-VxE4qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:24 INFO - Running setup.py (path:/tmp/pip-WVechf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:24 INFO - Running setup.py (path:/tmp/pip-9sfNbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:24 INFO - Running setup.py (path:/tmp/pip-zlRJRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:24 INFO - Running setup.py (path:/tmp/pip-2hHdWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:24 INFO - Running setup.py (path:/tmp/pip-JqmMNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:24 INFO - Running setup.py (path:/tmp/pip-uLcxd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:24 INFO - Running setup.py (path:/tmp/pip-fMDfsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:24 INFO - Running setup.py (path:/tmp/pip-13B9Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:24 INFO - Running setup.py (path:/tmp/pip-HpUMkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:25 INFO - Running setup.py (path:/tmp/pip-jd_M_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:25 INFO - Running setup.py (path:/tmp/pip-6p8dnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:25 INFO - Running setup.py (path:/tmp/pip-LOIWVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:25 INFO - Running setup.py (path:/tmp/pip-cqBSqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:25 INFO - Running setup.py (path:/tmp/pip-xCOYzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:25 INFO - Running setup.py (path:/tmp/pip-kX78TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:25 INFO - Running setup.py (path:/tmp/pip-NflH75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:25 INFO - Running setup.py install for manifestparser 08:25:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:25 INFO - Running setup.py install for mozcrash 08:25:25 INFO - Running setup.py install for mozdebug 08:25:25 INFO - Running setup.py install for mozdevice 08:25:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozfile 08:25:26 INFO - Running setup.py install for mozhttpd 08:25:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozinfo 08:25:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozInstall 08:25:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozleak 08:25:26 INFO - Running setup.py install for mozlog 08:25:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for moznetwork 08:25:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozprocess 08:25:26 INFO - Running setup.py install for mozprofile 08:25:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:26 INFO - Running setup.py install for mozrunner 08:25:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:27 INFO - Running setup.py install for mozscreenshot 08:25:27 INFO - Running setup.py install for moztest 08:25:27 INFO - Running setup.py install for mozversion 08:25:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:27 INFO - Cleaning up... 08:25:27 INFO - Return code: 0 08:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:27 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:27 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 08:25:27 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 08:25:27 INFO - Using env: {'DISPLAY': ':0', 08:25:27 INFO - 'HOME': '/home/cltbld', 08:25:27 INFO - 'LANG': 'en_US.UTF-8', 08:25:27 INFO - 'LANGUAGE': 'en_US:en', 08:25:27 INFO - 'LOGNAME': 'cltbld', 08:25:27 INFO - 'MAIL': '/var/mail/cltbld', 08:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:27 INFO - 'MOZ_NO_REMOTE': '1', 08:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:27 INFO - 'NO_EM_RESTART': '1', 08:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:27 INFO - 'PWD': '/builds/slave/test', 08:25:27 INFO - 'SHELL': '/bin/bash', 08:25:27 INFO - 'SHLVL': '1', 08:25:27 INFO - 'TERM': 'linux', 08:25:27 INFO - 'TMOUT': '86400', 08:25:27 INFO - 'USER': 'cltbld', 08:25:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:27 INFO - '_': '/tools/buildbot/bin/python'} 08:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:27 INFO - Running setup.py (path:/tmp/pip-yp2nw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:27 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)) 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:27 INFO - Running setup.py (path:/tmp/pip-_YHXkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:27 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)) 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:27 INFO - Running setup.py (path:/tmp/pip-n_l2Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:27 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)) 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:27 INFO - Running setup.py (path:/tmp/pip-_uMQcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:27 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)) 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:27 INFO - Running setup.py (path:/tmp/pip-lGe6nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:27 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)) 08:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:27 INFO - Running setup.py (path:/tmp/pip-5fmw0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:28 INFO - Running setup.py (path:/tmp/pip-v2OGQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:28 INFO - Running setup.py (path:/tmp/pip-H66UHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:28 INFO - Running setup.py (path:/tmp/pip-ZNlwpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:28 INFO - Running setup.py (path:/tmp/pip-195ocU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:28 INFO - Running setup.py (path:/tmp/pip-g0dndO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:28 INFO - Running setup.py (path:/tmp/pip-K0f_IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:28 INFO - Running setup.py (path:/tmp/pip-x04p7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:28 INFO - Running setup.py (path:/tmp/pip-qyAAiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:28 INFO - Running setup.py (path:/tmp/pip-R8M7UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:28 INFO - Running setup.py (path:/tmp/pip-yBKV2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:28 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)) 08:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:28 INFO - Running setup.py (path:/tmp/pip-WO4W0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:28 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)) 08:25:28 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)) 08:25:28 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)) 08:25:28 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)) 08:25:28 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)) 08:25:28 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)) 08:25:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:28 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 08:25:28 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 08:25:28 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 08:25:28 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 08:25:28 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 08:25:28 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 08:25:31 INFO - Downloading blessings-1.6.tar.gz 08:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:31 INFO - Installing collected packages: blessings 08:25:31 INFO - Running setup.py install for blessings 08:25:31 INFO - Successfully installed blessings 08:25:31 INFO - Cleaning up... 08:25:31 INFO - Return code: 0 08:25:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:31 INFO - Reading from file tmpfile_stdout 08:25:31 INFO - Current package versions: 08:25:31 INFO - argparse == 1.2.1 08:25:31 INFO - blessings == 1.6 08:25:31 INFO - blobuploader == 1.2.4 08:25:31 INFO - docopt == 0.6.1 08:25:31 INFO - functools32 == 3.2.3-2 08:25:31 INFO - jsonschema == 2.5.1 08:25:31 INFO - manifestparser == 1.1 08:25:31 INFO - mozInstall == 1.12 08:25:31 INFO - mozcrash == 0.17 08:25:31 INFO - mozdebug == 0.1 08:25:31 INFO - mozdevice == 0.48 08:25:31 INFO - mozfile == 1.2 08:25:31 INFO - mozhttpd == 0.7 08:25:31 INFO - mozinfo == 0.9 08:25:31 INFO - mozleak == 0.1 08:25:31 INFO - mozlog == 3.3 08:25:31 INFO - moznetwork == 0.27 08:25:31 INFO - mozprocess == 0.23 08:25:31 INFO - mozprofile == 0.28 08:25:31 INFO - mozrunner == 6.12 08:25:31 INFO - mozscreenshot == 0.1 08:25:31 INFO - mozsystemmonitor == 0.3 08:25:31 INFO - moztest == 0.7 08:25:31 INFO - mozversion == 1.4 08:25:31 INFO - psutil == 3.1.1 08:25:31 INFO - requests == 1.2.3 08:25:31 INFO - wsgiref == 0.1.2 08:25:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:31 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 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:31 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 08:25:31 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 08:25:31 INFO - Using env: {'DISPLAY': ':0', 08:25:31 INFO - 'HOME': '/home/cltbld', 08:25:31 INFO - 'LANG': 'en_US.UTF-8', 08:25:31 INFO - 'LANGUAGE': 'en_US:en', 08:25:31 INFO - 'LOGNAME': 'cltbld', 08:25:31 INFO - 'MAIL': '/var/mail/cltbld', 08:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:31 INFO - 'MOZ_NO_REMOTE': '1', 08:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:31 INFO - 'NO_EM_RESTART': '1', 08:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:31 INFO - 'PWD': '/builds/slave/test', 08:25:31 INFO - 'SHELL': '/bin/bash', 08:25:31 INFO - 'SHLVL': '1', 08:25:31 INFO - 'TERM': 'linux', 08:25:31 INFO - 'TMOUT': '86400', 08:25:31 INFO - 'USER': 'cltbld', 08:25:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:31 INFO - '_': '/tools/buildbot/bin/python'} 08:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 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)) 08:25:32 INFO - Cleaning up... 08:25:32 INFO - Return code: 0 08:25:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7800306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', '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 08:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:25:32 INFO - Using env: {'DISPLAY': ':0', 08:25:32 INFO - 'HOME': '/home/cltbld', 08:25:32 INFO - 'LANG': 'en_US.UTF-8', 08:25:32 INFO - 'LANGUAGE': 'en_US:en', 08:25:32 INFO - 'LOGNAME': 'cltbld', 08:25:32 INFO - 'MAIL': '/var/mail/cltbld', 08:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:32 INFO - 'MOZ_NO_REMOTE': '1', 08:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:32 INFO - 'NO_EM_RESTART': '1', 08:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:32 INFO - 'PWD': '/builds/slave/test', 08:25:32 INFO - 'SHELL': '/bin/bash', 08:25:32 INFO - 'SHLVL': '1', 08:25:32 INFO - 'TERM': 'linux', 08:25:32 INFO - 'TMOUT': '86400', 08:25:32 INFO - 'USER': 'cltbld', 08:25:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:32 INFO - '_': '/tools/buildbot/bin/python'} 08:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:32 INFO - Cleaning up... 08:25:32 INFO - Return code: 0 08:25:32 INFO - Running post-action listener: _resource_record_post_action 08:25:32 INFO - Running post-action listener: _start_resource_monitoring 08:25:32 INFO - Starting resource monitoring. 08:25:32 INFO - [mozharness: 2016-08-19 15:25:32.278555Z] Finished create-virtualenv step (success) 08:25:32 INFO - [mozharness: 2016-08-19 15:25:32.279119Z] Running install step. 08:25:32 INFO - Running pre-action listener: _resource_record_pre_action 08:25:32 INFO - Running main action method: install 08:25:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:32 INFO - Reading from file tmpfile_stdout 08:25:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:32 INFO - Reading from file tmpfile_stdout 08:25:32 INFO - Output received: 08:25:32 INFO - Usage: mozinstall [options] installer 08:25:32 INFO - Options: 08:25:32 INFO - -h, --help show this help message and exit 08:25:32 INFO - -d DEST, --destination=DEST 08:25:32 INFO - Directory to install application into. [default: 08:25:32 INFO - "/builds/slave/test"] 08:25:32 INFO - --app=APP Application being installed. [default: firefox] 08:25:32 INFO - mkdir: /builds/slave/test/build/application 08:25:32 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'] 08:25:32 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 08:25:48 INFO - Reading from file tmpfile_stdout 08:25:48 INFO - Output received: 08:25:48 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - [mozharness: 2016-08-19 15:25:48.677515Z] Finished install step (success) 08:25:48 INFO - [mozharness: 2016-08-19 15:25:48.677625Z] Running run-tests step. 08:25:48 INFO - Running pre-action listener: _resource_record_pre_action 08:25:48 INFO - Running main action method: run_tests 08:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:48 INFO - Python 2.7.3 08:25:48 INFO - Return code: 0 08:25:48 INFO - grabbing minidump binary from tooltool 08:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:48 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 0x1506090>, '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 0x15099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1509e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:48 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 08:25:48 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 08:25:48 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 08:25:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:48 INFO - Return code: 0 08:25:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 08:25:48 INFO - Using env: {'DISPLAY': ':0', 08:25:48 INFO - 'HOME': '/home/cltbld', 08:25:48 INFO - 'LANG': 'en_US.UTF-8', 08:25:48 INFO - 'LANGUAGE': 'en_US:en', 08:25:48 INFO - 'LOGNAME': 'cltbld', 08:25:48 INFO - 'MAIL': '/var/mail/cltbld', 08:25:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:48 INFO - 'MOZ_NO_REMOTE': '1', 08:25:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:48 INFO - 'NO_EM_RESTART': '1', 08:25:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:48 INFO - 'PWD': '/builds/slave/test', 08:25:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:48 INFO - 'SHELL': '/bin/bash', 08:25:48 INFO - 'SHLVL': '1', 08:25:48 INFO - 'TERM': 'linux', 08:25:48 INFO - 'TMOUT': '86400', 08:25:48 INFO - 'USER': 'cltbld', 08:25:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850', 08:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:48 INFO - '_': '/tools/buildbot/bin/python'} 08:25:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:25:48 INFO - mozversion application_buildid: 20160819071322 08:25:48 INFO - mozversion application_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 08:25:48 INFO - mozversion application_display_name: Nightly 08:25:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:48 INFO - mozversion application_name: Firefox 08:25:48 INFO - mozversion application_remotingname: firefox 08:25:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:25:48 INFO - mozversion application_vendor: Mozilla 08:25:48 INFO - mozversion application_version: 51.0a1 08:25:48 INFO - mozversion platform_buildid: 20160819071322 08:25:48 INFO - mozversion platform_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 08:25:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:25:48 INFO - mozversion platform_version: 51.0a1 08:25:48 INFO - using testdate: 1471620348 08:25:48 INFO - actual date: 1471620348 08:25:48 INFO - starting webserver on 'localhost:32847' 08:25:48 INFO - SUITE-START | Running 2 tests 08:25:48 INFO - TEST-START | dromaeo_css 08:25:48 INFO - operating with platform_type : linux_ 08:25:48 INFO - Initialising browser for dromaeo_css test... 08:25:48 INFO - TEST-INFO | started process 14346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmjeeTM/profile http://localhost:32847/getInfo.html) 08:25:53 INFO - PROCESS | 14346 | __metrics Screen width/height:1600/1200 08:25:53 INFO - PROCESS | 14346 | colorDepth:24 08:25:53 INFO - PROCESS | 14346 | Browser inner width/height: 1024/697 08:25:53 INFO - PROCESS | 14346 | __metrics 08:25:54 INFO - PROCESS | 14346 | 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" 08:25:54 INFO - PROCESS | 14346 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:54 INFO - PROCESS | 14346 | console.error: PushService: 08:25:54 INFO - PROCESS | 14346 | stateChangeProcessEnqueue: Error transitioning state 08:25:54 INFO - PROCESS | 14346 | UnknownError 08:25:55 INFO - TEST-INFO | 14346: exit 0 08:25:55 INFO - Browser initialized. 08:25:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:55 INFO - TEST-INFO | started process 14426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmjeeTM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:07 INFO - PROCESS | 14426 | RSS: Main: 157401088 08:26:07 INFO - PROCESS | 14426 | 08:26:58 INFO - PROCESS | 14426 | 1471620418871 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] 08:29:10 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32847/tests/dromaeo/cssquery-ext.html) 08:29:12 INFO - PROCESS | 14426 | RSS: Main: 237506560 08:29:12 INFO - PROCESS | 14426 | 08:32:14 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-ext.html (next: http://localhost:32847/tests/dromaeo/cssquery-jquery.html) 08:32:15 INFO - PROCESS | 14426 | RSS: Main: 250863616 08:32:15 INFO - PROCESS | 14426 | 08:35:17 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32847/tests/dromaeo/cssquery-mootools.html) 08:35:18 INFO - PROCESS | 14426 | RSS: Main: 187150336 08:35:18 INFO - PROCESS | 14426 | 08:38:20 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32847/tests/dromaeo/cssquery-prototype.html) 08:38:21 INFO - PROCESS | 14426 | RSS: Main: 189747200 08:38:21 INFO - PROCESS | 14426 | 08:41:24 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32847/tests/dromaeo/cssquery-yui.html) 08:41:24 INFO - PROCESS | 14426 | RSS: Main: 190562304 08:41:24 INFO - PROCESS | 14426 | 08:44:27 INFO - PROCESS | 14426 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-yui.html (next: http://localhost:32847/tests/dromaeo/cssquery-dojo.html) 08:44:28 INFO - PROCESS | 14426 | RSS: Main: 284282880 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | __start_tp_report 08:44:28 INFO - PROCESS | 14426 | _x_x_mozilla_page_load 08:44:28 INFO - PROCESS | 14426 | _x_x_mozilla_page_load_details 08:44:28 INFO - PROCESS | 14426 | |i|pagename|runs| 08:44:28 INFO - PROCESS | 14426 | |0;dojo.html;2565.64081028656;2568.396426839693;2598.2205338398476;2609.7651211390985;2612.830166039207;4571.108633816407;4592.931106033412;4636.536346365362;4719.457262414823;4720.221163508017;4606.5393460654;4617.584417402433;4653.208954477738;4659.301104834268;4707.811687532503;4061.3501839705505;4265.296226122686;4284.97857510712;4304.698671093009;4309.396684464177;4295.634871035965;4311.568843115679;4328.7706830981915;4338.240807858628;4338.522762496123;4192.182524407742;4231.597998190167;4241.406203131564;4306.095719898809;4318.460192475941;4232.555581663912;4253.80857861397;4268.87193384199;4283.807228674717;4302.827886884521;4239.51245606753;4273.209456250604;4279.422277992462;4282.914341713179;4286.699931004831;4669.789859456333;4684.508126646687;4691.695039822401;4692.155412025834;4701;4829.10661527615;4913.557779799799;4951.232558953368;4968.503149685039;4988.950110498921;4992.226204938241;4993.6005119590345;5004.924926126111;5005.424376196747;5006.799728010875;4687.039156972813;4694.319323698045;4700.976495117503;4741.715497070118;4748.477667456577;4933.45731969483;5018;5084.618653600995;5086.491350864884;5140.280360749498;4929.704217746875;4931.50684931504;4937.432195297515;4937.654364194544;4938.654294199371;5002.09962206799;5005.224190250444;5007.899842003139;5009.223570346602;5026.623003274769;4812.374391329175;4842.128416884994;4904.362432883774;4908.263760435963;4947.604191664658;4936.90126197474;4945.802167913315;4948.406191257072;4954.578860796801;4962.925556116661;4200.369944508348;4200.537940826506;4208.621224089786;4219.113986062961;4222.197782421392;3586.605473397924;3628.7097032237357;3654.6710796028483;3687.1335236219466;3744.9438258426144;4289.420928174719;4294.184105020036;4301.247281725686;4303.634191093792;4306.612404883575;5041.873953151127;5047.772850221749;5048.242763585418;5052.317937078521;5061.898762024739;4180.874573762792;4240.427542281815;4261.74429534229;4261.850835220753;4336.284513055373;4520.118576877543;4536;4537.705049171859;4543.114092751948;4546.704464209815;4739.241721324572;4754.381930349033;4755.0727608116085;4759.0719809637485;4777.474477807369;4862.270659400977;4949.282354058713;4981.42713587942;5004.5746111579465;5062.164742817394;4740.644451666208;4756.310335001474;4761.119192949315;4762.047590481849;4778.1638213311835;4963.429205641253;4964.156093464047;4966.956939042841;4974.452810190804;4977.576905963034;4829.44461386945;4898.730569818552;4931.211006238985;4958.776855041459;5010.899782004412;4856.660033797601;4872.756362181806;4875.293082503088;4878.024395120919;4888.535589119028;4849.248366503198;4860.975695121501;4863.659543831898;4880.438749543848;4881.463039065629;4659.161350956861;4719.457262414866;4765.309030190672;4774.976125119352;4821.467820248955;4891.657583969088;4914.238293064581;4925.310456536016;4929.482404347636;4929.556339929423;4824.8793780155775;4831.613470922388;4832.130216561053;4832.8791780205775;4834.444038935568 08:44:28 INFO - PROCESS | 14426 | |1;ext.html;556.0658094401407;564.9802256921008;565.7821738630629;566.9149627555867;573.8995675756742;39738.60261397389;41311.58688413119;41320;44337.77831110848;44391.334129988;41233;41562.7921860391;41609;41634.58365416345;41697.58302416975;7429.702811887518;7589.658465369058;7731.724265496215;7736.690532378698;9597.66408175714;9863.26025548083;10007.099361057504;10018.899811001906;10023.097921187129;10027.298089133763;10100;10131.848022279672;10134.645287414942;10141.645042423517;10150.898491015068;10072.446015469146;10079.09288164065;10110.19118470528;10127.544260508257;10139.746506337327;9638.42169469834;9702.27232957531;9704.320697551175;9704.61181552737;9716.465594392306;39023.609763902285;39510;39523.80238098791;39541.20917581661;39633.40549891754;2960.407918416325;2992.1621945855195;3311.304626028537;3632.055665526982;3669.944950825713;28793.424131517462;29304.267393315124;29351.2662183445;29507.40985180306;29714.85142574295;3335.799852008863;3337.8664853405835;3435.7423193260606;3451.4132597458242;3475.8088305143206;243585;243993;244902;245171;246424;52324.476755232725;52519;52573.7371313141;52626.52674522632;52672;56396.71801640966;56428.717856410454;56536;56580.71709641426;56595.71702141463;12587.811182832265;12766.80849787254;12800.35998200105;12812;12815.807762883564;9042.231410330063;9155.404898681565;9201.309901757395;9423.811523769486;9450.480223587769;16664.083475408726;16673.749893751603;16730.6653866922;16736.581585460463;16824.579385515215;5897.557683173779;5902.586818922634;5962.970185149046;6031.457168854824;6087.726052327655;679.5005670831935;697.7104501631766;847.7456762971208;877.4559772940818;984.8965858584888;25508.489830203293;27883.860580696968;28425.43149137006;28438.85780571084;28495.28761780972;853.4751128056325;944.1313991128178;953.7806304549993;996.7607774134301;1004.924630652704;13543.932280338535;14554.272286385638;14663.92668036653;14952.327145278488;15001.2499375033;121871.39064304798;122608;122714.38642806729;123486;123726.38136809258;47816.7609161952;47978.28032579514;48024.519754802706;48033.75983120062;48080.759596201795;1024.897510248984;1106.5573770491867;1114.8439218509252;1118.1613789657756;1135.483355073456;27085.729142708322;28479.572806407505;28952.276193094498;29137.125886223446;29362.265943351587;42236.155276894904;42862.35706464468;42906.570934290256;42927.785361072994;42936;231444;232936;233040;233173;372153;24232.515349692556;25396.74603253944;25491.617625736;25744;25808.61287080733;42715;42887;43157.352639711055;43326.350104749086;44021.55978440175;35814.28371432609;37023.81488092542;37039.629603703615;37152.44271335878;37208.44187337246;34264.65735342615;36540.45189322109;36572.451413229355;36642.26715465623;36967.81516092402;36017.63982360143;36070.63929360673;36242.63757362498;36860.262794743416;36936.44595331018;30696;32756.50865237071;32842;32855;33185.66814331826;24511.877440612683;24623.753762462864;24767.7399687156;24948.37629059288;25167.24498265055 08:44:28 INFO - PROCESS | 14426 | |2;jquery.html;355.433084230652;375.39561306296866;376.1630372421363;382.8793929912077;393.13902553408036;11990.220635658676;15864.762028569567;15966.28151733172;16270.186490675449;17027.48917532476;14531.927340363283;14654.122745548242;14824.703505929874;14964.401423943029;14995.47515836946;4433.467983841943;4953.207486802113;5138.229265610151;5177.48225177483;5180.948190518103;4977.352944117278;5062.26597143414;5063.873403164914;5070.6816227780855;5070.873228169288;4837.177679794443;5008.373953255843;5030.57240134589;5042.042012017723;5044.167712327461;5072.416672082721;5106.106431374495;5112.309838171855;5117.488251174853;5117.641765076428;4400.911981760379;4504.774761261957;4576.244919588297;4581.67928245023;4589.380433641449;19140.425787226406;19794.208231670716;20989.16043358279;21125.89437052805;21141.048652810507;1781.3141940352928;1839.3562253211403;1853.4717605482372;1895.7914629390757;1968.4193163016944;8998.820023599557;9084.865056711667;9241.353105282633;9726.854097188478;9785.755356116082;1705.8976461412356;1719.123247143953;1747.1788259518132;1762.02207774685;1794.5369409451237;62345.68827155835;67046.66476667635;68206.65896670485;68494.65752671254;69354.3064569358;9981.00189980996;9985.002999400149;10127.442990635438;10214.64248751305;10278.486075696186;13294.401751921187;13313.267770272534;13324.733505330032;13345.399457024458;13417.262050587311;6400.423961843363;6643.634600097041;6801.081853949752;6944.201416837129;6953.79138625842;5953.255843019622;5981.611195272293;6194.34959329273;6258.468030217483;6258.843528911813;3997.84008639657;4070.9796451018146;4076.7146299759324;4204.8528301509305;4207.915841683149;1703.4038086669566;1777.146969454669;1789.1412122181425;1794.1926133240095;1805.7562229098903;779.1585088104833;782.2177822177822;807.4751411582519;813.7396033269415;906.3746015249457;16157.192140392934;17265.223064962105;17339.306427743002;17450.47648570545;17482;793.5357815677893;815.09524427885;832.450582615483;832.8292699996487;842.4103127810557;9090.318226133066;9691.951540242253;9717.708468745948;9756.756081098029;9843.507824608741;259891;384449;387060;387389;387606;52319;71296;71336.64331678412;81135;83014.58492707618;868.7437206024238;879.2921698033017;891.2157301574443;894.1952242981239;943.8584212368199;14734;15687.215639218222;16432.83567164313;16453.683705303785;16707.749383759496;38807.61192388153;39205;39359.803200984956;39811.80094099511;39961.80019099886;49704.50295497143;50628.74685626548;50736.23895641642;50920.14418341938;52759.472405275454;7033.085698859116;7623.4663573549315;7726.690932362642;7786.883196752166;8029.638666259915;10556.683299501028;11080.39057851826;11088.833667495155;11106.61126860556;11634.709132271422;6235;6955.339242771928;9367.5784589695;9597.47213903242;10137.087662110445;9518.571664275263;9543.761405964906;9566.61733530651;9677.37097088687;9826.459544725109;9235.26117910552;9451.243900488082;9504.95247523758;9997.300188986701;10120;7011.964940175267;7249.528780629243;7356.374708149653;7556.811079723051;7803.8829417557645;8865.734027979172;9207.677731279373;9293.488858112869;10188.898111018794;10402.687919362432 08:44:28 INFO - PROCESS | 14426 | |3;mootools.html;1347.9460821567134;1385.8891288696905;1394.365563668531;1597.1774536113896;1632.2083789362164;7307.305805948433;7930.36557075434;7940.801479963004;7947.801304967365;7952.92047079529;6763.932360676392;7374.188839227681;7582.696692132322;7597.582132982684;7817.804554886131;2159;2191.857529260601;2198.1317379635034;2198.4393979535275;2210.5136869888597;2129.4037669452578;2148.699182114505;2202.592520383726;2203.052687344449;2206.3160420269687;2176.281826997087;2183.257692384589;2188.7592364839857;2192.9342119736434;2240.1599400224914;2150.4301360139575;2154.041451554059;2160.114353115215;2160.935171944844;2161.827053835689;2153.7738537453497;2186.2348178137686;2187.409399462152;2188.715466989297;2194.583029224458;7763.107242667109;7818.257265559762;7858.724944626911;7861.803454913673;7867.331276841475;4268.466441694788;4434.667399945017;4435.002124521957;4435.667324950641;4443.266860967937;2981.1652737233608;3023.4104349651825;3090.6909309069138;3114.4394009078355;3117.0804612639326;908.7319240823973;949.7435692363092;950.5627411390768;964.2045312617118;993.0169132558786;10787.514561844735;10804.67585972422;10823.783524329549;10847.240693151483;10853;4004.6596039336982;4177.770222637784;4281.422008028939;4287.485501739811;4374.868753937323;9094.86357704635;9137.543122843965;9143.54282285883;9145.496997665192;9163.358564900527;4459.1304695584695;4469.508354081048;4471.552844715502;4473.977630111829;4474.7762611869275;3522.823858807101;3896.59085795993;4022.8390864365097;4030;4030.7581545107387;3567.464880267981;3600.71194304455;3682.6869716073898;3750.9062273443383;3773.811309434517;1184.5972369394447;1184.7452797648375;1189.149757923089;1205.0600531585203;1217.34263497712;694.836713372357;809.2918696140877;839.6725277141919;841.3689732700352;869.7825543614097;5071.315372424676;5112.182050871843;5212.921806172911;5231.9476805232225;5284.180951952453;393.7460338081921;415.20695471649003;416.0908415112988;419.7670292987421;420.80853211788565;3598.8020658864016;3606.495090687306;3689.5756987946193;3937.645611894886;3940.2710498557285;9444.8583271251;9608.943016268206;9664.806703865883;9835.508224588884;9853.950730246446;9690.37012594179;9782.755431114138;9802.65690700822;9805.362651427635;9813.264005199639;7133.464990125762;7222.169450513154;7269.745558905519;7349.412047036224;7356.301151390609;5151.782906264502;5219.269302297757;5270.525652691276;5323.068463018879;5371.140617501181;8778.122187781171;8955.686550970946;8974.955125224333;8990.460572365417;9044.638214471348;8813.691520796741;8956.68651597191;9036.864447033167;9039.096090390909;9073.727788166365;5921.289445266596;6260.186175797117;6426.871462570816;6500.089987401673;6520.967395162994;7214.6392680364725;7442.7395041173295;7443.292887175709;7444.664990075568;7449.627518623939;6335.049742538656;6392.328805475358;6393.2967373587935;6400.423961843457;6605.801825945229;6236.469900058546;6278.811635650938;6344.365563443619;6381.106645069787;6429.260635027032;6144.354842741626;6227.221597300338;6232.532560057924;6234.0337247726675;6234.096056071935;4619.422572178478;4667.929981050355;4697.5302469754115;4703.365045718784;4778.522147785194;4485.497358384847;4502.954970450253;4570.520095390069;4627;4712.316714076508 08:44:28 INFO - PROCESS | 14426 | |4;prototype.html;292.5319488817891;300.9744171745402;301.46189052541206;304.423118191028;309.10976388002547;4815.37400137982;4840.370751802261;4851;4865.708057516547;4887.462379138292;4786.904261914759;4790.257510085942;4802.519748025195;4825.300331451937;4830.541098595637;3600.90997725057;3703.1482758965453;3721.1999420124666;3728.291624591319;3749.5125633667585;3633.454981752745;3751.1372384351616;3789.4694742736037;3809.4095415210686;3835.789031603261;3766.8699390182974;3769.2649933263024;3776.2258736958856;3781.754185977916;3783.262263858535;3537.6816086552076;3716.1824398632257;3770.547534295875;3771.981140094282;3776.9055773605605;3247.1232767152974;3252.1381833814057;3254.804711717281;3255.544223808669;3255.755818313636;4664.976675116603;4666.206744853349;4680.578747912704;4710.505396933341;4713.764311784397;4247.341662042389;4249.086446414036;4252;4252.702310838243;4256.659467242614;4910.705357678551;4964.478729733362;5013.89972200554;5015.724135172564;5037.244413337992;3549;3561.3767590671787;3562.946555801665;3568.0901370150705;3571.4285714285847;5254.689545586294;5255.237990491358;5274.7626356814035;5285.709285989269;5289.285946397225;3494.2138018945534;3579.2483578448296;3589.9178476483576;3597.5503062117236;3604.513390692223;3647.1611529348397;3649.0512466758832;3651.087228192952;3651.926961460756;3665.1753355495334;4181;4183.707140500136;4184.163167366539;4193.182329445729;4195.937060944088;4994.525520075587;5000.249962505581;5004.424491183488;5012.273220383097;5037.319961805109;1213.9028877689764;1274.9736462147875;1283.865194154619;1288.4395288049727;1288.5812111063942;777.8211011467281;807.8488154380102;810.8702607582759;819.2626636027622;820.8153165537825;4264.445622069111;4326.697131200849;4431.135928493913;4453.55464453552;4486.1252055849445;5207.323048003811;5215.13950198213;5218;5223.817166399158;5226.137687281632;4443.511213766483;4461.843835465743;4470.240059189946;4473.396091527602;4480.4175457191;2678.2902530829347;2734.740199681027;2750.4911591355662;2755.7244275572284;2785.3454438207004;4914.771307173207;4918.385201849769;4920.957802511989;4926.261060840831;4929.852104436873;5049.444561098277;5319.973400133052;5337.466253374631;5338.252644629755;5342.263764276626;4855.344528488608;4869.878253043631;4904.705717656952;4905.6075513958085;4946.703197808143;5205.271262023244;5213.227502649118;5213.582913366998;5227.817026404057;5237.502437268454;4886.853394398174;5084.466131056334;5125.641205115606;5128.615353848401;5135.948640513547;4894.681845680019;4898.7550622468025;4906;4912.189488734319;4948.38145231846;3643.4534819777246;3660.6156353583556;3673.7244706647643;3674.283514714605;3679.411294192916;4975.228839529878;5207.3490813648295;5211.166213405989;5214.957008598371;5227.079690232325;5026.698398096126;5039.84880453587;5050.747462626928;5051.646384753032;5070.264811602223;4972.254161875748;4973.104841128632;5006.1739812930455;5048.974755126201;5049.762808111889;4781.282807578891;4886.486918873467;4916.188828843201;4956.529129732669;4976.477469865612;4854.757262136808;4951.9257211142585;4976.308055261228;5025.447200807835;5045.990801839574;4769.73766442849;4865.756712164449;4874.878128046827;4876.463589005278;4904.435989861212 08:44:28 INFO - PROCESS | 14426 | |5;yui.html;633.8098570428871;656.524020085438;687.8005378440249;708.5606923707302;752.6161657554645;11561.132915031374;12181.269123852564;12226.816597751018;12327.938360308208;12365.381730913452;12510.93744531276;13000.28498432586;13066.934665326684;13173;13208.603741887759;612.944834964853;753.4913933095166;767.6200280860953;770.6917233106747;771.3906014248737;725.7967769024682;757.6628400361841;761.9161892191854;764.831737017858;765.8736308509117;811.8295158016823;813.6704634622987;813.7111325479458;814.2630919018297;815.2051749544177;651.3649192037773;808.5714571277232;809.4212637963855;809.6761295481825;810.3031393002013;573.1059547106486;587.6620942957817;588.4233451217831;591.6864062047079;592.6236839606837;12786.104972651918;12794.360281985864;12835.294058826761;12852.35738213095;12892.548760793421;11458.255213411101;11601.419929003516;12156.270623762513;12445.937770311091;13517.121387109806;10465.267431279814;10610.840837387444;11873.346965916871;11937.40312984356;11944.880551194463;3328.983355083209;3381.2561236527927;3435.2442462658173;3474.4614584739406;3506.0358401439807;60634.696826516025;62431.37568624347;62963.6851815738;63184.684076579324;63657;9231.261499080058;9295.395799273025;9564.90435095654;9579.760505987406;9613.615455381707;17344.913275433795;17617.207225674876;17631.471055868344;17702;17709.38017169393;6687.498437617198;6740.224874139439;6744.190697116279;6750;6779.15260592426;3867.2458870519977;3904.8438062477185;3944.5660977292473;4072.8778136655355;4109.075458021981;2874.841883696417;3002.1894088595955;3006.7895247332913;3007.2331555453657;3009.5786589877434;509.08364943102265;510.97700603472936;514.5574805667123;522.1801771219225;523.0428316181379;480.52239363955977;600.0429315242181;607.8267693707361;612.935641757618;617.4597227426002;7785.727499537489;7976.880346794803;8202.138775428493;8418.915810841936;8637.568121593895;605.2222893581726;627.1940556385023;633.5596760251581;638.8722255548909;641.4900154377282;3667.2848794485353;3858.194432693101;4027.9194416111513;4069.206504731549;4188.6649068074485;55338;55380.44619553834;55572.44427555673;55589;69531.30468695248;82676.58661706652;90033.54983225041;90369;90772;91157;61717.38282617206;63537;67654;68707.999999999;76504.61747691226;8147.674093036212;8413.326933845156;8527.658893644184;8685.218330350046;9043.412178208395;28419;28749.425011500072;31448.842755786074;40318.1936361277;43450;51724.22413663873;58783.70608147103;60370.698146508985;61927.69036154971;64751.676241618494;10261.692149235534;10483;10533;10583.94708026455;10712.785744285227;12613.87386126127;12903.290319032169;13023;13149.671258218239;13315.933420332836;11720.765584688088;11746.941265293619;11986.880131198925;12094.637160885188;12097.092718046006;11926.582569610022;12099.274043557414;12574.685632859251;12701.4284357206;12776.169548979287;11433;11740.119491038036;11963.162578619762;12287.385630718249;12320.322382268703;9276.350655454053;9278.907210927804;9553.952230238805;9945.900540994497;9947.701568952943;9801.509924503604;10120.291579589359;10153.695389138338;10247.231457640557;10260.692179234635 08:44:28 INFO - PROCESS | 14426 | __end_tp_report 08:44:28 INFO - PROCESS | 14426 | __start_cc_report 08:44:28 INFO - PROCESS | 14426 | _x_x_mozilla_cycle_collect,1021 08:44:28 INFO - PROCESS | 14426 | __end_cc_report 08:44:28 INFO - PROCESS | 14426 | __startTimestamp1471621468212__endTimestamp 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | ------- Summary: start ------- 08:44:28 INFO - PROCESS | 14426 | Number of tests: 6 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#0] dojo.html Cycles:165 Average:4607.68 Median:4759.07 stddev:487.83 (10.3%) stddev-sans-first:462.27 08:44:28 INFO - PROCESS | 14426 | Values: 2565.6 2568.4 2598.2 2609.8 2612.8 4571.1 4592.9 4636.5 4719.5 4720.2 4606.5 4617.6 4653.2 4659.3 4707.8 4061.4 4265.3 4285.0 4304.7 4309.4 4295.6 4311.6 4328.8 4338.2 4338.5 4192.2 4231.6 4241.4 4306.1 4318.5 4232.6 4253.8 4268.9 4283.8 4302.8 4239.5 4273.2 4279.4 4282.9 4286.7 4669.8 4684.5 4691.7 4692.2 4701.0 4829.1 4913.6 4951.2 4968.5 4989.0 4992.2 4993.6 5004.9 5005.4 5006.8 4687.0 4694.3 4701.0 4741.7 4748.5 4933.5 5018.0 5084.6 5086.5 5140.3 4929.7 4931.5 4937.4 4937.7 4938.7 5002.1 5005.2 5007.9 5009.2 5026.6 4812.4 4842.1 4904.4 4908.3 4947.6 4936.9 4945.8 4948.4 4954.6 4962.9 4200.4 4200.5 4208.6 4219.1 4222.2 3586.6 3628.7 3654.7 3687.1 3744.9 4289.4 4294.2 4301.2 4303.6 4306.6 5041.9 5047.8 5048.2 5052.3 5061.9 4180.9 4240.4 4261.7 4261.9 4336.3 4520.1 4536.0 4537.7 4543.1 4546.7 4739.2 4754.4 4755.1 4759.1 4777.5 4862.3 4949.3 4981.4 5004.6 5062.2 4740.6 4756.3 4761.1 4762.0 4778.2 4963.4 4964.2 4967.0 4974.5 4977.6 4829.4 4898.7 4931.2 4958.8 5010.9 4856.7 4872.8 4875.3 4878.0 4888.5 4849.2 4861.0 4863.7 4880.4 4881.5 4659.2 4719.5 4765.3 4775.0 4821.5 4891.7 4914.2 4925.3 4929.5 4929.6 4824.9 4831.6 4832.1 4832.9 4834.4 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#1] ext.html Cycles:180 Average:38600.08 Median:36156.64 stddev:57761.80 (159.8%) stddev-sans-first:57853.20 08:44:28 INFO - PROCESS | 14426 | Values: 556.1 565.0 565.8 566.9 573.9 39738.6 41311.6 41320.0 44337.8 44391.3 41233.0 41562.8 41609.0 41634.6 41697.6 7429.7 7589.7 7731.7 7736.7 9597.7 9863.3 10007.1 10018.9 10023.1 10027.3 10100.0 10131.8 10134.6 10141.6 10150.9 10072.4 10079.1 10110.2 10127.5 10139.7 9638.4 9702.3 9704.3 9704.6 9716.5 39023.6 39510.0 39523.8 39541.2 39633.4 2960.4 2992.2 3311.3 3632.1 3669.9 28793.4 29304.3 29351.3 29507.4 29714.9 3335.8 3337.9 3435.7 3451.4 3475.8 243585.0 243993.0 244902.0 245171.0 246424.0 52324.5 52519.0 52573.7 52626.5 52672.0 56396.7 56428.7 56536.0 56580.7 56595.7 12587.8 12766.8 12800.4 12812.0 12815.8 9042.2 9155.4 9201.3 9423.8 9450.5 16664.1 16673.7 16730.7 16736.6 16824.6 5897.6 5902.6 5963.0 6031.5 6087.7 679.5 697.7 847.7 877.5 984.9 25508.5 27883.9 28425.4 28438.9 28495.3 853.5 944.1 953.8 996.8 1004.9 13543.9 14554.3 14663.9 14952.3 15001.2 121871.4 122608.0 122714.4 123486.0 123726.4 47816.8 47978.3 48024.5 48033.8 48080.8 1024.9 1106.6 1114.8 1118.2 1135.5 27085.7 28479.6 28952.3 29137.1 29362.3 42236.2 42862.4 42906.6 42927.8 42936.0 231444.0 232936.0 233040.0 233173.0 372153.0 24232.5 25396.7 25491.6 25744.0 25808.6 42715.0 42887.0 43157.4 43326.4 44021.6 35814.3 37023.8 37039.6 37152.4 37208.4 34264.7 36540.5 36572.5 36642.3 36967.8 36017.6 36070.6 36242.6 36860.3 36936.4 30696.0 32756.5 32842.0 32855.0 33185.7 24511.9 24623.8 24767.7 24948.4 25167.2 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#2] jquery.html Cycles:180 Average:23061.70 Median:5053.22 stddev:60398.01 (1195.2%) stddev-sans-first:60543.38 08:44:28 INFO - PROCESS | 14426 | Values: 355.4 375.4 376.2 382.9 393.1 11990.2 15864.8 15966.3 16270.2 17027.5 14531.9 14654.1 14824.7 14964.4 14995.5 4433.5 4953.2 5138.2 5177.5 5180.9 4977.4 5062.3 5063.9 5070.7 5070.9 4837.2 5008.4 5030.6 5042.0 5044.2 5072.4 5106.1 5112.3 5117.5 5117.6 4400.9 4504.8 4576.2 4581.7 4589.4 19140.4 19794.2 20989.2 21125.9 21141.0 1781.3 1839.4 1853.5 1895.8 1968.4 8998.8 9084.9 9241.4 9726.9 9785.8 1705.9 1719.1 1747.2 1762.0 1794.5 62345.7 67046.7 68206.7 68494.7 69354.3 9981.0 9985.0 10127.4 10214.6 10278.5 13294.4 13313.3 13324.7 13345.4 13417.3 6400.4 6643.6 6801.1 6944.2 6953.8 5953.3 5981.6 6194.3 6258.5 6258.8 3997.8 4071.0 4076.7 4204.9 4207.9 1703.4 1777.1 1789.1 1794.2 1805.8 779.2 782.2 807.5 813.7 906.4 16157.2 17265.2 17339.3 17450.5 17482.0 793.5 815.1 832.5 832.8 842.4 9090.3 9692.0 9717.7 9756.8 9843.5 259891.0 384449.0 387060.0 387389.0 387606.0 52319.0 71296.0 71336.6 81135.0 83014.6 868.7 879.3 891.2 894.2 943.9 14734.0 15687.2 16432.8 16453.7 16707.7 38807.6 39205.0 39359.8 39811.8 39961.8 49704.5 50628.7 50736.2 50920.1 52759.5 7033.1 7623.5 7726.7 7786.9 8029.6 10556.7 11080.4 11088.8 11106.6 11634.7 6235.0 6955.3 9367.6 9597.5 10137.1 9518.6 9543.8 9566.6 9677.4 9826.5 9235.3 9451.2 9505.0 9997.3 10120.0 7012.0 7249.5 7356.4 7556.8 7803.9 8865.7 9207.7 9293.5 10188.9 10402.7 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#3] mootools.html Cycles:180 Average:5093.41 Median:5091.75 stddev:2888.31 (56.7%) stddev-sans-first:2882.70 08:44:28 INFO - PROCESS | 14426 | Values: 1347.9 1385.9 1394.4 1597.2 1632.2 7307.3 7930.4 7940.8 7947.8 7952.9 6763.9 7374.2 7582.7 7597.6 7817.8 2159.0 2191.9 2198.1 2198.4 2210.5 2129.4 2148.7 2202.6 2203.1 2206.3 2176.3 2183.3 2188.8 2192.9 2240.2 2150.4 2154.0 2160.1 2160.9 2161.8 2153.8 2186.2 2187.4 2188.7 2194.6 7763.1 7818.3 7858.7 7861.8 7867.3 4268.5 4434.7 4435.0 4435.7 4443.3 2981.2 3023.4 3090.7 3114.4 3117.1 908.7 949.7 950.6 964.2 993.0 10787.5 10804.7 10823.8 10847.2 10853.0 4004.7 4177.8 4281.4 4287.5 4374.9 9094.9 9137.5 9143.5 9145.5 9163.4 4459.1 4469.5 4471.6 4474.0 4474.8 3522.8 3896.6 4022.8 4030.0 4030.8 3567.5 3600.7 3682.7 3750.9 3773.8 1184.6 1184.7 1189.1 1205.1 1217.3 694.8 809.3 839.7 841.4 869.8 5071.3 5112.2 5212.9 5231.9 5284.2 393.7 415.2 416.1 419.8 420.8 3598.8 3606.5 3689.6 3937.6 3940.3 9444.9 9608.9 9664.8 9835.5 9854.0 9690.4 9782.8 9802.7 9805.4 9813.3 7133.5 7222.2 7269.7 7349.4 7356.3 5151.8 5219.3 5270.5 5323.1 5371.1 8778.1 8955.7 8975.0 8990.5 9044.6 8813.7 8956.7 9036.9 9039.1 9073.7 5921.3 6260.2 6426.9 6500.1 6521.0 7214.6 7442.7 7443.3 7444.7 7449.6 6335.0 6392.3 6393.3 6400.4 6605.8 6236.5 6278.8 6344.4 6381.1 6429.3 6144.4 6227.2 6232.5 6234.0 6234.1 4619.4 4667.9 4697.5 4703.4 4778.5 4485.5 4503.0 4570.5 4627.0 4712.3 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#4] prototype.html Cycles:180 Average:4171.44 Median:4820.34 stddev:1222.64 (25.4%) stddev-sans-first:1190.90 08:44:28 INFO - PROCESS | 14426 | Values: 292.5 301.0 301.5 304.4 309.1 4815.4 4840.4 4851.0 4865.7 4887.5 4786.9 4790.3 4802.5 4825.3 4830.5 3600.9 3703.1 3721.2 3728.3 3749.5 3633.5 3751.1 3789.5 3809.4 3835.8 3766.9 3769.3 3776.2 3781.8 3783.3 3537.7 3716.2 3770.5 3772.0 3776.9 3247.1 3252.1 3254.8 3255.5 3255.8 4665.0 4666.2 4680.6 4710.5 4713.8 4247.3 4249.1 4252.0 4252.7 4256.7 4910.7 4964.5 5013.9 5015.7 5037.2 3549.0 3561.4 3562.9 3568.1 3571.4 5254.7 5255.2 5274.8 5285.7 5289.3 3494.2 3579.2 3589.9 3597.6 3604.5 3647.2 3649.1 3651.1 3651.9 3665.2 4181.0 4183.7 4184.2 4193.2 4195.9 4994.5 5000.2 5004.4 5012.3 5037.3 1213.9 1275.0 1283.9 1288.4 1288.6 777.8 807.8 810.9 819.3 820.8 4264.4 4326.7 4431.1 4453.6 4486.1 5207.3 5215.1 5218.0 5223.8 5226.1 4443.5 4461.8 4470.2 4473.4 4480.4 2678.3 2734.7 2750.5 2755.7 2785.3 4914.8 4918.4 4921.0 4926.3 4929.9 5049.4 5320.0 5337.5 5338.3 5342.3 4855.3 4869.9 4904.7 4905.6 4946.7 5205.3 5213.2 5213.6 5227.8 5237.5 4886.9 5084.5 5125.6 5128.6 5135.9 4894.7 4898.8 4906.0 4912.2 4948.4 3643.5 3660.6 3673.7 3674.3 3679.4 4975.2 5207.3 5211.2 5215.0 5227.1 5026.7 5039.8 5050.7 5051.6 5070.3 4972.3 4973.1 5006.2 5049.0 5049.8 4781.3 4886.5 4916.2 4956.5 4976.5 4854.8 4951.9 4976.3 5025.4 5046.0 4769.7 4865.8 4874.9 4876.5 4904.4 08:44:28 INFO - PROCESS | 14426 | 08:44:28 INFO - PROCESS | 14426 | [#5] yui.html Cycles:180 Average:16209.88 Median:27930.52 stddev:22122.67 (79.2%) stddev-sans-first:22153.82 08:44:28 INFO - PROCESS | 14426 | Values: 633.8 656.5 687.8 708.6 752.6 11561.1 12181.3 12226.8 12327.9 12365.4 12510.9 13000.3 13066.9 13173.0 13208.6 612.9 753.5 767.6 770.7 771.4 725.8 757.7 761.9 764.8 765.9 811.8 813.7 813.7 814.3 815.2 651.4 808.6 809.4 809.7 810.3 573.1 587.7 588.4 591.7 592.6 12786.1 12794.4 12835.3 12852.4 12892.5 11458.3 11601.4 12156.3 12445.9 13517.1 10465.3 10610.8 11873.3 11937.4 11944.9 3329.0 3381.3 3435.2 3474.5 3506.0 60634.7 62431.4 62963.7 63184.7 63657.0 9231.3 9295.4 9564.9 9579.8 9613.6 17344.9 17617.2 17631.5 17702.0 17709.4 6687.5 6740.2 6744.2 6750.0 6779.2 3867.2 3904.8 3944.6 4072.9 4109.1 2874.8 3002.2 3006.8 3007.2 3009.6 509.1 511.0 514.6 522.2 523.0 480.5 600.0 607.8 612.9 617.5 7785.7 7976.9 8202.1 8418.9 8637.6 605.2 627.2 633.6 638.9 641.5 3667.3 3858.2 4027.9 4069.2 4188.7 55338.0 55380.4 55572.4 55589.0 69531.3 82676.6 90033.5 90369.0 90772.0 91157.0 61717.4 63537.0 67654.0 68708.0 76504.6 8147.7 8413.3 8527.7 8685.2 9043.4 28419.0 28749.4 31448.8 40318.2 43450.0 51724.2 58783.7 60370.7 61927.7 64751.7 10261.7 10483.0 10533.0 10583.9 10712.8 12613.9 12903.3 13023.0 13149.7 13315.9 11720.8 11746.9 11986.9 12094.6 12097.1 11926.6 12099.3 12574.7 12701.4 12776.2 11433.0 11740.1 11963.2 12287.4 12320.3 9276.4 9278.9 9554.0 9945.9 9947.7 9801.5 10120.3 10153.7 10247.2 10260.7 08:44:28 INFO - PROCESS | 14426 | -------- Summary: end -------- 08:44:28 INFO - PROCESS | 14426 | 08:44:29 INFO - TEST-INFO | 14426: exit 0 08:44:29 INFO - TEST-OK | dromaeo_css | took 1120090ms 08:44:29 INFO - TEST-START | kraken 08:44:29 INFO - operating with platform_type : linux_ 08:44:29 INFO - Initialising browser for kraken test... 08:44:29 INFO - TEST-INFO | started process 14724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP0NIqi/profile http://localhost:32847/getInfo.html) 08:44:33 INFO - PROCESS | 14724 | __metrics Screen width/height:1600/1200 08:44:33 INFO - PROCESS | 14724 | colorDepth:24 08:44:33 INFO - PROCESS | 14724 | Browser inner width/height: 1024/697 08:44:33 INFO - PROCESS | 14724 | __metrics 08:44:34 INFO - PROCESS | 14724 | 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" 08:44:34 INFO - PROCESS | 14724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:34 INFO - PROCESS | 14724 | console.error: PushService: 08:44:34 INFO - PROCESS | 14724 | stateChangeProcessEnqueue: Error transitioning state 08:44:34 INFO - PROCESS | 14724 | UnknownError 08:44:35 INFO - TEST-INFO | 14724: exit 0 08:44:35 INFO - Browser initialized. 08:44:35 INFO - Running cycle 1/1 for kraken test... 08:44:35 INFO - TEST-INFO | started process 14805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP0NIqi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:47 INFO - PROCESS | 14805 | RSS: Main: 156958720 08:44:47 INFO - PROCESS | 14805 | 08:44:50 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:51 INFO - PROCESS | 14805 | RSS: Main: 212488192 08:44:51 INFO - PROCESS | 14805 | 08:44:53 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-dft) 08:44:54 INFO - PROCESS | 14805 | RSS: Main: 191250432 08:44:54 INFO - PROCESS | 14805 | 08:44:57 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-fft) 08:44:58 INFO - PROCESS | 14805 | RSS: Main: 270196736 08:44:58 INFO - PROCESS | 14805 | 08:45:00 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-oscillator) 08:45:01 INFO - PROCESS | 14805 | RSS: Main: 179544064 08:45:01 INFO - PROCESS | 14805 | 08:45:03 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:03 INFO - PROCESS | 14805 | RSS: Main: 184594432 08:45:03 INFO - PROCESS | 14805 | 08:45:07 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:07 INFO - PROCESS | 14805 | RSS: Main: 220803072 08:45:07 INFO - PROCESS | 14805 | 08:45:11 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:11 INFO - PROCESS | 14805 | RSS: Main: 214790144 08:45:11 INFO - PROCESS | 14805 | 08:45:14 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32847/tests/kraken/driver.html?testName=json-parse-financial) 08:45:15 INFO - PROCESS | 14805 | RSS: Main: 217747456 08:45:15 INFO - PROCESS | 14805 | 08:45:16 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:17 INFO - PROCESS | 14805 | RSS: Main: 182001664 08:45:17 INFO - PROCESS | 14805 | 08:45:19 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:20 INFO - PROCESS | 14805 | RSS: Main: 189153280 08:45:20 INFO - PROCESS | 14805 | 08:45:22 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:22 INFO - PROCESS | 14805 | RSS: Main: 194351104 08:45:22 INFO - PROCESS | 14805 | 08:45:25 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:26 INFO - PROCESS | 14805 | RSS: Main: 189116416 08:45:26 INFO - PROCESS | 14805 | 08:45:29 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:29 INFO - PROCESS | 14805 | RSS: Main: 192229376 08:45:29 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32847/tests/kraken/driver.html?testName=ai-astar) 08:45:31 INFO - PROCESS | 14805 | RSS: Main: 243408896 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | __start_tp_report 08:45:31 INFO - PROCESS | 14805 | _x_x_mozilla_page_load 08:45:31 INFO - PROCESS | 14805 | _x_x_mozilla_page_load_details 08:45:31 INFO - PROCESS | 14805 | |i|pagename|runs| 08:45:31 INFO - PROCESS | 14805 | |0;ai-astar;106;116;115;118;114;115;115;116;115;114 08:45:31 INFO - PROCESS | 14805 | |1;audio-beat-detection;161;124;129;200;122;129;152;121;157;121 08:45:31 INFO - PROCESS | 14805 | |2;audio-dft;162;162;162;162;162;162;160;161;162;163 08:45:31 INFO - PROCESS | 14805 | |3;audio-fft;76;76;75;101;75;76;75;76;97;75 08:45:31 INFO - PROCESS | 14805 | |4;audio-oscillator;87;94;128;86;87;87;121;87;86;120 08:45:31 INFO - PROCESS | 14805 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 08:45:31 INFO - PROCESS | 14805 | |6;imaging-darkroom;147;146;147;145;146;148;149;147;146;146 08:45:31 INFO - PROCESS | 14805 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;96;94 08:45:31 INFO - PROCESS | 14805 | |8;json-parse-financial;62;63;65;63;65;66;65;64;64;64 08:45:31 INFO - PROCESS | 14805 | |9;json-stringify-tinderbox;65;65;66;65;66;65;65;65;64;65 08:45:31 INFO - PROCESS | 14805 | |10;stanford-crypto-aes;87;82;83;91;82;82;88;84;81;92 08:45:31 INFO - PROCESS | 14805 | |11;stanford-crypto-ccm;132;132;132;132;131;130;134;136;148;133 08:45:31 INFO - PROCESS | 14805 | |12;stanford-crypto-pbkdf2;171;169;172;172;171;170;172;170;175;169 08:45:31 INFO - PROCESS | 14805 | |13;stanford-crypto-sha256-iterative;69;72;68;67;67;69;67;68;66;66 08:45:31 INFO - PROCESS | 14805 | __end_tp_report 08:45:31 INFO - PROCESS | 14805 | __start_cc_report 08:45:31 INFO - PROCESS | 14805 | _x_x_mozilla_cycle_collect,1942 08:45:31 INFO - PROCESS | 14805 | __end_cc_report 08:45:31 INFO - PROCESS | 14805 | __startTimestamp1471621531877__endTimestamp 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | ------- Summary: start ------- 08:45:31 INFO - PROCESS | 14805 | Number of tests: 14 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:3.17 (2.8%) stddev-sans-first:1.22 08:45:31 INFO - PROCESS | 14805 | Values: 106.0 116.0 115.0 118.0 114.0 115.0 115.0 116.0 115.0 114.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:140.50 stddev:25.80 (18.4%) stddev-sans-first:26.40 08:45:31 INFO - PROCESS | 14805 | Values: 161.0 124.0 129.0 200.0 122.0 129.0 152.0 121.0 157.0 121.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:45:31 INFO - PROCESS | 14805 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 160.0 161.0 162.0 163.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.96 (13.1%) stddev-sans-first:10.45 08:45:31 INFO - PROCESS | 14805 | Values: 76.0 76.0 75.0 101.0 75.0 76.0 75.0 76.0 97.0 75.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:87.00 stddev:17.32 (19.9%) stddev-sans-first:17.88 08:45:31 INFO - PROCESS | 14805 | Values: 87.0 94.0 128.0 86.0 87.0 87.0 121.0 87.0 86.0 120.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:45:31 INFO - PROCESS | 14805 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 08:45:31 INFO - PROCESS | 14805 | Values: 147.0 146.0 147.0 145.0 146.0 148.0 149.0 147.0 146.0 146.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:45:31 INFO - PROCESS | 14805 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 96.0 94.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:1.20 (1.9%) stddev-sans-first:1.00 08:45:31 INFO - PROCESS | 14805 | Values: 62.0 63.0 65.0 63.0 65.0 66.0 65.0 64.0 64.0 64.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:45:31 INFO - PROCESS | 14805 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 64.0 65.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:4.02 (4.7%) stddev-sans-first:4.21 08:45:31 INFO - PROCESS | 14805 | Values: 87.0 82.0 83.0 91.0 82.0 82.0 88.0 84.0 81.0 92.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.50 stddev:5.19 (3.9%) stddev-sans-first:5.45 08:45:31 INFO - PROCESS | 14805 | Values: 132.0 132.0 132.0 132.0 131.0 130.0 134.0 136.0 148.0 133.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:1.79 (1.0%) stddev-sans-first:1.90 08:45:31 INFO - PROCESS | 14805 | Values: 171.0 169.0 172.0 172.0 171.0 170.0 172.0 170.0 175.0 169.0 08:45:31 INFO - PROCESS | 14805 | 08:45:31 INFO - PROCESS | 14805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 08:45:31 INFO - PROCESS | 14805 | Values: 69.0 72.0 68.0 67.0 67.0 69.0 67.0 68.0 66.0 66.0 08:45:31 INFO - PROCESS | 14805 | -------- Summary: end -------- 08:45:31 INFO - PROCESS | 14805 | 08:45:32 INFO - TEST-INFO | 14805: exit 0 08:45:33 INFO - TEST-OK | kraken | took 64096ms 08:45:33 INFO - SUITE-END | took 1184s 08:45:33 INFO - Completed test suite (00:19:44) 08:45:33 INFO - javascript benchmark 08:45:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.64081028656, 2568.396426839693, 2598.2205338398476, 2609.7651211390985, 2612.830166039207, 4571.108633816407, 4592.931106033412, 4636.536346365362, 4719.457262414823, 4720.221163508017, 4606.5393460654, 4617.584417402433, 4653.208954477738, 4659.301104834268, 4707.811687532503, 4061.3501839705505, 4265.296226122686, 4284.97857510712, 4304.698671093009, 4309.396684464177, 4295.634871035965, 4311.568843115679, 4328.7706830981915, 4338.240807858628, 4338.522762496123, 4192.182524407742, 4231.597998190167, 4241.406203131564, 4306.095719898809, 4318.460192475941, 4232.555581663912, 4253.80857861397, 4268.87193384199, 4283.807228674717, 4302.827886884521, 4239.51245606753, 4273.209456250604, 4279.422277992462, 4282.914341713179, 4286.699931004831, 4669.789859456333, 4684.508126646687, 4691.695039822401, 4692.155412025834, 4701.0, 4829.10661527615, 4913.557779799799, 4951.232558953368, 4968.503149685039, 4988.950110498921, 4992.226204938241, 4993.6005119590345, 5004.924926126111, 5005.424376196747, 5006.799728010875, 4687.039156972813, 4694.319323698045, 4700.976495117503, 4741.715497070118, 4748.477667456577, 4933.45731969483, 5018.0, 5084.618653600995, 5086.491350864884, 5140.280360749498, 4929.704217746875, 4931.50684931504, 4937.432195297515, 4937.654364194544, 4938.654294199371, 5002.09962206799, 5005.224190250444, 5007.899842003139, 5009.223570346602, 5026.623003274769, 4812.374391329175, 4842.128416884994, 4904.362432883774, 4908.263760435963, 4947.604191664658, 4936.90126197474, 4945.802167913315, 4948.406191257072, 4954.578860796801, 4962.925556116661, 4200.369944508348, 4200.537940826506, 4208.621224089786, 4219.113986062961, 4222.197782421392, 3586.605473397924, 3628.7097032237357, 3654.6710796028483, 3687.1335236219466, 3744.9438258426144, 4289.420928174719, 4294.184105020036, 4301.247281725686, 4303.634191093792, 4306.612404883575, 5041.873953151127, 5047.772850221749, 5048.242763585418, 5052.317937078521, 5061.898762024739, 4180.874573762792, 4240.427542281815, 4261.74429534229, 4261.850835220753, 4336.284513055373, 4520.118576877543, 4536.0, 4537.705049171859, 4543.114092751948, 4546.704464209815, 4739.241721324572, 4754.381930349033, 4755.0727608116085, 4759.0719809637485, 4777.474477807369, 4862.270659400977, 4949.282354058713, 4981.42713587942, 5004.5746111579465, 5062.164742817394, 4740.644451666208, 4756.310335001474, 4761.119192949315, 4762.047590481849, 4778.1638213311835, 4963.429205641253, 4964.156093464047, 4966.956939042841, 4974.452810190804, 4977.576905963034, 4829.44461386945, 4898.730569818552, 4931.211006238985, 4958.776855041459, 5010.899782004412, 4856.660033797601, 4872.756362181806, 4875.293082503088, 4878.024395120919, 4888.535589119028, 4849.248366503198, 4860.975695121501, 4863.659543831898, 4880.438749543848, 4881.463039065629, 4659.161350956861, 4719.457262414866, 4765.309030190672, 4774.976125119352, 4821.467820248955, 4891.657583969088, 4914.238293064581, 4925.310456536016, 4929.482404347636, 4929.556339929423, 4824.8793780155775, 4831.613470922388, 4832.130216561053, 4832.8791780205775, 4834.444038935568], "value": 4576.034757335387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.0658094401407, 564.9802256921008, 565.7821738630629, 566.9149627555867, 573.8995675756742, 39738.60261397389, 41311.58688413119, 41320.0, 44337.77831110848, 44391.334129988, 41233.0, 41562.7921860391, 41609.0, 41634.58365416345, 41697.58302416975, 7429.702811887518, 7589.658465369058, 7731.724265496215, 7736.690532378698, 9597.66408175714, 9863.26025548083, 10007.099361057504, 10018.899811001906, 10023.097921187129, 10027.298089133763, 10100.0, 10131.848022279672, 10134.645287414942, 10141.645042423517, 10150.898491015068, 10072.446015469146, 10079.09288164065, 10110.19118470528, 10127.544260508257, 10139.746506337327, 9638.42169469834, 9702.27232957531, 9704.320697551175, 9704.61181552737, 9716.465594392306, 39023.609763902285, 39510.0, 39523.80238098791, 39541.20917581661, 39633.40549891754, 2960.407918416325, 2992.1621945855195, 3311.304626028537, 3632.055665526982, 3669.944950825713, 28793.424131517462, 29304.267393315124, 29351.2662183445, 29507.40985180306, 29714.85142574295, 3335.799852008863, 3337.8664853405835, 3435.7423193260606, 3451.4132597458242, 3475.8088305143206, 243585.0, 243993.0, 244902.0, 245171.0, 246424.0, 52324.476755232725, 52519.0, 52573.7371313141, 52626.52674522632, 52672.0, 56396.71801640966, 56428.717856410454, 56536.0, 56580.71709641426, 56595.71702141463, 12587.811182832265, 12766.80849787254, 12800.35998200105, 12812.0, 12815.807762883564, 9042.231410330063, 9155.404898681565, 9201.309901757395, 9423.811523769486, 9450.480223587769, 16664.083475408726, 16673.749893751603, 16730.6653866922, 16736.581585460463, 16824.579385515215, 5897.557683173779, 5902.586818922634, 5962.970185149046, 6031.457168854824, 6087.726052327655, 679.5005670831935, 697.7104501631766, 847.7456762971208, 877.4559772940818, 984.8965858584888, 25508.489830203293, 27883.860580696968, 28425.43149137006, 28438.85780571084, 28495.28761780972, 853.4751128056325, 944.1313991128178, 953.7806304549993, 996.7607774134301, 1004.924630652704, 13543.932280338535, 14554.272286385638, 14663.92668036653, 14952.327145278488, 15001.2499375033, 121871.39064304798, 122608.0, 122714.38642806729, 123486.0, 123726.38136809258, 47816.7609161952, 47978.28032579514, 48024.519754802706, 48033.75983120062, 48080.759596201795, 1024.897510248984, 1106.5573770491867, 1114.8439218509252, 1118.1613789657756, 1135.483355073456, 27085.729142708322, 28479.572806407505, 28952.276193094498, 29137.125886223446, 29362.265943351587, 42236.155276894904, 42862.35706464468, 42906.570934290256, 42927.785361072994, 42936.0, 231444.0, 232936.0, 233040.0, 233173.0, 372153.0, 24232.515349692556, 25396.74603253944, 25491.617625736, 25744.0, 25808.61287080733, 42715.0, 42887.0, 43157.352639711055, 43326.350104749086, 44021.55978440175, 35814.28371432609, 37023.81488092542, 37039.629603703615, 37152.44271335878, 37208.44187337246, 34264.65735342615, 36540.45189322109, 36572.451413229355, 36642.26715465623, 36967.81516092402, 36017.63982360143, 36070.63929360673, 36242.63757362498, 36860.262794743416, 36936.44595331018, 30696.0, 32756.50865237071, 32842.0, 32855.0, 33185.66814331826, 24511.877440612683, 24623.753762462864, 24767.7399687156, 24948.37629059288, 25167.24498265055], "value": 17104.592164447862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.433084230652, 375.39561306296866, 376.1630372421363, 382.8793929912077, 393.13902553408036, 11990.220635658676, 15864.762028569567, 15966.28151733172, 16270.186490675449, 17027.48917532476, 14531.927340363283, 14654.122745548242, 14824.703505929874, 14964.401423943029, 14995.47515836946, 4433.467983841943, 4953.207486802113, 5138.229265610151, 5177.48225177483, 5180.948190518103, 4977.352944117278, 5062.26597143414, 5063.873403164914, 5070.6816227780855, 5070.873228169288, 4837.177679794443, 5008.373953255843, 5030.57240134589, 5042.042012017723, 5044.167712327461, 5072.416672082721, 5106.106431374495, 5112.309838171855, 5117.488251174853, 5117.641765076428, 4400.911981760379, 4504.774761261957, 4576.244919588297, 4581.67928245023, 4589.380433641449, 19140.425787226406, 19794.208231670716, 20989.16043358279, 21125.89437052805, 21141.048652810507, 1781.3141940352928, 1839.3562253211403, 1853.4717605482372, 1895.7914629390757, 1968.4193163016944, 8998.820023599557, 9084.865056711667, 9241.353105282633, 9726.854097188478, 9785.755356116082, 1705.8976461412356, 1719.123247143953, 1747.1788259518132, 1762.02207774685, 1794.5369409451237, 62345.68827155835, 67046.66476667635, 68206.65896670485, 68494.65752671254, 69354.3064569358, 9981.00189980996, 9985.002999400149, 10127.442990635438, 10214.64248751305, 10278.486075696186, 13294.401751921187, 13313.267770272534, 13324.733505330032, 13345.399457024458, 13417.262050587311, 6400.423961843363, 6643.634600097041, 6801.081853949752, 6944.201416837129, 6953.79138625842, 5953.255843019622, 5981.611195272293, 6194.34959329273, 6258.468030217483, 6258.843528911813, 3997.84008639657, 4070.9796451018146, 4076.7146299759324, 4204.8528301509305, 4207.915841683149, 1703.4038086669566, 1777.146969454669, 1789.1412122181425, 1794.1926133240095, 1805.7562229098903, 779.1585088104833, 782.2177822177822, 807.4751411582519, 813.7396033269415, 906.3746015249457, 16157.192140392934, 17265.223064962105, 17339.306427743002, 17450.47648570545, 17482.0, 793.5357815677893, 815.09524427885, 832.450582615483, 832.8292699996487, 842.4103127810557, 9090.318226133066, 9691.951540242253, 9717.708468745948, 9756.756081098029, 9843.507824608741, 259891.0, 384449.0, 387060.0, 387389.0, 387606.0, 52319.0, 71296.0, 71336.64331678412, 81135.0, 83014.58492707618, 868.7437206024238, 879.2921698033017, 891.2157301574443, 894.1952242981239, 943.8584212368199, 14734.0, 15687.215639218222, 16432.83567164313, 16453.683705303785, 16707.749383759496, 38807.61192388153, 39205.0, 39359.803200984956, 39811.80094099511, 39961.80019099886, 49704.50295497143, 50628.74685626548, 50736.23895641642, 50920.14418341938, 52759.472405275454, 7033.085698859116, 7623.4663573549315, 7726.690932362642, 7786.883196752166, 8029.638666259915, 10556.683299501028, 11080.39057851826, 11088.833667495155, 11106.61126860556, 11634.709132271422, 6235.0, 6955.339242771928, 9367.5784589695, 9597.47213903242, 10137.087662110445, 9518.571664275263, 9543.761405964906, 9566.61733530651, 9677.37097088687, 9826.459544725109, 9235.26117910552, 9451.243900488082, 9504.95247523758, 9997.300188986701, 10120.0, 7011.964940175267, 7249.528780629243, 7356.374708149653, 7556.811079723051, 7803.8829417557645, 8865.734027979172, 9207.677731279373, 9293.488858112869, 10188.898111018794, 10402.687919362432], "value": 7854.789502175568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.9460821567134, 1385.8891288696905, 1394.365563668531, 1597.1774536113896, 1632.2083789362164, 7307.305805948433, 7930.36557075434, 7940.801479963004, 7947.801304967365, 7952.92047079529, 6763.932360676392, 7374.188839227681, 7582.696692132322, 7597.582132982684, 7817.804554886131, 2159.0, 2191.857529260601, 2198.1317379635034, 2198.4393979535275, 2210.5136869888597, 2129.4037669452578, 2148.699182114505, 2202.592520383726, 2203.052687344449, 2206.3160420269687, 2176.281826997087, 2183.257692384589, 2188.7592364839857, 2192.9342119736434, 2240.1599400224914, 2150.4301360139575, 2154.041451554059, 2160.114353115215, 2160.935171944844, 2161.827053835689, 2153.7738537453497, 2186.2348178137686, 2187.409399462152, 2188.715466989297, 2194.583029224458, 7763.107242667109, 7818.257265559762, 7858.724944626911, 7861.803454913673, 7867.331276841475, 4268.466441694788, 4434.667399945017, 4435.002124521957, 4435.667324950641, 4443.266860967937, 2981.1652737233608, 3023.4104349651825, 3090.6909309069138, 3114.4394009078355, 3117.0804612639326, 908.7319240823973, 949.7435692363092, 950.5627411390768, 964.2045312617118, 993.0169132558786, 10787.514561844735, 10804.67585972422, 10823.783524329549, 10847.240693151483, 10853.0, 4004.6596039336982, 4177.770222637784, 4281.422008028939, 4287.485501739811, 4374.868753937323, 9094.86357704635, 9137.543122843965, 9143.54282285883, 9145.496997665192, 9163.358564900527, 4459.1304695584695, 4469.508354081048, 4471.552844715502, 4473.977630111829, 4474.7762611869275, 3522.823858807101, 3896.59085795993, 4022.8390864365097, 4030.0, 4030.7581545107387, 3567.464880267981, 3600.71194304455, 3682.6869716073898, 3750.9062273443383, 3773.811309434517, 1184.5972369394447, 1184.7452797648375, 1189.149757923089, 1205.0600531585203, 1217.34263497712, 694.836713372357, 809.2918696140877, 839.6725277141919, 841.3689732700352, 869.7825543614097, 5071.315372424676, 5112.182050871843, 5212.921806172911, 5231.9476805232225, 5284.180951952453, 393.7460338081921, 415.20695471649003, 416.0908415112988, 419.7670292987421, 420.80853211788565, 3598.8020658864016, 3606.495090687306, 3689.5756987946193, 3937.645611894886, 3940.2710498557285, 9444.8583271251, 9608.943016268206, 9664.806703865883, 9835.508224588884, 9853.950730246446, 9690.37012594179, 9782.755431114138, 9802.65690700822, 9805.362651427635, 9813.264005199639, 7133.464990125762, 7222.169450513154, 7269.745558905519, 7349.412047036224, 7356.301151390609, 5151.782906264502, 5219.269302297757, 5270.525652691276, 5323.068463018879, 5371.140617501181, 8778.122187781171, 8955.686550970946, 8974.955125224333, 8990.460572365417, 9044.638214471348, 8813.691520796741, 8956.68651597191, 9036.864447033167, 9039.096090390909, 9073.727788166365, 5921.289445266596, 6260.186175797117, 6426.871462570816, 6500.089987401673, 6520.967395162994, 7214.6392680364725, 7442.7395041173295, 7443.292887175709, 7444.664990075568, 7449.627518623939, 6335.049742538656, 6392.328805475358, 6393.2967373587935, 6400.423961843457, 6605.801825945229, 6236.469900058546, 6278.811635650938, 6344.365563443619, 6381.106645069787, 6429.260635027032, 6144.354842741626, 6227.221597300338, 6232.532560057924, 6234.0337247726675, 6234.096056071935, 4619.422572178478, 4667.929981050355, 4697.5302469754115, 4703.365045718784, 4778.522147785194, 4485.497358384847, 4502.954970450253, 4570.520095390069, 4627.0, 4712.316714076508], "value": 4037.4326887692823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.5319488817891, 300.9744171745402, 301.46189052541206, 304.423118191028, 309.10976388002547, 4815.37400137982, 4840.370751802261, 4851.0, 4865.708057516547, 4887.462379138292, 4786.904261914759, 4790.257510085942, 4802.519748025195, 4825.300331451937, 4830.541098595637, 3600.90997725057, 3703.1482758965453, 3721.1999420124666, 3728.291624591319, 3749.5125633667585, 3633.454981752745, 3751.1372384351616, 3789.4694742736037, 3809.4095415210686, 3835.789031603261, 3766.8699390182974, 3769.2649933263024, 3776.2258736958856, 3781.754185977916, 3783.262263858535, 3537.6816086552076, 3716.1824398632257, 3770.547534295875, 3771.981140094282, 3776.9055773605605, 3247.1232767152974, 3252.1381833814057, 3254.804711717281, 3255.544223808669, 3255.755818313636, 4664.976675116603, 4666.206744853349, 4680.578747912704, 4710.505396933341, 4713.764311784397, 4247.341662042389, 4249.086446414036, 4252.0, 4252.702310838243, 4256.659467242614, 4910.705357678551, 4964.478729733362, 5013.89972200554, 5015.724135172564, 5037.244413337992, 3549.0, 3561.3767590671787, 3562.946555801665, 3568.0901370150705, 3571.4285714285847, 5254.689545586294, 5255.237990491358, 5274.7626356814035, 5285.709285989269, 5289.285946397225, 3494.2138018945534, 3579.2483578448296, 3589.9178476483576, 3597.5503062117236, 3604.513390692223, 3647.1611529348397, 3649.0512466758832, 3651.087228192952, 3651.926961460756, 3665.1753355495334, 4181.0, 4183.707140500136, 4184.163167366539, 4193.182329445729, 4195.937060944088, 4994.525520075587, 5000.249962505581, 5004.424491183488, 5012.273220383097, 5037.319961805109, 1213.9028877689764, 1274.9736462147875, 1283.865194154619, 1288.4395288049727, 1288.5812111063942, 777.8211011467281, 807.8488154380102, 810.8702607582759, 819.2626636027622, 820.8153165537825, 4264.445622069111, 4326.697131200849, 4431.135928493913, 4453.55464453552, 4486.1252055849445, 5207.323048003811, 5215.13950198213, 5218.0, 5223.817166399158, 5226.137687281632, 4443.511213766483, 4461.843835465743, 4470.240059189946, 4473.396091527602, 4480.4175457191, 2678.2902530829347, 2734.740199681027, 2750.4911591355662, 2755.7244275572284, 2785.3454438207004, 4914.771307173207, 4918.385201849769, 4920.957802511989, 4926.261060840831, 4929.852104436873, 5049.444561098277, 5319.973400133052, 5337.466253374631, 5338.252644629755, 5342.263764276626, 4855.344528488608, 4869.878253043631, 4904.705717656952, 4905.6075513958085, 4946.703197808143, 5205.271262023244, 5213.227502649118, 5213.582913366998, 5227.817026404057, 5237.502437268454, 4886.853394398174, 5084.466131056334, 5125.641205115606, 5128.615353848401, 5135.948640513547, 4894.681845680019, 4898.7550622468025, 4906.0, 4912.189488734319, 4948.38145231846, 3643.4534819777246, 3660.6156353583556, 3673.7244706647643, 3674.283514714605, 3679.411294192916, 4975.228839529878, 5207.3490813648295, 5211.166213405989, 5214.957008598371, 5227.079690232325, 5026.698398096126, 5039.84880453587, 5050.747462626928, 5051.646384753032, 5070.264811602223, 4972.254161875748, 4973.104841128632, 5006.1739812930455, 5048.974755126201, 5049.762808111889, 4781.282807578891, 4886.486918873467, 4916.188828843201, 4956.529129732669, 4976.477469865612, 4854.757262136808, 4951.9257211142585, 4976.308055261228, 5025.447200807835, 5045.990801839574, 4769.73766442849, 4865.756712164449, 4874.878128046827, 4876.463589005278, 4904.435989861212], "value": 3780.5046918958137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.8098570428871, 656.524020085438, 687.8005378440249, 708.5606923707302, 752.6161657554645, 11561.132915031374, 12181.269123852564, 12226.816597751018, 12327.938360308208, 12365.381730913452, 12510.93744531276, 13000.28498432586, 13066.934665326684, 13173.0, 13208.603741887759, 612.944834964853, 753.4913933095166, 767.6200280860953, 770.6917233106747, 771.3906014248737, 725.7967769024682, 757.6628400361841, 761.9161892191854, 764.831737017858, 765.8736308509117, 811.8295158016823, 813.6704634622987, 813.7111325479458, 814.2630919018297, 815.2051749544177, 651.3649192037773, 808.5714571277232, 809.4212637963855, 809.6761295481825, 810.3031393002013, 573.1059547106486, 587.6620942957817, 588.4233451217831, 591.6864062047079, 592.6236839606837, 12786.104972651918, 12794.360281985864, 12835.294058826761, 12852.35738213095, 12892.548760793421, 11458.255213411101, 11601.419929003516, 12156.270623762513, 12445.937770311091, 13517.121387109806, 10465.267431279814, 10610.840837387444, 11873.346965916871, 11937.40312984356, 11944.880551194463, 3328.983355083209, 3381.2561236527927, 3435.2442462658173, 3474.4614584739406, 3506.0358401439807, 60634.696826516025, 62431.37568624347, 62963.6851815738, 63184.684076579324, 63657.0, 9231.261499080058, 9295.395799273025, 9564.90435095654, 9579.760505987406, 9613.615455381707, 17344.913275433795, 17617.207225674876, 17631.471055868344, 17702.0, 17709.38017169393, 6687.498437617198, 6740.224874139439, 6744.190697116279, 6750.0, 6779.15260592426, 3867.2458870519977, 3904.8438062477185, 3944.5660977292473, 4072.8778136655355, 4109.075458021981, 2874.841883696417, 3002.1894088595955, 3006.7895247332913, 3007.2331555453657, 3009.5786589877434, 509.08364943102265, 510.97700603472936, 514.5574805667123, 522.1801771219225, 523.0428316181379, 480.52239363955977, 600.0429315242181, 607.8267693707361, 612.935641757618, 617.4597227426002, 7785.727499537489, 7976.880346794803, 8202.138775428493, 8418.915810841936, 8637.568121593895, 605.2222893581726, 627.1940556385023, 633.5596760251581, 638.8722255548909, 641.4900154377282, 3667.2848794485353, 3858.194432693101, 4027.9194416111513, 4069.206504731549, 4188.6649068074485, 55338.0, 55380.44619553834, 55572.44427555673, 55589.0, 69531.30468695248, 82676.58661706652, 90033.54983225041, 90369.0, 90772.0, 91157.0, 61717.38282617206, 63537.0, 67654.0, 68707.999999999, 76504.61747691226, 8147.674093036212, 8413.326933845156, 8527.658893644184, 8685.218330350046, 9043.412178208395, 28419.0, 28749.425011500072, 31448.842755786074, 40318.1936361277, 43450.0, 51724.22413663873, 58783.70608147103, 60370.698146508985, 61927.69036154971, 64751.676241618494, 10261.692149235534, 10483.0, 10533.0, 10583.94708026455, 10712.785744285227, 12613.87386126127, 12903.290319032169, 13023.0, 13149.671258218239, 13315.933420332836, 11720.765584688088, 11746.941265293619, 11986.880131198925, 12094.637160885188, 12097.092718046006, 11926.582569610022, 12099.274043557414, 12574.685632859251, 12701.4284357206, 12776.169548979287, 11433.0, 11740.119491038036, 11963.162578619762, 12287.385630718249, 12320.322382268703, 9276.350655454053, 9278.907210927804, 9553.952230238805, 9945.900540994497, 9947.701568952943, 9801.509924503604, 10120.291579589359, 10153.695389138338, 10247.231457640557, 10260.692179234635], "value": 6395.427969269802, "unit": "score"}], "name": "dromaeo_css", "value": 6257.273342515558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 115.0, 118.0, 114.0, 115.0, 115.0, 116.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 129.0, 200.0, 122.0, 129.0, 152.0, 121.0, 157.0, 121.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 160.0, 161.0, 162.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 101.0, 75.0, 76.0, 75.0, 76.0, 97.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 128.0, 86.0, 87.0, 87.0, 121.0, 87.0, 86.0, 120.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 148.0, 149.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 63.0, 65.0, 66.0, 65.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 91.0, 82.0, 82.0, 88.0, 84.0, 81.0, 92.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 132.0, 132.0, 131.0, 130.0, 134.0, 136.0, 148.0, 133.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 172.0, 172.0, 171.0, 170.0, 172.0, 170.0, 175.0, 169.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 68.0, 67.0, 67.0, 69.0, 67.0, 68.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1542.1, "alertThreshold": 2.0}]} 08:45:33 INFO - Return code: 0 08:45:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:33 INFO - # TBPL SUCCESS # 08:45:33 INFO - Running post-action listener: _resource_record_post_action 08:45:33 INFO - [mozharness: 2016-08-19 15:45:33.670251Z] Finished run-tests step (success) 08:45:33 INFO - Running post-run listener: _resource_record_post_run 08:45:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 407564288; Read time: 0; Write time: 374404 08:45:33 INFO - TinderboxPrint: CPU usage
13.0% 08:45:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:45:33 INFO - TinderboxPrint: I/O write bytes / time
407,564,288 / 374,404 08:45:33 INFO - TinderboxPrint: CPU idle
8,340.6 (87.0%) 08:45:33 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 08:45:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114421760; Read time: 0; Write time: 113184 08:45:33 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 293142528; Read time: 0; Write time: 261220 08:45:34 INFO - Running post-run listener: _upload_blobber_files 08:45:34 INFO - Blob upload gear active. 08:45:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:34 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 08:45:34 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:45:34 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:45:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:40 INFO - (blobuploader) - INFO - Done attempting. 08:45:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:45:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:41 INFO - (blobuploader) - INFO - Done attempting. 08:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:42 INFO - (blobuploader) - INFO - Done attempting. 08:45:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:42 INFO - Return code: 0 08:45:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddaffc0a8628359e30223d3946f8d0a4d91997eb2c986f91b1f8d48155c4460397bb418ab90132822d39e857dda29fd92aca8870f8ab4c78d6ff0cfd370f7951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04e0717dd2c552ec553d781138b2f1a7bc060911575b90a0eda1040f4310843a5c79be8aab2e8d891d8bf570c9f0d936758b8721a067f71b4c1b109357518006", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/440f634186d42495529fff2b350ceeb16e1505ed04c44b147e7772a37386ca3e4d3d0989c381ab0110b1fee24e660b4596f7e49795d7ce5b01091186fa38e76b"} 08:45:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:42 INFO - Contents: 08:45:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddaffc0a8628359e30223d3946f8d0a4d91997eb2c986f91b1f8d48155c4460397bb418ab90132822d39e857dda29fd92aca8870f8ab4c78d6ff0cfd370f7951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04e0717dd2c552ec553d781138b2f1a7bc060911575b90a0eda1040f4310843a5c79be8aab2e8d891d8bf570c9f0d936758b8721a067f71b4c1b109357518006", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/440f634186d42495529fff2b350ceeb16e1505ed04c44b147e7772a37386ca3e4d3d0989c381ab0110b1fee24e660b4596f7e49795d7ce5b01091186fa38e76b"} 08:45:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:42 INFO - Copying logs to upload dir... 08:45:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.186122 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-19 08:45:41.421512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:41.425516) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 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-Non-PGO/sha512/ddaffc0a8628359e30223d3946f8d0a4d91997eb2c986f91b1f8d48155c4460397bb418ab90132822d39e857dda29fd92aca8870f8ab4c78d6ff0cfd370f7951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04e0717dd2c552ec553d781138b2f1a7bc060911575b90a0eda1040f4310843a5c79be8aab2e8d891d8bf570c9f0d936758b8721a067f71b4c1b109357518006", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/440f634186d42495529fff2b350ceeb16e1505ed04c44b147e7772a37386ca3e4d3d0989c381ab0110b1fee24e660b4596f7e49795d7ce5b01091186fa38e76b"} build_url:https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011552 build_url: 'https://queue.taskcluster.net/v1/task/Ca0a6PjhQaG9Yrhw4mEMeA/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-Non-PGO/sha512/ddaffc0a8628359e30223d3946f8d0a4d91997eb2c986f91b1f8d48155c4460397bb418ab90132822d39e857dda29fd92aca8870f8ab4c78d6ff0cfd370f7951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04e0717dd2c552ec553d781138b2f1a7bc060911575b90a0eda1040f4310843a5c79be8aab2e8d891d8bf570c9f0d936758b8721a067f71b4c1b109357518006", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/440f634186d42495529fff2b350ceeb16e1505ed04c44b147e7772a37386ca3e4d3d0989c381ab0110b1fee24e660b4596f7e49795d7ce5b01091186fa38e76b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:41.452097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:41.452632) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1471620291.76695-1505169850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:41.536349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:45:41.536700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:45:41.537205) ========= ========= Total master_lag: 0.15 =========