builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1471391320.8 results: success (0) buildid: 20160816152615 builduid: 9eaa5fbcfb664d47af209bfb1e29f74c revision: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.800158) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.800643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.800940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.815318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.815638) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 16:48:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.9M=0s 2016-08-16 16:48:40 (33.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.904532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.904849) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020279 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:40.954194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 16:48:40.954550) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14974aa2862f2dd9fac16cd78cd88a6208c951d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 14974aa2862f2dd9fac16cd78cd88a6208c951d6 --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=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 16:48:41,054 truncating revision to first 12 chars 2016-08-16 16:48:41,054 Setting DEBUG logging. 2016-08-16 16:48:41,054 attempt 1/10 2016-08-16 16:48:41,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14974aa2862f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 16:48:42,071 unpacking tar archive at: mozilla-central-14974aa2862f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.448184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 16:48:42.415632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:42.416096) ========= script_repo_revision: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:42.416610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:42.416869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 16:48:42.426425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-16 16:48:42.426776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:48:42 INFO - MultiFileLogger online at 20160816 16:48:42 in /builds/slave/test 16:48:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:48:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:48:42 INFO - {'append_to_log': False, 16:48:42 INFO - 'base_work_dir': '/builds/slave/test', 16:48:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:48:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:48:42 INFO - 'branch': 'Firefox-Non-PGO', 16:48:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:42 INFO - 'config_files': ('talos/linux_config.py',), 16:48:42 INFO - 'default_actions': ('clobber', 16:48:42 INFO - 'read-buildbot-config', 16:48:42 INFO - 'download-and-extract', 16:48:42 INFO - 'populate-webroot', 16:48:42 INFO - 'create-virtualenv', 16:48:42 INFO - 'install', 16:48:42 INFO - 'run-tests'), 16:48:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:42 INFO - 'download_minidump_stackwalk': True, 16:48:42 INFO - 'download_symbols': 'ondemand', 16:48:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:42 INFO - 'installer_path': 'installer.exe', 16:48:42 INFO - 'log_level': 'info', 16:48:42 INFO - 'log_name': 'talos', 16:48:42 INFO - 'log_to_console': True, 16:48:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:48:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:48:42 INFO - 'opt_config_files': (), 16:48:42 INFO - 'pip_index': False, 16:48:42 INFO - 'sps_profile': False, 16:48:42 INFO - 'sps_profile_interval': 0, 16:48:42 INFO - 'suite': 'dromaeojs', 16:48:42 INFO - 'system_bits': '32', 16:48:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:42 INFO - 'title': 'talos-linux64-ix-009', 16:48:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:42 INFO - 'use_talos_json': True, 16:48:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:48:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:42 INFO - 'work_dir': 'build'} 16:48:42 INFO - [mozharness: 2016-08-16 23:48:42.614408Z] Running clobber step. 16:48:42 INFO - Running pre-action listener: _resource_record_pre_action 16:48:42 INFO - Running main action method: clobber 16:48:42 INFO - rmtree: /builds/slave/test/build 16:48:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:48:43 INFO - Running post-action listener: _resource_record_post_action 16:48:43 INFO - [mozharness: 2016-08-16 23:48:43.078671Z] Finished clobber step (success) 16:48:43 INFO - [mozharness: 2016-08-16 23:48:43.078772Z] Running read-buildbot-config step. 16:48:43 INFO - Running pre-action listener: _resource_record_pre_action 16:48:43 INFO - Running main action method: read_buildbot_config 16:48:43 INFO - Using buildbot properties: 16:48:43 INFO - { 16:48:43 INFO - "project": "", 16:48:43 INFO - "product": "firefox", 16:48:43 INFO - "script_repo_revision": "production", 16:48:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:48:43 INFO - "repository": "", 16:48:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:48:43 INFO - "buildid": "20160816152615", 16:48:43 INFO - "pgo_build": "False", 16:48:43 INFO - "basedir": "/builds/slave/test", 16:48:43 INFO - "buildnumber": 679, 16:48:43 INFO - "slavename": "talos-linux64-ix-009", 16:48:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:48:43 INFO - "platform": "ubuntu64_hw", 16:48:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:48:43 INFO - "branch": "mozilla-central", 16:48:43 INFO - "repo_path": "mozilla-central", 16:48:43 INFO - "revision": "14974aa2862f2dd9fac16cd78cd88a6208c951d6", 16:48:43 INFO - "stage_platform": "linux64", 16:48:43 INFO - "builduid": "9eaa5fbcfb664d47af209bfb1e29f74c", 16:48:43 INFO - "slavebuilddir": "test" 16:48:43 INFO - } 16:48:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:48:43 INFO - Running post-action listener: _resource_record_post_action 16:48:43 INFO - [mozharness: 2016-08-16 23:48:43.081188Z] Finished read-buildbot-config step (success) 16:48:43 INFO - [mozharness: 2016-08-16 23:48:43.081276Z] Running download-and-extract step. 16:48:43 INFO - Running pre-action listener: _resource_record_pre_action 16:48:43 INFO - Running main action method: download_and_extract 16:48:43 INFO - mkdir: /builds/slave/test/build/tests 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:43 INFO - trying https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:48:43 INFO - Downloaded 1361 bytes. 16:48:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:48:43 INFO - Using the following test package requirements: 16:48:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:48:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:48:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'jsshell-linux-x86_64.zip'], 16:48:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:48:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:48:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:48:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:48:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:48:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:43 INFO - trying https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:48:44 INFO - Downloaded 20266409 bytes. 16:48:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:48:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:48 INFO - trying https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:48:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:48:49 INFO - Downloaded 20266409 bytes. 16:48:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:54 INFO - trying https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:48:54 INFO - Downloaded 14413719 bytes. 16:48:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:55 INFO - trying https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:48:55 INFO - Downloading https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:48:56 INFO - Downloaded 55636389 bytes. 16:48:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:48:56 INFO - mkdir: /builds/slave/test/properties 16:48:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:56 INFO - Contents: 16:48:56 INFO - build_url:https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:48:56 INFO - Running post-action listener: _resource_record_post_action 16:48:56 INFO - Running post-action listener: set_extra_try_arguments 16:48:56 INFO - [mozharness: 2016-08-16 23:48:56.786586Z] Finished download-and-extract step (success) 16:48:56 INFO - [mozharness: 2016-08-16 23:48:56.786809Z] Running populate-webroot step. 16:48:56 INFO - Running pre-action listener: _resource_record_pre_action 16:48:56 INFO - Running main action method: populate_webroot 16:48:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:56 INFO - '--tppagecycles', 16:48:56 INFO - '7'], 16:48:56 INFO - 'tests': ['tsvgm']}}, 16:48:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['damp', 'tps']}, 16:48:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'tests': ['damp', 'tps']}, 16:48:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['dromaeo_dom']}, 16:48:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['basic_compositor_video']}, 16:48:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['a11yr', 16:48:56 INFO - 'ts_paint', 16:48:56 INFO - 'tpaint', 16:48:56 INFO - 'sessionrestore', 16:48:56 INFO - 'sessionrestore_no_auto_restore', 16:48:56 INFO - 'tabpaint']}, 16:48:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['tsvgx', 16:48:56 INFO - 'tsvgr_opacity', 16:48:56 INFO - 'tart', 16:48:56 INFO - 'tscrollx', 16:48:56 INFO - 'cart']}, 16:48:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:56 INFO - 'tsvgr_opacity', 16:48:56 INFO - 'tart', 16:48:56 INFO - 'tscrollx', 16:48:56 INFO - 'cart']}, 16:48:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'talos_options': ['--disable-e10s'], 16:48:56 INFO - 'tests': ['tp5o']}, 16:48:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'tests': ['tp5o']}, 16:48:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'talos_options': ['--disable-e10s', 16:48:56 INFO - '--xperf_path', 16:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:56 INFO - 'tests': ['tp5n']}, 16:48:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:56 INFO - 'talos_options': ['--xperf_path', 16:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:56 INFO - 'tests': ['tp5n']}}, 16:48:56 INFO - 'talos.zip': {'path': '', 16:48:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:56 INFO - Running post-action listener: _resource_record_post_action 16:48:56 INFO - [mozharness: 2016-08-16 23:48:56.804407Z] Finished populate-webroot step (success) 16:48:56 INFO - [mozharness: 2016-08-16 23:48:56.804495Z] Running create-virtualenv step. 16:48:56 INFO - Running pre-action listener: _resource_record_pre_action 16:48:56 INFO - Running main action method: create_virtualenv 16:48:56 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:56 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 16:48:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:56 INFO - Using real prefix '/usr' 16:48:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:59 INFO - Installing pip.................done. 16:48:59 INFO - Return code: 0 16:48:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:59 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:48:59 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 16:48:59 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 16:48:59 INFO - Using env: {'DISPLAY': ':0', 16:48:59 INFO - 'HOME': '/home/cltbld', 16:48:59 INFO - 'LANG': 'en_US.UTF-8', 16:48:59 INFO - 'LANGUAGE': 'en_US:en', 16:48:59 INFO - 'LOGNAME': 'cltbld', 16:48:59 INFO - 'MAIL': '/var/mail/cltbld', 16:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:59 INFO - 'MOZ_NO_REMOTE': '1', 16:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:59 INFO - 'NO_EM_RESTART': '1', 16:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:59 INFO - 'PWD': '/builds/slave/test', 16:48:59 INFO - 'SHELL': '/bin/bash', 16:48:59 INFO - 'SHLVL': '1', 16:48:59 INFO - 'TERM': 'linux', 16:48:59 INFO - 'TMOUT': '86400', 16:48:59 INFO - 'USER': 'cltbld', 16:48:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:59 INFO - '_': '/tools/buildbot/bin/python'} 16:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:59 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 16:48:59 INFO - Cleaning up... 16:48:59 INFO - Return code: 0 16:48:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:59 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:48:59 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 16:48:59 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 16:48:59 INFO - Using env: {'DISPLAY': ':0', 16:48:59 INFO - 'HOME': '/home/cltbld', 16:48:59 INFO - 'LANG': 'en_US.UTF-8', 16:48:59 INFO - 'LANGUAGE': 'en_US:en', 16:48:59 INFO - 'LOGNAME': 'cltbld', 16:48:59 INFO - 'MAIL': '/var/mail/cltbld', 16:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:59 INFO - 'MOZ_NO_REMOTE': '1', 16:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:59 INFO - 'NO_EM_RESTART': '1', 16:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:59 INFO - 'PWD': '/builds/slave/test', 16:48:59 INFO - 'SHELL': '/bin/bash', 16:48:59 INFO - 'SHLVL': '1', 16:48:59 INFO - 'TERM': 'linux', 16:48:59 INFO - 'TMOUT': '86400', 16:48:59 INFO - 'USER': 'cltbld', 16:48:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:59 INFO - '_': '/tools/buildbot/bin/python'} 16:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:59 INFO - Downloading/unpacking psutil>=3.1.1 16: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 16: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 16: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 16: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 16: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 16: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 16:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:01 INFO - Installing collected packages: psutil 16:49:01 INFO - Running setup.py install for psutil 16:49:01 INFO - building 'psutil._psutil_linux' extension 16:49:01 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 16:49:02 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 16:49:02 INFO - building 'psutil._psutil_posix' extension 16:49:02 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 16:49:02 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 16:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:02 INFO - Successfully installed psutil 16:49:02 INFO - Cleaning up... 16:49:02 INFO - Return code: 0 16:49:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:02 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:02 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 16:49:02 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 16:49:02 INFO - Using env: {'DISPLAY': ':0', 16:49:02 INFO - 'HOME': '/home/cltbld', 16:49:02 INFO - 'LANG': 'en_US.UTF-8', 16:49:02 INFO - 'LANGUAGE': 'en_US:en', 16:49:02 INFO - 'LOGNAME': 'cltbld', 16:49:02 INFO - 'MAIL': '/var/mail/cltbld', 16:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:02 INFO - 'MOZ_NO_REMOTE': '1', 16:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:02 INFO - 'NO_EM_RESTART': '1', 16:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:02 INFO - 'PWD': '/builds/slave/test', 16:49:02 INFO - 'SHELL': '/bin/bash', 16:49:02 INFO - 'SHLVL': '1', 16:49:02 INFO - 'TERM': 'linux', 16:49:02 INFO - 'TMOUT': '86400', 16:49:02 INFO - 'USER': 'cltbld', 16:49:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:02 INFO - '_': '/tools/buildbot/bin/python'} 16:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:49:02 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 16:49:02 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 16:49:02 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 16:49:02 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 16:49:02 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 16:49:02 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 16:49:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:49:04 INFO - Installing collected packages: mozsystemmonitor 16:49:04 INFO - Running setup.py install for mozsystemmonitor 16:49:04 INFO - Successfully installed mozsystemmonitor 16:49:04 INFO - Cleaning up... 16:49:04 INFO - Return code: 0 16:49:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:04 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 16:49:04 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 16:49:04 INFO - Using env: {'DISPLAY': ':0', 16:49:04 INFO - 'HOME': '/home/cltbld', 16:49:04 INFO - 'LANG': 'en_US.UTF-8', 16:49:04 INFO - 'LANGUAGE': 'en_US:en', 16:49:04 INFO - 'LOGNAME': 'cltbld', 16:49:04 INFO - 'MAIL': '/var/mail/cltbld', 16:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:04 INFO - 'MOZ_NO_REMOTE': '1', 16:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:04 INFO - 'NO_EM_RESTART': '1', 16:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:04 INFO - 'PWD': '/builds/slave/test', 16:49:04 INFO - 'SHELL': '/bin/bash', 16:49:04 INFO - 'SHLVL': '1', 16:49:04 INFO - 'TERM': 'linux', 16:49:04 INFO - 'TMOUT': '86400', 16:49:04 INFO - 'USER': 'cltbld', 16:49:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:04 INFO - '_': '/tools/buildbot/bin/python'} 16:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:49:04 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 16:49:04 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 16:49:04 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 16:49:04 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 16:49:04 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 16:49:04 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 16:49:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:49:06 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 16:49:06 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 16:49:06 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 16:49:06 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 16:49:06 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 16:49:06 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 16:49:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:07 INFO - warning: no files found matching '*.txt' 16:49:07 INFO - no previously-included directories found matching 'build' 16:49:07 INFO - no previously-included directories found matching 'dist' 16:49:07 INFO - no previously-included directories found matching '.git*' 16:49:07 INFO - Installing collected packages: jsonschema, functools32 16:49:07 INFO - Running setup.py install for functools32 16:49:07 INFO - warning: no files found matching '*.txt' 16:49:07 INFO - no previously-included directories found matching 'build' 16:49:07 INFO - no previously-included directories found matching 'dist' 16:49:07 INFO - no previously-included directories found matching '.git*' 16:49:07 INFO - Successfully installed jsonschema functools32 16:49:07 INFO - Cleaning up... 16:49:07 INFO - Return code: 0 16:49:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16: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 functools32==3.2.3-2 16:49:07 INFO - Using env: {'DISPLAY': ':0', 16:49:07 INFO - 'HOME': '/home/cltbld', 16:49:07 INFO - 'LANG': 'en_US.UTF-8', 16:49:07 INFO - 'LANGUAGE': 'en_US:en', 16:49:07 INFO - 'LOGNAME': 'cltbld', 16:49:07 INFO - 'MAIL': '/var/mail/cltbld', 16:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:07 INFO - 'MOZ_NO_REMOTE': '1', 16:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:07 INFO - 'NO_EM_RESTART': '1', 16:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:07 INFO - 'PWD': '/builds/slave/test', 16:49:07 INFO - 'SHELL': '/bin/bash', 16:49:07 INFO - 'SHLVL': '1', 16:49:07 INFO - 'TERM': 'linux', 16:49:07 INFO - 'TMOUT': '86400', 16:49:07 INFO - 'USER': 'cltbld', 16:49:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:07 INFO - '_': '/tools/buildbot/bin/python'} 16:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:49:07 INFO - Cleaning up... 16:49:07 INFO - Return code: 0 16:49:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', '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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16: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 blobuploader==1.2.4 16:49:07 INFO - Using env: {'DISPLAY': ':0', 16:49:07 INFO - 'HOME': '/home/cltbld', 16:49:07 INFO - 'LANG': 'en_US.UTF-8', 16:49:07 INFO - 'LANGUAGE': 'en_US:en', 16:49:07 INFO - 'LOGNAME': 'cltbld', 16:49:07 INFO - 'MAIL': '/var/mail/cltbld', 16:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:07 INFO - 'MOZ_NO_REMOTE': '1', 16:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:07 INFO - 'NO_EM_RESTART': '1', 16:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:07 INFO - 'PWD': '/builds/slave/test', 16:49:07 INFO - 'SHELL': '/bin/bash', 16:49:07 INFO - 'SHLVL': '1', 16:49:07 INFO - 'TERM': 'linux', 16:49:07 INFO - 'TMOUT': '86400', 16:49:07 INFO - 'USER': 'cltbld', 16:49:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:07 INFO - '_': '/tools/buildbot/bin/python'} 16:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:07 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 16:49:07 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 16:49:07 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 16:49:07 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 16:49:07 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 16:49:07 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 16:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:09 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 16:49:09 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 16:49:09 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 16:49:09 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 16:49:09 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 16:49:09 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 16:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:49:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:10 INFO - Downloading docopt-0.6.1.tar.gz 16:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:10 INFO - Running setup.py install for blobuploader 16:49:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:10 INFO - Running setup.py install for requests 16:49:10 INFO - Running setup.py install for docopt 16:49:10 INFO - Successfully installed blobuploader requests docopt 16:49:10 INFO - Cleaning up... 16:49:10 INFO - Return code: 0 16:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:10 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 16:49:10 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 16:49:10 INFO - Using env: {'DISPLAY': ':0', 16:49:10 INFO - 'HOME': '/home/cltbld', 16:49:10 INFO - 'LANG': 'en_US.UTF-8', 16:49:10 INFO - 'LANGUAGE': 'en_US:en', 16:49:10 INFO - 'LOGNAME': 'cltbld', 16:49:10 INFO - 'MAIL': '/var/mail/cltbld', 16:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:10 INFO - 'MOZ_NO_REMOTE': '1', 16:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:10 INFO - 'NO_EM_RESTART': '1', 16:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:10 INFO - 'PWD': '/builds/slave/test', 16:49:10 INFO - 'SHELL': '/bin/bash', 16:49:10 INFO - 'SHLVL': '1', 16:49:10 INFO - 'TERM': 'linux', 16:49:10 INFO - 'TMOUT': '86400', 16:49:10 INFO - 'USER': 'cltbld', 16:49:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:10 INFO - '_': '/tools/buildbot/bin/python'} 16:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:11 INFO - Running setup.py (path:/tmp/pip-jOcNca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:11 INFO - Running setup.py (path:/tmp/pip-5ODSLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:11 INFO - Running setup.py (path:/tmp/pip-ooNvNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:11 INFO - Running setup.py (path:/tmp/pip-sXtB1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:11 INFO - Running setup.py (path:/tmp/pip-nMtcLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:11 INFO - Running setup.py (path:/tmp/pip-bueSZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:11 INFO - Running setup.py (path:/tmp/pip-8Sf8E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:11 INFO - Running setup.py (path:/tmp/pip-0a5T4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:11 INFO - Running setup.py (path:/tmp/pip-sjyjEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:11 INFO - Running setup.py (path:/tmp/pip-kb3EwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:11 INFO - Running setup.py (path:/tmp/pip-Vxv9ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:11 INFO - Running setup.py (path:/tmp/pip-xDopBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:12 INFO - Running setup.py (path:/tmp/pip-gAvMQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:12 INFO - Running setup.py (path:/tmp/pip-Mpg9xP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:12 INFO - Running setup.py (path:/tmp/pip-IQYXqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:12 INFO - Running setup.py (path:/tmp/pip-499GS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:12 INFO - Running setup.py (path:/tmp/pip-bLXNRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:12 INFO - Running setup.py install for manifestparser 16:49:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:12 INFO - Running setup.py install for mozcrash 16:49:12 INFO - Running setup.py install for mozdebug 16:49:12 INFO - Running setup.py install for mozdevice 16:49:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:12 INFO - Running setup.py install for mozfile 16:49:12 INFO - Running setup.py install for mozhttpd 16:49:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:12 INFO - Running setup.py install for mozinfo 16:49:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for mozInstall 16:49:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for mozleak 16:49:13 INFO - Running setup.py install for mozlog 16:49:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for moznetwork 16:49:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for mozprocess 16:49:13 INFO - Running setup.py install for mozprofile 16:49:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for mozrunner 16:49:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:13 INFO - Running setup.py install for mozscreenshot 16:49:13 INFO - Running setup.py install for moztest 16:49:14 INFO - Running setup.py install for mozversion 16:49:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:14 INFO - Cleaning up... 16:49:14 INFO - Return code: 0 16:49:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:14 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:14 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 16:49:14 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 16:49:14 INFO - Using env: {'DISPLAY': ':0', 16:49:14 INFO - 'HOME': '/home/cltbld', 16:49:14 INFO - 'LANG': 'en_US.UTF-8', 16:49:14 INFO - 'LANGUAGE': 'en_US:en', 16:49:14 INFO - 'LOGNAME': 'cltbld', 16:49:14 INFO - 'MAIL': '/var/mail/cltbld', 16:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:14 INFO - 'MOZ_NO_REMOTE': '1', 16:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:14 INFO - 'NO_EM_RESTART': '1', 16:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:14 INFO - 'PWD': '/builds/slave/test', 16:49:14 INFO - 'SHELL': '/bin/bash', 16:49:14 INFO - 'SHLVL': '1', 16:49:14 INFO - 'TERM': 'linux', 16:49:14 INFO - 'TMOUT': '86400', 16:49:14 INFO - 'USER': 'cltbld', 16:49:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:14 INFO - '_': '/tools/buildbot/bin/python'} 16:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:14 INFO - Running setup.py (path:/tmp/pip-SgNqfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:14 INFO - Running setup.py (path:/tmp/pip-rB8fZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:14 INFO - Running setup.py (path:/tmp/pip-G4hbin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:14 INFO - Running setup.py (path:/tmp/pip-2lREPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:14 INFO - Running setup.py (path:/tmp/pip-9RsQsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:14 INFO - Running setup.py (path:/tmp/pip-KDHEtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:14 INFO - Running setup.py (path:/tmp/pip-bq00cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:14 INFO - Running setup.py (path:/tmp/pip-0lHlFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:14 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)) 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:14 INFO - Running setup.py (path:/tmp/pip-z_H_2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:15 INFO - Running setup.py (path:/tmp/pip-CXaO9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:15 INFO - Running setup.py (path:/tmp/pip-hsKoYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:15 INFO - Running setup.py (path:/tmp/pip-08tU_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:15 INFO - Running setup.py (path:/tmp/pip-LtTnwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:15 INFO - Running setup.py (path:/tmp/pip-iRfd9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:15 INFO - Running setup.py (path:/tmp/pip-bkLvbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:15 INFO - Running setup.py (path:/tmp/pip-VdjpSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:15 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)) 16:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:15 INFO - Running setup.py (path:/tmp/pip-zL2Xvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:15 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)) 16:49:15 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)) 16:49:15 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)) 16:49:15 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)) 16:49:15 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)) 16:49:15 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)) 16:49:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:15 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 16:49:15 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 16:49:15 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 16:49:15 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 16:49:15 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 16:49:15 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 16:49:17 INFO - Downloading blessings-1.6.tar.gz 16:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:17 INFO - Installing collected packages: blessings 16:49:17 INFO - Running setup.py install for blessings 16:49:17 INFO - Successfully installed blessings 16:49:17 INFO - Cleaning up... 16:49:17 INFO - Return code: 0 16:49:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:17 INFO - Reading from file tmpfile_stdout 16:49:18 INFO - Current package versions: 16:49:18 INFO - argparse == 1.2.1 16:49:18 INFO - blessings == 1.6 16:49:18 INFO - blobuploader == 1.2.4 16:49:18 INFO - docopt == 0.6.1 16:49:18 INFO - functools32 == 3.2.3-2 16:49:18 INFO - jsonschema == 2.5.1 16:49:18 INFO - manifestparser == 1.1 16:49:18 INFO - mozInstall == 1.12 16:49:18 INFO - mozcrash == 0.17 16:49:18 INFO - mozdebug == 0.1 16:49:18 INFO - mozdevice == 0.48 16:49:18 INFO - mozfile == 1.2 16:49:18 INFO - mozhttpd == 0.7 16:49:18 INFO - mozinfo == 0.9 16:49:18 INFO - mozleak == 0.1 16:49:18 INFO - mozlog == 3.3 16:49:18 INFO - moznetwork == 0.27 16:49:18 INFO - mozprocess == 0.23 16:49:18 INFO - mozprofile == 0.28 16:49:18 INFO - mozrunner == 6.12 16:49:18 INFO - mozscreenshot == 0.1 16:49:18 INFO - mozsystemmonitor == 0.3 16:49:18 INFO - moztest == 0.7 16:49:18 INFO - mozversion == 1.4 16:49:18 INFO - psutil == 3.1.1 16:49:18 INFO - requests == 1.2.3 16:49:18 INFO - wsgiref == 0.1.2 16:49:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:18 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 16:49:18 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 16:49:18 INFO - Using env: {'DISPLAY': ':0', 16:49:18 INFO - 'HOME': '/home/cltbld', 16:49:18 INFO - 'LANG': 'en_US.UTF-8', 16:49:18 INFO - 'LANGUAGE': 'en_US:en', 16:49:18 INFO - 'LOGNAME': 'cltbld', 16:49:18 INFO - 'MAIL': '/var/mail/cltbld', 16:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:18 INFO - 'MOZ_NO_REMOTE': '1', 16:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:18 INFO - 'NO_EM_RESTART': '1', 16:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:18 INFO - 'PWD': '/builds/slave/test', 16:49:18 INFO - 'SHELL': '/bin/bash', 16:49:18 INFO - 'SHLVL': '1', 16:49:18 INFO - 'TERM': 'linux', 16:49:18 INFO - 'TMOUT': '86400', 16:49:18 INFO - 'USER': 'cltbld', 16:49:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:18 INFO - '_': '/tools/buildbot/bin/python'} 16:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 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)) 16:49:18 INFO - Cleaning up... 16:49:18 INFO - Return code: 0 16:49:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 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 0x7f382f4aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2511230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', '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 16:49:18 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 16:49:18 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 16:49:18 INFO - Using env: {'DISPLAY': ':0', 16:49:18 INFO - 'HOME': '/home/cltbld', 16:49:18 INFO - 'LANG': 'en_US.UTF-8', 16:49:18 INFO - 'LANGUAGE': 'en_US:en', 16:49:18 INFO - 'LOGNAME': 'cltbld', 16:49:18 INFO - 'MAIL': '/var/mail/cltbld', 16:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:18 INFO - 'MOZ_NO_REMOTE': '1', 16:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:18 INFO - 'NO_EM_RESTART': '1', 16:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:18 INFO - 'PWD': '/builds/slave/test', 16:49:18 INFO - 'SHELL': '/bin/bash', 16:49:18 INFO - 'SHLVL': '1', 16:49:18 INFO - 'TERM': 'linux', 16:49:18 INFO - 'TMOUT': '86400', 16:49:18 INFO - 'USER': 'cltbld', 16:49:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:18 INFO - '_': '/tools/buildbot/bin/python'} 16:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:49:18 INFO - Cleaning up... 16:49:18 INFO - Return code: 0 16:49:18 INFO - Running post-action listener: _resource_record_post_action 16:49:18 INFO - Running post-action listener: _start_resource_monitoring 16:49:18 INFO - Starting resource monitoring. 16:49:18 INFO - [mozharness: 2016-08-16 23:49:18.490139Z] Finished create-virtualenv step (success) 16:49:18 INFO - [mozharness: 2016-08-16 23:49:18.490604Z] Running install step. 16:49:18 INFO - Running pre-action listener: _resource_record_pre_action 16:49:18 INFO - Running main action method: install 16:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:18 INFO - Reading from file tmpfile_stdout 16:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:18 INFO - Reading from file tmpfile_stdout 16:49:18 INFO - Output received: 16:49:18 INFO - Usage: mozinstall [options] installer 16:49:18 INFO - Options: 16:49:18 INFO - -h, --help show this help message and exit 16:49:18 INFO - -d DEST, --destination=DEST 16:49:18 INFO - Directory to install application into. [default: 16:49:18 INFO - "/builds/slave/test"] 16:49:18 INFO - --app=APP Application being installed. [default: firefox] 16:49:18 INFO - mkdir: /builds/slave/test/build/application 16:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:49:34 INFO - Reading from file tmpfile_stdout 16:49:34 INFO - Output received: 16:49:34 INFO - /builds/slave/test/build/application/firefox/firefox 16:49:34 INFO - Running post-action listener: _resource_record_post_action 16:49:34 INFO - [mozharness: 2016-08-16 23:49:34.811525Z] Finished install step (success) 16:49:34 INFO - [mozharness: 2016-08-16 23:49:34.811771Z] Running run-tests step. 16:49:34 INFO - Running pre-action listener: _resource_record_pre_action 16:49:34 INFO - Running main action method: run_tests 16:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:34 INFO - Python 2.7.3 16:49:34 INFO - Return code: 0 16:49:34 INFO - grabbing minidump binary from tooltool 16:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:34 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 0x250b090>, '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 0x250e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:34 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 16:49:34 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 16:49:34 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 16:49:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:34 INFO - Return code: 0 16:49:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:49:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:49:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:49:34 INFO - Using env: {'DISPLAY': ':0', 16:49:34 INFO - 'HOME': '/home/cltbld', 16:49:34 INFO - 'LANG': 'en_US.UTF-8', 16:49:34 INFO - 'LANGUAGE': 'en_US:en', 16:49:34 INFO - 'LOGNAME': 'cltbld', 16:49:34 INFO - 'MAIL': '/var/mail/cltbld', 16:49:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:34 INFO - 'MOZ_NO_REMOTE': '1', 16:49:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:34 INFO - 'NO_EM_RESTART': '1', 16:49:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:34 INFO - 'PWD': '/builds/slave/test', 16:49:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:34 INFO - 'SHELL': '/bin/bash', 16:49:34 INFO - 'SHLVL': '1', 16:49:34 INFO - 'TERM': 'linux', 16:49:34 INFO - 'TMOUT': '86400', 16:49:34 INFO - 'USER': 'cltbld', 16:49:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509', 16:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:34 INFO - '_': '/tools/buildbot/bin/python'} 16:49:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:49:35 INFO - mozversion application_buildid: 20160816152615 16:49:35 INFO - mozversion application_changeset: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 16:49:35 INFO - mozversion application_display_name: Nightly 16:49:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:35 INFO - mozversion application_name: Firefox 16:49:35 INFO - mozversion application_remotingname: firefox 16:49:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:49:35 INFO - mozversion application_vendor: Mozilla 16:49:35 INFO - mozversion application_version: 51.0a1 16:49:35 INFO - mozversion platform_buildid: 20160816152615 16:49:35 INFO - mozversion platform_changeset: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 16:49:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:49:35 INFO - mozversion platform_version: 51.0a1 16:49:35 INFO - using testdate: 1471391375 16:49:35 INFO - actual date: 1471391375 16:49:35 INFO - starting webserver on 'localhost:47524' 16:49:35 INFO - SUITE-START | Running 2 tests 16:49:35 INFO - TEST-START | dromaeo_css 16:49:35 INFO - operating with platform_type : linux_ 16:49:35 INFO - Initialising browser for dromaeo_css test... 16:49:35 INFO - TEST-INFO | started process 6609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUD82F/profile http://localhost:47524/getInfo.html) 16:49:39 INFO - PROCESS | 6609 | __metrics Screen width/height:1600/1200 16:49:39 INFO - PROCESS | 6609 | colorDepth:24 16:49:39 INFO - PROCESS | 6609 | Browser inner width/height: 1024/697 16:49:39 INFO - PROCESS | 6609 | __metrics 16:49:40 INFO - PROCESS | 6609 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:49:40 INFO - PROCESS | 6609 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:41 INFO - TEST-INFO | 6609: exit 0 16:49:41 INFO - Browser initialized. 16:49:41 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:41 INFO - TEST-INFO | started process 6692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUD82F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:53 INFO - PROCESS | 6692 | RSS: Main: 156807168 16:49:53 INFO - PROCESS | 6692 | 16:50:44 INFO - PROCESS | 6692 | 1471391444435 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] 16:52:57 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47524/tests/dromaeo/cssquery-ext.html) 16:52:58 INFO - PROCESS | 6692 | RSS: Main: 248123392 16:52:58 INFO - PROCESS | 6692 | 16:56:01 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-ext.html (next: http://localhost:47524/tests/dromaeo/cssquery-jquery.html) 16:56:01 INFO - PROCESS | 6692 | RSS: Main: 245919744 16:56:01 INFO - PROCESS | 6692 | 16:59:04 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47524/tests/dromaeo/cssquery-mootools.html) 16:59:04 INFO - PROCESS | 6692 | RSS: Main: 219803648 16:59:04 INFO - PROCESS | 6692 | 17:02:07 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47524/tests/dromaeo/cssquery-prototype.html) 17:02:07 INFO - PROCESS | 6692 | RSS: Main: 187977728 17:02:07 INFO - PROCESS | 6692 | 17:05:10 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47524/tests/dromaeo/cssquery-yui.html) 17:05:11 INFO - PROCESS | 6692 | RSS: Main: 188776448 17:05:11 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | Cycle 1(1): loaded http://localhost:47524/tests/dromaeo/cssquery-yui.html (next: http://localhost:47524/tests/dromaeo/cssquery-dojo.html) 17:08:14 INFO - PROCESS | 6692 | RSS: Main: 281997312 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | __start_tp_report 17:08:14 INFO - PROCESS | 6692 | _x_x_mozilla_page_load 17:08:14 INFO - PROCESS | 6692 | _x_x_mozilla_page_load_details 17:08:14 INFO - PROCESS | 6692 | |i|pagename|runs| 17:08:14 INFO - PROCESS | 6692 | |0;dojo.html;2616.63367128602;2639.3401649587604;2653.7744291735203;2668.599710043492;2672.7728143107834;4669.392978912741;4676.462206846205;4713.387259656244;4728.125296820082;4731.9053618927555;4668.883277918054;4735.857924262269;4752.572268495835;4768.475467698559;4777.307290442893;4299.613034826865;4327;4374.387585737999;4416.183006143858;4486.753228572427;4377.474703035656;4428.468583769952;4442.622377097934;4453.176162409948;4459.331100334944;4269.957300426987;4302.806373713191;4303.935440968388;4316.395704601358;4385.5833695799165;4332.306830907071;4333.133373325316;4358.150160718661;4380.167768124078;4463.977680111611;4374.715643483163;4384.298512238027;4393.209222339978;4420;4432.889177770549;4651.534846515321;4737.644676649231;4812.759362031885;4813.518648135194;4862.756862156878;5116.053530096944;5125.3080834087295;5186.974065129688;5192.740362981874;5210.140326846066;5184.066867963765;5202.973985130088;5219;5220.92168617471;5246.317978662788;4628.051249493846;4733.881652958704;4807.879803004883;4828.66199366048;4888.682235654706;5303.204519322056;5321.813736519203;5356.651817631841;5360.8659783504945;5369.758360873692;5098.898022039539;5102.285680004802;5138.640295179376;5147.022065807485;5147.6911385317;4937.975310123498;5079.74601269935;5090.007448547572;5121.436641969381;5125.794968201305;5116.513931176532;5118.462561430996;5122.87192820175;5146.511081447256;5170.069387510209;5075.949240507548;5080.796768129233;5096.898062038813;5100.231149370279;5139.640225184201;4266.935995960063;4303.311470164821;4315.525292217853;4399.73601583906;4441.844535441244;3780.319542482325;3802.733808633369;3832.789196594214;3871.922561548753;3900.4344370066183;4414.602685758297;4417.447819022622;4419.248727716296;4423.026934074498;4463.955360446419;4976.552110310089;5040.79836806531;5151.871203219875;5165.690058596496;5218.243354713545;4342.934855977162;4361.389405483234;4380.123975204971;4382.6055654991205;4448.221561226773;4625.468071171858;4625.976870115628;4637.698549594265;4638.141943740419;4685.20351540239;4704.5765881070865;4795.9280610790165;4833.734144622009;4842.782074806712;4885.462599114024;5045.066662667272;5056.292119103255;5074.289599456005;5131.127708289674;5147.665401749025;4824.179889418878;4827.300041494034;4841.225403935494;4841.709497430165;4884.975575122102;4905.3623029006;5031.974840125776;5035.622328325317;5041.621878359211;5081.8729531762;5040.193569028937;5048.924266136084;5073.467285934924;5105.693658380509;5109.821156259513;4946.530079642428;4949.084419382281;4951.306817045688;5000.724960127228;5049.343585333883;4880.585150262267;4990.3762029746285;5002.774875130555;5004.3994720633755;5053.67151135175;4793.880152996203;4816.205326121291;4822.035592881368;4885;4914.311996320446;4960.3551538301235;4962.776675049704;4965.875853103701;4969.403671559291;5007.824726134568;4843.975780121077;4853.126437241331;4854.514548545118;4855.1260773061185;4890.462049174517 17:08:14 INFO - PROCESS | 6692 | |1;ext.html;572.5105035194908;572.7852055479198;574.2764117212314;580.770595614732;583.6556431705294;29346;38737.806310968444;39017;39214.4117838232;44021.33967990483;40887.795561022154;41248;41300.58699413005;41355;41355.17289654205;7347.412207023452;7646.311831935125;7728.149903510609;7779.76660700177;7788.766337009871;7378.631068446583;7618.9619051904665;7631.7710468685755;9776.217902567812;10006.59973601055;10092.142167915736;10129.3922364658;10155.441450720207;10171.084602385783;10184.949075254613;9911.108000279974;9974.251931105124;9977.750556236153;9990.600375984952;9993.650222242186;9835.573841792972;9901.455419951899;9909.554070066864;9910.35582687123;9913.65302214419;37620.62379376226;38324.42513362274;38349.23301533954;38372.42441363382;38397.80801096005;3095.520194369876;3113.3150706844685;3137.8431078445988;3166.62000559932;3362.9406736877804;28668.569971450444;28996.710032899824;29279.853600732073;29479.557806632918;29577.760451028687;3174.7301479374282;3267.281198136406;3318.4192766266046;3320.96679033209;3392.915177120567;241384;241789;243014;243418;244118;52155;52294.21558676623;52521.47478525242;52600;52710.209346859825;32425;32786.50820237699;32904;35263.11842203965;35411.4688279676;13127.343632818322;13236.735265294641;13239;13246.536371226961;13248.470061197637;10264.384136951807;10355.17158627308;10356.585736570603;10364.378137311785;10369.740756480998;15936.282867271;16301.755473667905;16343.754843677354;17012.659746804995;17397.565060873327;6684.665766711645;7037.788866334018;7061.964690176516;7072.434205263669;7202.243764404767;814.6334149632689;868.3053557154251;917.5175502479486;923.9907600924039;984.5766320482118;27197.86401067982;27704;28188.85905570459;28652.713472865005;28805.7119428803;926.6849271247673;951.7715748220377;956.550421301987;958.6740508227236;982.9410235385757;13888.375023123983;14842.480513181987;15111.4710985115;15123.546293611209;15380.461683841011;370841;370859;372476;374763;375102.1244893758;43849.34225986613;48550.75724621425;48668.51331486711;48982.26526602104;49290.75354623204;1155.4338374196584;1161.9128565357632;1170.7248796532808;1182.7338848759132;1192.314419208941;27596.448071038867;28921.710782891903;29351.70648293575;29699.554506681983;29871.850640746656;42712;42778.572214278705;43070.56929430665;43098.78450607727;43183.35224971565;316416;577892;599632;601014;605144;38689.6131038686;38937;39072.41391379075;39415;39757.40363894486;42429.36355954725;42440.787796060824;42528.78735606426;42783.14433711371;43761.34357984569;36559.05413814561;36834;37001.62998370089;37065;38145.618543814206;36452.63547364492;36557;37049.814750926074;37161.814190928875;37367.439488408236;35449.29101418009;35564.466533001505;35566.28867422689;37010.62989370179;37543.43684844675;31713.20716982094;33579.16052098717;33723.494147588295;34128.829355853064;34352.48471272983;25332.620010699484;25610.359741006625;25666.871665641553;25850;26042.34894127662 17:08:14 INFO - PROCESS | 6692 | |2;jquery.html;343.06856883561125;360.8682830766769;361.199942128186;363.33872352318775;379.1609949263705;13230.867691323085;16604.501864944057;17044.403445879398;18478.44564663059;18674.719879201824;15438.922805385986;15464.304106315214;16186.757198642;16319.51041468755;16376.344946202138;5021.347224860763;5045.217991211359;5163.19970404586;5188.507091826271;5199.870003249911;3711.962880371189;5111.539961403473;5154.74226288686;5732.369439361667;6080.787172448965;6106.114613381057;6112.847178820521;6114.480269177126;6119.66341851198;6154.692265386713;5994.860976414511;6001;6010.819675409744;6028.065649824241;6045.425684559959;5116.258142569344;5293.179557168645;5295.205719142121;5305.151175811851;5305.893882122375;21185.364439066852;21257.787422125737;21284.574308513744;21493.453580159254;21669.241576544744;1920.4334721257123;1942.5920556682972;2352.2120089769946;2408.7832095111526;2486.3038349262238;13327.73344533104;13708.108972916729;13712.24582647954;13956.860431395658;14043.297835108204;1708.3337498375643;1726.231826837058;1746.5720898379852;1776.342753181331;1777.8133296003991;45965.54034459646;62287;62821.37178628246;69548.6522567389;72739.63630181868;8603.397762156714;8931.330150238628;9128.406653567497;9206.17144457002;9297.209737172281;11727.941360293315;11803.350815705218;11814.46834892432;11822.34977076252;11832.88167118335;6523.119378883885;6543.1821022372205;6665.600063996176;6745.797626071226;6769.05233267343;6481.578697384655;6495.382938620824;6540.000685740047;6659.60042397448;6715.966420167965;3622.692071173927;3712.1462063725494;3746.756460830037;3788.677962373229;3837.328467518173;1774.3434929076325;1774.7249176377682;1832.3495159218285;1844.7601811764653;1848.7134494153158;800.415696541528;815.7634286056978;854.6581367453068;885.9246964008003;889.0753616239039;16315.265813038443;16893.23980420884;17573.912130439265;17753.64309871977;17825;792.6247959789761;827.3244406664006;835.7701632051235;850.974470765878;876.1457578860687;9169.816603667889;9802.404683592826;9842.163416109568;9863.852042219229;9877.259205559612;363953;368632;371362;372344;372820;46415.30377044347;57203;70542;80004.59997700091;80368;860.4710151997;864.2740098317569;888.7378223424106;902.6840605787921;909.3225546967551;11632.592859249886;15080.245987700791;15751.606209844846;16431.507054788377;16618.833811661727;38623.42064869085;38825.805870970464;39511.80244098761;39906.2018759629;40676.74586033169;48768.756156218995;49433;51089.23366149436;57557;57606.71196644157;7256.7460138894885;7351.154617219088;7479.6634151464405;7714;7810.648520816463;8812.206901378906;11435.485403156712;11956.222845515014;12515.56195533152;12632.43154058088;10138.898611013796;10196.898031019595;10297.227707921786;10394.376337419779;10503.632372866912;10140.54367553447;10418;10430.478476076318;10521.263511554424;10669.733256668645;5123.026624941249;6545;7953.363730901629;10776.245662803529;10940.12479001662;7334.229905859808;7496.58768767723;7520.586367749826;7533.434992375484;7565.659545320364;9581.377210481296;10307.536160872629;10332.380057196593;10601.628942986958;10707.785844283226 17:08:14 INFO - PROCESS | 6692 | |3;mootools.html;1202.1524824998378;1255.7739606870766;1333.1601091312475;1639.3524557799662;1652.0830938828944;7183.497155199138;7674.117476490192;7719.614019299041;7722;7728.381729461644;6677.933220667792;7147.213806481296;7355.080614923135;7380.188179300273;7553.811154721135;2155.3210738617327;2186.562687462514;2187.223535644847;2188.223180770827;2191.189259973812;2148.4199266198193;2179.1065663078143;2196.7254093238344;2198.1317379635034;2199.461132022657;2155.1271734947372;2161.3407910587266;2171.1206961180746;2173.630482817917;2188.474766056143;2152.7954844289848;2156.137544982004;2157.4390658428765;2159.0608085482863;2160.2223199648115;2079.1683326669304;2100.2964007057653;2104.452842261008;2104.736907886514;2107.9894600527055;7511.399088072941;7630.656620452093;7658.042744656918;7672.232776722339;7672.5012874163;4346.673999450054;4485.237509623372;4492.730436173807;4493.28107502798;4500.797464114123;2908.8836446542114;2968.317287023975;3027.16752892954;3030.636323641177;3038.2100653829943;902.7697937026082;945.5792172483248;969.1229437359201;976.6142373762324;987.2003677021563;10015.349002314826;10024.649137280234;10027.89972100277;10041.096301332842;10077.193824494096;3872.3997780344093;4086.836526538965;4107.691923105719;4244.830206791756;4246.044639956047;8729.08344623818;8770.12298770118;8770.429922055046;8786.560671966505;8804.515751633593;4411.933820992687;4413.095315460323;4418.2488976873365;4432.578905004019;4437.733735975852;3600.0639833642917;3900.278448486982;3991.9201615967518;4006.4791577094793;4102.2821006324375;3511.420615598449;3554.4668299755244;3671.5777685565968;3720.534933133358;3746.981265093657;1143.8627364716288;1177.1348059176498;1187.5724739093919;1188.3820413384992;1193.5106606291552;692.5567636712508;811.6956141446957;815.176671561727;829.639106988462;850.4472093139385;4685.4143232095985;4848.345473361122;4855.878603034882;5103.642745007814;5136.43499215086;390.4202259644426;394.15847166299585;396.7242766277467;396.83928009156335;412.30732369618727;3291.769576129696;3298.736101111905;3317.4857897026;3421.982890085583;3426.3147370525994;8813.911860881437;9174.495402752778;9193;9406.90593094074;9421.199198068241;9268.536573171314;9343.532823358804;9343.766405839908;9359.391639543408;9400.811983760423;6909.170899492093;7125.643717814089;7129.073220481304;7131.322524360177;7145.035420218204;4935.457099718957;5091.083604950996;5105.4983058301905;5115.18157094863;5166.767495462638;8422.199891010345;8436.367272454469;8588.969323681198;8750.60622272012;8756.824863502821;8407.621657025325;8761.5181165034;8763.430377025474;8811.427257228259;8908.420952638058;6168.444839964424;6492.5455218134275;6529.281779004211;6614.3385661435395;6645.933540664725;7328.083989501312;7503.737369192052;7511.474196806171;7526.736564220226;7533.698652053857;6636.971269453243;6683.832904177434;6743.831404214738;6862.382385585322;6886.414654754402;6636.867262654817;6647.501437392311;6764.627945463047;6775.796726098225;6778.8983165251575;6048.243969503812;6127.172831667668;6134.447899689049;6135.417135372132;6135.447809697149;4222;4293.82824687009;4409.911801764011;4411.602955733999;4503.279475283939;4343.934840977451;4464.084862603224;4468.553144685506;4478.9552104478535;4499.122671079239 17:08:14 INFO - PROCESS | 6692 | |4;prototype.html;300.6812778454837;300.81048939168323;304.3198451460983;305.06497584902286;307.4742190853641;4839.24991626298;4841.12859685257;4847.903041939159;4871.366722326097;4890.437599676038;4776.593989510896;4777.593904518111;4826;4830.661853670244;4839.346688197093;3582.588002379727;3603.2433189030335;3667.688246499051;3683.926321473569;3738.663520283174;3740.9251814963686;3744.7565908216015;3761.4921985532014;3762.9811850940846;3763.4354846773067;3718.3307004739136;3719.665230129288;3728.571214310362;3739.551253849542;3742.719296052793;3606.585242697084;3671.229041901204;3723.888283351504;3754;3768.698504119664;3344.3311337732553;3349.531065650811;3355.9496607550905;3356.647552007053;3356.7482438817187;4692.906141877177;4704.529547045302;4711.835085772016;4727.550882666175;4727.692699974491;4206.137741762931;4293.806778694966;4299.806508707115;4311.310190369557;4325.416068830699;4945.184044632631;4947.604191664658;4981.227909674007;4985.302057711923;4993.650444468889;3632.1282892105705;3632.7093832493338;3648.1426864686778;3673.4489826526233;3676.6874815640704;5157.7936882524655;5228.320318358589;5272.999999999962;5294.152935530296;5320.308359913225;3709.9629003710156;3733.4213196954515;3742.3450896093077;3745.5879853216125;3753.60587138352;3795.905102372463;3813.771173729585;3814.6948244140403;3818.980905095457;3819.7899115548357;4311.590398912098;4311.8706438806885;4322.092360604308;4323.654107671378;4324.048709283952;4854.660173787801;4994.700317980933;4998.800047998112;4999.975000124976;5073.594112470993;1292.5992942187763;1307.6730817295677;1311.849137349198;1316.8748968847945;1320.6236222676491;854.4104567848165;867.3841572483482;880.0143838900473;880.2561835249204;905.108468158863;4385.451818522684;4392.1874453226255;4394.626456751212;4452.376667266585;4459.821607135678;5081.59347252219;5087.440381558025;5088.872778180576;5103.770330335144;5104.540591346722;4267.125239325931;4399.802008909607;4402.801873915681;4414.668899832525;4416.1609294233995;2695.0702007807276;2698.689650690196;2702.7837772978114;2712.416830381438;2720.91837244883;4806.206975849016;4826.903461930812;4843.903121937612;4861.083349989978;4866.245731911559;4998.70007799526;5187.844364669066;5218.9739051304505;5250.921236181461;5257.158854583325;4778.928316075262;4781.928271075936;4805.27920811881;4820.34925285082;4820.373351464287;5063.3417655704525;5065.468125846733;5070.543651071422;5073.949260507496;5096.847094587169;4780.498047704941;4966.925496117633;4972.477889821516;4973.45292017885;4990.525900039491;4787.3776409066595;4804.663673542818;4807.278908163804;4809.495003024632;4820.469748327611;3719.5722491912693;3722.957571879878;3744.307303148817;3763.2661630981697;3764.8494060237285;5002.624803139706;5135.6405051646025;5140.46025167352;5172.069027575073;5174.327337446108;5054.19132938728;5063.8480845574695;5074.238864170256;5117.232415137611;5138.434772174983;5057.8735531612;5062.620303477181;5065.3161823153405;5086.745662716923;5091.261767043832;4794.161021821097;4965.975170124127;5016.673916195436;5018.397792264952;5024.84925452237;4827.275908613596;4892.339534162842;5071.0872043032605;5081.593472522115;5083.542481176712;4981.178105612534;4984.37695288089;4990.251462280687;4990.950090499048;4996.675216110941 17:08:14 INFO - PROCESS | 6692 | |5;yui.html;654.7610122305357;663.4526515624609;692.1935944624513;718.0306586108754;735.2794261623609;13244.801327980089;14599.41602335908;14617.926910365433;14635.999999999987;14697.853021469782;13795.724085518284;13830.10104343217;13903.721925561482;13905.860941390583;13911.930440347784;620.9596376235553;739.4047791527818;742.0205328965767;749.3218637133403;762.142589586715;724.7608289264556;725.1986554856886;725.2312548698396;726.1322719350378;728.0935235631646;764.50307300255;769.5805785846699;769.6228847864534;770.3144201660499;773.284711641732;645.2805122288638;663.4725393312328;665.6937808608046;667.1527160506179;772.8029352515101;575.6258432019179;589.1692713274306;590.220908400911;591.1900696046401;596.9224000879901;13113.606591802261;13207.207567545882;13248.668783280398;13259.801102983463;13277.734445311136;11998.340091294975;12176.147669663127;12870.935645321713;13056.543020994219;13389.19664820114;11987;12031.759364812742;12277.508899644003;12310.322932238723;13038.152520086163;4098.7950602469755;4108.548303001701;4128.5756414037405;4332.458442694663;4333.783310834446;68599.97100043553;69294;70223.2977670227;70319;70448.6477567614;10024;10038;10248.23138264633;10413.9479302603;10420.32267902584;19561.1197496113;19577.608447830964;19612.313569025016;19627.60744785096;19682.409527714193;6656.667166641649;6795.3204679531655;6800.251972283045;6846.863062738717;7121.679524421414;3727.552693676722;3758.4926034985474;3812.1041555234497;3834.6740527054953;3901.785401802928;2730.412961213309;2834.6456692913384;2834.8157369770897;2838.531642279042;2840.7017263187067;494.7377889718455;496.2481840012384;501.9222020586815;507.69538277033485;508.6642815741593;557.3540039400843;560.2940295227961;573.3091624592356;575.0626478839465;578.2684903596953;7994.720184793504;8245.093039765741;8266.793330166674;8275.337972962148;8368.121347258571;455.7083466581391;462.38733677876945;480.51708033426183;493.5804862608578;568.4003376437897;3813.828377723009;3827.6172382762056;3829.7127715421457;3916.686665066845;4018.276710192135;57224;60922.69538652367;65824.67087664627;101241;101790.49104754429;55250.17124743132;86287.56856215805;86307.56846215729;86582;87870.1212987862;73688.63155684188;74078.25921740821;74463.25536744672;77459.61270193725;79084.60457697675;7567.772966811004;7634.847303053797;7674.194209607911;7827.178146294785;7847.489913155627;32994.835025825676;38220;45038.0992380144;46165;46950.76524617355;61169;61358.69320653547;66219.33780662324;69048.30951690419;69491.92367106842;10337.844932326172;10531.514722169451;10632.362058276529;10858.13134949218;11073.667789966314;11205.495752690986;11507.827382589101;11580.305181689126;11890.34603096838;12028.63914082579;9954.20366370703;10102.69691909244;10271.178305735373;10432.113270372103;10774.191935604704;10487.003734645197;10510.947445262726;10580.15358771312;10867.239293249397;10880.564777408816;9140.177384035469;9217.400868943498;9327;9604.567794449405;9816.705498835046;8258.669653214045;8423.70517031901;8575.356848236283;8600.440971336842;8754.91245087541;7487.925120748723;7977.601119944095;8378.916210837813;8402.495850249004;8567.729903728425 17:08:14 INFO - PROCESS | 6692 | __end_tp_report 17:08:14 INFO - PROCESS | 6692 | __start_cc_report 17:08:14 INFO - PROCESS | 6692 | _x_x_mozilla_cycle_collect,1027 17:08:14 INFO - PROCESS | 6692 | __end_cc_report 17:08:14 INFO - PROCESS | 6692 | __startTimestamp1471392494844__endTimestamp 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | ------- Summary: start ------- 17:08:14 INFO - PROCESS | 6692 | Number of tests: 6 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#0] dojo.html Cycles:165 Average:4725.45 Median:4841.71 stddev:502.09 (10.4%) stddev-sans-first:475.59 17:08:14 INFO - PROCESS | 6692 | Values: 2616.6 2639.3 2653.8 2668.6 2672.8 4669.4 4676.5 4713.4 4728.1 4731.9 4668.9 4735.9 4752.6 4768.5 4777.3 4299.6 4327.0 4374.4 4416.2 4486.8 4377.5 4428.5 4442.6 4453.2 4459.3 4270.0 4302.8 4303.9 4316.4 4385.6 4332.3 4333.1 4358.2 4380.2 4464.0 4374.7 4384.3 4393.2 4420.0 4432.9 4651.5 4737.6 4812.8 4813.5 4862.8 5116.1 5125.3 5187.0 5192.7 5210.1 5184.1 5203.0 5219.0 5220.9 5246.3 4628.1 4733.9 4807.9 4828.7 4888.7 5303.2 5321.8 5356.7 5360.9 5369.8 5098.9 5102.3 5138.6 5147.0 5147.7 4938.0 5079.7 5090.0 5121.4 5125.8 5116.5 5118.5 5122.9 5146.5 5170.1 5075.9 5080.8 5096.9 5100.2 5139.6 4266.9 4303.3 4315.5 4399.7 4441.8 3780.3 3802.7 3832.8 3871.9 3900.4 4414.6 4417.4 4419.2 4423.0 4464.0 4976.6 5040.8 5151.9 5165.7 5218.2 4342.9 4361.4 4380.1 4382.6 4448.2 4625.5 4626.0 4637.7 4638.1 4685.2 4704.6 4795.9 4833.7 4842.8 4885.5 5045.1 5056.3 5074.3 5131.1 5147.7 4824.2 4827.3 4841.2 4841.7 4885.0 4905.4 5032.0 5035.6 5041.6 5081.9 5040.2 5048.9 5073.5 5105.7 5109.8 4946.5 4949.1 4951.3 5000.7 5049.3 4880.6 4990.4 5002.8 5004.4 5053.7 4793.9 4816.2 4822.0 4885.0 4914.3 4960.4 4962.8 4965.9 4969.4 5007.8 4844.0 4853.1 4854.5 4855.1 4890.5 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#1] ext.html Cycles:180 Average:52950.80 Median:204010.41 stddev:109191.48 (53.5%) stddev-sans-first:109426.97 17:08:14 INFO - PROCESS | 6692 | Values: 572.5 572.8 574.3 580.8 583.7 29346.0 38737.8 39017.0 39214.4 44021.3 40887.8 41248.0 41300.6 41355.0 41355.2 7347.4 7646.3 7728.1 7779.8 7788.8 7378.6 7619.0 7631.8 9776.2 10006.6 10092.1 10129.4 10155.4 10171.1 10184.9 9911.1 9974.3 9977.8 9990.6 9993.7 9835.6 9901.5 9909.6 9910.4 9913.7 37620.6 38324.4 38349.2 38372.4 38397.8 3095.5 3113.3 3137.8 3166.6 3362.9 28668.6 28996.7 29279.9 29479.6 29577.8 3174.7 3267.3 3318.4 3321.0 3392.9 241384.0 241789.0 243014.0 243418.0 244118.0 52155.0 52294.2 52521.5 52600.0 52710.2 32425.0 32786.5 32904.0 35263.1 35411.5 13127.3 13236.7 13239.0 13246.5 13248.5 10264.4 10355.2 10356.6 10364.4 10369.7 15936.3 16301.8 16343.8 17012.7 17397.6 6684.7 7037.8 7062.0 7072.4 7202.2 814.6 868.3 917.5 924.0 984.6 27197.9 27704.0 28188.9 28652.7 28805.7 926.7 951.8 956.6 958.7 982.9 13888.4 14842.5 15111.5 15123.5 15380.5 370841.0 370859.0 372476.0 374763.0 375102.1 43849.3 48550.8 48668.5 48982.3 49290.8 1155.4 1161.9 1170.7 1182.7 1192.3 27596.4 28921.7 29351.7 29699.6 29871.9 42712.0 42778.6 43070.6 43098.8 43183.4 316416.0 577892.0 599632.0 601014.0 605144.0 38689.6 38937.0 39072.4 39415.0 39757.4 42429.4 42440.8 42528.8 42783.1 43761.3 36559.1 36834.0 37001.6 37065.0 38145.6 36452.6 36557.0 37049.8 37161.8 37367.4 35449.3 35564.5 35566.3 37010.6 37543.4 31713.2 33579.2 33723.5 34128.8 34352.5 25332.6 25610.4 25666.9 25850.0 26042.3 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#2] jquery.html Cycles:180 Average:23382.76 Median:43321.14 stddev:60969.89 (140.7%) stddev-sans-first:61116.38 17:08:14 INFO - PROCESS | 6692 | Values: 343.1 360.9 361.2 363.3 379.2 13230.9 16604.5 17044.4 18478.4 18674.7 15438.9 15464.3 16186.8 16319.5 16376.3 5021.3 5045.2 5163.2 5188.5 5199.9 3712.0 5111.5 5154.7 5732.4 6080.8 6106.1 6112.8 6114.5 6119.7 6154.7 5994.9 6001.0 6010.8 6028.1 6045.4 5116.3 5293.2 5295.2 5305.2 5305.9 21185.4 21257.8 21284.6 21493.5 21669.2 1920.4 1942.6 2352.2 2408.8 2486.3 13327.7 13708.1 13712.2 13956.9 14043.3 1708.3 1726.2 1746.6 1776.3 1777.8 45965.5 62287.0 62821.4 69548.7 72739.6 8603.4 8931.3 9128.4 9206.2 9297.2 11727.9 11803.4 11814.5 11822.3 11832.9 6523.1 6543.2 6665.6 6745.8 6769.1 6481.6 6495.4 6540.0 6659.6 6716.0 3622.7 3712.1 3746.8 3788.7 3837.3 1774.3 1774.7 1832.3 1844.8 1848.7 800.4 815.8 854.7 885.9 889.1 16315.3 16893.2 17573.9 17753.6 17825.0 792.6 827.3 835.8 851.0 876.1 9169.8 9802.4 9842.2 9863.9 9877.3 363953.0 368632.0 371362.0 372344.0 372820.0 46415.3 57203.0 70542.0 80004.6 80368.0 860.5 864.3 888.7 902.7 909.3 11632.6 15080.2 15751.6 16431.5 16618.8 38623.4 38825.8 39511.8 39906.2 40676.7 48768.8 49433.0 51089.2 57557.0 57606.7 7256.7 7351.2 7479.7 7714.0 7810.6 8812.2 11435.5 11956.2 12515.6 12632.4 10138.9 10196.9 10297.2 10394.4 10503.6 10140.5 10418.0 10430.5 10521.3 10669.7 5123.0 6545.0 7953.4 10776.2 10940.1 7334.2 7496.6 7520.6 7533.4 7565.7 9581.4 10307.5 10332.4 10601.6 10707.8 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#3] mootools.html Cycles:180 Average:4974.06 Median:4766.88 stddev:2781.24 (58.3%) stddev-sans-first:2774.60 17:08:14 INFO - PROCESS | 6692 | Values: 1202.2 1255.8 1333.2 1639.4 1652.1 7183.5 7674.1 7719.6 7722.0 7728.4 6677.9 7147.2 7355.1 7380.2 7553.8 2155.3 2186.6 2187.2 2188.2 2191.2 2148.4 2179.1 2196.7 2198.1 2199.5 2155.1 2161.3 2171.1 2173.6 2188.5 2152.8 2156.1 2157.4 2159.1 2160.2 2079.2 2100.3 2104.5 2104.7 2108.0 7511.4 7630.7 7658.0 7672.2 7672.5 4346.7 4485.2 4492.7 4493.3 4500.8 2908.9 2968.3 3027.2 3030.6 3038.2 902.8 945.6 969.1 976.6 987.2 10015.3 10024.6 10027.9 10041.1 10077.2 3872.4 4086.8 4107.7 4244.8 4246.0 8729.1 8770.1 8770.4 8786.6 8804.5 4411.9 4413.1 4418.2 4432.6 4437.7 3600.1 3900.3 3991.9 4006.5 4102.3 3511.4 3554.5 3671.6 3720.5 3747.0 1143.9 1177.1 1187.6 1188.4 1193.5 692.6 811.7 815.2 829.6 850.4 4685.4 4848.3 4855.9 5103.6 5136.4 390.4 394.2 396.7 396.8 412.3 3291.8 3298.7 3317.5 3422.0 3426.3 8813.9 9174.5 9193.0 9406.9 9421.2 9268.5 9343.5 9343.8 9359.4 9400.8 6909.2 7125.6 7129.1 7131.3 7145.0 4935.5 5091.1 5105.5 5115.2 5166.8 8422.2 8436.4 8589.0 8750.6 8756.8 8407.6 8761.5 8763.4 8811.4 8908.4 6168.4 6492.5 6529.3 6614.3 6645.9 7328.1 7503.7 7511.5 7526.7 7533.7 6637.0 6683.8 6743.8 6862.4 6886.4 6636.9 6647.5 6764.6 6775.8 6778.9 6048.2 6127.2 6134.4 6135.4 6135.4 4222.0 4293.8 4409.9 4411.6 4503.3 4343.9 4464.1 4468.6 4479.0 4499.1 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#4] prototype.html Cycles:180 Average:4174.98 Median:4790.77 stddev:1197.55 (25.0%) stddev-sans-first:1165.07 17:08:14 INFO - PROCESS | 6692 | Values: 300.7 300.8 304.3 305.1 307.5 4839.2 4841.1 4847.9 4871.4 4890.4 4776.6 4777.6 4826.0 4830.7 4839.3 3582.6 3603.2 3667.7 3683.9 3738.7 3740.9 3744.8 3761.5 3763.0 3763.4 3718.3 3719.7 3728.6 3739.6 3742.7 3606.6 3671.2 3723.9 3754.0 3768.7 3344.3 3349.5 3355.9 3356.6 3356.7 4692.9 4704.5 4711.8 4727.6 4727.7 4206.1 4293.8 4299.8 4311.3 4325.4 4945.2 4947.6 4981.2 4985.3 4993.7 3632.1 3632.7 3648.1 3673.4 3676.7 5157.8 5228.3 5273.0 5294.2 5320.3 3710.0 3733.4 3742.3 3745.6 3753.6 3795.9 3813.8 3814.7 3819.0 3819.8 4311.6 4311.9 4322.1 4323.7 4324.0 4854.7 4994.7 4998.8 5000.0 5073.6 1292.6 1307.7 1311.8 1316.9 1320.6 854.4 867.4 880.0 880.3 905.1 4385.5 4392.2 4394.6 4452.4 4459.8 5081.6 5087.4 5088.9 5103.8 5104.5 4267.1 4399.8 4402.8 4414.7 4416.2 2695.1 2698.7 2702.8 2712.4 2720.9 4806.2 4826.9 4843.9 4861.1 4866.2 4998.7 5187.8 5219.0 5250.9 5257.2 4778.9 4781.9 4805.3 4820.3 4820.4 5063.3 5065.5 5070.5 5073.9 5096.8 4780.5 4966.9 4972.5 4973.5 4990.5 4787.4 4804.7 4807.3 4809.5 4820.5 3719.6 3723.0 3744.3 3763.3 3764.8 5002.6 5135.6 5140.5 5172.1 5174.3 5054.2 5063.8 5074.2 5117.2 5138.4 5057.9 5062.6 5065.3 5086.7 5091.3 4794.2 4966.0 5016.7 5018.4 5024.8 4827.3 4892.3 5071.1 5081.6 5083.5 4981.2 4984.4 4990.3 4991.0 4996.7 17:08:14 INFO - PROCESS | 6692 | 17:08:14 INFO - PROCESS | 6692 | [#5] yui.html Cycles:180 Average:17213.43 Median:27903.76 stddev:24422.39 (87.5%) stddev-sans-first:24459.25 17:08:14 INFO - PROCESS | 6692 | Values: 654.8 663.5 692.2 718.0 735.3 13244.8 14599.4 14617.9 14636.0 14697.9 13795.7 13830.1 13903.7 13905.9 13911.9 621.0 739.4 742.0 749.3 762.1 724.8 725.2 725.2 726.1 728.1 764.5 769.6 769.6 770.3 773.3 645.3 663.5 665.7 667.2 772.8 575.6 589.2 590.2 591.2 596.9 13113.6 13207.2 13248.7 13259.8 13277.7 11998.3 12176.1 12870.9 13056.5 13389.2 11987.0 12031.8 12277.5 12310.3 13038.2 4098.8 4108.5 4128.6 4332.5 4333.8 68600.0 69294.0 70223.3 70319.0 70448.6 10024.0 10038.0 10248.2 10413.9 10420.3 19561.1 19577.6 19612.3 19627.6 19682.4 6656.7 6795.3 6800.3 6846.9 7121.7 3727.6 3758.5 3812.1 3834.7 3901.8 2730.4 2834.6 2834.8 2838.5 2840.7 494.7 496.2 501.9 507.7 508.7 557.4 560.3 573.3 575.1 578.3 7994.7 8245.1 8266.8 8275.3 8368.1 455.7 462.4 480.5 493.6 568.4 3813.8 3827.6 3829.7 3916.7 4018.3 57224.0 60922.7 65824.7 101241.0 101790.5 55250.2 86287.6 86307.6 86582.0 87870.1 73688.6 74078.3 74463.3 77459.6 79084.6 7567.8 7634.8 7674.2 7827.2 7847.5 32994.8 38220.0 45038.1 46165.0 46950.8 61169.0 61358.7 66219.3 69048.3 69491.9 10337.8 10531.5 10632.4 10858.1 11073.7 11205.5 11507.8 11580.3 11890.3 12028.6 9954.2 10102.7 10271.2 10432.1 10774.2 10487.0 10510.9 10580.2 10867.2 10880.6 9140.2 9217.4 9327.0 9604.6 9816.7 8258.7 8423.7 8575.4 8600.4 8754.9 7487.9 7977.6 8378.9 8402.5 8567.7 17:08:14 INFO - PROCESS | 6692 | -------- Summary: end -------- 17:08:14 INFO - PROCESS | 6692 | 17:08:15 INFO - TEST-INFO | 6692: exit 0 17:08:15 INFO - TEST-OK | dromaeo_css | took 1120628ms 17:08:15 INFO - TEST-START | kraken 17:08:15 INFO - operating with platform_type : linux_ 17:08:15 INFO - Initialising browser for kraken test... 17:08:15 INFO - TEST-INFO | started process 6990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH1hrui/profile http://localhost:47524/getInfo.html) 17:08:19 INFO - PROCESS | 6990 | __metrics Screen width/height:1600/1200 17:08:19 INFO - PROCESS | 6990 | colorDepth:24 17:08:19 INFO - PROCESS | 6990 | Browser inner width/height: 1024/697 17:08:19 INFO - PROCESS | 6990 | __metrics 17:08:20 INFO - PROCESS | 6990 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:08:20 INFO - PROCESS | 6990 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:21 INFO - TEST-INFO | 6990: exit 0 17:08:21 INFO - Browser initialized. 17:08:21 INFO - Running cycle 1/1 for kraken test... 17:08:21 INFO - TEST-INFO | started process 7071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH1hrui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:33 INFO - PROCESS | 7071 | RSS: Main: 157179904 17:08:33 INFO - PROCESS | 7071 | 17:08:36 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47524/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:37 INFO - PROCESS | 7071 | RSS: Main: 204165120 17:08:37 INFO - PROCESS | 7071 | 17:08:39 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47524/tests/kraken/driver.html?testName=audio-dft) 17:08:40 INFO - PROCESS | 7071 | RSS: Main: 196136960 17:08:40 INFO - PROCESS | 7071 | 17:08:43 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47524/tests/kraken/driver.html?testName=audio-fft) 17:08:44 INFO - PROCESS | 7071 | RSS: Main: 277307392 17:08:44 INFO - PROCESS | 7071 | 17:08:46 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47524/tests/kraken/driver.html?testName=audio-oscillator) 17:08:47 INFO - PROCESS | 7071 | RSS: Main: 186892288 17:08:47 INFO - PROCESS | 7071 | 17:08:49 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:50 INFO - PROCESS | 7071 | RSS: Main: 192110592 17:08:50 INFO - PROCESS | 7071 | 17:08:53 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47524/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:53 INFO - PROCESS | 7071 | RSS: Main: 228515840 17:08:53 INFO - PROCESS | 7071 | 17:08:57 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47524/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:58 INFO - PROCESS | 7071 | RSS: Main: 221982720 17:08:58 INFO - PROCESS | 7071 | 17:09:00 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47524/tests/kraken/driver.html?testName=json-parse-financial) 17:09:01 INFO - PROCESS | 7071 | RSS: Main: 224677888 17:09:01 INFO - PROCESS | 7071 | 17:09:03 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:03 INFO - PROCESS | 7071 | RSS: Main: 188878848 17:09:03 INFO - PROCESS | 7071 | 17:09:05 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:06 INFO - PROCESS | 7071 | RSS: Main: 196096000 17:09:06 INFO - PROCESS | 7071 | 17:09:08 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:09 INFO - PROCESS | 7071 | RSS: Main: 192897024 17:09:09 INFO - PROCESS | 7071 | 17:09:12 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:12 INFO - PROCESS | 7071 | RSS: Main: 188981248 17:09:12 INFO - PROCESS | 7071 | 17:09:15 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:16 INFO - PROCESS | 7071 | RSS: Main: 191897600 17:09:16 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:47524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47524/tests/kraken/driver.html?testName=ai-astar) 17:09:18 INFO - PROCESS | 7071 | RSS: Main: 242593792 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | __start_tp_report 17:09:18 INFO - PROCESS | 7071 | _x_x_mozilla_page_load 17:09:18 INFO - PROCESS | 7071 | _x_x_mozilla_page_load_details 17:09:18 INFO - PROCESS | 7071 | |i|pagename|runs| 17:09:18 INFO - PROCESS | 7071 | |0;ai-astar;106;115;116;114;111;115;115;114;115;113 17:09:18 INFO - PROCESS | 7071 | |1;audio-beat-detection;167;122;124;177;130;123;149;127;177;126 17:09:18 INFO - PROCESS | 7071 | |2;audio-dft;163;160;160;161;164;161;161;161;161;160 17:09:18 INFO - PROCESS | 7071 | |3;audio-fft;76;77;76;109;77;76;73;74;103;75 17:09:18 INFO - PROCESS | 7071 | |4;audio-oscillator;86;87;138;85;85;86;113;86;87;133 17:09:18 INFO - PROCESS | 7071 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 17:09:18 INFO - PROCESS | 7071 | |6;imaging-darkroom;146;145;146;147;146;146;146;146;145;146 17:09:18 INFO - PROCESS | 7071 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 17:09:18 INFO - PROCESS | 7071 | |8;json-parse-financial;67;64;66;64;66;66;66;64;67;65 17:09:18 INFO - PROCESS | 7071 | |9;json-stringify-tinderbox;67;66;66;67;66;66;66;67;66;67 17:09:18 INFO - PROCESS | 7071 | |10;stanford-crypto-aes;83;82;82;92;82;84;82;82;83;82 17:09:18 INFO - PROCESS | 7071 | |11;stanford-crypto-ccm;135;131;132;134;141;138;130;131;150;142 17:09:18 INFO - PROCESS | 7071 | |12;stanford-crypto-pbkdf2;173;174;178;169;175;172;174;171;169;171 17:09:18 INFO - PROCESS | 7071 | |13;stanford-crypto-sha256-iterative;71;68;67;67;70;68;67;67;66;67 17:09:18 INFO - PROCESS | 7071 | __end_tp_report 17:09:18 INFO - PROCESS | 7071 | __start_cc_report 17:09:18 INFO - PROCESS | 7071 | _x_x_mozilla_cycle_collect,1951 17:09:18 INFO - PROCESS | 7071 | __end_cc_report 17:09:18 INFO - PROCESS | 7071 | __startTimestamp1471392558315__endTimestamp 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | ------- Summary: start ------- 17:09:18 INFO - PROCESS | 7071 | Number of tests: 14 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:2.95 (2.6%) stddev-sans-first:1.48 17:09:18 INFO - PROCESS | 7071 | Values: 106.0 115.0 116.0 114.0 111.0 115.0 115.0 114.0 115.0 113.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:139.50 stddev:23.17 (16.6%) stddev-sans-first:22.78 17:09:18 INFO - PROCESS | 7071 | Values: 167.0 122.0 124.0 177.0 130.0 123.0 149.0 127.0 177.0 126.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.22 17:09:18 INFO - PROCESS | 7071 | Values: 163.0 160.0 160.0 161.0 164.0 161.0 161.0 161.0 161.0 160.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:13.00 (17.1%) stddev-sans-first:13.63 17:09:18 INFO - PROCESS | 7071 | Values: 76.0 77.0 76.0 109.0 77.0 76.0 73.0 74.0 103.0 75.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:86.00 stddev:21.24 (24.7%) stddev-sans-first:22.03 17:09:18 INFO - PROCESS | 7071 | Values: 86.0 87.0 138.0 85.0 85.0 86.0 113.0 86.0 87.0 133.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:09:18 INFO - PROCESS | 7071 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:09:18 INFO - PROCESS | 7071 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:09:18 INFO - PROCESS | 7071 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.12 17:09:18 INFO - PROCESS | 7071 | Values: 67.0 64.0 66.0 64.0 66.0 66.0 66.0 64.0 67.0 65.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 17:09:18 INFO - PROCESS | 7071 | Values: 67.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 66.0 67.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.10 (3.8%) stddev-sans-first:3.28 17:09:18 INFO - PROCESS | 7071 | Values: 83.0 82.0 82.0 92.0 82.0 84.0 82.0 82.0 83.0 82.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:136.50 stddev:6.38 (4.7%) stddev-sans-first:6.75 17:09:18 INFO - PROCESS | 7071 | Values: 135.0 131.0 132.0 134.0 141.0 138.0 130.0 131.0 150.0 142.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.50 stddev:2.80 (1.6%) stddev-sans-first:2.96 17:09:18 INFO - PROCESS | 7071 | Values: 173.0 174.0 178.0 169.0 175.0 172.0 174.0 171.0 169.0 171.0 17:09:18 INFO - PROCESS | 7071 | 17:09:18 INFO - PROCESS | 7071 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.13 17:09:18 INFO - PROCESS | 7071 | Values: 71.0 68.0 67.0 67.0 70.0 68.0 67.0 67.0 66.0 67.0 17:09:18 INFO - PROCESS | 7071 | -------- Summary: end -------- 17:09:18 INFO - PROCESS | 7071 | 17:09:19 INFO - TEST-INFO | 7071: exit 0 17:09:19 INFO - TEST-OK | kraken | took 63707ms 17:09:19 INFO - SUITE-END | took 1184s 17:09:19 INFO - Completed test suite (00:19:44) 17:09:19 INFO - javascript benchmark 17:09:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.63367128602, 2639.3401649587604, 2653.7744291735203, 2668.599710043492, 2672.7728143107834, 4669.392978912741, 4676.462206846205, 4713.387259656244, 4728.125296820082, 4731.9053618927555, 4668.883277918054, 4735.857924262269, 4752.572268495835, 4768.475467698559, 4777.307290442893, 4299.613034826865, 4327.0, 4374.387585737999, 4416.183006143858, 4486.753228572427, 4377.474703035656, 4428.468583769952, 4442.622377097934, 4453.176162409948, 4459.331100334944, 4269.957300426987, 4302.806373713191, 4303.935440968388, 4316.395704601358, 4385.5833695799165, 4332.306830907071, 4333.133373325316, 4358.150160718661, 4380.167768124078, 4463.977680111611, 4374.715643483163, 4384.298512238027, 4393.209222339978, 4420.0, 4432.889177770549, 4651.534846515321, 4737.644676649231, 4812.759362031885, 4813.518648135194, 4862.756862156878, 5116.053530096944, 5125.3080834087295, 5186.974065129688, 5192.740362981874, 5210.140326846066, 5184.066867963765, 5202.973985130088, 5219.0, 5220.92168617471, 5246.317978662788, 4628.051249493846, 4733.881652958704, 4807.879803004883, 4828.66199366048, 4888.682235654706, 5303.204519322056, 5321.813736519203, 5356.651817631841, 5360.8659783504945, 5369.758360873692, 5098.898022039539, 5102.285680004802, 5138.640295179376, 5147.022065807485, 5147.6911385317, 4937.975310123498, 5079.74601269935, 5090.007448547572, 5121.436641969381, 5125.794968201305, 5116.513931176532, 5118.462561430996, 5122.87192820175, 5146.511081447256, 5170.069387510209, 5075.949240507548, 5080.796768129233, 5096.898062038813, 5100.231149370279, 5139.640225184201, 4266.935995960063, 4303.311470164821, 4315.525292217853, 4399.73601583906, 4441.844535441244, 3780.319542482325, 3802.733808633369, 3832.789196594214, 3871.922561548753, 3900.4344370066183, 4414.602685758297, 4417.447819022622, 4419.248727716296, 4423.026934074498, 4463.955360446419, 4976.552110310089, 5040.79836806531, 5151.871203219875, 5165.690058596496, 5218.243354713545, 4342.934855977162, 4361.389405483234, 4380.123975204971, 4382.6055654991205, 4448.221561226773, 4625.468071171858, 4625.976870115628, 4637.698549594265, 4638.141943740419, 4685.20351540239, 4704.5765881070865, 4795.9280610790165, 4833.734144622009, 4842.782074806712, 4885.462599114024, 5045.066662667272, 5056.292119103255, 5074.289599456005, 5131.127708289674, 5147.665401749025, 4824.179889418878, 4827.300041494034, 4841.225403935494, 4841.709497430165, 4884.975575122102, 4905.3623029006, 5031.974840125776, 5035.622328325317, 5041.621878359211, 5081.8729531762, 5040.193569028937, 5048.924266136084, 5073.467285934924, 5105.693658380509, 5109.821156259513, 4946.530079642428, 4949.084419382281, 4951.306817045688, 5000.724960127228, 5049.343585333883, 4880.585150262267, 4990.3762029746285, 5002.774875130555, 5004.3994720633755, 5053.67151135175, 4793.880152996203, 4816.205326121291, 4822.035592881368, 4885.0, 4914.311996320446, 4960.3551538301235, 4962.776675049704, 4965.875853103701, 4969.403671559291, 5007.824726134568, 4843.975780121077, 4853.126437241331, 4854.514548545118, 4855.1260773061185, 4890.462049174517], "value": 4693.004992993117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5105035194908, 572.7852055479198, 574.2764117212314, 580.770595614732, 583.6556431705294, 29346.0, 38737.806310968444, 39017.0, 39214.4117838232, 44021.33967990483, 40887.795561022154, 41248.0, 41300.58699413005, 41355.0, 41355.17289654205, 7347.412207023452, 7646.311831935125, 7728.149903510609, 7779.76660700177, 7788.766337009871, 7378.631068446583, 7618.9619051904665, 7631.7710468685755, 9776.217902567812, 10006.59973601055, 10092.142167915736, 10129.3922364658, 10155.441450720207, 10171.084602385783, 10184.949075254613, 9911.108000279974, 9974.251931105124, 9977.750556236153, 9990.600375984952, 9993.650222242186, 9835.573841792972, 9901.455419951899, 9909.554070066864, 9910.35582687123, 9913.65302214419, 37620.62379376226, 38324.42513362274, 38349.23301533954, 38372.42441363382, 38397.80801096005, 3095.520194369876, 3113.3150706844685, 3137.8431078445988, 3166.62000559932, 3362.9406736877804, 28668.569971450444, 28996.710032899824, 29279.853600732073, 29479.557806632918, 29577.760451028687, 3174.7301479374282, 3267.281198136406, 3318.4192766266046, 3320.96679033209, 3392.915177120567, 241384.0, 241789.0, 243014.0, 243418.0, 244118.0, 52155.0, 52294.21558676623, 52521.47478525242, 52600.0, 52710.209346859825, 32425.0, 32786.50820237699, 32904.0, 35263.11842203965, 35411.4688279676, 13127.343632818322, 13236.735265294641, 13239.0, 13246.536371226961, 13248.470061197637, 10264.384136951807, 10355.17158627308, 10356.585736570603, 10364.378137311785, 10369.740756480998, 15936.282867271, 16301.755473667905, 16343.754843677354, 17012.659746804995, 17397.565060873327, 6684.665766711645, 7037.788866334018, 7061.964690176516, 7072.434205263669, 7202.243764404767, 814.6334149632689, 868.3053557154251, 917.5175502479486, 923.9907600924039, 984.5766320482118, 27197.86401067982, 27704.0, 28188.85905570459, 28652.713472865005, 28805.7119428803, 926.6849271247673, 951.7715748220377, 956.550421301987, 958.6740508227236, 982.9410235385757, 13888.375023123983, 14842.480513181987, 15111.4710985115, 15123.546293611209, 15380.461683841011, 370841.0, 370859.0, 372476.0, 374763.0, 375102.1244893758, 43849.34225986613, 48550.75724621425, 48668.51331486711, 48982.26526602104, 49290.75354623204, 1155.4338374196584, 1161.9128565357632, 1170.7248796532808, 1182.7338848759132, 1192.314419208941, 27596.448071038867, 28921.710782891903, 29351.70648293575, 29699.554506681983, 29871.850640746656, 42712.0, 42778.572214278705, 43070.56929430665, 43098.78450607727, 43183.35224971565, 316416.0, 577892.0, 599632.0, 601014.0, 605144.0, 38689.6131038686, 38937.0, 39072.41391379075, 39415.0, 39757.40363894486, 42429.36355954725, 42440.787796060824, 42528.78735606426, 42783.14433711371, 43761.34357984569, 36559.05413814561, 36834.0, 37001.62998370089, 37065.0, 38145.618543814206, 36452.63547364492, 36557.0, 37049.814750926074, 37161.814190928875, 37367.439488408236, 35449.29101418009, 35564.466533001505, 35566.28867422689, 37010.62989370179, 37543.43684844675, 31713.20716982094, 33579.16052098717, 33723.494147588295, 34128.829355853064, 34352.48471272983, 25332.620010699484, 25610.359741006625, 25666.871665641553, 25850.0, 26042.34894127662], "value": 18052.94635981672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.06856883561125, 360.8682830766769, 361.199942128186, 363.33872352318775, 379.1609949263705, 13230.867691323085, 16604.501864944057, 17044.403445879398, 18478.44564663059, 18674.719879201824, 15438.922805385986, 15464.304106315214, 16186.757198642, 16319.51041468755, 16376.344946202138, 5021.347224860763, 5045.217991211359, 5163.19970404586, 5188.507091826271, 5199.870003249911, 3711.962880371189, 5111.539961403473, 5154.74226288686, 5732.369439361667, 6080.787172448965, 6106.114613381057, 6112.847178820521, 6114.480269177126, 6119.66341851198, 6154.692265386713, 5994.860976414511, 6001.0, 6010.819675409744, 6028.065649824241, 6045.425684559959, 5116.258142569344, 5293.179557168645, 5295.205719142121, 5305.151175811851, 5305.893882122375, 21185.364439066852, 21257.787422125737, 21284.574308513744, 21493.453580159254, 21669.241576544744, 1920.4334721257123, 1942.5920556682972, 2352.2120089769946, 2408.7832095111526, 2486.3038349262238, 13327.73344533104, 13708.108972916729, 13712.24582647954, 13956.860431395658, 14043.297835108204, 1708.3337498375643, 1726.231826837058, 1746.5720898379852, 1776.342753181331, 1777.8133296003991, 45965.54034459646, 62287.0, 62821.37178628246, 69548.6522567389, 72739.63630181868, 8603.397762156714, 8931.330150238628, 9128.406653567497, 9206.17144457002, 9297.209737172281, 11727.941360293315, 11803.350815705218, 11814.46834892432, 11822.34977076252, 11832.88167118335, 6523.119378883885, 6543.1821022372205, 6665.600063996176, 6745.797626071226, 6769.05233267343, 6481.578697384655, 6495.382938620824, 6540.000685740047, 6659.60042397448, 6715.966420167965, 3622.692071173927, 3712.1462063725494, 3746.756460830037, 3788.677962373229, 3837.328467518173, 1774.3434929076325, 1774.7249176377682, 1832.3495159218285, 1844.7601811764653, 1848.7134494153158, 800.415696541528, 815.7634286056978, 854.6581367453068, 885.9246964008003, 889.0753616239039, 16315.265813038443, 16893.23980420884, 17573.912130439265, 17753.64309871977, 17825.0, 792.6247959789761, 827.3244406664006, 835.7701632051235, 850.974470765878, 876.1457578860687, 9169.816603667889, 9802.404683592826, 9842.163416109568, 9863.852042219229, 9877.259205559612, 363953.0, 368632.0, 371362.0, 372344.0, 372820.0, 46415.30377044347, 57203.0, 70542.0, 80004.59997700091, 80368.0, 860.4710151997, 864.2740098317569, 888.7378223424106, 902.6840605787921, 909.3225546967551, 11632.592859249886, 15080.245987700791, 15751.606209844846, 16431.507054788377, 16618.833811661727, 38623.42064869085, 38825.805870970464, 39511.80244098761, 39906.2018759629, 40676.74586033169, 48768.756156218995, 49433.0, 51089.23366149436, 57557.0, 57606.71196644157, 7256.7460138894885, 7351.154617219088, 7479.6634151464405, 7714.0, 7810.648520816463, 8812.206901378906, 11435.485403156712, 11956.222845515014, 12515.56195533152, 12632.43154058088, 10138.898611013796, 10196.898031019595, 10297.227707921786, 10394.376337419779, 10503.632372866912, 10140.54367553447, 10418.0, 10430.478476076318, 10521.263511554424, 10669.733256668645, 5123.026624941249, 6545.0, 7953.363730901629, 10776.245662803529, 10940.12479001662, 7334.229905859808, 7496.58768767723, 7520.586367749826, 7533.434992375484, 7565.659545320364, 9581.377210481296, 10307.536160872629, 10332.380057196593, 10601.628942986958, 10707.785844283226], "value": 8118.975657690509, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1202.1524824998378, 1255.7739606870766, 1333.1601091312475, 1639.3524557799662, 1652.0830938828944, 7183.497155199138, 7674.117476490192, 7719.614019299041, 7722.0, 7728.381729461644, 6677.933220667792, 7147.213806481296, 7355.080614923135, 7380.188179300273, 7553.811154721135, 2155.3210738617327, 2186.562687462514, 2187.223535644847, 2188.223180770827, 2191.189259973812, 2148.4199266198193, 2179.1065663078143, 2196.7254093238344, 2198.1317379635034, 2199.461132022657, 2155.1271734947372, 2161.3407910587266, 2171.1206961180746, 2173.630482817917, 2188.474766056143, 2152.7954844289848, 2156.137544982004, 2157.4390658428765, 2159.0608085482863, 2160.2223199648115, 2079.1683326669304, 2100.2964007057653, 2104.452842261008, 2104.736907886514, 2107.9894600527055, 7511.399088072941, 7630.656620452093, 7658.042744656918, 7672.232776722339, 7672.5012874163, 4346.673999450054, 4485.237509623372, 4492.730436173807, 4493.28107502798, 4500.797464114123, 2908.8836446542114, 2968.317287023975, 3027.16752892954, 3030.636323641177, 3038.2100653829943, 902.7697937026082, 945.5792172483248, 969.1229437359201, 976.6142373762324, 987.2003677021563, 10015.349002314826, 10024.649137280234, 10027.89972100277, 10041.096301332842, 10077.193824494096, 3872.3997780344093, 4086.836526538965, 4107.691923105719, 4244.830206791756, 4246.044639956047, 8729.08344623818, 8770.12298770118, 8770.429922055046, 8786.560671966505, 8804.515751633593, 4411.933820992687, 4413.095315460323, 4418.2488976873365, 4432.578905004019, 4437.733735975852, 3600.0639833642917, 3900.278448486982, 3991.9201615967518, 4006.4791577094793, 4102.2821006324375, 3511.420615598449, 3554.4668299755244, 3671.5777685565968, 3720.534933133358, 3746.981265093657, 1143.8627364716288, 1177.1348059176498, 1187.5724739093919, 1188.3820413384992, 1193.5106606291552, 692.5567636712508, 811.6956141446957, 815.176671561727, 829.639106988462, 850.4472093139385, 4685.4143232095985, 4848.345473361122, 4855.878603034882, 5103.642745007814, 5136.43499215086, 390.4202259644426, 394.15847166299585, 396.7242766277467, 396.83928009156335, 412.30732369618727, 3291.769576129696, 3298.736101111905, 3317.4857897026, 3421.982890085583, 3426.3147370525994, 8813.911860881437, 9174.495402752778, 9193.0, 9406.90593094074, 9421.199198068241, 9268.536573171314, 9343.532823358804, 9343.766405839908, 9359.391639543408, 9400.811983760423, 6909.170899492093, 7125.643717814089, 7129.073220481304, 7131.322524360177, 7145.035420218204, 4935.457099718957, 5091.083604950996, 5105.4983058301905, 5115.18157094863, 5166.767495462638, 8422.199891010345, 8436.367272454469, 8588.969323681198, 8750.60622272012, 8756.824863502821, 8407.621657025325, 8761.5181165034, 8763.430377025474, 8811.427257228259, 8908.420952638058, 6168.444839964424, 6492.5455218134275, 6529.281779004211, 6614.3385661435395, 6645.933540664725, 7328.083989501312, 7503.737369192052, 7511.474196806171, 7526.736564220226, 7533.698652053857, 6636.971269453243, 6683.832904177434, 6743.831404214738, 6862.382385585322, 6886.414654754402, 6636.867262654817, 6647.501437392311, 6764.627945463047, 6775.796726098225, 6778.8983165251575, 6048.243969503812, 6127.172831667668, 6134.447899689049, 6135.417135372132, 6135.447809697149, 4222.0, 4293.82824687009, 4409.911801764011, 4411.602955733999, 4503.279475283939, 4343.934840977451, 4464.084862603224, 4468.553144685506, 4478.9552104478535, 4499.122671079239], "value": 3952.75175305892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.6812778454837, 300.81048939168323, 304.3198451460983, 305.06497584902286, 307.4742190853641, 4839.24991626298, 4841.12859685257, 4847.903041939159, 4871.366722326097, 4890.437599676038, 4776.593989510896, 4777.593904518111, 4826.0, 4830.661853670244, 4839.346688197093, 3582.588002379727, 3603.2433189030335, 3667.688246499051, 3683.926321473569, 3738.663520283174, 3740.9251814963686, 3744.7565908216015, 3761.4921985532014, 3762.9811850940846, 3763.4354846773067, 3718.3307004739136, 3719.665230129288, 3728.571214310362, 3739.551253849542, 3742.719296052793, 3606.585242697084, 3671.229041901204, 3723.888283351504, 3754.0, 3768.698504119664, 3344.3311337732553, 3349.531065650811, 3355.9496607550905, 3356.647552007053, 3356.7482438817187, 4692.906141877177, 4704.529547045302, 4711.835085772016, 4727.550882666175, 4727.692699974491, 4206.137741762931, 4293.806778694966, 4299.806508707115, 4311.310190369557, 4325.416068830699, 4945.184044632631, 4947.604191664658, 4981.227909674007, 4985.302057711923, 4993.650444468889, 3632.1282892105705, 3632.7093832493338, 3648.1426864686778, 3673.4489826526233, 3676.6874815640704, 5157.7936882524655, 5228.320318358589, 5272.999999999962, 5294.152935530296, 5320.308359913225, 3709.9629003710156, 3733.4213196954515, 3742.3450896093077, 3745.5879853216125, 3753.60587138352, 3795.905102372463, 3813.771173729585, 3814.6948244140403, 3818.980905095457, 3819.7899115548357, 4311.590398912098, 4311.8706438806885, 4322.092360604308, 4323.654107671378, 4324.048709283952, 4854.660173787801, 4994.700317980933, 4998.800047998112, 4999.975000124976, 5073.594112470993, 1292.5992942187763, 1307.6730817295677, 1311.849137349198, 1316.8748968847945, 1320.6236222676491, 854.4104567848165, 867.3841572483482, 880.0143838900473, 880.2561835249204, 905.108468158863, 4385.451818522684, 4392.1874453226255, 4394.626456751212, 4452.376667266585, 4459.821607135678, 5081.59347252219, 5087.440381558025, 5088.872778180576, 5103.770330335144, 5104.540591346722, 4267.125239325931, 4399.802008909607, 4402.801873915681, 4414.668899832525, 4416.1609294233995, 2695.0702007807276, 2698.689650690196, 2702.7837772978114, 2712.416830381438, 2720.91837244883, 4806.206975849016, 4826.903461930812, 4843.903121937612, 4861.083349989978, 4866.245731911559, 4998.70007799526, 5187.844364669066, 5218.9739051304505, 5250.921236181461, 5257.158854583325, 4778.928316075262, 4781.928271075936, 4805.27920811881, 4820.34925285082, 4820.373351464287, 5063.3417655704525, 5065.468125846733, 5070.543651071422, 5073.949260507496, 5096.847094587169, 4780.498047704941, 4966.925496117633, 4972.477889821516, 4973.45292017885, 4990.525900039491, 4787.3776409066595, 4804.663673542818, 4807.278908163804, 4809.495003024632, 4820.469748327611, 3719.5722491912693, 3722.957571879878, 3744.307303148817, 3763.2661630981697, 3764.8494060237285, 5002.624803139706, 5135.6405051646025, 5140.46025167352, 5172.069027575073, 5174.327337446108, 5054.19132938728, 5063.8480845574695, 5074.238864170256, 5117.232415137611, 5138.434772174983, 5057.8735531612, 5062.620303477181, 5065.3161823153405, 5086.745662716923, 5091.261767043832, 4794.161021821097, 4965.975170124127, 5016.673916195436, 5018.397792264952, 5024.84925452237, 4827.275908613596, 4892.339534162842, 5071.0872043032605, 5081.593472522115, 5083.542481176712, 4981.178105612534, 4984.37695288089, 4990.251462280687, 4990.950090499048, 4996.675216110941], "value": 3797.5576088616685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.7610122305357, 663.4526515624609, 692.1935944624513, 718.0306586108754, 735.2794261623609, 13244.801327980089, 14599.41602335908, 14617.926910365433, 14635.999999999987, 14697.853021469782, 13795.724085518284, 13830.10104343217, 13903.721925561482, 13905.860941390583, 13911.930440347784, 620.9596376235553, 739.4047791527818, 742.0205328965767, 749.3218637133403, 762.142589586715, 724.7608289264556, 725.1986554856886, 725.2312548698396, 726.1322719350378, 728.0935235631646, 764.50307300255, 769.5805785846699, 769.6228847864534, 770.3144201660499, 773.284711641732, 645.2805122288638, 663.4725393312328, 665.6937808608046, 667.1527160506179, 772.8029352515101, 575.6258432019179, 589.1692713274306, 590.220908400911, 591.1900696046401, 596.9224000879901, 13113.606591802261, 13207.207567545882, 13248.668783280398, 13259.801102983463, 13277.734445311136, 11998.340091294975, 12176.147669663127, 12870.935645321713, 13056.543020994219, 13389.19664820114, 11987.0, 12031.759364812742, 12277.508899644003, 12310.322932238723, 13038.152520086163, 4098.7950602469755, 4108.548303001701, 4128.5756414037405, 4332.458442694663, 4333.783310834446, 68599.97100043553, 69294.0, 70223.2977670227, 70319.0, 70448.6477567614, 10024.0, 10038.0, 10248.23138264633, 10413.9479302603, 10420.32267902584, 19561.1197496113, 19577.608447830964, 19612.313569025016, 19627.60744785096, 19682.409527714193, 6656.667166641649, 6795.3204679531655, 6800.251972283045, 6846.863062738717, 7121.679524421414, 3727.552693676722, 3758.4926034985474, 3812.1041555234497, 3834.6740527054953, 3901.785401802928, 2730.412961213309, 2834.6456692913384, 2834.8157369770897, 2838.531642279042, 2840.7017263187067, 494.7377889718455, 496.2481840012384, 501.9222020586815, 507.69538277033485, 508.6642815741593, 557.3540039400843, 560.2940295227961, 573.3091624592356, 575.0626478839465, 578.2684903596953, 7994.720184793504, 8245.093039765741, 8266.793330166674, 8275.337972962148, 8368.121347258571, 455.7083466581391, 462.38733677876945, 480.51708033426183, 493.5804862608578, 568.4003376437897, 3813.828377723009, 3827.6172382762056, 3829.7127715421457, 3916.686665066845, 4018.276710192135, 57224.0, 60922.69538652367, 65824.67087664627, 101241.0, 101790.49104754429, 55250.17124743132, 86287.56856215805, 86307.56846215729, 86582.0, 87870.1212987862, 73688.63155684188, 74078.25921740821, 74463.25536744672, 77459.61270193725, 79084.60457697675, 7567.772966811004, 7634.847303053797, 7674.194209607911, 7827.178146294785, 7847.489913155627, 32994.835025825676, 38220.0, 45038.0992380144, 46165.0, 46950.76524617355, 61169.0, 61358.69320653547, 66219.33780662324, 69048.30951690419, 69491.92367106842, 10337.844932326172, 10531.514722169451, 10632.362058276529, 10858.13134949218, 11073.667789966314, 11205.495752690986, 11507.827382589101, 11580.305181689126, 11890.34603096838, 12028.63914082579, 9954.20366370703, 10102.69691909244, 10271.178305735373, 10432.113270372103, 10774.191935604704, 10487.003734645197, 10510.947445262726, 10580.15358771312, 10867.239293249397, 10880.564777408816, 9140.177384035469, 9217.400868943498, 9327.0, 9604.567794449405, 9816.705498835046, 8258.669653214045, 8423.70517031901, 8575.356848236283, 8600.440971336842, 8754.91245087541, 7487.925120748723, 7977.601119944095, 8378.916210837813, 8402.495850249004, 8567.729903728425], "value": 6353.751064313913, "unit": "score"}], "name": "dromaeo_css", "value": 6350.839464666536, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 116.0, 114.0, 111.0, 115.0, 115.0, 114.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 122.0, 124.0, 177.0, 130.0, 123.0, 149.0, 127.0, 177.0, 126.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 164.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 109.0, 77.0, 76.0, 73.0, 74.0, 103.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 138.0, 85.0, 85.0, 86.0, 113.0, 86.0, 87.0, 133.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 64.0, 66.0, 66.0, 66.0, 64.0, 67.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 92.0, 82.0, 84.0, 82.0, 82.0, 83.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 132.0, 134.0, 141.0, 138.0, 130.0, 131.0, 150.0, 142.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 178.0, 169.0, 175.0, 172.0, 174.0, 171.0, 169.0, 171.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 67.0, 70.0, 68.0, 67.0, 67.0, 66.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1547.1000000000001, "alertThreshold": 2.0}]} 17:09:19 INFO - Return code: 0 17:09:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:09:19 INFO - # TBPL SUCCESS # 17:09:19 INFO - Running post-action listener: _resource_record_post_action 17:09:19 INFO - [mozharness: 2016-08-17 00:09:19.594729Z] Finished run-tests step (success) 17:09:19 INFO - Running post-run listener: _resource_record_post_run 17:09:19 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 319488; Write bytes: 397979648; Read time: 116; Write time: 360164 17:09:19 INFO - TinderboxPrint: CPU usage
13.0% 17:09:19 INFO - TinderboxPrint: I/O read bytes / time
319,488 / 116 17:09:19 INFO - TinderboxPrint: I/O write bytes / time
397,979,648 / 360,164 17:09:19 INFO - TinderboxPrint: CPU idle
8,342.2 (87.0%) 17:09:19 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 17:09:19 INFO - TinderboxPrint: Swap in / out
0 / 0 17:09:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 118784; Write bytes: 113614848; Read time: 28; Write time: 129036 17:09:19 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 196608; Write bytes: 283828224; Read time: 80; Write time: 231128 17:09:20 INFO - Running post-run listener: _upload_blobber_files 17:09:20 INFO - Blob upload gear active. 17:09:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:20 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 17:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:09:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:21 INFO - (blobuploader) - INFO - Done attempting. 17:09:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:22 INFO - (blobuploader) - INFO - Done attempting. 17:09:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:09:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:25 INFO - (blobuploader) - INFO - Done attempting. 17:09:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:25 INFO - Return code: 0 17:09:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec736bc3ee6b9689d08b6626a7e39002989ba833ebabb4fd2a84511df0a33f8a6999e3bed59264e3d1e7cffd13477dfa5be2071ee5873e9ffc1dfb50152bf3d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/632ba3719e1d30624426566e3d4c9338ca3b67763ed5e8333d9b5363315d1cb86332bf4aefcff3c538bbd13ee96872776cfcad2b2e92a2d9fdecc069ceec55dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef135f53b1f979f8da7b3160bb956ba26be40de0a5812b9dd273bf704614878ebfc9162a84963a3c1b4632d8754534f34ff1d5dabc85d5abc1e40c8213fb33e3"} 17:09:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:25 INFO - Contents: 17:09:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec736bc3ee6b9689d08b6626a7e39002989ba833ebabb4fd2a84511df0a33f8a6999e3bed59264e3d1e7cffd13477dfa5be2071ee5873e9ffc1dfb50152bf3d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/632ba3719e1d30624426566e3d4c9338ca3b67763ed5e8333d9b5363315d1cb86332bf4aefcff3c538bbd13ee96872776cfcad2b2e92a2d9fdecc069ceec55dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef135f53b1f979f8da7b3160bb956ba26be40de0a5812b9dd273bf704614878ebfc9162a84963a3c1b4632d8754534f34ff1d5dabc85d5abc1e40c8213fb33e3"} 17:09:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:25 INFO - Copying logs to upload dir... 17:09:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.414150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-16 17:09:25.857985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:09:25.861884) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec736bc3ee6b9689d08b6626a7e39002989ba833ebabb4fd2a84511df0a33f8a6999e3bed59264e3d1e7cffd13477dfa5be2071ee5873e9ffc1dfb50152bf3d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/632ba3719e1d30624426566e3d4c9338ca3b67763ed5e8333d9b5363315d1cb86332bf4aefcff3c538bbd13ee96872776cfcad2b2e92a2d9fdecc069ceec55dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef135f53b1f979f8da7b3160bb956ba26be40de0a5812b9dd273bf704614878ebfc9162a84963a3c1b4632d8754534f34ff1d5dabc85d5abc1e40c8213fb33e3"} build_url:https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/RL2_9rd6QZy6oo0A_pHsiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec736bc3ee6b9689d08b6626a7e39002989ba833ebabb4fd2a84511df0a33f8a6999e3bed59264e3d1e7cffd13477dfa5be2071ee5873e9ffc1dfb50152bf3d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/632ba3719e1d30624426566e3d4c9338ca3b67763ed5e8333d9b5363315d1cb86332bf4aefcff3c538bbd13ee96872776cfcad2b2e92a2d9fdecc069ceec55dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef135f53b1f979f8da7b3160bb956ba26be40de0a5812b9dd273bf704614878ebfc9162a84963a3c1b4632d8754534f34ff1d5dabc85d5abc1e40c8213fb33e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:09:25.887680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:09:25.888011) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471391320.63225-508808509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:09:25.972431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:09:25.972844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:09:25.973256) ========= ========= Total master_lag: 0.17 =========