builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1469023508.45 results: success (0) buildid: 20160720043038 builduid: 16f6ca84d4a54266b12d798613f3948b revision: da701570fa3f6147f56b4d83c190da120470f560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.452343) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.452848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.453144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.468540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.468897) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 07:05:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-07-20 07:05:09 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.586939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.587478) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014705 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.638565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:08.638980) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev da701570fa3f6147f56b4d83c190da120470f560 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev da701570fa3f6147f56b4d83c190da120470f560 --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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 07:05:09,327 truncating revision to first 12 chars 2016-07-20 07:05:09,327 Setting DEBUG logging. 2016-07-20 07:05:09,327 attempt 1/10 2016-07-20 07:05:09,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/da701570fa3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 07:05:09,674 unpacking tar archive at: mozilla-inbound-da701570fa3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:09.356901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:09.357255) ========= script_repo_revision: da701570fa3f6147f56b4d83c190da120470f560 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:09.357738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:09.358027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:05:09.369380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-20 07:05:09.369900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:10 INFO - MultiFileLogger online at 20160720 07:05:10 in /builds/slave/test 07:05:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:05:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:10 INFO - {'append_to_log': False, 07:05:10 INFO - 'base_work_dir': '/builds/slave/test', 07:05:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:10 INFO - 'branch': 'Mozilla-Inbound', 07:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:10 INFO - 'config_files': ('talos/linux_config.py',), 07:05:10 INFO - 'default_actions': ('clobber', 07:05:10 INFO - 'read-buildbot-config', 07:05:10 INFO - 'download-and-extract', 07:05:10 INFO - 'populate-webroot', 07:05:10 INFO - 'create-virtualenv', 07:05:10 INFO - 'install', 07:05:10 INFO - 'run-tests'), 07:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:10 INFO - 'download_minidump_stackwalk': True, 07:05:10 INFO - 'download_symbols': 'ondemand', 07:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:10 INFO - 'installer_path': 'installer.exe', 07:05:10 INFO - 'log_level': 'info', 07:05:10 INFO - 'log_name': 'talos', 07:05:10 INFO - 'log_to_console': True, 07:05:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:10 INFO - 'opt_config_files': (), 07:05:10 INFO - 'pip_index': False, 07:05:10 INFO - 'sps_profile': False, 07:05:10 INFO - 'sps_profile_interval': 0, 07:05:10 INFO - 'suite': 'dromaeojs-e10s', 07:05:10 INFO - 'system_bits': '32', 07:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:10 INFO - 'title': 'talos-linux64-ix-067', 07:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:10 INFO - 'use_talos_json': True, 07:05:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:10 INFO - 'work_dir': 'build'} 07:05:10 INFO - [mozharness: 2016-07-20 14:05:10.143763Z] Running clobber step. 07:05:10 INFO - Running pre-action listener: _resource_record_pre_action 07:05:10 INFO - Running main action method: clobber 07:05:10 INFO - rmtree: /builds/slave/test/build 07:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:10 INFO - Running post-action listener: _resource_record_post_action 07:05:10 INFO - [mozharness: 2016-07-20 14:05:10.613786Z] Finished clobber step (success) 07:05:10 INFO - [mozharness: 2016-07-20 14:05:10.613886Z] Running read-buildbot-config step. 07:05:10 INFO - Running pre-action listener: _resource_record_pre_action 07:05:10 INFO - Running main action method: read_buildbot_config 07:05:10 INFO - Using buildbot properties: 07:05:10 INFO - { 07:05:10 INFO - "project": "", 07:05:10 INFO - "product": "firefox", 07:05:10 INFO - "script_repo_revision": "production", 07:05:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:05:10 INFO - "repository": "", 07:05:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:05:10 INFO - "buildid": "20160720043038", 07:05:10 INFO - "pgo_build": "True", 07:05:10 INFO - "basedir": "/builds/slave/test", 07:05:10 INFO - "buildnumber": 1325, 07:05:10 INFO - "slavename": "talos-linux64-ix-067", 07:05:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:05:10 INFO - "platform": "ubuntu64_hw", 07:05:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:05:10 INFO - "branch": "mozilla-inbound", 07:05:10 INFO - "repo_path": "integration/mozilla-inbound", 07:05:10 INFO - "revision": "da701570fa3f6147f56b4d83c190da120470f560", 07:05:10 INFO - "stage_platform": "linux64-pgo", 07:05:10 INFO - "builduid": "16f6ca84d4a54266b12d798613f3948b", 07:05:10 INFO - "slavebuilddir": "test" 07:05:10 INFO - } 07:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:05:10 INFO - Running post-action listener: _resource_record_post_action 07:05:10 INFO - [mozharness: 2016-07-20 14:05:10.616318Z] Finished read-buildbot-config step (success) 07:05:10 INFO - [mozharness: 2016-07-20 14:05:10.616408Z] Running download-and-extract step. 07:05:10 INFO - Running pre-action listener: _resource_record_pre_action 07:05:10 INFO - Running main action method: download_and_extract 07:05:10 INFO - mkdir: /builds/slave/test/build/tests 07:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:10 INFO - https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:16 INFO - Downloaded 1361 bytes. 07:05:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:05:16 INFO - Using the following test package requirements: 07:05:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:05:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'jsshell-linux-x86_64.zip'], 07:05:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:05:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:05:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:16 INFO - https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:28 INFO - Downloaded 24343327 bytes. 07:05:28 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'] 07:05:28 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 07:05:29 INFO - Return code: 0 07:05:29 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 07:05:29 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')]} 07:05:29 INFO - https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:31 INFO - Downloaded 24343327 bytes. 07:05:31 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'] 07:05:31 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 07:05:32 INFO - Return code: 0 07:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:32 INFO - https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:33 INFO - Downloaded 14403317 bytes. 07:05:33 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'] 07:05:33 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 07:05:33 INFO - Return code: 0 07:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:33 INFO - https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG3OmYwaQGe14f-d-zdj2A/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 07:05:35 INFO - Downloaded 60903122 bytes. 07:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:05:35 INFO - mkdir: /builds/slave/test/properties 07:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:35 INFO - Contents: 07:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:05:35 INFO - Running post-action listener: _resource_record_post_action 07:05:35 INFO - Running post-action listener: set_extra_try_arguments 07:05:35 INFO - [mozharness: 2016-07-20 14:05:35.955889Z] Finished download-and-extract step (success) 07:05:35 INFO - [mozharness: 2016-07-20 14:05:35.956121Z] Running populate-webroot step. 07:05:35 INFO - Running pre-action listener: _resource_record_pre_action 07:05:35 INFO - Running main action method: populate_webroot 07:05:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:35 INFO - '--tppagecycles', 07:05:35 INFO - '7'], 07:05:35 INFO - 'tests': ['tsvgm']}}, 07:05:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['damp', 'tps']}, 07:05:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'tests': ['damp', 'tps']}, 07:05:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['dromaeo_dom']}, 07:05:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['basic_compositor_video']}, 07:05:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['a11yr', 07:05:35 INFO - 'ts_paint', 07:05:35 INFO - 'tpaint', 07:05:35 INFO - 'sessionrestore', 07:05:35 INFO - 'sessionrestore_no_auto_restore', 07:05:35 INFO - 'tabpaint']}, 07:05:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['tsvgx', 07:05:35 INFO - 'tsvgr_opacity', 07:05:35 INFO - 'tart', 07:05:35 INFO - 'tscrollx', 07:05:35 INFO - 'cart']}, 07:05:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:35 INFO - 'tsvgr_opacity', 07:05:35 INFO - 'tart', 07:05:35 INFO - 'tscrollx', 07:05:35 INFO - 'cart']}, 07:05:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'talos_options': ['--disable-e10s'], 07:05:35 INFO - 'tests': ['tp5o']}, 07:05:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'tests': ['tp5o']}, 07:05:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'talos_options': ['--disable-e10s', 07:05:35 INFO - '--xperf_path', 07:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:35 INFO - 'tests': ['tp5n']}, 07:05:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:35 INFO - 'talos_options': ['--xperf_path', 07:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:35 INFO - 'tests': ['tp5n']}}, 07:05:35 INFO - 'talos.zip': {'path': '', 07:05:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:35 INFO - Running post-action listener: _resource_record_post_action 07:05:35 INFO - [mozharness: 2016-07-20 14:05:35.974015Z] Finished populate-webroot step (success) 07:05:35 INFO - [mozharness: 2016-07-20 14:05:35.974103Z] Running create-virtualenv step. 07:05:35 INFO - Running pre-action listener: _resource_record_pre_action 07:05:35 INFO - Running main action method: create_virtualenv 07:05:35 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:35 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 07:05:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:36 INFO - Using real prefix '/usr' 07:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:38 INFO - Installing pip.................done. 07:05:38 INFO - Return code: 0 07:05:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:38 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:38 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 07:05:38 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 07:05:38 INFO - Using env: {'DISPLAY': ':0', 07:05:38 INFO - 'HOME': '/home/cltbld', 07:05:38 INFO - 'LANG': 'en_US.UTF-8', 07:05:38 INFO - 'LANGUAGE': 'en_US:en', 07:05:38 INFO - 'LOGNAME': 'cltbld', 07:05:38 INFO - 'MAIL': '/var/mail/cltbld', 07:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:38 INFO - 'MOZ_NO_REMOTE': '1', 07:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:38 INFO - 'NO_EM_RESTART': '1', 07:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:38 INFO - 'PWD': '/builds/slave/test', 07:05:38 INFO - 'SHELL': '/bin/bash', 07:05:38 INFO - 'SHLVL': '1', 07:05:38 INFO - 'TERM': 'linux', 07:05:38 INFO - 'TMOUT': '86400', 07:05:38 INFO - 'USER': 'cltbld', 07:05:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:38 INFO - '_': '/tools/buildbot/bin/python'} 07:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:38 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 07:05:38 INFO - Cleaning up... 07:05:38 INFO - Return code: 0 07:05:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:38 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:38 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 07:05:38 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 07:05:38 INFO - Using env: {'DISPLAY': ':0', 07:05:38 INFO - 'HOME': '/home/cltbld', 07:05:38 INFO - 'LANG': 'en_US.UTF-8', 07:05:38 INFO - 'LANGUAGE': 'en_US:en', 07:05:38 INFO - 'LOGNAME': 'cltbld', 07:05:38 INFO - 'MAIL': '/var/mail/cltbld', 07:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:38 INFO - 'MOZ_NO_REMOTE': '1', 07:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:38 INFO - 'NO_EM_RESTART': '1', 07:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:38 INFO - 'PWD': '/builds/slave/test', 07:05:38 INFO - 'SHELL': '/bin/bash', 07:05:38 INFO - 'SHLVL': '1', 07:05:38 INFO - 'TERM': 'linux', 07:05:38 INFO - 'TMOUT': '86400', 07:05:38 INFO - 'USER': 'cltbld', 07:05:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:38 INFO - '_': '/tools/buildbot/bin/python'} 07:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:38 INFO - Downloading/unpacking psutil>=3.1.1 07:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:41 INFO - Installing collected packages: psutil 07:05:41 INFO - Running setup.py install for psutil 07:05:41 INFO - building 'psutil._psutil_linux' extension 07:05:41 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 07:05:41 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 07:05:41 INFO - building 'psutil._psutil_posix' extension 07:05:41 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 07:05:41 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 07:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:41 INFO - Successfully installed psutil 07:05:41 INFO - Cleaning up... 07:05:41 INFO - Return code: 0 07:05:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:41 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:41 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 07:05:41 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 07:05:41 INFO - Using env: {'DISPLAY': ':0', 07:05:41 INFO - 'HOME': '/home/cltbld', 07:05:41 INFO - 'LANG': 'en_US.UTF-8', 07:05:41 INFO - 'LANGUAGE': 'en_US:en', 07:05:41 INFO - 'LOGNAME': 'cltbld', 07:05:41 INFO - 'MAIL': '/var/mail/cltbld', 07:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:41 INFO - 'MOZ_NO_REMOTE': '1', 07:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:41 INFO - 'NO_EM_RESTART': '1', 07:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:41 INFO - 'PWD': '/builds/slave/test', 07:05:41 INFO - 'SHELL': '/bin/bash', 07:05:41 INFO - 'SHLVL': '1', 07:05:41 INFO - 'TERM': 'linux', 07:05:41 INFO - 'TMOUT': '86400', 07:05:41 INFO - 'USER': 'cltbld', 07:05:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:41 INFO - '_': '/tools/buildbot/bin/python'} 07:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:05:43 INFO - Installing collected packages: mozsystemmonitor 07:05:43 INFO - Running setup.py install for mozsystemmonitor 07:05:43 INFO - Successfully installed mozsystemmonitor 07:05:43 INFO - Cleaning up... 07:05:43 INFO - Return code: 0 07:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:43 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:43 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 07:05:43 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 07:05:43 INFO - Using env: {'DISPLAY': ':0', 07:05:43 INFO - 'HOME': '/home/cltbld', 07:05:43 INFO - 'LANG': 'en_US.UTF-8', 07:05:43 INFO - 'LANGUAGE': 'en_US:en', 07:05:43 INFO - 'LOGNAME': 'cltbld', 07:05:43 INFO - 'MAIL': '/var/mail/cltbld', 07:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:43 INFO - 'MOZ_NO_REMOTE': '1', 07:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:43 INFO - 'NO_EM_RESTART': '1', 07:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:43 INFO - 'PWD': '/builds/slave/test', 07:05:43 INFO - 'SHELL': '/bin/bash', 07:05:43 INFO - 'SHLVL': '1', 07:05:43 INFO - 'TERM': 'linux', 07:05:43 INFO - 'TMOUT': '86400', 07:05:43 INFO - 'USER': 'cltbld', 07:05:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:43 INFO - '_': '/tools/buildbot/bin/python'} 07:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:05:45 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 07:05:45 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 07:05:45 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 07:05:45 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 07:05:45 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 07:05:45 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 07:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:46 INFO - warning: no files found matching '*.txt' 07:05:46 INFO - no previously-included directories found matching 'build' 07:05:46 INFO - no previously-included directories found matching 'dist' 07:05:46 INFO - no previously-included directories found matching '.git*' 07:05:46 INFO - Installing collected packages: jsonschema, functools32 07:05:46 INFO - Running setup.py install for functools32 07:05:46 INFO - warning: no files found matching '*.txt' 07:05:46 INFO - no previously-included directories found matching 'build' 07:05:46 INFO - no previously-included directories found matching 'dist' 07:05:46 INFO - no previously-included directories found matching '.git*' 07:05:46 INFO - Successfully installed jsonschema functools32 07:05:46 INFO - Cleaning up... 07:05:46 INFO - Return code: 0 07:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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', '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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:05: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 blobuploader==1.2.4 07:05:46 INFO - Using env: {'DISPLAY': ':0', 07:05:46 INFO - 'HOME': '/home/cltbld', 07:05:46 INFO - 'LANG': 'en_US.UTF-8', 07:05:46 INFO - 'LANGUAGE': 'en_US:en', 07:05:46 INFO - 'LOGNAME': 'cltbld', 07:05:46 INFO - 'MAIL': '/var/mail/cltbld', 07:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:46 INFO - 'MOZ_NO_REMOTE': '1', 07:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:46 INFO - 'NO_EM_RESTART': '1', 07:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:46 INFO - 'PWD': '/builds/slave/test', 07:05:46 INFO - 'SHELL': '/bin/bash', 07:05:46 INFO - 'SHLVL': '1', 07:05:46 INFO - 'TERM': 'linux', 07:05:46 INFO - 'TMOUT': '86400', 07:05:46 INFO - 'USER': 'cltbld', 07:05:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:46 INFO - '_': '/tools/buildbot/bin/python'} 07:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:05:46 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 07:05:46 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 07:05:46 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 07:05:46 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 07:05:46 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 07:05:46 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 07:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:05:48 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 07:05:48 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 07:05:48 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 07:05:48 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 07:05:48 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 07:05:48 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 07:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:05:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:49 INFO - Downloading docopt-0.6.1.tar.gz 07:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:05:49 INFO - Running setup.py install for blobuploader 07:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:05:49 INFO - Running setup.py install for requests 07:05:50 INFO - Running setup.py install for docopt 07:05:50 INFO - Successfully installed blobuploader requests docopt 07:05:50 INFO - Cleaning up... 07:05:50 INFO - Return code: 0 07:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:50 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')]} 07:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:50 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')]} 07:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:50 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:50 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 07:05:50 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 07:05:50 INFO - Using env: {'DISPLAY': ':0', 07:05:50 INFO - 'HOME': '/home/cltbld', 07:05:50 INFO - 'LANG': 'en_US.UTF-8', 07:05:50 INFO - 'LANGUAGE': 'en_US:en', 07:05:50 INFO - 'LOGNAME': 'cltbld', 07:05:50 INFO - 'MAIL': '/var/mail/cltbld', 07:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:50 INFO - 'MOZ_NO_REMOTE': '1', 07:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:50 INFO - 'NO_EM_RESTART': '1', 07:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:50 INFO - 'PWD': '/builds/slave/test', 07:05:50 INFO - 'SHELL': '/bin/bash', 07:05:50 INFO - 'SHLVL': '1', 07:05:50 INFO - 'TERM': 'linux', 07:05:50 INFO - 'TMOUT': '86400', 07:05:50 INFO - 'USER': 'cltbld', 07:05:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:50 INFO - '_': '/tools/buildbot/bin/python'} 07:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:50 INFO - Running setup.py (path:/tmp/pip-Ppn2Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:50 INFO - Running setup.py (path:/tmp/pip-1BabwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:50 INFO - Running setup.py (path:/tmp/pip-Xs4I3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:50 INFO - Running setup.py (path:/tmp/pip-2h0x7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:50 INFO - Running setup.py (path:/tmp/pip-joQA12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:50 INFO - Running setup.py (path:/tmp/pip-9aOhMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:50 INFO - Running setup.py (path:/tmp/pip-_b47A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:50 INFO - Running setup.py (path:/tmp/pip-xvOyhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:50 INFO - Running setup.py (path:/tmp/pip-nD1Kdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:51 INFO - Running setup.py (path:/tmp/pip-FgH_3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:51 INFO - Running setup.py (path:/tmp/pip-5rf8B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:51 INFO - Running setup.py (path:/tmp/pip-2A_R1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:51 INFO - Running setup.py (path:/tmp/pip-Ph43dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:51 INFO - Running setup.py (path:/tmp/pip-FEAfSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:51 INFO - Running setup.py (path:/tmp/pip-zVwcan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:51 INFO - Running setup.py (path:/tmp/pip-a9T9X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:51 INFO - Running setup.py (path:/tmp/pip-nqKe4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:05:51 INFO - Running setup.py install for manifestparser 07:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:05:51 INFO - Running setup.py install for mozcrash 07:05:51 INFO - Running setup.py install for mozdebug 07:05:51 INFO - Running setup.py install for mozdevice 07:05:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozfile 07:05:52 INFO - Running setup.py install for mozhttpd 07:05:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozinfo 07:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozInstall 07:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozleak 07:05:52 INFO - Running setup.py install for mozlog 07:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for moznetwork 07:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozprocess 07:05:52 INFO - Running setup.py install for mozprofile 07:05:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:05:52 INFO - Running setup.py install for mozrunner 07:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:05:53 INFO - Running setup.py install for mozscreenshot 07:05:53 INFO - Running setup.py install for moztest 07:05:53 INFO - Running setup.py install for mozversion 07:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:05:53 INFO - Cleaning up... 07:05:53 INFO - Return code: 0 07:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:53 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:53 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 07:05:53 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 07:05:53 INFO - Using env: {'DISPLAY': ':0', 07:05:53 INFO - 'HOME': '/home/cltbld', 07:05:53 INFO - 'LANG': 'en_US.UTF-8', 07:05:53 INFO - 'LANGUAGE': 'en_US:en', 07:05:53 INFO - 'LOGNAME': 'cltbld', 07:05:53 INFO - 'MAIL': '/var/mail/cltbld', 07:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:53 INFO - 'MOZ_NO_REMOTE': '1', 07:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:53 INFO - 'NO_EM_RESTART': '1', 07:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:53 INFO - 'PWD': '/builds/slave/test', 07:05:53 INFO - 'SHELL': '/bin/bash', 07:05:53 INFO - 'SHLVL': '1', 07:05:53 INFO - 'TERM': 'linux', 07:05:53 INFO - 'TMOUT': '86400', 07:05:53 INFO - 'USER': 'cltbld', 07:05:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:53 INFO - '_': '/tools/buildbot/bin/python'} 07:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:53 INFO - Running setup.py (path:/tmp/pip-RuvPiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:53 INFO - Running setup.py (path:/tmp/pip-naAup5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:53 INFO - Running setup.py (path:/tmp/pip-ZuO0E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:53 INFO - Running setup.py (path:/tmp/pip-rjQLl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:53 INFO - Running setup.py (path:/tmp/pip-GobLHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:53 INFO - Running setup.py (path:/tmp/pip-M2KNZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:54 INFO - Running setup.py (path:/tmp/pip-t7T9cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:54 INFO - Running setup.py (path:/tmp/pip-8kg87n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:54 INFO - Running setup.py (path:/tmp/pip-l0Csyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:54 INFO - Running setup.py (path:/tmp/pip-SdGugx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:54 INFO - Running setup.py (path:/tmp/pip-gasQxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:54 INFO - Running setup.py (path:/tmp/pip-z58qrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:54 INFO - Running setup.py (path:/tmp/pip-Cw4STe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:54 INFO - Running setup.py (path:/tmp/pip-lXdiQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:54 INFO - Running setup.py (path:/tmp/pip-b9dD69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:54 INFO - Running setup.py (path:/tmp/pip-lvk5aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:54 INFO - Running setup.py (path:/tmp/pip-g8fOkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:56 INFO - Downloading blessings-1.6.tar.gz 07:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:05:56 INFO - Installing collected packages: blessings 07:05:56 INFO - Running setup.py install for blessings 07:05:56 INFO - Successfully installed blessings 07:05:56 INFO - Cleaning up... 07:05:57 INFO - Return code: 0 07:05:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:57 INFO - Reading from file tmpfile_stdout 07:05:57 INFO - Current package versions: 07:05:57 INFO - argparse == 1.2.1 07:05:57 INFO - blessings == 1.6 07:05:57 INFO - blobuploader == 1.2.4 07:05:57 INFO - docopt == 0.6.1 07:05:57 INFO - functools32 == 3.2.3-2 07:05:57 INFO - jsonschema == 2.5.1 07:05:57 INFO - manifestparser == 1.1 07:05:57 INFO - mozInstall == 1.12 07:05:57 INFO - mozcrash == 0.17 07:05:57 INFO - mozdebug == 0.1 07:05:57 INFO - mozdevice == 0.48 07:05:57 INFO - mozfile == 1.2 07:05:57 INFO - mozhttpd == 0.7 07:05:57 INFO - mozinfo == 0.9 07:05:57 INFO - mozleak == 0.1 07:05:57 INFO - mozlog == 3.3 07:05:57 INFO - moznetwork == 0.27 07:05:57 INFO - mozprocess == 0.23 07:05:57 INFO - mozprofile == 0.28 07:05:57 INFO - mozrunner == 6.12 07:05:57 INFO - mozscreenshot == 0.1 07:05:57 INFO - mozsystemmonitor == 0.3 07:05:57 INFO - moztest == 0.7 07:05:57 INFO - mozversion == 1.4 07:05:57 INFO - psutil == 3.1.1 07:05:57 INFO - requests == 1.2.3 07:05:57 INFO - wsgiref == 0.1.2 07:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:57 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 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:57 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 07:05:57 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 07:05:57 INFO - Using env: {'DISPLAY': ':0', 07:05:57 INFO - 'HOME': '/home/cltbld', 07:05:57 INFO - 'LANG': 'en_US.UTF-8', 07:05:57 INFO - 'LANGUAGE': 'en_US:en', 07:05:57 INFO - 'LOGNAME': 'cltbld', 07:05:57 INFO - 'MAIL': '/var/mail/cltbld', 07:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:57 INFO - 'MOZ_NO_REMOTE': '1', 07:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:57 INFO - 'NO_EM_RESTART': '1', 07:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:57 INFO - 'PWD': '/builds/slave/test', 07:05:57 INFO - 'SHELL': '/bin/bash', 07:05:57 INFO - 'SHLVL': '1', 07:05:57 INFO - 'TERM': 'linux', 07:05:57 INFO - 'TMOUT': '86400', 07:05:57 INFO - 'USER': 'cltbld', 07:05:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:57 INFO - '_': '/tools/buildbot/bin/python'} 07:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 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)) 07:05:57 INFO - Cleaning up... 07:05:57 INFO - Return code: 0 07:05:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb38030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', '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 07:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:05:57 INFO - Using env: {'DISPLAY': ':0', 07:05:57 INFO - 'HOME': '/home/cltbld', 07:05:57 INFO - 'LANG': 'en_US.UTF-8', 07:05:57 INFO - 'LANGUAGE': 'en_US:en', 07:05:57 INFO - 'LOGNAME': 'cltbld', 07:05:57 INFO - 'MAIL': '/var/mail/cltbld', 07:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:57 INFO - 'MOZ_NO_REMOTE': '1', 07:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:57 INFO - 'NO_EM_RESTART': '1', 07:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:57 INFO - 'PWD': '/builds/slave/test', 07:05:57 INFO - 'SHELL': '/bin/bash', 07:05:57 INFO - 'SHLVL': '1', 07:05:57 INFO - 'TERM': 'linux', 07:05:57 INFO - 'TMOUT': '86400', 07:05:57 INFO - 'USER': 'cltbld', 07:05:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:57 INFO - '_': '/tools/buildbot/bin/python'} 07:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:05:57 INFO - Cleaning up... 07:05:57 INFO - Return code: 0 07:05:57 INFO - Running post-action listener: _resource_record_post_action 07:05:57 INFO - Running post-action listener: _start_resource_monitoring 07:05:57 INFO - Starting resource monitoring. 07:05:57 INFO - [mozharness: 2016-07-20 14:05:57.732026Z] Finished create-virtualenv step (success) 07:05:57 INFO - [mozharness: 2016-07-20 14:05:57.732506Z] Running install step. 07:05:57 INFO - Running pre-action listener: _resource_record_pre_action 07:05:57 INFO - Running main action method: install 07:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:57 INFO - Reading from file tmpfile_stdout 07:05:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:05:58 INFO - Reading from file tmpfile_stdout 07:05:58 INFO - Output received: 07:05:58 INFO - Usage: mozinstall [options] installer 07:05:58 INFO - Options: 07:05:58 INFO - -h, --help show this help message and exit 07:05:58 INFO - -d DEST, --destination=DEST 07:05:58 INFO - Directory to install application into. [default: 07:05:58 INFO - "/builds/slave/test"] 07:05:58 INFO - --app=APP Application being installed. [default: firefox] 07:05:58 INFO - mkdir: /builds/slave/test/build/application 07:05:58 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'] 07:05:58 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 07:06:15 INFO - Reading from file tmpfile_stdout 07:06:15 INFO - Output received: 07:06:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:15 INFO - Running post-action listener: _resource_record_post_action 07:06:15 INFO - [mozharness: 2016-07-20 14:06:15.330081Z] Finished install step (success) 07:06:15 INFO - [mozharness: 2016-07-20 14:06:15.330360Z] Running run-tests step. 07:06:15 INFO - Running pre-action listener: _resource_record_pre_action 07:06:15 INFO - Running main action method: run_tests 07:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:15 INFO - Python 2.7.3 07:06:15 INFO - Return code: 0 07:06:15 INFO - grabbing minidump binary from tooltool 07:06:15 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')]} 07:06:15 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 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:15 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 07:06:15 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 07:06:15 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 07:06:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:15 INFO - Return code: 0 07:06:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:06:15 INFO - Using env: {'DISPLAY': ':0', 07:06:15 INFO - 'HOME': '/home/cltbld', 07:06:15 INFO - 'LANG': 'en_US.UTF-8', 07:06:15 INFO - 'LANGUAGE': 'en_US:en', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MAIL': '/var/mail/cltbld', 07:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SHLVL': '1', 07:06:15 INFO - 'TERM': 'linux', 07:06:15 INFO - 'TMOUT': '86400', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - '_': '/tools/buildbot/bin/python'} 07:06:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:06:15 INFO - mozversion application_buildid: 20160720043038 07:06:15 INFO - mozversion application_changeset: da701570fa3f6147f56b4d83c190da120470f560 07:06:15 INFO - mozversion application_display_name: Nightly 07:06:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:15 INFO - mozversion application_name: Firefox 07:06:15 INFO - mozversion application_remotingname: firefox 07:06:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:06:15 INFO - mozversion application_vendor: Mozilla 07:06:15 INFO - mozversion application_version: 50.0a1 07:06:15 INFO - mozversion platform_buildid: 20160720043038 07:06:15 INFO - mozversion platform_changeset: da701570fa3f6147f56b4d83c190da120470f560 07:06:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:06:15 INFO - mozversion platform_version: 50.0a1 07:06:15 INFO - using testdate: 1469023575 07:06:15 INFO - actual date: 1469023575 07:06:15 INFO - starting webserver on 'localhost:57472' 07:06:15 INFO - SUITE-START | Running 2 tests 07:06:15 INFO - TEST-START | dromaeo_css 07:06:15 INFO - operating with platform_type : linux_ 07:06:15 INFO - Initialising browser for dromaeo_css test... 07:06:15 INFO - TEST-INFO | started process 23903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjjiWB/profile http://localhost:57472/getInfo.html) 07:06:19 INFO - PROCESS | 23903 | __metrics Screen width/height:1600/1200 07:06:19 INFO - PROCESS | 23903 | colorDepth:24 07:06:19 INFO - PROCESS | 23903 | Browser inner width/height: 1024/697 07:06:19 INFO - PROCESS | 23903 | __metrics 07:06:20 ERROR - PROCESS | 23903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:06:21 INFO - TEST-INFO | 23903: exit 0 07:06:21 INFO - Browser initialized. 07:06:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:21 INFO - TEST-INFO | started process 24027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjjiWB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:32 INFO - PROCESS | 24027 | RSS: Main: 167587840 07:06:32 INFO - PROCESS | 24027 | 07:07:22 INFO - PROCESS | 24027 | 1469023642605 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] 07:09:31 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57472/tests/dromaeo/cssquery-ext.html) 07:09:32 INFO - PROCESS | 24027 | RSS: Main: 172593152 07:09:32 INFO - PROCESS | 24027 | 07:12:34 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-ext.html (next: http://localhost:57472/tests/dromaeo/cssquery-jquery.html) 07:12:35 INFO - PROCESS | 24027 | RSS: Main: 169889792 07:12:35 INFO - PROCESS | 24027 | 07:15:37 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57472/tests/dromaeo/cssquery-mootools.html) 07:15:37 INFO - PROCESS | 24027 | RSS: Main: 173244416 07:15:37 INFO - PROCESS | 24027 | 07:18:39 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57472/tests/dromaeo/cssquery-prototype.html) 07:18:40 INFO - PROCESS | 24027 | RSS: Main: 168022016 07:18:40 INFO - PROCESS | 24027 | 07:21:42 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57472/tests/dromaeo/cssquery-yui.html) 07:21:43 INFO - PROCESS | 24027 | RSS: Main: 170287104 07:21:43 INFO - PROCESS | 24027 | 07:24:45 INFO - PROCESS | 24027 | Cycle 1(1): loaded http://localhost:57472/tests/dromaeo/cssquery-yui.html (next: http://localhost:57472/tests/dromaeo/cssquery-dojo.html) 07:24:46 INFO - PROCESS | 24027 | RSS: Main: 170840064 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | __start_tp_report 07:24:46 INFO - PROCESS | 24027 | _x_x_mozilla_page_load 07:24:46 INFO - PROCESS | 24027 | _x_x_mozilla_page_load_details 07:24:46 INFO - PROCESS | 24027 | |i|pagename|runs| 07:24:46 INFO - PROCESS | 24027 | |0;dojo.html;3100.6899310068998;3102.782805203636;3118.73490753286;3137.4509460844347;3141.37172565487;5534.003879301724;5575.0522411190095;5603.60774745768;5616.719164041791;5620.887582248358;5381.219723140152;5473.124300111983;5540.63985840921;5583.58123140764;5630.014747419205;5012.072766538193;5047.192449208127;5116.771974726057;5162.845114646567;5192.766325515342;5075.847724568269;5223.895522089575;5225.764840582183;5229.712365819878;5253.86865328366;4993.251012348141;5030.798768049273;5036;5038.924416133761;5056.191009438472;5103.719295438749;5111.488851114896;5111.642185047048;5118.564921981636;5142.974285128588;5052.191649336089;5063.468335824722;5076.695398276078;5104.540591346759;5128.512791284822;5359.410464848864;5409.43200963897;5493.505584497414;5534.972325138348;5575.052241118979;5928.7628494860155;5934.910976335358;5940.970295148497;5945.464908158287;5982.312034116088;5895.970520147414;5966.373530779249;5976.462118409364;5983.58114931955;5988.700564971778;5455.09990851513;5478.04134276504;5485.122380419114;5506.779728810883;5539.861503462445;6008.519318454513;6030.547708921848;6055.878882422415;6060.2727672678675;6105.9694701526205;5822.621529600562;5836.737346819404;5837.387074357216;5840.620359676607;5842.298924129132;5777.2200752897825;5906.734196961061;5914.8817023659285;5926.288845338587;5982.73077711504;5645.576581756302;5813;5845.269341332333;5888.175655408247;5979.073243647242;5875.823725288248;5925.555583331267;5932.110183472513;5943.613665111754;5946.1972633693895;4404.493483249404;4499.10017996402;4501.347304640809;4507.549245075466;4550.863474095782;3977.463042489227;3982.4424580558743;4004.3192657248337;4012;4059.0258337999257;5661.122526008476;5706.42935706426;5723.313202415654;5725.5133313667975;5732.742026608813;5860.238169037998;6012.729427175787;6014.548908831767;6019.067044608093;6023.216981792427;5619.522340601095;5676.375598684142;5682.801101961411;5719.456651618089;5768.163616275617;5028.220625802934;5071.8985620287385;5090.796368145233;5108.361454818148;5111.207762796773;5939.316978547436;6133.417325354173;6144.047672610753;6144.692765361714;6167.136600875881;5914.556408269483;5961.910571341346;5975.133605627073;5999.4900433463645;6056.242969628796;6180.412860778219;6184.876302474016;6186.536009799193;6188.938110618837;6190.1952746142715;5747;5853.736581853742;5893.6463812171405;5895.02732049207;5898.734556944862;5857.560682948882;5875.030619947661;5884.911726324023;5928;5971.880562388641;5806.65160090396;5821.505172060422;5829.883402332014;5845.064789633639;5868.794592189253;5679.9432005681065;5791.739371728367;5804.622699524517;5811.418858114154;5815.563832712479;5665.66006039639;5770.336411312753;5776.566757493289;5820.679862607597;5832.387599302012;5793.102069179284;5897.498712609477;5922.644641321534;5936.643801371932;5937.910931335947;5481.150421684645;5610.579206559442;5774.8845023098465;5777.826665200051;5785.595008349375 07:24:46 INFO - PROCESS | 24027 | |1;ext.html;555.8377909930372;600;603.0682595390122;610.1183789424281;617.0066193428579;41829.58170418295;43039.56960430395;43082.784586077025;43110.353344699855;45932.77033614827;43812.3428148578;44260.55739442613;44274.778626106825;44482;44587.33119003218;8768.254698350647;8900.910990890074;8931.50876701781;8946.686865959693;8957.328200384965;8876.955615221947;8933.731988040368;8992.77518062047;8997.370184087116;8998.280137588978;9030.413023153475;9052.321075919299;9067.773305667346;9070.501122438263;9092.909070909272;8949.955250223707;8960.820783584324;9009.549522523881;9016.954915225448;9022.729318120433;8867.911320886773;8902.109789021046;8928.973168085688;8931.73204803857;8937.955310223408;41999.580004199874;42477;42550.78724606388;42577.148457030686;42675;3564.055525285801;3569.5181150544863;3583.6774690278;3656.725745569093;3768.6231376862092;32231.677683223337;32791.344173116646;32915.50626740601;33091;34076.659233407845;4390.604845563915;4393.290827271733;4468.19572476954;4483.417155769762;4601.240795268776;360205;360413;360727;361540.19229903945;361640;56953.71523142358;57236.42763572394;57338.42661573414;57468.42531574631;57646;58545;58568;58878.41121588815;59234.70382648059;59606;15268.465603703817;15864.206789660471;16053.03681779097;16178.676426471404;16248.187590620422;11948;12047.518099276105;12068.456919438646;12073.637790866289;12136.817947730791;19012.334568290044;19126.904365478364;19171.32900348481;19291.4212573623;19497.610047798964;6799.838075295012;7182.138143422822;7324.597147156957;7326.890096648554;7428.2571742825285;983.233078199006;1101.5483651702764;1127.9960834856984;1131.4512461456188;1146.4210573660248;32735.83632081872;33090.33819323648;33127.66872331294;33127.83436082852;33476.49785253223;1127.413744852672;1150.6087930103804;1174.5654107980101;1216.6410908781932;1217.6347095871204;17215.56961075958;17331.56671083233;17536;17543.824561754474;17603.911980440273;600461;602279;611987;612129;613047;57539;58004.70997644985;58269.4173058264;58278.125828112614;58308.41691583115;1341.7584834729842;1347.238810072306;1374.8212732344732;1388.0838646493266;1398.2798858587835;30877.69122308748;32479.675203247665;32934.50598241076;33087.33825323432;33311;49679;50173.24740128828;50359;50361;50398;456151;456504.6097234044;456774;457269;459801;27966.44067118687;28231.15306540807;28318.43363132767;28320.71679283181;28400;47840.521594783604;47888;48176.27735583899;49361.25958110703;49460.75269623629;40211;41765.79117104395;42356.57643423649;42456.575434245264;42925.78537107419;40960;41975;42857;44361;44867.775661121486;42226.577734222265;42704.786476068664;42855.142897142505;43088.569114308455;44945.775271123435;29668.554971675872;32952.176195595304;33998.150046249044;34071.148221294665;34201.65798341985;28850.27874303075;28861.950317229388;28916.855415722788;29090.7090929088;29167 07:24:46 INFO - PROCESS | 24027 | |2;jquery.html;377.6167190301844;379.81416945478765;393.578870608449;400.92382447335007;414.63097842919785;18487.722684159733;19926.10332535036;20019.099140538674;20169.49576260594;20223.59552808943;19170.137343819526;19332.420027399166;19624.607507849836;19720;19729.901350493226;5616.9157462638095;5705.515031222351;5713.085906255;5742;5787.045137552299;5511.338639363282;5584.441555844423;5641.943580564182;5645.858853528674;5658.519025882805;5573.760694827649;5629.7185140743;5666.5183459406;5668.971655141719;5684.204211410406;5558.44415558441;5571.582131340166;5668.206451096829;5699.430056994309;5706.600537962344;4879.756012199411;4954.653174277802;4982.701037937699;4990.750462476898;5000.374953130859;23368.532629347486;23759.287221383387;23827.285181444586;23921.52156956851;24067.759322406728;2297.5060362022245;2477.962830557543;2525.343410713228;2808.311963568918;2998.8500574971163;14353.354099065567;14633.268336583129;14885.553433396906;15194.392224311014;15450.1502417367;1923.8460923126256;1964.499052741556;1984.2955750708436;1996.930107446247;2037.8267847233003;78295.60852195759;79233;80349.19650803534;80821.59589202075;80980.59509702414;10593.523291451904;10599.364038157735;10660.520276587573;10738.248322617343;11237.438128093563;14877.47928822486;14898.702025959637;14952.551423457313;14954.401823927139;14994.70010599782;7394.667239974214;7736;7813.570253635991;7865;7935.127136015034;7183.568985860865;7310.013148224922;7338.77983660491;7457.2542745724995;7515.473916825879;6205.627662340274;6352.078948552434;6377;6529.183852018497;6613.801585952333;1922.5385907382408;1936.1771247219874;1954.4625228062112;1955.2654430038558;2040.5306779440812;987.4322264697828;1037.4294138223947;1053.4311471805293;1067.4075887882145;1068.871735391758;20003.799962000194;20448.284310049075;20772.376828695164;20793;20887;1002.8395456726888;1045.6183493025144;1046.4819914142397;1073.4793625091825;1127.1658972360558;9904.306698531178;11166.888331116585;11193.72015699614;11252.718682033015;11254.324740515594;386407;389493;389544;499376;501890;57619;96980.51509742548;100146.4992675032;100873;104915.95084049062;1007.9344842585208;1008.1078245752561;1061.6072053340158;1066.088494337346;1068.2362111090608;17179.656406872044;17818.643627127643;17910.462686119437;18233.635327293116;18472;41367.37948930829;43306;43895;44527.77736111299;44683.329750053126;57154.42845571491;59880;60546.09180862379;60875.39124608697;62043.069353958825;7315.231900650355;7676.193999630182;7736.097645859835;7861.331786798186;8053.557054362066;13714.24571648569;13926.860731392557;13939.721205576034;13981.44074237019;14014.649633759238;5551.9722401387735;10304.484775761332;10348;10348.482575871327;10601.893981060091;10618.469076545987;10870.45647717595;11421.828672569753;11681.649550513499;11906.583269585522;10859.511321990687;11114.499847507042;11115.166362523005;11400.486978086172;11535.538578456768;6981.301869812978;7128.322809333105;7170.89243661356;8090.757277281691;8338;9865.506724663595;10127.848082278624;10378.42918639482;10386;10771.353718776898 07:24:46 INFO - PROCESS | 24027 | |3;mootools.html;1495.925203739813;1522.3606085444114;1680.2777153417753;1828.7165489349156;1828.7439758433813;8003.919960800405;8659.350548708848;8818.86771698425;9214.585343659535;9221.58502867371;8864.601092950817;9059.773505662362;9123.817523649523;9133.269338452925;9156.58795354209;2385.0698227691173;2418.3591348292716;2426.502566973775;2429.210506585358;2431.209856796548;2348.765123487646;2358.1864256831363;2383.642453631952;2412.589859723851;2420.056178090546;2369.07606033647;2372.2645979746335;2388.773066558674;2403.67550380699;2406.4826062396583;2289.370423133635;2290.702208712865;2308.6306191009444;2316.0041182291607;2344.941376465585;2245.6406974884103;2250.81993440526;2269.6822444857735;2279.7036385269807;2280.4754906371627;9110.908890911072;9221.400608960463;9258.398204116711;9261.120193581599;9293.395929264643;5446.346438427375;5546.084895992157;5573.916391254134;5591.552675785927;5602.299712535933;3484.8257587120797;3567.983124809417;3590.533230680021;3641.9817900910325;3643.908902277438;1005.7737009172951;1007.1288335589735;1095.2606990281529;1101.1851230089756;1114.6990312615549;12754.936225318907;12757;12842.550510732079;12853.67865803353;12860.099793014399;4583.083383323348;4677.602403795648;4819.807207711722;4819.879503012453;4829.541193586604;10115.089641932262;10123.797524049478;10123.898761012442;10141.898581014242;10142.239332050125;5535.252740880011;5550.139728342114;5553.583481238923;5555.583331250092;5556.666600004012;4529.38853254813;4886.706797592155;4977.576905962961;4990.101781679333;5142.897142057138;3711.183539621279;3846.442265871433;3883.203943191639;3960.6039396060164;3964.385520244367;1163.7148898519918;1168.8129899216085;1176.1061593189238;1180.3626041937257;1185.531714972581;980.9852852207223;1011.6610935336745;1015.4009134610615;1016.207358260558;1021.3259248895694;6101.786437474667;6284.214473190851;6286.559940804192;6299.181106456132;6446.806595802133;1051.4690081508788;1079.1366906474946;1088.1403691084113;1120.1990576737671;1124.4995976790249;4260.382244574519;4421.40311058003;4463.5759602838325;4574.954250457519;4612.123696497655;11025.889741102646;11552.480138393792;11566.768664626661;11593.826092608617;11603.187776855708;10623.84064239037;11465.484053217626;11466.48400821965;11495.310281383145;11504.654860354203;8227.83544329122;8691.392092462915;8714.302855771522;8728.869066964;8761.868571971552;6430.356964303533;6514.837129071811;6528.543001989815;6556.803295901131;6556.8525508036855;10271.383716977005;10370.066693997576;10386.740331491774;10481.475926203811;10483.21375896826;9770.462624555434;10161.84757228657;10163.491825408551;10456.163506919276;10480.266381353233;6881.311868813079;7749;7832.608369581612;7958.403119766156;8196.344292456708;8688.261497772508;8770.649174032967;8779.956100219459;8795.868061978947;8799.296056315352;7586.734464293723;7725.150233474201;7808.258215469521;7984.081830589556;8093.028836539653;7675.692972281046;7853.803654908673;7912.36701063925;7951.125376208728;7985.960070199844;7337.119545654556;7427.368673662583;7448.217937116741;7454.776356709307;7459.776206713807;5340.359156901197;5363.946360536501;5476.67139971603;5489.917651235314;5547.639403438763;5505.091659876076;5575.247341608993;5579.9163012555655;5653.265075540154;5656.010198215378 07:24:46 INFO - PROCESS | 24027 | |4;prototype.html;335.20723488948636;337.6640242958257;344.8413729684345;345.10445394202037;345.9515667806507;5604.859878503034;5605.607607467479;5649.045668032383;5668.186180422266;5699.344575373833;5520.751566179521;5574.219609254697;5586.636868603538;5596.4123767004485;5610.859728506789;4105.630493255607;4178;4252.787360631956;4269.573042695737;4276.379924910886;4237.449131612886;4242.342436922282;4261.424707664457;4264.957350426487;4276.102018576103;4279.422277992478;4279.507856596485;4283;4286.242640517388;4292.120115376356;4093.3655283431267;4200.936985945214;4237.279662457389;4284.271673815459;4290.334998075304;3769.6230376962358;3795.1460921292764;3796.6393192646656;3805.46723458716;3820.36963900956;5412.161115027177;5412.5940554458575;5423.830467812867;5439.456054394568;5451.182322651594;4851.393575803025;4859.878503037417;4961.280614310905;4962.106820772259;4965.602751779849;5794.101914203306;5823.505002074829;5836.620619659751;5842.474177324061;5847.26909136358;4140.296149654566;4163;4178.415021896937;4200.537940826506;4208.095259519218;5858.443447872488;6026.186464827192;6037.366076561942;6057.757689692407;6124.326324104345;4251.681123915719;4261.4673165854265;4271.060366719316;4280.636145927569;4281.7645029523055;4330.501992270929;4338.288569643973;4347.7826108694435;4352.564743525685;4355.346697995263;4900.607951363882;4951.9752401237765;4978.726170060609;4998.900021999612;5008.17365134756;5872.647641141545;5875.353711091777;5878.206442130343;5913.822585322448;5915.645061296336;1486.6283429142713;1505.954821355361;1506.4426162320012;1512.631068882663;1514.947111757318;935.5182081228173;951.3055469507299;954.9161701468744;959.6976952260015;961.1493827962304;5014.34813474246;5026.693059804404;5032.370953630796;5062.544371006627;5064.518870707277;5241.895162096736;5293.973530132324;5299.470052994747;5328.8401347959625;5420.322459692538;4798.640101992364;5046.243063540498;5064.139096353629;5180.326557547494;5183.948160518422;2896;2896.5944767732535;2901.17316564778;2903.985480072586;2909.312598692753;5423.511883930465;5445.646033007842;5448.618596698272;5470.53500452466;5488.9725551371985;5164;5395;5414.7021913795115;5415.729213539307;5435.646682965595;5457.754401051962;5469.617126801086;5504.779808807683;5529.364123125892;5538;5175.844724658266;5210.541048506424;5339.866503337447;5344.514800617576;5390.4879036491475;5255.211718242294;5273.971575542886;5275.947240527546;5287.52412282881;5301.655392399482;5462.361291612579;5471.908371769937;5499.395066542757;5531.778728850801;5535.560754203855;3917.8834032300656;3941.625545573166;3956.584558621303;3960.306946284331;4221.409002739681;5807.738651760596;5980.581359304807;5983.820485385445;5998.9801733706245;6033.9698301508215;5788.855278618068;5915.911261330997;5931.525477961666;5967.791127310524;5990.483996721475;5908.5568582357355;5922;5941.7623295067715;5975.282966044103;5996.2504686914135;5691.174779657009;5827.475527202572;5839.182514447895;5853.678047707247;5916;5919.378465261258;5973.103045023074;6000.369961154191;6005.489533389711;6055.606385585099;5715.942840571541;5851.590388672752;5869.589128760946;5872.706364681834;5887.381824908323 07:24:46 INFO - PROCESS | 24027 | |5;yui.html;736.6832262127283;737.5574655206875;756.092688773472;767.2059418501851;776.0299625468165;15052.17213053283;16150.676986460263;16210.432634857782;16322.673546529062;16375;15489.070655760634;15576.844231557681;15594.688106237896;15611.687766244668;15672.373105075783;806.939479539034;815.8939337886067;816.6243527977138;821.9054808697017;825.1500954017372;781.452982911961;830.9169083091673;835.3567752830317;836.3016880904452;838.3837879158814;875.3522393428849;878.6090189865513;878.7627340618029;885.6678745470449;886.0829041941591;866.1554983890719;869.1438932651333;869.9826003479895;871.0462044061742;878.0473186592554;637.4199478474612;642.0593830038969;643.0514990389186;643.6138317009803;643.6942452335151;16275.430359937345;16384.672306553803;16403.42588009414;16419.42532011386;16447.25987330573;14597.343119559539;14938;15016.624584385478;15024;15140.33456319804;12461.688457788629;12512.37438128099;12521.499140034388;12574.622761317176;13222.537211197658;3908.545025442889;3956.1296514766705;4024.577419370953;4064.8577299794365;4160.105577300895;79184;79376.60311698404;80408.19591804066;80905.59547202285;81119.78320325259;10169.171061797253;10274.434906080238;10807.78384432307;10882.29265097766;10888.618898338678;21695.566088678454;21807.67288490674;21810.890945545172;21895.12419503202;21917.23289684885;8429.873551896726;8454.87317690235;8587.484750914966;8853.690120845868;8859.557022148867;4477.328400739915;4681.087187998308;4709.128811169944;4857.1742803723455;4907.386576677915;3355.0773537276955;3435.7594968352473;3452.741044421628;3459.152507635595;3481.164520515109;611.6421893192444;634.6794868591331;646.0761111610442;647.757091090841;664.0272001517703;722.8554289142193;743.8177646476539;766.7278116268756;802.9759107226793;815.2499700275761;9915.900840991499;10202;10562.419066951392;10686.0916822071;10759.246852720235;751.335068464402;766.6473422225838;766.7738017284914;781.7303030454484;787.1223585701902;4962.280469331927;5136.43499215086;5194.27280180775;5207.921881171786;5232.947670523246;95830;98820;110584;117878;118498;94888;95191.52404237934;98425.03149936961;98690;102063.48968255111;81121;84479;87450;89475;90334.54832725794;10210.489475526343;10706.357618542912;10706.368374851863;10779.245452818228;10830;51633.225501616755;52219;53241;53356.73321633367;53362;71659.28340716526;74839.62580187064;75120.24879751352;77754;78161;12354.08511680691;12371.75256494883;12460.750784984431;12562.560310389092;12660.810087848506;15816.446424375092;15845.920770396075;15890.126043067743;15945.521634350987;16153.111578863276;14938.701225975637;15244.237788110771;15650.217489125725;15841.287142078403;15892.52322430329;14433.204921088605;14747.336369863167;15164.696706065597;15292.770608441106;15605.141717205663;14100.858991409954;14372.784408233676;14547.78178327347;14591.20752927096;14675.19286439256;10042.447665378475;10418.166546676399;10427.113269249767;10517.368957862553;10560.630377936735;10065.949670251603;10448.40492774477;10721.839172412265;12147.271163730204;12731.681707957376 07:24:46 INFO - PROCESS | 24027 | __end_tp_report 07:24:46 INFO - PROCESS | 24027 | __start_cc_report 07:24:46 INFO - PROCESS | 24027 | _x_x_mozilla_cycle_collect,366 07:24:46 INFO - PROCESS | 24027 | __end_cc_report 07:24:46 INFO - PROCESS | 24027 | __startTimestamp1469024686180__endTimestamp 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | ------- Summary: start ------- 07:24:46 INFO - PROCESS | 24027 | Number of tests: 6 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#0] dojo.html Cycles:165 Average:5520.48 Median:5774.88 stddev:638.56 (11.1%) stddev-sans-first:611.66 07:24:46 INFO - PROCESS | 24027 | Values: 3100.7 3102.8 3118.7 3137.5 3141.4 5534.0 5575.1 5603.6 5616.7 5620.9 5381.2 5473.1 5540.6 5583.6 5630.0 5012.1 5047.2 5116.8 5162.8 5192.8 5075.8 5223.9 5225.8 5229.7 5253.9 4993.3 5030.8 5036.0 5038.9 5056.2 5103.7 5111.5 5111.6 5118.6 5143.0 5052.2 5063.5 5076.7 5104.5 5128.5 5359.4 5409.4 5493.5 5535.0 5575.1 5928.8 5934.9 5941.0 5945.5 5982.3 5896.0 5966.4 5976.5 5983.6 5988.7 5455.1 5478.0 5485.1 5506.8 5539.9 6008.5 6030.5 6055.9 6060.3 6106.0 5822.6 5836.7 5837.4 5840.6 5842.3 5777.2 5906.7 5914.9 5926.3 5982.7 5645.6 5813.0 5845.3 5888.2 5979.1 5875.8 5925.6 5932.1 5943.6 5946.2 4404.5 4499.1 4501.3 4507.5 4550.9 3977.5 3982.4 4004.3 4012.0 4059.0 5661.1 5706.4 5723.3 5725.5 5732.7 5860.2 6012.7 6014.5 6019.1 6023.2 5619.5 5676.4 5682.8 5719.5 5768.2 5028.2 5071.9 5090.8 5108.4 5111.2 5939.3 6133.4 6144.0 6144.7 6167.1 5914.6 5961.9 5975.1 5999.5 6056.2 6180.4 6184.9 6186.5 6188.9 6190.2 5747.0 5853.7 5893.6 5895.0 5898.7 5857.6 5875.0 5884.9 5928.0 5971.9 5806.7 5821.5 5829.9 5845.1 5868.8 5679.9 5791.7 5804.6 5811.4 5815.6 5665.7 5770.3 5776.6 5820.7 5832.4 5793.1 5897.5 5922.6 5936.6 5937.9 5481.2 5610.6 5774.9 5777.8 5785.6 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#1] ext.html Cycles:180 Average:63206.87 Median:42982.68 stddev:129341.03 (300.9%) stddev-sans-first:129618.33 07:24:46 INFO - PROCESS | 24027 | Values: 555.8 600.0 603.1 610.1 617.0 41829.6 43039.6 43082.8 43110.4 45932.8 43812.3 44260.6 44274.8 44482.0 44587.3 8768.3 8900.9 8931.5 8946.7 8957.3 8877.0 8933.7 8992.8 8997.4 8998.3 9030.4 9052.3 9067.8 9070.5 9092.9 8950.0 8960.8 9009.5 9017.0 9022.7 8867.9 8902.1 8929.0 8931.7 8938.0 41999.6 42477.0 42550.8 42577.1 42675.0 3564.1 3569.5 3583.7 3656.7 3768.6 32231.7 32791.3 32915.5 33091.0 34076.7 4390.6 4393.3 4468.2 4483.4 4601.2 360205.0 360413.0 360727.0 361540.2 361640.0 56953.7 57236.4 57338.4 57468.4 57646.0 58545.0 58568.0 58878.4 59234.7 59606.0 15268.5 15864.2 16053.0 16178.7 16248.2 11948.0 12047.5 12068.5 12073.6 12136.8 19012.3 19126.9 19171.3 19291.4 19497.6 6799.8 7182.1 7324.6 7326.9 7428.3 983.2 1101.5 1128.0 1131.5 1146.4 32735.8 33090.3 33127.7 33127.8 33476.5 1127.4 1150.6 1174.6 1216.6 1217.6 17215.6 17331.6 17536.0 17543.8 17603.9 600461.0 602279.0 611987.0 612129.0 613047.0 57539.0 58004.7 58269.4 58278.1 58308.4 1341.8 1347.2 1374.8 1388.1 1398.3 30877.7 32479.7 32934.5 33087.3 33311.0 49679.0 50173.2 50359.0 50361.0 50398.0 456151.0 456504.6 456774.0 457269.0 459801.0 27966.4 28231.2 28318.4 28320.7 28400.0 47840.5 47888.0 48176.3 49361.3 49460.8 40211.0 41765.8 42356.6 42456.6 42925.8 40960.0 41975.0 42857.0 44361.0 44867.8 42226.6 42704.8 42855.1 43088.6 44945.8 29668.6 32952.2 33998.2 34071.1 34201.7 28850.3 28862.0 28916.9 29090.7 29167.0 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#2] jquery.html Cycles:180 Average:27577.69 Median:23563.91 stddev:72461.16 (307.5%) stddev-sans-first:72635.65 07:24:46 INFO - PROCESS | 24027 | Values: 377.6 379.8 393.6 400.9 414.6 18487.7 19926.1 20019.1 20169.5 20223.6 19170.1 19332.4 19624.6 19720.0 19729.9 5616.9 5705.5 5713.1 5742.0 5787.0 5511.3 5584.4 5641.9 5645.9 5658.5 5573.8 5629.7 5666.5 5669.0 5684.2 5558.4 5571.6 5668.2 5699.4 5706.6 4879.8 4954.7 4982.7 4990.8 5000.4 23368.5 23759.3 23827.3 23921.5 24067.8 2297.5 2478.0 2525.3 2808.3 2998.9 14353.4 14633.3 14885.6 15194.4 15450.2 1923.8 1964.5 1984.3 1996.9 2037.8 78295.6 79233.0 80349.2 80821.6 80980.6 10593.5 10599.4 10660.5 10738.2 11237.4 14877.5 14898.7 14952.6 14954.4 14994.7 7394.7 7736.0 7813.6 7865.0 7935.1 7183.6 7310.0 7338.8 7457.3 7515.5 6205.6 6352.1 6377.0 6529.2 6613.8 1922.5 1936.2 1954.5 1955.3 2040.5 987.4 1037.4 1053.4 1067.4 1068.9 20003.8 20448.3 20772.4 20793.0 20887.0 1002.8 1045.6 1046.5 1073.5 1127.2 9904.3 11166.9 11193.7 11252.7 11254.3 386407.0 389493.0 389544.0 499376.0 501890.0 57619.0 96980.5 100146.5 100873.0 104916.0 1007.9 1008.1 1061.6 1066.1 1068.2 17179.7 17818.6 17910.5 18233.6 18472.0 41367.4 43306.0 43895.0 44527.8 44683.3 57154.4 59880.0 60546.1 60875.4 62043.1 7315.2 7676.2 7736.1 7861.3 8053.6 13714.2 13926.9 13939.7 13981.4 14014.6 5552.0 10304.5 10348.0 10348.5 10601.9 10618.5 10870.5 11421.8 11681.6 11906.6 10859.5 11114.5 11115.2 11400.5 11535.5 6981.3 7128.3 7170.9 8090.8 8338.0 9865.5 10127.8 10378.4 10386.0 10771.4 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#3] mootools.html Cycles:180 Average:5998.90 Median:4496.48 stddev:3392.91 (75.5%) stddev-sans-first:3385.55 07:24:46 INFO - PROCESS | 24027 | Values: 1495.9 1522.4 1680.3 1828.7 1828.7 8003.9 8659.4 8818.9 9214.6 9221.6 8864.6 9059.8 9123.8 9133.3 9156.6 2385.1 2418.4 2426.5 2429.2 2431.2 2348.8 2358.2 2383.6 2412.6 2420.1 2369.1 2372.3 2388.8 2403.7 2406.5 2289.4 2290.7 2308.6 2316.0 2344.9 2245.6 2250.8 2269.7 2279.7 2280.5 9110.9 9221.4 9258.4 9261.1 9293.4 5446.3 5546.1 5573.9 5591.6 5602.3 3484.8 3568.0 3590.5 3642.0 3643.9 1005.8 1007.1 1095.3 1101.2 1114.7 12754.9 12757.0 12842.6 12853.7 12860.1 4583.1 4677.6 4819.8 4819.9 4829.5 10115.1 10123.8 10123.9 10141.9 10142.2 5535.3 5550.1 5553.6 5555.6 5556.7 4529.4 4886.7 4977.6 4990.1 5142.9 3711.2 3846.4 3883.2 3960.6 3964.4 1163.7 1168.8 1176.1 1180.4 1185.5 981.0 1011.7 1015.4 1016.2 1021.3 6101.8 6284.2 6286.6 6299.2 6446.8 1051.5 1079.1 1088.1 1120.2 1124.5 4260.4 4421.4 4463.6 4575.0 4612.1 11025.9 11552.5 11566.8 11593.8 11603.2 10623.8 11465.5 11466.5 11495.3 11504.7 8227.8 8691.4 8714.3 8728.9 8761.9 6430.4 6514.8 6528.5 6556.8 6556.9 10271.4 10370.1 10386.7 10481.5 10483.2 9770.5 10161.8 10163.5 10456.2 10480.3 6881.3 7749.0 7832.6 7958.4 8196.3 8688.3 8770.6 8780.0 8795.9 8799.3 7586.7 7725.2 7808.3 7984.1 8093.0 7675.7 7853.8 7912.4 7951.1 7986.0 7337.1 7427.4 7448.2 7454.8 7459.8 5340.4 5363.9 5476.7 5489.9 5547.6 5505.1 5575.2 5579.9 5653.3 5656.0 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#4] prototype.html Cycles:180 Average:4745.44 Median:5315.25 stddev:1382.77 (26.0%) stddev-sans-first:1346.44 07:24:46 INFO - PROCESS | 24027 | Values: 335.2 337.7 344.8 345.1 346.0 5604.9 5605.6 5649.0 5668.2 5699.3 5520.8 5574.2 5586.6 5596.4 5610.9 4105.6 4178.0 4252.8 4269.6 4276.4 4237.4 4242.3 4261.4 4265.0 4276.1 4279.4 4279.5 4283.0 4286.2 4292.1 4093.4 4200.9 4237.3 4284.3 4290.3 3769.6 3795.1 3796.6 3805.5 3820.4 5412.2 5412.6 5423.8 5439.5 5451.2 4851.4 4859.9 4961.3 4962.1 4965.6 5794.1 5823.5 5836.6 5842.5 5847.3 4140.3 4163.0 4178.4 4200.5 4208.1 5858.4 6026.2 6037.4 6057.8 6124.3 4251.7 4261.5 4271.1 4280.6 4281.8 4330.5 4338.3 4347.8 4352.6 4355.3 4900.6 4952.0 4978.7 4998.9 5008.2 5872.6 5875.4 5878.2 5913.8 5915.6 1486.6 1506.0 1506.4 1512.6 1514.9 935.5 951.3 954.9 959.7 961.1 5014.3 5026.7 5032.4 5062.5 5064.5 5241.9 5294.0 5299.5 5328.8 5420.3 4798.6 5046.2 5064.1 5180.3 5183.9 2896.0 2896.6 2901.2 2904.0 2909.3 5423.5 5445.6 5448.6 5470.5 5489.0 5164.0 5395.0 5414.7 5415.7 5435.6 5457.8 5469.6 5504.8 5529.4 5538.0 5175.8 5210.5 5339.9 5344.5 5390.5 5255.2 5274.0 5275.9 5287.5 5301.7 5462.4 5471.9 5499.4 5531.8 5535.6 3917.9 3941.6 3956.6 3960.3 4221.4 5807.7 5980.6 5983.8 5999.0 6034.0 5788.9 5915.9 5931.5 5967.8 5990.5 5908.6 5922.0 5941.8 5975.3 5996.3 5691.2 5827.5 5839.2 5853.7 5916.0 5919.4 5973.1 6000.4 6005.5 6055.6 5715.9 5851.6 5869.6 5872.7 5887.4 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - PROCESS | 24027 | [#5] yui.html Cycles:180 Average:21064.00 Median:4044.72 stddev:29570.02 (731.1%) stddev-sans-first:29613.58 07:24:46 INFO - PROCESS | 24027 | Values: 736.7 737.6 756.1 767.2 776.0 15052.2 16150.7 16210.4 16322.7 16375.0 15489.1 15576.8 15594.7 15611.7 15672.4 806.9 815.9 816.6 821.9 825.2 781.5 830.9 835.4 836.3 838.4 875.4 878.6 878.8 885.7 886.1 866.2 869.1 870.0 871.0 878.0 637.4 642.1 643.1 643.6 643.7 16275.4 16384.7 16403.4 16419.4 16447.3 14597.3 14938.0 15016.6 15024.0 15140.3 12461.7 12512.4 12521.5 12574.6 13222.5 3908.5 3956.1 4024.6 4064.9 4160.1 79184.0 79376.6 80408.2 80905.6 81119.8 10169.2 10274.4 10807.8 10882.3 10888.6 21695.6 21807.7 21810.9 21895.1 21917.2 8429.9 8454.9 8587.5 8853.7 8859.6 4477.3 4681.1 4709.1 4857.2 4907.4 3355.1 3435.8 3452.7 3459.2 3481.2 611.6 634.7 646.1 647.8 664.0 722.9 743.8 766.7 803.0 815.2 9915.9 10202.0 10562.4 10686.1 10759.2 751.3 766.6 766.8 781.7 787.1 4962.3 5136.4 5194.3 5207.9 5232.9 95830.0 98820.0 110584.0 117878.0 118498.0 94888.0 95191.5 98425.0 98690.0 102063.5 81121.0 84479.0 87450.0 89475.0 90334.5 10210.5 10706.4 10706.4 10779.2 10830.0 51633.2 52219.0 53241.0 53356.7 53362.0 71659.3 74839.6 75120.2 77754.0 78161.0 12354.1 12371.8 12460.8 12562.6 12660.8 15816.4 15845.9 15890.1 15945.5 16153.1 14938.7 15244.2 15650.2 15841.3 15892.5 14433.2 14747.3 15164.7 15292.8 15605.1 14100.9 14372.8 14547.8 14591.2 14675.2 10042.4 10418.2 10427.1 10517.4 10560.6 10065.9 10448.4 10721.8 12147.3 12731.7 07:24:46 INFO - PROCESS | 24027 | -------- Summary: end -------- 07:24:46 INFO - PROCESS | 24027 | 07:24:46 INFO - TEST-INFO | 24027: exit 0 07:24:46 INFO - TEST-OK | dromaeo_css | took 1111310ms 07:24:46 INFO - TEST-START | kraken 07:24:46 INFO - operating with platform_type : linux_ 07:24:46 INFO - Initialising browser for kraken test... 07:24:46 INFO - TEST-INFO | started process 24280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo9s28W/profile http://localhost:57472/getInfo.html) 07:24:51 INFO - PROCESS | 24280 | __metrics Screen width/height:1600/1200 07:24:51 INFO - PROCESS | 24280 | colorDepth:24 07:24:51 INFO - PROCESS | 24280 | Browser inner width/height: 1024/697 07:24:51 INFO - PROCESS | 24280 | __metrics 07:24:51 ERROR - PROCESS | 24280 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:24:52 INFO - TEST-INFO | 24280: exit 0 07:24:52 INFO - Browser initialized. 07:24:52 INFO - Running cycle 1/1 for kraken test... 07:24:52 INFO - TEST-INFO | started process 24402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo9s28W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:04 INFO - PROCESS | 24402 | RSS: Main: 167399424 07:25:04 INFO - PROCESS | 24402 | 07:25:06 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57472/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:07 INFO - PROCESS | 24402 | RSS: Main: 172732416 07:25:07 INFO - PROCESS | 24402 | 07:25:10 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57472/tests/kraken/driver.html?testName=audio-dft) 07:25:10 INFO - PROCESS | 24402 | RSS: Main: 171098112 07:25:10 INFO - PROCESS | 24402 | 07:25:13 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57472/tests/kraken/driver.html?testName=audio-fft) 07:25:14 INFO - PROCESS | 24402 | RSS: Main: 167403520 07:25:14 INFO - PROCESS | 24402 | 07:25:16 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57472/tests/kraken/driver.html?testName=audio-oscillator) 07:25:17 INFO - PROCESS | 24402 | RSS: Main: 169025536 07:25:17 INFO - PROCESS | 24402 | 07:25:19 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:19 INFO - PROCESS | 24402 | RSS: Main: 168734720 07:25:19 INFO - PROCESS | 24402 | 07:25:23 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57472/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:23 INFO - PROCESS | 24402 | RSS: Main: 169041920 07:25:23 INFO - PROCESS | 24402 | 07:25:27 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57472/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:27 INFO - PROCESS | 24402 | RSS: Main: 166473728 07:25:27 INFO - PROCESS | 24402 | 07:25:30 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57472/tests/kraken/driver.html?testName=json-parse-financial) 07:25:31 INFO - PROCESS | 24402 | RSS: Main: 167485440 07:25:31 INFO - PROCESS | 24402 | 07:25:32 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:25:33 INFO - PROCESS | 24402 | RSS: Main: 167944192 07:25:33 INFO - PROCESS | 24402 | 07:25:35 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:25:36 INFO - PROCESS | 24402 | RSS: Main: 168640512 07:25:36 INFO - PROCESS | 24402 | 07:25:38 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:25:38 INFO - PROCESS | 24402 | RSS: Main: 169033728 07:25:38 INFO - PROCESS | 24402 | 07:25:41 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:25:42 INFO - PROCESS | 24402 | RSS: Main: 169037824 07:25:42 INFO - PROCESS | 24402 | 07:25:44 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:45 INFO - PROCESS | 24402 | RSS: Main: 168886272 07:25:45 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | Cycle 1(1): loaded http://localhost:57472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57472/tests/kraken/driver.html?testName=ai-astar) 07:25:47 INFO - PROCESS | 24402 | RSS: Main: 170053632 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | __start_tp_report 07:25:47 INFO - PROCESS | 24402 | _x_x_mozilla_page_load 07:25:47 INFO - PROCESS | 24402 | _x_x_mozilla_page_load_details 07:25:47 INFO - PROCESS | 24402 | |i|pagename|runs| 07:25:47 INFO - PROCESS | 24402 | |0;ai-astar;102;112;106;113;115;112;114;113;112;114 07:25:47 INFO - PROCESS | 24402 | |1;audio-beat-detection;152;117;147;184;121;149;155;122;187;119 07:25:47 INFO - PROCESS | 24402 | |2;audio-dft;164;162;162;162;162;164;177;162;161;163 07:25:47 INFO - PROCESS | 24402 | |3;audio-fft;76;75;77;147;76;76;76;76;177;77 07:25:47 INFO - PROCESS | 24402 | |4;audio-oscillator;84;83;147;90;83;85;136;83;85;154 07:25:47 INFO - PROCESS | 24402 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 07:25:47 INFO - PROCESS | 24402 | |6;imaging-darkroom;147;148;147;147;149;147;149;147;147;146 07:25:47 INFO - PROCESS | 24402 | |7;imaging-desaturate;95;96;97;96;96;95;95;96;96;95 07:25:47 INFO - PROCESS | 24402 | |8;json-parse-financial;52;52;50;51;57;52;56;51;51;55 07:25:47 INFO - PROCESS | 24402 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;64;69;63 07:25:47 INFO - PROCESS | 24402 | |10;stanford-crypto-aes;77;77;76;78;77;77;77;76;81;76 07:25:47 INFO - PROCESS | 24402 | |11;stanford-crypto-ccm;128;133;149;125;130;130;123;139;169;127 07:25:47 INFO - PROCESS | 24402 | |12;stanford-crypto-pbkdf2;157;160;165;158;155;157;155;154;154;155 07:25:47 INFO - PROCESS | 24402 | |13;stanford-crypto-sha256-iterative;72;63;64;67;63;62;63;62;63;61 07:25:47 INFO - PROCESS | 24402 | __end_tp_report 07:25:47 INFO - PROCESS | 24402 | __start_cc_report 07:25:47 INFO - PROCESS | 24402 | _x_x_mozilla_cycle_collect,924 07:25:47 INFO - PROCESS | 24402 | __end_cc_report 07:25:47 INFO - PROCESS | 24402 | __startTimestamp1469024747293__endTimestamp 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | ------- Summary: start ------- 07:25:47 INFO - PROCESS | 24402 | Number of tests: 14 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.08 (3.6%) stddev-sans-first:2.60 07:25:47 INFO - PROCESS | 24402 | Values: 102.0 112.0 106.0 113.0 115.0 112.0 114.0 113.0 112.0 114.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:25.86 (17.2%) stddev-sans-first:27.31 07:25:47 INFO - PROCESS | 24402 | Values: 152.0 117.0 147.0 184.0 121.0 149.0 155.0 122.0 187.0 119.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#2] audio-dft Cycles:10 Average:163.90 Median:162.50 stddev:4.70 (2.9%) stddev-sans-first:4.99 07:25:47 INFO - PROCESS | 24402 | Values: 164.0 162.0 162.0 162.0 162.0 164.0 177.0 162.0 161.0 163.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.90 (48.5%) stddev-sans-first:38.60 07:25:47 INFO - PROCESS | 24402 | Values: 76.0 75.0 77.0 147.0 76.0 76.0 76.0 76.0 177.0 77.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.50 stddev:29.82 (35.7%) stddev-sans-first:30.83 07:25:47 INFO - PROCESS | 24402 | Values: 84.0 83.0 147.0 90.0 83.0 85.0 136.0 83.0 85.0 154.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:25:47 INFO - PROCESS | 24402 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 07:25:47 INFO - PROCESS | 24402 | Values: 147.0 148.0 147.0 147.0 149.0 147.0 149.0 147.0 147.0 146.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:25:47 INFO - PROCESS | 24402 | Values: 95.0 96.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.41 (4.6%) stddev-sans-first:2.54 07:25:47 INFO - PROCESS | 24402 | Values: 52.0 52.0 50.0 51.0 57.0 52.0 56.0 51.0 51.0 55.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.00 stddev:1.89 (3.0%) stddev-sans-first:1.99 07:25:47 INFO - PROCESS | 24402 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 69.0 63.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:1.48 (1.9%) stddev-sans-first:1.56 07:25:47 INFO - PROCESS | 24402 | Values: 77.0 77.0 76.0 78.0 77.0 77.0 77.0 76.0 81.0 76.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:131.50 stddev:14.06 (10.7%) stddev-sans-first:14.66 07:25:47 INFO - PROCESS | 24402 | Values: 128.0 133.0 149.0 125.0 130.0 130.0 123.0 139.0 169.0 127.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:3.40 (2.2%) stddev-sans-first:3.61 07:25:47 INFO - PROCESS | 24402 | Values: 157.0 160.0 165.0 158.0 155.0 157.0 155.0 154.0 154.0 155.0 07:25:47 INFO - PROCESS | 24402 | 07:25:47 INFO - PROCESS | 24402 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.00 stddev:3.23 (5.1%) stddev-sans-first:1.69 07:25:47 INFO - PROCESS | 24402 | Values: 72.0 63.0 64.0 67.0 63.0 62.0 63.0 62.0 63.0 61.0 07:25:47 INFO - PROCESS | 24402 | -------- Summary: end -------- 07:25:47 INFO - PROCESS | 24402 | 07:25:48 INFO - TEST-INFO | 24402: exit 0 07:25:48 INFO - TEST-OK | kraken | took 61341ms 07:25:48 INFO - SUITE-END | took 1172s 07:25:48 INFO - Completed test suite (00:19:32) 07:25:48 INFO - javascript benchmark 07:25:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7416.9225349556455, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.6899310068998, 3102.782805203636, 3118.73490753286, 3137.4509460844347, 3141.37172565487, 5534.003879301724, 5575.0522411190095, 5603.60774745768, 5616.719164041791, 5620.887582248358, 5381.219723140152, 5473.124300111983, 5540.63985840921, 5583.58123140764, 5630.014747419205, 5012.072766538193, 5047.192449208127, 5116.771974726057, 5162.845114646567, 5192.766325515342, 5075.847724568269, 5223.895522089575, 5225.764840582183, 5229.712365819878, 5253.86865328366, 4993.251012348141, 5030.798768049273, 5036.0, 5038.924416133761, 5056.191009438472, 5103.719295438749, 5111.488851114896, 5111.642185047048, 5118.564921981636, 5142.974285128588, 5052.191649336089, 5063.468335824722, 5076.695398276078, 5104.540591346759, 5128.512791284822, 5359.410464848864, 5409.43200963897, 5493.505584497414, 5534.972325138348, 5575.052241118979, 5928.7628494860155, 5934.910976335358, 5940.970295148497, 5945.464908158287, 5982.312034116088, 5895.970520147414, 5966.373530779249, 5976.462118409364, 5983.58114931955, 5988.700564971778, 5455.09990851513, 5478.04134276504, 5485.122380419114, 5506.779728810883, 5539.861503462445, 6008.519318454513, 6030.547708921848, 6055.878882422415, 6060.2727672678675, 6105.9694701526205, 5822.621529600562, 5836.737346819404, 5837.387074357216, 5840.620359676607, 5842.298924129132, 5777.2200752897825, 5906.734196961061, 5914.8817023659285, 5926.288845338587, 5982.73077711504, 5645.576581756302, 5813.0, 5845.269341332333, 5888.175655408247, 5979.073243647242, 5875.823725288248, 5925.555583331267, 5932.110183472513, 5943.613665111754, 5946.1972633693895, 4404.493483249404, 4499.10017996402, 4501.347304640809, 4507.549245075466, 4550.863474095782, 3977.463042489227, 3982.4424580558743, 4004.3192657248337, 4012.0, 4059.0258337999257, 5661.122526008476, 5706.42935706426, 5723.313202415654, 5725.5133313667975, 5732.742026608813, 5860.238169037998, 6012.729427175787, 6014.548908831767, 6019.067044608093, 6023.216981792427, 5619.522340601095, 5676.375598684142, 5682.801101961411, 5719.456651618089, 5768.163616275617, 5028.220625802934, 5071.8985620287385, 5090.796368145233, 5108.361454818148, 5111.207762796773, 5939.316978547436, 6133.417325354173, 6144.047672610753, 6144.692765361714, 6167.136600875881, 5914.556408269483, 5961.910571341346, 5975.133605627073, 5999.4900433463645, 6056.242969628796, 6180.412860778219, 6184.876302474016, 6186.536009799193, 6188.938110618837, 6190.1952746142715, 5747.0, 5853.736581853742, 5893.6463812171405, 5895.02732049207, 5898.734556944862, 5857.560682948882, 5875.030619947661, 5884.911726324023, 5928.0, 5971.880562388641, 5806.65160090396, 5821.505172060422, 5829.883402332014, 5845.064789633639, 5868.794592189253, 5679.9432005681065, 5791.739371728367, 5804.622699524517, 5811.418858114154, 5815.563832712479, 5665.66006039639, 5770.336411312753, 5776.566757493289, 5820.679862607597, 5832.387599302012, 5793.102069179284, 5897.498712609477, 5922.644641321534, 5936.643801371932, 5937.910931335947, 5481.150421684645, 5610.579206559442, 5774.8845023098465, 5777.826665200051, 5785.595008349375], "value": 5475.735731516702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8377909930372, 600.0, 603.0682595390122, 610.1183789424281, 617.0066193428579, 41829.58170418295, 43039.56960430395, 43082.784586077025, 43110.353344699855, 45932.77033614827, 43812.3428148578, 44260.55739442613, 44274.778626106825, 44482.0, 44587.33119003218, 8768.254698350647, 8900.910990890074, 8931.50876701781, 8946.686865959693, 8957.328200384965, 8876.955615221947, 8933.731988040368, 8992.77518062047, 8997.370184087116, 8998.280137588978, 9030.413023153475, 9052.321075919299, 9067.773305667346, 9070.501122438263, 9092.909070909272, 8949.955250223707, 8960.820783584324, 9009.549522523881, 9016.954915225448, 9022.729318120433, 8867.911320886773, 8902.109789021046, 8928.973168085688, 8931.73204803857, 8937.955310223408, 41999.580004199874, 42477.0, 42550.78724606388, 42577.148457030686, 42675.0, 3564.055525285801, 3569.5181150544863, 3583.6774690278, 3656.725745569093, 3768.6231376862092, 32231.677683223337, 32791.344173116646, 32915.50626740601, 33091.0, 34076.659233407845, 4390.604845563915, 4393.290827271733, 4468.19572476954, 4483.417155769762, 4601.240795268776, 360205.0, 360413.0, 360727.0, 361540.19229903945, 361640.0, 56953.71523142358, 57236.42763572394, 57338.42661573414, 57468.42531574631, 57646.0, 58545.0, 58568.0, 58878.41121588815, 59234.70382648059, 59606.0, 15268.465603703817, 15864.206789660471, 16053.03681779097, 16178.676426471404, 16248.187590620422, 11948.0, 12047.518099276105, 12068.456919438646, 12073.637790866289, 12136.817947730791, 19012.334568290044, 19126.904365478364, 19171.32900348481, 19291.4212573623, 19497.610047798964, 6799.838075295012, 7182.138143422822, 7324.597147156957, 7326.890096648554, 7428.2571742825285, 983.233078199006, 1101.5483651702764, 1127.9960834856984, 1131.4512461456188, 1146.4210573660248, 32735.83632081872, 33090.33819323648, 33127.66872331294, 33127.83436082852, 33476.49785253223, 1127.413744852672, 1150.6087930103804, 1174.5654107980101, 1216.6410908781932, 1217.6347095871204, 17215.56961075958, 17331.56671083233, 17536.0, 17543.824561754474, 17603.911980440273, 600461.0, 602279.0, 611987.0, 612129.0, 613047.0, 57539.0, 58004.70997644985, 58269.4173058264, 58278.125828112614, 58308.41691583115, 1341.7584834729842, 1347.238810072306, 1374.8212732344732, 1388.0838646493266, 1398.2798858587835, 30877.69122308748, 32479.675203247665, 32934.50598241076, 33087.33825323432, 33311.0, 49679.0, 50173.24740128828, 50359.0, 50361.0, 50398.0, 456151.0, 456504.6097234044, 456774.0, 457269.0, 459801.0, 27966.44067118687, 28231.15306540807, 28318.43363132767, 28320.71679283181, 28400.0, 47840.521594783604, 47888.0, 48176.27735583899, 49361.25958110703, 49460.75269623629, 40211.0, 41765.79117104395, 42356.57643423649, 42456.575434245264, 42925.78537107419, 40960.0, 41975.0, 42857.0, 44361.0, 44867.775661121486, 42226.577734222265, 42704.786476068664, 42855.142897142505, 43088.569114308455, 44945.775271123435, 29668.554971675872, 32952.176195595304, 33998.150046249044, 34071.148221294665, 34201.65798341985, 28850.27874303075, 28861.950317229388, 28916.855415722788, 29090.7090929088, 29167.0], "value": 20381.299084194296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.6167190301844, 379.81416945478765, 393.578870608449, 400.92382447335007, 414.63097842919785, 18487.722684159733, 19926.10332535036, 20019.099140538674, 20169.49576260594, 20223.59552808943, 19170.137343819526, 19332.420027399166, 19624.607507849836, 19720.0, 19729.901350493226, 5616.9157462638095, 5705.515031222351, 5713.085906255, 5742.0, 5787.045137552299, 5511.338639363282, 5584.441555844423, 5641.943580564182, 5645.858853528674, 5658.519025882805, 5573.760694827649, 5629.7185140743, 5666.5183459406, 5668.971655141719, 5684.204211410406, 5558.44415558441, 5571.582131340166, 5668.206451096829, 5699.430056994309, 5706.600537962344, 4879.756012199411, 4954.653174277802, 4982.701037937699, 4990.750462476898, 5000.374953130859, 23368.532629347486, 23759.287221383387, 23827.285181444586, 23921.52156956851, 24067.759322406728, 2297.5060362022245, 2477.962830557543, 2525.343410713228, 2808.311963568918, 2998.8500574971163, 14353.354099065567, 14633.268336583129, 14885.553433396906, 15194.392224311014, 15450.1502417367, 1923.8460923126256, 1964.499052741556, 1984.2955750708436, 1996.930107446247, 2037.8267847233003, 78295.60852195759, 79233.0, 80349.19650803534, 80821.59589202075, 80980.59509702414, 10593.523291451904, 10599.364038157735, 10660.520276587573, 10738.248322617343, 11237.438128093563, 14877.47928822486, 14898.702025959637, 14952.551423457313, 14954.401823927139, 14994.70010599782, 7394.667239974214, 7736.0, 7813.570253635991, 7865.0, 7935.127136015034, 7183.568985860865, 7310.013148224922, 7338.77983660491, 7457.2542745724995, 7515.473916825879, 6205.627662340274, 6352.078948552434, 6377.0, 6529.183852018497, 6613.801585952333, 1922.5385907382408, 1936.1771247219874, 1954.4625228062112, 1955.2654430038558, 2040.5306779440812, 987.4322264697828, 1037.4294138223947, 1053.4311471805293, 1067.4075887882145, 1068.871735391758, 20003.799962000194, 20448.284310049075, 20772.376828695164, 20793.0, 20887.0, 1002.8395456726888, 1045.6183493025144, 1046.4819914142397, 1073.4793625091825, 1127.1658972360558, 9904.306698531178, 11166.888331116585, 11193.72015699614, 11252.718682033015, 11254.324740515594, 386407.0, 389493.0, 389544.0, 499376.0, 501890.0, 57619.0, 96980.51509742548, 100146.4992675032, 100873.0, 104915.95084049062, 1007.9344842585208, 1008.1078245752561, 1061.6072053340158, 1066.088494337346, 1068.2362111090608, 17179.656406872044, 17818.643627127643, 17910.462686119437, 18233.635327293116, 18472.0, 41367.37948930829, 43306.0, 43895.0, 44527.77736111299, 44683.329750053126, 57154.42845571491, 59880.0, 60546.09180862379, 60875.39124608697, 62043.069353958825, 7315.231900650355, 7676.193999630182, 7736.097645859835, 7861.331786798186, 8053.557054362066, 13714.24571648569, 13926.860731392557, 13939.721205576034, 13981.44074237019, 14014.649633759238, 5551.9722401387735, 10304.484775761332, 10348.0, 10348.482575871327, 10601.893981060091, 10618.469076545987, 10870.45647717595, 11421.828672569753, 11681.649550513499, 11906.583269585522, 10859.511321990687, 11114.499847507042, 11115.166362523005, 11400.486978086172, 11535.538578456768, 6981.301869812978, 7128.322809333105, 7170.89243661356, 8090.757277281691, 8338.0, 9865.506724663595, 10127.848082278624, 10378.42918639482, 10386.0, 10771.353718776898], "value": 9263.52988063257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.925203739813, 1522.3606085444114, 1680.2777153417753, 1828.7165489349156, 1828.7439758433813, 8003.919960800405, 8659.350548708848, 8818.86771698425, 9214.585343659535, 9221.58502867371, 8864.601092950817, 9059.773505662362, 9123.817523649523, 9133.269338452925, 9156.58795354209, 2385.0698227691173, 2418.3591348292716, 2426.502566973775, 2429.210506585358, 2431.209856796548, 2348.765123487646, 2358.1864256831363, 2383.642453631952, 2412.589859723851, 2420.056178090546, 2369.07606033647, 2372.2645979746335, 2388.773066558674, 2403.67550380699, 2406.4826062396583, 2289.370423133635, 2290.702208712865, 2308.6306191009444, 2316.0041182291607, 2344.941376465585, 2245.6406974884103, 2250.81993440526, 2269.6822444857735, 2279.7036385269807, 2280.4754906371627, 9110.908890911072, 9221.400608960463, 9258.398204116711, 9261.120193581599, 9293.395929264643, 5446.346438427375, 5546.084895992157, 5573.916391254134, 5591.552675785927, 5602.299712535933, 3484.8257587120797, 3567.983124809417, 3590.533230680021, 3641.9817900910325, 3643.908902277438, 1005.7737009172951, 1007.1288335589735, 1095.2606990281529, 1101.1851230089756, 1114.6990312615549, 12754.936225318907, 12757.0, 12842.550510732079, 12853.67865803353, 12860.099793014399, 4583.083383323348, 4677.602403795648, 4819.807207711722, 4819.879503012453, 4829.541193586604, 10115.089641932262, 10123.797524049478, 10123.898761012442, 10141.898581014242, 10142.239332050125, 5535.252740880011, 5550.139728342114, 5553.583481238923, 5555.583331250092, 5556.666600004012, 4529.38853254813, 4886.706797592155, 4977.576905962961, 4990.101781679333, 5142.897142057138, 3711.183539621279, 3846.442265871433, 3883.203943191639, 3960.6039396060164, 3964.385520244367, 1163.7148898519918, 1168.8129899216085, 1176.1061593189238, 1180.3626041937257, 1185.531714972581, 980.9852852207223, 1011.6610935336745, 1015.4009134610615, 1016.207358260558, 1021.3259248895694, 6101.786437474667, 6284.214473190851, 6286.559940804192, 6299.181106456132, 6446.806595802133, 1051.4690081508788, 1079.1366906474946, 1088.1403691084113, 1120.1990576737671, 1124.4995976790249, 4260.382244574519, 4421.40311058003, 4463.5759602838325, 4574.954250457519, 4612.123696497655, 11025.889741102646, 11552.480138393792, 11566.768664626661, 11593.826092608617, 11603.187776855708, 10623.84064239037, 11465.484053217626, 11466.48400821965, 11495.310281383145, 11504.654860354203, 8227.83544329122, 8691.392092462915, 8714.302855771522, 8728.869066964, 8761.868571971552, 6430.356964303533, 6514.837129071811, 6528.543001989815, 6556.803295901131, 6556.8525508036855, 10271.383716977005, 10370.066693997576, 10386.740331491774, 10481.475926203811, 10483.21375896826, 9770.462624555434, 10161.84757228657, 10163.491825408551, 10456.163506919276, 10480.266381353233, 6881.311868813079, 7749.0, 7832.608369581612, 7958.403119766156, 8196.344292456708, 8688.261497772508, 8770.649174032967, 8779.956100219459, 8795.868061978947, 8799.296056315352, 7586.734464293723, 7725.150233474201, 7808.258215469521, 7984.081830589556, 8093.028836539653, 7675.692972281046, 7853.803654908673, 7912.36701063925, 7951.125376208728, 7985.960070199844, 7337.119545654556, 7427.368673662583, 7448.217937116741, 7454.776356709307, 7459.776206713807, 5340.359156901197, 5363.946360536501, 5476.67139971603, 5489.917651235314, 5547.639403438763, 5505.091659876076, 5575.247341608993, 5579.9163012555655, 5653.265075540154, 5656.010198215378], "value": 4796.117565156057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.20723488948636, 337.6640242958257, 344.8413729684345, 345.10445394202037, 345.9515667806507, 5604.859878503034, 5605.607607467479, 5649.045668032383, 5668.186180422266, 5699.344575373833, 5520.751566179521, 5574.219609254697, 5586.636868603538, 5596.4123767004485, 5610.859728506789, 4105.630493255607, 4178.0, 4252.787360631956, 4269.573042695737, 4276.379924910886, 4237.449131612886, 4242.342436922282, 4261.424707664457, 4264.957350426487, 4276.102018576103, 4279.422277992478, 4279.507856596485, 4283.0, 4286.242640517388, 4292.120115376356, 4093.3655283431267, 4200.936985945214, 4237.279662457389, 4284.271673815459, 4290.334998075304, 3769.6230376962358, 3795.1460921292764, 3796.6393192646656, 3805.46723458716, 3820.36963900956, 5412.161115027177, 5412.5940554458575, 5423.830467812867, 5439.456054394568, 5451.182322651594, 4851.393575803025, 4859.878503037417, 4961.280614310905, 4962.106820772259, 4965.602751779849, 5794.101914203306, 5823.505002074829, 5836.620619659751, 5842.474177324061, 5847.26909136358, 4140.296149654566, 4163.0, 4178.415021896937, 4200.537940826506, 4208.095259519218, 5858.443447872488, 6026.186464827192, 6037.366076561942, 6057.757689692407, 6124.326324104345, 4251.681123915719, 4261.4673165854265, 4271.060366719316, 4280.636145927569, 4281.7645029523055, 4330.501992270929, 4338.288569643973, 4347.7826108694435, 4352.564743525685, 4355.346697995263, 4900.607951363882, 4951.9752401237765, 4978.726170060609, 4998.900021999612, 5008.17365134756, 5872.647641141545, 5875.353711091777, 5878.206442130343, 5913.822585322448, 5915.645061296336, 1486.6283429142713, 1505.954821355361, 1506.4426162320012, 1512.631068882663, 1514.947111757318, 935.5182081228173, 951.3055469507299, 954.9161701468744, 959.6976952260015, 961.1493827962304, 5014.34813474246, 5026.693059804404, 5032.370953630796, 5062.544371006627, 5064.518870707277, 5241.895162096736, 5293.973530132324, 5299.470052994747, 5328.8401347959625, 5420.322459692538, 4798.640101992364, 5046.243063540498, 5064.139096353629, 5180.326557547494, 5183.948160518422, 2896.0, 2896.5944767732535, 2901.17316564778, 2903.985480072586, 2909.312598692753, 5423.511883930465, 5445.646033007842, 5448.618596698272, 5470.53500452466, 5488.9725551371985, 5164.0, 5395.0, 5414.7021913795115, 5415.729213539307, 5435.646682965595, 5457.754401051962, 5469.617126801086, 5504.779808807683, 5529.364123125892, 5538.0, 5175.844724658266, 5210.541048506424, 5339.866503337447, 5344.514800617576, 5390.4879036491475, 5255.211718242294, 5273.971575542886, 5275.947240527546, 5287.52412282881, 5301.655392399482, 5462.361291612579, 5471.908371769937, 5499.395066542757, 5531.778728850801, 5535.560754203855, 3917.8834032300656, 3941.625545573166, 3956.584558621303, 3960.306946284331, 4221.409002739681, 5807.738651760596, 5980.581359304807, 5983.820485385445, 5998.9801733706245, 6033.9698301508215, 5788.855278618068, 5915.911261330997, 5931.525477961666, 5967.791127310524, 5990.483996721475, 5908.5568582357355, 5922.0, 5941.7623295067715, 5975.282966044103, 5996.2504686914135, 5691.174779657009, 5827.475527202572, 5839.182514447895, 5853.678047707247, 5916.0, 5919.378465261258, 5973.103045023074, 6000.369961154191, 6005.489533389711, 6055.606385585099, 5715.942840571541, 5851.590388672752, 5869.589128760946, 5872.706364681834, 5887.381824908323], "value": 4306.598625612249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.6832262127283, 737.5574655206875, 756.092688773472, 767.2059418501851, 776.0299625468165, 15052.17213053283, 16150.676986460263, 16210.432634857782, 16322.673546529062, 16375.0, 15489.070655760634, 15576.844231557681, 15594.688106237896, 15611.687766244668, 15672.373105075783, 806.939479539034, 815.8939337886067, 816.6243527977138, 821.9054808697017, 825.1500954017372, 781.452982911961, 830.9169083091673, 835.3567752830317, 836.3016880904452, 838.3837879158814, 875.3522393428849, 878.6090189865513, 878.7627340618029, 885.6678745470449, 886.0829041941591, 866.1554983890719, 869.1438932651333, 869.9826003479895, 871.0462044061742, 878.0473186592554, 637.4199478474612, 642.0593830038969, 643.0514990389186, 643.6138317009803, 643.6942452335151, 16275.430359937345, 16384.672306553803, 16403.42588009414, 16419.42532011386, 16447.25987330573, 14597.343119559539, 14938.0, 15016.624584385478, 15024.0, 15140.33456319804, 12461.688457788629, 12512.37438128099, 12521.499140034388, 12574.622761317176, 13222.537211197658, 3908.545025442889, 3956.1296514766705, 4024.577419370953, 4064.8577299794365, 4160.105577300895, 79184.0, 79376.60311698404, 80408.19591804066, 80905.59547202285, 81119.78320325259, 10169.171061797253, 10274.434906080238, 10807.78384432307, 10882.29265097766, 10888.618898338678, 21695.566088678454, 21807.67288490674, 21810.890945545172, 21895.12419503202, 21917.23289684885, 8429.873551896726, 8454.87317690235, 8587.484750914966, 8853.690120845868, 8859.557022148867, 4477.328400739915, 4681.087187998308, 4709.128811169944, 4857.1742803723455, 4907.386576677915, 3355.0773537276955, 3435.7594968352473, 3452.741044421628, 3459.152507635595, 3481.164520515109, 611.6421893192444, 634.6794868591331, 646.0761111610442, 647.757091090841, 664.0272001517703, 722.8554289142193, 743.8177646476539, 766.7278116268756, 802.9759107226793, 815.2499700275761, 9915.900840991499, 10202.0, 10562.419066951392, 10686.0916822071, 10759.246852720235, 751.335068464402, 766.6473422225838, 766.7738017284914, 781.7303030454484, 787.1223585701902, 4962.280469331927, 5136.43499215086, 5194.27280180775, 5207.921881171786, 5232.947670523246, 95830.0, 98820.0, 110584.0, 117878.0, 118498.0, 94888.0, 95191.52404237934, 98425.03149936961, 98690.0, 102063.48968255111, 81121.0, 84479.0, 87450.0, 89475.0, 90334.54832725794, 10210.489475526343, 10706.357618542912, 10706.368374851863, 10779.245452818228, 10830.0, 51633.225501616755, 52219.0, 53241.0, 53356.73321633367, 53362.0, 71659.28340716526, 74839.62580187064, 75120.24879751352, 77754.0, 78161.0, 12354.08511680691, 12371.75256494883, 12460.750784984431, 12562.560310389092, 12660.810087848506, 15816.446424375092, 15845.920770396075, 15890.126043067743, 15945.521634350987, 16153.111578863276, 14938.701225975637, 15244.237788110771, 15650.217489125725, 15841.287142078403, 15892.52322430329, 14433.204921088605, 14747.336369863167, 15164.696706065597, 15292.770608441106, 15605.141717205663, 14100.858991409954, 14372.784408233676, 14547.78178327347, 14591.20752927096, 14675.19286439256, 10042.447665378475, 10418.166546676399, 10427.113269249767, 10517.368957862553, 10560.630377936735, 10065.949670251603, 10448.40492774477, 10721.839172412265, 12147.271163730204, 12731.681707957376], "value": 7795.143575224058, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 113.0, 115.0, 112.0, 114.0, 113.0, 112.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 147.0, 184.0, 121.0, 149.0, 155.0, 122.0, 187.0, 119.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 162.0, 162.0, 164.0, 177.0, 162.0, 161.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 147.0, 76.0, 76.0, 76.0, 76.0, 177.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 147.0, 90.0, 83.0, 85.0, 136.0, 83.0, 85.0, 154.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 149.0, 147.0, 149.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 51.0, 57.0, 52.0, 56.0, 51.0, 51.0, 55.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 69.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 78.0, 77.0, 77.0, 77.0, 76.0, 81.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 149.0, 125.0, 130.0, 130.0, 123.0, 139.0, 169.0, 127.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 165.0, 158.0, 155.0, 157.0, 155.0, 154.0, 154.0, 155.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 64.0, 67.0, 63.0, 62.0, 63.0, 62.0, 63.0, 61.0], "value": 64.0, "unit": "score"}]}]} 07:25:48 INFO - Return code: 0 07:25:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:25:48 ERROR - # TBPL SUCCESS # 07:25:48 INFO - Running post-action listener: _resource_record_post_action 07:25:48 INFO - [mozharness: 2016-07-20 14:25:48.617320Z] Finished run-tests step (success) 07:25:48 INFO - Running post-run listener: _resource_record_post_run 07:25:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 556924928; Read time: 184; Write time: 438828 07:25:48 INFO - TinderboxPrint: CPU usage
13.4% 07:25:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 07:25:48 INFO - TinderboxPrint: I/O write bytes / time
556,924,928 / 438,828 07:25:48 INFO - TinderboxPrint: CPU idle
8,220.6 (86.6%) 07:25:48 INFO - TinderboxPrint: CPU user
1,218.9 (12.8%) 07:25:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:25:48 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256995328; Read time: 0; Write time: 245904 07:25:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299180032; Read time: 180; Write time: 192916 07:25:49 INFO - Running post-run listener: _upload_blobber_files 07:25:49 INFO - Blob upload gear active. 07:25:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:25:49 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 07:25:49 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:25:49 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:25:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:25:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:50 INFO - (blobuploader) - INFO - Done attempting. 07:25:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:25:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:11 INFO - (blobuploader) - INFO - Done attempting. 07:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:12 INFO - (blobuploader) - INFO - Done attempting. 07:26:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:12 INFO - Return code: 0 07:26:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd8ae943404d100e4ce99e905bf41474bee99d3a7ccb1aaf2a6c66e80642160093ecb7c97ec7b3435e2442757d6c6081fb428d6a81546d4767fce5eba4a3f974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d59626f562338d490cc28e2724f16ec16835f657d989cccbbcde37c1b43496e007bb03cae740a226fe3e142fa2e53ccdb25f403e48953ab16f555b4276a20020", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2cc30fda9a66cf37a10c15ff5348647f23c7ab8755ecdfe0af0c2034cb0a7572ac5efc1a2c5986c88cada7a7d15fdeeeb15063448167d3c9f3deaddc47dcb2"} 07:26:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:12 INFO - Contents: 07:26:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd8ae943404d100e4ce99e905bf41474bee99d3a7ccb1aaf2a6c66e80642160093ecb7c97ec7b3435e2442757d6c6081fb428d6a81546d4767fce5eba4a3f974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d59626f562338d490cc28e2724f16ec16835f657d989cccbbcde37c1b43496e007bb03cae740a226fe3e142fa2e53ccdb25f403e48953ab16f555b4276a20020", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2cc30fda9a66cf37a10c15ff5348647f23c7ab8755ecdfe0af0c2034cb0a7572ac5efc1a2c5986c88cada7a7d15fdeeeb15063448167d3c9f3deaddc47dcb2"} 07:26:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:12 INFO - Copying logs to upload dir... 07:26:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.719933 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-20 07:26:12.086069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:26:12.089784) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd8ae943404d100e4ce99e905bf41474bee99d3a7ccb1aaf2a6c66e80642160093ecb7c97ec7b3435e2442757d6c6081fb428d6a81546d4767fce5eba4a3f974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d59626f562338d490cc28e2724f16ec16835f657d989cccbbcde37c1b43496e007bb03cae740a226fe3e142fa2e53ccdb25f403e48953ab16f555b4276a20020", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2cc30fda9a66cf37a10c15ff5348647f23c7ab8755ecdfe0af0c2034cb0a7572ac5efc1a2c5986c88cada7a7d15fdeeeb15063448167d3c9f3deaddc47dcb2"} build_url:https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/aG3OmYwaQGe14f-d-zdj2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd8ae943404d100e4ce99e905bf41474bee99d3a7ccb1aaf2a6c66e80642160093ecb7c97ec7b3435e2442757d6c6081fb428d6a81546d4767fce5eba4a3f974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d59626f562338d490cc28e2724f16ec16835f657d989cccbbcde37c1b43496e007bb03cae740a226fe3e142fa2e53ccdb25f403e48953ab16f555b4276a20020", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2cc30fda9a66cf37a10c15ff5348647f23c7ab8755ecdfe0af0c2034cb0a7572ac5efc1a2c5986c88cada7a7d15fdeeeb15063448167d3c9f3deaddc47dcb2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:26:12.117391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:26:12.117920) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469022959.388255-249784807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:26:12.203001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:26:12.203384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:26:12.203744) ========= ========= Total master_lag: 0.16 =========