builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1469034453.17 results: success (0) buildid: 20160720075620 builduid: 79d4d09368c34695847800ac0af5effb revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.169419) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.169875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.170220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.185157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.185518) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 10:07:33-- 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% 220M=0s 2016-07-20 10:07:33 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.297795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.298114) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023217 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.348640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:33.349041) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d224fc999cb6accb208af0a105f14433375e2e77 --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 d224fc999cb6accb208af0a105f14433375e2e77 --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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 10:07:33,646 truncating revision to first 12 chars 2016-07-20 10:07:33,646 Setting DEBUG logging. 2016-07-20 10:07:33,646 attempt 1/10 2016-07-20 10:07:33,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d224fc999cb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 10:07:33,952 unpacking tar archive at: mozilla-central-d224fc999cb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:34.014421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:34.014755) ========= script_repo_revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:34.015151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:34.015428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 10:07:34.025854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-20 10:07:34.026284) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:34 INFO - MultiFileLogger online at 20160720 10:07:34 in /builds/slave/test 10:07:34 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 10:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:34 INFO - {'append_to_log': False, 10:07:34 INFO - 'base_work_dir': '/builds/slave/test', 10:07:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:34 INFO - 'branch': 'Firefox-Non-PGO', 10:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:34 INFO - 'config_files': ('talos/linux_config.py',), 10:07:34 INFO - 'default_actions': ('clobber', 10:07:34 INFO - 'read-buildbot-config', 10:07:34 INFO - 'download-and-extract', 10:07:34 INFO - 'populate-webroot', 10:07:34 INFO - 'create-virtualenv', 10:07:34 INFO - 'install', 10:07:34 INFO - 'run-tests'), 10:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:34 INFO - 'download_minidump_stackwalk': True, 10:07:34 INFO - 'download_symbols': 'ondemand', 10:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:34 INFO - 'installer_path': 'installer.exe', 10:07:34 INFO - 'log_level': 'info', 10:07:34 INFO - 'log_name': 'talos', 10:07:34 INFO - 'log_to_console': True, 10:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:34 INFO - 'opt_config_files': (), 10:07:34 INFO - 'pip_index': False, 10:07:34 INFO - 'sps_profile': False, 10:07:34 INFO - 'sps_profile_interval': 0, 10:07:34 INFO - 'suite': 'dromaeojs', 10:07:34 INFO - 'system_bits': '32', 10:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:34 INFO - 'title': 'talos-linux64-ix-064', 10:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:34 INFO - 'use_talos_json': True, 10:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:34 INFO - 'work_dir': 'build'} 10:07:34 INFO - [mozharness: 2016-07-20 17:07:34.409161Z] Running clobber step. 10:07:34 INFO - Running pre-action listener: _resource_record_pre_action 10:07:34 INFO - Running main action method: clobber 10:07:34 INFO - rmtree: /builds/slave/test/build 10:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:35 INFO - Running post-action listener: _resource_record_post_action 10:07:35 INFO - [mozharness: 2016-07-20 17:07:35.391363Z] Finished clobber step (success) 10:07:35 INFO - [mozharness: 2016-07-20 17:07:35.391464Z] Running read-buildbot-config step. 10:07:35 INFO - Running pre-action listener: _resource_record_pre_action 10:07:35 INFO - Running main action method: read_buildbot_config 10:07:35 INFO - Using buildbot properties: 10:07:35 INFO - { 10:07:35 INFO - "project": "", 10:07:35 INFO - "product": "firefox", 10:07:35 INFO - "script_repo_revision": "production", 10:07:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:07:35 INFO - "repository": "", 10:07:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:07:35 INFO - "buildid": "20160720075620", 10:07:35 INFO - "pgo_build": "False", 10:07:35 INFO - "basedir": "/builds/slave/test", 10:07:35 INFO - "buildnumber": 159, 10:07:35 INFO - "slavename": "talos-linux64-ix-064", 10:07:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:07:35 INFO - "platform": "ubuntu64_hw", 10:07:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:07:35 INFO - "branch": "mozilla-central", 10:07:35 INFO - "repo_path": "mozilla-central", 10:07:35 INFO - "revision": "d224fc999cb6accb208af0a105f14433375e2e77", 10:07:35 INFO - "stage_platform": "linux64", 10:07:35 INFO - "builduid": "79d4d09368c34695847800ac0af5effb", 10:07:35 INFO - "slavebuilddir": "test" 10:07:35 INFO - } 10:07:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:07:35 INFO - Running post-action listener: _resource_record_post_action 10:07:35 INFO - [mozharness: 2016-07-20 17:07:35.393909Z] Finished read-buildbot-config step (success) 10:07:35 INFO - [mozharness: 2016-07-20 17:07:35.393998Z] Running download-and-extract step. 10:07:35 INFO - Running pre-action listener: _resource_record_pre_action 10:07:35 INFO - Running main action method: download_and_extract 10:07:35 INFO - mkdir: /builds/slave/test/build/tests 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:07:36 INFO - Downloaded 1361 bytes. 10:07:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:36 INFO - Using the following test package requirements: 10:07:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'jsshell-linux-x86_64.zip'], 10:07:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:36 INFO - https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:37 INFO - Downloaded 22771936 bytes. 10:07:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:38 INFO - Return code: 0 10:07:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:38 INFO - https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:39 INFO - Downloaded 22771936 bytes. 10:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:40 INFO - Return code: 0 10:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:40 INFO - https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:07:41 INFO - Downloaded 14403317 bytes. 10:07:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:07:41 INFO - Return code: 0 10:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:41 INFO - https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:07:43 INFO - Downloaded 57117044 bytes. 10:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:43 INFO - mkdir: /builds/slave/test/properties 10:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:43 INFO - Contents: 10:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:43 INFO - Running post-action listener: _resource_record_post_action 10:07:43 INFO - Running post-action listener: set_extra_try_arguments 10:07:43 INFO - [mozharness: 2016-07-20 17:07:43.987152Z] Finished download-and-extract step (success) 10:07:43 INFO - [mozharness: 2016-07-20 17:07:43.987383Z] Running populate-webroot step. 10:07:43 INFO - Running pre-action listener: _resource_record_pre_action 10:07:43 INFO - Running main action method: populate_webroot 10:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:44 INFO - '--tppagecycles', 10:07:44 INFO - '7'], 10:07:44 INFO - 'tests': ['tsvgm']}}, 10:07:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['damp', 'tps']}, 10:07:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['damp', 'tps']}, 10:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['dromaeo_dom']}, 10:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['basic_compositor_video']}, 10:07:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tsvgx', 10:07:44 INFO - 'tsvgr_opacity', 10:07:44 INFO - 'tart', 10:07:44 INFO - 'tscrollx', 10:07:44 INFO - 'cart']}, 10:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:44 INFO - 'tsvgr_opacity', 10:07:44 INFO - 'tart', 10:07:44 INFO - 'tscrollx', 10:07:44 INFO - 'cart']}, 10:07:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tp5o']}, 10:07:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['tp5o']}, 10:07:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s', 10:07:44 INFO - '--xperf_path', 10:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:44 INFO - 'tests': ['tp5n']}, 10:07:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--xperf_path', 10:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:44 INFO - 'tests': ['tp5n']}}, 10:07:44 INFO - 'talos.zip': {'path': '', 10:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:44 INFO - Running post-action listener: _resource_record_post_action 10:07:44 INFO - [mozharness: 2016-07-20 17:07:44.007477Z] Finished populate-webroot step (success) 10:07:44 INFO - [mozharness: 2016-07-20 17:07:44.007565Z] Running create-virtualenv step. 10:07:44 INFO - Running pre-action listener: _resource_record_pre_action 10:07:44 INFO - Running main action method: create_virtualenv 10:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:44 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 10:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:44 INFO - Using real prefix '/usr' 10:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:46 INFO - Installing pip.................done. 10:07:46 INFO - Return code: 0 10:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:46 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 10:07:46 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 10:07:46 INFO - Using env: {'DISPLAY': ':0', 10:07:46 INFO - 'HOME': '/home/cltbld', 10:07:46 INFO - 'LANG': 'en_US.UTF-8', 10:07:46 INFO - 'LANGUAGE': 'en_US:en', 10:07:46 INFO - 'LOGNAME': 'cltbld', 10:07:46 INFO - 'MAIL': '/var/mail/cltbld', 10:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:46 INFO - 'MOZ_NO_REMOTE': '1', 10:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:46 INFO - 'NO_EM_RESTART': '1', 10:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:46 INFO - 'PWD': '/builds/slave/test', 10:07:46 INFO - 'SHELL': '/bin/bash', 10:07:46 INFO - 'SHLVL': '1', 10:07:46 INFO - 'TERM': 'linux', 10:07:46 INFO - 'TMOUT': '86400', 10:07:46 INFO - 'USER': 'cltbld', 10:07:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:46 INFO - '_': '/tools/buildbot/bin/python'} 10:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:46 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 10:07:46 INFO - Cleaning up... 10:07:46 INFO - Return code: 0 10:07:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:46 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 10:07:46 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 10:07:46 INFO - Using env: {'DISPLAY': ':0', 10:07:46 INFO - 'HOME': '/home/cltbld', 10:07:46 INFO - 'LANG': 'en_US.UTF-8', 10:07:46 INFO - 'LANGUAGE': 'en_US:en', 10:07:46 INFO - 'LOGNAME': 'cltbld', 10:07:46 INFO - 'MAIL': '/var/mail/cltbld', 10:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:46 INFO - 'MOZ_NO_REMOTE': '1', 10:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:46 INFO - 'NO_EM_RESTART': '1', 10:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:46 INFO - 'PWD': '/builds/slave/test', 10:07:46 INFO - 'SHELL': '/bin/bash', 10:07:46 INFO - 'SHLVL': '1', 10:07:46 INFO - 'TERM': 'linux', 10:07:46 INFO - 'TMOUT': '86400', 10:07:46 INFO - 'USER': 'cltbld', 10:07:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:46 INFO - '_': '/tools/buildbot/bin/python'} 10:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:47 INFO - Downloading/unpacking psutil>=3.1.1 10:07:47 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 10:07:47 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 10:07:47 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 10:07:47 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 10:07:47 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 10:07:47 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 10:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:49 INFO - Installing collected packages: psutil 10:07:49 INFO - Running setup.py install for psutil 10:07:49 INFO - building 'psutil._psutil_linux' extension 10:07:49 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 10:07:49 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 10:07:49 INFO - building 'psutil._psutil_posix' extension 10:07:49 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 10:07:49 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 10:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:49 INFO - Successfully installed psutil 10:07:49 INFO - Cleaning up... 10:07:49 INFO - Return code: 0 10:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:49 INFO - Using env: {'DISPLAY': ':0', 10:07:49 INFO - 'HOME': '/home/cltbld', 10:07:49 INFO - 'LANG': 'en_US.UTF-8', 10:07:49 INFO - 'LANGUAGE': 'en_US:en', 10:07:49 INFO - 'LOGNAME': 'cltbld', 10:07:49 INFO - 'MAIL': '/var/mail/cltbld', 10:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:49 INFO - 'MOZ_NO_REMOTE': '1', 10:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:49 INFO - 'NO_EM_RESTART': '1', 10:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:49 INFO - 'PWD': '/builds/slave/test', 10:07:49 INFO - 'SHELL': '/bin/bash', 10:07:49 INFO - 'SHLVL': '1', 10:07:49 INFO - 'TERM': 'linux', 10:07:49 INFO - 'TMOUT': '86400', 10:07:49 INFO - 'USER': 'cltbld', 10:07:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:49 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:51 INFO - Installing collected packages: mozsystemmonitor 10:07:51 INFO - Running setup.py install for mozsystemmonitor 10:07:51 INFO - Successfully installed mozsystemmonitor 10:07:51 INFO - Cleaning up... 10:07:51 INFO - Return code: 0 10:07:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:51 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:51 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 10:07:51 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 10:07:51 INFO - Using env: {'DISPLAY': ':0', 10:07:51 INFO - 'HOME': '/home/cltbld', 10:07:51 INFO - 'LANG': 'en_US.UTF-8', 10:07:51 INFO - 'LANGUAGE': 'en_US:en', 10:07:51 INFO - 'LOGNAME': 'cltbld', 10:07:51 INFO - 'MAIL': '/var/mail/cltbld', 10:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:51 INFO - 'MOZ_NO_REMOTE': '1', 10:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:51 INFO - 'NO_EM_RESTART': '1', 10:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:51 INFO - 'PWD': '/builds/slave/test', 10:07:51 INFO - 'SHELL': '/bin/bash', 10:07:51 INFO - 'SHLVL': '1', 10:07:51 INFO - 'TERM': 'linux', 10:07:51 INFO - 'TMOUT': '86400', 10:07:51 INFO - 'USER': 'cltbld', 10:07:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:51 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Downloading/unpacking jsonschema==2.5.1 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:07:53 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 10:07:53 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 10:07:53 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 10:07:53 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 10:07:53 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 10:07:53 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 10:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:54 INFO - warning: no files found matching '*.txt' 10:07:54 INFO - no previously-included directories found matching 'build' 10:07:54 INFO - no previously-included directories found matching 'dist' 10:07:54 INFO - no previously-included directories found matching '.git*' 10:07:54 INFO - Installing collected packages: jsonschema, functools32 10:07:54 INFO - Running setup.py install for functools32 10:07:54 INFO - warning: no files found matching '*.txt' 10:07:54 INFO - no previously-included directories found matching 'build' 10:07:54 INFO - no previously-included directories found matching 'dist' 10:07:54 INFO - no previously-included directories found matching '.git*' 10:07:54 INFO - Successfully installed jsonschema functools32 10:07:54 INFO - Cleaning up... 10:07:54 INFO - Return code: 0 10:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:54 INFO - Using env: {'DISPLAY': ':0', 10:07:54 INFO - 'HOME': '/home/cltbld', 10:07:54 INFO - 'LANG': 'en_US.UTF-8', 10:07:54 INFO - 'LANGUAGE': 'en_US:en', 10:07:54 INFO - 'LOGNAME': 'cltbld', 10:07:54 INFO - 'MAIL': '/var/mail/cltbld', 10:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:54 INFO - 'MOZ_NO_REMOTE': '1', 10:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:54 INFO - 'NO_EM_RESTART': '1', 10:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:54 INFO - 'PWD': '/builds/slave/test', 10:07:54 INFO - 'SHELL': '/bin/bash', 10:07:54 INFO - 'SHLVL': '1', 10:07:54 INFO - 'TERM': 'linux', 10:07:54 INFO - 'TMOUT': '86400', 10:07:54 INFO - 'USER': 'cltbld', 10:07:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:54 INFO - '_': '/tools/buildbot/bin/python'} 10:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - Downloading docopt-0.6.1.tar.gz 10:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:57 INFO - Running setup.py install for blobuploader 10:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:57 INFO - Running setup.py install for requests 10:07:57 INFO - Running setup.py install for docopt 10:07:57 INFO - Successfully installed blobuploader requests docopt 10:07:57 INFO - Cleaning up... 10:07:57 INFO - Return code: 0 10:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:57 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:07:57 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 10:07:57 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 10:07:57 INFO - Using env: {'DISPLAY': ':0', 10:07:57 INFO - 'HOME': '/home/cltbld', 10:07:57 INFO - 'LANG': 'en_US.UTF-8', 10:07:57 INFO - 'LANGUAGE': 'en_US:en', 10:07:57 INFO - 'LOGNAME': 'cltbld', 10:07:57 INFO - 'MAIL': '/var/mail/cltbld', 10:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:57 INFO - 'MOZ_NO_REMOTE': '1', 10:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:57 INFO - 'NO_EM_RESTART': '1', 10:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:57 INFO - 'PWD': '/builds/slave/test', 10:07:57 INFO - 'SHELL': '/bin/bash', 10:07:57 INFO - 'SHLVL': '1', 10:07:57 INFO - 'TERM': 'linux', 10:07:57 INFO - 'TMOUT': '86400', 10:07:57 INFO - 'USER': 'cltbld', 10:07:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:57 INFO - '_': '/tools/buildbot/bin/python'} 10:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:58 INFO - Running setup.py (path:/tmp/pip-YS_THO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:58 INFO - Running setup.py (path:/tmp/pip-ZPP6Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:58 INFO - Running setup.py (path:/tmp/pip-CzzFfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:58 INFO - Running setup.py (path:/tmp/pip-70ZfAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:58 INFO - Running setup.py (path:/tmp/pip-uASguQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:58 INFO - Running setup.py (path:/tmp/pip-csczb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:58 INFO - Running setup.py (path:/tmp/pip-yQzKbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:58 INFO - Running setup.py (path:/tmp/pip-j4Y4Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:58 INFO - Running setup.py (path:/tmp/pip-1gqnfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:58 INFO - Running setup.py (path:/tmp/pip-59e66h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:58 INFO - Running setup.py (path:/tmp/pip-QNvpQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:58 INFO - Running setup.py (path:/tmp/pip-DERv8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:59 INFO - Running setup.py (path:/tmp/pip-iP11fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:59 INFO - Running setup.py (path:/tmp/pip-ZyZgTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:59 INFO - Running setup.py (path:/tmp/pip-_T6AtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:59 INFO - Running setup.py (path:/tmp/pip-2Tecox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:59 INFO - Running setup.py (path:/tmp/pip-uoxfbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:59 INFO - Running setup.py install for manifestparser 10:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:59 INFO - Running setup.py install for mozcrash 10:07:59 INFO - Running setup.py install for mozdebug 10:07:59 INFO - Running setup.py install for mozdevice 10:07:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:59 INFO - Running setup.py install for mozfile 10:07:59 INFO - Running setup.py install for mozhttpd 10:08:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozinfo 10:08:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozInstall 10:08:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozleak 10:08:00 INFO - Running setup.py install for mozlog 10:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for moznetwork 10:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozprocess 10:08:00 INFO - Running setup.py install for mozprofile 10:08:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozrunner 10:08:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozscreenshot 10:08:00 INFO - Running setup.py install for moztest 10:08:01 INFO - Running setup.py install for mozversion 10:08:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:08:01 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 10:08:01 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 10:08:01 INFO - Using env: {'DISPLAY': ':0', 10:08:01 INFO - 'HOME': '/home/cltbld', 10:08:01 INFO - 'LANG': 'en_US.UTF-8', 10:08:01 INFO - 'LANGUAGE': 'en_US:en', 10:08:01 INFO - 'LOGNAME': 'cltbld', 10:08:01 INFO - 'MAIL': '/var/mail/cltbld', 10:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:01 INFO - 'MOZ_NO_REMOTE': '1', 10:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:01 INFO - 'NO_EM_RESTART': '1', 10:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:01 INFO - 'PWD': '/builds/slave/test', 10:08:01 INFO - 'SHELL': '/bin/bash', 10:08:01 INFO - 'SHLVL': '1', 10:08:01 INFO - 'TERM': 'linux', 10:08:01 INFO - 'TMOUT': '86400', 10:08:01 INFO - 'USER': 'cltbld', 10:08:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:01 INFO - '_': '/tools/buildbot/bin/python'} 10:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 INFO - Running setup.py (path:/tmp/pip-dm7pqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 INFO - Running setup.py (path:/tmp/pip-nJrcOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:01 INFO - Running setup.py (path:/tmp/pip-tLY8Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:01 INFO - Running setup.py (path:/tmp/pip-6a3qhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:01 INFO - Running setup.py (path:/tmp/pip-6N0Pw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:01 INFO - Running setup.py (path:/tmp/pip-LF6gBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:01 INFO - Running setup.py (path:/tmp/pip-H8Vw2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:01 INFO - Running setup.py (path:/tmp/pip-nLkKWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:01 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)) 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:01 INFO - Running setup.py (path:/tmp/pip-A6I99C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:02 INFO - Running setup.py (path:/tmp/pip-3ZiSMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 INFO - Running setup.py (path:/tmp/pip-v29Lsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 INFO - Running setup.py (path:/tmp/pip-dtiUv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 INFO - Running setup.py (path:/tmp/pip-xSU5eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 INFO - Running setup.py (path:/tmp/pip-HX7KSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 INFO - Running setup.py (path:/tmp/pip-1AcQi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:02 INFO - Running setup.py (path:/tmp/pip-yrn3xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:02 INFO - Running setup.py (path:/tmp/pip-eC3Dq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:02 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)) 10:08:02 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)) 10:08:02 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)) 10:08:02 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)) 10:08:02 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)) 10:08:02 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)) 10:08:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:04 INFO - Downloading blessings-1.6.tar.gz 10:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:04 INFO - Installing collected packages: blessings 10:08:04 INFO - Running setup.py install for blessings 10:08:04 INFO - Successfully installed blessings 10:08:04 INFO - Cleaning up... 10:08:04 INFO - Return code: 0 10:08:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:05 INFO - Reading from file tmpfile_stdout 10:08:05 INFO - Current package versions: 10:08:05 INFO - argparse == 1.2.1 10:08:05 INFO - blessings == 1.6 10:08:05 INFO - blobuploader == 1.2.4 10:08:05 INFO - docopt == 0.6.1 10:08:05 INFO - functools32 == 3.2.3-2 10:08:05 INFO - jsonschema == 2.5.1 10:08:05 INFO - manifestparser == 1.1 10:08:05 INFO - mozInstall == 1.12 10:08:05 INFO - mozcrash == 0.17 10:08:05 INFO - mozdebug == 0.1 10:08:05 INFO - mozdevice == 0.48 10:08:05 INFO - mozfile == 1.2 10:08:05 INFO - mozhttpd == 0.7 10:08:05 INFO - mozinfo == 0.9 10:08:05 INFO - mozleak == 0.1 10:08:05 INFO - mozlog == 3.3 10:08:05 INFO - moznetwork == 0.27 10:08:05 INFO - mozprocess == 0.23 10:08:05 INFO - mozprofile == 0.28 10:08:05 INFO - mozrunner == 6.12 10:08:05 INFO - mozscreenshot == 0.1 10:08:05 INFO - mozsystemmonitor == 0.3 10:08:05 INFO - moztest == 0.7 10:08:05 INFO - mozversion == 1.4 10:08:05 INFO - psutil == 3.1.1 10:08:05 INFO - requests == 1.2.3 10:08:05 INFO - wsgiref == 0.1.2 10:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:08:05 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 10:08:05 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 10:08:05 INFO - Using env: {'DISPLAY': ':0', 10:08:05 INFO - 'HOME': '/home/cltbld', 10:08:05 INFO - 'LANG': 'en_US.UTF-8', 10:08:05 INFO - 'LANGUAGE': 'en_US:en', 10:08:05 INFO - 'LOGNAME': 'cltbld', 10:08:05 INFO - 'MAIL': '/var/mail/cltbld', 10:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:05 INFO - 'MOZ_NO_REMOTE': '1', 10:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:05 INFO - 'NO_EM_RESTART': '1', 10:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:05 INFO - 'PWD': '/builds/slave/test', 10:08:05 INFO - 'SHELL': '/bin/bash', 10:08:05 INFO - 'SHLVL': '1', 10:08:05 INFO - 'TERM': 'linux', 10:08:05 INFO - 'TMOUT': '86400', 10:08:05 INFO - 'USER': 'cltbld', 10:08:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:05 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 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)) 10:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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 0x1327030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', '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 10:08:05 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 10:08:05 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 10:08:05 INFO - Using env: {'DISPLAY': ':0', 10:08:05 INFO - 'HOME': '/home/cltbld', 10:08:05 INFO - 'LANG': 'en_US.UTF-8', 10:08:05 INFO - 'LANGUAGE': 'en_US:en', 10:08:05 INFO - 'LOGNAME': 'cltbld', 10:08:05 INFO - 'MAIL': '/var/mail/cltbld', 10:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:05 INFO - 'MOZ_NO_REMOTE': '1', 10:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:05 INFO - 'NO_EM_RESTART': '1', 10:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:05 INFO - 'PWD': '/builds/slave/test', 10:08:05 INFO - 'SHELL': '/bin/bash', 10:08:05 INFO - 'SHLVL': '1', 10:08:05 INFO - 'TERM': 'linux', 10:08:05 INFO - 'TMOUT': '86400', 10:08:05 INFO - 'USER': 'cltbld', 10:08:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:05 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Running post-action listener: _resource_record_post_action 10:08:05 INFO - Running post-action listener: _start_resource_monitoring 10:08:05 INFO - Starting resource monitoring. 10:08:05 INFO - [mozharness: 2016-07-20 17:08:05.504537Z] Finished create-virtualenv step (success) 10:08:05 INFO - [mozharness: 2016-07-20 17:08:05.505018Z] Running install step. 10:08:05 INFO - Running pre-action listener: _resource_record_pre_action 10:08:05 INFO - Running main action method: install 10:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:05 INFO - Reading from file tmpfile_stdout 10:08:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:05 INFO - Reading from file tmpfile_stdout 10:08:05 INFO - Output received: 10:08:05 INFO - Usage: mozinstall [options] installer 10:08:05 INFO - Options: 10:08:05 INFO - -h, --help show this help message and exit 10:08:05 INFO - -d DEST, --destination=DEST 10:08:05 INFO - Directory to install application into. [default: 10:08:05 INFO - "/builds/slave/test"] 10:08:05 INFO - --app=APP Application being installed. [default: firefox] 10:08:05 INFO - mkdir: /builds/slave/test/build/application 10:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:08:22 INFO - Reading from file tmpfile_stdout 10:08:22 INFO - Output received: 10:08:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:22 INFO - Running post-action listener: _resource_record_post_action 10:08:22 INFO - [mozharness: 2016-07-20 17:08:22.174895Z] Finished install step (success) 10:08:22 INFO - [mozharness: 2016-07-20 17:08:22.175146Z] Running run-tests step. 10:08:22 INFO - Running pre-action listener: _resource_record_pre_action 10:08:22 INFO - Running main action method: run_tests 10:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:22 INFO - Python 2.7.3 10:08:22 INFO - Return code: 0 10:08:22 INFO - grabbing minidump binary from tooltool 10:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:22 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 0x15e63b0>, '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 0x15e72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:22 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 10:08:22 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 10:08:22 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 10:08:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:22 INFO - Return code: 0 10:08:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:22 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/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 10:08:22 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/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 10:08:22 INFO - Using env: {'DISPLAY': ':0', 10:08:22 INFO - 'HOME': '/home/cltbld', 10:08:22 INFO - 'LANG': 'en_US.UTF-8', 10:08:22 INFO - 'LANGUAGE': 'en_US:en', 10:08:22 INFO - 'LOGNAME': 'cltbld', 10:08:22 INFO - 'MAIL': '/var/mail/cltbld', 10:08:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:22 INFO - 'MOZ_NO_REMOTE': '1', 10:08:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:22 INFO - 'NO_EM_RESTART': '1', 10:08:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:22 INFO - 'PWD': '/builds/slave/test', 10:08:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:22 INFO - 'SHELL': '/bin/bash', 10:08:22 INFO - 'SHLVL': '1', 10:08:22 INFO - 'TERM': 'linux', 10:08:22 INFO - 'TMOUT': '86400', 10:08:22 INFO - 'USER': 'cltbld', 10:08:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667', 10:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:22 INFO - '_': '/tools/buildbot/bin/python'} 10:08:22 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/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 10:08:22 INFO - mozversion application_buildid: 20160720075620 10:08:22 INFO - mozversion application_changeset: d224fc999cb6accb208af0a105f14433375e2e77 10:08:22 INFO - mozversion application_display_name: Nightly 10:08:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:22 INFO - mozversion application_name: Firefox 10:08:22 INFO - mozversion application_remotingname: firefox 10:08:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:22 INFO - mozversion application_vendor: Mozilla 10:08:22 INFO - mozversion application_version: 50.0a1 10:08:22 INFO - mozversion platform_buildid: 20160720075620 10:08:22 INFO - mozversion platform_changeset: d224fc999cb6accb208af0a105f14433375e2e77 10:08:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:22 INFO - mozversion platform_version: 50.0a1 10:08:22 INFO - using testdate: 1469034502 10:08:22 INFO - actual date: 1469034502 10:08:22 INFO - starting webserver on 'localhost:60554' 10:08:22 INFO - SUITE-START | Running 2 tests 10:08:22 INFO - TEST-START | dromaeo_css 10:08:22 INFO - operating with platform_type : linux_ 10:08:22 INFO - Initialising browser for dromaeo_css test... 10:08:22 INFO - TEST-INFO | started process 14012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoGswN/profile http://localhost:60554/getInfo.html) 10:08:27 INFO - PROCESS | 14012 | __metrics Screen width/height:1600/1200 10:08:27 INFO - PROCESS | 14012 | colorDepth:24 10:08:27 INFO - PROCESS | 14012 | Browser inner width/height: 1024/697 10:08:27 INFO - PROCESS | 14012 | __metrics 10:08:27 INFO - PROCESS | 14012 | 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" 10:08:27 INFO - PROCESS | 14012 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:28 INFO - TEST-INFO | 14012: exit 0 10:08:28 INFO - Browser initialized. 10:08:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:28 INFO - TEST-INFO | started process 14094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoGswN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:40 INFO - PROCESS | 14094 | RSS: Main: 158261248 10:08:40 INFO - PROCESS | 14094 | 10:09:32 INFO - PROCESS | 14094 | 1469034572794 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] 10:11:44 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60554/tests/dromaeo/cssquery-ext.html) 10:11:45 INFO - PROCESS | 14094 | RSS: Main: 267489280 10:11:45 INFO - PROCESS | 14094 | 10:14:48 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-ext.html (next: http://localhost:60554/tests/dromaeo/cssquery-jquery.html) 10:14:49 INFO - PROCESS | 14094 | RSS: Main: 232222720 10:14:49 INFO - PROCESS | 14094 | 10:17:51 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60554/tests/dromaeo/cssquery-mootools.html) 10:17:51 INFO - PROCESS | 14094 | RSS: Main: 228548608 10:17:51 INFO - PROCESS | 14094 | 10:20:54 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60554/tests/dromaeo/cssquery-prototype.html) 10:20:54 INFO - PROCESS | 14094 | RSS: Main: 187297792 10:20:54 INFO - PROCESS | 14094 | 10:23:57 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60554/tests/dromaeo/cssquery-yui.html) 10:23:58 INFO - PROCESS | 14094 | RSS: Main: 186068992 10:23:58 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-yui.html (next: http://localhost:60554/tests/dromaeo/cssquery-dojo.html) 10:27:01 INFO - PROCESS | 14094 | RSS: Main: 275554304 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | __start_tp_report 10:27:01 INFO - PROCESS | 14094 | _x_x_mozilla_page_load 10:27:01 INFO - PROCESS | 14094 | _x_x_mozilla_page_load_details 10:27:01 INFO - PROCESS | 14094 | |i|pagename|runs| 10:27:01 INFO - PROCESS | 14094 | |0;dojo.html;2560.820742548022;2577.7293384194645;2594.0272397850804;2597.9610305845417;2613.621024951381;4550.158220729168;4606.907861842761;4673.859784206475;4702.90594188116;4715.929261061086;4656.930146047812;4694.061187762444;4700.036492519034;4741.502142275063;4753.073150735608;4235.9152816943715;4283.785810709468;4300.591443812833;4352.086061926983;4517.344984977176;4440.245158323077;4472.306792447176;4477.216487114758;4483.14820184164;4492.034212644281;4215.578442155791;4259.74441533509;4267.530571637118;4272.401863739079;4355.303151495761;4294.892627684301;4311.37485064667;4318.114786468798;4390.517043125254;4401.911961760747;4336.132773445323;4352.238358287287;4355.760433176174;4398.670099742532;4399.5160532341415;4575.95424045762;4757.238841785298;4820.879478013043;4827.758612069418;4838.588719958808;4954.950450495485;5002.274670172841;5017.122003649347;5039.521245481674;5050.7222102784335;5076.974615126901;5106.336176297058;5113.590912726973;5120.5903527718065;5132.486751324875;4624.28323609841;4633.6524760642415;4727.550882666142;4764.809407623657;4765.380500534909;5108.514691104339;5112.130937740593;5170.948290517122;5176.378834539879;5184.377874655065;4870.488598697157;4872.6589138760655;4910.091633047898;4967.453580106186;4967.627427942919;4856.8785780355065;4958.603311735053;4981.975090124599;4987.002599480118;4991.925121123186;4991.051700176955;5036.496350364934;5038.193888977746;5060.342155519759;5078.4667609900425;5066.873328166826;5081.161608334583;5082.161443361804;5087.109755792721;5135.229715542699;4185.393117997874;4236.301010333261;4326.437563116838;4343.19650864591;4377.627901628333;3704.4258139988347;3752.399616061417;3765.2281282337053;3805.771653700787;3832.1569254764463;4382.802773875183;4397.2964325707735;4401.185780630593;4401.779911004437;4442.022754993961;5113.795448182105;5117.462666420047;5117.565006974449;5119.87200319995;5153.458886816905;4259.42497762798;4297.72064815786;4347.174036932973;4349.695521313541;4409.140217657526;4532.637389008872;4560.5895469407915;4564.132814765184;4566.0411313623845;4612.838550650711;4710.3170040343275;4736.076465089274;4747.311639812277;4749.857504274877;4794.496577859344;4952.232403977389;5009.398872135367;5013.849584512471;5073.492650734897;5077.086124497626;4630.143423466669;4723.33873257751;4750;4755.5719985201495;4757.952420475751;4941.431735350337;4964.081644895706;4966.726830024383;5008.323876276656;5009;5018.197088465828;5022.372203474566;5024.748762561931;5025.623078269217;5075.87310317245;4833.419989601271;4879.024195160911;4885.877853053702;4887.34020907173;4946.530079642428;4937.506249375034;4965.379327584052;4987.451380348086;5032.6225533084435;5035.967626636458;4871.098846713369;4876.390451193601;4884.218525035977;4885;4934.7285899275885;4725.078609671219;4788.066327066189;4906.018796240694;4919.262110683426;4927.630427717864;4696.2486002239475;4731.337612734289;4736.644751643572;4750.78621462042;4790.209615413418 10:27:01 INFO - PROCESS | 14094 | |1;ext.html;547.4401845179099;582.129716074469;585.6573904266004;587.2102022779362;588.2029849553854;26922.326941826464;40427.797861010724;41156;41189.79405102974;41232.433621461096;41456.792716036376;41791.58208417915;41876.16247675045;41900.79049604755;41909.16181676365;7722.61386930654;7885.0932142803595;8042.517448953053;8044;10052.698419047403;10265.538050787694;10400.791984160312;10401;10401.479926003707;10407.53166107527;10413.062824345807;10460;10480.58077676892;10483.68548943533;10490.58037678492;7825.765227043198;10059;10380.065794078531;10404.271700980935;10433.913217356521;10240.948795255976;10320.896791032068;10322.638707645196;10336.17310615149;10345.068943795019;39361.40957885605;39589.80205098956;39676.80161599174;39708;39731;2737.8220415672918;2771.80597358185;2792.4135931454216;2835.4754370441533;3371.870423408161;29226.269343266376;29637.703622963927;29688.257793555116;29838.85080574605;30407.391852163055;3441.1913200397885;3523.823808809549;3528.876489322887;3551.7336199784863;3614.1326081740194;258041;258051;258207;258478;259671.70164149246;53442.73278633582;53650.46349536533;53780;53795;53799.46200537944;33317.666823331456;34142.31715365679;34158;55877;55928.440715592325;15215.771763423558;15657.29542170605;15687.058776473219;15701.528954131394;15711.921440392953;10623.575056997634;10804.945975270073;10998.450077496092;11027.338359698444;11032.834507482394;18377.17302721381;18447.53881152955;18479.44561663152;18527.53681157982;18674.439766807016;6768.83077923046;6923.376896079377;6929.861402771916;7044.260352662999;7072.222055573883;763.1490887660219;866.0776273268948;886.4769785826394;945.4516380499294;975.9902400975899;26958.730412696015;28734.712652873623;28754.086233267753;29133.12600621985;29285;936.3866667332908;944.3861490031397;955.1260596554214;963.677168148678;979.5396163803001;14471.92764036194;15233.23833808305;15324;15431.768523472158;15556.377744890304;327512;425085;427004;428229;430262;52398;52544.47455525396;52579.47420525822;52641.7367913158;52661;1078.951447184863;1164.999999999983;1188.1207906149386;1203.2179083595734;1207.5954555223923;27544.311392215353;28907.855460722563;29151;29301;29461.81252384694;42478.362824557036;43163.56836431596;43293.35059974166;43300;43314.35028474638;263300;264435.55644436175;264440;264508;265456;22404;24663.260102196964;24667.25998220056;25355.74644253534;25423.745762542876;40634.79682601568;41299;41300;41408.37887431631;41424.1715165701;34906.30187396187;35180;35434.822825885705;35680.82159589185;35937.46093808647;34891.65108348986;35131.29737405289;35372.82313588416;35635.643643563235;35792.64207357893;34575.481367780005;35002.29995400027;35345;35539.46690799692;35751.46372804358;30392.696073038987;32263.35473290568;32865.83567082149;32913;32958.835205823816;24662;24852.25443236706;25104.49791004206;25379.746202538478;25554.872225638752 10:27:01 INFO - PROCESS | 14094 | |2;jquery.html;365.9194977105036;368.07796469843043;374.8388193076977;378.1208689796221;385.8919502539288;16820.327186912524;17252.568685782862;18320.08399580019;18341.26634934601;18400.723989140173;16214.594635134128;16264.918675406636;16730.330786768543;16878.493645190632;17889.373871914486;4574.817007319712;4832.516748325157;4836.056968891067;4839.032193561302;4840.080384726908;4667.533246675339;4753.691010084351;4790.137775200463;4798.4241890973135;4835.927461088087;4782.808687652489;4788.305695674125;4789.976050119744;4791.856244312658;4801.663883528155;4755.881102972418;4777.09235245304;4780.617550595944;4782.30656554801;5176.352955880515;4659.673822832403;4688.835890743808;4694.155052090622;4695.765211739434;4696.225122854759;18774.718379224323;21059.68410473844;21393.786062139334;21524.784752152435;21740.130394784188;1764.4794785538297;1769.0712376002703;1802.9459116226535;1818.990460294536;1861.7672790901138;8995;9170.082991700776;9324.393914395543;9370.39092458988;9560.474173920431;1722.8966262024194;1751.0894334945883;1800.3608718904732;1847.7782666080157;1851.5463711390796;70685.29314706838;73418;74008.6299568504;74637.99999999946;75300.24699752987;9855.55649995752;9991.400515969066;10111.64609238673;10169.847452288222;10185.847212291821;14147.646308842155;14167.433302667983;14194.787078193835;14216.360263788154;14216.715665686628;7331.596762178025;7421.554706717614;7516.849663006709;7626.504277221963;7646;7107.92892071083;7113.857722845514;7126.964365178141;7336.0463139792555;7338.669759860819;4370.38814565961;4409.735415875058;4416.4321665808175;4419.18245124653;4531.637469002472;1798.6402719456162;1826.5524946387955;1838.5985926036726;1854.5456363191104;1876.5402476393372;802.1897883138073;802.9197080291924;855.5080828523623;891.5809569502323;918.8392031394479;17223.13884305805;17508.5622859427;17548.104562747005;17889.28442862271;18194.90902545479;778.3189709004621;834.7078522517071;837.1001173738256;841.0706169682413;860.5611138319377;9394.248460123174;9484.810303793885;9568.95215523918;10077.798444031225;10080.596776128872;407729;409330;411264.71838204283;411704;424350;49284.50715492799;75725;76033.61983190049;77375.61312193403;80468;891.2157301574573;901.517688036884;934.1545900959643;938.7887725261899;939.7979434421495;15876.603084922508;15909;16273.67452650964;17001.789767330167;17126;37693.62306376901;40075.599244007186;40246.59753402429;40756;41006.79496602498;52537;57602.69589216384;58025.419745802;58862;59728.70135649294;6669.399754022162;7141.678624461808;7317.963410183128;7456.850862982818;8003.759887203393;10692.411917344622;11902.702432439259;12453.93773031129;12823.102382833486;13082.476700931857;7201.3158749918675;10465.424401657981;10497.26519143683;10717.35695858251;10931.39877306724;10338;10652.8934710655;10654.8401773975;10667.786644266916;10721.35671859691;10260.486975651336;10539;10626.893731062899;10749.677509674722;11290.548378065114;7287.161976372785;7368;7371.926280737124;7381.815454613463;7700.268474494914;9004.54977251148;9906.207503399566;10322.845157322496;10489;10612.151027917902 10:27:01 INFO - PROCESS | 14094 | |3;mootools.html;1289.4133169407921;1396.225095072235;1441.1353188087148;1485.7102864941335;1690.8647308215343;6694.832629184267;7494.250574942503;7849.175836537167;7856.764297071083;8077.151899050603;7864.96067519663;7963.840723185533;7965.402594805384;7975;7981.92018079819;2148.4736239621275;2175.695402643631;2177.0747432341273;2177.2379667116543;2178.4662757624405;2099.9475013124716;2104.0531760707668;2106.4944413340763;2110.398536417114;2159.265849611132;2107.778683238261;2108.841836862234;2121.9469513262216;2123.4691327168207;2179.1501314487364;2138.1554286057;2140.9678854817034;2141.389703934379;2143.732033495821;2145.871247725126;2067.224790703486;2128.6700561413004;2130.158587358;2132.9466763330884;2133.07211363056;7674.040744906887;7888.645010974463;7897.6840926362875;7954.443188976774;7966.601669916539;4407.735535867858;4579.519150489184;4585.95414045862;4590.74750888701;4594.2419500782335;2636.5781474963915;2787.428577141701;2825.9576106358422;2838.3755573773738;2847.288177955511;904.3759805734088;909.5088652127843;920.769807548113;954.1698722111738;967.3712087143343;10422.635207767767;10563.947180264126;10617.41604211768;10628.468576571218;10669;3637.0180051386506;3857.9035524112123;3940.5468371137686;3942.132730799277;3976.2643910876004;8405;8443.493390396596;8445.746627601182;8455.408121431441;8465.195806398382;4504.166729155051;4511.345854851028;4514.187446259639;4517.683762136685;4518.457785065813;3676.7426280160666;3770.170562476251;4069.2675318442966;4209.368594710757;4211.368294755811;3382.340443613521;3392.6098498672477;3509.578850537952;3515.5957064937347;3518.8592456301462;1016.872890888639;1020.2705065877784;1026.6817286641165;1039.620538503456;1056.1920131099714;789.9644515996794;818.7993941484375;827.6110228192861;837.7696133563319;843.6541018182515;4951.529604687621;4982.526659967298;5120.436751957282;5156.381234251914;5207.5313221809465;406.68685112463237;420.1366192474494;423.7690458700016;425;432.05811331297446;3425.606055303672;3475.6350583188905;3566.9108272292883;3815.198808250243;3961.1483531040963;9487.193588545051;9617.27870409722;9722.368046076983;9738.659146929824;9742.659006934724;9467.90532094684;9527.714168574954;9588;9699.563519641633;9701.369410988264;7267.091613548307;7332.413406927433;7452.813679658052;7458.589777562178;7472.402207823361;5376.408595054462;5389.461053894579;5527.585431092603;5559.58303127259;5665.150227465913;8840.24857887061;8973.50645714492;8974.102589740975;8983.146601072887;9090.454572725657;8609.225169734504;8752.299816014576;8913.019567847661;9095.545222738969;9096.954515227382;5904.143899134688;6622.337766223339;6707;6890.31096890307;6897.034415181778;7391.926080739124;7684.500507466997;7685.884711729441;7686.346660533917;7686.961565192362;6655.966720166368;6701.966490167518;6710.563813352116;6864.935934930094;6985.755498557526;6725.260221375547;6794.52438329332;6829.556078854858;6994.2656021117045;6995.860082798417;6082.787102451393;6164.445199931848;6172.351903050295;6172.969135154295;6173.228346456693;4403.405540252025;4407.272799987966;4511.09778044399;4553.567411095941;4584.037352156084;4365.367021781761;4452.777361131995;4538.977305113453;4552.954470455253;4678.111158879802 10:27:01 INFO - PROCESS | 14094 | |4;prototype.html;287.38346799254197;295.30603082755516;295.9302122825984;298.0492229786981;299.7077849097129;4852.830150944717;4876.829310974116;4902.828401005965;4909.852704418869;4928.408590969079;4772.78522466489;4773.665843390964;4822.590079843218;4831.8792030199265;4840.346553215315;3603.189282411456;3715.5912849586525;3723.1250656095795;3746.438034294864;3843.2121415109973;3796.8671096511625;3806.238752249561;3807.4098514730263;3844.7116466265;3846.653801157895;3782.224643947984;3801.277757226132;3802.954187598405;3817.0457385653585;3830.080780612647;3580.731445141612;3686.4654625079215;3790.3745881929726;3799.3351163546267;3806.7335286529956;3321.285923526453;3348.162959260185;3351.3632409842294;3361.1765117546356;3364.34395292918;4696.577308042292;4700.835470758507;4711.458182309044;4713;4790.80836766529;4193.916121677549;4288.571142885718;4309.913801723948;4383.715058521186;4388.978055109736;4956.504349565051;5002.799888004475;5016.194170098762;5018.7490625468945;5019.171836646949;3661.4141737322166;3666.1934374437583;3681.7790932543867;3691.3171063353097;3724.9068773280615;5037.722925239111;5285.471452854761;5290.153575427951;5297.284866543006;5345.946540534584;3722.571904230994;3763.5483741950593;3768.624452074973;3771.9434208486896;3797.9050523736573;3812.046988252937;3819.5607505137264;3822.694184465236;3826.234753049401;3831.252905683365;4308.030693094029;4337.024169561823;4346.609364849383;4349.173657005159;4365.716228445141;4854.320395144682;5028.220625802934;5028.220625803006;5055.848324550269;5112.386513618315;1280.6094141286997;1292.8319318488536;1296.883280504759;1297.7469393468184;1300.2848433361614;818.8198596308803;844.907060223375;857.4726543176026;868.4398562927003;879.8460269452949;4419.204543182193;4511.714161463967;4518.254488009507;4519.502854685982;4520.52534483881;5196.948030519722;5218.139007063792;5243.187305967581;5271.789128434896;5275.551578115903;4520.2089634314525;4521.525239849834;4539.387182730289;4542.545745425431;4559.179347717442;2633.3541536539665;2794.832310061362;2794.874230659625;2803.4112836304603;2806.466771313444;4910.558049775537;4926.581240594518;4935.851924442272;4936.259561065869;4943.591076543168;5205.401378841406;5294.49702278283;5350.5987050971335;5382.811601593926;5384.946150538444;4883.316335713003;4936;4939.777710003059;4941.851744447672;4946.975265123651;5288.312519372457;5289.3652761668845;5291.576673866004;5307.460836357413;5318.760655770422;4906.190478570996;5135.794568217229;5139.357580302462;5168.9483105168465;5170.121079416433;4912.38595175603;4925.768557860535;4929.433115191799;4929.975350123226;4933.0514446792595;3714.925701486009;3729.7202709797416;3772.5661548922226;3777.471154038492;3784.394496880486;5125.154349532286;5299.49654782795;5322.654027488201;5346.331708536433;5349.1976203569775;5118.564921981524;5119.308893299357;5127.92308115386;5133.537981581526;5135.87160320995;5115.846524604268;5124.871878203075;5130.48695130484;5207.2449494823795;5219.686818790885;4933.186024306093;4978.82997495581;5086.872828179326;5119.436861945109;5128.410232823273;4837.733924634038;4915.3855768029;5028.245763135413;5061.164907790173;5061.620378471555;4988.750562471934;5000.899982000413;5007.1487847065355;5013.523715247045;5020.213781351239 10:27:01 INFO - PROCESS | 14094 | |5;yui.html;588.4327547736114;640.4268179978919;649.7725795971413;707.1867352544573;712.9001939728437;13126.803097953527;14089.225092619901;14204.573862784107;14231.71536569268;14234.71530569388;12973.351332433387;13075.869241307584;13128.343582820844;13136;13155.342232888364;611;757.5984728094119;767.2979224010038;779.1896427715169;781.1056340490136;764.9311561959422;765.0360545712415;766.6051983228642;767.3592550220544;787.7557957033338;850.8511010573125;850.9787255318605;851.4082712514804;851.8594431918757;852.1691350932822;652.6280020388405;668.812732434919;669.7254125808444;672.4989882537492;842.877782721505;598.61090291311;609.1441524657863;610.9236345456818;611.3428064830281;613.123233775705;13364.465421383133;13378.130421522666;13425.731485370237;13436.798448023288;13441.19352838823;12461.93769031149;12582.622521324374;12902.612921612366;13018.86981130186;13354.131981421177;11037;11382.430878456127;11408.372539510323;11503.482343294489;11919.582814601446;4231.1114665920195;4235.894102647428;4239.863095030184;4356.237658409766;4401.471823381183;64192.35807641957;65080.349196508374;65171.67414162946;65261.021084683765;65420.3457965419;9802.803943921082;10041.246906482043;10142.645007424704;10438.582456701799;10864.782704346027;19637.410877673407;19640;19707.605847882962;19790;19793.604127917362;6860.416864566568;6900.930990690129;6933.410660093848;6994.510384273154;7178.605176715227;3356.983215083909;3498.650134986481;3514.4376899695926;3533.5406397168204;3562.1628917204434;2745.258780129354;2810.1148138336357;2820.7461328480535;2821.957670634942;2824.039826459014;479.5132940065836;481.1507688929043;483.1641260619148;485.434468843793;494.18952917215796;495.70010143863163;497.64169797745564;508.92366145078535;514.1131548079533;516.3442428116347;6587.703553340111;6759.526833121634;6978.511504194657;7054.576725396492;7092.858142837114;410.0548236315322;470.3908438571989;497.095286578431;501.1255359397874;514.9983282515547;4167.166566686675;4362.934555981663;4463.553644635575;4602.493725690171;4631;54758.45241547534;55720.72139639276;56058;56104.438955610734;56215.15677264763;82120.58939705264;82379.58810206031;82641;82852;84570.15429845746;71212.64393678102;73651.63174184095;76080.61959690166;76199.61900190463;77278.61360693161;8518.53148076837;8917;9103.453792772454;9216.539173041187;9299.116583924517;37677.4348384769;44182.77908610436;44836.9999999987;45689;45772.31341529813;55705.44294557002;65573.67213163903;65666.34333656602;66067.33932660804;67087;10705.785884282115;11233.502133258862;11332;11514.19400641947;11710.180287379802;9754.414735115915;10484.947575262075;11404.087672985976;11795.053816120244;11811.763764724485;11091.500882460146;11607.941960290145;11832.408379580815;12381.938090309492;12385.876141238472;11758.70603234926;11767.764644706887;12149.757004859677;12766.489340426278;12788.040896932953;11558.30650160993;11598.768024639292;11904.28574285511;12021.398930053287;12332.876671233173;9370.672026479313;9682;9846.45844478532;10119.898801011896;10342.224333175192;9059.501727404793;9942.105210530797;9958.651447199314;10016.148627366756;10041.096301332915 10:27:01 INFO - PROCESS | 14094 | __end_tp_report 10:27:01 INFO - PROCESS | 14094 | __start_cc_report 10:27:01 INFO - PROCESS | 14094 | _x_x_mozilla_cycle_collect,1106 10:27:01 INFO - PROCESS | 14094 | __end_cc_report 10:27:01 INFO - PROCESS | 14094 | __startTimestamp1469035621685__endTimestamp 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | ------- Summary: start ------- 10:27:01 INFO - PROCESS | 14094 | Number of tests: 6 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#0] dojo.html Cycles:165 Average:4662.28 Median:4757.24 stddev:489.59 (10.3%) stddev-sans-first:462.51 10:27:01 INFO - PROCESS | 14094 | Values: 2560.8 2577.7 2594.0 2598.0 2613.6 4550.2 4606.9 4673.9 4702.9 4715.9 4656.9 4694.1 4700.0 4741.5 4753.1 4235.9 4283.8 4300.6 4352.1 4517.3 4440.2 4472.3 4477.2 4483.1 4492.0 4215.6 4259.7 4267.5 4272.4 4355.3 4294.9 4311.4 4318.1 4390.5 4401.9 4336.1 4352.2 4355.8 4398.7 4399.5 4576.0 4757.2 4820.9 4827.8 4838.6 4955.0 5002.3 5017.1 5039.5 5050.7 5077.0 5106.3 5113.6 5120.6 5132.5 4624.3 4633.7 4727.6 4764.8 4765.4 5108.5 5112.1 5170.9 5176.4 5184.4 4870.5 4872.7 4910.1 4967.5 4967.6 4856.9 4958.6 4982.0 4987.0 4991.9 4991.1 5036.5 5038.2 5060.3 5078.5 5066.9 5081.2 5082.2 5087.1 5135.2 4185.4 4236.3 4326.4 4343.2 4377.6 3704.4 3752.4 3765.2 3805.8 3832.2 4382.8 4397.3 4401.2 4401.8 4442.0 5113.8 5117.5 5117.6 5119.9 5153.5 4259.4 4297.7 4347.2 4349.7 4409.1 4532.6 4560.6 4564.1 4566.0 4612.8 4710.3 4736.1 4747.3 4749.9 4794.5 4952.2 5009.4 5013.8 5073.5 5077.1 4630.1 4723.3 4750.0 4755.6 4758.0 4941.4 4964.1 4966.7 5008.3 5009.0 5018.2 5022.4 5024.7 5025.6 5075.9 4833.4 4879.0 4885.9 4887.3 4946.5 4937.5 4965.4 4987.5 5032.6 5036.0 4871.1 4876.4 4884.2 4885.0 4934.7 4725.1 4788.1 4906.0 4919.3 4927.6 4696.2 4731.3 4736.6 4750.8 4790.2 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#1] ext.html Cycles:180 Average:46805.95 Median:33138.25 stddev:83839.16 (253.0%) stddev-sans-first:84002.41 10:27:01 INFO - PROCESS | 14094 | Values: 547.4 582.1 585.7 587.2 588.2 26922.3 40427.8 41156.0 41189.8 41232.4 41456.8 41791.6 41876.2 41900.8 41909.2 7722.6 7885.1 8042.5 8044.0 10052.7 10265.5 10400.8 10401.0 10401.5 10407.5 10413.1 10460.0 10480.6 10483.7 10490.6 7825.8 10059.0 10380.1 10404.3 10433.9 10240.9 10320.9 10322.6 10336.2 10345.1 39361.4 39589.8 39676.8 39708.0 39731.0 2737.8 2771.8 2792.4 2835.5 3371.9 29226.3 29637.7 29688.3 29838.9 30407.4 3441.2 3523.8 3528.9 3551.7 3614.1 258041.0 258051.0 258207.0 258478.0 259671.7 53442.7 53650.5 53780.0 53795.0 53799.5 33317.7 34142.3 34158.0 55877.0 55928.4 15215.8 15657.3 15687.1 15701.5 15711.9 10623.6 10804.9 10998.5 11027.3 11032.8 18377.2 18447.5 18479.4 18527.5 18674.4 6768.8 6923.4 6929.9 7044.3 7072.2 763.1 866.1 886.5 945.5 976.0 26958.7 28734.7 28754.1 29133.1 29285.0 936.4 944.4 955.1 963.7 979.5 14471.9 15233.2 15324.0 15431.8 15556.4 327512.0 425085.0 427004.0 428229.0 430262.0 52398.0 52544.5 52579.5 52641.7 52661.0 1079.0 1165.0 1188.1 1203.2 1207.6 27544.3 28907.9 29151.0 29301.0 29461.8 42478.4 43163.6 43293.4 43300.0 43314.4 263300.0 264435.6 264440.0 264508.0 265456.0 22404.0 24663.3 24667.3 25355.7 25423.7 40634.8 41299.0 41300.0 41408.4 41424.2 34906.3 35180.0 35434.8 35680.8 35937.5 34891.7 35131.3 35372.8 35635.6 35792.6 34575.5 35002.3 35345.0 35539.5 35751.5 30392.7 32263.4 32865.8 32913.0 32958.8 24662.0 24852.3 25104.5 25379.7 25554.9 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#2] jquery.html Cycles:180 Average:25226.79 Median:4475.41 stddev:68142.56 (1522.6%) stddev-sans-first:68308.15 10:27:01 INFO - PROCESS | 14094 | Values: 365.9 368.1 374.8 378.1 385.9 16820.3 17252.6 18320.1 18341.3 18400.7 16214.6 16264.9 16730.3 16878.5 17889.4 4574.8 4832.5 4836.1 4839.0 4840.1 4667.5 4753.7 4790.1 4798.4 4835.9 4782.8 4788.3 4790.0 4791.9 4801.7 4755.9 4777.1 4780.6 4782.3 5176.4 4659.7 4688.8 4694.2 4695.8 4696.2 18774.7 21059.7 21393.8 21524.8 21740.1 1764.5 1769.1 1802.9 1819.0 1861.8 8995.0 9170.1 9324.4 9370.4 9560.5 1722.9 1751.1 1800.4 1847.8 1851.5 70685.3 73418.0 74008.6 74638.0 75300.2 9855.6 9991.4 10111.6 10169.8 10185.8 14147.6 14167.4 14194.8 14216.4 14216.7 7331.6 7421.6 7516.8 7626.5 7646.0 7107.9 7113.9 7127.0 7336.0 7338.7 4370.4 4409.7 4416.4 4419.2 4531.6 1798.6 1826.6 1838.6 1854.5 1876.5 802.2 802.9 855.5 891.6 918.8 17223.1 17508.6 17548.1 17889.3 18194.9 778.3 834.7 837.1 841.1 860.6 9394.2 9484.8 9569.0 10077.8 10080.6 407729.0 409330.0 411264.7 411704.0 424350.0 49284.5 75725.0 76033.6 77375.6 80468.0 891.2 901.5 934.2 938.8 939.8 15876.6 15909.0 16273.7 17001.8 17126.0 37693.6 40075.6 40246.6 40756.0 41006.8 52537.0 57602.7 58025.4 58862.0 59728.7 6669.4 7141.7 7318.0 7456.9 8003.8 10692.4 11902.7 12453.9 12823.1 13082.5 7201.3 10465.4 10497.3 10717.4 10931.4 10338.0 10652.9 10654.8 10667.8 10721.4 10260.5 10539.0 10626.9 10749.7 11290.5 7287.2 7368.0 7371.9 7381.8 7700.3 9004.5 9906.2 10322.8 10489.0 10612.2 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#3] mootools.html Cycles:180 Average:5076.83 Median:4967.03 stddev:2899.79 (58.4%) stddev-sans-first:2893.96 10:27:01 INFO - PROCESS | 14094 | Values: 1289.4 1396.2 1441.1 1485.7 1690.9 6694.8 7494.3 7849.2 7856.8 8077.2 7865.0 7963.8 7965.4 7975.0 7981.9 2148.5 2175.7 2177.1 2177.2 2178.5 2099.9 2104.1 2106.5 2110.4 2159.3 2107.8 2108.8 2121.9 2123.5 2179.2 2138.2 2141.0 2141.4 2143.7 2145.9 2067.2 2128.7 2130.2 2132.9 2133.1 7674.0 7888.6 7897.7 7954.4 7966.6 4407.7 4579.5 4586.0 4590.7 4594.2 2636.6 2787.4 2826.0 2838.4 2847.3 904.4 909.5 920.8 954.2 967.4 10422.6 10563.9 10617.4 10628.5 10669.0 3637.0 3857.9 3940.5 3942.1 3976.3 8405.0 8443.5 8445.7 8455.4 8465.2 4504.2 4511.3 4514.2 4517.7 4518.5 3676.7 3770.2 4069.3 4209.4 4211.4 3382.3 3392.6 3509.6 3515.6 3518.9 1016.9 1020.3 1026.7 1039.6 1056.2 790.0 818.8 827.6 837.8 843.7 4951.5 4982.5 5120.4 5156.4 5207.5 406.7 420.1 423.8 425.0 432.1 3425.6 3475.6 3566.9 3815.2 3961.1 9487.2 9617.3 9722.4 9738.7 9742.7 9467.9 9527.7 9588.0 9699.6 9701.4 7267.1 7332.4 7452.8 7458.6 7472.4 5376.4 5389.5 5527.6 5559.6 5665.2 8840.2 8973.5 8974.1 8983.1 9090.5 8609.2 8752.3 8913.0 9095.5 9097.0 5904.1 6622.3 6707.0 6890.3 6897.0 7391.9 7684.5 7685.9 7686.3 7687.0 6656.0 6702.0 6710.6 6864.9 6985.8 6725.3 6794.5 6829.6 6994.3 6995.9 6082.8 6164.4 6172.4 6173.0 6173.2 4403.4 4407.3 4511.1 4553.6 4584.0 4365.4 4452.8 4539.0 4553.0 4678.1 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#4] prototype.html Cycles:180 Average:4233.95 Median:4846.59 stddev:1227.48 (25.3%) stddev-sans-first:1194.64 10:27:01 INFO - PROCESS | 14094 | Values: 287.4 295.3 295.9 298.0 299.7 4852.8 4876.8 4902.8 4909.9 4928.4 4772.8 4773.7 4822.6 4831.9 4840.3 3603.2 3715.6 3723.1 3746.4 3843.2 3796.9 3806.2 3807.4 3844.7 3846.7 3782.2 3801.3 3803.0 3817.0 3830.1 3580.7 3686.5 3790.4 3799.3 3806.7 3321.3 3348.2 3351.4 3361.2 3364.3 4696.6 4700.8 4711.5 4713.0 4790.8 4193.9 4288.6 4309.9 4383.7 4389.0 4956.5 5002.8 5016.2 5018.7 5019.2 3661.4 3666.2 3681.8 3691.3 3724.9 5037.7 5285.5 5290.2 5297.3 5345.9 3722.6 3763.5 3768.6 3771.9 3797.9 3812.0 3819.6 3822.7 3826.2 3831.3 4308.0 4337.0 4346.6 4349.2 4365.7 4854.3 5028.2 5028.2 5055.8 5112.4 1280.6 1292.8 1296.9 1297.7 1300.3 818.8 844.9 857.5 868.4 879.8 4419.2 4511.7 4518.3 4519.5 4520.5 5196.9 5218.1 5243.2 5271.8 5275.6 4520.2 4521.5 4539.4 4542.5 4559.2 2633.4 2794.8 2794.9 2803.4 2806.5 4910.6 4926.6 4935.9 4936.3 4943.6 5205.4 5294.5 5350.6 5382.8 5384.9 4883.3 4936.0 4939.8 4941.9 4947.0 5288.3 5289.4 5291.6 5307.5 5318.8 4906.2 5135.8 5139.4 5168.9 5170.1 4912.4 4925.8 4929.4 4930.0 4933.1 3714.9 3729.7 3772.6 3777.5 3784.4 5125.2 5299.5 5322.7 5346.3 5349.2 5118.6 5119.3 5127.9 5133.5 5135.9 5115.8 5124.9 5130.5 5207.2 5219.7 4933.2 4978.8 5086.9 5119.4 5128.4 4837.7 4915.4 5028.2 5061.2 5061.6 4988.8 5000.9 5007.1 5013.5 5020.2 10:27:01 INFO - PROCESS | 14094 | 10:27:01 INFO - PROCESS | 14094 | [#5] yui.html Cycles:180 Average:16742.83 Median:482.16 stddev:22558.66 (4678.7%) stddev-sans-first:22589.33 10:27:01 INFO - PROCESS | 14094 | Values: 588.4 640.4 649.8 707.2 712.9 13126.8 14089.2 14204.6 14231.7 14234.7 12973.4 13075.9 13128.3 13136.0 13155.3 611.0 757.6 767.3 779.2 781.1 764.9 765.0 766.6 767.4 787.8 850.9 851.0 851.4 851.9 852.2 652.6 668.8 669.7 672.5 842.9 598.6 609.1 610.9 611.3 613.1 13364.5 13378.1 13425.7 13436.8 13441.2 12461.9 12582.6 12902.6 13018.9 13354.1 11037.0 11382.4 11408.4 11503.5 11919.6 4231.1 4235.9 4239.9 4356.2 4401.5 64192.4 65080.3 65171.7 65261.0 65420.3 9802.8 10041.2 10142.6 10438.6 10864.8 19637.4 19640.0 19707.6 19790.0 19793.6 6860.4 6900.9 6933.4 6994.5 7178.6 3357.0 3498.7 3514.4 3533.5 3562.2 2745.3 2810.1 2820.7 2822.0 2824.0 479.5 481.2 483.2 485.4 494.2 495.7 497.6 508.9 514.1 516.3 6587.7 6759.5 6978.5 7054.6 7092.9 410.1 470.4 497.1 501.1 515.0 4167.2 4362.9 4463.6 4602.5 4631.0 54758.5 55720.7 56058.0 56104.4 56215.2 82120.6 82379.6 82641.0 82852.0 84570.2 71212.6 73651.6 76080.6 76199.6 77278.6 8518.5 8917.0 9103.5 9216.5 9299.1 37677.4 44182.8 44837.0 45689.0 45772.3 55705.4 65573.7 65666.3 66067.3 67087.0 10705.8 11233.5 11332.0 11514.2 11710.2 9754.4 10484.9 11404.1 11795.1 11811.8 11091.5 11607.9 11832.4 12381.9 12385.9 11758.7 11767.8 12149.8 12766.5 12788.0 11558.3 11598.8 11904.3 12021.4 12332.9 9370.7 9682.0 9846.5 10119.9 10342.2 9059.5 9942.1 9958.7 10016.1 10041.1 10:27:01 INFO - PROCESS | 14094 | -------- Summary: end -------- 10:27:01 INFO - PROCESS | 14094 | 10:27:02 INFO - TEST-INFO | 14094: exit 0 10:27:02 INFO - TEST-OK | dromaeo_css | took 1119966ms 10:27:02 INFO - TEST-START | kraken 10:27:02 INFO - operating with platform_type : linux_ 10:27:02 INFO - Initialising browser for kraken test... 10:27:02 INFO - TEST-INFO | started process 14288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVV5ADN/profile http://localhost:60554/getInfo.html) 10:27:07 INFO - PROCESS | 14288 | __metrics Screen width/height:1600/1200 10:27:07 INFO - PROCESS | 14288 | colorDepth:24 10:27:07 INFO - PROCESS | 14288 | Browser inner width/height: 1024/697 10:27:07 INFO - PROCESS | 14288 | __metrics 10:27:07 INFO - PROCESS | 14288 | 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" 10:27:07 INFO - PROCESS | 14288 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:08 INFO - TEST-INFO | 14288: exit 0 10:27:08 INFO - Browser initialized. 10:27:08 INFO - Running cycle 1/1 for kraken test... 10:27:08 INFO - TEST-INFO | started process 14371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVV5ADN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:20 INFO - PROCESS | 14371 | RSS: Main: 158298112 10:27:20 INFO - PROCESS | 14371 | 10:27:23 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:24 INFO - PROCESS | 14371 | RSS: Main: 215425024 10:27:24 INFO - PROCESS | 14371 | 10:27:27 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-dft) 10:27:27 INFO - PROCESS | 14371 | RSS: Main: 192204800 10:27:27 INFO - PROCESS | 14371 | 10:27:31 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-fft) 10:27:31 INFO - PROCESS | 14371 | RSS: Main: 273014784 10:27:31 INFO - PROCESS | 14371 | 10:27:33 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-oscillator) 10:27:34 INFO - PROCESS | 14371 | RSS: Main: 181899264 10:27:34 INFO - PROCESS | 14371 | 10:27:36 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:37 INFO - PROCESS | 14371 | RSS: Main: 186056704 10:27:37 INFO - PROCESS | 14371 | 10:27:40 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:41 INFO - PROCESS | 14371 | RSS: Main: 222388224 10:27:41 INFO - PROCESS | 14371 | 10:27:44 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:45 INFO - PROCESS | 14371 | RSS: Main: 216838144 10:27:45 INFO - PROCESS | 14371 | 10:27:48 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60554/tests/kraken/driver.html?testName=json-parse-financial) 10:27:48 INFO - PROCESS | 14371 | RSS: Main: 218451968 10:27:48 INFO - PROCESS | 14371 | 10:27:50 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:51 INFO - PROCESS | 14371 | RSS: Main: 185212928 10:27:51 INFO - PROCESS | 14371 | 10:27:52 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:53 INFO - PROCESS | 14371 | RSS: Main: 190992384 10:27:53 INFO - PROCESS | 14371 | 10:27:55 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:56 INFO - PROCESS | 14371 | RSS: Main: 195198976 10:27:56 INFO - PROCESS | 14371 | 10:27:59 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:59 INFO - PROCESS | 14371 | RSS: Main: 190083072 10:27:59 INFO - PROCESS | 14371 | 10:28:02 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:03 INFO - PROCESS | 14371 | RSS: Main: 193138688 10:28:03 INFO - PROCESS | 14371 | 10:28:04 INFO - PROCESS | 14371 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60554/tests/kraken/driver.html?testName=ai-astar) 10:28:05 INFO - PROCESS | 14371 | RSS: Main: 244297728 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | __start_tp_report 10:28:05 INFO - PROCESS | 14371 | _x_x_mozilla_page_load 10:28:05 INFO - PROCESS | 14371 | _x_x_mozilla_page_load_details 10:28:05 INFO - PROCESS | 14371 | |i|pagename|runs| 10:28:05 INFO - PROCESS | 14371 | |0;ai-astar;104;115;114;114;113;113;112;114;114;113 10:28:05 INFO - PROCESS | 14371 | |1;audio-beat-detection;155;122;122;182;128;129;152;127;168;126 10:28:05 INFO - PROCESS | 14371 | |2;audio-dft;160;161;161;163;160;161;161;161;160;161 10:28:05 INFO - PROCESS | 14371 | |3;audio-fft;76;76;75;117;75;77;75;76;103;77 10:28:05 INFO - PROCESS | 14371 | |4;audio-oscillator;85;85;122;86;86;85;126;85;85;131 10:28:05 INFO - PROCESS | 14371 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;117;117;117 10:28:05 INFO - PROCESS | 14371 | |6;imaging-darkroom;146;146;146;146;147;147;147;146;146;147 10:28:05 INFO - PROCESS | 14371 | |7;imaging-desaturate;97;95;95;96;94;94;95;94;95;94 10:28:05 INFO - PROCESS | 14371 | |8;json-parse-financial;64;64;63;63;64;64;64;65;64;62 10:28:05 INFO - PROCESS | 14371 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;67;65 10:28:05 INFO - PROCESS | 14371 | |10;stanford-crypto-aes;79;79;80;79;78;82;85;79;78;80 10:28:05 INFO - PROCESS | 14371 | |11;stanford-crypto-ccm;130;129;132;130;127;129;138;134;183;130 10:28:05 INFO - PROCESS | 14371 | |12;stanford-crypto-pbkdf2;164;161;163;160;161;160;161;163;160;160 10:28:05 INFO - PROCESS | 14371 | |13;stanford-crypto-sha256-iterative;69;68;66;66;67;66;65;67;68;67 10:28:05 INFO - PROCESS | 14371 | __end_tp_report 10:28:05 INFO - PROCESS | 14371 | __start_cc_report 10:28:05 INFO - PROCESS | 14371 | _x_x_mozilla_cycle_collect,1929 10:28:05 INFO - PROCESS | 14371 | __end_cc_report 10:28:05 INFO - PROCESS | 14371 | __startTimestamp1469035685123__endTimestamp 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | ------- Summary: start ------- 10:28:05 INFO - PROCESS | 14371 | Number of tests: 14 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:0.88 10:28:05 INFO - PROCESS | 14371 | Values: 104.0 115.0 114.0 114.0 113.0 113.0 112.0 114.0 114.0 113.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.50 stddev:21.56 (15.3%) stddev-sans-first:22.27 10:28:05 INFO - PROCESS | 14371 | Values: 155.0 122.0 122.0 182.0 128.0 129.0 152.0 127.0 168.0 126.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 10:28:05 INFO - PROCESS | 14371 | Values: 160.0 161.0 161.0 163.0 160.0 161.0 161.0 161.0 160.0 161.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.78 (19.4%) stddev-sans-first:15.48 10:28:05 INFO - PROCESS | 14371 | Values: 76.0 76.0 75.0 117.0 75.0 77.0 75.0 76.0 103.0 77.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:19.95 (23.5%) stddev-sans-first:20.63 10:28:05 INFO - PROCESS | 14371 | Values: 85.0 85.0 122.0 86.0 86.0 85.0 126.0 85.0 85.0 131.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 10:28:05 INFO - PROCESS | 14371 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:28:05 INFO - PROCESS | 14371 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:0.71 10:28:05 INFO - PROCESS | 14371 | Values: 97.0 95.0 95.0 96.0 94.0 94.0 95.0 94.0 95.0 94.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 10:28:05 INFO - PROCESS | 14371 | Values: 64.0 64.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 62.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 10:28:05 INFO - PROCESS | 14371 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.13 (2.7%) stddev-sans-first:2.24 10:28:05 INFO - PROCESS | 14371 | Values: 79.0 79.0 80.0 79.0 78.0 82.0 85.0 79.0 78.0 80.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:131.00 stddev:16.73 (12.8%) stddev-sans-first:17.60 10:28:05 INFO - PROCESS | 14371 | Values: 130.0 129.0 132.0 130.0 127.0 129.0 138.0 134.0 183.0 130.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.22 10:28:05 INFO - PROCESS | 14371 | Values: 164.0 161.0 163.0 160.0 161.0 160.0 161.0 163.0 160.0 160.0 10:28:05 INFO - PROCESS | 14371 | 10:28:05 INFO - PROCESS | 14371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 10:28:05 INFO - PROCESS | 14371 | Values: 69.0 68.0 66.0 66.0 67.0 66.0 65.0 67.0 68.0 67.0 10:28:05 INFO - PROCESS | 14371 | -------- Summary: end -------- 10:28:05 INFO - PROCESS | 14371 | 10:28:06 INFO - TEST-INFO | 14371: exit 0 10:28:06 INFO - TEST-OK | kraken | took 63826ms 10:28:06 INFO - SUITE-END | took 1183s 10:28:06 INFO - Completed test suite (00:19:43) 10:28:06 INFO - javascript benchmark 10:28:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.820742548022, 2577.7293384194645, 2594.0272397850804, 2597.9610305845417, 2613.621024951381, 4550.158220729168, 4606.907861842761, 4673.859784206475, 4702.90594188116, 4715.929261061086, 4656.930146047812, 4694.061187762444, 4700.036492519034, 4741.502142275063, 4753.073150735608, 4235.9152816943715, 4283.785810709468, 4300.591443812833, 4352.086061926983, 4517.344984977176, 4440.245158323077, 4472.306792447176, 4477.216487114758, 4483.14820184164, 4492.034212644281, 4215.578442155791, 4259.74441533509, 4267.530571637118, 4272.401863739079, 4355.303151495761, 4294.892627684301, 4311.37485064667, 4318.114786468798, 4390.517043125254, 4401.911961760747, 4336.132773445323, 4352.238358287287, 4355.760433176174, 4398.670099742532, 4399.5160532341415, 4575.95424045762, 4757.238841785298, 4820.879478013043, 4827.758612069418, 4838.588719958808, 4954.950450495485, 5002.274670172841, 5017.122003649347, 5039.521245481674, 5050.7222102784335, 5076.974615126901, 5106.336176297058, 5113.590912726973, 5120.5903527718065, 5132.486751324875, 4624.28323609841, 4633.6524760642415, 4727.550882666142, 4764.809407623657, 4765.380500534909, 5108.514691104339, 5112.130937740593, 5170.948290517122, 5176.378834539879, 5184.377874655065, 4870.488598697157, 4872.6589138760655, 4910.091633047898, 4967.453580106186, 4967.627427942919, 4856.8785780355065, 4958.603311735053, 4981.975090124599, 4987.002599480118, 4991.925121123186, 4991.051700176955, 5036.496350364934, 5038.193888977746, 5060.342155519759, 5078.4667609900425, 5066.873328166826, 5081.161608334583, 5082.161443361804, 5087.109755792721, 5135.229715542699, 4185.393117997874, 4236.301010333261, 4326.437563116838, 4343.19650864591, 4377.627901628333, 3704.4258139988347, 3752.399616061417, 3765.2281282337053, 3805.771653700787, 3832.1569254764463, 4382.802773875183, 4397.2964325707735, 4401.185780630593, 4401.779911004437, 4442.022754993961, 5113.795448182105, 5117.462666420047, 5117.565006974449, 5119.87200319995, 5153.458886816905, 4259.42497762798, 4297.72064815786, 4347.174036932973, 4349.695521313541, 4409.140217657526, 4532.637389008872, 4560.5895469407915, 4564.132814765184, 4566.0411313623845, 4612.838550650711, 4710.3170040343275, 4736.076465089274, 4747.311639812277, 4749.857504274877, 4794.496577859344, 4952.232403977389, 5009.398872135367, 5013.849584512471, 5073.492650734897, 5077.086124497626, 4630.143423466669, 4723.33873257751, 4750.0, 4755.5719985201495, 4757.952420475751, 4941.431735350337, 4964.081644895706, 4966.726830024383, 5008.323876276656, 5009.0, 5018.197088465828, 5022.372203474566, 5024.748762561931, 5025.623078269217, 5075.87310317245, 4833.419989601271, 4879.024195160911, 4885.877853053702, 4887.34020907173, 4946.530079642428, 4937.506249375034, 4965.379327584052, 4987.451380348086, 5032.6225533084435, 5035.967626636458, 4871.098846713369, 4876.390451193601, 4884.218525035977, 4885.0, 4934.7285899275885, 4725.078609671219, 4788.066327066189, 4906.018796240694, 4919.262110683426, 4927.630427717864, 4696.2486002239475, 4731.337612734289, 4736.644751643572, 4750.78621462042, 4790.209615413418], "value": 4630.561840491246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4401845179099, 582.129716074469, 585.6573904266004, 587.2102022779362, 588.2029849553854, 26922.326941826464, 40427.797861010724, 41156.0, 41189.79405102974, 41232.433621461096, 41456.792716036376, 41791.58208417915, 41876.16247675045, 41900.79049604755, 41909.16181676365, 7722.61386930654, 7885.0932142803595, 8042.517448953053, 8044.0, 10052.698419047403, 10265.538050787694, 10400.791984160312, 10401.0, 10401.479926003707, 10407.53166107527, 10413.062824345807, 10460.0, 10480.58077676892, 10483.68548943533, 10490.58037678492, 7825.765227043198, 10059.0, 10380.065794078531, 10404.271700980935, 10433.913217356521, 10240.948795255976, 10320.896791032068, 10322.638707645196, 10336.17310615149, 10345.068943795019, 39361.40957885605, 39589.80205098956, 39676.80161599174, 39708.0, 39731.0, 2737.8220415672918, 2771.80597358185, 2792.4135931454216, 2835.4754370441533, 3371.870423408161, 29226.269343266376, 29637.703622963927, 29688.257793555116, 29838.85080574605, 30407.391852163055, 3441.1913200397885, 3523.823808809549, 3528.876489322887, 3551.7336199784863, 3614.1326081740194, 258041.0, 258051.0, 258207.0, 258478.0, 259671.70164149246, 53442.73278633582, 53650.46349536533, 53780.0, 53795.0, 53799.46200537944, 33317.666823331456, 34142.31715365679, 34158.0, 55877.0, 55928.440715592325, 15215.771763423558, 15657.29542170605, 15687.058776473219, 15701.528954131394, 15711.921440392953, 10623.575056997634, 10804.945975270073, 10998.450077496092, 11027.338359698444, 11032.834507482394, 18377.17302721381, 18447.53881152955, 18479.44561663152, 18527.53681157982, 18674.439766807016, 6768.83077923046, 6923.376896079377, 6929.861402771916, 7044.260352662999, 7072.222055573883, 763.1490887660219, 866.0776273268948, 886.4769785826394, 945.4516380499294, 975.9902400975899, 26958.730412696015, 28734.712652873623, 28754.086233267753, 29133.12600621985, 29285.0, 936.3866667332908, 944.3861490031397, 955.1260596554214, 963.677168148678, 979.5396163803001, 14471.92764036194, 15233.23833808305, 15324.0, 15431.768523472158, 15556.377744890304, 327512.0, 425085.0, 427004.0, 428229.0, 430262.0, 52398.0, 52544.47455525396, 52579.47420525822, 52641.7367913158, 52661.0, 1078.951447184863, 1164.999999999983, 1188.1207906149386, 1203.2179083595734, 1207.5954555223923, 27544.311392215353, 28907.855460722563, 29151.0, 29301.0, 29461.81252384694, 42478.362824557036, 43163.56836431596, 43293.35059974166, 43300.0, 43314.35028474638, 263300.0, 264435.55644436175, 264440.0, 264508.0, 265456.0, 22404.0, 24663.260102196964, 24667.25998220056, 25355.74644253534, 25423.745762542876, 40634.79682601568, 41299.0, 41300.0, 41408.37887431631, 41424.1715165701, 34906.30187396187, 35180.0, 35434.822825885705, 35680.82159589185, 35937.46093808647, 34891.65108348986, 35131.29737405289, 35372.82313588416, 35635.643643563235, 35792.64207357893, 34575.481367780005, 35002.29995400027, 35345.0, 35539.46690799692, 35751.46372804358, 30392.696073038987, 32263.35473290568, 32865.83567082149, 32913.0, 32958.835205823816, 24662.0, 24852.25443236706, 25104.49791004206, 25379.746202538478, 25554.872225638752], "value": 17970.94761726175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.9194977105036, 368.07796469843043, 374.8388193076977, 378.1208689796221, 385.8919502539288, 16820.327186912524, 17252.568685782862, 18320.08399580019, 18341.26634934601, 18400.723989140173, 16214.594635134128, 16264.918675406636, 16730.330786768543, 16878.493645190632, 17889.373871914486, 4574.817007319712, 4832.516748325157, 4836.056968891067, 4839.032193561302, 4840.080384726908, 4667.533246675339, 4753.691010084351, 4790.137775200463, 4798.4241890973135, 4835.927461088087, 4782.808687652489, 4788.305695674125, 4789.976050119744, 4791.856244312658, 4801.663883528155, 4755.881102972418, 4777.09235245304, 4780.617550595944, 4782.30656554801, 5176.352955880515, 4659.673822832403, 4688.835890743808, 4694.155052090622, 4695.765211739434, 4696.225122854759, 18774.718379224323, 21059.68410473844, 21393.786062139334, 21524.784752152435, 21740.130394784188, 1764.4794785538297, 1769.0712376002703, 1802.9459116226535, 1818.990460294536, 1861.7672790901138, 8995.0, 9170.082991700776, 9324.393914395543, 9370.39092458988, 9560.474173920431, 1722.8966262024194, 1751.0894334945883, 1800.3608718904732, 1847.7782666080157, 1851.5463711390796, 70685.29314706838, 73418.0, 74008.6299568504, 74637.99999999946, 75300.24699752987, 9855.55649995752, 9991.400515969066, 10111.64609238673, 10169.847452288222, 10185.847212291821, 14147.646308842155, 14167.433302667983, 14194.787078193835, 14216.360263788154, 14216.715665686628, 7331.596762178025, 7421.554706717614, 7516.849663006709, 7626.504277221963, 7646.0, 7107.92892071083, 7113.857722845514, 7126.964365178141, 7336.0463139792555, 7338.669759860819, 4370.38814565961, 4409.735415875058, 4416.4321665808175, 4419.18245124653, 4531.637469002472, 1798.6402719456162, 1826.5524946387955, 1838.5985926036726, 1854.5456363191104, 1876.5402476393372, 802.1897883138073, 802.9197080291924, 855.5080828523623, 891.5809569502323, 918.8392031394479, 17223.13884305805, 17508.5622859427, 17548.104562747005, 17889.28442862271, 18194.90902545479, 778.3189709004621, 834.7078522517071, 837.1001173738256, 841.0706169682413, 860.5611138319377, 9394.248460123174, 9484.810303793885, 9568.95215523918, 10077.798444031225, 10080.596776128872, 407729.0, 409330.0, 411264.71838204283, 411704.0, 424350.0, 49284.50715492799, 75725.0, 76033.61983190049, 77375.61312193403, 80468.0, 891.2157301574573, 901.517688036884, 934.1545900959643, 938.7887725261899, 939.7979434421495, 15876.603084922508, 15909.0, 16273.67452650964, 17001.789767330167, 17126.0, 37693.62306376901, 40075.599244007186, 40246.59753402429, 40756.0, 41006.79496602498, 52537.0, 57602.69589216384, 58025.419745802, 58862.0, 59728.70135649294, 6669.399754022162, 7141.678624461808, 7317.963410183128, 7456.850862982818, 8003.759887203393, 10692.411917344622, 11902.702432439259, 12453.93773031129, 12823.102382833486, 13082.476700931857, 7201.3158749918675, 10465.424401657981, 10497.26519143683, 10717.35695858251, 10931.39877306724, 10338.0, 10652.8934710655, 10654.8401773975, 10667.786644266916, 10721.35671859691, 10260.486975651336, 10539.0, 10626.893731062899, 10749.677509674722, 11290.548378065114, 7287.161976372785, 7368.0, 7371.926280737124, 7381.815454613463, 7700.268474494914, 9004.54977251148, 9906.207503399566, 10322.845157322496, 10489.0, 10612.151027917902], "value": 8194.493239027579, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.4133169407921, 1396.225095072235, 1441.1353188087148, 1485.7102864941335, 1690.8647308215343, 6694.832629184267, 7494.250574942503, 7849.175836537167, 7856.764297071083, 8077.151899050603, 7864.96067519663, 7963.840723185533, 7965.402594805384, 7975.0, 7981.92018079819, 2148.4736239621275, 2175.695402643631, 2177.0747432341273, 2177.2379667116543, 2178.4662757624405, 2099.9475013124716, 2104.0531760707668, 2106.4944413340763, 2110.398536417114, 2159.265849611132, 2107.778683238261, 2108.841836862234, 2121.9469513262216, 2123.4691327168207, 2179.1501314487364, 2138.1554286057, 2140.9678854817034, 2141.389703934379, 2143.732033495821, 2145.871247725126, 2067.224790703486, 2128.6700561413004, 2130.158587358, 2132.9466763330884, 2133.07211363056, 7674.040744906887, 7888.645010974463, 7897.6840926362875, 7954.443188976774, 7966.601669916539, 4407.735535867858, 4579.519150489184, 4585.95414045862, 4590.74750888701, 4594.2419500782335, 2636.5781474963915, 2787.428577141701, 2825.9576106358422, 2838.3755573773738, 2847.288177955511, 904.3759805734088, 909.5088652127843, 920.769807548113, 954.1698722111738, 967.3712087143343, 10422.635207767767, 10563.947180264126, 10617.41604211768, 10628.468576571218, 10669.0, 3637.0180051386506, 3857.9035524112123, 3940.5468371137686, 3942.132730799277, 3976.2643910876004, 8405.0, 8443.493390396596, 8445.746627601182, 8455.408121431441, 8465.195806398382, 4504.166729155051, 4511.345854851028, 4514.187446259639, 4517.683762136685, 4518.457785065813, 3676.7426280160666, 3770.170562476251, 4069.2675318442966, 4209.368594710757, 4211.368294755811, 3382.340443613521, 3392.6098498672477, 3509.578850537952, 3515.5957064937347, 3518.8592456301462, 1016.872890888639, 1020.2705065877784, 1026.6817286641165, 1039.620538503456, 1056.1920131099714, 789.9644515996794, 818.7993941484375, 827.6110228192861, 837.7696133563319, 843.6541018182515, 4951.529604687621, 4982.526659967298, 5120.436751957282, 5156.381234251914, 5207.5313221809465, 406.68685112463237, 420.1366192474494, 423.7690458700016, 425.0, 432.05811331297446, 3425.606055303672, 3475.6350583188905, 3566.9108272292883, 3815.198808250243, 3961.1483531040963, 9487.193588545051, 9617.27870409722, 9722.368046076983, 9738.659146929824, 9742.659006934724, 9467.90532094684, 9527.714168574954, 9588.0, 9699.563519641633, 9701.369410988264, 7267.091613548307, 7332.413406927433, 7452.813679658052, 7458.589777562178, 7472.402207823361, 5376.408595054462, 5389.461053894579, 5527.585431092603, 5559.58303127259, 5665.150227465913, 8840.24857887061, 8973.50645714492, 8974.102589740975, 8983.146601072887, 9090.454572725657, 8609.225169734504, 8752.299816014576, 8913.019567847661, 9095.545222738969, 9096.954515227382, 5904.143899134688, 6622.337766223339, 6707.0, 6890.31096890307, 6897.034415181778, 7391.926080739124, 7684.500507466997, 7685.884711729441, 7686.346660533917, 7686.961565192362, 6655.966720166368, 6701.966490167518, 6710.563813352116, 6864.935934930094, 6985.755498557526, 6725.260221375547, 6794.52438329332, 6829.556078854858, 6994.2656021117045, 6995.860082798417, 6082.787102451393, 6164.445199931848, 6172.351903050295, 6172.969135154295, 6173.228346456693, 4403.405540252025, 4407.272799987966, 4511.09778044399, 4553.567411095941, 4584.037352156084, 4365.367021781761, 4452.777361131995, 4538.977305113453, 4552.954470455253, 4678.111158879802], "value": 3997.624317682043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.38346799254197, 295.30603082755516, 295.9302122825984, 298.0492229786981, 299.7077849097129, 4852.830150944717, 4876.829310974116, 4902.828401005965, 4909.852704418869, 4928.408590969079, 4772.78522466489, 4773.665843390964, 4822.590079843218, 4831.8792030199265, 4840.346553215315, 3603.189282411456, 3715.5912849586525, 3723.1250656095795, 3746.438034294864, 3843.2121415109973, 3796.8671096511625, 3806.238752249561, 3807.4098514730263, 3844.7116466265, 3846.653801157895, 3782.224643947984, 3801.277757226132, 3802.954187598405, 3817.0457385653585, 3830.080780612647, 3580.731445141612, 3686.4654625079215, 3790.3745881929726, 3799.3351163546267, 3806.7335286529956, 3321.285923526453, 3348.162959260185, 3351.3632409842294, 3361.1765117546356, 3364.34395292918, 4696.577308042292, 4700.835470758507, 4711.458182309044, 4713.0, 4790.80836766529, 4193.916121677549, 4288.571142885718, 4309.913801723948, 4383.715058521186, 4388.978055109736, 4956.504349565051, 5002.799888004475, 5016.194170098762, 5018.7490625468945, 5019.171836646949, 3661.4141737322166, 3666.1934374437583, 3681.7790932543867, 3691.3171063353097, 3724.9068773280615, 5037.722925239111, 5285.471452854761, 5290.153575427951, 5297.284866543006, 5345.946540534584, 3722.571904230994, 3763.5483741950593, 3768.624452074973, 3771.9434208486896, 3797.9050523736573, 3812.046988252937, 3819.5607505137264, 3822.694184465236, 3826.234753049401, 3831.252905683365, 4308.030693094029, 4337.024169561823, 4346.609364849383, 4349.173657005159, 4365.716228445141, 4854.320395144682, 5028.220625802934, 5028.220625803006, 5055.848324550269, 5112.386513618315, 1280.6094141286997, 1292.8319318488536, 1296.883280504759, 1297.7469393468184, 1300.2848433361614, 818.8198596308803, 844.907060223375, 857.4726543176026, 868.4398562927003, 879.8460269452949, 4419.204543182193, 4511.714161463967, 4518.254488009507, 4519.502854685982, 4520.52534483881, 5196.948030519722, 5218.139007063792, 5243.187305967581, 5271.789128434896, 5275.551578115903, 4520.2089634314525, 4521.525239849834, 4539.387182730289, 4542.545745425431, 4559.179347717442, 2633.3541536539665, 2794.832310061362, 2794.874230659625, 2803.4112836304603, 2806.466771313444, 4910.558049775537, 4926.581240594518, 4935.851924442272, 4936.259561065869, 4943.591076543168, 5205.401378841406, 5294.49702278283, 5350.5987050971335, 5382.811601593926, 5384.946150538444, 4883.316335713003, 4936.0, 4939.777710003059, 4941.851744447672, 4946.975265123651, 5288.312519372457, 5289.3652761668845, 5291.576673866004, 5307.460836357413, 5318.760655770422, 4906.190478570996, 5135.794568217229, 5139.357580302462, 5168.9483105168465, 5170.121079416433, 4912.38595175603, 4925.768557860535, 4929.433115191799, 4929.975350123226, 4933.0514446792595, 3714.925701486009, 3729.7202709797416, 3772.5661548922226, 3777.471154038492, 3784.394496880486, 5125.154349532286, 5299.49654782795, 5322.654027488201, 5346.331708536433, 5349.1976203569775, 5118.564921981524, 5119.308893299357, 5127.92308115386, 5133.537981581526, 5135.87160320995, 5115.846524604268, 5124.871878203075, 5130.48695130484, 5207.2449494823795, 5219.686818790885, 4933.186024306093, 4978.82997495581, 5086.872828179326, 5119.436861945109, 5128.410232823273, 4837.733924634038, 4915.3855768029, 5028.245763135413, 5061.164907790173, 5061.620378471555, 4988.750562471934, 5000.899982000413, 5007.1487847065355, 5013.523715247045, 5020.213781351239], "value": 3840.1770532524915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4327547736114, 640.4268179978919, 649.7725795971413, 707.1867352544573, 712.9001939728437, 13126.803097953527, 14089.225092619901, 14204.573862784107, 14231.71536569268, 14234.71530569388, 12973.351332433387, 13075.869241307584, 13128.343582820844, 13136.0, 13155.342232888364, 611.0, 757.5984728094119, 767.2979224010038, 779.1896427715169, 781.1056340490136, 764.9311561959422, 765.0360545712415, 766.6051983228642, 767.3592550220544, 787.7557957033338, 850.8511010573125, 850.9787255318605, 851.4082712514804, 851.8594431918757, 852.1691350932822, 652.6280020388405, 668.812732434919, 669.7254125808444, 672.4989882537492, 842.877782721505, 598.61090291311, 609.1441524657863, 610.9236345456818, 611.3428064830281, 613.123233775705, 13364.465421383133, 13378.130421522666, 13425.731485370237, 13436.798448023288, 13441.19352838823, 12461.93769031149, 12582.622521324374, 12902.612921612366, 13018.86981130186, 13354.131981421177, 11037.0, 11382.430878456127, 11408.372539510323, 11503.482343294489, 11919.582814601446, 4231.1114665920195, 4235.894102647428, 4239.863095030184, 4356.237658409766, 4401.471823381183, 64192.35807641957, 65080.349196508374, 65171.67414162946, 65261.021084683765, 65420.3457965419, 9802.803943921082, 10041.246906482043, 10142.645007424704, 10438.582456701799, 10864.782704346027, 19637.410877673407, 19640.0, 19707.605847882962, 19790.0, 19793.604127917362, 6860.416864566568, 6900.930990690129, 6933.410660093848, 6994.510384273154, 7178.605176715227, 3356.983215083909, 3498.650134986481, 3514.4376899695926, 3533.5406397168204, 3562.1628917204434, 2745.258780129354, 2810.1148138336357, 2820.7461328480535, 2821.957670634942, 2824.039826459014, 479.5132940065836, 481.1507688929043, 483.1641260619148, 485.434468843793, 494.18952917215796, 495.70010143863163, 497.64169797745564, 508.92366145078535, 514.1131548079533, 516.3442428116347, 6587.703553340111, 6759.526833121634, 6978.511504194657, 7054.576725396492, 7092.858142837114, 410.0548236315322, 470.3908438571989, 497.095286578431, 501.1255359397874, 514.9983282515547, 4167.166566686675, 4362.934555981663, 4463.553644635575, 4602.493725690171, 4631.0, 54758.45241547534, 55720.72139639276, 56058.0, 56104.438955610734, 56215.15677264763, 82120.58939705264, 82379.58810206031, 82641.0, 82852.0, 84570.15429845746, 71212.64393678102, 73651.63174184095, 76080.61959690166, 76199.61900190463, 77278.61360693161, 8518.53148076837, 8917.0, 9103.453792772454, 9216.539173041187, 9299.116583924517, 37677.4348384769, 44182.77908610436, 44836.9999999987, 45689.0, 45772.31341529813, 55705.44294557002, 65573.67213163903, 65666.34333656602, 66067.33932660804, 67087.0, 10705.785884282115, 11233.502133258862, 11332.0, 11514.19400641947, 11710.180287379802, 9754.414735115915, 10484.947575262075, 11404.087672985976, 11795.053816120244, 11811.763764724485, 11091.500882460146, 11607.941960290145, 11832.408379580815, 12381.938090309492, 12385.876141238472, 11758.70603234926, 11767.764644706887, 12149.757004859677, 12766.489340426278, 12788.040896932953, 11558.30650160993, 11598.768024639292, 11904.28574285511, 12021.398930053287, 12332.876671233173, 9370.672026479313, 9682.0, 9846.45844478532, 10119.898801011896, 10342.224333175192, 9059.501727404793, 9942.105210530797, 9958.651447199314, 10016.148627366756, 10041.096301332915], "value": 6432.117056623742, "unit": "score"}], "name": "dromaeo_css", "value": 6378.43693261432, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 113.0, 113.0, 112.0, 114.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 122.0, 182.0, 128.0, 129.0, 152.0, 127.0, 168.0, 126.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 163.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 117.0, 75.0, 77.0, 75.0, 76.0, 103.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 86.0, 86.0, 85.0, 126.0, 85.0, 85.0, 131.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 62.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 78.0, 82.0, 85.0, 79.0, 78.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 132.0, 130.0, 127.0, 129.0, 138.0, 134.0, 183.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 163.0, 160.0, 161.0, 160.0, 161.0, 163.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 68.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1526.4, "alertThreshold": 2.0}]} 10:28:06 INFO - Return code: 0 10:28:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:28:06 INFO - # TBPL SUCCESS # 10:28:06 INFO - Running post-action listener: _resource_record_post_action 10:28:06 INFO - [mozharness: 2016-07-20 17:28:06.414770Z] Finished run-tests step (success) 10:28:06 INFO - Running post-run listener: _resource_record_post_run 10:28:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556494848; Read time: 16; Write time: 616420 10:28:06 INFO - TinderboxPrint: CPU usage
13.0% 10:28:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:28:06 INFO - TinderboxPrint: I/O write bytes / time
556,494,848 / 616,420 10:28:06 INFO - TinderboxPrint: CPU idle
8,332.5 (87.0%) 10:28:06 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 10:28:06 INFO - TinderboxPrint: Swap in / out
0 / 0 10:28:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267788288; Read time: 0; Write time: 357940 10:28:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288706560; Read time: 0; Write time: 258480 10:28:07 INFO - Running post-run listener: _upload_blobber_files 10:28:07 INFO - Blob upload gear active. 10:28:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:08 INFO - (blobuploader) - INFO - Done attempting. 10:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:35 INFO - (blobuploader) - INFO - Done attempting. 10:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:35 INFO - (blobuploader) - INFO - Done attempting. 10:28:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:35 INFO - Return code: 0 10:28:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/380bab1bb06035b3bad62f90e7100106214f7ca5629d9ca474975e68eb4c350fa96b85cc116ddb687b65101fbb765156bab4ec208c257e20c5c40572198504ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318cb955172932a6b1e8f07a5d0fb09bd1ccee34ce1fcd4c03d52101f0a0311c9f8c54008ee2a6847e0f1458d0231d1aad62a62a7234dc5634be1b99c9e9fdd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c4442d040e1dda2e6719d76fe77deae4bc480c214c9d2f9d640a135a1fa35697c12e8c5211a874982b78e81ac38658b0b6f4a9d1563a85ff515503208a6ae3"} 10:28:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:35 INFO - Contents: 10:28:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/380bab1bb06035b3bad62f90e7100106214f7ca5629d9ca474975e68eb4c350fa96b85cc116ddb687b65101fbb765156bab4ec208c257e20c5c40572198504ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318cb955172932a6b1e8f07a5d0fb09bd1ccee34ce1fcd4c03d52101f0a0311c9f8c54008ee2a6847e0f1458d0231d1aad62a62a7234dc5634be1b99c9e9fdd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c4442d040e1dda2e6719d76fe77deae4bc480c214c9d2f9d640a135a1fa35697c12e8c5211a874982b78e81ac38658b0b6f4a9d1563a85ff515503208a6ae3"} 10:28:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:35 INFO - Copying logs to upload dir... 10:28:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.547810 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-20 10:28:35.574112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:28:35.577639) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 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/380bab1bb06035b3bad62f90e7100106214f7ca5629d9ca474975e68eb4c350fa96b85cc116ddb687b65101fbb765156bab4ec208c257e20c5c40572198504ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318cb955172932a6b1e8f07a5d0fb09bd1ccee34ce1fcd4c03d52101f0a0311c9f8c54008ee2a6847e0f1458d0231d1aad62a62a7234dc5634be1b99c9e9fdd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c4442d040e1dda2e6719d76fe77deae4bc480c214c9d2f9d640a135a1fa35697c12e8c5211a874982b78e81ac38658b0b6f4a9d1563a85ff515503208a6ae3"} build_url:https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/P-nMyXuHRFWZJ3XddmzG6A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/380bab1bb06035b3bad62f90e7100106214f7ca5629d9ca474975e68eb4c350fa96b85cc116ddb687b65101fbb765156bab4ec208c257e20c5c40572198504ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318cb955172932a6b1e8f07a5d0fb09bd1ccee34ce1fcd4c03d52101f0a0311c9f8c54008ee2a6847e0f1458d0231d1aad62a62a7234dc5634be1b99c9e9fdd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c4442d040e1dda2e6719d76fe77deae4bc480c214c9d2f9d640a135a1fa35697c12e8c5211a874982b78e81ac38658b0b6f4a9d1563a85ff515503208a6ae3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 10:28:35.603289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:28:35.603628) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469034452.509559-2005520667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 10:28:35.686224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:28:35.686560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 10:28:35.686887) ========= ========= Total master_lag: 0.15 =========