builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1469033315.56 results: success (0) buildid: 20160720083420 builduid: 80a8a103b6994bddb37ef72e4f8b8826 revision: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.557415) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.558442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.559129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.581016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.581764) ========= 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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 09:48:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-07-20 09:48:36 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117808 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.715035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.715398) ========= 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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.767489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:35.768356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0cca5d80caa9f04d491c28b388f2f396fd45fe5c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0cca5d80caa9f04d491c28b388f2f396fd45fe5c --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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 09:48:36,555 truncating revision to first 12 chars 2016-07-20 09:48:36,555 Setting DEBUG logging. 2016-07-20 09:48:36,555 attempt 1/10 2016-07-20 09:48:36,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0cca5d80caa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 09:48:36,867 unpacking tar archive at: fx-team-0cca5d80caa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:36.463613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:36.463988) ========= script_repo_revision: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:36.464450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:36.464764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 09:48:36.475010) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-20 09:48:36.475339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:37 INFO - MultiFileLogger online at 20160720 09:48:37 in /builds/slave/test 09:48:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:48:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:37 INFO - {'append_to_log': False, 09:48:37 INFO - 'base_work_dir': '/builds/slave/test', 09:48:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:37 INFO - 'branch': 'Fx-Team-Non-PGO', 09:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:37 INFO - 'config_files': ('talos/linux_config.py',), 09:48:37 INFO - 'default_actions': ('clobber', 09:48:37 INFO - 'read-buildbot-config', 09:48:37 INFO - 'download-and-extract', 09:48:37 INFO - 'populate-webroot', 09:48:37 INFO - 'create-virtualenv', 09:48:37 INFO - 'install', 09:48:37 INFO - 'run-tests'), 09:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:37 INFO - 'download_minidump_stackwalk': True, 09:48:37 INFO - 'download_symbols': 'ondemand', 09:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:37 INFO - 'installer_path': 'installer.exe', 09:48:37 INFO - 'log_level': 'info', 09:48:37 INFO - 'log_name': 'talos', 09:48:37 INFO - 'log_to_console': True, 09:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:37 INFO - 'opt_config_files': (), 09:48:37 INFO - 'pip_index': False, 09:48:37 INFO - 'sps_profile': False, 09:48:37 INFO - 'sps_profile_interval': 0, 09:48:37 INFO - 'suite': 'dromaeojs-e10s', 09:48:37 INFO - 'system_bits': '32', 09:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:37 INFO - 'title': 'talos-linux64-ix-065', 09:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:37 INFO - 'use_talos_json': True, 09:48:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:37 INFO - 'work_dir': 'build'} 09:48:37 INFO - [mozharness: 2016-07-20 16:48:37.352206Z] Running clobber step. 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: clobber 09:48:37 INFO - rmtree: /builds/slave/test/build 09:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - [mozharness: 2016-07-20 16:48:37.830099Z] Finished clobber step (success) 09:48:37 INFO - [mozharness: 2016-07-20 16:48:37.830203Z] Running read-buildbot-config step. 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: read_buildbot_config 09:48:37 INFO - Using buildbot properties: 09:48:37 INFO - { 09:48:37 INFO - "project": "", 09:48:37 INFO - "product": "firefox", 09:48:37 INFO - "script_repo_revision": "production", 09:48:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:48:37 INFO - "repository": "", 09:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:48:37 INFO - "buildid": "20160720083420", 09:48:37 INFO - "pgo_build": "False", 09:48:37 INFO - "basedir": "/builds/slave/test", 09:48:37 INFO - "buildnumber": 1492, 09:48:37 INFO - "slavename": "talos-linux64-ix-065", 09:48:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:48:37 INFO - "platform": "ubuntu64_hw", 09:48:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:48:37 INFO - "branch": "fx-team", 09:48:37 INFO - "repo_path": "integration/fx-team", 09:48:37 INFO - "revision": "0cca5d80caa9f04d491c28b388f2f396fd45fe5c", 09:48:37 INFO - "stage_platform": "linux64", 09:48:37 INFO - "builduid": "80a8a103b6994bddb37ef72e4f8b8826", 09:48:37 INFO - "slavebuilddir": "test" 09:48:37 INFO - } 09:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - [mozharness: 2016-07-20 16:48:37.832656Z] Finished read-buildbot-config step (success) 09:48:37 INFO - [mozharness: 2016-07-20 16:48:37.832745Z] Running download-and-extract step. 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: download_and_extract 09:48:37 INFO - mkdir: /builds/slave/test/build/tests 09:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:37 INFO - https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:38 INFO - Downloaded 1361 bytes. 09:48:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:48:38 INFO - Using the following test package requirements: 09:48:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:48:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'jsshell-linux-x86_64.zip'], 09:48:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:48:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:48:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:38 INFO - https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:39 INFO - Downloaded 22771994 bytes. 09:48:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:40 INFO - Return code: 0 09:48:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:41 INFO - Downloaded 22771994 bytes. 09:48:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:43 INFO - Return code: 0 09:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:43 INFO - https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:44 INFO - Downloaded 14403317 bytes. 09:48:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:48:44 INFO - Return code: 0 09:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:44 INFO - https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:45 INFO - Downloaded 57115690 bytes. 09:48:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:48:45 INFO - mkdir: /builds/slave/test/properties 09:48:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:45 INFO - Contents: 09:48:45 INFO - build_url:https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:48:46 INFO - Running post-action listener: _resource_record_post_action 09:48:46 INFO - Running post-action listener: set_extra_try_arguments 09:48:46 INFO - [mozharness: 2016-07-20 16:48:46.482738Z] Finished download-and-extract step (success) 09:48:46 INFO - [mozharness: 2016-07-20 16:48:46.482972Z] Running populate-webroot step. 09:48:46 INFO - Running pre-action listener: _resource_record_pre_action 09:48:46 INFO - Running main action method: populate_webroot 09:48:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:46 INFO - '--tppagecycles', 09:48:46 INFO - '7'], 09:48:46 INFO - 'tests': ['tsvgm']}}, 09:48:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['damp', 'tps']}, 09:48:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'tests': ['damp', 'tps']}, 09:48:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['dromaeo_dom']}, 09:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['basic_compositor_video']}, 09:48:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['a11yr', 09:48:46 INFO - 'ts_paint', 09:48:46 INFO - 'tpaint', 09:48:46 INFO - 'sessionrestore', 09:48:46 INFO - 'sessionrestore_no_auto_restore', 09:48:46 INFO - 'tabpaint']}, 09:48:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['tsvgx', 09:48:46 INFO - 'tsvgr_opacity', 09:48:46 INFO - 'tart', 09:48:46 INFO - 'tscrollx', 09:48:46 INFO - 'cart']}, 09:48:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:46 INFO - 'tsvgr_opacity', 09:48:46 INFO - 'tart', 09:48:46 INFO - 'tscrollx', 09:48:46 INFO - 'cart']}, 09:48:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'talos_options': ['--disable-e10s'], 09:48:46 INFO - 'tests': ['tp5o']}, 09:48:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'tests': ['tp5o']}, 09:48:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'talos_options': ['--disable-e10s', 09:48:46 INFO - '--xperf_path', 09:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:46 INFO - 'tests': ['tp5n']}, 09:48:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:46 INFO - 'talos_options': ['--xperf_path', 09:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:46 INFO - 'tests': ['tp5n']}}, 09:48:46 INFO - 'talos.zip': {'path': '', 09:48:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:46 INFO - Running post-action listener: _resource_record_post_action 09:48:46 INFO - [mozharness: 2016-07-20 16:48:46.501939Z] Finished populate-webroot step (success) 09:48:46 INFO - [mozharness: 2016-07-20 16:48:46.502029Z] Running create-virtualenv step. 09:48:46 INFO - Running pre-action listener: _resource_record_pre_action 09:48:46 INFO - Running main action method: create_virtualenv 09:48:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:46 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 09:48:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:46 INFO - Using real prefix '/usr' 09:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:49 INFO - Installing pip.................done. 09:48:49 INFO - Return code: 0 09:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:49 INFO - Using env: {'DISPLAY': ':0', 09:48:49 INFO - 'HOME': '/home/cltbld', 09:48:49 INFO - 'LANG': 'en_US.UTF-8', 09:48:49 INFO - 'LANGUAGE': 'en_US:en', 09:48:49 INFO - 'LOGNAME': 'cltbld', 09:48:49 INFO - 'MAIL': '/var/mail/cltbld', 09:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:49 INFO - 'MOZ_NO_REMOTE': '1', 09:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:49 INFO - 'NO_EM_RESTART': '1', 09:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:49 INFO - 'PWD': '/builds/slave/test', 09:48:49 INFO - 'SHELL': '/bin/bash', 09:48:49 INFO - 'SHLVL': '1', 09:48:49 INFO - 'TERM': 'linux', 09:48:49 INFO - 'TMOUT': '86400', 09:48:49 INFO - 'USER': 'cltbld', 09:48:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:49 INFO - '_': '/tools/buildbot/bin/python'} 09:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:49 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 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:48:49 INFO - Using env: {'DISPLAY': ':0', 09:48:49 INFO - 'HOME': '/home/cltbld', 09:48:49 INFO - 'LANG': 'en_US.UTF-8', 09:48:49 INFO - 'LANGUAGE': 'en_US:en', 09:48:49 INFO - 'LOGNAME': 'cltbld', 09:48:49 INFO - 'MAIL': '/var/mail/cltbld', 09:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:49 INFO - 'MOZ_NO_REMOTE': '1', 09:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:49 INFO - 'NO_EM_RESTART': '1', 09:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:49 INFO - 'PWD': '/builds/slave/test', 09:48:49 INFO - 'SHELL': '/bin/bash', 09:48:49 INFO - 'SHLVL': '1', 09:48:49 INFO - 'TERM': 'linux', 09:48:49 INFO - 'TMOUT': '86400', 09:48:49 INFO - 'USER': 'cltbld', 09:48:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:49 INFO - '_': '/tools/buildbot/bin/python'} 09:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:49 INFO - Downloading/unpacking psutil>=3.1.1 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:51 INFO - Installing collected packages: psutil 09:48:51 INFO - Running setup.py install for psutil 09:48:51 INFO - building 'psutil._psutil_linux' extension 09:48:51 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 09:48:51 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 09:48:51 INFO - building 'psutil._psutil_posix' extension 09:48:51 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 09:48:51 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 09:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:52 INFO - Successfully installed psutil 09:48:52 INFO - Cleaning up... 09:48:52 INFO - Return code: 0 09:48:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:48:52 INFO - Using env: {'DISPLAY': ':0', 09:48:52 INFO - 'HOME': '/home/cltbld', 09:48:52 INFO - 'LANG': 'en_US.UTF-8', 09:48:52 INFO - 'LANGUAGE': 'en_US:en', 09:48:52 INFO - 'LOGNAME': 'cltbld', 09:48:52 INFO - 'MAIL': '/var/mail/cltbld', 09:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:52 INFO - 'MOZ_NO_REMOTE': '1', 09:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:52 INFO - 'NO_EM_RESTART': '1', 09:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:52 INFO - 'PWD': '/builds/slave/test', 09:48:52 INFO - 'SHELL': '/bin/bash', 09:48:52 INFO - 'SHLVL': '1', 09:48:52 INFO - 'TERM': 'linux', 09:48:52 INFO - 'TMOUT': '86400', 09:48:52 INFO - 'USER': 'cltbld', 09:48:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:52 INFO - '_': '/tools/buildbot/bin/python'} 09:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:54 INFO - Installing collected packages: mozsystemmonitor 09:48:54 INFO - Running setup.py install for mozsystemmonitor 09:48:54 INFO - Successfully installed mozsystemmonitor 09:48:54 INFO - Cleaning up... 09:48:54 INFO - Return code: 0 09:48:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:54 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:48:54 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 09:48:54 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 09:48:54 INFO - Using env: {'DISPLAY': ':0', 09:48:54 INFO - 'HOME': '/home/cltbld', 09:48:54 INFO - 'LANG': 'en_US.UTF-8', 09:48:54 INFO - 'LANGUAGE': 'en_US:en', 09:48:54 INFO - 'LOGNAME': 'cltbld', 09:48:54 INFO - 'MAIL': '/var/mail/cltbld', 09:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:54 INFO - 'MOZ_NO_REMOTE': '1', 09:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:54 INFO - 'NO_EM_RESTART': '1', 09:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:54 INFO - 'PWD': '/builds/slave/test', 09:48:54 INFO - 'SHELL': '/bin/bash', 09:48:54 INFO - 'SHLVL': '1', 09:48:54 INFO - 'TERM': 'linux', 09:48:54 INFO - 'TMOUT': '86400', 09:48:54 INFO - 'USER': 'cltbld', 09:48:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:54 INFO - '_': '/tools/buildbot/bin/python'} 09:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:56 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 09:48:56 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 09:48:56 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 09:48:56 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 09:48:56 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 09:48:56 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 09:48:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:56 INFO - warning: no files found matching '*.txt' 09:48:56 INFO - no previously-included directories found matching 'build' 09:48:56 INFO - no previously-included directories found matching 'dist' 09:48:56 INFO - no previously-included directories found matching '.git*' 09:48:56 INFO - Installing collected packages: jsonschema, functools32 09:48:56 INFO - Running setup.py install for functools32 09:48:57 INFO - warning: no files found matching '*.txt' 09:48:57 INFO - no previously-included directories found matching 'build' 09:48:57 INFO - no previously-included directories found matching 'dist' 09:48:57 INFO - no previously-included directories found matching '.git*' 09:48:57 INFO - Successfully installed jsonschema functools32 09:48:57 INFO - Cleaning up... 09:48:57 INFO - Return code: 0 09:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:57 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:48:57 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 09:48:57 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 09:48:57 INFO - Using env: {'DISPLAY': ':0', 09:48:57 INFO - 'HOME': '/home/cltbld', 09:48:57 INFO - 'LANG': 'en_US.UTF-8', 09:48:57 INFO - 'LANGUAGE': 'en_US:en', 09:48:57 INFO - 'LOGNAME': 'cltbld', 09:48:57 INFO - 'MAIL': '/var/mail/cltbld', 09:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:57 INFO - 'MOZ_NO_REMOTE': '1', 09:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:57 INFO - 'NO_EM_RESTART': '1', 09:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:57 INFO - 'PWD': '/builds/slave/test', 09:48:57 INFO - 'SHELL': '/bin/bash', 09:48:57 INFO - 'SHLVL': '1', 09:48:57 INFO - 'TERM': 'linux', 09:48:57 INFO - 'TMOUT': '86400', 09:48:57 INFO - 'USER': 'cltbld', 09:48:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:57 INFO - '_': '/tools/buildbot/bin/python'} 09:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:57 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 09:48:57 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 09:48:57 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 09:48:57 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 09:48:57 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 09:48:57 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 09:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 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 09:48:59 INFO - Downloading docopt-0.6.1.tar.gz 09:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:00 INFO - Running setup.py install for blobuploader 09:49:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:00 INFO - Running setup.py install for requests 09:49:00 INFO - Running setup.py install for docopt 09:49:00 INFO - Successfully installed blobuploader requests docopt 09:49:00 INFO - Cleaning up... 09:49:00 INFO - Return code: 0 09:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:49:00 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 09:49:00 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 09:49:00 INFO - Using env: {'DISPLAY': ':0', 09:49:00 INFO - 'HOME': '/home/cltbld', 09:49:00 INFO - 'LANG': 'en_US.UTF-8', 09:49:00 INFO - 'LANGUAGE': 'en_US:en', 09:49:00 INFO - 'LOGNAME': 'cltbld', 09:49:00 INFO - 'MAIL': '/var/mail/cltbld', 09:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:00 INFO - 'MOZ_NO_REMOTE': '1', 09:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:00 INFO - 'NO_EM_RESTART': '1', 09:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:00 INFO - 'PWD': '/builds/slave/test', 09:49:00 INFO - 'SHELL': '/bin/bash', 09:49:00 INFO - 'SHLVL': '1', 09:49:00 INFO - 'TERM': 'linux', 09:49:00 INFO - 'TMOUT': '86400', 09:49:00 INFO - 'USER': 'cltbld', 09:49:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:00 INFO - '_': '/tools/buildbot/bin/python'} 09:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:00 INFO - Running setup.py (path:/tmp/pip-jctHPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:00 INFO - Running setup.py (path:/tmp/pip-0KEXZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:00 INFO - Running setup.py (path:/tmp/pip-7HdDzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:01 INFO - Running setup.py (path:/tmp/pip-GegtHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:01 INFO - Running setup.py (path:/tmp/pip-uviHTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:01 INFO - Running setup.py (path:/tmp/pip-XtlrnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:01 INFO - Running setup.py (path:/tmp/pip-YuEers-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:01 INFO - Running setup.py (path:/tmp/pip-G24u_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:01 INFO - Running setup.py (path:/tmp/pip-CxVy5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:01 INFO - Running setup.py (path:/tmp/pip-yU120a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:01 INFO - Running setup.py (path:/tmp/pip-niKeH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:01 INFO - Running setup.py (path:/tmp/pip-ogNGuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:01 INFO - Running setup.py (path:/tmp/pip-7ttNij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:01 INFO - Running setup.py (path:/tmp/pip-KS4nsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:01 INFO - Running setup.py (path:/tmp/pip-93LyjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:01 INFO - Running setup.py (path:/tmp/pip-07rFG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:01 INFO - Running setup.py (path:/tmp/pip-hhimRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:02 INFO - Running setup.py install for manifestparser 09:49:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Running setup.py install for mozcrash 09:49:02 INFO - Running setup.py install for mozdebug 09:49:02 INFO - Running setup.py install for mozdevice 09:49:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Running setup.py install for mozfile 09:49:02 INFO - Running setup.py install for mozhttpd 09:49:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Running setup.py install for mozinfo 09:49:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Running setup.py install for mozInstall 09:49:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:02 INFO - Running setup.py install for mozleak 09:49:02 INFO - Running setup.py install for mozlog 09:49:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Running setup.py install for moznetwork 09:49:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Running setup.py install for mozprocess 09:49:03 INFO - Running setup.py install for mozprofile 09:49:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Running setup.py install for mozrunner 09:49:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Running setup.py install for mozscreenshot 09:49:03 INFO - Running setup.py install for moztest 09:49:03 INFO - Running setup.py install for mozversion 09:49:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:03 INFO - Cleaning up... 09:49:03 INFO - Return code: 0 09:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:49:03 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 09:49:03 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 09:49:03 INFO - Using env: {'DISPLAY': ':0', 09:49:03 INFO - 'HOME': '/home/cltbld', 09:49:03 INFO - 'LANG': 'en_US.UTF-8', 09:49:03 INFO - 'LANGUAGE': 'en_US:en', 09:49:03 INFO - 'LOGNAME': 'cltbld', 09:49:03 INFO - 'MAIL': '/var/mail/cltbld', 09:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:03 INFO - 'MOZ_NO_REMOTE': '1', 09:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:03 INFO - 'NO_EM_RESTART': '1', 09:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:03 INFO - 'PWD': '/builds/slave/test', 09:49:03 INFO - 'SHELL': '/bin/bash', 09:49:03 INFO - 'SHLVL': '1', 09:49:03 INFO - 'TERM': 'linux', 09:49:03 INFO - 'TMOUT': '86400', 09:49:03 INFO - 'USER': 'cltbld', 09:49:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:03 INFO - '_': '/tools/buildbot/bin/python'} 09:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:04 INFO - Running setup.py (path:/tmp/pip-2_OAaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:04 INFO - Running setup.py (path:/tmp/pip-UvsC57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:04 INFO - Running setup.py (path:/tmp/pip-Idwjqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:04 INFO - Running setup.py (path:/tmp/pip-zqsAtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:04 INFO - Running setup.py (path:/tmp/pip-MRM3tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:04 INFO - Running setup.py (path:/tmp/pip-8s7Nud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:04 INFO - Running setup.py (path:/tmp/pip-6CtlGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:04 INFO - Running setup.py (path:/tmp/pip-4KLxc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:04 INFO - Running setup.py (path:/tmp/pip-HPA9Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:04 INFO - Running setup.py (path:/tmp/pip-YSUqDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:04 INFO - Running setup.py (path:/tmp/pip-csgZ7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:04 INFO - Running setup.py (path:/tmp/pip-dWiQPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:04 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)) 09:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:04 INFO - Running setup.py (path:/tmp/pip-3Za4uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:05 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)) 09:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:05 INFO - Running setup.py (path:/tmp/pip-9xNmYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:05 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)) 09:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:05 INFO - Running setup.py (path:/tmp/pip-dqPJmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:05 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)) 09:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:05 INFO - Running setup.py (path:/tmp/pip-6cKiYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:05 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)) 09:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:05 INFO - Running setup.py (path:/tmp/pip-ShWAoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:05 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)) 09:49:05 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)) 09:49:05 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)) 09:49:05 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)) 09:49:05 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)) 09:49:05 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)) 09:49:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:05 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 09:49:05 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 09:49:05 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 09:49:05 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 09:49:05 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 09:49:05 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 09:49:07 INFO - Downloading blessings-1.6.tar.gz 09:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:07 INFO - Installing collected packages: blessings 09:49:07 INFO - Running setup.py install for blessings 09:49:07 INFO - Successfully installed blessings 09:49:07 INFO - Cleaning up... 09:49:07 INFO - Return code: 0 09:49:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:07 INFO - Reading from file tmpfile_stdout 09:49:07 INFO - Current package versions: 09:49:07 INFO - argparse == 1.2.1 09:49:07 INFO - blessings == 1.6 09:49:07 INFO - blobuploader == 1.2.4 09:49:07 INFO - docopt == 0.6.1 09:49:07 INFO - functools32 == 3.2.3-2 09:49:07 INFO - jsonschema == 2.5.1 09:49:07 INFO - manifestparser == 1.1 09:49:07 INFO - mozInstall == 1.12 09:49:07 INFO - mozcrash == 0.17 09:49:07 INFO - mozdebug == 0.1 09:49:07 INFO - mozdevice == 0.48 09:49:07 INFO - mozfile == 1.2 09:49:07 INFO - mozhttpd == 0.7 09:49:07 INFO - mozinfo == 0.9 09:49:07 INFO - mozleak == 0.1 09:49:07 INFO - mozlog == 3.3 09:49:07 INFO - moznetwork == 0.27 09:49:07 INFO - mozprocess == 0.23 09:49:07 INFO - mozprofile == 0.28 09:49:07 INFO - mozrunner == 6.12 09:49:07 INFO - mozscreenshot == 0.1 09:49:07 INFO - mozsystemmonitor == 0.3 09:49:07 INFO - moztest == 0.7 09:49:07 INFO - mozversion == 1.4 09:49:07 INFO - psutil == 3.1.1 09:49:07 INFO - requests == 1.2.3 09:49:07 INFO - wsgiref == 0.1.2 09:49:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:07 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:49:07 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 09:49:07 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 09:49:07 INFO - Using env: {'DISPLAY': ':0', 09:49:07 INFO - 'HOME': '/home/cltbld', 09:49:07 INFO - 'LANG': 'en_US.UTF-8', 09:49:07 INFO - 'LANGUAGE': 'en_US:en', 09:49:07 INFO - 'LOGNAME': 'cltbld', 09:49:07 INFO - 'MAIL': '/var/mail/cltbld', 09:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:07 INFO - 'MOZ_NO_REMOTE': '1', 09:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:07 INFO - 'NO_EM_RESTART': '1', 09:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:07 INFO - 'PWD': '/builds/slave/test', 09:49:07 INFO - 'SHELL': '/bin/bash', 09:49:07 INFO - 'SHLVL': '1', 09:49:07 INFO - 'TERM': 'linux', 09:49:07 INFO - 'TMOUT': '86400', 09:49:07 INFO - 'USER': 'cltbld', 09:49:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:07 INFO - '_': '/tools/buildbot/bin/python'} 09:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 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)) 09:49:07 INFO - Cleaning up... 09:49:07 INFO - Return code: 0 09:49:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:07 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 0x2a8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, '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': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', '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 09:49:07 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 09:49:07 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 09:49:07 INFO - Using env: {'DISPLAY': ':0', 09:49:07 INFO - 'HOME': '/home/cltbld', 09:49:07 INFO - 'LANG': 'en_US.UTF-8', 09:49:07 INFO - 'LANGUAGE': 'en_US:en', 09:49:07 INFO - 'LOGNAME': 'cltbld', 09:49:07 INFO - 'MAIL': '/var/mail/cltbld', 09:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:07 INFO - 'MOZ_NO_REMOTE': '1', 09:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:07 INFO - 'NO_EM_RESTART': '1', 09:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:07 INFO - 'PWD': '/builds/slave/test', 09:49:07 INFO - 'SHELL': '/bin/bash', 09:49:07 INFO - 'SHLVL': '1', 09:49:07 INFO - 'TERM': 'linux', 09:49:07 INFO - 'TMOUT': '86400', 09:49:07 INFO - 'USER': 'cltbld', 09:49:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:07 INFO - '_': '/tools/buildbot/bin/python'} 09:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:08 INFO - Cleaning up... 09:49:08 INFO - Return code: 0 09:49:08 INFO - Running post-action listener: _resource_record_post_action 09:49:08 INFO - Running post-action listener: _start_resource_monitoring 09:49:08 INFO - Starting resource monitoring. 09:49:08 INFO - [mozharness: 2016-07-20 16:49:08.177795Z] Finished create-virtualenv step (success) 09:49:08 INFO - [mozharness: 2016-07-20 16:49:08.178280Z] Running install step. 09:49:08 INFO - Running pre-action listener: _resource_record_pre_action 09:49:08 INFO - Running main action method: install 09:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:08 INFO - Reading from file tmpfile_stdout 09:49:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:08 INFO - Reading from file tmpfile_stdout 09:49:08 INFO - Output received: 09:49:08 INFO - Usage: mozinstall [options] installer 09:49:08 INFO - Options: 09:49:08 INFO - -h, --help show this help message and exit 09:49:08 INFO - -d DEST, --destination=DEST 09:49:08 INFO - Directory to install application into. [default: 09:49:08 INFO - "/builds/slave/test"] 09:49:08 INFO - --app=APP Application being installed. [default: firefox] 09:49:08 INFO - mkdir: /builds/slave/test/build/application 09:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:49:24 INFO - Reading from file tmpfile_stdout 09:49:24 INFO - Output received: 09:49:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:24 INFO - Running post-action listener: _resource_record_post_action 09:49:24 INFO - [mozharness: 2016-07-20 16:49:24.889553Z] Finished install step (success) 09:49:24 INFO - [mozharness: 2016-07-20 16:49:24.889832Z] Running run-tests step. 09:49:24 INFO - Running pre-action listener: _resource_record_pre_action 09:49:24 INFO - Running main action method: run_tests 09:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:24 INFO - Python 2.7.3 09:49:24 INFO - Return code: 0 09:49:24 INFO - grabbing minidump binary from tooltool 09:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:24 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 0x2d4c570>, '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 0x2d4d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:24 INFO - Return code: 0 09:49:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:49:24 INFO - Using env: {'DISPLAY': ':0', 09:49:24 INFO - 'HOME': '/home/cltbld', 09:49:24 INFO - 'LANG': 'en_US.UTF-8', 09:49:24 INFO - 'LANGUAGE': 'en_US:en', 09:49:24 INFO - 'LOGNAME': 'cltbld', 09:49:24 INFO - 'MAIL': '/var/mail/cltbld', 09:49:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:24 INFO - 'MOZ_NO_REMOTE': '1', 09:49:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:24 INFO - 'NO_EM_RESTART': '1', 09:49:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:24 INFO - 'PWD': '/builds/slave/test', 09:49:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:24 INFO - 'SHELL': '/bin/bash', 09:49:24 INFO - 'SHLVL': '1', 09:49:24 INFO - 'TERM': 'linux', 09:49:24 INFO - 'TMOUT': '86400', 09:49:24 INFO - 'USER': 'cltbld', 09:49:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039', 09:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:24 INFO - '_': '/tools/buildbot/bin/python'} 09:49:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:49:25 INFO - mozversion application_buildid: 20160720083420 09:49:25 INFO - mozversion application_changeset: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c 09:49:25 INFO - mozversion application_display_name: Nightly 09:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:25 INFO - mozversion application_name: Firefox 09:49:25 INFO - mozversion application_remotingname: firefox 09:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:49:25 INFO - mozversion application_vendor: Mozilla 09:49:25 INFO - mozversion application_version: 50.0a1 09:49:25 INFO - mozversion platform_buildid: 20160720083420 09:49:25 INFO - mozversion platform_changeset: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c 09:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:49:25 INFO - mozversion platform_version: 50.0a1 09:49:25 INFO - using testdate: 1469033365 09:49:25 INFO - actual date: 1469033365 09:49:25 INFO - starting webserver on 'localhost:54344' 09:49:25 INFO - SUITE-START | Running 2 tests 09:49:25 INFO - TEST-START | dromaeo_css 09:49:25 INFO - operating with platform_type : linux_ 09:49:25 INFO - Initialising browser for dromaeo_css test... 09:49:25 INFO - TEST-INFO | started process 10003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4OIz4/profile http://localhost:54344/getInfo.html) 09:49:29 INFO - PROCESS | 10003 | __metrics Screen width/height:1600/1200 09:49:29 INFO - PROCESS | 10003 | colorDepth:24 09:49:29 INFO - PROCESS | 10003 | Browser inner width/height: 1024/697 09:49:29 INFO - PROCESS | 10003 | __metrics 09:49:30 ERROR - PROCESS | 10003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:49:31 INFO - TEST-INFO | 10003: exit 0 09:49:31 INFO - Browser initialized. 09:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:31 INFO - TEST-INFO | started process 10123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4OIz4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:43 INFO - PROCESS | 10123 | RSS: Main: 168738816 09:49:43 INFO - PROCESS | 10123 | 09:50:32 INFO - PROCESS | 10123 | 1469033432811 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] 09:52:45 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54344/tests/dromaeo/cssquery-ext.html) 09:52:47 INFO - PROCESS | 10123 | RSS: Main: 170360832 09:52:47 INFO - PROCESS | 10123 | 09:55:49 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-ext.html (next: http://localhost:54344/tests/dromaeo/cssquery-jquery.html) 09:55:50 INFO - PROCESS | 10123 | RSS: Main: 170549248 09:55:50 INFO - PROCESS | 10123 | 09:58:52 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54344/tests/dromaeo/cssquery-mootools.html) 09:58:52 INFO - PROCESS | 10123 | RSS: Main: 173572096 09:58:52 INFO - PROCESS | 10123 | 10:01:54 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54344/tests/dromaeo/cssquery-prototype.html) 10:01:55 INFO - PROCESS | 10123 | RSS: Main: 168284160 10:01:55 INFO - PROCESS | 10123 | 10:04:58 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54344/tests/dromaeo/cssquery-yui.html) 10:04:58 INFO - PROCESS | 10123 | RSS: Main: 170115072 10:04:58 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-yui.html (next: http://localhost:54344/tests/dromaeo/cssquery-dojo.html) 10:08:01 INFO - PROCESS | 10123 | RSS: Main: 171454464 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | __start_tp_report 10:08:01 INFO - PROCESS | 10123 | _x_x_mozilla_page_load 10:08:01 INFO - PROCESS | 10123 | _x_x_mozilla_page_load_details 10:08:01 INFO - PROCESS | 10123 | |i|pagename|runs| 10:08:01 INFO - PROCESS | 10123 | |0;dojo.html;2595.727448617895;2621.8557979311136;2629.6581444412222;2676.2238950704295;2680.919572412827;4838.927416088757;4943.752812359381;4960.652754307195;4990.126727822626;4995.975020124894;4674.158651442739;4830.154722923483;4849.078675051737;4901.779419926103;4916.508349165082;4411.117776444716;4451.9777401113115;4579.725216487005;4580.7938642761155;4581.61056310214;4521.841735539257;4522.819087236507;4585.174668559658;4608.400907881971;4637.65217608679;4349.41282926804;4407.316865885793;4455.977720111411;4470.932936005963;4475.037866858641;4388.495323037828;4390.429244198233;4396.56034396561;4423.557644235583;4459.130469558438;4416;4451.666125040635;4453.955460445419;4462.4645042594775;4511.278195488706;4756.453007904101;4760.285957106462;4810.6873053251775;4840.540148685869;4858.951410485885;5158.509941555546;5161.148410512298;5162.1224391853475;5195.090859099642;5242.397124330712;5133.435322114565;5226.163813789775;5233.895322093575;5238.92141617876;5239.607029472805;4863.683860549053;4888.26675998596;4911.705297682151;4920.6309526785635;4943.110240156806;5365.651232669942;5377.704226267593;5382.946170538245;5425.457454254622;5434.049140634297;4897.681650692693;5168.508991645787;5188.481151884781;5195.6622819516615;5234.633575649744;4915.582175515121;5173.92239116406;5197.402298735618;5250.369955605352;5268.104422248227;5177.094008548489;5211.765470553834;5249.790008399621;5256.763445644955;5263.473652634706;5225.712585807817;5239.947600524022;5253.343332083489;5263.3947096083675;5292.073887069748;4333.804978775963;4372.584604462571;4432.445944256968;4456.888577785581;4526.049529598821;3850.441685955521;3864.169203621235;3873.24471728016;3899.941500877489;3903.2388684206876;4521.434820647419;4522.34426008227;4523.163214805206;4544.613707834871;4558.361829343895;5099.36257967754;5233.4243233244315;5258.07983602868;5280.6039547034125;5309.548688361455;4494.348319493655;4545.613622842029;4548.840790572314;4569.29175977724;4581.816727330869;4753.714777113384;4755.38180036593;4764.285357196448;4793.01743142655;4831.782569784298;4783.7129772213775;4881.877953051202;4927.260910863399;4934.259861020875;4937.382827146606;5270.288511050959;5295.788168473218;5314.5216930476445;5318.441563635917;5353.785848566014;4940.061388336205;4947.752612369439;4949.480304568113;4951.430585482715;4993.201087825931;4969.726665033458;5036.395632524121;5088.6946783193125;5110.565601923878;5177.741112944263;5155.149400349051;5176.301199338041;5181.06740786647;5202.115640341075;5211.114110601283;5034.496550345083;5041.42023667283;5052.494750524918;5062.594992400525;5097.235414687826;4927.679700819435;5035.169197082587;5080.085584594808;5114.64197506171;5128.948710512847;4982.227754698028;5054.494550544916;5100.48995100487;5106.259592359162;5110.821121260887;5074.238864170404;5122.46214147524;5124.641275110706;5139.177731562932;5164.922526162036;4801.91956809729;4904.5095490452095;4947.356843610308;4976.029674213639;4991.42598601151 10:08:01 INFO - PROCESS | 10123 | |1;ext.html;553.0404747762634;561.2647431864258;570.4381184533235;575.0626478839491;585.8271809816104;36123.458148127764;40857;41134;41197;41362.37956430656;41014.38478422826;41043.794781026125;41506;41543;41620.16759664805;7717.575533345678;7921.7227397041115;7923.643436045363;7932.048154221501;7958.562279074648;7715.768526944201;7780.6109694515335;7786.610669466532;7818.1009183943725;7826.921730782677;7744.186860379636;7800.141984381714;7803.063632364124;7823.608819559027;7859.882101768478;7783.494072885244;7783.610819459004;7794.72718454857;7798.142204357488;7798.688052477894;7712.6529306181355;7742.070951485802;7762.45662803604;7767;7774.689012439552;38588.421173682415;39039;39124.608753912384;39227.8038609808;39396;2404.7955923746504;2757.655293088364;2843.559248316514;2978.19588711049;2980.8509574521404;28091.29771755702;28195.718042819513;28621;28661.57007644887;29228.976985805395;3152;3176.3806057818733;3189.9043028709175;3208.566843476124;3230.5800245967876;232648;232873;234990.8250458754;235908;236799;31198.532022019688;31411.528827067614;31421.057368278987;31452.685473145433;31540.36919261602;33400.33199336;33489.162770930925;34268.65731342655;34341.14147146291;36013.279734405165;15373.538793836204;15550.911436199358;15582.45461408868;15583.922080389526;15657.765133522778;11540.422978851024;11544.307341559534;11585.536578536932;11617.825732614017;11637.243579167496;18226.63546729058;18390.63218735618;18588.721169182474;18693.345732899284;18830.51635447419;6996.510244282953;7040.6479676016;7082.822929426806;7248.086909331704;7276.854462910712;789.3842802613971;867.3841572483482;892.3485855325648;941.9811603768023;947.0151042915429;27908.302292442444;29431;29572.39669751895;29787.55318670222;30015.249618759706;967.511406739592;1004.7488127968008;1009.7021378693303;1012.7620009297809;1083.0847933496184;15013.924930375497;15665.843341566439;15888.841111588736;15918.137007645977;15991.36034558628;403470;405628;405792;406675.4325882274;406947;50549;50933.74533127311;51217.7439112802;51295;51553.48446515562;1148.9655310340704;1164.5283660117666;1226.350034481744;1236.8330275412884;1248.606688893014;27440;28332.858335708188;29083.854580727806;29193.416131676822;29586.704132958395;44564.55435445604;44737.55262447334;44815.10369792651;44974.77512612416;44976.550234497234;356966;357326;357755;359511;359538;25200.873995629903;26312.8684356577;26322.341941451617;26323.60514592321;26337.604935925592;42872;43252.78373608112;43307.35038974355;43450.56549434465;43968.12063758771;36336.63663363332;37163.442548362334;39629.80185099056;40896.386554202305;42367;36219.27561448809;36563.63436365602;37144;37377.813110935356;37429.251414971004;37105.44341834821;37217;37925.810370949075;38111.80944095262;40108.39837402383;30562;33308.833455832566;34877.30245395027;34924.47613285854;34967.82516087403;26576.8671156643;26603.60094598544;26847.597286041117;27020;27118.864405677847 10:08:01 INFO - PROCESS | 10123 | |2;jquery.html;349.51592045017645;370.98516059357627;372.7893740036878;380.4483498926557;390.71282607283644;15856.445024424147;17484.30062797488;17873.553161170978;17878.28486860524;17952.10239488027;16684.164741878383;17009.659806803855;17495.125243737795;17552;17663;4986.326845875806;5176.663516871391;5195.220716892478;5195.870103247411;5205.713685747282;3878.146807702301;5160.767765450545;5827.242458480391;6081.361457046991;6136.938630613704;6178.38216178383;6186.907196392058;6193.566450348478;6212.62724236545;6216.689165541728;6139.017757158856;6142.539309551801;6142.723577439048;6162.075688646694;6168.568200225964;5194.142966410538;5273.683578985273;5313.946860531384;5342.893142137174;5410.675359478405;20935;21035.368938931857;21176.788232117637;21212.151513939578;21219.5756084879;1849.907504624777;1872.896990665513;1878.64305781901;1998.530345368837;2448.155386391692;13457.932710336483;13587.796183057262;13785;13799.2410417427;14301.64245893861;1743.790745110582;1802.4142153800067;1852.8980906050163;1859.5072305838964;1883.4349695091419;80388;82702;83440.16559834384;84188.57905710493;85389.57305213434;16625.83374166267;16674.666506669797;16831;16850.662986740197;16916.915415422845;29333.85333073321;29444;29448.411031779244;29471.557926631118;29478.557821632694;9141.817163656822;9257.166854982948;9309.20871725911;9680.515974201262;9736.269779766546;7724.575148366894;7749.883751743729;7757.961210194026;7978;8021.117677055519;8187.672493100209;8384.455010424303;8398.496090234605;8410.621522031523;8624.913750862412;1542.2597153366446;1554.7356949318644;1628.9592760180853;3247.6265229498435;3251.7561182911377;849.362977766675;885.4996926736374;906.4334790755778;935.9578818953163;943.9757862719027;16846.91576542134;16901.23944422504;17474.291484819874;17718.734218986727;17798.84307520007;771.2981187119806;812.6911773526023;822.3955392786297;852.2500199824115;916.9037251088673;8412.032616249087;8768.123187681182;8904.554772261361;8987.865182022275;9086.772830679285;310755;417310;418108;420106;423471;52939.47060529423;54070;81416;82891.58554207311;84013;913.5432283858071;919.8758167647416;969.9369540979814;975.3611384543135;975.9316847820727;15752.763708544151;15836.92081539585;15870.68258634844;16324.591885202964;16530.09084500364;37009;38073;38324.6167538321;38336.616633833306;39036.60963390443;52025;52331;52630;54060.18909716279;54922;7505.099388073248;7557.697692092254;7575.128860181149;7751.844963100819;7759.30166285037;8642.956785216034;11664.475098620753;11842.467088980844;12101.213421127599;12550.0587455943;10023;10115.14021308197;10381.740456488647;10431.634892778717;10781.299215550964;10383.792324153626;10401.427921464392;10481.475926203811;10526.842047374936;10685.252032357661;10133.847992279974;10430.16558675289;10564.366138031743;10680.89319106799;10949.45252737344;7439.144498382755;7545;7663.770086897402;7699.26856948589;7814.921850781419;4678.789454474489;4742.976285118691;9643.566039528378;9924.206063515046;10820.350778953289 10:08:01 INFO - PROCESS | 10123 | |3;mootools.html;1388.2989090509295;1422.8932830037747;1492.9626759331015;1695.5167777183506;1704.539774260949;6863.2107307659635;7630.65662045208;7642.503237289572;8241.217084376982;8247.79380515488;7687.346575541086;7869.370450363971;7963.163867793871;8008.799780005503;8009.11899691035;2210.4694873230387;2253.4704344479032;2256.717910261217;2260.8191344692386;2269.636858102704;2152.773958734334;2233.9553208935813;2238.6194346961056;2238.7201599800023;2240.5406891587186;2127.8084972352485;2140.571885622882;2143.4427048967304;2151.139544182324;2200.6258935980923;2167.328128280238;2174.065151984646;2176.3035828534876;2181.6727490876337;2185.191479152708;2056.598963202176;2081.718967939324;2083.2916808285254;2083.4166433398523;2086.050846864673;8009.799755006114;8023.558704271263;8032.759017229492;8036.357091432671;8041.477303975282;4623.56076172763;4709.599684026862;4749.121412538657;4759.095771803346;4780.689255198401;2794.5109605819102;2871.913842584726;2915.533514637669;2950.6901775313713;3007.9548806767916;902.7336935604012;967.4727273635885;972.7422233108232;996.8405055191134;998.9250806189492;10647.680569583003;10678.946605266923;10691.144708423308;10728.892711072867;10758.085562727178;4032;4204.726692764961;4341.283688191476;4346.543612920661;4354.325079612665;8982.281417486585;9070.319726020574;9080.727578172533;9122.86315705265;9145.222656074307;4766.118268120409;4781.6891902026255;4786.569208771228;4792.472827988919;4803.567678908915;3703.129764505339;4255.5957184067465;4353.064091220403;4353.869383918487;4354;3631.4915911772373;3674.65090816372;3722.2927643747603;3801.2777572261184;3815.2369526094335;1122.9550817967354;1191.1602320364123;1192.2548407245472;1210.0622017935993;1225.9448324825405;846.9618867150994;858.3776761847611;859.441363113981;898.5192921786812;901.3600343756007;5287.312649355559;5327.600429967768;5339.092354299778;5380.838574842761;5447.673139611636;874.8294082653821;909.9772505687279;924.9630014799467;927.1377618814568;939.793245485992;3522.172289511963;3526.3476256892045;3533.858645654145;3611.9097022574647;3639.1084184374467;9463.242940564738;9933.25500587459;9942.403455792675;9943.701688949342;9986.600535978625;9859.26055545837;9861.950690246646;9877.160441362565;9879.357841740264;9913.752156196153;7068.434525237969;7380.889286660705;7400.888986665204;7452.776416707507;7565.092188937363;5405.729713514387;5472.069748142905;5543.611947163821;5655.688937108499;5661.094224923992;8919.241864441596;8953.104689530996;8979.595918183828;9097.909020909707;9108.453492790453;9250.352475326932;9267.351285410226;9272;9297.395669281475;9377.953110234404;6012.428819262163;6684.364985326386;6792.694328755119;6892.414144797548;7081.964590177016;7597.3162415382885;7690.961720167929;7702.537847729154;7736.690532378641;7743.845123097619;6863;7001.964990175016;7006.9649651751415;7045.365917067488;7237.782866514013;6599.571027883172;6678.532502724763;6812.352826481477;6862.107925969592;6939.687714052779;6169.84575385619;6328.715207815567;6353.4599559038;6398.616083035033;6405.423511883952;4236.830526778895;4455.821767129279;4554.635629149726;4565.292379681155;4572;4370.868873933787;4402.5597440255715;4483.887902802456;4520.07338495601;4543.4775000875325 10:08:01 INFO - PROCESS | 10123 | |4;prototype.html;299.71227621483376;303.3054305640084;306.6979025659725;307.52640932963254;309.81256339914364;5042.545856088582;5065.974670126649;5090.160123579614;5091.490850914906;5093.541581257686;5015.423226328973;5016.799328026884;5021.5645411975165;5022.246663000552;5022.673526220793;3799.7720136791813;3808.7143464240294;3893.1629699614577;3928.387622231213;3943.0142464383903;3933.4099885017336;3934.8426062957446;3938.2714197873483;3942.172143849795;3946.3291240489043;3936.9015774605577;3936.960630393688;3939.665128464084;3949.4273330367078;3954.070793363557;3782.8084153491563;3906.374980003214;3913.98043009786;3918.510965832994;3927.430522574225;3459.2043829919007;3461.248307595468;3463.2207753255316;3468;3471.9826400868087;4876.512348765131;4904.852854414374;4909.288153217799;4913.508649135094;4925.581325587329;4353.564643535653;4458.480958258573;4469.620082293009;4491.191585514606;4505.346724724896;5226.451222621608;5265.815696450644;5275.894482110375;5279.260903473517;5289.471052894718;3768.8680896168503;3779.6598306152578;3781.8865434037025;3784.280986612562;3789.204267103884;5342.252084708144;5479.0959491683825;5480.725963701839;5487.807926722546;5495.450454954513;3832.2718683450057;3835.6931445484292;3838.0213045673177;3857.4985251917633;3868.6905047596124;3893.5133108361456;3908.6482216600643;3911.1395492991496;3912.667423269054;3912.784796836201;4445.488768791565;4447.466304043471;4460.30865215892;4465.620422264144;4486.327050942385;5018.197088465828;5270.578353731692;5271.367435907716;5273.894522109536;5310.2831117798605;1324.9334285899943;1326.747917895616;1328.3225554966843;1337.9130356526794;1341.9194848308937;823.9752807415787;852.0925214646381;857.4512312120248;859.9828003439897;867.3494878840869;4444.511103778582;4474.293052703133;4624.815007399667;4627.190241707755;4647.814087436533;5431.402545719968;5473;5474.206240095244;5498.670079795225;5499.972500137554;4586.334981427674;4602.493725690171;4604.539546045368;4611.492735799059;4615.953840461552;2758.3379988802544;2905.2301140197865;2916.3000879789124;2925.7220564046384;2929.633795775528;5084.288199652052;5111.539961403491;5118.181091025418;5129.922716229634;5134.306868572695;5346.759395827119;5519.779208831682;5536.861578460571;5589.888202235932;5597.74810133545;5058.760603652128;5087.465816089258;5091.745412729349;5092.363454568179;5096.541311282002;5478.233047373291;5486.396496385474;5489.847132102143;5490.972545137249;5497.752601132878;5093.719845408538;5327.9733601331745;5331.600129990344;5345.839624811262;5399.676019438846;5119.718415487184;5132.435432102391;5139.563137133386;5149.201873709581;5155.711072231942;3820.1595648957186;3842.9231415370978;3852.1332700142243;3852.1910398816563;3853.0560012797046;5222.2688823565495;5450.672959622435;5458.972705136449;5517.503424691797;5520.779168833202;5317.0960936640095;5344.9732751336;5350.7693230556415;5355.946440535545;5363.302770639792;5353.304070470814;5360.865978350416;5370.731463426891;5380.757865895966;5408.59435542328;5151.484851514819;5203.375594928481;5247.9737601311745;5266.631335806457;5275.287836142072;5006.824761133343;5117.667351622133;5252.501012403815;5259.8422047338645;5288.709120998228;5157.535821776059;5185.688858668492;5185.766640501262;5186.06650802844;5197.4542673020305 10:08:01 INFO - PROCESS | 10123 | |5;yui.html;602.9698515074246;640.5068097564872;674.4098913450731;731.8133875861656;766.0998326965815;13334.533291334805;14323.92838035811;14517.419303227858;14520.05619634723;14521.419143234285;13322.800157997637;13482.730345393085;13508.257045862474;13510.189388636689;13532.052756307063;620.5190976992822;768.1128296817158;780.6643143448315;781.5584194929846;794.8648729715962;789.8933643958078;792.528445574882;794.0788685125256;794.4240425691356;794.9801254968643;840.4705035827451;847.4279861093768;847.8812966184739;848.0586548930683;850.3537311643134;837.794740288627;837.7989282572199;838.5555655502593;844.3920377328344;844.543946269017;615.6613862375721;615.92916814566;615.9414855588711;617.7405489694339;618.5700937848197;13424.194548327034;13514.729705405935;13520.256385898772;13531;13562.79655805154;13076.280804555745;13380.665483362896;13818.170909745348;13883.652908677263;13906.93046534771;10519.263651544396;10665.466726663635;10792.244542882001;10918;11030.558777648965;3237.3363460490777;3284.080457471912;3286.7206287465356;3311.420501412243;3312.4368857294317;61458.692706536625;62089;62955;63019.05471417886;63332.366676333106;10462.319949203278;10471.84292235617;10494.527746251437;10609.628662996758;10799.190060745475;19714.309999149962;19746.210151594063;19797.109130089182;19915.302964396178;20165.79834201639;6833.658317084126;6991.580505169706;6998.090248267693;7051.259617740166;7052.2595127511895;3724.3110024645525;3814.408766641175;3815.847366105325;3843.9615603844163;3925.0187453136714;2954.3795802881205;3029.712177343149;3031.77261705373;3042;3043.710847469487;487.97072175669575;489.54961435479447;492.40419092898;494.2758858272576;511.959043276537;499.07606178183306;512.4721536817084;521.3431076843129;541.4314969282237;555.9805406810823;6919.342662447059;7159.105111861018;7285.927140728631;7575.507592006612;7903.36773058154;428.3852671416527;436.36073152831256;441.3930845088004;460.96312295016315;501.68143229049815;3812.4662547243406;3954.7231693781737;4227.830886764495;4290.420793192879;4294.055307832272;57846.710766445896;58412;99056;104227;104764.47617761862;84671;87383.56308218546;88850.55574722214;92599;93220;79539.60230198927;79590.6020469894;80123;80688.19311806925;82735.586322068;7623.275788800055;7864.567448790372;7954.323882469824;7972.840543188988;8170.591470426574;43947.34078988882;44377;45928.540714592426;46026.769866150455;46254.537454625024;38878.222435551696;43516.78241608771;44386;44791.776041119585;67102.32897670961;9693.176080033276;9835.85246221293;9945.751356216153;10037.899621003697;10523.579056837641;11167.162462815484;11330.150238732293;11335.489902954552;11446.771064578495;11664.358460284426;10021.09810117093;10083.647072352433;10113;10635.468226588484;11096.223264371416;10078.395296282246;10205.948970255102;10516.474176291002;10623.203259755704;11062.944685276843;9851.310408271353;9896.752581185528;9962.551685174329;10325.380477171393;10823.350598964087;7816.687332506864;7899.565523896241;7937.8412431752195;8016.198380161937;8046.195380461907;8310.12743661931;8560.48637081777;8876.392214527797;8973.32700047486;9000.189982901571 10:08:01 INFO - PROCESS | 10123 | __end_tp_report 10:08:01 INFO - PROCESS | 10123 | __start_cc_report 10:08:01 INFO - PROCESS | 10123 | _x_x_mozilla_cycle_collect,393 10:08:01 INFO - PROCESS | 10123 | __end_cc_report 10:08:01 INFO - PROCESS | 10123 | __startTimestamp1469034481591__endTimestamp 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | ------- Summary: start ------- 10:08:01 INFO - PROCESS | 10123 | Number of tests: 6 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#0] dojo.html Cycles:165 Average:4823.27 Median:4943.75 stddev:517.39 (10.5%) stddev-sans-first:488.58 10:08:01 INFO - PROCESS | 10123 | Values: 2595.7 2621.9 2629.7 2676.2 2680.9 4838.9 4943.8 4960.7 4990.1 4996.0 4674.2 4830.2 4849.1 4901.8 4916.5 4411.1 4452.0 4579.7 4580.8 4581.6 4521.8 4522.8 4585.2 4608.4 4637.7 4349.4 4407.3 4456.0 4470.9 4475.0 4388.5 4390.4 4396.6 4423.6 4459.1 4416.0 4451.7 4454.0 4462.5 4511.3 4756.5 4760.3 4810.7 4840.5 4859.0 5158.5 5161.1 5162.1 5195.1 5242.4 5133.4 5226.2 5233.9 5238.9 5239.6 4863.7 4888.3 4911.7 4920.6 4943.1 5365.7 5377.7 5382.9 5425.5 5434.0 4897.7 5168.5 5188.5 5195.7 5234.6 4915.6 5173.9 5197.4 5250.4 5268.1 5177.1 5211.8 5249.8 5256.8 5263.5 5225.7 5239.9 5253.3 5263.4 5292.1 4333.8 4372.6 4432.4 4456.9 4526.0 3850.4 3864.2 3873.2 3899.9 3903.2 4521.4 4522.3 4523.2 4544.6 4558.4 5099.4 5233.4 5258.1 5280.6 5309.5 4494.3 4545.6 4548.8 4569.3 4581.8 4753.7 4755.4 4764.3 4793.0 4831.8 4783.7 4881.9 4927.3 4934.3 4937.4 5270.3 5295.8 5314.5 5318.4 5353.8 4940.1 4947.8 4949.5 4951.4 4993.2 4969.7 5036.4 5088.7 5110.6 5177.7 5155.1 5176.3 5181.1 5202.1 5211.1 5034.5 5041.4 5052.5 5062.6 5097.2 4927.7 5035.2 5080.1 5114.6 5128.9 4982.2 5054.5 5100.5 5106.3 5110.8 5074.2 5122.5 5124.6 5139.2 5164.9 4801.9 4904.5 4947.4 4976.0 4991.4 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#1] ext.html Cycles:180 Average:48025.70 Median:36277.96 stddev:89881.49 (247.8%) stddev-sans-first:90062.96 10:08:01 INFO - PROCESS | 10123 | Values: 553.0 561.3 570.4 575.1 585.8 36123.5 40857.0 41134.0 41197.0 41362.4 41014.4 41043.8 41506.0 41543.0 41620.2 7717.6 7921.7 7923.6 7932.0 7958.6 7715.8 7780.6 7786.6 7818.1 7826.9 7744.2 7800.1 7803.1 7823.6 7859.9 7783.5 7783.6 7794.7 7798.1 7798.7 7712.7 7742.1 7762.5 7767.0 7774.7 38588.4 39039.0 39124.6 39227.8 39396.0 2404.8 2757.7 2843.6 2978.2 2980.9 28091.3 28195.7 28621.0 28661.6 29229.0 3152.0 3176.4 3189.9 3208.6 3230.6 232648.0 232873.0 234990.8 235908.0 236799.0 31198.5 31411.5 31421.1 31452.7 31540.4 33400.3 33489.2 34268.7 34341.1 36013.3 15373.5 15550.9 15582.5 15583.9 15657.8 11540.4 11544.3 11585.5 11617.8 11637.2 18226.6 18390.6 18588.7 18693.3 18830.5 6996.5 7040.6 7082.8 7248.1 7276.9 789.4 867.4 892.3 942.0 947.0 27908.3 29431.0 29572.4 29787.6 30015.2 967.5 1004.7 1009.7 1012.8 1083.1 15013.9 15665.8 15888.8 15918.1 15991.4 403470.0 405628.0 405792.0 406675.4 406947.0 50549.0 50933.7 51217.7 51295.0 51553.5 1149.0 1164.5 1226.4 1236.8 1248.6 27440.0 28332.9 29083.9 29193.4 29586.7 44564.6 44737.6 44815.1 44974.8 44976.6 356966.0 357326.0 357755.0 359511.0 359538.0 25200.9 26312.9 26322.3 26323.6 26337.6 42872.0 43252.8 43307.4 43450.6 43968.1 36336.6 37163.4 39629.8 40896.4 42367.0 36219.3 36563.6 37144.0 37377.8 37429.3 37105.4 37217.0 37925.8 38111.8 40108.4 30562.0 33308.8 34877.3 34924.5 34967.8 26576.9 26603.6 26847.6 27020.0 27118.9 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#2] jquery.html Cycles:180 Average:25851.64 Median:214074.89 stddev:66170.45 (30.9%) stddev-sans-first:66328.37 10:08:01 INFO - PROCESS | 10123 | Values: 349.5 371.0 372.8 380.4 390.7 15856.4 17484.3 17873.6 17878.3 17952.1 16684.2 17009.7 17495.1 17552.0 17663.0 4986.3 5176.7 5195.2 5195.9 5205.7 3878.1 5160.8 5827.2 6081.4 6136.9 6178.4 6186.9 6193.6 6212.6 6216.7 6139.0 6142.5 6142.7 6162.1 6168.6 5194.1 5273.7 5313.9 5342.9 5410.7 20935.0 21035.4 21176.8 21212.2 21219.6 1849.9 1872.9 1878.6 1998.5 2448.2 13457.9 13587.8 13785.0 13799.2 14301.6 1743.8 1802.4 1852.9 1859.5 1883.4 80388.0 82702.0 83440.2 84188.6 85389.6 16625.8 16674.7 16831.0 16850.7 16916.9 29333.9 29444.0 29448.4 29471.6 29478.6 9141.8 9257.2 9309.2 9680.5 9736.3 7724.6 7749.9 7758.0 7978.0 8021.1 8187.7 8384.5 8398.5 8410.6 8624.9 1542.3 1554.7 1629.0 3247.6 3251.8 849.4 885.5 906.4 936.0 944.0 16846.9 16901.2 17474.3 17718.7 17798.8 771.3 812.7 822.4 852.3 916.9 8412.0 8768.1 8904.6 8987.9 9086.8 310755.0 417310.0 418108.0 420106.0 423471.0 52939.5 54070.0 81416.0 82891.6 84013.0 913.5 919.9 969.9 975.4 975.9 15752.8 15836.9 15870.7 16324.6 16530.1 37009.0 38073.0 38324.6 38336.6 39036.6 52025.0 52331.0 52630.0 54060.2 54922.0 7505.1 7557.7 7575.1 7751.8 7759.3 8643.0 11664.5 11842.5 12101.2 12550.1 10023.0 10115.1 10381.7 10431.6 10781.3 10383.8 10401.4 10481.5 10526.8 10685.3 10133.8 10430.2 10564.4 10680.9 10949.5 7439.1 7545.0 7663.8 7699.3 7814.9 4678.8 4743.0 9643.6 9924.2 10820.4 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#3] mootools.html Cycles:180 Average:5215.68 Median:5459.87 stddev:2926.56 (53.6%) stddev-sans-first:2920.64 10:08:01 INFO - PROCESS | 10123 | Values: 1388.3 1422.9 1493.0 1695.5 1704.5 6863.2 7630.7 7642.5 8241.2 8247.8 7687.3 7869.4 7963.2 8008.8 8009.1 2210.5 2253.5 2256.7 2260.8 2269.6 2152.8 2234.0 2238.6 2238.7 2240.5 2127.8 2140.6 2143.4 2151.1 2200.6 2167.3 2174.1 2176.3 2181.7 2185.2 2056.6 2081.7 2083.3 2083.4 2086.1 8009.8 8023.6 8032.8 8036.4 8041.5 4623.6 4709.6 4749.1 4759.1 4780.7 2794.5 2871.9 2915.5 2950.7 3008.0 902.7 967.5 972.7 996.8 998.9 10647.7 10678.9 10691.1 10728.9 10758.1 4032.0 4204.7 4341.3 4346.5 4354.3 8982.3 9070.3 9080.7 9122.9 9145.2 4766.1 4781.7 4786.6 4792.5 4803.6 3703.1 4255.6 4353.1 4353.9 4354.0 3631.5 3674.7 3722.3 3801.3 3815.2 1123.0 1191.2 1192.3 1210.1 1225.9 847.0 858.4 859.4 898.5 901.4 5287.3 5327.6 5339.1 5380.8 5447.7 874.8 910.0 925.0 927.1 939.8 3522.2 3526.3 3533.9 3611.9 3639.1 9463.2 9933.3 9942.4 9943.7 9986.6 9859.3 9862.0 9877.2 9879.4 9913.8 7068.4 7380.9 7400.9 7452.8 7565.1 5405.7 5472.1 5543.6 5655.7 5661.1 8919.2 8953.1 8979.6 9097.9 9108.5 9250.4 9267.4 9272.0 9297.4 9378.0 6012.4 6684.4 6792.7 6892.4 7082.0 7597.3 7691.0 7702.5 7736.7 7743.8 6863.0 7002.0 7007.0 7045.4 7237.8 6599.6 6678.5 6812.4 6862.1 6939.7 6169.8 6328.7 6353.5 6398.6 6405.4 4236.8 4455.8 4554.6 4565.3 4572.0 4370.9 4402.6 4483.9 4520.1 4543.5 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#4] prototype.html Cycles:180 Average:4382.83 Median:5022.46 stddev:1280.43 (25.5%) stddev-sans-first:1246.80 10:08:01 INFO - PROCESS | 10123 | Values: 299.7 303.3 306.7 307.5 309.8 5042.5 5066.0 5090.2 5091.5 5093.5 5015.4 5016.8 5021.6 5022.2 5022.7 3799.8 3808.7 3893.2 3928.4 3943.0 3933.4 3934.8 3938.3 3942.2 3946.3 3936.9 3937.0 3939.7 3949.4 3954.1 3782.8 3906.4 3914.0 3918.5 3927.4 3459.2 3461.2 3463.2 3468.0 3472.0 4876.5 4904.9 4909.3 4913.5 4925.6 4353.6 4458.5 4469.6 4491.2 4505.3 5226.5 5265.8 5275.9 5279.3 5289.5 3768.9 3779.7 3781.9 3784.3 3789.2 5342.3 5479.1 5480.7 5487.8 5495.5 3832.3 3835.7 3838.0 3857.5 3868.7 3893.5 3908.6 3911.1 3912.7 3912.8 4445.5 4447.5 4460.3 4465.6 4486.3 5018.2 5270.6 5271.4 5273.9 5310.3 1324.9 1326.7 1328.3 1337.9 1341.9 824.0 852.1 857.5 860.0 867.3 4444.5 4474.3 4624.8 4627.2 4647.8 5431.4 5473.0 5474.2 5498.7 5500.0 4586.3 4602.5 4604.5 4611.5 4616.0 2758.3 2905.2 2916.3 2925.7 2929.6 5084.3 5111.5 5118.2 5129.9 5134.3 5346.8 5519.8 5536.9 5589.9 5597.7 5058.8 5087.5 5091.7 5092.4 5096.5 5478.2 5486.4 5489.8 5491.0 5497.8 5093.7 5328.0 5331.6 5345.8 5399.7 5119.7 5132.4 5139.6 5149.2 5155.7 3820.2 3842.9 3852.1 3852.2 3853.1 5222.3 5450.7 5459.0 5517.5 5520.8 5317.1 5345.0 5350.8 5355.9 5363.3 5353.3 5360.9 5370.7 5380.8 5408.6 5151.5 5203.4 5248.0 5266.6 5275.3 5006.8 5117.7 5252.5 5259.8 5288.7 5157.5 5185.7 5185.8 5186.1 5197.5 10:08:01 INFO - PROCESS | 10123 | 10:08:01 INFO - PROCESS | 10123 | [#5] yui.html Cycles:180 Average:17168.85 Median:490.98 stddev:24893.61 (5070.2%) stddev-sans-first:24932.36 10:08:01 INFO - PROCESS | 10123 | Values: 603.0 640.5 674.4 731.8 766.1 13334.5 14323.9 14517.4 14520.1 14521.4 13322.8 13482.7 13508.3 13510.2 13532.1 620.5 768.1 780.7 781.6 794.9 789.9 792.5 794.1 794.4 795.0 840.5 847.4 847.9 848.1 850.4 837.8 837.8 838.6 844.4 844.5 615.7 615.9 615.9 617.7 618.6 13424.2 13514.7 13520.3 13531.0 13562.8 13076.3 13380.7 13818.2 13883.7 13906.9 10519.3 10665.5 10792.2 10918.0 11030.6 3237.3 3284.1 3286.7 3311.4 3312.4 61458.7 62089.0 62955.0 63019.1 63332.4 10462.3 10471.8 10494.5 10609.6 10799.2 19714.3 19746.2 19797.1 19915.3 20165.8 6833.7 6991.6 6998.1 7051.3 7052.3 3724.3 3814.4 3815.8 3844.0 3925.0 2954.4 3029.7 3031.8 3042.0 3043.7 488.0 489.5 492.4 494.3 512.0 499.1 512.5 521.3 541.4 556.0 6919.3 7159.1 7285.9 7575.5 7903.4 428.4 436.4 441.4 461.0 501.7 3812.5 3954.7 4227.8 4290.4 4294.1 57846.7 58412.0 99056.0 104227.0 104764.5 84671.0 87383.6 88850.6 92599.0 93220.0 79539.6 79590.6 80123.0 80688.2 82735.6 7623.3 7864.6 7954.3 7972.8 8170.6 43947.3 44377.0 45928.5 46026.8 46254.5 38878.2 43516.8 44386.0 44791.8 67102.3 9693.2 9835.9 9945.8 10037.9 10523.6 11167.2 11330.2 11335.5 11446.8 11664.4 10021.1 10083.6 10113.0 10635.5 11096.2 10078.4 10205.9 10516.5 10623.2 11062.9 9851.3 9896.8 9962.6 10325.4 10823.4 7816.7 7899.6 7937.8 8016.2 8046.2 8310.1 8560.5 8876.4 8973.3 9000.2 10:08:01 INFO - PROCESS | 10123 | -------- Summary: end -------- 10:08:01 INFO - PROCESS | 10123 | 10:08:02 INFO - TEST-INFO | 10123: exit 0 10:08:02 INFO - TEST-OK | dromaeo_css | took 1117239ms 10:08:02 INFO - TEST-START | kraken 10:08:02 INFO - operating with platform_type : linux_ 10:08:02 INFO - Initialising browser for kraken test... 10:08:02 INFO - TEST-INFO | started process 10365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmKR53/profile http://localhost:54344/getInfo.html) 10:08:07 INFO - PROCESS | 10365 | __metrics Screen width/height:1600/1200 10:08:07 INFO - PROCESS | 10365 | colorDepth:24 10:08:07 INFO - PROCESS | 10365 | Browser inner width/height: 1024/697 10:08:07 INFO - PROCESS | 10365 | __metrics 10:08:07 ERROR - PROCESS | 10365 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:08:08 INFO - TEST-INFO | 10365: exit 0 10:08:08 INFO - Browser initialized. 10:08:08 INFO - Running cycle 1/1 for kraken test... 10:08:08 INFO - TEST-INFO | started process 10485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmKR53/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:20 INFO - PROCESS | 10485 | RSS: Main: 168513536 10:08:20 INFO - PROCESS | 10485 | 10:08:23 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:24 INFO - PROCESS | 10485 | RSS: Main: 173543424 10:08:24 INFO - PROCESS | 10485 | 10:08:26 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-dft) 10:08:27 INFO - PROCESS | 10485 | RSS: Main: 172802048 10:08:27 INFO - PROCESS | 10485 | 10:08:30 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-fft) 10:08:30 INFO - PROCESS | 10485 | RSS: Main: 169132032 10:08:30 INFO - PROCESS | 10485 | 10:08:33 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-oscillator) 10:08:33 INFO - PROCESS | 10485 | RSS: Main: 169594880 10:08:33 INFO - PROCESS | 10485 | 10:08:36 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:36 INFO - PROCESS | 10485 | RSS: Main: 170328064 10:08:36 INFO - PROCESS | 10485 | 10:08:39 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:40 INFO - PROCESS | 10485 | RSS: Main: 170266624 10:08:40 INFO - PROCESS | 10485 | 10:08:44 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:44 INFO - PROCESS | 10485 | RSS: Main: 167510016 10:08:44 INFO - PROCESS | 10485 | 10:08:47 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54344/tests/kraken/driver.html?testName=json-parse-financial) 10:08:48 INFO - PROCESS | 10485 | RSS: Main: 169140224 10:08:48 INFO - PROCESS | 10485 | 10:08:49 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:50 INFO - PROCESS | 10485 | RSS: Main: 169070592 10:08:50 INFO - PROCESS | 10485 | 10:08:52 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:53 INFO - PROCESS | 10485 | RSS: Main: 169910272 10:08:53 INFO - PROCESS | 10485 | 10:08:55 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:56 INFO - PROCESS | 10485 | RSS: Main: 170291200 10:08:56 INFO - PROCESS | 10485 | 10:08:58 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:59 INFO - PROCESS | 10485 | RSS: Main: 170360832 10:08:59 INFO - PROCESS | 10485 | 10:09:02 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:03 INFO - PROCESS | 10485 | RSS: Main: 170074112 10:09:03 INFO - PROCESS | 10485 | 10:09:04 INFO - PROCESS | 10485 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54344/tests/kraken/driver.html?testName=ai-astar) 10:09:05 INFO - PROCESS | 10485 | RSS: Main: 170721280 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | __start_tp_report 10:09:05 INFO - PROCESS | 10485 | _x_x_mozilla_page_load 10:09:05 INFO - PROCESS | 10485 | _x_x_mozilla_page_load_details 10:09:05 INFO - PROCESS | 10485 | |i|pagename|runs| 10:09:05 INFO - PROCESS | 10485 | |0;ai-astar;105;116;112;116;116;116;116;115;114;113 10:09:05 INFO - PROCESS | 10485 | |1;audio-beat-detection;153;127;149;191;129;155;152;126;189;123 10:09:05 INFO - PROCESS | 10485 | |2;audio-dft;164;163;169;180;165;168;164;164;164;164 10:09:05 INFO - PROCESS | 10485 | |3;audio-fft;83;78;77;150;78;79;78;77;160;76 10:09:05 INFO - PROCESS | 10485 | |4;audio-oscillator;85;86;153;86;86;87;136;85;88;142 10:09:05 INFO - PROCESS | 10485 | |5;imaging-gaussian-blur;118;118;119;117;118;117;117;118;118;118 10:09:05 INFO - PROCESS | 10485 | |6;imaging-darkroom;147;148;148;148;148;147;148;149;147;149 10:09:05 INFO - PROCESS | 10485 | |7;imaging-desaturate;95;95;97;96;95;95;96;97;96;96 10:09:05 INFO - PROCESS | 10485 | |8;json-parse-financial;65;65;64;66;66;64;63;65;62;64 10:09:05 INFO - PROCESS | 10485 | |9;json-stringify-tinderbox;66;65;66;66;65;65;68;65;66;65 10:09:05 INFO - PROCESS | 10485 | |10;stanford-crypto-aes;80;80;84;80;82;82;80;81;84;80 10:09:05 INFO - PROCESS | 10485 | |11;stanford-crypto-ccm;150;130;157;138;130;130;129;134;182;151 10:09:05 INFO - PROCESS | 10485 | |12;stanford-crypto-pbkdf2;165;172;166;173;167;165;165;167;170;170 10:09:05 INFO - PROCESS | 10485 | |13;stanford-crypto-sha256-iterative;67;71;70;69;69;67;69;69;67;67 10:09:05 INFO - PROCESS | 10485 | __end_tp_report 10:09:05 INFO - PROCESS | 10485 | __start_cc_report 10:09:05 INFO - PROCESS | 10485 | _x_x_mozilla_cycle_collect,1004 10:09:05 INFO - PROCESS | 10485 | __end_cc_report 10:09:05 INFO - PROCESS | 10485 | __startTimestamp1469034545131__endTimestamp 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | ------- Summary: start ------- 10:09:05 INFO - PROCESS | 10485 | Number of tests: 14 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#0] ai-astar Cycles:10 Average:113.90 Median:116.00 stddev:3.45 (3.0%) stddev-sans-first:1.54 10:09:05 INFO - PROCESS | 10485 | Values: 105.0 116.0 112.0 116.0 116.0 116.0 116.0 115.0 114.0 113.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.50 stddev:24.75 (16.2%) stddev-sans-first:26.22 10:09:05 INFO - PROCESS | 10485 | Values: 153.0 127.0 149.0 191.0 129.0 155.0 152.0 126.0 189.0 123.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#2] audio-dft Cycles:10 Average:166.50 Median:164.50 stddev:5.13 (3.1%) stddev-sans-first:5.36 10:09:05 INFO - PROCESS | 10485 | Values: 164.0 163.0 169.0 180.0 165.0 168.0 164.0 164.0 164.0 164.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#3] audio-fft Cycles:10 Average:93.60 Median:78.00 stddev:32.50 (41.7%) stddev-sans-first:34.24 10:09:05 INFO - PROCESS | 10485 | Values: 83.0 78.0 77.0 150.0 78.0 79.0 78.0 77.0 160.0 76.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:86.00 stddev:28.10 (32.7%) stddev-sans-first:29.00 10:09:05 INFO - PROCESS | 10485 | Values: 85.0 86.0 153.0 86.0 86.0 87.0 136.0 85.0 88.0 142.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:09:05 INFO - PROCESS | 10485 | Values: 118.0 118.0 119.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:09:05 INFO - PROCESS | 10485 | Values: 147.0 148.0 148.0 148.0 148.0 147.0 148.0 149.0 147.0 149.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 10:09:05 INFO - PROCESS | 10485 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 10:09:05 INFO - PROCESS | 10485 | Values: 65.0 65.0 64.0 66.0 66.0 64.0 63.0 65.0 62.0 64.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 10:09:05 INFO - PROCESS | 10485 | Values: 66.0 65.0 66.0 66.0 65.0 65.0 68.0 65.0 66.0 65.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:1.64 (2.0%) stddev-sans-first:1.67 10:09:05 INFO - PROCESS | 10485 | Values: 80.0 80.0 84.0 80.0 82.0 82.0 80.0 81.0 84.0 80.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:144.00 stddev:17.12 (11.9%) stddev-sans-first:17.98 10:09:05 INFO - PROCESS | 10485 | Values: 150.0 130.0 157.0 138.0 130.0 130.0 129.0 134.0 182.0 151.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:3.02 (1.8%) stddev-sans-first:3.00 10:09:05 INFO - PROCESS | 10485 | Values: 165.0 172.0 166.0 173.0 167.0 165.0 165.0 167.0 170.0 170.0 10:09:05 INFO - PROCESS | 10485 | 10:09:05 INFO - PROCESS | 10485 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.41 10:09:05 INFO - PROCESS | 10485 | Values: 67.0 71.0 70.0 69.0 69.0 67.0 69.0 69.0 67.0 67.0 10:09:05 INFO - PROCESS | 10485 | -------- Summary: end -------- 10:09:05 INFO - PROCESS | 10485 | 10:09:06 INFO - TEST-INFO | 10485: exit 0 10:09:06 INFO - TEST-OK | kraken | took 63826ms 10:09:06 INFO - SUITE-END | took 1181s 10:09:06 INFO - Completed test suite (00:19:41) 10:09:06 INFO - javascript benchmark 10:09:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6558.314814791761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.727448617895, 2621.8557979311136, 2629.6581444412222, 2676.2238950704295, 2680.919572412827, 4838.927416088757, 4943.752812359381, 4960.652754307195, 4990.126727822626, 4995.975020124894, 4674.158651442739, 4830.154722923483, 4849.078675051737, 4901.779419926103, 4916.508349165082, 4411.117776444716, 4451.9777401113115, 4579.725216487005, 4580.7938642761155, 4581.61056310214, 4521.841735539257, 4522.819087236507, 4585.174668559658, 4608.400907881971, 4637.65217608679, 4349.41282926804, 4407.316865885793, 4455.977720111411, 4470.932936005963, 4475.037866858641, 4388.495323037828, 4390.429244198233, 4396.56034396561, 4423.557644235583, 4459.130469558438, 4416.0, 4451.666125040635, 4453.955460445419, 4462.4645042594775, 4511.278195488706, 4756.453007904101, 4760.285957106462, 4810.6873053251775, 4840.540148685869, 4858.951410485885, 5158.509941555546, 5161.148410512298, 5162.1224391853475, 5195.090859099642, 5242.397124330712, 5133.435322114565, 5226.163813789775, 5233.895322093575, 5238.92141617876, 5239.607029472805, 4863.683860549053, 4888.26675998596, 4911.705297682151, 4920.6309526785635, 4943.110240156806, 5365.651232669942, 5377.704226267593, 5382.946170538245, 5425.457454254622, 5434.049140634297, 4897.681650692693, 5168.508991645787, 5188.481151884781, 5195.6622819516615, 5234.633575649744, 4915.582175515121, 5173.92239116406, 5197.402298735618, 5250.369955605352, 5268.104422248227, 5177.094008548489, 5211.765470553834, 5249.790008399621, 5256.763445644955, 5263.473652634706, 5225.712585807817, 5239.947600524022, 5253.343332083489, 5263.3947096083675, 5292.073887069748, 4333.804978775963, 4372.584604462571, 4432.445944256968, 4456.888577785581, 4526.049529598821, 3850.441685955521, 3864.169203621235, 3873.24471728016, 3899.941500877489, 3903.2388684206876, 4521.434820647419, 4522.34426008227, 4523.163214805206, 4544.613707834871, 4558.361829343895, 5099.36257967754, 5233.4243233244315, 5258.07983602868, 5280.6039547034125, 5309.548688361455, 4494.348319493655, 4545.613622842029, 4548.840790572314, 4569.29175977724, 4581.816727330869, 4753.714777113384, 4755.38180036593, 4764.285357196448, 4793.01743142655, 4831.782569784298, 4783.7129772213775, 4881.877953051202, 4927.260910863399, 4934.259861020875, 4937.382827146606, 5270.288511050959, 5295.788168473218, 5314.5216930476445, 5318.441563635917, 5353.785848566014, 4940.061388336205, 4947.752612369439, 4949.480304568113, 4951.430585482715, 4993.201087825931, 4969.726665033458, 5036.395632524121, 5088.6946783193125, 5110.565601923878, 5177.741112944263, 5155.149400349051, 5176.301199338041, 5181.06740786647, 5202.115640341075, 5211.114110601283, 5034.496550345083, 5041.42023667283, 5052.494750524918, 5062.594992400525, 5097.235414687826, 4927.679700819435, 5035.169197082587, 5080.085584594808, 5114.64197506171, 5128.948710512847, 4982.227754698028, 5054.494550544916, 5100.48995100487, 5106.259592359162, 5110.821121260887, 5074.238864170404, 5122.46214147524, 5124.641275110706, 5139.177731562932, 5164.922526162036, 4801.91956809729, 4904.5095490452095, 4947.356843610308, 4976.029674213639, 4991.42598601151], "value": 4788.942303979146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.0404747762634, 561.2647431864258, 570.4381184533235, 575.0626478839491, 585.8271809816104, 36123.458148127764, 40857.0, 41134.0, 41197.0, 41362.37956430656, 41014.38478422826, 41043.794781026125, 41506.0, 41543.0, 41620.16759664805, 7717.575533345678, 7921.7227397041115, 7923.643436045363, 7932.048154221501, 7958.562279074648, 7715.768526944201, 7780.6109694515335, 7786.610669466532, 7818.1009183943725, 7826.921730782677, 7744.186860379636, 7800.141984381714, 7803.063632364124, 7823.608819559027, 7859.882101768478, 7783.494072885244, 7783.610819459004, 7794.72718454857, 7798.142204357488, 7798.688052477894, 7712.6529306181355, 7742.070951485802, 7762.45662803604, 7767.0, 7774.689012439552, 38588.421173682415, 39039.0, 39124.608753912384, 39227.8038609808, 39396.0, 2404.7955923746504, 2757.655293088364, 2843.559248316514, 2978.19588711049, 2980.8509574521404, 28091.29771755702, 28195.718042819513, 28621.0, 28661.57007644887, 29228.976985805395, 3152.0, 3176.3806057818733, 3189.9043028709175, 3208.566843476124, 3230.5800245967876, 232648.0, 232873.0, 234990.8250458754, 235908.0, 236799.0, 31198.532022019688, 31411.528827067614, 31421.057368278987, 31452.685473145433, 31540.36919261602, 33400.33199336, 33489.162770930925, 34268.65731342655, 34341.14147146291, 36013.279734405165, 15373.538793836204, 15550.911436199358, 15582.45461408868, 15583.922080389526, 15657.765133522778, 11540.422978851024, 11544.307341559534, 11585.536578536932, 11617.825732614017, 11637.243579167496, 18226.63546729058, 18390.63218735618, 18588.721169182474, 18693.345732899284, 18830.51635447419, 6996.510244282953, 7040.6479676016, 7082.822929426806, 7248.086909331704, 7276.854462910712, 789.3842802613971, 867.3841572483482, 892.3485855325648, 941.9811603768023, 947.0151042915429, 27908.302292442444, 29431.0, 29572.39669751895, 29787.55318670222, 30015.249618759706, 967.511406739592, 1004.7488127968008, 1009.7021378693303, 1012.7620009297809, 1083.0847933496184, 15013.924930375497, 15665.843341566439, 15888.841111588736, 15918.137007645977, 15991.36034558628, 403470.0, 405628.0, 405792.0, 406675.4325882274, 406947.0, 50549.0, 50933.74533127311, 51217.7439112802, 51295.0, 51553.48446515562, 1148.9655310340704, 1164.5283660117666, 1226.350034481744, 1236.8330275412884, 1248.606688893014, 27440.0, 28332.858335708188, 29083.854580727806, 29193.416131676822, 29586.704132958395, 44564.55435445604, 44737.55262447334, 44815.10369792651, 44974.77512612416, 44976.550234497234, 356966.0, 357326.0, 357755.0, 359511.0, 359538.0, 25200.873995629903, 26312.8684356577, 26322.341941451617, 26323.60514592321, 26337.604935925592, 42872.0, 43252.78373608112, 43307.35038974355, 43450.56549434465, 43968.12063758771, 36336.63663363332, 37163.442548362334, 39629.80185099056, 40896.386554202305, 42367.0, 36219.27561448809, 36563.63436365602, 37144.0, 37377.813110935356, 37429.251414971004, 37105.44341834821, 37217.0, 37925.810370949075, 38111.80944095262, 40108.39837402383, 30562.0, 33308.833455832566, 34877.30245395027, 34924.47613285854, 34967.82516087403, 26576.8671156643, 26603.60094598544, 26847.597286041117, 27020.0, 27118.864405677847], "value": 17388.41554016314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.51592045017645, 370.98516059357627, 372.7893740036878, 380.4483498926557, 390.71282607283644, 15856.445024424147, 17484.30062797488, 17873.553161170978, 17878.28486860524, 17952.10239488027, 16684.164741878383, 17009.659806803855, 17495.125243737795, 17552.0, 17663.0, 4986.326845875806, 5176.663516871391, 5195.220716892478, 5195.870103247411, 5205.713685747282, 3878.146807702301, 5160.767765450545, 5827.242458480391, 6081.361457046991, 6136.938630613704, 6178.38216178383, 6186.907196392058, 6193.566450348478, 6212.62724236545, 6216.689165541728, 6139.017757158856, 6142.539309551801, 6142.723577439048, 6162.075688646694, 6168.568200225964, 5194.142966410538, 5273.683578985273, 5313.946860531384, 5342.893142137174, 5410.675359478405, 20935.0, 21035.368938931857, 21176.788232117637, 21212.151513939578, 21219.5756084879, 1849.907504624777, 1872.896990665513, 1878.64305781901, 1998.530345368837, 2448.155386391692, 13457.932710336483, 13587.796183057262, 13785.0, 13799.2410417427, 14301.64245893861, 1743.790745110582, 1802.4142153800067, 1852.8980906050163, 1859.5072305838964, 1883.4349695091419, 80388.0, 82702.0, 83440.16559834384, 84188.57905710493, 85389.57305213434, 16625.83374166267, 16674.666506669797, 16831.0, 16850.662986740197, 16916.915415422845, 29333.85333073321, 29444.0, 29448.411031779244, 29471.557926631118, 29478.557821632694, 9141.817163656822, 9257.166854982948, 9309.20871725911, 9680.515974201262, 9736.269779766546, 7724.575148366894, 7749.883751743729, 7757.961210194026, 7978.0, 8021.117677055519, 8187.672493100209, 8384.455010424303, 8398.496090234605, 8410.621522031523, 8624.913750862412, 1542.2597153366446, 1554.7356949318644, 1628.9592760180853, 3247.6265229498435, 3251.7561182911377, 849.362977766675, 885.4996926736374, 906.4334790755778, 935.9578818953163, 943.9757862719027, 16846.91576542134, 16901.23944422504, 17474.291484819874, 17718.734218986727, 17798.84307520007, 771.2981187119806, 812.6911773526023, 822.3955392786297, 852.2500199824115, 916.9037251088673, 8412.032616249087, 8768.123187681182, 8904.554772261361, 8987.865182022275, 9086.772830679285, 310755.0, 417310.0, 418108.0, 420106.0, 423471.0, 52939.47060529423, 54070.0, 81416.0, 82891.58554207311, 84013.0, 913.5432283858071, 919.8758167647416, 969.9369540979814, 975.3611384543135, 975.9316847820727, 15752.763708544151, 15836.92081539585, 15870.68258634844, 16324.591885202964, 16530.09084500364, 37009.0, 38073.0, 38324.6167538321, 38336.616633833306, 39036.60963390443, 52025.0, 52331.0, 52630.0, 54060.18909716279, 54922.0, 7505.099388073248, 7557.697692092254, 7575.128860181149, 7751.844963100819, 7759.30166285037, 8642.956785216034, 11664.475098620753, 11842.467088980844, 12101.213421127599, 12550.0587455943, 10023.0, 10115.14021308197, 10381.740456488647, 10431.634892778717, 10781.299215550964, 10383.792324153626, 10401.427921464392, 10481.475926203811, 10526.842047374936, 10685.252032357661, 10133.847992279974, 10430.16558675289, 10564.366138031743, 10680.89319106799, 10949.45252737344, 7439.144498382755, 7545.0, 7663.770086897402, 7699.26856948589, 7814.921850781419, 4678.789454474489, 4742.976285118691, 9643.566039528378, 9924.206063515046, 10820.350778953289], "value": 9015.098301247168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.2989090509295, 1422.8932830037747, 1492.9626759331015, 1695.5167777183506, 1704.539774260949, 6863.2107307659635, 7630.65662045208, 7642.503237289572, 8241.217084376982, 8247.79380515488, 7687.346575541086, 7869.370450363971, 7963.163867793871, 8008.799780005503, 8009.11899691035, 2210.4694873230387, 2253.4704344479032, 2256.717910261217, 2260.8191344692386, 2269.636858102704, 2152.773958734334, 2233.9553208935813, 2238.6194346961056, 2238.7201599800023, 2240.5406891587186, 2127.8084972352485, 2140.571885622882, 2143.4427048967304, 2151.139544182324, 2200.6258935980923, 2167.328128280238, 2174.065151984646, 2176.3035828534876, 2181.6727490876337, 2185.191479152708, 2056.598963202176, 2081.718967939324, 2083.2916808285254, 2083.4166433398523, 2086.050846864673, 8009.799755006114, 8023.558704271263, 8032.759017229492, 8036.357091432671, 8041.477303975282, 4623.56076172763, 4709.599684026862, 4749.121412538657, 4759.095771803346, 4780.689255198401, 2794.5109605819102, 2871.913842584726, 2915.533514637669, 2950.6901775313713, 3007.9548806767916, 902.7336935604012, 967.4727273635885, 972.7422233108232, 996.8405055191134, 998.9250806189492, 10647.680569583003, 10678.946605266923, 10691.144708423308, 10728.892711072867, 10758.085562727178, 4032.0, 4204.726692764961, 4341.283688191476, 4346.543612920661, 4354.325079612665, 8982.281417486585, 9070.319726020574, 9080.727578172533, 9122.86315705265, 9145.222656074307, 4766.118268120409, 4781.6891902026255, 4786.569208771228, 4792.472827988919, 4803.567678908915, 3703.129764505339, 4255.5957184067465, 4353.064091220403, 4353.869383918487, 4354.0, 3631.4915911772373, 3674.65090816372, 3722.2927643747603, 3801.2777572261184, 3815.2369526094335, 1122.9550817967354, 1191.1602320364123, 1192.2548407245472, 1210.0622017935993, 1225.9448324825405, 846.9618867150994, 858.3776761847611, 859.441363113981, 898.5192921786812, 901.3600343756007, 5287.312649355559, 5327.600429967768, 5339.092354299778, 5380.838574842761, 5447.673139611636, 874.8294082653821, 909.9772505687279, 924.9630014799467, 927.1377618814568, 939.793245485992, 3522.172289511963, 3526.3476256892045, 3533.858645654145, 3611.9097022574647, 3639.1084184374467, 9463.242940564738, 9933.25500587459, 9942.403455792675, 9943.701688949342, 9986.600535978625, 9859.26055545837, 9861.950690246646, 9877.160441362565, 9879.357841740264, 9913.752156196153, 7068.434525237969, 7380.889286660705, 7400.888986665204, 7452.776416707507, 7565.092188937363, 5405.729713514387, 5472.069748142905, 5543.611947163821, 5655.688937108499, 5661.094224923992, 8919.241864441596, 8953.104689530996, 8979.595918183828, 9097.909020909707, 9108.453492790453, 9250.352475326932, 9267.351285410226, 9272.0, 9297.395669281475, 9377.953110234404, 6012.428819262163, 6684.364985326386, 6792.694328755119, 6892.414144797548, 7081.964590177016, 7597.3162415382885, 7690.961720167929, 7702.537847729154, 7736.690532378641, 7743.845123097619, 6863.0, 7001.964990175016, 7006.9649651751415, 7045.365917067488, 7237.782866514013, 6599.571027883172, 6678.532502724763, 6812.352826481477, 6862.107925969592, 6939.687714052779, 6169.84575385619, 6328.715207815567, 6353.4599559038, 6398.616083035033, 6405.423511883952, 4236.830526778895, 4455.821767129279, 4554.635629149726, 4565.292379681155, 4572.0, 4370.868873933787, 4402.5597440255715, 4483.887902802456, 4520.07338495601, 4543.4775000875325], "value": 4205.176521132988, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.71227621483376, 303.3054305640084, 306.6979025659725, 307.52640932963254, 309.81256339914364, 5042.545856088582, 5065.974670126649, 5090.160123579614, 5091.490850914906, 5093.541581257686, 5015.423226328973, 5016.799328026884, 5021.5645411975165, 5022.246663000552, 5022.673526220793, 3799.7720136791813, 3808.7143464240294, 3893.1629699614577, 3928.387622231213, 3943.0142464383903, 3933.4099885017336, 3934.8426062957446, 3938.2714197873483, 3942.172143849795, 3946.3291240489043, 3936.9015774605577, 3936.960630393688, 3939.665128464084, 3949.4273330367078, 3954.070793363557, 3782.8084153491563, 3906.374980003214, 3913.98043009786, 3918.510965832994, 3927.430522574225, 3459.2043829919007, 3461.248307595468, 3463.2207753255316, 3468.0, 3471.9826400868087, 4876.512348765131, 4904.852854414374, 4909.288153217799, 4913.508649135094, 4925.581325587329, 4353.564643535653, 4458.480958258573, 4469.620082293009, 4491.191585514606, 4505.346724724896, 5226.451222621608, 5265.815696450644, 5275.894482110375, 5279.260903473517, 5289.471052894718, 3768.8680896168503, 3779.6598306152578, 3781.8865434037025, 3784.280986612562, 3789.204267103884, 5342.252084708144, 5479.0959491683825, 5480.725963701839, 5487.807926722546, 5495.450454954513, 3832.2718683450057, 3835.6931445484292, 3838.0213045673177, 3857.4985251917633, 3868.6905047596124, 3893.5133108361456, 3908.6482216600643, 3911.1395492991496, 3912.667423269054, 3912.784796836201, 4445.488768791565, 4447.466304043471, 4460.30865215892, 4465.620422264144, 4486.327050942385, 5018.197088465828, 5270.578353731692, 5271.367435907716, 5273.894522109536, 5310.2831117798605, 1324.9334285899943, 1326.747917895616, 1328.3225554966843, 1337.9130356526794, 1341.9194848308937, 823.9752807415787, 852.0925214646381, 857.4512312120248, 859.9828003439897, 867.3494878840869, 4444.511103778582, 4474.293052703133, 4624.815007399667, 4627.190241707755, 4647.814087436533, 5431.402545719968, 5473.0, 5474.206240095244, 5498.670079795225, 5499.972500137554, 4586.334981427674, 4602.493725690171, 4604.539546045368, 4611.492735799059, 4615.953840461552, 2758.3379988802544, 2905.2301140197865, 2916.3000879789124, 2925.7220564046384, 2929.633795775528, 5084.288199652052, 5111.539961403491, 5118.181091025418, 5129.922716229634, 5134.306868572695, 5346.759395827119, 5519.779208831682, 5536.861578460571, 5589.888202235932, 5597.74810133545, 5058.760603652128, 5087.465816089258, 5091.745412729349, 5092.363454568179, 5096.541311282002, 5478.233047373291, 5486.396496385474, 5489.847132102143, 5490.972545137249, 5497.752601132878, 5093.719845408538, 5327.9733601331745, 5331.600129990344, 5345.839624811262, 5399.676019438846, 5119.718415487184, 5132.435432102391, 5139.563137133386, 5149.201873709581, 5155.711072231942, 3820.1595648957186, 3842.9231415370978, 3852.1332700142243, 3852.1910398816563, 3853.0560012797046, 5222.2688823565495, 5450.672959622435, 5458.972705136449, 5517.503424691797, 5520.779168833202, 5317.0960936640095, 5344.9732751336, 5350.7693230556415, 5355.946440535545, 5363.302770639792, 5353.304070470814, 5360.865978350416, 5370.731463426891, 5380.757865895966, 5408.59435542328, 5151.484851514819, 5203.375594928481, 5247.9737601311745, 5266.631335806457, 5275.287836142072, 5006.824761133343, 5117.667351622133, 5252.501012403815, 5259.8422047338645, 5288.709120998228, 5157.535821776059, 5185.688858668492, 5185.766640501262, 5186.06650802844, 5197.4542673020305], "value": 3969.9722123914376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9698515074246, 640.5068097564872, 674.4098913450731, 731.8133875861656, 766.0998326965815, 13334.533291334805, 14323.92838035811, 14517.419303227858, 14520.05619634723, 14521.419143234285, 13322.800157997637, 13482.730345393085, 13508.257045862474, 13510.189388636689, 13532.052756307063, 620.5190976992822, 768.1128296817158, 780.6643143448315, 781.5584194929846, 794.8648729715962, 789.8933643958078, 792.528445574882, 794.0788685125256, 794.4240425691356, 794.9801254968643, 840.4705035827451, 847.4279861093768, 847.8812966184739, 848.0586548930683, 850.3537311643134, 837.794740288627, 837.7989282572199, 838.5555655502593, 844.3920377328344, 844.543946269017, 615.6613862375721, 615.92916814566, 615.9414855588711, 617.7405489694339, 618.5700937848197, 13424.194548327034, 13514.729705405935, 13520.256385898772, 13531.0, 13562.79655805154, 13076.280804555745, 13380.665483362896, 13818.170909745348, 13883.652908677263, 13906.93046534771, 10519.263651544396, 10665.466726663635, 10792.244542882001, 10918.0, 11030.558777648965, 3237.3363460490777, 3284.080457471912, 3286.7206287465356, 3311.420501412243, 3312.4368857294317, 61458.692706536625, 62089.0, 62955.0, 63019.05471417886, 63332.366676333106, 10462.319949203278, 10471.84292235617, 10494.527746251437, 10609.628662996758, 10799.190060745475, 19714.309999149962, 19746.210151594063, 19797.109130089182, 19915.302964396178, 20165.79834201639, 6833.658317084126, 6991.580505169706, 6998.090248267693, 7051.259617740166, 7052.2595127511895, 3724.3110024645525, 3814.408766641175, 3815.847366105325, 3843.9615603844163, 3925.0187453136714, 2954.3795802881205, 3029.712177343149, 3031.77261705373, 3042.0, 3043.710847469487, 487.97072175669575, 489.54961435479447, 492.40419092898, 494.2758858272576, 511.959043276537, 499.07606178183306, 512.4721536817084, 521.3431076843129, 541.4314969282237, 555.9805406810823, 6919.342662447059, 7159.105111861018, 7285.927140728631, 7575.507592006612, 7903.36773058154, 428.3852671416527, 436.36073152831256, 441.3930845088004, 460.96312295016315, 501.68143229049815, 3812.4662547243406, 3954.7231693781737, 4227.830886764495, 4290.420793192879, 4294.055307832272, 57846.710766445896, 58412.0, 99056.0, 104227.0, 104764.47617761862, 84671.0, 87383.56308218546, 88850.55574722214, 92599.0, 93220.0, 79539.60230198927, 79590.6020469894, 80123.0, 80688.19311806925, 82735.586322068, 7623.275788800055, 7864.567448790372, 7954.323882469824, 7972.840543188988, 8170.591470426574, 43947.34078988882, 44377.0, 45928.540714592426, 46026.769866150455, 46254.537454625024, 38878.222435551696, 43516.78241608771, 44386.0, 44791.776041119585, 67102.32897670961, 9693.176080033276, 9835.85246221293, 9945.751356216153, 10037.899621003697, 10523.579056837641, 11167.162462815484, 11330.150238732293, 11335.489902954552, 11446.771064578495, 11664.358460284426, 10021.09810117093, 10083.647072352433, 10113.0, 10635.468226588484, 11096.223264371416, 10078.395296282246, 10205.948970255102, 10516.474176291002, 10623.203259755704, 11062.944685276843, 9851.310408271353, 9896.752581185528, 9962.551685174329, 10325.380477171393, 10823.350598964087, 7816.687332506864, 7899.565523896241, 7937.8412431752195, 8016.198380161937, 8046.195380461907, 8310.12743661931, 8560.48637081777, 8876.392214527797, 8973.32700047486, 9000.189982901571], "value": 6348.398771026995, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 112.0, 116.0, 116.0, 116.0, 116.0, 115.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 149.0, 191.0, 129.0, 155.0, 152.0, 126.0, 189.0, 123.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 169.0, 180.0, 165.0, 168.0, 164.0, 164.0, 164.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 77.0, 150.0, 78.0, 79.0, 78.0, 77.0, 160.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 153.0, 86.0, 86.0, 87.0, 136.0, 85.0, 88.0, 142.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 147.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 64.0, 63.0, 65.0, 62.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 68.0, 65.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 80.0, 82.0, 82.0, 80.0, 81.0, 84.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 157.0, 138.0, 130.0, 130.0, 129.0, 134.0, 182.0, 151.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 172.0, 166.0, 173.0, 167.0, 165.0, 165.0, 167.0, 170.0, 170.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 70.0, 69.0, 69.0, 67.0, 69.0, 69.0, 67.0, 67.0], "value": 68.5, "unit": "score"}]}]} 10:09:06 INFO - Return code: 0 10:09:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:06 ERROR - # TBPL SUCCESS # 10:09:06 INFO - Running post-action listener: _resource_record_post_action 10:09:06 INFO - [mozharness: 2016-07-20 17:09:06.440751Z] Finished run-tests step (success) 10:09:06 INFO - Running post-run listener: _resource_record_post_run 10:09:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 548352000; Read time: 0; Write time: 476876 10:09:06 INFO - TinderboxPrint: CPU usage
13.3% 10:09:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:09:06 INFO - TinderboxPrint: I/O write bytes / time
548,352,000 / 476,876 10:09:06 INFO - TinderboxPrint: CPU idle
8,284.4 (86.7%) 10:09:06 INFO - TinderboxPrint: CPU user
1,218.0 (12.7%) 10:09:06 INFO - TinderboxPrint: Swap in / out
0 / 0 10:09:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258949120; Read time: 0; Write time: 267056 10:09:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289402880; Read time: 0; Write time: 209820 10:09:07 INFO - Running post-run listener: _upload_blobber_files 10:09:07 INFO - Blob upload gear active. 10:09:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:09:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:08 INFO - (blobuploader) - INFO - Done attempting. 10:09:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:09 INFO - (blobuploader) - INFO - Done attempting. 10:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:29 INFO - (blobuploader) - INFO - Done attempting. 10:09:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:29 INFO - Return code: 0 10:09:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d869371aaf8672bff97cb7e49eb850f78abf2c8a1436457f616cd8f4cfc7beccbd24d49ffe98a6231d39435d83242f3e6aedc46b4d9507d7fa17b1155fac748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9e8378d9025268c0c0a3e38eef9a5e85dd2d0c402ee94b7ce81b566281b263e4c22f5412d10d8f8bda2afb8a8f89f8adfd9562ac7abc77d2249bd7cef0ff3a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3c8c29faa2d4b5548c8166e24df818e8d014e18b1face0875a170c6c3a075eb8e37a9f170a4dea1f3acd28b3b4d53699bfd8cf2485d3a1963d2e0f851acb348"} 10:09:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:29 INFO - Contents: 10:09:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d869371aaf8672bff97cb7e49eb850f78abf2c8a1436457f616cd8f4cfc7beccbd24d49ffe98a6231d39435d83242f3e6aedc46b4d9507d7fa17b1155fac748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9e8378d9025268c0c0a3e38eef9a5e85dd2d0c402ee94b7ce81b566281b263e4c22f5412d10d8f8bda2afb8a8f89f8adfd9562ac7abc77d2249bd7cef0ff3a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3c8c29faa2d4b5548c8166e24df818e8d014e18b1face0875a170c6c3a075eb8e37a9f170a4dea1f3acd28b3b4d53699bfd8cf2485d3a1963d2e0f851acb348"} 10:09:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:29 INFO - Copying logs to upload dir... 10:09:29 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.508968 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-20 10:09:28.997378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:09:29.001559) ========= 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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d869371aaf8672bff97cb7e49eb850f78abf2c8a1436457f616cd8f4cfc7beccbd24d49ffe98a6231d39435d83242f3e6aedc46b4d9507d7fa17b1155fac748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9e8378d9025268c0c0a3e38eef9a5e85dd2d0c402ee94b7ce81b566281b263e4c22f5412d10d8f8bda2afb8a8f89f8adfd9562ac7abc77d2249bd7cef0ff3a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3c8c29faa2d4b5548c8166e24df818e8d014e18b1face0875a170c6c3a075eb8e37a9f170a4dea1f3acd28b3b4d53699bfd8cf2485d3a1963d2e0f851acb348"} build_url:https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/b-XT3CbhRC6pLGqaA7MKvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d869371aaf8672bff97cb7e49eb850f78abf2c8a1436457f616cd8f4cfc7beccbd24d49ffe98a6231d39435d83242f3e6aedc46b4d9507d7fa17b1155fac748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9e8378d9025268c0c0a3e38eef9a5e85dd2d0c402ee94b7ce81b566281b263e4c22f5412d10d8f8bda2afb8a8f89f8adfd9562ac7abc77d2249bd7cef0ff3a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3c8c29faa2d4b5548c8166e24df818e8d014e18b1face0875a170c6c3a075eb8e37a9f170a4dea1f3acd28b3b4d53699bfd8cf2485d3a1963d2e0f851acb348"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:09:29.032850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:09:29.033418) ========= 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=523ca41ca1e0623de333ad52000001bf-1469033315.148605-1422166039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:09:29.117179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:09:29.117722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:09:29.118253) ========= ========= Total master_lag: 0.18 =========