builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1470889876.0 results: success (0) buildid: 20160810193023 builduid: f93bbfd2ac634dc79b2cf707de6b214e revision: 32e07e32891d070cdba97e2872cd30265278c0bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.003427) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.004207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.004664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.022357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.022888) ========= 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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 21:31:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-08-10 21:31:16 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.138787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.139303) ========= 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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:16.189615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 21:31:16.189967) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 32e07e32891d070cdba97e2872cd30265278c0bf --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 32e07e32891d070cdba97e2872cd30265278c0bf --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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 21:31:16,334 truncating revision to first 12 chars 2016-08-10 21:31:16,334 Setting DEBUG logging. 2016-08-10 21:31:16,334 attempt 1/10 2016-08-10 21:31:16,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/32e07e32891d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 21:31:17,778 unpacking tar archive at: mozilla-inbound-32e07e32891d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.757319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 21:31:17.962728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:17.963382) ========= script_repo_revision: 32e07e32891d070cdba97e2872cd30265278c0bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:17.964076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:17.964438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 21:31:17.976598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 21:31:17.977222) ========= /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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:31:18 INFO - MultiFileLogger online at 20160810 21:31:18 in /builds/slave/test 21:31:18 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 21:31:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:31:18 INFO - {'append_to_log': False, 21:31:18 INFO - 'base_work_dir': '/builds/slave/test', 21:31:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:31:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:31:18 INFO - 'branch': 'Mozilla-Inbound', 21:31:18 INFO - 'buildbot_json_path': 'buildprops.json', 21:31:18 INFO - 'config_files': ('talos/linux_config.py',), 21:31:18 INFO - 'default_actions': ('clobber', 21:31:18 INFO - 'read-buildbot-config', 21:31:18 INFO - 'download-and-extract', 21:31:18 INFO - 'populate-webroot', 21:31:18 INFO - 'create-virtualenv', 21:31:18 INFO - 'install', 21:31:18 INFO - 'run-tests'), 21:31:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:31:18 INFO - 'download_minidump_stackwalk': True, 21:31:18 INFO - 'download_symbols': 'ondemand', 21:31:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:31:18 INFO - 'tooltool.py': '/tools/tooltool.py', 21:31:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:31:18 INFO - '/tools/misc-python/virtualenv.py')}, 21:31:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:31:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:31:18 INFO - 'installer_path': 'installer.exe', 21:31:18 INFO - 'log_level': 'info', 21:31:18 INFO - 'log_name': 'talos', 21:31:18 INFO - 'log_to_console': True, 21:31:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:31:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:31:18 INFO - 'opt_config_files': (), 21:31:18 INFO - 'pip_index': False, 21:31:18 INFO - 'sps_profile': False, 21:31:18 INFO - 'sps_profile_interval': 0, 21:31:18 INFO - 'suite': 'dromaeojs-e10s', 21:31:18 INFO - 'system_bits': '32', 21:31:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:31:18 INFO - 'title': 'talos-linux64-ix-018', 21:31:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:31:18 INFO - 'use_talos_json': True, 21:31:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:31:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:31:18 INFO - 'work_dir': 'build'} 21:31:18 INFO - [mozharness: 2016-08-11 04:31:18.210350Z] Running clobber step. 21:31:18 INFO - Running pre-action listener: _resource_record_pre_action 21:31:18 INFO - Running main action method: clobber 21:31:18 INFO - rmtree: /builds/slave/test/build 21:31:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:31:18 INFO - Running post-action listener: _resource_record_post_action 21:31:18 INFO - [mozharness: 2016-08-11 04:31:18.666961Z] Finished clobber step (success) 21:31:18 INFO - [mozharness: 2016-08-11 04:31:18.667060Z] Running read-buildbot-config step. 21:31:18 INFO - Running pre-action listener: _resource_record_pre_action 21:31:18 INFO - Running main action method: read_buildbot_config 21:31:18 INFO - Using buildbot properties: 21:31:18 INFO - { 21:31:18 INFO - "project": "", 21:31:18 INFO - "product": "firefox", 21:31:18 INFO - "script_repo_revision": "production", 21:31:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:31:18 INFO - "repository": "", 21:31:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:31:18 INFO - "buildid": "20160810193023", 21:31:18 INFO - "pgo_build": "True", 21:31:18 INFO - "basedir": "/builds/slave/test", 21:31:18 INFO - "buildnumber": 1471, 21:31:18 INFO - "slavename": "talos-linux64-ix-018", 21:31:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:31:18 INFO - "platform": "ubuntu64_hw", 21:31:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:31:18 INFO - "branch": "mozilla-inbound", 21:31:18 INFO - "repo_path": "integration/mozilla-inbound", 21:31:18 INFO - "revision": "32e07e32891d070cdba97e2872cd30265278c0bf", 21:31:18 INFO - "stage_platform": "linux64-pgo", 21:31:18 INFO - "builduid": "f93bbfd2ac634dc79b2cf707de6b214e", 21:31:18 INFO - "slavebuilddir": "test" 21:31:18 INFO - } 21:31:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:31:18 INFO - Running post-action listener: _resource_record_post_action 21:31:18 INFO - [mozharness: 2016-08-11 04:31:18.669476Z] Finished read-buildbot-config step (success) 21:31:18 INFO - [mozharness: 2016-08-11 04:31:18.669565Z] Running download-and-extract step. 21:31:18 INFO - Running pre-action listener: _resource_record_pre_action 21:31:18 INFO - Running main action method: download_and_extract 21:31:18 INFO - mkdir: /builds/slave/test/build/tests 21:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:18 INFO - trying https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:31:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:31:19 INFO - Downloaded 1361 bytes. 21:31:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:31:19 INFO - Using the following test package requirements: 21:31:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:31:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:31:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'jsshell-linux-x86_64.zip'], 21:31:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:31:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:31:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:31:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:31:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:31:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:19 INFO - trying https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:31:21 INFO - Downloaded 21833907 bytes. 21:31:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:31:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:31:22 INFO - Return code: 0 21:31:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:22 INFO - trying https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:31:23 INFO - Downloaded 21833907 bytes. 21:31:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:31:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:31:24 INFO - Return code: 0 21:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:24 INFO - trying https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:31:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:31:26 INFO - Downloaded 14413719 bytes. 21:31:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:31:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:31:26 INFO - Return code: 0 21:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:26 INFO - trying https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:31:28 INFO - Downloaded 59339792 bytes. 21:31:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:31:28 INFO - mkdir: /builds/slave/test/properties 21:31:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:31:28 INFO - Writing to file /builds/slave/test/properties/build_url 21:31:28 INFO - Contents: 21:31:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:31:29 INFO - Running post-action listener: _resource_record_post_action 21:31:29 INFO - Running post-action listener: set_extra_try_arguments 21:31:29 INFO - [mozharness: 2016-08-11 04:31:29.249668Z] Finished download-and-extract step (success) 21:31:29 INFO - [mozharness: 2016-08-11 04:31:29.249898Z] Running populate-webroot step. 21:31:29 INFO - Running pre-action listener: _resource_record_pre_action 21:31:29 INFO - Running main action method: populate_webroot 21:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:31:29 INFO - '--tppagecycles', 21:31:29 INFO - '7'], 21:31:29 INFO - 'tests': ['tsvgm']}}, 21:31:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:31:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:31:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:31:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:31:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['damp', 'tps']}, 21:31:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'tests': ['damp', 'tps']}, 21:31:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['dromaeo_dom']}, 21:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:31:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['basic_compositor_video']}, 21:31:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:31:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'other-e10s': {'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['a11yr', 21:31:29 INFO - 'ts_paint', 21:31:29 INFO - 'tpaint', 21:31:29 INFO - 'sessionrestore', 21:31:29 INFO - 'sessionrestore_no_auto_restore', 21:31:29 INFO - 'tabpaint']}, 21:31:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['tsvgx', 21:31:29 INFO - 'tsvgr_opacity', 21:31:29 INFO - 'tart', 21:31:29 INFO - 'tscrollx', 21:31:29 INFO - 'cart']}, 21:31:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:31:29 INFO - 'tsvgr_opacity', 21:31:29 INFO - 'tart', 21:31:29 INFO - 'tscrollx', 21:31:29 INFO - 'cart']}, 21:31:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'talos_options': ['--disable-e10s'], 21:31:29 INFO - 'tests': ['tp5o']}, 21:31:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'tests': ['tp5o']}, 21:31:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'talos_options': ['--disable-e10s', 21:31:29 INFO - '--xperf_path', 21:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:29 INFO - 'tests': ['tp5n']}, 21:31:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:29 INFO - 'talos_options': ['--xperf_path', 21:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:29 INFO - 'tests': ['tp5n']}}, 21:31:29 INFO - 'talos.zip': {'path': '', 21:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:31:29 INFO - Running post-action listener: _resource_record_post_action 21:31:29 INFO - [mozharness: 2016-08-11 04:31:29.270423Z] Finished populate-webroot step (success) 21:31:29 INFO - [mozharness: 2016-08-11 04:31:29.270511Z] Running create-virtualenv step. 21:31:29 INFO - Running pre-action listener: _resource_record_pre_action 21:31:29 INFO - Running main action method: create_virtualenv 21:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 21:31:29 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 21:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:31:29 INFO - Using real prefix '/usr' 21:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:31:29 INFO - Installing distribute.............................................................................................................................................................................................done. 21:31:31 INFO - Installing pip.................done. 21:31:31 INFO - Return code: 0 21:31:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:31 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:31 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 21:31:31 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 21:31:31 INFO - Using env: {'DISPLAY': ':0', 21:31:31 INFO - 'HOME': '/home/cltbld', 21:31:31 INFO - 'LANG': 'en_US.UTF-8', 21:31:31 INFO - 'LANGUAGE': 'en_US:en', 21:31:31 INFO - 'LOGNAME': 'cltbld', 21:31:31 INFO - 'MAIL': '/var/mail/cltbld', 21:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:31 INFO - 'MOZ_NO_REMOTE': '1', 21:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:31 INFO - 'NO_EM_RESTART': '1', 21:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:31 INFO - 'PWD': '/builds/slave/test', 21:31:31 INFO - 'SHELL': '/bin/bash', 21:31:31 INFO - 'SHLVL': '1', 21:31:31 INFO - 'TERM': 'linux', 21:31:31 INFO - 'TMOUT': '86400', 21:31:31 INFO - 'USER': 'cltbld', 21:31:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:31 INFO - '_': '/tools/buildbot/bin/python'} 21:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:32 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 21:31:32 INFO - Cleaning up... 21:31:32 INFO - Return code: 0 21:31:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:31:32 INFO - Using env: {'DISPLAY': ':0', 21:31:32 INFO - 'HOME': '/home/cltbld', 21:31:32 INFO - 'LANG': 'en_US.UTF-8', 21:31:32 INFO - 'LANGUAGE': 'en_US:en', 21:31:32 INFO - 'LOGNAME': 'cltbld', 21:31:32 INFO - 'MAIL': '/var/mail/cltbld', 21:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:32 INFO - 'MOZ_NO_REMOTE': '1', 21:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:32 INFO - 'NO_EM_RESTART': '1', 21:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:32 INFO - 'PWD': '/builds/slave/test', 21:31:32 INFO - 'SHELL': '/bin/bash', 21:31:32 INFO - 'SHLVL': '1', 21:31:32 INFO - 'TERM': 'linux', 21:31:32 INFO - 'TMOUT': '86400', 21:31:32 INFO - 'USER': 'cltbld', 21:31:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:32 INFO - '_': '/tools/buildbot/bin/python'} 21:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:32 INFO - Downloading/unpacking psutil>=3.1.1 21:31:32 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 21:31:32 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 21:31:32 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 21:31:32 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 21:31:32 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 21:31:32 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 21:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:34 INFO - Installing collected packages: psutil 21:31:34 INFO - Running setup.py install for psutil 21:31:34 INFO - building 'psutil._psutil_linux' extension 21:31:34 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 21:31:34 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 21:31:34 INFO - building 'psutil._psutil_posix' extension 21:31:34 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 21:31:34 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 21:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:34 INFO - Successfully installed psutil 21:31:34 INFO - Cleaning up... 21:31:34 INFO - Return code: 0 21:31:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:34 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:34 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 21:31:34 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 21:31:34 INFO - Using env: {'DISPLAY': ':0', 21:31:34 INFO - 'HOME': '/home/cltbld', 21:31:34 INFO - 'LANG': 'en_US.UTF-8', 21:31:34 INFO - 'LANGUAGE': 'en_US:en', 21:31:34 INFO - 'LOGNAME': 'cltbld', 21:31:34 INFO - 'MAIL': '/var/mail/cltbld', 21:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:34 INFO - 'MOZ_NO_REMOTE': '1', 21:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:34 INFO - 'NO_EM_RESTART': '1', 21:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:34 INFO - 'PWD': '/builds/slave/test', 21:31:34 INFO - 'SHELL': '/bin/bash', 21:31:34 INFO - 'SHLVL': '1', 21:31:34 INFO - 'TERM': 'linux', 21:31:34 INFO - 'TMOUT': '86400', 21:31:34 INFO - 'USER': 'cltbld', 21:31:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:34 INFO - '_': '/tools/buildbot/bin/python'} 21:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:31:35 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 21:31:35 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 21:31:35 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 21:31:35 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 21:31:35 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 21:31:35 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 21:31:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:31:36 INFO - Installing collected packages: mozsystemmonitor 21:31:36 INFO - Running setup.py install for mozsystemmonitor 21:31:37 INFO - Successfully installed mozsystemmonitor 21:31:37 INFO - Cleaning up... 21:31:37 INFO - Return code: 0 21:31:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:37 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:37 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 21:31:37 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 21:31:37 INFO - Using env: {'DISPLAY': ':0', 21:31:37 INFO - 'HOME': '/home/cltbld', 21:31:37 INFO - 'LANG': 'en_US.UTF-8', 21:31:37 INFO - 'LANGUAGE': 'en_US:en', 21:31:37 INFO - 'LOGNAME': 'cltbld', 21:31:37 INFO - 'MAIL': '/var/mail/cltbld', 21:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:37 INFO - 'MOZ_NO_REMOTE': '1', 21:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:37 INFO - 'NO_EM_RESTART': '1', 21:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:37 INFO - 'PWD': '/builds/slave/test', 21:31:37 INFO - 'SHELL': '/bin/bash', 21:31:37 INFO - 'SHLVL': '1', 21:31:37 INFO - 'TERM': 'linux', 21:31:37 INFO - 'TMOUT': '86400', 21:31:37 INFO - 'USER': 'cltbld', 21:31:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:37 INFO - '_': '/tools/buildbot/bin/python'} 21:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:37 INFO - Downloading/unpacking jsonschema==2.5.1 21:31:37 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 21:31:37 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 21:31:37 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 21:31:37 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 21:31:37 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 21:31:37 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 21:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:31:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:31:39 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 21:31:39 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 21:31:39 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 21:31:39 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 21:31:39 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 21:31:39 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 21:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:31:39 INFO - warning: no files found matching '*.txt' 21:31:39 INFO - no previously-included directories found matching 'build' 21:31:39 INFO - no previously-included directories found matching 'dist' 21:31:39 INFO - no previously-included directories found matching '.git*' 21:31:39 INFO - Installing collected packages: jsonschema, functools32 21:31:39 INFO - Running setup.py install for functools32 21:31:39 INFO - warning: no files found matching '*.txt' 21:31:39 INFO - no previously-included directories found matching 'build' 21:31:39 INFO - no previously-included directories found matching 'dist' 21:31:39 INFO - no previously-included directories found matching '.git*' 21:31:39 INFO - Successfully installed jsonschema functools32 21:31:39 INFO - Cleaning up... 21:31:39 INFO - Return code: 0 21:31:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:31:39 INFO - Using env: {'DISPLAY': ':0', 21:31:39 INFO - 'HOME': '/home/cltbld', 21:31:39 INFO - 'LANG': 'en_US.UTF-8', 21:31:39 INFO - 'LANGUAGE': 'en_US:en', 21:31:39 INFO - 'LOGNAME': 'cltbld', 21:31:39 INFO - 'MAIL': '/var/mail/cltbld', 21:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:39 INFO - 'MOZ_NO_REMOTE': '1', 21:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:39 INFO - 'NO_EM_RESTART': '1', 21:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:39 INFO - 'PWD': '/builds/slave/test', 21:31:39 INFO - 'SHELL': '/bin/bash', 21:31:39 INFO - 'SHLVL': '1', 21:31:39 INFO - 'TERM': 'linux', 21:31:39 INFO - 'TMOUT': '86400', 21:31:39 INFO - 'USER': 'cltbld', 21:31:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:39 INFO - '_': '/tools/buildbot/bin/python'} 21:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:31:39 INFO - Cleaning up... 21:31:39 INFO - Return code: 0 21:31:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:39 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:39 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 21:31:39 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 21:31:39 INFO - Using env: {'DISPLAY': ':0', 21:31:39 INFO - 'HOME': '/home/cltbld', 21:31:39 INFO - 'LANG': 'en_US.UTF-8', 21:31:39 INFO - 'LANGUAGE': 'en_US:en', 21:31:39 INFO - 'LOGNAME': 'cltbld', 21:31:39 INFO - 'MAIL': '/var/mail/cltbld', 21:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:39 INFO - 'MOZ_NO_REMOTE': '1', 21:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:39 INFO - 'NO_EM_RESTART': '1', 21:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:39 INFO - 'PWD': '/builds/slave/test', 21:31:39 INFO - 'SHELL': '/bin/bash', 21:31:39 INFO - 'SHLVL': '1', 21:31:39 INFO - 'TERM': 'linux', 21:31:39 INFO - 'TMOUT': '86400', 21:31:39 INFO - 'USER': 'cltbld', 21:31:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:39 INFO - '_': '/tools/buildbot/bin/python'} 21:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:40 INFO - Downloading/unpacking blobuploader==1.2.4 21:31:40 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 21:31:40 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 21:31:40 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 21:31:40 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 21:31:40 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 21:31:40 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 21:31:41 INFO - Downloading blobuploader-1.2.4.tar.gz 21:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 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 21:31:42 INFO - Downloading docopt-0.6.1.tar.gz 21:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:31:42 INFO - Installing collected packages: blobuploader, requests, docopt 21:31:42 INFO - Running setup.py install for blobuploader 21:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:31:42 INFO - Running setup.py install for requests 21:31:43 INFO - Running setup.py install for docopt 21:31:43 INFO - Successfully installed blobuploader requests docopt 21:31:43 INFO - Cleaning up... 21:31:43 INFO - Return code: 0 21:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:43 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:43 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 21:31:43 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 21:31:43 INFO - Using env: {'DISPLAY': ':0', 21:31:43 INFO - 'HOME': '/home/cltbld', 21:31:43 INFO - 'LANG': 'en_US.UTF-8', 21:31:43 INFO - 'LANGUAGE': 'en_US:en', 21:31:43 INFO - 'LOGNAME': 'cltbld', 21:31:43 INFO - 'MAIL': '/var/mail/cltbld', 21:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:43 INFO - 'MOZ_NO_REMOTE': '1', 21:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:43 INFO - 'NO_EM_RESTART': '1', 21:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:43 INFO - 'PWD': '/builds/slave/test', 21:31:43 INFO - 'SHELL': '/bin/bash', 21:31:43 INFO - 'SHLVL': '1', 21:31:43 INFO - 'TERM': 'linux', 21:31:43 INFO - 'TMOUT': '86400', 21:31:43 INFO - 'USER': 'cltbld', 21:31:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:43 INFO - '_': '/tools/buildbot/bin/python'} 21:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:43 INFO - Running setup.py (path:/tmp/pip-CMflC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:43 INFO - Running setup.py (path:/tmp/pip-xPaCO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:43 INFO - Running setup.py (path:/tmp/pip-LUd6zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:43 INFO - Running setup.py (path:/tmp/pip-F4WAnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:43 INFO - Running setup.py (path:/tmp/pip-pZBtOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:43 INFO - Running setup.py (path:/tmp/pip-_i7me_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:43 INFO - Running setup.py (path:/tmp/pip-ADt7qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:44 INFO - Running setup.py (path:/tmp/pip-rpiFGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:44 INFO - Running setup.py (path:/tmp/pip-vvvOW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:44 INFO - Running setup.py (path:/tmp/pip-OtgOxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:44 INFO - Running setup.py (path:/tmp/pip-hJgtxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:44 INFO - Running setup.py (path:/tmp/pip-0fBVRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:44 INFO - Running setup.py (path:/tmp/pip-ge_lVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:44 INFO - Running setup.py (path:/tmp/pip-57Fzcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:44 INFO - Running setup.py (path:/tmp/pip-plguRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:44 INFO - Running setup.py (path:/tmp/pip-16Zohu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:44 INFO - Running setup.py (path:/tmp/pip-G6Df3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:31:44 INFO - Running setup.py install for manifestparser 21:31:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:31:44 INFO - Running setup.py install for mozcrash 21:31:44 INFO - Running setup.py install for mozdebug 21:31:45 INFO - Running setup.py install for mozdevice 21:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for mozfile 21:31:45 INFO - Running setup.py install for mozhttpd 21:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for mozinfo 21:31:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for mozInstall 21:31:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for mozleak 21:31:45 INFO - Running setup.py install for mozlog 21:31:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for moznetwork 21:31:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:31:45 INFO - Running setup.py install for mozprocess 21:31:46 INFO - Running setup.py install for mozprofile 21:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:31:46 INFO - Running setup.py install for mozrunner 21:31:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:31:46 INFO - Running setup.py install for mozscreenshot 21:31:46 INFO - Running setup.py install for moztest 21:31:46 INFO - Running setup.py install for mozversion 21:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:31:46 INFO - Cleaning up... 21:31:46 INFO - Return code: 0 21:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:46 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:46 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 21:31:46 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 21:31:46 INFO - Using env: {'DISPLAY': ':0', 21:31:46 INFO - 'HOME': '/home/cltbld', 21:31:46 INFO - 'LANG': 'en_US.UTF-8', 21:31:46 INFO - 'LANGUAGE': 'en_US:en', 21:31:46 INFO - 'LOGNAME': 'cltbld', 21:31:46 INFO - 'MAIL': '/var/mail/cltbld', 21:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:46 INFO - 'MOZ_NO_REMOTE': '1', 21:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:46 INFO - 'NO_EM_RESTART': '1', 21:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:46 INFO - 'PWD': '/builds/slave/test', 21:31:46 INFO - 'SHELL': '/bin/bash', 21:31:46 INFO - 'SHLVL': '1', 21:31:46 INFO - 'TERM': 'linux', 21:31:46 INFO - 'TMOUT': '86400', 21:31:46 INFO - 'USER': 'cltbld', 21:31:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:46 INFO - '_': '/tools/buildbot/bin/python'} 21:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:46 INFO - Running setup.py (path:/tmp/pip-Zmhqqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:46 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)) 21:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:46 INFO - Running setup.py (path:/tmp/pip-zfV3oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:46 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)) 21:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:46 INFO - Running setup.py (path:/tmp/pip-PoL6po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:47 INFO - Running setup.py (path:/tmp/pip-sLM2tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:47 INFO - Running setup.py (path:/tmp/pip-9KUBap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:47 INFO - Running setup.py (path:/tmp/pip-yqNumH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:47 INFO - Running setup.py (path:/tmp/pip-ZpdfK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:47 INFO - Running setup.py (path:/tmp/pip-cFRcYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:47 INFO - Running setup.py (path:/tmp/pip-6LdBrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:47 INFO - Running setup.py (path:/tmp/pip-sI31ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:47 INFO - Running setup.py (path:/tmp/pip-ubY69X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:47 INFO - Running setup.py (path:/tmp/pip-CO0cvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:47 INFO - Running setup.py (path:/tmp/pip-jAqPKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:47 INFO - Running setup.py (path:/tmp/pip-rd35RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:47 INFO - Running setup.py (path:/tmp/pip-NcBYnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:47 INFO - Running setup.py (path:/tmp/pip-MN9SBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:47 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)) 21:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:47 INFO - Running setup.py (path:/tmp/pip-ING8QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:48 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)) 21:31:48 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)) 21:31:48 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)) 21:31:48 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)) 21:31:48 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)) 21:31:48 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)) 21:31:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:31: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 21:31: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 21:31: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 21:31: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 21:31: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 21:31: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 21:31:49 INFO - Downloading blessings-1.6.tar.gz 21:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:31:50 INFO - Installing collected packages: blessings 21:31:50 INFO - Running setup.py install for blessings 21:31:50 INFO - Successfully installed blessings 21:31:50 INFO - Cleaning up... 21:31:50 INFO - Return code: 0 21:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:31:50 INFO - Reading from file tmpfile_stdout 21:31:50 INFO - Current package versions: 21:31:50 INFO - argparse == 1.2.1 21:31:50 INFO - blessings == 1.6 21:31:50 INFO - blobuploader == 1.2.4 21:31:50 INFO - docopt == 0.6.1 21:31:50 INFO - functools32 == 3.2.3-2 21:31:50 INFO - jsonschema == 2.5.1 21:31:50 INFO - manifestparser == 1.1 21:31:50 INFO - mozInstall == 1.12 21:31:50 INFO - mozcrash == 0.17 21:31:50 INFO - mozdebug == 0.1 21:31:50 INFO - mozdevice == 0.48 21:31:50 INFO - mozfile == 1.2 21:31:50 INFO - mozhttpd == 0.7 21:31:50 INFO - mozinfo == 0.9 21:31:50 INFO - mozleak == 0.1 21:31:50 INFO - mozlog == 3.3 21:31:50 INFO - moznetwork == 0.27 21:31:50 INFO - mozprocess == 0.23 21:31:50 INFO - mozprofile == 0.28 21:31:50 INFO - mozrunner == 6.12 21:31:50 INFO - mozscreenshot == 0.1 21:31:50 INFO - mozsystemmonitor == 0.3 21:31:50 INFO - moztest == 0.7 21:31:50 INFO - mozversion == 1.4 21:31:50 INFO - psutil == 3.1.1 21:31:50 INFO - requests == 1.2.3 21:31:50 INFO - wsgiref == 0.1.2 21:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:50 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:50 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 21:31:50 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 21:31:50 INFO - Using env: {'DISPLAY': ':0', 21:31:50 INFO - 'HOME': '/home/cltbld', 21:31:50 INFO - 'LANG': 'en_US.UTF-8', 21:31:50 INFO - 'LANGUAGE': 'en_US:en', 21:31:50 INFO - 'LOGNAME': 'cltbld', 21:31:50 INFO - 'MAIL': '/var/mail/cltbld', 21:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:50 INFO - 'MOZ_NO_REMOTE': '1', 21:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:50 INFO - 'NO_EM_RESTART': '1', 21:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:50 INFO - 'PWD': '/builds/slave/test', 21:31:50 INFO - 'SHELL': '/bin/bash', 21:31:50 INFO - 'SHLVL': '1', 21:31:50 INFO - 'TERM': 'linux', 21:31:50 INFO - 'TMOUT': '86400', 21:31:50 INFO - 'USER': 'cltbld', 21:31:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:50 INFO - '_': '/tools/buildbot/bin/python'} 21:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 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)) 21:31:50 INFO - Cleaning up... 21:31:50 INFO - Return code: 0 21:31:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:50 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 0xe9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, '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': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', '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 21:31:50 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 21:31:50 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 21:31:50 INFO - Using env: {'DISPLAY': ':0', 21:31:50 INFO - 'HOME': '/home/cltbld', 21:31:50 INFO - 'LANG': 'en_US.UTF-8', 21:31:50 INFO - 'LANGUAGE': 'en_US:en', 21:31:50 INFO - 'LOGNAME': 'cltbld', 21:31:50 INFO - 'MAIL': '/var/mail/cltbld', 21:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:50 INFO - 'MOZ_NO_REMOTE': '1', 21:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:50 INFO - 'NO_EM_RESTART': '1', 21:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:50 INFO - 'PWD': '/builds/slave/test', 21:31:50 INFO - 'SHELL': '/bin/bash', 21:31:50 INFO - 'SHLVL': '1', 21:31:50 INFO - 'TERM': 'linux', 21:31:50 INFO - 'TMOUT': '86400', 21:31:50 INFO - 'USER': 'cltbld', 21:31:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:50 INFO - '_': '/tools/buildbot/bin/python'} 21:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:31:50 INFO - Cleaning up... 21:31:50 INFO - Return code: 0 21:31:50 INFO - Running post-action listener: _resource_record_post_action 21:31:50 INFO - Running post-action listener: _start_resource_monitoring 21:31:50 INFO - Starting resource monitoring. 21:31:50 INFO - [mozharness: 2016-08-11 04:31:50.966634Z] Finished create-virtualenv step (success) 21:31:50 INFO - [mozharness: 2016-08-11 04:31:50.967111Z] Running install step. 21:31:50 INFO - Running pre-action listener: _resource_record_pre_action 21:31:50 INFO - Running main action method: install 21:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:31:51 INFO - Reading from file tmpfile_stdout 21:31:51 INFO - Detecting whether we're running mozinstall >=1.0... 21:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:31:51 INFO - Reading from file tmpfile_stdout 21:31:51 INFO - Output received: 21:31:51 INFO - Usage: mozinstall [options] installer 21:31:51 INFO - Options: 21:31:51 INFO - -h, --help show this help message and exit 21:31:51 INFO - -d DEST, --destination=DEST 21:31:51 INFO - Directory to install application into. [default: 21:31:51 INFO - "/builds/slave/test"] 21:31:51 INFO - --app=APP Application being installed. [default: firefox] 21:31:51 INFO - mkdir: /builds/slave/test/build/application 21:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:32:08 INFO - Reading from file tmpfile_stdout 21:32:08 INFO - Output received: 21:32:08 INFO - /builds/slave/test/build/application/firefox/firefox 21:32:08 INFO - Running post-action listener: _resource_record_post_action 21:32:08 INFO - [mozharness: 2016-08-11 04:32:08.188329Z] Finished install step (success) 21:32:08 INFO - [mozharness: 2016-08-11 04:32:08.188576Z] Running run-tests step. 21:32:08 INFO - Running pre-action listener: _resource_record_pre_action 21:32:08 INFO - Running main action method: run_tests 21:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:32:08 INFO - Python 2.7.3 21:32:08 INFO - Return code: 0 21:32:08 INFO - grabbing minidump binary from tooltool 21:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:08 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 0x115c570>, '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 0x115d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:32:08 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 21:32:08 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 21:32:08 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 21:32:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:32:08 INFO - Return code: 0 21:32:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:32:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:32:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:32:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:32:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:32:08 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/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 21:32:08 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/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 21:32:08 INFO - Using env: {'DISPLAY': ':0', 21:32:08 INFO - 'HOME': '/home/cltbld', 21:32:08 INFO - 'LANG': 'en_US.UTF-8', 21:32:08 INFO - 'LANGUAGE': 'en_US:en', 21:32:08 INFO - 'LOGNAME': 'cltbld', 21:32:08 INFO - 'MAIL': '/var/mail/cltbld', 21:32:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:32:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:08 INFO - 'MOZ_NO_REMOTE': '1', 21:32:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:08 INFO - 'NO_EM_RESTART': '1', 21:32:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:08 INFO - 'PWD': '/builds/slave/test', 21:32:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:32:08 INFO - 'SHELL': '/bin/bash', 21:32:08 INFO - 'SHLVL': '1', 21:32:08 INFO - 'TERM': 'linux', 21:32:08 INFO - 'TMOUT': '86400', 21:32:08 INFO - 'USER': 'cltbld', 21:32:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785', 21:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:08 INFO - '_': '/tools/buildbot/bin/python'} 21:32:08 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/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 21:32:08 INFO - mozversion application_buildid: 20160810193023 21:32:08 INFO - mozversion application_changeset: 32e07e32891d070cdba97e2872cd30265278c0bf 21:32:08 INFO - mozversion application_display_name: Nightly 21:32:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:32:08 INFO - mozversion application_name: Firefox 21:32:08 INFO - mozversion application_remotingname: firefox 21:32:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:32:08 INFO - mozversion application_vendor: Mozilla 21:32:08 INFO - mozversion application_version: 51.0a1 21:32:08 INFO - mozversion platform_buildid: 20160810193023 21:32:08 INFO - mozversion platform_changeset: 32e07e32891d070cdba97e2872cd30265278c0bf 21:32:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:32:08 INFO - mozversion platform_version: 51.0a1 21:32:08 INFO - using testdate: 1470889928 21:32:08 INFO - actual date: 1470889928 21:32:08 INFO - starting webserver on 'localhost:56004' 21:32:08 INFO - SUITE-START | Running 2 tests 21:32:08 INFO - TEST-START | dromaeo_css 21:32:08 INFO - operating with platform_type : linux_ 21:32:08 INFO - Initialising browser for dromaeo_css test... 21:32:08 INFO - TEST-INFO | started process 6493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsqDUO/profile http://localhost:56004/getInfo.html) 21:32:12 INFO - PROCESS | 6493 | __metrics Screen width/height:1600/1200 21:32:12 INFO - PROCESS | 6493 | colorDepth:24 21:32:12 INFO - PROCESS | 6493 | Browser inner width/height: 1024/697 21:32:12 INFO - PROCESS | 6493 | __metrics 21:32:13 ERROR - PROCESS | 6493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:32:14 INFO - TEST-INFO | 6493: exit 0 21:32:14 INFO - Browser initialized. 21:32:14 INFO - Running cycle 1/1 for dromaeo_css test... 21:32:14 INFO - TEST-INFO | started process 6610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsqDUO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:32:25 INFO - PROCESS | 6610 | RSS: Main: 163328000 21:32:25 INFO - PROCESS | 6610 | 21:33:15 INFO - PROCESS | 6610 | 1470889995415 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] 21:35:25 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56004/tests/dromaeo/cssquery-ext.html) 21:35:26 INFO - PROCESS | 6610 | RSS: Main: 166916096 21:35:26 INFO - PROCESS | 6610 | 21:38:28 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-ext.html (next: http://localhost:56004/tests/dromaeo/cssquery-jquery.html) 21:38:28 INFO - PROCESS | 6610 | RSS: Main: 165302272 21:38:28 INFO - PROCESS | 6610 | 21:41:30 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56004/tests/dromaeo/cssquery-mootools.html) 21:41:31 INFO - PROCESS | 6610 | RSS: Main: 169009152 21:41:31 INFO - PROCESS | 6610 | 21:44:33 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56004/tests/dromaeo/cssquery-prototype.html) 21:44:33 INFO - PROCESS | 6610 | RSS: Main: 163414016 21:44:33 INFO - PROCESS | 6610 | 21:47:36 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56004/tests/dromaeo/cssquery-yui.html) 21:47:37 INFO - PROCESS | 6610 | RSS: Main: 165756928 21:47:37 INFO - PROCESS | 6610 | 21:50:39 INFO - PROCESS | 6610 | Cycle 1(1): loaded http://localhost:56004/tests/dromaeo/cssquery-yui.html (next: http://localhost:56004/tests/dromaeo/cssquery-dojo.html) 21:50:40 INFO - PROCESS | 6610 | RSS: Main: 168988672 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | __start_tp_report 21:50:40 INFO - PROCESS | 6610 | _x_x_mozilla_page_load 21:50:40 INFO - PROCESS | 6610 | _x_x_mozilla_page_load_details 21:50:40 INFO - PROCESS | 6610 | |i|pagename|runs| 21:50:40 INFO - PROCESS | 6610 | |0;dojo.html;3102.565640810287;3122.718955294023;3129.217695576106;3141.151888989971;3154.6056742907135;5342.599305052117;5388.461153884609;5434.320709911256;5449.373322067953;5483.670979741213;5404.513593776559;5419.160030195326;5431.049566325897;5444.210589464526;5460.399356070829;4891.5353041461;4980.676256043345;5025.874353141183;5044.39467263927;5116.718580478072;5060.822871199509;5064.063148317573;5078.5175408336145;5119.4880511948695;5119.820806271781;4904.803807847682;4909.1409003424615;4938.358013458227;5012.04771093491;5014.072396606622;4848.85453436394;4999.725015124167;5034.11902916988;5040.042391945555;5064.11378008847;4916.041371932474;4968.279599458095;4968.552830245259;4993.800247990076;5025.572826309732;5352;5357.330333708286;5466.043442397565;5476.945230547723;5481.75332110056;5742.397048309951;5848.766049358021;5862.413758624146;5899.410058994109;5900.822975310747;5888.5877988540815;5902.32123305821;5902.439268269508;5903.114532820111;5920.79277225295;5280.234366016906;5380.300560927054;5469.261649677323;5479.561635069185;5482.451754824526;5931.199288096138;6010.098485227251;6013.30846952606;6046.788362407295;6060.848478787977;5748.223989761329;5781.5952883298605;5789.247397838254;5792.275965504312;5794.159846822187;5652.717364131777;5724.25584673998;5857.824265272048;5867.559933005042;5869;5740.712964351766;5792;5809.099589563624;5840.678762668094;5850.882982340329;5803.854903627359;5805.245318108618;5813.76744930198;5815.73829177688;5833.970830145907;4440.444944381952;4480.507144214133;4489.461264648263;4496.527864574238;4529.705569137996;3979.1842672252697;4006.0185254612807;4049.5950404959267;4062.2484840304637;4072.9796351018053;5490.752916118784;5521.171824226318;5526.944730552643;5574.358948720949;5576.0241957657245;5689.630174038757;5776.046952252916;5858.94141058584;5859.941400586024;5869.530437564985;5447.618666693294;5503.064479038573;5515.310586176728;5574.693391863405;5624.521915637217;5016.899662006739;5034.84895453137;5037.697738135724;5050;5101.821436249787;5937.495312898452;6031.849203769941;6051.092336149525;6064.75740970365;6084.452399284174;5789.9710501447225;5793.246877905845;5861.267341582302;5901.5868889177345;5964.850878728066;6060.575759696779;6091.8781624366375;6094;6102.145699602148;6109.144719739329;5694.259746233129;5765.336986246635;5773.393793651606;5774.538036957118;5777.22007528995;5767.538596912321;5784.652920824764;5835.2122463466885;5862.912056319074;5888.882222355614;5729.914051289317;5733.397993210653;5744.5117165039765;5744.913826292525;5745.8563535911935;5507.889842203213;5641.153826925994;5689.402612725604;5700.315962084576;5716.199732037435;5664.801731939528;5675.404082571271;5753.3958934311295;5799.536037116936;5835;5703.714814259188;5815.41845815415;5816.098504731774;5827.70861456917;5834.649921004753;5651.067573850433;5665;5690.971545142248;5692.800751973661;5720.713964301852 21:50:40 INFO - PROCESS | 6610 | |1;ext.html;553.4133818152758;589.8613825750948;600.8978473659478;613.034470708634;630.7477009196324;40119.79940100299;44891.77554112233;44918;44972.77513612436;45017.32474012888;44998.32502512465;45501.7724911375;45590.948407321666;45621.31568026482;45708.77145614276;8798.164174403437;8914;8941.731748047569;8960.28317734583;8989.640414383417;8794.164554367326;8952.686655967042;8956.462612243286;8959.910400896006;8977.640894364218;8999.41503802254;9032.548372581377;9045.954770226139;9046.231070359026;9052.8642070369;8944.508052057134;8995.460272383645;8996.370254082183;9018.503982280972;9043;8793.7801554961;8862.069482704288;8862.822743545094;8866;8880.777980550472;42949.14101717948;43180.78409607932;43290.350644740356;43298.350524742156;43496.13007739859;3772.4152756322537;3790.8483660653815;3847.5190601174854;3885.33949228629;4146.875593732193;33565.83217083923;34017.14957126067;34136.65863341359;34146.48780268298;34429.82785086059;4256;4382.649388048949;4400.713953593006;4470.575295346936;4614.423197100363;402208;403734.9999999971;404085;404318;405616;61515.38484615096;61558;61617.38382616206;61777.38222617806;62146.378536214965;37169.81415092907;38138.04654883595;65208;65212.34787652158;65415.67292163509;18029;18173.273069077353;18195.909020454812;18205.453836384928;18208.726869096976;13761;13840.377183026789;13871.306434678225;13916.443342266197;13925;20120.496987575134;20202.191912323342;20302.796972030384;20319.155318255456;20457.693134602992;7299.5620262784405;7431.962840185764;7483.438742094365;7574.016526943653;7684.6926122954455;934.5467448287575;1055.3615062886997;1059.5391004912733;1148.1618418554335;1166.049669519339;32291.677083228868;33774.83112584471;33832.661673383445;33853.49219761706;34478.65521344754;1110.5502271580024;1130.8812574679541;1166.445938179358;1175.3183153770963;1188.1385995153444;17692.84996475225;17887;17893.821061789477;17904.55238619019;17986.91006544985;627443;634305;635933;637820;637914;60670.393296067356;61418.69290653518;61631.38368616257;61671.38328616746;61704.69147654233;1317.0648839324188;1332.8067430222563;1337.4048548396065;1339.049275014731;1361.3873756809476;31204;33838.49242261319;33877.66122338745;33922.32155356929;33923.49114763231;53583.732081339345;53600.195997059294;53935.19097213623;53965;54060.18909716436;470138;471832;474167;475512;476896;28732.569011464428;29605.407891841613;29635;30015.399692006475;30049.497525124094;47225;47264.7636761814;47709.5229047719;48447.27329089996;50864.74567627286;40195.61994408095;42875.35686964761;43111.88811188811;43633.56366436295;43669.34495982499;43289.567104328555;43302.78348608363;43624;44012;44082.55917440913;41647.791761041;42138.57861421469;42389.78805105955;42420.36369454522;42875.142497150504;35852.82073589615;38099;38247.42628860625;38933.415998759476;39106;28975.85512072426;29016.709832902245;29191.270218243862;29296;29656.258593535335 21:50:40 INFO - PROCESS | 6610 | |2;jquery.html;394.86574564648015;396.2194476880548;404.5347849972532;410.1653135868508;420.1953259508042;18755.718664220032;19727.704084438745;20123.899380503077;20364.185432582697;20383.694244586324;18927.33754318599;19245.61508769824;20438.795612043876;20515.487112822186;20672.379828605128;5591.384947655764;5696;5818.5453636590855;5845.766169353221;5866.794662186803;5718.313802343725;5760.53915686744;5769.884602307972;5777.393373695764;5786.623869448494;5673.404292549285;5679.176519404684;5780.277465316835;5810.622309549887;5832.2418085649015;5659.830205093854;5750.309962804448;5784.132380142991;5798.1592669063175;5804.303483581955;5064.063148317573;5132.640715149941;5145.588352931794;5163.7159956202395;5169.457206993249;17032.40386586476;21499.2475263365;23135.190268340695;23297.301080967598;23574.76425235743;2278.908843646252;2403.9519209615883;2540.2125341144306;2714.009386573906;2774.542200536909;11044.558217671363;11056.723581910435;11276.43617819114;11360.48877800501;14006.29968501581;1929.3343796390222;1967.2917749610128;1985.811347921945;1997.5617555360118;2032.3293313206607;88093.55953220192;88918.55540722255;90199;90724;92609.53695231548;11093.335999599964;11389.202755807013;11561.710957225969;11675.299482031105;12023.759524809455;16300.918495407446;16309.83690163107;16313.83686163147;16364.590885227726;16370.918145409196;8055.879161812578;8257.628406721711;8360.498370097692;8423.70517031901;8675.522846243517;7860.174681658458;7956.5226086435;8150.225728555778;8172.877406838902;8234.258916697527;4800.35195248644;4847.709137451694;4925.310456536088;4975.950240497621;5129.897402051938;1978.2186036515495;2027.28031548801;2035.3893831850385;2044.182327069184;2075.8546901717036;916.3906002508257;937.7702462896634;1011.9696409107738;1047.2616805152502;1075.1936047964027;20479.4880127998;20496.69254961177;20600.58798824045;20636.380908572766;20893;977.4770497783652;983.4197823284154;998.4708104704519;1051.9053285204368;1083.842842787807;10690.251682382159;11512.136589755803;11587.652370428901;11614.361210133355;11617.535298587962;500368;509320;516167;516472;517083;91858;93636;94223.31965430867;95956;97075.51462242784;991.8313886639289;1020.2705065877933;1027.6557353286582;1028.136365453023;1028.840529717895;17828.286868525633;18505.167267472727;19060.332888348843;19169;19275.22899084021;44077.33883991807;44736.55263447454;44980.325295121256;45232.54767452284;45554.77222613866;57974;60825.69587152036;66642;66644;68326.9750953746;8833.911660883308;9102.13529714676;9164.541772911462;9204.171624553823;9205.815883682422;13607.047506674438;13738.65653358674;13964.087776550672;14104.929475352557;14304.499342522962;11516.769664606494;12152.331621760535;12186;12450;12541.184822986477;10464;11621.535138594361;11645.359505227294;11715.414229288672;11728.530858765555;11776.882231177578;11791.469383877575;11811.645650630495;12408.503659853866;12675.683107922376;9010;9038.276937845088;9087.182153606207;9098.454092754457;9144.908550914406;9964.501774911081;11600.245984011011;11864.050875929732;11904.226225295328;12543.059270554562 21:50:40 INFO - PROCESS | 6610 | |3;mootools.html;1504.2027725305586;1509.6376869551307;1663.6773764856937;1779.3861117914314;1791.4804706635077;8077.19228077192;8723.956380218098;8826.117388261171;9420.670276540322;9480.288978326627;8913.68802091927;9228.584713687884;9278.768030799216;9311.767205819859;9313.58088886;2395.724491683457;2412.601920683085;2430.878456077198;2435.0868424340874;2442.0476014354417;2362.2086600988605;2396.8322217444784;2436.1473484280536;2439.1706819681303;2448.7673671001226;2433.4038160650666;2445.303088619744;2451.5464639041834;2464.827462077655;2470.3824043989002;2353.8116950643907;2360.78752912237;2364.9645255321184;2372.418757404438;2375.5130198309307;2313.733920599119;2351.0478256306224;2353.329301149164;2357.351728274738;2368.7512811154925;8750.649974001033;8865.822683546357;8947.865782013276;8953.283737301;8956.283497320199;5415.810446634349;5496.615236933416;5507.421720719347;5533.750981205855;5542.11326187812;3840.9231815363537;3853.6319606539555;3871.593482684306;3882.1459278958864;3895.7467764595212;1237.876212378764;1255.7362953779718;1257.704439456727;1283.6277479530925;1291.9741605167937;12920.935395322964;12945.87054129456;12955.352232388343;13033.087683862133;13069.477220911152;4730.337752714623;4817.78319975602;4855;4877.219644856806;5024.6733962293065;11001.449927503592;11004.669859904216;11010.614628487965;11010.669679909615;11035;5552.694601796859;5573.832785016456;5580.916286255629;5581.888362232733;5583.860403489864;4511.661625378109;4819.831305904277;4909.239067944474;4919.581835543947;5099.36257967754;4105.641192379854;4135.17296540693;4192.014876504019;4234.470691163605;4321.157374312042;1340.7787715027107;1355.59382096779;1362.1826903857607;1383.3429121167364;1397.8881689464818;939.8167357365248;985.1183191044119;1019.8113349030453;1032.5714828346152;1038.460000799595;6252.406021427957;6400.807975760735;6436;6487.3836985486305;6662.333766623396;987.5259875259916;1001.8246806808779;1006.3257617396362;1010.8433192855119;1011.903869132446;4331.97834010828;4354.390385346054;4371.278739008028;4548.4541854977615;4577.496475387771;11312.20814542974;11758;11774;11797.056235501312;11805.114616403633;11483.770324593628;11595.942020290013;11745.882541174478;11779.705507362212;11842.76314473723;8352.582370881431;8591.957040214758;8662.263707584925;8667.479951203075;8740.169683880022;6155.569110162246;6363.268224154282;6408.58344207625;6506.41442270198;6563.737450502117;10198.949005254926;10732.892671073188;10742.51658675377;10793.56825726962;10879.728006799893;10663.89336106629;10869.728256793327;10970.670879873616;10977.83533246986;10995.34027958325;7979.441439099207;8187.4678145920325;8192.385571082074;8214.712485062993;8377.748667539983;9217.953910230406;9271.30465215098;9280.118388753057;9300.534973251446;9328.39365441244;7992.560409177318;8053.275205231557;8125.634346454305;8345.082040975609;8483.787905302417;8090.110087890445;8101.270885620323;8137.674493020213;8259;8284.25441710249;7407.740729074457;7439.404847612286;7503.587302698404;7520.323170914644;7526.209747976603;5500.834974950758;5571.972140139435;5613.158026296088;5629.915551266816;5737;5483.75323110453;5489.39616642177;5637.49262566371;5647.887042259214;5682.062459694104 21:50:40 INFO - PROCESS | 6610 | |4;prototype.html;318.4331889237157;325.51660783736156;328.1877353549963;332.23254282607166;332.966703329667;5367.865803354908;5450.809221677242;5543.390227075019;5616.578756593257;5655.1517272409155;5430.56555475562;5462.590305727076;5462.945370546293;5468.152436372358;5535.671438854676;4353.847615333456;4378.233809083414;4378.81771921581;4380.3210502372185;4422.579854913794;4105.9178816423655;4296.355546667994;4363.585459381369;4411.42651455312;4415.536368681291;4281.486221653406;4291.570842915699;4293.2701440755145;4306.1172459645695;4324.567543245666;4314.3528470729325;4315.050688848449;4341.305391137403;4350.477942646902;4351.216780979423;3718.851245950159;3726.962730372689;3814.561325447581;3819.1216020315483;3819.656230939201;5332.33345831771;5347.197920311945;5364.275822763916;5367.758450869681;5407.486288802596;4889.437714662824;4914.459409464956;4914.901701965977;4916.213405855046;4926;5431.985248187255;5749.482546570829;5782;5804.448577385142;5806.44516412777;4120;4121.175764847013;4125.411716489143;4131.132462182945;4143.399207114951;5895.970520147414;5940.287165540163;6012.188354572164;6012.909806352908;6023.518118550505;4019.638232559084;4118.217538667644;4139.627433530996;4173.5409104998425;4196.706230563892;4217.198732240864;4227.556106608823;4238.364245363158;4246.851360202378;4257.957420425756;4850.102730994778;4885.145099607555;4887.413510378778;4903.166461701519;4907.3620429343955;5635.915461268084;5797.507211887037;5817.418258174233;5843.772807710344;5857.326407463196;1454.5527200435422;1475.3139789997704;1475.6237159524253;1485.264793927013;1486.7026594681106;901.3104974694234;925.4031149908405;931.2120728201869;942.8774259346378;947.8009617980301;4804.663673542888;4859.570214892554;4905.730184839868;4917;4936.259561065869;5211.5049070338255;5224.9738751306;5232.816851410258;5282.520894149644;5295.920561191585;4609.446866376056;4886.975565122223;4946.530079642428;4955.72743499111;4969.105560998983;2729.5086884360608;2768.404792969481;2793.594928735363;2793.7764978801647;2794.748472637432;5357.383900851374;5373.865653358619;5413.2692086568595;5437.83686489398;5446.128619420873;5299.470052994747;5338.199270109437;5552.91670624941;6046.546509011841;6084.695765211722;6160.199174107337;6174.351693072253;6188.381161883775;6220.813375598739;6224.782132625427;5706.229658995982;5982.222311099529;6049.969750151221;6060.060870477727;6073;5826.718122013151;5876.882462350814;5894.410558944071;5927.436893495111;5964.165016897551;6231.5637905348;6267.185265915402;6275.811725648238;6278.937210627835;6295.96852015737;4034.8789536313957;4078.898697351639;4175.269327867672;4196.9370459442525;4203.222403855297;5939.227900372924;5957.642541447527;5981.850453738692;6036.969815151072;6069.8163858047255;5747.5689323300085;5810.941890581209;5855.560832937462;5886.764529418947;5894.145348924296;5695.914561281501;5750.6837123958585;5752.798652047159;5757.107648314518;5762.4525670061275;5753.554739235892;5785.392533783892;5818.709064546841;5850.414958504116;5852.18069470283;5591.608587398843;5716.28546431696;5767.5674324425;5797.507211887037;5805.94194058054;5665.716714164358;5704.172894930129;5711.685857277889;5769.134629805562;5773.364929857628 21:50:40 INFO - PROCESS | 6610 | |5;yui.html;736.6537727268183;751.4551949836367;800.5316889619576;854.7393045121236;858.9570521473925;16110.516684499455;17231.052292123943;17264;17273.91363043183;17275.395361162362;14470.20413877239;14520.782188267185;14610.415583376678;14626.853731462683;14677.633059173526;657.4313219065498;790.1426951757351;803.9196080391944;816.6284340625031;818.6848063495538;821.6015232612208;827.9006519217702;829.0631586307464;830.1159265382379;833.649867055835;872.0102683454294;873.76845136039;877.8156587116713;877.8156587116713;880.0407555764248;866.4714524140269;869.0614136732314;870.0255713600744;870.7213691618684;870.8476016697084;634.0995785983914;634.2230767310008;635.0696230023038;635.6503922842418;636.7262077306756;15563.844361556352;15610.921945390313;15655.452059177987;15679;15706.450274240347;16349.063588525534;16387.984943688753;16554.089525076117;16692;16727.414540491023;13054.608361749162;13133.60599182026;13278.734425311537;13299.734005319937;13355.332233388292;3927.332353499883;3959.5248570171766;4000.739951903117;4143.875683729463;4151.107511884959;86035;87631;87635.56182219111;88220.55889720639;88884.55557722235;12083.516659333704;12088.879111208775;12104.273743575413;12541.749165016648;12652.17760845542;24257.636135457982;24431.63352549713;24444.266671999867;24446.511069778506;24531.877340613184;8653;8729.127087291346;8808.77978050541;8906.198442140238;8907.55462226886;4759.619230461624;4794.616430685537;4805.1590971579835;4874.073925954058;4974.427940786783;3668.706503479715;3735.7758534488016;3741.9251614967548;3811.466394704688;3818.579956204815;565.0507147991332;565.5832140488051;566.7761234312424;568.8720037991502;578.4735890339771;644.7388807532863;676.6921050921819;739.663453128825;754.5472716370134;761.2121454294778;9644.9035509644;10106.747331316776;10108.01160900383;10272.589096436059;10331.173506119492;590.6311627307707;751.8571471420413;764.9388048956071;795.0499153511498;818.9426740128253;4594.977025114853;5143.665661731976;5202.297689811902;5205.9219111713355;5230.241614965808;111657;115339;117775;118679;119527.40236298763;95564;96095;98296;99121.50439247758;99189.50405247927;87170;91256.54371728231;91465.54267228754;92826.53586732023;93188.53405732928;9211.631534738535;9437.764055898657;9572.856407154037;9698.224142068477;9705.6117755289;51821;52364.47635523596;52498.73750631222;52870.735646321526;54512.72743636256;72291;74654;75229.62385188039;75504;76612.61693691496;13867.514636987657;13905;14108.717825643635;14124.435022599391;14133.717325653224;15913;15937.68124637524;15951.361945522513;16311.184440777677;16385.262663179947;14841.703165936837;15119.16844573559;15435.22823858825;15477.071375717493;15599.532014039596;15102.54692359231;15495.380184792934;15627.655851622347;15739.68520629558;16040;13702;13864.584062478141;13912.044552106323;14099;14971.781067070631;11771.646850594496;12275.079369047178;12323.876761232632;12356.505739770308;12542.937285313516;10961;12153.331566763913;12809.167404118702;12838.229706217657;12964.611061668165 21:50:40 INFO - PROCESS | 6610 | __end_tp_report 21:50:40 INFO - PROCESS | 6610 | __start_cc_report 21:50:40 INFO - PROCESS | 6610 | _x_x_mozilla_cycle_collect,347 21:50:40 INFO - PROCESS | 6610 | __end_cc_report 21:50:40 INFO - PROCESS | 6610 | __startTimestamp1470891040167__endTimestamp 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | ------- Summary: start ------- 21:50:40 INFO - PROCESS | 6610 | Number of tests: 6 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#0] dojo.html Cycles:165 Average:5438.23 Median:5689.40 stddev:615.24 (10.8%) stddev-sans-first:589.21 21:50:40 INFO - PROCESS | 6610 | Values: 3102.6 3122.7 3129.2 3141.2 3154.6 5342.6 5388.5 5434.3 5449.4 5483.7 5404.5 5419.2 5431.0 5444.2 5460.4 4891.5 4980.7 5025.9 5044.4 5116.7 5060.8 5064.1 5078.5 5119.5 5119.8 4904.8 4909.1 4938.4 5012.0 5014.1 4848.9 4999.7 5034.1 5040.0 5064.1 4916.0 4968.3 4968.6 4993.8 5025.6 5352.0 5357.3 5466.0 5476.9 5481.8 5742.4 5848.8 5862.4 5899.4 5900.8 5888.6 5902.3 5902.4 5903.1 5920.8 5280.2 5380.3 5469.3 5479.6 5482.5 5931.2 6010.1 6013.3 6046.8 6060.8 5748.2 5781.6 5789.2 5792.3 5794.2 5652.7 5724.3 5857.8 5867.6 5869.0 5740.7 5792.0 5809.1 5840.7 5850.9 5803.9 5805.2 5813.8 5815.7 5834.0 4440.4 4480.5 4489.5 4496.5 4529.7 3979.2 4006.0 4049.6 4062.2 4073.0 5490.8 5521.2 5526.9 5574.4 5576.0 5689.6 5776.0 5858.9 5859.9 5869.5 5447.6 5503.1 5515.3 5574.7 5624.5 5016.9 5034.8 5037.7 5050.0 5101.8 5937.5 6031.8 6051.1 6064.8 6084.5 5790.0 5793.2 5861.3 5901.6 5964.9 6060.6 6091.9 6094.0 6102.1 6109.1 5694.3 5765.3 5773.4 5774.5 5777.2 5767.5 5784.7 5835.2 5862.9 5888.9 5729.9 5733.4 5744.5 5744.9 5745.9 5507.9 5641.2 5689.4 5700.3 5716.2 5664.8 5675.4 5753.4 5799.5 5835.0 5703.7 5815.4 5816.1 5827.7 5834.6 5651.1 5665.0 5691.0 5692.8 5720.7 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#1] ext.html Cycles:180 Average:66279.96 Median:43300.57 stddev:136596.37 (315.5%) stddev-sans-first:136890.41 21:50:40 INFO - PROCESS | 6610 | Values: 553.4 589.9 600.9 613.0 630.7 40119.8 44891.8 44918.0 44972.8 45017.3 44998.3 45501.8 45590.9 45621.3 45708.8 8798.2 8914.0 8941.7 8960.3 8989.6 8794.2 8952.7 8956.5 8959.9 8977.6 8999.4 9032.5 9046.0 9046.2 9052.9 8944.5 8995.5 8996.4 9018.5 9043.0 8793.8 8862.1 8862.8 8866.0 8880.8 42949.1 43180.8 43290.4 43298.4 43496.1 3772.4 3790.8 3847.5 3885.3 4146.9 33565.8 34017.1 34136.7 34146.5 34429.8 4256.0 4382.6 4400.7 4470.6 4614.4 402208.0 403735.0 404085.0 404318.0 405616.0 61515.4 61558.0 61617.4 61777.4 62146.4 37169.8 38138.0 65208.0 65212.3 65415.7 18029.0 18173.3 18195.9 18205.5 18208.7 13761.0 13840.4 13871.3 13916.4 13925.0 20120.5 20202.2 20302.8 20319.2 20457.7 7299.6 7432.0 7483.4 7574.0 7684.7 934.5 1055.4 1059.5 1148.2 1166.0 32291.7 33774.8 33832.7 33853.5 34478.7 1110.6 1130.9 1166.4 1175.3 1188.1 17692.8 17887.0 17893.8 17904.6 17986.9 627443.0 634305.0 635933.0 637820.0 637914.0 60670.4 61418.7 61631.4 61671.4 61704.7 1317.1 1332.8 1337.4 1339.0 1361.4 31204.0 33838.5 33877.7 33922.3 33923.5 53583.7 53600.2 53935.2 53965.0 54060.2 470138.0 471832.0 474167.0 475512.0 476896.0 28732.6 29605.4 29635.0 30015.4 30049.5 47225.0 47264.8 47709.5 48447.3 50864.7 40195.6 42875.4 43111.9 43633.6 43669.3 43289.6 43302.8 43624.0 44012.0 44082.6 41647.8 42138.6 42389.8 42420.4 42875.1 35852.8 38099.0 38247.4 38933.4 39106.0 28975.9 29016.7 29191.3 29296.0 29656.3 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#2] jquery.html Cycles:180 Average:30456.51 Median:2627.11 stddev:84538.03 (3217.9%) stddev-sans-first:84745.05 21:50:40 INFO - PROCESS | 6610 | Values: 394.9 396.2 404.5 410.2 420.2 18755.7 19727.7 20123.9 20364.2 20383.7 18927.3 19245.6 20438.8 20515.5 20672.4 5591.4 5696.0 5818.5 5845.8 5866.8 5718.3 5760.5 5769.9 5777.4 5786.6 5673.4 5679.2 5780.3 5810.6 5832.2 5659.8 5750.3 5784.1 5798.2 5804.3 5064.1 5132.6 5145.6 5163.7 5169.5 17032.4 21499.2 23135.2 23297.3 23574.8 2278.9 2404.0 2540.2 2714.0 2774.5 11044.6 11056.7 11276.4 11360.5 14006.3 1929.3 1967.3 1985.8 1997.6 2032.3 88093.6 88918.6 90199.0 90724.0 92609.5 11093.3 11389.2 11561.7 11675.3 12023.8 16300.9 16309.8 16313.8 16364.6 16370.9 8055.9 8257.6 8360.5 8423.7 8675.5 7860.2 7956.5 8150.2 8172.9 8234.3 4800.4 4847.7 4925.3 4976.0 5129.9 1978.2 2027.3 2035.4 2044.2 2075.9 916.4 937.8 1012.0 1047.3 1075.2 20479.5 20496.7 20600.6 20636.4 20893.0 977.5 983.4 998.5 1051.9 1083.8 10690.3 11512.1 11587.7 11614.4 11617.5 500368.0 509320.0 516167.0 516472.0 517083.0 91858.0 93636.0 94223.3 95956.0 97075.5 991.8 1020.3 1027.7 1028.1 1028.8 17828.3 18505.2 19060.3 19169.0 19275.2 44077.3 44736.6 44980.3 45232.5 45554.8 57974.0 60825.7 66642.0 66644.0 68327.0 8833.9 9102.1 9164.5 9204.2 9205.8 13607.0 13738.7 13964.1 14104.9 14304.5 11516.8 12152.3 12186.0 12450.0 12541.2 10464.0 11621.5 11645.4 11715.4 11728.5 11776.9 11791.5 11811.6 12408.5 12675.7 9010.0 9038.3 9087.2 9098.5 9144.9 9964.5 11600.2 11864.1 11904.2 12543.1 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#3] mootools.html Cycles:180 Average:6153.08 Median:4530.06 stddev:3493.30 (77.1%) stddev-sans-first:3485.63 21:50:40 INFO - PROCESS | 6610 | Values: 1504.2 1509.6 1663.7 1779.4 1791.5 8077.2 8724.0 8826.1 9420.7 9480.3 8913.7 9228.6 9278.8 9311.8 9313.6 2395.7 2412.6 2430.9 2435.1 2442.0 2362.2 2396.8 2436.1 2439.2 2448.8 2433.4 2445.3 2451.5 2464.8 2470.4 2353.8 2360.8 2365.0 2372.4 2375.5 2313.7 2351.0 2353.3 2357.4 2368.8 8750.6 8865.8 8947.9 8953.3 8956.3 5415.8 5496.6 5507.4 5533.8 5542.1 3840.9 3853.6 3871.6 3882.1 3895.7 1237.9 1255.7 1257.7 1283.6 1292.0 12920.9 12945.9 12955.4 13033.1 13069.5 4730.3 4817.8 4855.0 4877.2 5024.7 11001.4 11004.7 11010.6 11010.7 11035.0 5552.7 5573.8 5580.9 5581.9 5583.9 4511.7 4819.8 4909.2 4919.6 5099.4 4105.6 4135.2 4192.0 4234.5 4321.2 1340.8 1355.6 1362.2 1383.3 1397.9 939.8 985.1 1019.8 1032.6 1038.5 6252.4 6400.8 6436.0 6487.4 6662.3 987.5 1001.8 1006.3 1010.8 1011.9 4332.0 4354.4 4371.3 4548.5 4577.5 11312.2 11758.0 11774.0 11797.1 11805.1 11483.8 11595.9 11745.9 11779.7 11842.8 8352.6 8592.0 8662.3 8667.5 8740.2 6155.6 6363.3 6408.6 6506.4 6563.7 10198.9 10732.9 10742.5 10793.6 10879.7 10663.9 10869.7 10970.7 10977.8 10995.3 7979.4 8187.5 8192.4 8214.7 8377.7 9218.0 9271.3 9280.1 9300.5 9328.4 7992.6 8053.3 8125.6 8345.1 8483.8 8090.1 8101.3 8137.7 8259.0 8284.3 7407.7 7439.4 7503.6 7520.3 7526.2 5500.8 5572.0 5613.2 5629.9 5737.0 5483.8 5489.4 5637.5 5647.9 5682.1 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#4] prototype.html Cycles:180 Average:4782.41 Median:5366.02 stddev:1424.34 (26.5%) stddev-sans-first:1388.37 21:50:40 INFO - PROCESS | 6610 | Values: 318.4 325.5 328.2 332.2 333.0 5367.9 5450.8 5543.4 5616.6 5655.2 5430.6 5462.6 5462.9 5468.2 5535.7 4353.8 4378.2 4378.8 4380.3 4422.6 4105.9 4296.4 4363.6 4411.4 4415.5 4281.5 4291.6 4293.3 4306.1 4324.6 4314.4 4315.1 4341.3 4350.5 4351.2 3718.9 3727.0 3814.6 3819.1 3819.7 5332.3 5347.2 5364.3 5367.8 5407.5 4889.4 4914.5 4914.9 4916.2 4926.0 5432.0 5749.5 5782.0 5804.4 5806.4 4120.0 4121.2 4125.4 4131.1 4143.4 5896.0 5940.3 6012.2 6012.9 6023.5 4019.6 4118.2 4139.6 4173.5 4196.7 4217.2 4227.6 4238.4 4246.9 4258.0 4850.1 4885.1 4887.4 4903.2 4907.4 5635.9 5797.5 5817.4 5843.8 5857.3 1454.6 1475.3 1475.6 1485.3 1486.7 901.3 925.4 931.2 942.9 947.8 4804.7 4859.6 4905.7 4917.0 4936.3 5211.5 5225.0 5232.8 5282.5 5295.9 4609.4 4887.0 4946.5 4955.7 4969.1 2729.5 2768.4 2793.6 2793.8 2794.7 5357.4 5373.9 5413.3 5437.8 5446.1 5299.5 5338.2 5552.9 6046.5 6084.7 6160.2 6174.4 6188.4 6220.8 6224.8 5706.2 5982.2 6050.0 6060.1 6073.0 5826.7 5876.9 5894.4 5927.4 5964.2 6231.6 6267.2 6275.8 6278.9 6296.0 4034.9 4078.9 4175.3 4196.9 4203.2 5939.2 5957.6 5981.9 6037.0 6069.8 5747.6 5810.9 5855.6 5886.8 5894.1 5695.9 5750.7 5752.8 5757.1 5762.5 5753.6 5785.4 5818.7 5850.4 5852.2 5591.6 5716.3 5767.6 5797.5 5805.9 5665.7 5704.2 5711.7 5769.1 5773.4 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - PROCESS | 6610 | [#5] yui.html Cycles:180 Average:21866.59 Median:4777.12 stddev:30847.49 (645.7%) stddev-sans-first:30893.22 21:50:40 INFO - PROCESS | 6610 | Values: 736.7 751.5 800.5 854.7 859.0 16110.5 17231.1 17264.0 17273.9 17275.4 14470.2 14520.8 14610.4 14626.9 14677.6 657.4 790.1 803.9 816.6 818.7 821.6 827.9 829.1 830.1 833.6 872.0 873.8 877.8 877.8 880.0 866.5 869.1 870.0 870.7 870.8 634.1 634.2 635.1 635.7 636.7 15563.8 15610.9 15655.5 15679.0 15706.5 16349.1 16388.0 16554.1 16692.0 16727.4 13054.6 13133.6 13278.7 13299.7 13355.3 3927.3 3959.5 4000.7 4143.9 4151.1 86035.0 87631.0 87635.6 88220.6 88884.6 12083.5 12088.9 12104.3 12541.7 12652.2 24257.6 24431.6 24444.3 24446.5 24531.9 8653.0 8729.1 8808.8 8906.2 8907.6 4759.6 4794.6 4805.2 4874.1 4974.4 3668.7 3735.8 3741.9 3811.5 3818.6 565.1 565.6 566.8 568.9 578.5 644.7 676.7 739.7 754.5 761.2 9644.9 10106.7 10108.0 10272.6 10331.2 590.6 751.9 764.9 795.0 818.9 4595.0 5143.7 5202.3 5205.9 5230.2 111657.0 115339.0 117775.0 118679.0 119527.4 95564.0 96095.0 98296.0 99121.5 99189.5 87170.0 91256.5 91465.5 92826.5 93188.5 9211.6 9437.8 9572.9 9698.2 9705.6 51821.0 52364.5 52498.7 52870.7 54512.7 72291.0 74654.0 75229.6 75504.0 76612.6 13867.5 13905.0 14108.7 14124.4 14133.7 15913.0 15937.7 15951.4 16311.2 16385.3 14841.7 15119.2 15435.2 15477.1 15599.5 15102.5 15495.4 15627.7 15739.7 16040.0 13702.0 13864.6 13912.0 14099.0 14971.8 11771.6 12275.1 12323.9 12356.5 12542.9 10961.0 12153.3 12809.2 12838.2 12964.6 21:50:40 INFO - PROCESS | 6610 | -------- Summary: end -------- 21:50:40 INFO - PROCESS | 6610 | 21:50:40 INFO - TEST-INFO | 6610: exit 0 21:50:40 INFO - TEST-OK | dromaeo_css | took 1112411ms 21:50:40 INFO - TEST-START | kraken 21:50:40 INFO - operating with platform_type : linux_ 21:50:40 INFO - Initialising browser for kraken test... 21:50:40 INFO - TEST-INFO | started process 6855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqpWsVN/profile http://localhost:56004/getInfo.html) 21:50:45 INFO - PROCESS | 6855 | __metrics Screen width/height:1600/1200 21:50:45 INFO - PROCESS | 6855 | colorDepth:24 21:50:45 INFO - PROCESS | 6855 | Browser inner width/height: 1024/697 21:50:45 INFO - PROCESS | 6855 | __metrics 21:50:45 ERROR - PROCESS | 6855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:50:46 INFO - TEST-INFO | 6855: exit 0 21:50:46 INFO - Browser initialized. 21:50:46 INFO - Running cycle 1/1 for kraken test... 21:50:46 INFO - TEST-INFO | started process 6974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqpWsVN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:50:58 INFO - PROCESS | 6974 | RSS: Main: 162877440 21:50:58 INFO - PROCESS | 6974 | 21:51:00 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56004/tests/kraken/driver.html?testName=audio-beat-detection) 21:51:01 INFO - PROCESS | 6974 | RSS: Main: 168730624 21:51:01 INFO - PROCESS | 6974 | 21:51:04 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56004/tests/kraken/driver.html?testName=audio-dft) 21:51:04 INFO - PROCESS | 6974 | RSS: Main: 167096320 21:51:04 INFO - PROCESS | 6974 | 21:51:07 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56004/tests/kraken/driver.html?testName=audio-fft) 21:51:08 INFO - PROCESS | 6974 | RSS: Main: 163467264 21:51:08 INFO - PROCESS | 6974 | 21:51:10 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56004/tests/kraken/driver.html?testName=audio-oscillator) 21:51:11 INFO - PROCESS | 6974 | RSS: Main: 164335616 21:51:11 INFO - PROCESS | 6974 | 21:51:13 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:51:13 INFO - PROCESS | 6974 | RSS: Main: 164773888 21:51:13 INFO - PROCESS | 6974 | 21:51:17 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56004/tests/kraken/driver.html?testName=imaging-darkroom) 21:51:17 INFO - PROCESS | 6974 | RSS: Main: 164974592 21:51:17 INFO - PROCESS | 6974 | 21:51:21 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56004/tests/kraken/driver.html?testName=imaging-desaturate) 21:51:21 INFO - PROCESS | 6974 | RSS: Main: 165163008 21:51:21 INFO - PROCESS | 6974 | 21:51:24 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56004/tests/kraken/driver.html?testName=json-parse-financial) 21:51:25 INFO - PROCESS | 6974 | RSS: Main: 165150720 21:51:25 INFO - PROCESS | 6974 | 21:51:26 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:51:27 INFO - PROCESS | 6974 | RSS: Main: 164454400 21:51:27 INFO - PROCESS | 6974 | 21:51:29 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:51:29 INFO - PROCESS | 6974 | RSS: Main: 165855232 21:51:29 INFO - PROCESS | 6974 | 21:51:31 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:51:32 INFO - PROCESS | 6974 | RSS: Main: 165879808 21:51:32 INFO - PROCESS | 6974 | 21:51:35 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:51:35 INFO - PROCESS | 6974 | RSS: Main: 165990400 21:51:35 INFO - PROCESS | 6974 | 21:51:38 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:51:39 INFO - PROCESS | 6974 | RSS: Main: 165314560 21:51:39 INFO - PROCESS | 6974 | 21:51:40 INFO - PROCESS | 6974 | Cycle 1(1): loaded http://localhost:56004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56004/tests/kraken/driver.html?testName=ai-astar) 21:51:41 INFO - PROCESS | 6974 | RSS: Main: 166510592 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | __start_tp_report 21:51:41 INFO - PROCESS | 6974 | _x_x_mozilla_page_load 21:51:41 INFO - PROCESS | 6974 | _x_x_mozilla_page_load_details 21:51:41 INFO - PROCESS | 6974 | |i|pagename|runs| 21:51:41 INFO - PROCESS | 6974 | |0;ai-astar;101;113;105;110;113;112;112;112;111;110 21:51:41 INFO - PROCESS | 6974 | |1;audio-beat-detection;148;119;149;173;119;153;154;123;180;126 21:51:41 INFO - PROCESS | 6974 | |2;audio-dft;162;162;162;163;164;164;171;162;163;161 21:51:41 INFO - PROCESS | 6974 | |3;audio-fft;89;75;77;185;85;76;74;75;165;76 21:51:41 INFO - PROCESS | 6974 | |4;audio-oscillator;84;84;155;83;83;83;151;82;83;144 21:51:41 INFO - PROCESS | 6974 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;117 21:51:41 INFO - PROCESS | 6974 | |6;imaging-darkroom;146;148;147;147;147;147;146;147;147;149 21:51:41 INFO - PROCESS | 6974 | |7;imaging-desaturate;95;97;96;95;95;96;96;96;96;97 21:51:41 INFO - PROCESS | 6974 | |8;json-parse-financial;51;52;52;52;54;53;51;52;51;53 21:51:41 INFO - PROCESS | 6974 | |9;json-stringify-tinderbox;61;61;63;70;61;61;62;62;60;61 21:51:41 INFO - PROCESS | 6974 | |10;stanford-crypto-aes;86;76;77;77;86;77;78;78;82;76 21:51:41 INFO - PROCESS | 6974 | |11;stanford-crypto-ccm;131;131;125;147;125;124;126;124;145;126 21:51:41 INFO - PROCESS | 6974 | |12;stanford-crypto-pbkdf2;160;163;157;156;155;156;158;160;156;155 21:51:41 INFO - PROCESS | 6974 | |13;stanford-crypto-sha256-iterative;65;64;67;65;68;64;63;66;64;65 21:51:41 INFO - PROCESS | 6974 | __end_tp_report 21:51:41 INFO - PROCESS | 6974 | __start_cc_report 21:51:41 INFO - PROCESS | 6974 | _x_x_mozilla_cycle_collect,864 21:51:41 INFO - PROCESS | 6974 | __end_cc_report 21:51:41 INFO - PROCESS | 6974 | __startTimestamp1470891101001__endTimestamp 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | ------- Summary: start ------- 21:51:41 INFO - PROCESS | 6974 | Number of tests: 14 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.90 (3.5%) stddev-sans-first:2.47 21:51:41 INFO - PROCESS | 6974 | Values: 101.0 113.0 105.0 110.0 113.0 112.0 112.0 112.0 111.0 110.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.00 stddev:22.04 (14.6%) stddev-sans-first:23.34 21:51:41 INFO - PROCESS | 6974 | Values: 148.0 119.0 149.0 173.0 119.0 153.0 154.0 123.0 180.0 126.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 21:51:41 INFO - PROCESS | 6974 | Values: 162.0 162.0 162.0 163.0 164.0 164.0 171.0 162.0 163.0 161.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#3] audio-fft Cycles:10 Average:97.70 Median:76.00 stddev:41.30 (54.3%) stddev-sans-first:43.68 21:51:41 INFO - PROCESS | 6974 | Values: 89.0 75.0 77.0 185.0 85.0 76.0 74.0 75.0 165.0 76.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:83.00 stddev:32.41 (39.0%) stddev-sans-first:33.62 21:51:41 INFO - PROCESS | 6974 | Values: 84.0 84.0 155.0 83.0 83.0 83.0 151.0 82.0 83.0 144.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 21:51:41 INFO - PROCESS | 6974 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 21:51:41 INFO - PROCESS | 6974 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 149.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 21:51:41 INFO - PROCESS | 6974 | Values: 95.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 21:51:41 INFO - PROCESS | 6974 | Values: 51.0 52.0 52.0 52.0 54.0 53.0 51.0 52.0 51.0 53.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:61.50 stddev:2.86 (4.6%) stddev-sans-first:3.00 21:51:41 INFO - PROCESS | 6974 | Values: 61.0 61.0 63.0 70.0 61.0 61.0 62.0 62.0 60.0 61.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.00 stddev:3.92 (5.0%) stddev-sans-first:3.32 21:51:41 INFO - PROCESS | 6974 | Values: 86.0 76.0 77.0 77.0 86.0 77.0 78.0 78.0 82.0 76.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:128.50 stddev:8.62 (6.7%) stddev-sans-first:9.14 21:51:41 INFO - PROCESS | 6974 | Values: 131.0 131.0 125.0 147.0 125.0 124.0 126.0 124.0 145.0 126.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:157.50 stddev:2.63 (1.7%) stddev-sans-first:2.65 21:51:41 INFO - PROCESS | 6974 | Values: 160.0 163.0 157.0 156.0 155.0 156.0 158.0 160.0 156.0 155.0 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - PROCESS | 6974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 21:51:41 INFO - PROCESS | 6974 | Values: 65.0 64.0 67.0 65.0 68.0 64.0 63.0 66.0 64.0 65.0 21:51:41 INFO - PROCESS | 6974 | -------- Summary: end -------- 21:51:41 INFO - PROCESS | 6974 | 21:51:41 INFO - TEST-INFO | 6974: exit 0 21:51:41 INFO - TEST-OK | kraken | took 61098ms 21:51:41 INFO - SUITE-END | took 1173s 21:51:42 INFO - Completed test suite (00:19:33) 21:51:42 INFO - javascript benchmark 21:51:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7533.7202435812615, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.565640810287, 3122.718955294023, 3129.217695576106, 3141.151888989971, 3154.6056742907135, 5342.599305052117, 5388.461153884609, 5434.320709911256, 5449.373322067953, 5483.670979741213, 5404.513593776559, 5419.160030195326, 5431.049566325897, 5444.210589464526, 5460.399356070829, 4891.5353041461, 4980.676256043345, 5025.874353141183, 5044.39467263927, 5116.718580478072, 5060.822871199509, 5064.063148317573, 5078.5175408336145, 5119.4880511948695, 5119.820806271781, 4904.803807847682, 4909.1409003424615, 4938.358013458227, 5012.04771093491, 5014.072396606622, 4848.85453436394, 4999.725015124167, 5034.11902916988, 5040.042391945555, 5064.11378008847, 4916.041371932474, 4968.279599458095, 4968.552830245259, 4993.800247990076, 5025.572826309732, 5352.0, 5357.330333708286, 5466.043442397565, 5476.945230547723, 5481.75332110056, 5742.397048309951, 5848.766049358021, 5862.413758624146, 5899.410058994109, 5900.822975310747, 5888.5877988540815, 5902.32123305821, 5902.439268269508, 5903.114532820111, 5920.79277225295, 5280.234366016906, 5380.300560927054, 5469.261649677323, 5479.561635069185, 5482.451754824526, 5931.199288096138, 6010.098485227251, 6013.30846952606, 6046.788362407295, 6060.848478787977, 5748.223989761329, 5781.5952883298605, 5789.247397838254, 5792.275965504312, 5794.159846822187, 5652.717364131777, 5724.25584673998, 5857.824265272048, 5867.559933005042, 5869.0, 5740.712964351766, 5792.0, 5809.099589563624, 5840.678762668094, 5850.882982340329, 5803.854903627359, 5805.245318108618, 5813.76744930198, 5815.73829177688, 5833.970830145907, 4440.444944381952, 4480.507144214133, 4489.461264648263, 4496.527864574238, 4529.705569137996, 3979.1842672252697, 4006.0185254612807, 4049.5950404959267, 4062.2484840304637, 4072.9796351018053, 5490.752916118784, 5521.171824226318, 5526.944730552643, 5574.358948720949, 5576.0241957657245, 5689.630174038757, 5776.046952252916, 5858.94141058584, 5859.941400586024, 5869.530437564985, 5447.618666693294, 5503.064479038573, 5515.310586176728, 5574.693391863405, 5624.521915637217, 5016.899662006739, 5034.84895453137, 5037.697738135724, 5050.0, 5101.821436249787, 5937.495312898452, 6031.849203769941, 6051.092336149525, 6064.75740970365, 6084.452399284174, 5789.9710501447225, 5793.246877905845, 5861.267341582302, 5901.5868889177345, 5964.850878728066, 6060.575759696779, 6091.8781624366375, 6094.0, 6102.145699602148, 6109.144719739329, 5694.259746233129, 5765.336986246635, 5773.393793651606, 5774.538036957118, 5777.22007528995, 5767.538596912321, 5784.652920824764, 5835.2122463466885, 5862.912056319074, 5888.882222355614, 5729.914051289317, 5733.397993210653, 5744.5117165039765, 5744.913826292525, 5745.8563535911935, 5507.889842203213, 5641.153826925994, 5689.402612725604, 5700.315962084576, 5716.199732037435, 5664.801731939528, 5675.404082571271, 5753.3958934311295, 5799.536037116936, 5835.0, 5703.714814259188, 5815.41845815415, 5816.098504731774, 5827.70861456917, 5834.649921004753, 5651.067573850433, 5665.0, 5690.971545142248, 5692.800751973661, 5720.713964301852], "value": 5396.543303077064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4133818152758, 589.8613825750948, 600.8978473659478, 613.034470708634, 630.7477009196324, 40119.79940100299, 44891.77554112233, 44918.0, 44972.77513612436, 45017.32474012888, 44998.32502512465, 45501.7724911375, 45590.948407321666, 45621.31568026482, 45708.77145614276, 8798.164174403437, 8914.0, 8941.731748047569, 8960.28317734583, 8989.640414383417, 8794.164554367326, 8952.686655967042, 8956.462612243286, 8959.910400896006, 8977.640894364218, 8999.41503802254, 9032.548372581377, 9045.954770226139, 9046.231070359026, 9052.8642070369, 8944.508052057134, 8995.460272383645, 8996.370254082183, 9018.503982280972, 9043.0, 8793.7801554961, 8862.069482704288, 8862.822743545094, 8866.0, 8880.777980550472, 42949.14101717948, 43180.78409607932, 43290.350644740356, 43298.350524742156, 43496.13007739859, 3772.4152756322537, 3790.8483660653815, 3847.5190601174854, 3885.33949228629, 4146.875593732193, 33565.83217083923, 34017.14957126067, 34136.65863341359, 34146.48780268298, 34429.82785086059, 4256.0, 4382.649388048949, 4400.713953593006, 4470.575295346936, 4614.423197100363, 402208.0, 403734.9999999971, 404085.0, 404318.0, 405616.0, 61515.38484615096, 61558.0, 61617.38382616206, 61777.38222617806, 62146.378536214965, 37169.81415092907, 38138.04654883595, 65208.0, 65212.34787652158, 65415.67292163509, 18029.0, 18173.273069077353, 18195.909020454812, 18205.453836384928, 18208.726869096976, 13761.0, 13840.377183026789, 13871.306434678225, 13916.443342266197, 13925.0, 20120.496987575134, 20202.191912323342, 20302.796972030384, 20319.155318255456, 20457.693134602992, 7299.5620262784405, 7431.962840185764, 7483.438742094365, 7574.016526943653, 7684.6926122954455, 934.5467448287575, 1055.3615062886997, 1059.5391004912733, 1148.1618418554335, 1166.049669519339, 32291.677083228868, 33774.83112584471, 33832.661673383445, 33853.49219761706, 34478.65521344754, 1110.5502271580024, 1130.8812574679541, 1166.445938179358, 1175.3183153770963, 1188.1385995153444, 17692.84996475225, 17887.0, 17893.821061789477, 17904.55238619019, 17986.91006544985, 627443.0, 634305.0, 635933.0, 637820.0, 637914.0, 60670.393296067356, 61418.69290653518, 61631.38368616257, 61671.38328616746, 61704.69147654233, 1317.0648839324188, 1332.8067430222563, 1337.4048548396065, 1339.049275014731, 1361.3873756809476, 31204.0, 33838.49242261319, 33877.66122338745, 33922.32155356929, 33923.49114763231, 53583.732081339345, 53600.195997059294, 53935.19097213623, 53965.0, 54060.18909716436, 470138.0, 471832.0, 474167.0, 475512.0, 476896.0, 28732.569011464428, 29605.407891841613, 29635.0, 30015.399692006475, 30049.497525124094, 47225.0, 47264.7636761814, 47709.5229047719, 48447.27329089996, 50864.74567627286, 40195.61994408095, 42875.35686964761, 43111.88811188811, 43633.56366436295, 43669.34495982499, 43289.567104328555, 43302.78348608363, 43624.0, 44012.0, 44082.55917440913, 41647.791761041, 42138.57861421469, 42389.78805105955, 42420.36369454522, 42875.142497150504, 35852.82073589615, 38099.0, 38247.42628860625, 38933.415998759476, 39106.0, 28975.85512072426, 29016.709832902245, 29191.270218243862, 29296.0, 29656.258593535335], "value": 20963.44973939585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.86574564648015, 396.2194476880548, 404.5347849972532, 410.1653135868508, 420.1953259508042, 18755.718664220032, 19727.704084438745, 20123.899380503077, 20364.185432582697, 20383.694244586324, 18927.33754318599, 19245.61508769824, 20438.795612043876, 20515.487112822186, 20672.379828605128, 5591.384947655764, 5696.0, 5818.5453636590855, 5845.766169353221, 5866.794662186803, 5718.313802343725, 5760.53915686744, 5769.884602307972, 5777.393373695764, 5786.623869448494, 5673.404292549285, 5679.176519404684, 5780.277465316835, 5810.622309549887, 5832.2418085649015, 5659.830205093854, 5750.309962804448, 5784.132380142991, 5798.1592669063175, 5804.303483581955, 5064.063148317573, 5132.640715149941, 5145.588352931794, 5163.7159956202395, 5169.457206993249, 17032.40386586476, 21499.2475263365, 23135.190268340695, 23297.301080967598, 23574.76425235743, 2278.908843646252, 2403.9519209615883, 2540.2125341144306, 2714.009386573906, 2774.542200536909, 11044.558217671363, 11056.723581910435, 11276.43617819114, 11360.48877800501, 14006.29968501581, 1929.3343796390222, 1967.2917749610128, 1985.811347921945, 1997.5617555360118, 2032.3293313206607, 88093.55953220192, 88918.55540722255, 90199.0, 90724.0, 92609.53695231548, 11093.335999599964, 11389.202755807013, 11561.710957225969, 11675.299482031105, 12023.759524809455, 16300.918495407446, 16309.83690163107, 16313.83686163147, 16364.590885227726, 16370.918145409196, 8055.879161812578, 8257.628406721711, 8360.498370097692, 8423.70517031901, 8675.522846243517, 7860.174681658458, 7956.5226086435, 8150.225728555778, 8172.877406838902, 8234.258916697527, 4800.35195248644, 4847.709137451694, 4925.310456536088, 4975.950240497621, 5129.897402051938, 1978.2186036515495, 2027.28031548801, 2035.3893831850385, 2044.182327069184, 2075.8546901717036, 916.3906002508257, 937.7702462896634, 1011.9696409107738, 1047.2616805152502, 1075.1936047964027, 20479.4880127998, 20496.69254961177, 20600.58798824045, 20636.380908572766, 20893.0, 977.4770497783652, 983.4197823284154, 998.4708104704519, 1051.9053285204368, 1083.842842787807, 10690.251682382159, 11512.136589755803, 11587.652370428901, 11614.361210133355, 11617.535298587962, 500368.0, 509320.0, 516167.0, 516472.0, 517083.0, 91858.0, 93636.0, 94223.31965430867, 95956.0, 97075.51462242784, 991.8313886639289, 1020.2705065877933, 1027.6557353286582, 1028.136365453023, 1028.840529717895, 17828.286868525633, 18505.167267472727, 19060.332888348843, 19169.0, 19275.22899084021, 44077.33883991807, 44736.55263447454, 44980.325295121256, 45232.54767452284, 45554.77222613866, 57974.0, 60825.69587152036, 66642.0, 66644.0, 68326.9750953746, 8833.911660883308, 9102.13529714676, 9164.541772911462, 9204.171624553823, 9205.815883682422, 13607.047506674438, 13738.65653358674, 13964.087776550672, 14104.929475352557, 14304.499342522962, 11516.769664606494, 12152.331621760535, 12186.0, 12450.0, 12541.184822986477, 10464.0, 11621.535138594361, 11645.359505227294, 11715.414229288672, 11728.530858765555, 11776.882231177578, 11791.469383877575, 11811.645650630495, 12408.503659853866, 12675.683107922376, 9010.0, 9038.276937845088, 9087.182153606207, 9098.454092754457, 9144.908550914406, 9964.501774911081, 11600.245984011011, 11864.050875929732, 11904.226225295328, 12543.059270554562], "value": 9553.476423781676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.2027725305586, 1509.6376869551307, 1663.6773764856937, 1779.3861117914314, 1791.4804706635077, 8077.19228077192, 8723.956380218098, 8826.117388261171, 9420.670276540322, 9480.288978326627, 8913.68802091927, 9228.584713687884, 9278.768030799216, 9311.767205819859, 9313.58088886, 2395.724491683457, 2412.601920683085, 2430.878456077198, 2435.0868424340874, 2442.0476014354417, 2362.2086600988605, 2396.8322217444784, 2436.1473484280536, 2439.1706819681303, 2448.7673671001226, 2433.4038160650666, 2445.303088619744, 2451.5464639041834, 2464.827462077655, 2470.3824043989002, 2353.8116950643907, 2360.78752912237, 2364.9645255321184, 2372.418757404438, 2375.5130198309307, 2313.733920599119, 2351.0478256306224, 2353.329301149164, 2357.351728274738, 2368.7512811154925, 8750.649974001033, 8865.822683546357, 8947.865782013276, 8953.283737301, 8956.283497320199, 5415.810446634349, 5496.615236933416, 5507.421720719347, 5533.750981205855, 5542.11326187812, 3840.9231815363537, 3853.6319606539555, 3871.593482684306, 3882.1459278958864, 3895.7467764595212, 1237.876212378764, 1255.7362953779718, 1257.704439456727, 1283.6277479530925, 1291.9741605167937, 12920.935395322964, 12945.87054129456, 12955.352232388343, 13033.087683862133, 13069.477220911152, 4730.337752714623, 4817.78319975602, 4855.0, 4877.219644856806, 5024.6733962293065, 11001.449927503592, 11004.669859904216, 11010.614628487965, 11010.669679909615, 11035.0, 5552.694601796859, 5573.832785016456, 5580.916286255629, 5581.888362232733, 5583.860403489864, 4511.661625378109, 4819.831305904277, 4909.239067944474, 4919.581835543947, 5099.36257967754, 4105.641192379854, 4135.17296540693, 4192.014876504019, 4234.470691163605, 4321.157374312042, 1340.7787715027107, 1355.59382096779, 1362.1826903857607, 1383.3429121167364, 1397.8881689464818, 939.8167357365248, 985.1183191044119, 1019.8113349030453, 1032.5714828346152, 1038.460000799595, 6252.406021427957, 6400.807975760735, 6436.0, 6487.3836985486305, 6662.333766623396, 987.5259875259916, 1001.8246806808779, 1006.3257617396362, 1010.8433192855119, 1011.903869132446, 4331.97834010828, 4354.390385346054, 4371.278739008028, 4548.4541854977615, 4577.496475387771, 11312.20814542974, 11758.0, 11774.0, 11797.056235501312, 11805.114616403633, 11483.770324593628, 11595.942020290013, 11745.882541174478, 11779.705507362212, 11842.76314473723, 8352.582370881431, 8591.957040214758, 8662.263707584925, 8667.479951203075, 8740.169683880022, 6155.569110162246, 6363.268224154282, 6408.58344207625, 6506.41442270198, 6563.737450502117, 10198.949005254926, 10732.892671073188, 10742.51658675377, 10793.56825726962, 10879.728006799893, 10663.89336106629, 10869.728256793327, 10970.670879873616, 10977.83533246986, 10995.34027958325, 7979.441439099207, 8187.4678145920325, 8192.385571082074, 8214.712485062993, 8377.748667539983, 9217.953910230406, 9271.30465215098, 9280.118388753057, 9300.534973251446, 9328.39365441244, 7992.560409177318, 8053.275205231557, 8125.634346454305, 8345.082040975609, 8483.787905302417, 8090.110087890445, 8101.270885620323, 8137.674493020213, 8259.0, 8284.25441710249, 7407.740729074457, 7439.404847612286, 7503.587302698404, 7520.323170914644, 7526.209747976603, 5500.834974950758, 5571.972140139435, 5613.158026296088, 5629.915551266816, 5737.0, 5483.75323110453, 5489.39616642177, 5637.49262566371, 5647.887042259214, 5682.062459694104], "value": 4924.644477357926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.4331889237157, 325.51660783736156, 328.1877353549963, 332.23254282607166, 332.966703329667, 5367.865803354908, 5450.809221677242, 5543.390227075019, 5616.578756593257, 5655.1517272409155, 5430.56555475562, 5462.590305727076, 5462.945370546293, 5468.152436372358, 5535.671438854676, 4353.847615333456, 4378.233809083414, 4378.81771921581, 4380.3210502372185, 4422.579854913794, 4105.9178816423655, 4296.355546667994, 4363.585459381369, 4411.42651455312, 4415.536368681291, 4281.486221653406, 4291.570842915699, 4293.2701440755145, 4306.1172459645695, 4324.567543245666, 4314.3528470729325, 4315.050688848449, 4341.305391137403, 4350.477942646902, 4351.216780979423, 3718.851245950159, 3726.962730372689, 3814.561325447581, 3819.1216020315483, 3819.656230939201, 5332.33345831771, 5347.197920311945, 5364.275822763916, 5367.758450869681, 5407.486288802596, 4889.437714662824, 4914.459409464956, 4914.901701965977, 4916.213405855046, 4926.0, 5431.985248187255, 5749.482546570829, 5782.0, 5804.448577385142, 5806.44516412777, 4120.0, 4121.175764847013, 4125.411716489143, 4131.132462182945, 4143.399207114951, 5895.970520147414, 5940.287165540163, 6012.188354572164, 6012.909806352908, 6023.518118550505, 4019.638232559084, 4118.217538667644, 4139.627433530996, 4173.5409104998425, 4196.706230563892, 4217.198732240864, 4227.556106608823, 4238.364245363158, 4246.851360202378, 4257.957420425756, 4850.102730994778, 4885.145099607555, 4887.413510378778, 4903.166461701519, 4907.3620429343955, 5635.915461268084, 5797.507211887037, 5817.418258174233, 5843.772807710344, 5857.326407463196, 1454.5527200435422, 1475.3139789997704, 1475.6237159524253, 1485.264793927013, 1486.7026594681106, 901.3104974694234, 925.4031149908405, 931.2120728201869, 942.8774259346378, 947.8009617980301, 4804.663673542888, 4859.570214892554, 4905.730184839868, 4917.0, 4936.259561065869, 5211.5049070338255, 5224.9738751306, 5232.816851410258, 5282.520894149644, 5295.920561191585, 4609.446866376056, 4886.975565122223, 4946.530079642428, 4955.72743499111, 4969.105560998983, 2729.5086884360608, 2768.404792969481, 2793.594928735363, 2793.7764978801647, 2794.748472637432, 5357.383900851374, 5373.865653358619, 5413.2692086568595, 5437.83686489398, 5446.128619420873, 5299.470052994747, 5338.199270109437, 5552.91670624941, 6046.546509011841, 6084.695765211722, 6160.199174107337, 6174.351693072253, 6188.381161883775, 6220.813375598739, 6224.782132625427, 5706.229658995982, 5982.222311099529, 6049.969750151221, 6060.060870477727, 6073.0, 5826.718122013151, 5876.882462350814, 5894.410558944071, 5927.436893495111, 5964.165016897551, 6231.5637905348, 6267.185265915402, 6275.811725648238, 6278.937210627835, 6295.96852015737, 4034.8789536313957, 4078.898697351639, 4175.269327867672, 4196.9370459442525, 4203.222403855297, 5939.227900372924, 5957.642541447527, 5981.850453738692, 6036.969815151072, 6069.8163858047255, 5747.5689323300085, 5810.941890581209, 5855.560832937462, 5886.764529418947, 5894.145348924296, 5695.914561281501, 5750.6837123958585, 5752.798652047159, 5757.107648314518, 5762.4525670061275, 5753.554739235892, 5785.392533783892, 5818.709064546841, 5850.414958504116, 5852.18069470283, 5591.608587398843, 5716.28546431696, 5767.5674324425, 5797.507211887037, 5805.94194058054, 5665.716714164358, 5704.172894930129, 5711.685857277889, 5769.134629805562, 5773.364929857628], "value": 4322.76650704311, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.6537727268183, 751.4551949836367, 800.5316889619576, 854.7393045121236, 858.9570521473925, 16110.516684499455, 17231.052292123943, 17264.0, 17273.91363043183, 17275.395361162362, 14470.20413877239, 14520.782188267185, 14610.415583376678, 14626.853731462683, 14677.633059173526, 657.4313219065498, 790.1426951757351, 803.9196080391944, 816.6284340625031, 818.6848063495538, 821.6015232612208, 827.9006519217702, 829.0631586307464, 830.1159265382379, 833.649867055835, 872.0102683454294, 873.76845136039, 877.8156587116713, 877.8156587116713, 880.0407555764248, 866.4714524140269, 869.0614136732314, 870.0255713600744, 870.7213691618684, 870.8476016697084, 634.0995785983914, 634.2230767310008, 635.0696230023038, 635.6503922842418, 636.7262077306756, 15563.844361556352, 15610.921945390313, 15655.452059177987, 15679.0, 15706.450274240347, 16349.063588525534, 16387.984943688753, 16554.089525076117, 16692.0, 16727.414540491023, 13054.608361749162, 13133.60599182026, 13278.734425311537, 13299.734005319937, 13355.332233388292, 3927.332353499883, 3959.5248570171766, 4000.739951903117, 4143.875683729463, 4151.107511884959, 86035.0, 87631.0, 87635.56182219111, 88220.55889720639, 88884.55557722235, 12083.516659333704, 12088.879111208775, 12104.273743575413, 12541.749165016648, 12652.17760845542, 24257.636135457982, 24431.63352549713, 24444.266671999867, 24446.511069778506, 24531.877340613184, 8653.0, 8729.127087291346, 8808.77978050541, 8906.198442140238, 8907.55462226886, 4759.619230461624, 4794.616430685537, 4805.1590971579835, 4874.073925954058, 4974.427940786783, 3668.706503479715, 3735.7758534488016, 3741.9251614967548, 3811.466394704688, 3818.579956204815, 565.0507147991332, 565.5832140488051, 566.7761234312424, 568.8720037991502, 578.4735890339771, 644.7388807532863, 676.6921050921819, 739.663453128825, 754.5472716370134, 761.2121454294778, 9644.9035509644, 10106.747331316776, 10108.01160900383, 10272.589096436059, 10331.173506119492, 590.6311627307707, 751.8571471420413, 764.9388048956071, 795.0499153511498, 818.9426740128253, 4594.977025114853, 5143.665661731976, 5202.297689811902, 5205.9219111713355, 5230.241614965808, 111657.0, 115339.0, 117775.0, 118679.0, 119527.40236298763, 95564.0, 96095.0, 98296.0, 99121.50439247758, 99189.50405247927, 87170.0, 91256.54371728231, 91465.54267228754, 92826.53586732023, 93188.53405732928, 9211.631534738535, 9437.764055898657, 9572.856407154037, 9698.224142068477, 9705.6117755289, 51821.0, 52364.47635523596, 52498.73750631222, 52870.735646321526, 54512.72743636256, 72291.0, 74654.0, 75229.62385188039, 75504.0, 76612.61693691496, 13867.514636987657, 13905.0, 14108.717825643635, 14124.435022599391, 14133.717325653224, 15913.0, 15937.68124637524, 15951.361945522513, 16311.184440777677, 16385.262663179947, 14841.703165936837, 15119.16844573559, 15435.22823858825, 15477.071375717493, 15599.532014039596, 15102.54692359231, 15495.380184792934, 15627.655851622347, 15739.68520629558, 16040.0, 13702.0, 13864.584062478141, 13912.044552106323, 14099.0, 14971.781067070631, 11771.646850594496, 12275.079369047178, 12323.876761232632, 12356.505739770308, 12542.937285313516, 10961.0, 12153.331566763913, 12809.167404118702, 12838.229706217657, 12964.611061668165], "value": 7945.776536778171, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 105.0, 110.0, 113.0, 112.0, 112.0, 112.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 149.0, 173.0, 119.0, 153.0, 154.0, 123.0, 180.0, 126.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 164.0, 164.0, 171.0, 162.0, 163.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 77.0, 185.0, 85.0, 76.0, 74.0, 75.0, 165.0, 76.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 83.0, 83.0, 83.0, 151.0, 82.0, 83.0, 144.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 52.0, 54.0, 53.0, 51.0, 52.0, 51.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 70.0, 61.0, 61.0, 62.0, 62.0, 60.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 77.0, 77.0, 86.0, 77.0, 78.0, 78.0, 82.0, 76.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 125.0, 147.0, 125.0, 124.0, 126.0, 124.0, 145.0, 126.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 157.0, 156.0, 155.0, 156.0, 158.0, 160.0, 156.0, 155.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 65.0, 68.0, 64.0, 63.0, 66.0, 64.0, 65.0], "value": 65.1, "unit": "score"}]}]} 21:51:42 INFO - Return code: 0 21:51:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:51:42 ERROR - # TBPL SUCCESS # 21:51:42 INFO - Running post-action listener: _resource_record_post_action 21:51:42 INFO - [mozharness: 2016-08-11 04:51:42.308511Z] Finished run-tests step (success) 21:51:42 INFO - Running post-run listener: _resource_record_post_run 21:51:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558825472; Read time: 12; Write time: 508664 21:51:42 INFO - TinderboxPrint: CPU usage
13.4% 21:51:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:51:42 INFO - TinderboxPrint: I/O write bytes / time
558,825,472 / 508,664 21:51:42 INFO - TinderboxPrint: CPU idle
8,232.7 (86.6%) 21:51:42 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 21:51:42 INFO - TinderboxPrint: Swap in / out
0 / 0 21:51:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247463936; Read time: 0; Write time: 289028 21:51:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295219200; Read time: 0; Write time: 213864 21:51:42 INFO - Running post-run listener: _upload_blobber_files 21:51:42 INFO - Blob upload gear active. 21:51:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:51:42 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 21:51:42 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'] 21:51:42 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 21:51:43 INFO - (blobuploader) - INFO - Open directory for files ... 21:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:51:44 INFO - (blobuploader) - INFO - Done attempting. 21:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:51:44 INFO - (blobuploader) - INFO - Done attempting. 21:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:51:48 INFO - (blobuploader) - INFO - Done attempting. 21:51:48 INFO - (blobuploader) - INFO - Iteration through files over. 21:51:48 INFO - Return code: 0 21:51:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:51:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:51:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd74721431ae658a25fca0ed48fe72786c195254cef6ae2dcbdac3fbebabeeb028b24555c4ac2f57694f96d3c50422e9aa9c648e14cd9a4a44ab2bc26885797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bd108e3b4ef375c47d873ab7ab1a38c9fde22176036cf4bb1a758a3782c30f61e95d90cd4bca2b4dc2f1489cc873c21f4a7f8390d52e55ee46ce9b6857b5681", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e657fec7d19fdec6d6d82eff1dc96e9820b138b8a8a9f067bea0996c7b0e94adf665a482d33ca39faa6de8221b02742a22b364fcbaf55f133dc341454c88286c"} 21:51:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:51:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:51:48 INFO - Contents: 21:51:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd74721431ae658a25fca0ed48fe72786c195254cef6ae2dcbdac3fbebabeeb028b24555c4ac2f57694f96d3c50422e9aa9c648e14cd9a4a44ab2bc26885797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bd108e3b4ef375c47d873ab7ab1a38c9fde22176036cf4bb1a758a3782c30f61e95d90cd4bca2b4dc2f1489cc873c21f4a7f8390d52e55ee46ce9b6857b5681", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e657fec7d19fdec6d6d82eff1dc96e9820b138b8a8a9f067bea0996c7b0e94adf665a482d33ca39faa6de8221b02742a22b364fcbaf55f133dc341454c88286c"} 21:51:48 INFO - Running post-run listener: copy_logs_to_upload_dir 21:51:48 INFO - Copying logs to upload dir... 21:51:48 INFO - mkdir: /builds/slave/test/build/upload/logs 21:51:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.478880 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 21:51:48.474534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 21:51:48.477975) ========= 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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 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/abd74721431ae658a25fca0ed48fe72786c195254cef6ae2dcbdac3fbebabeeb028b24555c4ac2f57694f96d3c50422e9aa9c648e14cd9a4a44ab2bc26885797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bd108e3b4ef375c47d873ab7ab1a38c9fde22176036cf4bb1a758a3782c30f61e95d90cd4bca2b4dc2f1489cc873c21f4a7f8390d52e55ee46ce9b6857b5681", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e657fec7d19fdec6d6d82eff1dc96e9820b138b8a8a9f067bea0996c7b0e94adf665a482d33ca39faa6de8221b02742a22b364fcbaf55f133dc341454c88286c"} build_url:https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/Eo7eWyG2RMi-qtK3nyhBmA/artifacts/public/build/firefox-51.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/abd74721431ae658a25fca0ed48fe72786c195254cef6ae2dcbdac3fbebabeeb028b24555c4ac2f57694f96d3c50422e9aa9c648e14cd9a4a44ab2bc26885797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bd108e3b4ef375c47d873ab7ab1a38c9fde22176036cf4bb1a758a3782c30f61e95d90cd4bca2b4dc2f1489cc873c21f4a7f8390d52e55ee46ce9b6857b5681", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e657fec7d19fdec6d6d82eff1dc96e9820b138b8a8a9f067bea0996c7b0e94adf665a482d33ca39faa6de8221b02742a22b364fcbaf55f133dc341454c88286c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 21:51:48.503977) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:51:48.504318) ========= 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=62c568580acbfdaac3eec7be000001dc-1470889875.386957-638106785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:51:48.589517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 21:51:48.589863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 21:51:48.590193) ========= ========= Total master_lag: 0.18 =========