builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1467742574.21 results: success (0) buildid: 20160704043003 builduid: c627e31122614a9d9ef26501957468e5 revision: 7ad5763a7404c420b93301f17ea2e9bb66e5f00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.212640) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.213088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.213363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.228085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.228341) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 11:16:15-- 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% 104M=0s 2016-07-05 11:16:15 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.367895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.368216) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020396 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.418105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:14.418496) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ad5763a7404c420b93301f17ea2e9bb66e5f00b --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 7ad5763a7404c420b93301f17ea2e9bb66e5f00b --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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 11:16:15,452 truncating revision to first 12 chars 2016-07-05 11:16:15,452 Setting DEBUG logging. 2016-07-05 11:16:15,452 attempt 1/10 2016-07-05 11:16:15,452 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7ad5763a7404?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 11:16:15,788 unpacking tar archive at: mozilla-inbound-7ad5763a7404/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:15.098432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:15.098734) ========= script_repo_revision: 7ad5763a7404c420b93301f17ea2e9bb66e5f00b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:15.099189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:15.099456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:16:15.108419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 11:16:15.108689) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:16 INFO - MultiFileLogger online at 20160705 11:16:16 in /builds/slave/test 11:16:16 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 11:16:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:16 INFO - {'append_to_log': False, 11:16:16 INFO - 'base_work_dir': '/builds/slave/test', 11:16:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:16:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:16 INFO - 'branch': 'Mozilla-Inbound', 11:16:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:16 INFO - 'config_files': ('talos/linux_config.py',), 11:16:16 INFO - 'default_actions': ('clobber', 11:16:16 INFO - 'read-buildbot-config', 11:16:16 INFO - 'download-and-extract', 11:16:16 INFO - 'populate-webroot', 11:16:16 INFO - 'create-virtualenv', 11:16:16 INFO - 'install', 11:16:16 INFO - 'run-tests'), 11:16:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:16 INFO - 'download_minidump_stackwalk': True, 11:16:16 INFO - 'download_symbols': 'ondemand', 11:16:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:16 INFO - 'installer_path': 'installer.exe', 11:16:16 INFO - 'log_level': 'info', 11:16:16 INFO - 'log_name': 'talos', 11:16:16 INFO - 'log_to_console': True, 11:16:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:16 INFO - 'opt_config_files': (), 11:16:16 INFO - 'pip_index': False, 11:16:16 INFO - 'sps_profile': False, 11:16:16 INFO - 'sps_profile_interval': 0, 11:16:16 INFO - 'suite': 'dromaeojs-e10s', 11:16:16 INFO - 'system_bits': '32', 11:16:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:16 INFO - 'title': 'talos-linux64-ix-062', 11:16:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:16 INFO - 'use_talos_json': True, 11:16:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:16 INFO - 'work_dir': 'build'} 11:16:16 INFO - ##### 11:16:16 INFO - ##### Running clobber step. 11:16:16 INFO - ##### 11:16:16 INFO - Running pre-action listener: _resource_record_pre_action 11:16:16 INFO - Running main action method: clobber 11:16:16 INFO - rmtree: /builds/slave/test/build 11:16:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:16 INFO - Running post-action listener: _resource_record_post_action 11:16:16 INFO - ##### 11:16:16 INFO - ##### Finished clobber step (success) 11:16:16 INFO - ##### 11:16:16 INFO - ##### 11:16:16 INFO - ##### Running read-buildbot-config step. 11:16:16 INFO - ##### 11:16:16 INFO - Running pre-action listener: _resource_record_pre_action 11:16:16 INFO - Running main action method: read_buildbot_config 11:16:16 INFO - Using buildbot properties: 11:16:16 INFO - { 11:16:16 INFO - "project": "", 11:16:16 INFO - "product": "firefox", 11:16:16 INFO - "script_repo_revision": "production", 11:16:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:16:16 INFO - "repository": "", 11:16:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:16:16 INFO - "buildid": "20160704043003", 11:16:16 INFO - "pgo_build": "True", 11:16:16 INFO - "basedir": "/builds/slave/test", 11:16:16 INFO - "buildnumber": 1261, 11:16:16 INFO - "slavename": "talos-linux64-ix-062", 11:16:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:16:16 INFO - "platform": "ubuntu64_hw", 11:16:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:16:16 INFO - "branch": "mozilla-inbound", 11:16:16 INFO - "repo_path": "integration/mozilla-inbound", 11:16:16 INFO - "revision": "7ad5763a7404c420b93301f17ea2e9bb66e5f00b", 11:16:16 INFO - "stage_platform": "linux64-pgo", 11:16:16 INFO - "builduid": "c627e31122614a9d9ef26501957468e5", 11:16:16 INFO - "slavebuilddir": "test" 11:16:16 INFO - } 11:16:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:16:16 INFO - Running post-action listener: _resource_record_post_action 11:16:16 INFO - ##### 11:16:16 INFO - ##### Finished read-buildbot-config step (success) 11:16:16 INFO - ##### 11:16:16 INFO - ##### 11:16:16 INFO - ##### Running download-and-extract step. 11:16:16 INFO - ##### 11:16:16 INFO - Running pre-action listener: _resource_record_pre_action 11:16:16 INFO - Running main action method: download_and_extract 11:16:16 INFO - mkdir: /builds/slave/test/build/tests 11:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:16 INFO - https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:16:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:16:17 INFO - Downloaded 1361 bytes. 11:16:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:17 INFO - Using the following test package requirements: 11:16:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'jsshell-linux-x86_64.zip'], 11:16:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:17 INFO - https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:18 INFO - Downloaded 24276526 bytes. 11:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:19 INFO - Return code: 0 11:16:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:19 INFO - https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:20 INFO - Downloaded 24276526 bytes. 11:16:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:22 INFO - Return code: 0 11:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:22 INFO - https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:16:23 INFO - Downloaded 14403333 bytes. 11:16:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:16:23 INFO - Return code: 0 11:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:23 INFO - https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:16:24 INFO - Downloaded 60353317 bytes. 11:16:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:24 INFO - mkdir: /builds/slave/test/properties 11:16:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:24 INFO - Contents: 11:16:24 INFO - build_url:https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:25 INFO - Running post-action listener: _resource_record_post_action 11:16:25 INFO - Running post-action listener: set_extra_try_arguments 11:16:25 INFO - ##### 11:16:25 INFO - ##### Finished download-and-extract step (success) 11:16:25 INFO - ##### 11:16:25 INFO - ##### 11:16:25 INFO - ##### Running populate-webroot step. 11:16:25 INFO - ##### 11:16:25 INFO - Running pre-action listener: _resource_record_pre_action 11:16:25 INFO - Running main action method: populate_webroot 11:16:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:25 INFO - '--tppagecycles', 11:16:25 INFO - '7'], 11:16:25 INFO - 'tests': ['tsvgm']}}, 11:16:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['damp', 'tps']}, 11:16:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'tests': ['damp', 'tps']}, 11:16:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['dromaeo_dom']}, 11:16:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['basic_compositor_video']}, 11:16:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['a11yr', 11:16:25 INFO - 'ts_paint', 11:16:25 INFO - 'tpaint', 11:16:25 INFO - 'sessionrestore', 11:16:25 INFO - 'sessionrestore_no_auto_restore', 11:16:25 INFO - 'tabpaint']}, 11:16:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['tsvgx', 11:16:25 INFO - 'tsvgr_opacity', 11:16:25 INFO - 'tart', 11:16:25 INFO - 'tscrollx', 11:16:25 INFO - 'cart']}, 11:16:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:25 INFO - 'tsvgr_opacity', 11:16:25 INFO - 'tart', 11:16:25 INFO - 'tscrollx', 11:16:25 INFO - 'cart']}, 11:16:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'talos_options': ['--disable-e10s'], 11:16:25 INFO - 'tests': ['tp5o']}, 11:16:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'tests': ['tp5o']}, 11:16:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'talos_options': ['--disable-e10s', 11:16:25 INFO - '--xperf_path', 11:16:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:25 INFO - 'tests': ['tp5n']}, 11:16:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:25 INFO - 'talos_options': ['--xperf_path', 11:16:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:25 INFO - 'tests': ['tp5n']}}, 11:16:25 INFO - 'talos.zip': {'path': '', 11:16:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:25 INFO - Running post-action listener: _resource_record_post_action 11:16:25 INFO - ##### 11:16:25 INFO - ##### Finished populate-webroot step (success) 11:16:25 INFO - ##### 11:16:25 INFO - ##### 11:16:25 INFO - ##### Running create-virtualenv step. 11:16:25 INFO - ##### 11:16:25 INFO - Running pre-action listener: _resource_record_pre_action 11:16:25 INFO - Running main action method: create_virtualenv 11:16:25 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:25 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 11:16:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:25 INFO - Using real prefix '/usr' 11:16:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:28 INFO - Installing pip.................done. 11:16:28 INFO - Return code: 0 11:16:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:28 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 11:16:28 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 11:16:28 INFO - Using env: {'DISPLAY': ':0', 11:16:28 INFO - 'HOME': '/home/cltbld', 11:16:28 INFO - 'LANG': 'en_US.UTF-8', 11:16:28 INFO - 'LANGUAGE': 'en_US:en', 11:16:28 INFO - 'LOGNAME': 'cltbld', 11:16:28 INFO - 'MAIL': '/var/mail/cltbld', 11:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:28 INFO - 'MOZ_NO_REMOTE': '1', 11:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:28 INFO - 'NO_EM_RESTART': '1', 11:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:28 INFO - 'PWD': '/builds/slave/test', 11:16:28 INFO - 'SHELL': '/bin/bash', 11:16:28 INFO - 'SHLVL': '1', 11:16:28 INFO - 'TERM': 'linux', 11:16:28 INFO - 'TMOUT': '86400', 11:16:28 INFO - 'USER': 'cltbld', 11:16:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:28 INFO - '_': '/tools/buildbot/bin/python'} 11:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:28 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 11:16:28 INFO - Cleaning up... 11:16:28 INFO - Return code: 0 11:16:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:28 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 11:16:28 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 11:16:28 INFO - Using env: {'DISPLAY': ':0', 11:16:28 INFO - 'HOME': '/home/cltbld', 11:16:28 INFO - 'LANG': 'en_US.UTF-8', 11:16:28 INFO - 'LANGUAGE': 'en_US:en', 11:16:28 INFO - 'LOGNAME': 'cltbld', 11:16:28 INFO - 'MAIL': '/var/mail/cltbld', 11:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:28 INFO - 'MOZ_NO_REMOTE': '1', 11:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:28 INFO - 'NO_EM_RESTART': '1', 11:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:28 INFO - 'PWD': '/builds/slave/test', 11:16:28 INFO - 'SHELL': '/bin/bash', 11:16:28 INFO - 'SHLVL': '1', 11:16:28 INFO - 'TERM': 'linux', 11:16:28 INFO - 'TMOUT': '86400', 11:16:28 INFO - 'USER': 'cltbld', 11:16:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:28 INFO - '_': '/tools/buildbot/bin/python'} 11:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:28 INFO - Downloading/unpacking psutil>=3.1.1 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:30 INFO - Installing collected packages: psutil 11:16:30 INFO - Running setup.py install for psutil 11:16:30 INFO - building 'psutil._psutil_linux' extension 11:16:30 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 11:16:30 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 11:16:30 INFO - building 'psutil._psutil_posix' extension 11:16:30 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 11:16:30 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 11:16:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:31 INFO - Successfully installed psutil 11:16:31 INFO - Cleaning up... 11:16:31 INFO - Return code: 0 11:16:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:16: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 mozsystemmonitor==0.3 11:16:31 INFO - Using env: {'DISPLAY': ':0', 11:16:31 INFO - 'HOME': '/home/cltbld', 11:16:31 INFO - 'LANG': 'en_US.UTF-8', 11:16:31 INFO - 'LANGUAGE': 'en_US:en', 11:16:31 INFO - 'LOGNAME': 'cltbld', 11:16:31 INFO - 'MAIL': '/var/mail/cltbld', 11:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:31 INFO - 'MOZ_NO_REMOTE': '1', 11:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:31 INFO - 'NO_EM_RESTART': '1', 11:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:31 INFO - 'PWD': '/builds/slave/test', 11:16:31 INFO - 'SHELL': '/bin/bash', 11:16:31 INFO - 'SHLVL': '1', 11:16:31 INFO - 'TERM': 'linux', 11:16:31 INFO - 'TMOUT': '86400', 11:16:31 INFO - 'USER': 'cltbld', 11:16:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:31 INFO - '_': '/tools/buildbot/bin/python'} 11:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:31 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 11:16:31 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 11:16:31 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 11:16:31 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 11:16:31 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 11:16:31 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 11:16:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:33 INFO - Installing collected packages: mozsystemmonitor 11:16:33 INFO - Running setup.py install for mozsystemmonitor 11:16:33 INFO - Successfully installed mozsystemmonitor 11:16:33 INFO - Cleaning up... 11:16:33 INFO - Return code: 0 11:16:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:33 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:33 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 11:16:33 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 11:16:33 INFO - Using env: {'DISPLAY': ':0', 11:16:33 INFO - 'HOME': '/home/cltbld', 11:16:33 INFO - 'LANG': 'en_US.UTF-8', 11:16:33 INFO - 'LANGUAGE': 'en_US:en', 11:16:33 INFO - 'LOGNAME': 'cltbld', 11:16:33 INFO - 'MAIL': '/var/mail/cltbld', 11:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:33 INFO - 'MOZ_NO_REMOTE': '1', 11:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:33 INFO - 'NO_EM_RESTART': '1', 11:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:33 INFO - 'PWD': '/builds/slave/test', 11:16:33 INFO - 'SHELL': '/bin/bash', 11:16:33 INFO - 'SHLVL': '1', 11:16:33 INFO - 'TERM': 'linux', 11:16:33 INFO - 'TMOUT': '86400', 11:16:33 INFO - 'USER': 'cltbld', 11:16:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:33 INFO - '_': '/tools/buildbot/bin/python'} 11:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:33 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:33 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 11:16:33 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 11:16:33 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 11:16:33 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 11:16:33 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 11:16:33 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 11:16:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:35 INFO - warning: no files found matching '*.txt' 11:16:35 INFO - no previously-included directories found matching 'build' 11:16:35 INFO - no previously-included directories found matching 'dist' 11:16:35 INFO - no previously-included directories found matching '.git*' 11:16:35 INFO - Installing collected packages: jsonschema, functools32 11:16:35 INFO - Running setup.py install for functools32 11:16:35 INFO - warning: no files found matching '*.txt' 11:16:35 INFO - no previously-included directories found matching 'build' 11:16:35 INFO - no previously-included directories found matching 'dist' 11:16:35 INFO - no previously-included directories found matching '.git*' 11:16:35 INFO - Successfully installed jsonschema functools32 11:16:35 INFO - Cleaning up... 11:16:35 INFO - Return code: 0 11:16:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:35 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:35 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 11:16:35 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 11:16:35 INFO - Using env: {'DISPLAY': ':0', 11:16:35 INFO - 'HOME': '/home/cltbld', 11:16:35 INFO - 'LANG': 'en_US.UTF-8', 11:16:35 INFO - 'LANGUAGE': 'en_US:en', 11:16:35 INFO - 'LOGNAME': 'cltbld', 11:16:35 INFO - 'MAIL': '/var/mail/cltbld', 11:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:35 INFO - 'MOZ_NO_REMOTE': '1', 11:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:35 INFO - 'NO_EM_RESTART': '1', 11:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:35 INFO - 'PWD': '/builds/slave/test', 11:16:35 INFO - 'SHELL': '/bin/bash', 11:16:35 INFO - 'SHLVL': '1', 11:16:35 INFO - 'TERM': 'linux', 11:16:35 INFO - 'TMOUT': '86400', 11:16:35 INFO - 'USER': 'cltbld', 11:16:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:35 INFO - '_': '/tools/buildbot/bin/python'} 11:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:36 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 11:16:36 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 11:16:36 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 11:16:36 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 11:16:36 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 11:16:36 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 11:16:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:39 INFO - Downloading docopt-0.6.1.tar.gz 11:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:39 INFO - Running setup.py install for blobuploader 11:16:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:39 INFO - Running setup.py install for requests 11:16:40 INFO - Running setup.py install for docopt 11:16:40 INFO - Successfully installed blobuploader requests docopt 11:16:40 INFO - Cleaning up... 11:16:40 INFO - Return code: 0 11:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:40 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:40 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 11:16:40 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 11:16:40 INFO - Using env: {'DISPLAY': ':0', 11:16:40 INFO - 'HOME': '/home/cltbld', 11:16:40 INFO - 'LANG': 'en_US.UTF-8', 11:16:40 INFO - 'LANGUAGE': 'en_US:en', 11:16:40 INFO - 'LOGNAME': 'cltbld', 11:16:40 INFO - 'MAIL': '/var/mail/cltbld', 11:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:40 INFO - 'MOZ_NO_REMOTE': '1', 11:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:40 INFO - 'NO_EM_RESTART': '1', 11:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:40 INFO - 'PWD': '/builds/slave/test', 11:16:40 INFO - 'SHELL': '/bin/bash', 11:16:40 INFO - 'SHLVL': '1', 11:16:40 INFO - 'TERM': 'linux', 11:16:40 INFO - 'TMOUT': '86400', 11:16:40 INFO - 'USER': 'cltbld', 11:16:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:40 INFO - '_': '/tools/buildbot/bin/python'} 11:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:40 INFO - Running setup.py (path:/tmp/pip-RCTdxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:40 INFO - Running setup.py (path:/tmp/pip-NqWWeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:40 INFO - Running setup.py (path:/tmp/pip-GmgrYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:40 INFO - Running setup.py (path:/tmp/pip-64iD3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:40 INFO - Running setup.py (path:/tmp/pip-Lv1ybx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:41 INFO - Running setup.py (path:/tmp/pip-DtHNzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:41 INFO - Running setup.py (path:/tmp/pip-W6MC9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:41 INFO - Running setup.py (path:/tmp/pip-fvUPFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:41 INFO - Running setup.py (path:/tmp/pip-NOw606-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:41 INFO - Running setup.py (path:/tmp/pip-bPLIUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:41 INFO - Running setup.py (path:/tmp/pip-vv4Zve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:41 INFO - Running setup.py (path:/tmp/pip-QWkQ0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:41 INFO - Running setup.py (path:/tmp/pip-pJbUvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:41 INFO - Running setup.py (path:/tmp/pip-f04NH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:41 INFO - Running setup.py (path:/tmp/pip-8eCMXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:41 INFO - Running setup.py (path:/tmp/pip-0uspw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:41 INFO - Running setup.py (path:/tmp/pip-OJ00cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:41 INFO - Running setup.py install for manifestparser 11:16:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for mozcrash 11:16:42 INFO - Running setup.py install for mozdebug 11:16:42 INFO - Running setup.py install for mozdevice 11:16:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for mozfile 11:16:42 INFO - Running setup.py install for mozhttpd 11:16:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for mozinfo 11:16:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for mozInstall 11:16:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for mozleak 11:16:42 INFO - Running setup.py install for mozlog 11:16:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:42 INFO - Running setup.py install for moznetwork 11:16:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Running setup.py install for mozprocess 11:16:43 INFO - Running setup.py install for mozprofile 11:16:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Running setup.py install for mozrunner 11:16:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Running setup.py install for mozscreenshot 11:16:43 INFO - Running setup.py install for moztest 11:16:43 INFO - Running setup.py install for mozversion 11:16:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:43 INFO - Cleaning up... 11:16:43 INFO - Return code: 0 11:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:43 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:43 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 11:16:43 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 11:16:43 INFO - Using env: {'DISPLAY': ':0', 11:16:43 INFO - 'HOME': '/home/cltbld', 11:16:43 INFO - 'LANG': 'en_US.UTF-8', 11:16:43 INFO - 'LANGUAGE': 'en_US:en', 11:16:43 INFO - 'LOGNAME': 'cltbld', 11:16:43 INFO - 'MAIL': '/var/mail/cltbld', 11:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:43 INFO - 'MOZ_NO_REMOTE': '1', 11:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:43 INFO - 'NO_EM_RESTART': '1', 11:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:43 INFO - 'PWD': '/builds/slave/test', 11:16:43 INFO - 'SHELL': '/bin/bash', 11:16:43 INFO - 'SHLVL': '1', 11:16:43 INFO - 'TERM': 'linux', 11:16:43 INFO - 'TMOUT': '86400', 11:16:43 INFO - 'USER': 'cltbld', 11:16:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:43 INFO - '_': '/tools/buildbot/bin/python'} 11:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:43 INFO - Running setup.py (path:/tmp/pip-OJyZ9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:44 INFO - Running setup.py (path:/tmp/pip-eaJLA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:44 INFO - Running setup.py (path:/tmp/pip-En59UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:44 INFO - Running setup.py (path:/tmp/pip-OREWQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:44 INFO - Running setup.py (path:/tmp/pip-r3rrUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:44 INFO - Running setup.py (path:/tmp/pip-xTeLGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:44 INFO - Running setup.py (path:/tmp/pip-r476Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:44 INFO - Running setup.py (path:/tmp/pip-95Rs_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:44 INFO - Running setup.py (path:/tmp/pip-kUTC6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:44 INFO - Running setup.py (path:/tmp/pip-2ByFQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:44 INFO - Running setup.py (path:/tmp/pip-tj25BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:44 INFO - Running setup.py (path:/tmp/pip-LbTcaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:44 INFO - Running setup.py (path:/tmp/pip-gcE_ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:44 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:44 INFO - Running setup.py (path:/tmp/pip-uwANx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 11:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:44 INFO - Running setup.py (path:/tmp/pip-8mwr6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:45 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)) 11:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:45 INFO - Running setup.py (path:/tmp/pip-1A05u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:45 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)) 11:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:45 INFO - Running setup.py (path:/tmp/pip-G5HmPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:45 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)) 11:16:45 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)) 11:16:45 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)) 11:16:45 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)) 11:16:45 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)) 11:16:45 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)) 11:16:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:47 INFO - Downloading blessings-1.6.tar.gz 11:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:47 INFO - Installing collected packages: blessings 11:16:47 INFO - Running setup.py install for blessings 11:16:47 INFO - Successfully installed blessings 11:16:47 INFO - Cleaning up... 11:16:47 INFO - Return code: 0 11:16:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:47 INFO - Reading from file tmpfile_stdout 11:16:47 INFO - Current package versions: 11:16:47 INFO - argparse == 1.2.1 11:16:47 INFO - blessings == 1.6 11:16:47 INFO - blobuploader == 1.2.4 11:16:47 INFO - docopt == 0.6.1 11:16:47 INFO - functools32 == 3.2.3-2 11:16:47 INFO - jsonschema == 2.5.1 11:16:47 INFO - manifestparser == 1.1 11:16:47 INFO - mozInstall == 1.12 11:16:47 INFO - mozcrash == 0.17 11:16:47 INFO - mozdebug == 0.1 11:16:47 INFO - mozdevice == 0.48 11:16:47 INFO - mozfile == 1.2 11:16:47 INFO - mozhttpd == 0.7 11:16:47 INFO - mozinfo == 0.9 11:16:47 INFO - mozleak == 0.1 11:16:47 INFO - mozlog == 3.2 11:16:47 INFO - moznetwork == 0.27 11:16:47 INFO - mozprocess == 0.22 11:16:47 INFO - mozprofile == 0.28 11:16:47 INFO - mozrunner == 6.11 11:16:47 INFO - mozscreenshot == 0.1 11:16:47 INFO - mozsystemmonitor == 0.3 11:16:47 INFO - moztest == 0.7 11:16:47 INFO - mozversion == 1.4 11:16:47 INFO - psutil == 3.1.1 11:16:47 INFO - requests == 1.2.3 11:16:47 INFO - wsgiref == 0.1.2 11:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 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)) 11:16:47 INFO - Cleaning up... 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x1e55030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2084400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', '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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:47 INFO - Cleaning up... 11:16:48 INFO - Return code: 0 11:16:48 INFO - Running post-action listener: _resource_record_post_action 11:16:48 INFO - Running post-action listener: _start_resource_monitoring 11:16:48 INFO - Starting resource monitoring. 11:16:48 INFO - ##### 11:16:48 INFO - ##### Finished create-virtualenv step (success) 11:16:48 INFO - ##### 11:16:48 INFO - ##### 11:16:48 INFO - ##### Running install step. 11:16:48 INFO - ##### 11:16:48 INFO - Running pre-action listener: _resource_record_pre_action 11:16:48 INFO - Running main action method: install 11:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:48 INFO - Reading from file tmpfile_stdout 11:16:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:48 INFO - Reading from file tmpfile_stdout 11:16:48 INFO - Output received: 11:16:48 INFO - Usage: mozinstall [options] installer 11:16:48 INFO - Options: 11:16:48 INFO - -h, --help show this help message and exit 11:16:48 INFO - -d DEST, --destination=DEST 11:16:48 INFO - Directory to install application into. [default: 11:16:48 INFO - "/builds/slave/test"] 11:16:48 INFO - --app=APP Application being installed. [default: firefox] 11:16:48 INFO - mkdir: /builds/slave/test/build/application 11:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:05 INFO - Reading from file tmpfile_stdout 11:17:05 INFO - Output received: 11:17:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:05 INFO - Running post-action listener: _resource_record_post_action 11:17:05 INFO - ##### 11:17:05 INFO - ##### Finished install step (success) 11:17:05 INFO - ##### 11:17:05 INFO - ##### 11:17:05 INFO - ##### Running run-tests step. 11:17:05 INFO - ##### 11:17:05 INFO - Running pre-action listener: _resource_record_pre_action 11:17:05 INFO - Running main action method: run_tests 11:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:05 INFO - Python 2.7.3 11:17:05 INFO - Return code: 0 11:17:05 INFO - grabbing minidump binary from tooltool 11:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:05 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 0x2113570>, '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 0x2114470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:05 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 11:17:05 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 11:17:05 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 11:17:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:05 INFO - Return code: 0 11:17:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:05 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/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 11:17:05 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/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 11:17:05 INFO - Using env: {'DISPLAY': ':0', 11:17:05 INFO - 'HOME': '/home/cltbld', 11:17:05 INFO - 'LANG': 'en_US.UTF-8', 11:17:05 INFO - 'LANGUAGE': 'en_US:en', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MAIL': '/var/mail/cltbld', 11:17:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SHLVL': '1', 11:17:05 INFO - 'TERM': 'linux', 11:17:05 INFO - 'TMOUT': '86400', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - '_': '/tools/buildbot/bin/python'} 11:17:05 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/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 11:17:05 INFO - mozversion application_buildid: 20160704043003 11:17:05 INFO - mozversion application_changeset: 7ad5763a7404c420b93301f17ea2e9bb66e5f00b 11:17:05 INFO - mozversion application_display_name: Nightly 11:17:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:05 INFO - mozversion application_name: Firefox 11:17:05 INFO - mozversion application_remotingname: firefox 11:17:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:17:05 INFO - mozversion application_vendor: Mozilla 11:17:05 INFO - mozversion application_version: 50.0a1 11:17:05 INFO - mozversion platform_buildid: 20160704043003 11:17:05 INFO - mozversion platform_changeset: 7ad5763a7404c420b93301f17ea2e9bb66e5f00b 11:17:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:17:05 INFO - mozversion platform_version: 50.0a1 11:17:05 INFO - using testdate: 1467742625 11:17:05 INFO - actual date: 1467742625 11:17:05 INFO - starting webserver on 'localhost:53500' 11:17:05 INFO - SUITE-START | Running 2 tests 11:17:05 INFO - TEST-START | dromaeo_css 11:17:05 INFO - operating with platform_type : linux_ 11:17:05 INFO - Initialising browser for dromaeo_css test... 11:17:05 INFO - TEST-INFO | started process 17579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppPOwVk/profile http://localhost:53500/getInfo.html) 11:17:10 INFO - PROCESS | 17579 | __metrics Screen width/height:1600/1200 11:17:10 INFO - PROCESS | 17579 | colorDepth:24 11:17:10 INFO - PROCESS | 17579 | Browser inner width/height: 1024/697 11:17:10 INFO - PROCESS | 17579 | __metrics 11:17:11 ERROR - PROCESS | 17579 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:17:11 INFO - TEST-INFO | 17579: exit 0 11:17:11 INFO - Browser initialized. 11:17:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:11 INFO - TEST-INFO | started process 17699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppPOwVk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:23 INFO - PROCESS | 17699 | RSS: Main: 168071168 11:17:23 INFO - PROCESS | 17699 | 11:18:13 INFO - PROCESS | 17699 | 1467742693256 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] 11:20:21 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53500/tests/dromaeo/cssquery-ext.html) 11:20:22 INFO - PROCESS | 17699 | RSS: Main: 171339776 11:20:22 INFO - PROCESS | 17699 | 11:23:24 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-ext.html (next: http://localhost:53500/tests/dromaeo/cssquery-jquery.html) 11:23:25 INFO - PROCESS | 17699 | RSS: Main: 168185856 11:23:25 INFO - PROCESS | 17699 | 11:26:26 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53500/tests/dromaeo/cssquery-mootools.html) 11:26:27 INFO - PROCESS | 17699 | RSS: Main: 171962368 11:26:27 INFO - PROCESS | 17699 | 11:29:29 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53500/tests/dromaeo/cssquery-prototype.html) 11:29:29 INFO - PROCESS | 17699 | RSS: Main: 167460864 11:29:29 INFO - PROCESS | 17699 | 11:32:32 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53500/tests/dromaeo/cssquery-yui.html) 11:32:32 INFO - PROCESS | 17699 | RSS: Main: 169377792 11:32:32 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | Cycle 1(1): loaded http://localhost:53500/tests/dromaeo/cssquery-yui.html (next: http://localhost:53500/tests/dromaeo/cssquery-dojo.html) 11:35:35 INFO - PROCESS | 17699 | RSS: Main: 170627072 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | __start_tp_report 11:35:35 INFO - PROCESS | 17699 | _x_x_mozilla_page_load 11:35:35 INFO - PROCESS | 17699 | _x_x_mozilla_page_load_details 11:35:35 INFO - PROCESS | 17699 | |i|pagename|runs| 11:35:35 INFO - PROCESS | 17699 | |0;dojo.html;3096.1949893027813;3140.057982605218;3154.6687597802215;3158;3175.4601717707988;5280.1551751719735;5280.841574752754;5291;5297.841064768054;5302.3106996090555;5230.764615592298;5240.554552863011;5335.733213339327;5337.893242135155;5377.220303056055;4810.518948105197;4833.7099774013495;4855.927161092586;4947.084789313971;4961.727105009223;4810.446798618169;4902.485239049902;4959.479254678261;4990.87522811929;5000.549950504454;4802.32767412559;4805.447373552051;4842.394700662399;4855.951440485585;4864.756762161877;4836.177849765549;4857.587105096071;4858.732769697665;4935.629827762897;4947.431045429786;4871.902561948741;4884.7069175849565;4887.755612219375;4912.508749125094;4931.7040977541465;5235.267062611238;5244.082285600005;5269.762860671279;5305.708186049805;5362.544183744387;5645.125005624135;5671.461211184972;5683.2895888014;5698.914516282218;5699.971500142514;5633.40849210831;5757.568182386338;5769.624974376652;5778.653280803165;5784.421557844224;5408.486193811582;5441.918371224435;5443.537299329561;5457.454254574551;5473.17902314648;5912.73392697321;5929.080992446177;5948.078047902582;5948.910766338508;5954.970225148933;5462.9726851365485;5594.832155035356;5719.5138413235345;5720.170575266563;5725.227094342294;5680.5455563554815;5726.599138060295;5734.111212761945;5738.741756620962;5779.190913272145;5589.552835773128;5620.803271885465;5689.743961521742;5699.088145896637;5725.141228815628;5559.694216818114;5589.217509548666;5702.144678298288;5739.053056245756;5757.827265182052;4382.737035777864;4403.405540252089;4411.470623525198;4441.711288766284;4444.777761111996;3910.159315747071;3943.6253555912144;3950.48643676326;3957.56466788653;3981.3629819229363;5393.514583687487;5428.83713488596;5449.291592093082;5523.3295059722095;5587.273654424899;5654.293213348332;5659.745311460994;5659.952908711902;5684.403137670568;5763.366029736726;5461.371942226615;5509.5041446270025;5513.173024046425;5513.3108361454815;5533.972330138324;4870.683405578626;5003.074431230234;5024.547790698782;5041.949580504222;5055.039542486916;6053.878922421527;6072.180255665517;6077.1491991121275;6094.939050609526;6096.847578810476;5865.706714664249;5876.882462350814;5884.47039766423;5888.882222355443;5907.232059832194;5764.279465066867;5932.584719069624;5945.554083443845;5994.490468310242;6037.969810151097;5651.491365777099;5656.9717151415625;5682.801101961411;5695.373508914099;5711.114777209539;5685.800996965252;5731.770729170787;5771.797987070432;5780.537556995514;5795.275590551181;5433.130699088127;5449.3460784706085;5483.479069488392;5506.008918394567;5508.586855985737;5506.091494903296;5532.446755324436;5545.916811247916;5576.637518561281;5588.133839254922;5518.392976772471;5518.641288316247;5545.5009049184155;5551.639143455663;5555.444455554574;5492.47821456961;5611.298587676541;5670.489655930986;5739.598228123991;5755.021646320052;5512.641678290898;5554.389017208185;5561.805336813192;5567.24842146305;5570.5543556516195 11:35:35 INFO - PROCESS | 17699 | |1;ext.html;584.4272612839417;595.1192235491474;630.4074170279938;642.8296501427122;663.5222639699415;38191.23617527648;41933.370999435036;41964.37053444193;42141.78929105358;42180.57819421805;42536.361954570704;42610;42613;42805.57194428055;43093;8856.512891790964;9016.954915225415;9021.864672029891;9026.548672566378;9037.457752534869;8797.7800554986;8915.153060459279;8963.41737787045;8991.14584114508;9014.639414423415;8992.77518062047;8993.505357205351;9040.095990400972;9062.909370906305;9069.682561110363;8868.246199073086;8962.283017358595;8962.507062111581;8976;9007.099290071006;8899.243564297043;8947;8957.865632015524;8976.640934362618;8992.910070899272;31740;40488.190236195114;40720.185596288204;40787;40859.59140408588;3359.6808303211155;3532.8410221540094;3570.9821450892578;3844.5002149720635;4070.206309769596;31535.369292614017;31709;31804.363912721616;31855.362892742247;33297.50053749196;4259.8083086261195;4297.957020429787;4348.565143485658;4372.081862808814;4382.452193475816;311454;312756;312859;312912;315294;32699;34448.82775586156;36048.45927311092;36084.819575902475;36237;37403;37443.251134977145;37444.43833342502;37460.62539374626;37491.62508374936;14152.858471415155;14203.289835508183;14364.138151710931;14370;14409.06341087826;11074.612388566362;11146.888531114748;11148.108151348035;11154.163437742201;11157.609483668195;8409.20112589303;8431.15688431152;8457.619407126695;8521.062683104854;8536.359773017048;3247.8376081195847;3255.235019770352;3257.1042963185314;3303.6035675719068;3308.693066238822;1009.7374682582581;1077.3105212663902;1097.9945100274447;1102.895224953628;1153.7461758413135;32142.83928580342;32590.7002040785;32732.509012364833;32828.67171328256;32988.50517242243;1052.2791887557048;1080.3895798873612;1132.101819342486;1148.1675785055768;1183.4319526627266;16751.748723769153;17122.914385427994;17166.485005449857;17189.7421538677;17389.478315650296;594113;594272;594337;597668;599619;59285;59917;60162;60442.697786510784;60554.697226513585;1317.8155058291848;1319.0964189530202;1354.9458021679022;1359.64649191211;1363.2297751770416;31001.68998309988;31098.378032439676;31261.393358167985;31262.53106203363;31668.36663266768;52400.47599523956;52872.73563632157;53123.73438132785;53137;53194.73402632962;485478;490756;491155;491705;492100;26795.464090718466;27010;27054;27112.32219194536;27247.182584522496;47730.28404573865;47921.76039119782;48490.27264590964;48569;48719.26921096257;40259.59740402558;40453;41619.375709363776;41705;42051;41910.580894190665;42009.78995105005;42254.78872605618;42387.364189536565;43511.56488435202;36265.81867090753;40448.59551404566;41702.1659566813;44851.775741121084;45334.77332613316;36736.63263367332;36811.63188368082;37442.43836342402;38228.85313440601;38285.6171438282;28152.577711334758;28985.130446086652;29114.70885291205;29145.125646229797;29175.103618264744 11:35:35 INFO - PROCESS | 17699 | |2;jquery.html;383.9105691450011;384.749912556838;387.93986932025535;390.79287977371996;407.8022159252762;18083.095845207736;19230.71153932692;19598.804011959877;19613.803861961376;20710.27514037009;19089.14098865551;19548.804511954877;19657.21371145156;19834.801651983475;19865.702014469796;5363.061464243761;5568.303962004749;5606.55147588193;5672.829815105553;5782.797602083928;5645.435456454363;5655.5475561954945;5666.858328541799;5728.742206600692;5742.39704830993;5845.327787304451;5996.520278377741;6001.639901605896;6006.609570377911;6043.063325184604;5339;5555.944440555623;5573.164025396223;6017.067354560028;6032.426919442646;5392.083345831218;5463.890722185573;5467.097928841737;5499.587530935156;5518.558515318765;22990.540189196123;23065.53868922629;23932.28203153908;24274.878625606758;24480.510389792104;2311.90752369905;2357.634566642173;2376.989779343772;2578.8323758955607;2678.7723043541323;9870.802583948353;10101.292909496338;10186.388816671024;10382.53278602457;15063;1900.980990190108;1951.8145776151243;1952.746515614516;1981.2570286142698;2002.699595060738;71635.64182179108;81096.18903810946;81114.18885811126;81914;83053;10610;10919;11078.224524283383;11178.0498657615;11274.943625281821;15134.621634459007;15195.088294702353;15259.847401526065;15289;15377;7712.344450721752;7787.2602102801275;8127.471714338667;8306.8338633227;8314.127016663164;7736.6518506667335;7771.261730135628;7777.261160189886;7877.684892604231;7887.566183859943;4614.284785858197;4631.698939568917;4696.671233013656;4708.976455117771;4766.571008609172;1983.9008049597462;1994.982558894974;2004.4988752811796;2007.9899600502197;2049.25202301159;1013.6097602422973;1021.4075836015094;1021.6858814784518;1025.687165414541;1065.7069305940772;20132.19471221135;20182.39452816418;20298.391048268575;20312.593748124953;20337.389878303675;946.8390373636498;950.7860731335533;958.9760255993516;997.0527998401548;1075.833245846895;10592.364458132537;11089.05743011837;11142.554297828157;11171.66485005451;11183.217174797686;475730;477544;478974;490207;493536;56842.14736778952;86531;101346.4932675332;101382.4930875341;103057;1041.510490069666;1043.6921108273077;1058.0688993685508;1086.3373342261214;1089.596849165798;15810.920945395199;17825.821741782416;18091.728624070387;18092.638147237245;18290.26838926428;44769.32846007247;45071.549284506735;45249;45469.54530454653;46863.765681171375;58129;59048.70475647594;63054.36945630485;63058;64112.3588764125;7399.889001665087;7956.085050219067;8006.959965200137;8115.675372985251;8601.913980860112;13788.379522921694;13972.161670299814;14106;14165.291735413395;14259.64350891236;12413.131080824256;12447.439865205906;12666.809997850223;12707.36463176856;12815.807762883378;10620.309679870783;11278.774424511628;11359.54561817518;11734.471948762497;12055.457504412498;12153.696157595778;12194.329311887932;12720.236785792882;12964.935175324063;13018.088733788543;7977.641006154621;8013.038435387558;8020.278174964281;8057.556834374166;8058;8968.68609598687;11027.558897644005;11278.154138439486;11381.54473821038;11618.767624647291 11:35:35 INFO - PROCESS | 17699 | |3;mootools.html;1434.8995570310078;1472.4404726204043;1581.6520365519582;1720.638665880165;1753.6580366828466;7891.131975482693;8285.254327110559;8557.10150434204;8930.955345223265;8940.105989401065;8272.875906861402;8320.625571849267;8331.375146863978;8406.369522285822;8407.201315874998;2219.5893759654437;2249.3701763506247;2249.741279752833;2250.9887450562724;2256.3005468304796;2194.8353873459473;2224.3549370682563;2283.212291759349;2294.4608017115966;2302.6776251324827;2213.070510385634;2237.2281562860867;2241.0363543676212;2242.1703969531295;2250.032486031006;2175.7171567696255;2180.509385388291;2193.21044424008;2204.335726526478;2207.0399376271293;2109.5359021015506;2111.419359676086;2111.9472013199793;2117.76704562498;2134.5624147049816;8380.24577788002;8409.411341206118;8474.703385381483;8475.194856488624;8516.914830851736;4998.550130488237;5122.897542049138;5169.767360468751;5172.870678233036;5192.636515443921;3144.261098641817;3174.3968645957193;3229.951550726741;3266.6080070391467;3271.8527666255077;1037.1702637889734;1045.7751583409604;1051.2693677893867;1054.6203366788027;1062.6440142552253;12083.758324833454;12175.695607609792;12188.634340969786;12221.511139554406;12228.449719762632;4416.6245869101485;4438.423005009328;4533.297338912474;4556;4560.315952607069;10371.066604005675;10404.427756473315;10419.374837509773;10433.843492347622;10498.160147188206;5202.479752024843;5221.086309895753;5249.343832020997;5249.501297376743;5253.763580638804;4461.955380446154;4784.971231185312;4809.182438985381;4810.735409552438;4812.35033270504;3889.1055057336407;3890.2414029264587;3999.8400063997115;4016;4023.3562629979065;1201.987980120205;1238.9008879289636;1246.8566114896903;1258.779713550125;1270.5235536673747;933.9959543490775;953.1278879825021;963.802420503795;965.7875267441152;970.8834939807127;5699.857503562444;5741.598088133791;5818.5345172386105;5917.881642367214;5966.403359663999;1003.7139415266614;1028.3315844701003;1054.8101341758556;1089.6513115802868;1093.2347356850237;3808.7524310919703;3946.1121247719034;3969.622885825842;3971.801409929492;3973.7417067890497;10520.473976301155;10804.459777011118;10830.079443247412;10847.403392813314;10847.67456976292;10524;10624.309419887682;10624.840627390595;10641.361518308771;10679.145668346513;8168.305694016075;8248.257656810796;8256.091829898827;8272.875906861402;8285.25432711059;5539.307586551681;5552.111662134039;5619.325680918316;5629.352624448077;5753.626014309057;10081.092701656886;10087.69736907894;10102.949485252526;10147.137493312855;10153.898461015295;10033.949830250802;10072.899271007196;10428.739281518023;10430.634927777492;10470.842937355794;6894.655267236719;7245.710171593078;7345.338919497271;7456.589887556236;7472.439567032386;8572.485650860968;8583.442076265022;8596.398252122292;8624.655013799378;8724.520151391735;7551.962240188764;7793.791962245861;7810.726624568113;7859.09620393662;7901.920980790119;7327.816804579928;7366.447516436396;7510.39916806665;7536.585487798224;7588.734394296173;6732.764353247613;6735.73057077731;6810.28492008332;6810.761623343159;6869.931300687129;4931.753412329297;5044.848654540369;5077.162268225701;5160.458151894147;5201.6098792591465;5083.771230294572;5086.440491546001;5101.7194054327365;5159.2003239497935;5171.482851714798 11:35:35 INFO - PROCESS | 17699 | |4;prototype.html;310.23991221507305;311.44407233088936;317.5411530338662;334.3847320929489;339.4433129667344;5461.481159289871;5524.812165384442;5669;5688.544916406683;5731.51282141018;5547.944520554794;5575.135853942646;5585.575678202063;5598.188262701916;5632.38043815181;4342.1315736852675;4401.537838526957;4403.229434848905;4423.628675110726;4438.0014496738295;4118.19695159444;4316.352547117942;4335.891602709942;4419.469663640368;4429.424174857264;4270.29188324671;4271.850485233017;4276.080642661827;4321.503027151871;4325.4593175853015;4300.311950087987;4302.935455968163;4316.9855084055225;4325.891852703676;4336.84821031264;3630.2195028068827;3763.310445884469;3768.171002379472;3791.5829258781514;3799.183175617228;5416.864578385533;5462.726863656841;5477.780888764484;5477.917831232535;5549.445055494459;4948.826791062295;4964.528369804862;4966.652334336598;4972.8259510917305;4974.552290293891;5605.635633683797;5846.795362162304;5914.733836977346;5915.260592425947;5941.851453713649;4065.3698676705158;4076.8369265229353;4096.32410652242;4102.794860256975;4115.73247738899;6020.939790602081;6077.24034495688;6083.9087413688385;6094.8171554853425;6146.7541298348015;4112.897177570585;4210.305299625527;4211.305134652809;4236.533981262059;4238.3006803877015;4255.276602977501;4261.31818908973;4275.914481710349;4281.250781113293;4293.935590966138;4964.578010869117;4966.726830024383;4967.7019378837385;4982.576480999083;4998.550130488274;5754.683492407958;5894.498967587803;5895.997680394344;5968.1942937703725;6008.849778755566;1456.1772598481823;1473.7789331600345;1474.9822622390516;1476.6825132596543;1481.148339704674;903.7288813355967;921.6497730862229;930.2743859789375;938.887333519982;945.0879900895669;5018.290123333359;5047.217681259411;5050.393952725696;5075.213341932006;5086.389633243961;5128.8461346159675;5181.813184891264;5245.370555533361;5307.681539107666;5316.548093412103;5006.549410552995;5048.899022019539;5056.544910958031;5307.681539107666;5833.67914764692;3198.504231844068;3206.374756922378;3222.7421806255443;3227.322262324938;3246.3507298540385;6162.26052873658;6282.32483996867;6301.149344838388;6310.864044471948;6319;6130.816075517741;6194.535409844189;6198.411150940653;6214.8135555933395;6219.813405597839;6311.526635502264;6346.556575718381;6361.077643741632;6364.64994425311;6378.585391949601;5868.911966320594;6053.576249662481;6070.271567411939;6086.482648974887;6137.294211165773;6004.5496587755215;6024.638521688713;6053.3946605339115;6079.908801368071;6083.513318934386;6007.7596896125415;6193.628382297076;6259.280182779039;6315.684215789101;6335.461485773761;4212.283911734951;4244.808983595807;4263.850765223202;4284;4295.119500502452;6107.236595425572;6132.356102609162;6152.692365381802;6163.106349579376;6176.66028368444;5751.217122691979;5857.9121313179485;5881.529477641864;5893.793717219876;5911.55663325261;5841.065429531254;5949.851253718692;5956.791512297049;5962.403759624176;5971.208637408847;5809.448102430262;5871.94128058714;5875.794347197828;5897.882042359214;5910.408959104056;5599.536204070196;5886.764529418775;5911.930824211491;5915.142304365929;5920.654830021024;5729.684867332337;5765;5835.766569337179;5845.18167456548;5849.415058494286 11:35:35 INFO - PROCESS | 17699 | |5;yui.html;761.6572542355938;777.5023984649825;785.328544094799;804.645955779457;854.367767851789;14692.926535367322;15259.847401525982;15365.923170384132;15384;15524.146171960552;13643.18140911546;13746.450141994308;13812.93093534531;13822.723545529108;13844.169349839016;632.4181752787435;753.2730914667345;772.3126417488439;773.6866569039548;774.7946794099568;767.8579462799372;769.4882902869585;775.9418043646721;776.3401109057313;777.5334799120511;833.5457175839152;834.8413801377719;835.7242110103651;837.0666706622103;841.1336323586685;812.7764864662206;815.5432957543765;821.1049955548422;822.9135940726227;828.4490813608973;602.9336772954971;603.9607425517328;605.3039005144076;606.7087797857009;608.6530677513819;14099.78850317246;14108.92945535276;14126.081804682663;14146.787798183035;14177.85822141786;14255.358508867126;14769.70460590793;14931.25343732809;15090.17004064776;15164.545063648107;11210.215284930058;11265.49305281256;11476.885231147666;11572.016378607828;13397.464101435931;3911.550171730259;3987.7009224308295;4001.6598589119667;4031.858884939013;4036.5963403659694;79407;80720.59639701822;81028.18971810266;81943.59028204822;82211;11851.940322275685;11916.344601046852;12014.33921134346;12141.514339426323;12168.452419641137;23417.297481075595;23428;23450.179243726387;23460;23624;8168.9183108169345;8264;8297.170282971654;8372.33021358302;8579.571021448903;4756.8097276108565;4840.685355451885;4909.116359055404;4931.50684931504;5006.1739812930455;3443.8450269737923;3460.8788692395647;3517.120719820045;3534.5581802274714;3540.91147721309;593.442164365495;597.1848426897341;621.3041393639153;626.5175814622716;627.3193584960369;519.6752029981262;594.9196858424144;693.3101563943908;727.2037119354299;779.0845756236399;9366.157045865904;9428.198603118812;9555.665551705795;9831.852522212173;9967.55146018431;680.2211467869262;680.669875110571;681.8568100698809;688.879446096931;716.9749058782918;4613.930791038137;4615.123126606001;4655.557722016403;4688.8124475021295;4700.741459219776;117477.41261293639;118108;120175;121014.39492802479;125033;104079.4796026015;105189.47405262924;106429;107283.46358268315;108055;65326;88011.55994220116;89644.55177724069;91086.08913910908;94418;8760.51817150063;9298.792676101404;9476.905230947603;9596.616135354509;9725.319227653996;44214;51547.22679159891;53569.732151340555;53905.191422127915;54047;48373.27440088331;66420.33579664142;70279;71190.28809711836;71361.6431917837;11877.940610297239;12270;12403.689907752378;12695.492180312684;13263.137896036727;14353.210573418562;14479.565613031626;14495.492657756928;14587.879721822857;14865.053978408723;13264.204147751167;13713.862861371657;13907.165570065828;14077.436902523785;14219.431222751387;12624.684382890135;12829.93585032069;13217.537386191438;13313.600591982256;13781.931090344484;12822;13057.738845223232;13159.210447373189;13439.395227214995;13568.86431135676;10157.492125393554;10524.842127367943;10843.67468975932;11125.944370278097;11621.535138594361;9884.209263259067;10683.358998460117;10694;10866.13070954306;10884.183686223407 11:35:35 INFO - PROCESS | 17699 | __end_tp_report 11:35:35 INFO - PROCESS | 17699 | __start_cc_report 11:35:35 INFO - PROCESS | 17699 | _x_x_mozilla_cycle_collect,353 11:35:35 INFO - PROCESS | 17699 | __end_cc_report 11:35:35 INFO - PROCESS | 17699 | __startTimestamp1467743735553__endTimestamp 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | ------- Summary: start ------- 11:35:35 INFO - PROCESS | 17699 | Number of tests: 6 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#0] dojo.html Cycles:165 Average:5336.65 Median:5518.64 stddev:600.89 (10.9%) stddev-sans-first:576.45 11:35:35 INFO - PROCESS | 17699 | Values: 3096.2 3140.1 3154.7 3158.0 3175.5 5280.2 5280.8 5291.0 5297.8 5302.3 5230.8 5240.6 5335.7 5337.9 5377.2 4810.5 4833.7 4855.9 4947.1 4961.7 4810.4 4902.5 4959.5 4990.9 5000.5 4802.3 4805.4 4842.4 4856.0 4864.8 4836.2 4857.6 4858.7 4935.6 4947.4 4871.9 4884.7 4887.8 4912.5 4931.7 5235.3 5244.1 5269.8 5305.7 5362.5 5645.1 5671.5 5683.3 5698.9 5700.0 5633.4 5757.6 5769.6 5778.7 5784.4 5408.5 5441.9 5443.5 5457.5 5473.2 5912.7 5929.1 5948.1 5948.9 5955.0 5463.0 5594.8 5719.5 5720.2 5725.2 5680.5 5726.6 5734.1 5738.7 5779.2 5589.6 5620.8 5689.7 5699.1 5725.1 5559.7 5589.2 5702.1 5739.1 5757.8 4382.7 4403.4 4411.5 4441.7 4444.8 3910.2 3943.6 3950.5 3957.6 3981.4 5393.5 5428.8 5449.3 5523.3 5587.3 5654.3 5659.7 5660.0 5684.4 5763.4 5461.4 5509.5 5513.2 5513.3 5534.0 4870.7 5003.1 5024.5 5041.9 5055.0 6053.9 6072.2 6077.1 6094.9 6096.8 5865.7 5876.9 5884.5 5888.9 5907.2 5764.3 5932.6 5945.6 5994.5 6038.0 5651.5 5657.0 5682.8 5695.4 5711.1 5685.8 5731.8 5771.8 5780.5 5795.3 5433.1 5449.3 5483.5 5506.0 5508.6 5506.1 5532.4 5545.9 5576.6 5588.1 5518.4 5518.6 5545.5 5551.6 5555.4 5492.5 5611.3 5670.5 5739.6 5755.0 5512.6 5554.4 5561.8 5567.2 5570.6 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#1] ext.html Cycles:180 Average:60616.95 Median:22279.20 stddev:128394.59 (576.3%) stddev-sans-first:128675.65 11:35:35 INFO - PROCESS | 17699 | Values: 584.4 595.1 630.4 642.8 663.5 38191.2 41933.4 41964.4 42141.8 42180.6 42536.4 42610.0 42613.0 42805.6 43093.0 8856.5 9017.0 9021.9 9026.5 9037.5 8797.8 8915.2 8963.4 8991.1 9014.6 8992.8 8993.5 9040.1 9062.9 9069.7 8868.2 8962.3 8962.5 8976.0 9007.1 8899.2 8947.0 8957.9 8976.6 8992.9 31740.0 40488.2 40720.2 40787.0 40859.6 3359.7 3532.8 3571.0 3844.5 4070.2 31535.4 31709.0 31804.4 31855.4 33297.5 4259.8 4298.0 4348.6 4372.1 4382.5 311454.0 312756.0 312859.0 312912.0 315294.0 32699.0 34448.8 36048.5 36084.8 36237.0 37403.0 37443.3 37444.4 37460.6 37491.6 14152.9 14203.3 14364.1 14370.0 14409.1 11074.6 11146.9 11148.1 11154.2 11157.6 8409.2 8431.2 8457.6 8521.1 8536.4 3247.8 3255.2 3257.1 3303.6 3308.7 1009.7 1077.3 1098.0 1102.9 1153.7 32142.8 32590.7 32732.5 32828.7 32988.5 1052.3 1080.4 1132.1 1148.2 1183.4 16751.7 17122.9 17166.5 17189.7 17389.5 594113.0 594272.0 594337.0 597668.0 599619.0 59285.0 59917.0 60162.0 60442.7 60554.7 1317.8 1319.1 1354.9 1359.6 1363.2 31001.7 31098.4 31261.4 31262.5 31668.4 52400.5 52872.7 53123.7 53137.0 53194.7 485478.0 490756.0 491155.0 491705.0 492100.0 26795.5 27010.0 27054.0 27112.3 27247.2 47730.3 47921.8 48490.3 48569.0 48719.3 40259.6 40453.0 41619.4 41705.0 42051.0 41910.6 42009.8 42254.8 42387.4 43511.6 36265.8 40448.6 41702.2 44851.8 45334.8 36736.6 36811.6 37442.4 38228.9 38285.6 28152.6 28985.1 29114.7 29145.1 29175.1 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#2] jquery.html Cycles:180 Average:29036.38 Median:2367.31 stddev:79745.75 (3368.6%) stddev-sans-first:79940.44 11:35:35 INFO - PROCESS | 17699 | Values: 383.9 384.7 387.9 390.8 407.8 18083.1 19230.7 19598.8 19613.8 20710.3 19089.1 19548.8 19657.2 19834.8 19865.7 5363.1 5568.3 5606.6 5672.8 5782.8 5645.4 5655.5 5666.9 5728.7 5742.4 5845.3 5996.5 6001.6 6006.6 6043.1 5339.0 5555.9 5573.2 6017.1 6032.4 5392.1 5463.9 5467.1 5499.6 5518.6 22990.5 23065.5 23932.3 24274.9 24480.5 2311.9 2357.6 2377.0 2578.8 2678.8 9870.8 10101.3 10186.4 10382.5 15063.0 1901.0 1951.8 1952.7 1981.3 2002.7 71635.6 81096.2 81114.2 81914.0 83053.0 10610.0 10919.0 11078.2 11178.0 11274.9 15134.6 15195.1 15259.8 15289.0 15377.0 7712.3 7787.3 8127.5 8306.8 8314.1 7736.7 7771.3 7777.3 7877.7 7887.6 4614.3 4631.7 4696.7 4709.0 4766.6 1983.9 1995.0 2004.5 2008.0 2049.3 1013.6 1021.4 1021.7 1025.7 1065.7 20132.2 20182.4 20298.4 20312.6 20337.4 946.8 950.8 959.0 997.1 1075.8 10592.4 11089.1 11142.6 11171.7 11183.2 475730.0 477544.0 478974.0 490207.0 493536.0 56842.1 86531.0 101346.5 101382.5 103057.0 1041.5 1043.7 1058.1 1086.3 1089.6 15810.9 17825.8 18091.7 18092.6 18290.3 44769.3 45071.5 45249.0 45469.5 46863.8 58129.0 59048.7 63054.4 63058.0 64112.4 7399.9 7956.1 8007.0 8115.7 8601.9 13788.4 13972.2 14106.0 14165.3 14259.6 12413.1 12447.4 12666.8 12707.4 12815.8 10620.3 11278.8 11359.5 11734.5 12055.5 12153.7 12194.3 12720.2 12964.9 13018.1 7977.6 8013.0 8020.3 8057.6 8058.0 8968.7 11027.6 11278.2 11381.5 11618.8 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#3] mootools.html Cycles:180 Average:5700.69 Median:4427.52 stddev:3271.33 (73.9%) stddev-sans-first:3264.80 11:35:35 INFO - PROCESS | 17699 | Values: 1434.9 1472.4 1581.7 1720.6 1753.7 7891.1 8285.3 8557.1 8931.0 8940.1 8272.9 8320.6 8331.4 8406.4 8407.2 2219.6 2249.4 2249.7 2251.0 2256.3 2194.8 2224.4 2283.2 2294.5 2302.7 2213.1 2237.2 2241.0 2242.2 2250.0 2175.7 2180.5 2193.2 2204.3 2207.0 2109.5 2111.4 2111.9 2117.8 2134.6 8380.2 8409.4 8474.7 8475.2 8516.9 4998.6 5122.9 5169.8 5172.9 5192.6 3144.3 3174.4 3230.0 3266.6 3271.9 1037.2 1045.8 1051.3 1054.6 1062.6 12083.8 12175.7 12188.6 12221.5 12228.4 4416.6 4438.4 4533.3 4556.0 4560.3 10371.1 10404.4 10419.4 10433.8 10498.2 5202.5 5221.1 5249.3 5249.5 5253.8 4462.0 4785.0 4809.2 4810.7 4812.4 3889.1 3890.2 3999.8 4016.0 4023.4 1202.0 1238.9 1246.9 1258.8 1270.5 934.0 953.1 963.8 965.8 970.9 5699.9 5741.6 5818.5 5917.9 5966.4 1003.7 1028.3 1054.8 1089.7 1093.2 3808.8 3946.1 3969.6 3971.8 3973.7 10520.5 10804.5 10830.1 10847.4 10847.7 10524.0 10624.3 10624.8 10641.4 10679.1 8168.3 8248.3 8256.1 8272.9 8285.3 5539.3 5552.1 5619.3 5629.4 5753.6 10081.1 10087.7 10102.9 10147.1 10153.9 10033.9 10072.9 10428.7 10430.6 10470.8 6894.7 7245.7 7345.3 7456.6 7472.4 8572.5 8583.4 8596.4 8624.7 8724.5 7552.0 7793.8 7810.7 7859.1 7901.9 7327.8 7366.4 7510.4 7536.6 7588.7 6732.8 6735.7 6810.3 6810.8 6869.9 4931.8 5044.8 5077.2 5160.5 5201.6 5083.8 5086.4 5101.7 5159.2 5171.5 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#4] prototype.html Cycles:180 Average:4901.51 Median:5548.69 stddev:1468.63 (26.5%) stddev-sans-first:1431.75 11:35:35 INFO - PROCESS | 17699 | Values: 310.2 311.4 317.5 334.4 339.4 5461.5 5524.8 5669.0 5688.5 5731.5 5547.9 5575.1 5585.6 5598.2 5632.4 4342.1 4401.5 4403.2 4423.6 4438.0 4118.2 4316.4 4335.9 4419.5 4429.4 4270.3 4271.9 4276.1 4321.5 4325.5 4300.3 4302.9 4317.0 4325.9 4336.8 3630.2 3763.3 3768.2 3791.6 3799.2 5416.9 5462.7 5477.8 5477.9 5549.4 4948.8 4964.5 4966.7 4972.8 4974.6 5605.6 5846.8 5914.7 5915.3 5941.9 4065.4 4076.8 4096.3 4102.8 4115.7 6020.9 6077.2 6083.9 6094.8 6146.8 4112.9 4210.3 4211.3 4236.5 4238.3 4255.3 4261.3 4275.9 4281.3 4293.9 4964.6 4966.7 4967.7 4982.6 4998.6 5754.7 5894.5 5896.0 5968.2 6008.8 1456.2 1473.8 1475.0 1476.7 1481.1 903.7 921.6 930.3 938.9 945.1 5018.3 5047.2 5050.4 5075.2 5086.4 5128.8 5181.8 5245.4 5307.7 5316.5 5006.5 5048.9 5056.5 5307.7 5833.7 3198.5 3206.4 3222.7 3227.3 3246.4 6162.3 6282.3 6301.1 6310.9 6319.0 6130.8 6194.5 6198.4 6214.8 6219.8 6311.5 6346.6 6361.1 6364.6 6378.6 5868.9 6053.6 6070.3 6086.5 6137.3 6004.5 6024.6 6053.4 6079.9 6083.5 6007.8 6193.6 6259.3 6315.7 6335.5 4212.3 4244.8 4263.9 4284.0 4295.1 6107.2 6132.4 6152.7 6163.1 6176.7 5751.2 5857.9 5881.5 5893.8 5911.6 5841.1 5949.9 5956.8 5962.4 5971.2 5809.4 5871.9 5875.8 5897.9 5910.4 5599.5 5886.8 5911.9 5915.1 5920.7 5729.7 5765.0 5835.8 5845.2 5849.4 11:35:35 INFO - PROCESS | 17699 | 11:35:35 INFO - PROCESS | 17699 | [#5] yui.html Cycles:180 Average:20978.08 Median:4614.53 stddev:30878.25 (669.2%) stddev-sans-first:30927.56 11:35:35 INFO - PROCESS | 17699 | Values: 761.7 777.5 785.3 804.6 854.4 14692.9 15259.8 15365.9 15384.0 15524.1 13643.2 13746.5 13812.9 13822.7 13844.2 632.4 753.3 772.3 773.7 774.8 767.9 769.5 775.9 776.3 777.5 833.5 834.8 835.7 837.1 841.1 812.8 815.5 821.1 822.9 828.4 602.9 604.0 605.3 606.7 608.7 14099.8 14108.9 14126.1 14146.8 14177.9 14255.4 14769.7 14931.3 15090.2 15164.5 11210.2 11265.5 11476.9 11572.0 13397.5 3911.6 3987.7 4001.7 4031.9 4036.6 79407.0 80720.6 81028.2 81943.6 82211.0 11851.9 11916.3 12014.3 12141.5 12168.5 23417.3 23428.0 23450.2 23460.0 23624.0 8168.9 8264.0 8297.2 8372.3 8579.6 4756.8 4840.7 4909.1 4931.5 5006.2 3443.8 3460.9 3517.1 3534.6 3540.9 593.4 597.2 621.3 626.5 627.3 519.7 594.9 693.3 727.2 779.1 9366.2 9428.2 9555.7 9831.9 9967.6 680.2 680.7 681.9 688.9 717.0 4613.9 4615.1 4655.6 4688.8 4700.7 117477.4 118108.0 120175.0 121014.4 125033.0 104079.5 105189.5 106429.0 107283.5 108055.0 65326.0 88011.6 89644.6 91086.1 94418.0 8760.5 9298.8 9476.9 9596.6 9725.3 44214.0 51547.2 53569.7 53905.2 54047.0 48373.3 66420.3 70279.0 71190.3 71361.6 11877.9 12270.0 12403.7 12695.5 13263.1 14353.2 14479.6 14495.5 14587.9 14865.1 13264.2 13713.9 13907.2 14077.4 14219.4 12624.7 12829.9 13217.5 13313.6 13781.9 12822.0 13057.7 13159.2 13439.4 13568.9 10157.5 10524.8 10843.7 11125.9 11621.5 9884.2 10683.4 10694.0 10866.1 10884.2 11:35:35 INFO - PROCESS | 17699 | -------- Summary: end -------- 11:35:35 INFO - PROCESS | 17699 | 11:35:36 INFO - TEST-INFO | 17699: exit 0 11:35:36 INFO - TEST-OK | dromaeo_css | took 1110305ms 11:35:36 INFO - TEST-START | kraken 11:35:36 INFO - operating with platform_type : linux_ 11:35:36 INFO - Initialising browser for kraken test... 11:35:36 INFO - TEST-INFO | started process 17948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY50sP/profile http://localhost:53500/getInfo.html) 11:35:40 INFO - PROCESS | 17948 | __metrics Screen width/height:1600/1200 11:35:40 INFO - PROCESS | 17948 | colorDepth:24 11:35:40 INFO - PROCESS | 17948 | Browser inner width/height: 1024/697 11:35:40 INFO - PROCESS | 17948 | __metrics 11:35:41 ERROR - PROCESS | 17948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:35:42 INFO - TEST-INFO | 17948: exit 0 11:35:42 INFO - Browser initialized. 11:35:42 INFO - Running cycle 1/1 for kraken test... 11:35:42 INFO - TEST-INFO | started process 18067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY50sP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:53 INFO - PROCESS | 18067 | RSS: Main: 168550400 11:35:53 INFO - PROCESS | 18067 | 11:35:56 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53500/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:57 INFO - PROCESS | 18067 | RSS: Main: 174419968 11:35:57 INFO - PROCESS | 18067 | 11:35:59 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53500/tests/kraken/driver.html?testName=audio-dft) 11:36:00 INFO - PROCESS | 18067 | RSS: Main: 173678592 11:36:00 INFO - PROCESS | 18067 | 11:36:03 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53500/tests/kraken/driver.html?testName=audio-fft) 11:36:04 INFO - PROCESS | 18067 | RSS: Main: 168456192 11:36:04 INFO - PROCESS | 18067 | 11:36:06 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53500/tests/kraken/driver.html?testName=audio-oscillator) 11:36:06 INFO - PROCESS | 18067 | RSS: Main: 168972288 11:36:06 INFO - PROCESS | 18067 | 11:36:08 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:09 INFO - PROCESS | 18067 | RSS: Main: 169627648 11:36:09 INFO - PROCESS | 18067 | 11:36:12 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53500/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:13 INFO - PROCESS | 18067 | RSS: Main: 169295872 11:36:13 INFO - PROCESS | 18067 | 11:36:16 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53500/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:17 INFO - PROCESS | 18067 | RSS: Main: 167309312 11:36:17 INFO - PROCESS | 18067 | 11:36:20 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53500/tests/kraken/driver.html?testName=json-parse-financial) 11:36:20 INFO - PROCESS | 18067 | RSS: Main: 168779776 11:36:20 INFO - PROCESS | 18067 | 11:36:22 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:23 INFO - PROCESS | 18067 | RSS: Main: 169259008 11:36:23 INFO - PROCESS | 18067 | 11:36:24 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:25 INFO - PROCESS | 18067 | RSS: Main: 169361408 11:36:25 INFO - PROCESS | 18067 | 11:36:27 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:28 INFO - PROCESS | 18067 | RSS: Main: 169902080 11:36:28 INFO - PROCESS | 18067 | 11:36:30 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:31 INFO - PROCESS | 18067 | RSS: Main: 169627648 11:36:31 INFO - PROCESS | 18067 | 11:36:34 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:34 INFO - PROCESS | 18067 | RSS: Main: 169623552 11:36:34 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | Cycle 1(1): loaded http://localhost:53500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53500/tests/kraken/driver.html?testName=ai-astar) 11:36:36 INFO - PROCESS | 18067 | RSS: Main: 170627072 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | __start_tp_report 11:36:36 INFO - PROCESS | 18067 | _x_x_mozilla_page_load 11:36:36 INFO - PROCESS | 18067 | _x_x_mozilla_page_load_details 11:36:36 INFO - PROCESS | 18067 | |i|pagename|runs| 11:36:36 INFO - PROCESS | 18067 | |0;ai-astar;102;111;106;110;111;111;112;111;115;112 11:36:36 INFO - PROCESS | 18067 | |1;audio-beat-detection;145;119;145;166;123;154;150;120;174;119 11:36:36 INFO - PROCESS | 18067 | |2;audio-dft;166;164;163;163;162;166;169;167;166;161 11:36:36 INFO - PROCESS | 18067 | |3;audio-fft;76;76;75;157;76;76;76;78;165;77 11:36:36 INFO - PROCESS | 18067 | |4;audio-oscillator;84;84;149;86;85;88;140;83;85;135 11:36:36 INFO - PROCESS | 18067 | |5;imaging-gaussian-blur;118;118;119;118;118;118;118;118;118;118 11:36:36 INFO - PROCESS | 18067 | |6;imaging-darkroom;150;148;150;148;150;147;148;148;148;147 11:36:36 INFO - PROCESS | 18067 | |7;imaging-desaturate;96;98;96;95;97;96;96;99;96;96 11:36:36 INFO - PROCESS | 18067 | |8;json-parse-financial;55;55;54;59;54;54;55;57;55;58 11:36:36 INFO - PROCESS | 18067 | |9;json-stringify-tinderbox;61;62;62;62;62;62;63;62;64;63 11:36:36 INFO - PROCESS | 18067 | |10;stanford-crypto-aes;77;76;77;76;76;75;77;79;81;75 11:36:36 INFO - PROCESS | 18067 | |11;stanford-crypto-ccm;124;120;126;129;121;121;137;129;164;124 11:36:36 INFO - PROCESS | 18067 | |12;stanford-crypto-pbkdf2;162;156;155;152;158;155;156;159;160;158 11:36:36 INFO - PROCESS | 18067 | |13;stanford-crypto-sha256-iterative;67;64;64;63;67;63;63;64;67;65 11:36:36 INFO - PROCESS | 18067 | __end_tp_report 11:36:36 INFO - PROCESS | 18067 | __start_cc_report 11:36:36 INFO - PROCESS | 18067 | _x_x_mozilla_cycle_collect,942 11:36:36 INFO - PROCESS | 18067 | __end_cc_report 11:36:36 INFO - PROCESS | 18067 | __startTimestamp1467743796712__endTimestamp 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | ------- Summary: start ------- 11:36:36 INFO - PROCESS | 18067 | Number of tests: 14 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.60 (3.2%) stddev-sans-first:2.35 11:36:36 INFO - PROCESS | 18067 | Values: 102.0 111.0 106.0 110.0 111.0 111.0 112.0 111.0 115.0 112.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:20.35 (13.8%) stddev-sans-first:21.54 11:36:36 INFO - PROCESS | 18067 | Values: 145.0 119.0 145.0 166.0 123.0 154.0 150.0 120.0 174.0 119.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#2] audio-dft Cycles:10 Average:164.70 Median:166.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 11:36:36 INFO - PROCESS | 18067 | Values: 166.0 164.0 163.0 163.0 162.0 166.0 169.0 167.0 166.0 161.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:35.79 (47.1%) stddev-sans-first:37.42 11:36:36 INFO - PROCESS | 18067 | Values: 76.0 76.0 75.0 157.0 76.0 76.0 76.0 78.0 165.0 77.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:84.50 stddev:27.45 (32.5%) stddev-sans-first:28.34 11:36:36 INFO - PROCESS | 18067 | Values: 84.0 84.0 149.0 86.0 85.0 88.0 140.0 83.0 85.0 135.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:36:36 INFO - PROCESS | 18067 | Values: 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.17 (0.8%) stddev-sans-first:1.09 11:36:36 INFO - PROCESS | 18067 | Values: 150.0 148.0 150.0 148.0 150.0 147.0 148.0 148.0 148.0 147.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.18 (1.2%) stddev-sans-first:1.24 11:36:36 INFO - PROCESS | 18067 | Values: 96.0 98.0 96.0 95.0 97.0 96.0 96.0 99.0 96.0 96.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:1.78 (3.2%) stddev-sans-first:1.87 11:36:36 INFO - PROCESS | 18067 | Values: 55.0 55.0 54.0 59.0 54.0 54.0 55.0 57.0 55.0 58.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 11:36:36 INFO - PROCESS | 18067 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 64.0 63.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:1.85 (2.4%) stddev-sans-first:1.96 11:36:36 INFO - PROCESS | 18067 | Values: 77.0 76.0 77.0 76.0 76.0 75.0 77.0 79.0 81.0 75.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.50 stddev:13.14 (10.3%) stddev-sans-first:13.79 11:36:36 INFO - PROCESS | 18067 | Values: 124.0 120.0 126.0 129.0 121.0 121.0 137.0 129.0 164.0 124.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:158.00 stddev:2.88 (1.8%) stddev-sans-first:2.46 11:36:36 INFO - PROCESS | 18067 | Values: 162.0 156.0 155.0 152.0 158.0 155.0 156.0 159.0 160.0 158.0 11:36:36 INFO - PROCESS | 18067 | 11:36:36 INFO - PROCESS | 18067 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.70 (2.6%) stddev-sans-first:1.59 11:36:36 INFO - PROCESS | 18067 | Values: 67.0 64.0 64.0 63.0 67.0 63.0 63.0 64.0 67.0 65.0 11:36:36 INFO - PROCESS | 18067 | -------- Summary: end -------- 11:36:36 INFO - PROCESS | 18067 | 11:36:37 INFO - TEST-INFO | 18067: exit 0 11:36:37 INFO - TEST-OK | kraken | took 61426ms 11:36:37 INFO - SUITE-END | took 1171s 11:36:37 INFO - Completed test suite (00:19:31) 11:36:37 INFO - javascript benchmark 11:36:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7200.030473710015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.1949893027813, 3140.057982605218, 3154.6687597802215, 3158.0, 3175.4601717707988, 5280.1551751719735, 5280.841574752754, 5291.0, 5297.841064768054, 5302.3106996090555, 5230.764615592298, 5240.554552863011, 5335.733213339327, 5337.893242135155, 5377.220303056055, 4810.518948105197, 4833.7099774013495, 4855.927161092586, 4947.084789313971, 4961.727105009223, 4810.446798618169, 4902.485239049902, 4959.479254678261, 4990.87522811929, 5000.549950504454, 4802.32767412559, 4805.447373552051, 4842.394700662399, 4855.951440485585, 4864.756762161877, 4836.177849765549, 4857.587105096071, 4858.732769697665, 4935.629827762897, 4947.431045429786, 4871.902561948741, 4884.7069175849565, 4887.755612219375, 4912.508749125094, 4931.7040977541465, 5235.267062611238, 5244.082285600005, 5269.762860671279, 5305.708186049805, 5362.544183744387, 5645.125005624135, 5671.461211184972, 5683.2895888014, 5698.914516282218, 5699.971500142514, 5633.40849210831, 5757.568182386338, 5769.624974376652, 5778.653280803165, 5784.421557844224, 5408.486193811582, 5441.918371224435, 5443.537299329561, 5457.454254574551, 5473.17902314648, 5912.73392697321, 5929.080992446177, 5948.078047902582, 5948.910766338508, 5954.970225148933, 5462.9726851365485, 5594.832155035356, 5719.5138413235345, 5720.170575266563, 5725.227094342294, 5680.5455563554815, 5726.599138060295, 5734.111212761945, 5738.741756620962, 5779.190913272145, 5589.552835773128, 5620.803271885465, 5689.743961521742, 5699.088145896637, 5725.141228815628, 5559.694216818114, 5589.217509548666, 5702.144678298288, 5739.053056245756, 5757.827265182052, 4382.737035777864, 4403.405540252089, 4411.470623525198, 4441.711288766284, 4444.777761111996, 3910.159315747071, 3943.6253555912144, 3950.48643676326, 3957.56466788653, 3981.3629819229363, 5393.514583687487, 5428.83713488596, 5449.291592093082, 5523.3295059722095, 5587.273654424899, 5654.293213348332, 5659.745311460994, 5659.952908711902, 5684.403137670568, 5763.366029736726, 5461.371942226615, 5509.5041446270025, 5513.173024046425, 5513.3108361454815, 5533.972330138324, 4870.683405578626, 5003.074431230234, 5024.547790698782, 5041.949580504222, 5055.039542486916, 6053.878922421527, 6072.180255665517, 6077.1491991121275, 6094.939050609526, 6096.847578810476, 5865.706714664249, 5876.882462350814, 5884.47039766423, 5888.882222355443, 5907.232059832194, 5764.279465066867, 5932.584719069624, 5945.554083443845, 5994.490468310242, 6037.969810151097, 5651.491365777099, 5656.9717151415625, 5682.801101961411, 5695.373508914099, 5711.114777209539, 5685.800996965252, 5731.770729170787, 5771.797987070432, 5780.537556995514, 5795.275590551181, 5433.130699088127, 5449.3460784706085, 5483.479069488392, 5506.008918394567, 5508.586855985737, 5506.091494903296, 5532.446755324436, 5545.916811247916, 5576.637518561281, 5588.133839254922, 5518.392976772471, 5518.641288316247, 5545.5009049184155, 5551.639143455663, 5555.444455554574, 5492.47821456961, 5611.298587676541, 5670.489655930986, 5739.598228123991, 5755.021646320052, 5512.641678290898, 5554.389017208185, 5561.805336813192, 5567.24842146305, 5570.5543556516195], "value": 5296.753585133119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4272612839417, 595.1192235491474, 630.4074170279938, 642.8296501427122, 663.5222639699415, 38191.23617527648, 41933.370999435036, 41964.37053444193, 42141.78929105358, 42180.57819421805, 42536.361954570704, 42610.0, 42613.0, 42805.57194428055, 43093.0, 8856.512891790964, 9016.954915225415, 9021.864672029891, 9026.548672566378, 9037.457752534869, 8797.7800554986, 8915.153060459279, 8963.41737787045, 8991.14584114508, 9014.639414423415, 8992.77518062047, 8993.505357205351, 9040.095990400972, 9062.909370906305, 9069.682561110363, 8868.246199073086, 8962.283017358595, 8962.507062111581, 8976.0, 9007.099290071006, 8899.243564297043, 8947.0, 8957.865632015524, 8976.640934362618, 8992.910070899272, 31740.0, 40488.190236195114, 40720.185596288204, 40787.0, 40859.59140408588, 3359.6808303211155, 3532.8410221540094, 3570.9821450892578, 3844.5002149720635, 4070.206309769596, 31535.369292614017, 31709.0, 31804.363912721616, 31855.362892742247, 33297.50053749196, 4259.8083086261195, 4297.957020429787, 4348.565143485658, 4372.081862808814, 4382.452193475816, 311454.0, 312756.0, 312859.0, 312912.0, 315294.0, 32699.0, 34448.82775586156, 36048.45927311092, 36084.819575902475, 36237.0, 37403.0, 37443.251134977145, 37444.43833342502, 37460.62539374626, 37491.62508374936, 14152.858471415155, 14203.289835508183, 14364.138151710931, 14370.0, 14409.06341087826, 11074.612388566362, 11146.888531114748, 11148.108151348035, 11154.163437742201, 11157.609483668195, 8409.20112589303, 8431.15688431152, 8457.619407126695, 8521.062683104854, 8536.359773017048, 3247.8376081195847, 3255.235019770352, 3257.1042963185314, 3303.6035675719068, 3308.693066238822, 1009.7374682582581, 1077.3105212663902, 1097.9945100274447, 1102.895224953628, 1153.7461758413135, 32142.83928580342, 32590.7002040785, 32732.509012364833, 32828.67171328256, 32988.50517242243, 1052.2791887557048, 1080.3895798873612, 1132.101819342486, 1148.1675785055768, 1183.4319526627266, 16751.748723769153, 17122.914385427994, 17166.485005449857, 17189.7421538677, 17389.478315650296, 594113.0, 594272.0, 594337.0, 597668.0, 599619.0, 59285.0, 59917.0, 60162.0, 60442.697786510784, 60554.697226513585, 1317.8155058291848, 1319.0964189530202, 1354.9458021679022, 1359.64649191211, 1363.2297751770416, 31001.68998309988, 31098.378032439676, 31261.393358167985, 31262.53106203363, 31668.36663266768, 52400.47599523956, 52872.73563632157, 53123.73438132785, 53137.0, 53194.73402632962, 485478.0, 490756.0, 491155.0, 491705.0, 492100.0, 26795.464090718466, 27010.0, 27054.0, 27112.32219194536, 27247.182584522496, 47730.28404573865, 47921.76039119782, 48490.27264590964, 48569.0, 48719.26921096257, 40259.59740402558, 40453.0, 41619.375709363776, 41705.0, 42051.0, 41910.580894190665, 42009.78995105005, 42254.78872605618, 42387.364189536565, 43511.56488435202, 36265.81867090753, 40448.59551404566, 41702.1659566813, 44851.775741121084, 45334.77332613316, 36736.63263367332, 36811.63188368082, 37442.43836342402, 38228.85313440601, 38285.6171438282, 28152.577711334758, 28985.130446086652, 29114.70885291205, 29145.125646229797, 29175.103618264744], "value": 18721.105668876095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9105691450011, 384.749912556838, 387.93986932025535, 390.79287977371996, 407.8022159252762, 18083.095845207736, 19230.71153932692, 19598.804011959877, 19613.803861961376, 20710.27514037009, 19089.14098865551, 19548.804511954877, 19657.21371145156, 19834.801651983475, 19865.702014469796, 5363.061464243761, 5568.303962004749, 5606.55147588193, 5672.829815105553, 5782.797602083928, 5645.435456454363, 5655.5475561954945, 5666.858328541799, 5728.742206600692, 5742.39704830993, 5845.327787304451, 5996.520278377741, 6001.639901605896, 6006.609570377911, 6043.063325184604, 5339.0, 5555.944440555623, 5573.164025396223, 6017.067354560028, 6032.426919442646, 5392.083345831218, 5463.890722185573, 5467.097928841737, 5499.587530935156, 5518.558515318765, 22990.540189196123, 23065.53868922629, 23932.28203153908, 24274.878625606758, 24480.510389792104, 2311.90752369905, 2357.634566642173, 2376.989779343772, 2578.8323758955607, 2678.7723043541323, 9870.802583948353, 10101.292909496338, 10186.388816671024, 10382.53278602457, 15063.0, 1900.980990190108, 1951.8145776151243, 1952.746515614516, 1981.2570286142698, 2002.699595060738, 71635.64182179108, 81096.18903810946, 81114.18885811126, 81914.0, 83053.0, 10610.0, 10919.0, 11078.224524283383, 11178.0498657615, 11274.943625281821, 15134.621634459007, 15195.088294702353, 15259.847401526065, 15289.0, 15377.0, 7712.344450721752, 7787.2602102801275, 8127.471714338667, 8306.8338633227, 8314.127016663164, 7736.6518506667335, 7771.261730135628, 7777.261160189886, 7877.684892604231, 7887.566183859943, 4614.284785858197, 4631.698939568917, 4696.671233013656, 4708.976455117771, 4766.571008609172, 1983.9008049597462, 1994.982558894974, 2004.4988752811796, 2007.9899600502197, 2049.25202301159, 1013.6097602422973, 1021.4075836015094, 1021.6858814784518, 1025.687165414541, 1065.7069305940772, 20132.19471221135, 20182.39452816418, 20298.391048268575, 20312.593748124953, 20337.389878303675, 946.8390373636498, 950.7860731335533, 958.9760255993516, 997.0527998401548, 1075.833245846895, 10592.364458132537, 11089.05743011837, 11142.554297828157, 11171.66485005451, 11183.217174797686, 475730.0, 477544.0, 478974.0, 490207.0, 493536.0, 56842.14736778952, 86531.0, 101346.4932675332, 101382.4930875341, 103057.0, 1041.510490069666, 1043.6921108273077, 1058.0688993685508, 1086.3373342261214, 1089.596849165798, 15810.920945395199, 17825.821741782416, 18091.728624070387, 18092.638147237245, 18290.26838926428, 44769.32846007247, 45071.549284506735, 45249.0, 45469.54530454653, 46863.765681171375, 58129.0, 59048.70475647594, 63054.36945630485, 63058.0, 64112.3588764125, 7399.889001665087, 7956.085050219067, 8006.959965200137, 8115.675372985251, 8601.913980860112, 13788.379522921694, 13972.161670299814, 14106.0, 14165.291735413395, 14259.64350891236, 12413.131080824256, 12447.439865205906, 12666.809997850223, 12707.36463176856, 12815.807762883378, 10620.309679870783, 11278.774424511628, 11359.54561817518, 11734.471948762497, 12055.457504412498, 12153.696157595778, 12194.329311887932, 12720.236785792882, 12964.935175324063, 13018.088733788543, 7977.641006154621, 8013.038435387558, 8020.278174964281, 8057.556834374166, 8058.0, 8968.68609598687, 11027.558897644005, 11278.154138439486, 11381.54473821038, 11618.767624647291], "value": 9330.409799070809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.8995570310078, 1472.4404726204043, 1581.6520365519582, 1720.638665880165, 1753.6580366828466, 7891.131975482693, 8285.254327110559, 8557.10150434204, 8930.955345223265, 8940.105989401065, 8272.875906861402, 8320.625571849267, 8331.375146863978, 8406.369522285822, 8407.201315874998, 2219.5893759654437, 2249.3701763506247, 2249.741279752833, 2250.9887450562724, 2256.3005468304796, 2194.8353873459473, 2224.3549370682563, 2283.212291759349, 2294.4608017115966, 2302.6776251324827, 2213.070510385634, 2237.2281562860867, 2241.0363543676212, 2242.1703969531295, 2250.032486031006, 2175.7171567696255, 2180.509385388291, 2193.21044424008, 2204.335726526478, 2207.0399376271293, 2109.5359021015506, 2111.419359676086, 2111.9472013199793, 2117.76704562498, 2134.5624147049816, 8380.24577788002, 8409.411341206118, 8474.703385381483, 8475.194856488624, 8516.914830851736, 4998.550130488237, 5122.897542049138, 5169.767360468751, 5172.870678233036, 5192.636515443921, 3144.261098641817, 3174.3968645957193, 3229.951550726741, 3266.6080070391467, 3271.8527666255077, 1037.1702637889734, 1045.7751583409604, 1051.2693677893867, 1054.6203366788027, 1062.6440142552253, 12083.758324833454, 12175.695607609792, 12188.634340969786, 12221.511139554406, 12228.449719762632, 4416.6245869101485, 4438.423005009328, 4533.297338912474, 4556.0, 4560.315952607069, 10371.066604005675, 10404.427756473315, 10419.374837509773, 10433.843492347622, 10498.160147188206, 5202.479752024843, 5221.086309895753, 5249.343832020997, 5249.501297376743, 5253.763580638804, 4461.955380446154, 4784.971231185312, 4809.182438985381, 4810.735409552438, 4812.35033270504, 3889.1055057336407, 3890.2414029264587, 3999.8400063997115, 4016.0, 4023.3562629979065, 1201.987980120205, 1238.9008879289636, 1246.8566114896903, 1258.779713550125, 1270.5235536673747, 933.9959543490775, 953.1278879825021, 963.802420503795, 965.7875267441152, 970.8834939807127, 5699.857503562444, 5741.598088133791, 5818.5345172386105, 5917.881642367214, 5966.403359663999, 1003.7139415266614, 1028.3315844701003, 1054.8101341758556, 1089.6513115802868, 1093.2347356850237, 3808.7524310919703, 3946.1121247719034, 3969.622885825842, 3971.801409929492, 3973.7417067890497, 10520.473976301155, 10804.459777011118, 10830.079443247412, 10847.403392813314, 10847.67456976292, 10524.0, 10624.309419887682, 10624.840627390595, 10641.361518308771, 10679.145668346513, 8168.305694016075, 8248.257656810796, 8256.091829898827, 8272.875906861402, 8285.25432711059, 5539.307586551681, 5552.111662134039, 5619.325680918316, 5629.352624448077, 5753.626014309057, 10081.092701656886, 10087.69736907894, 10102.949485252526, 10147.137493312855, 10153.898461015295, 10033.949830250802, 10072.899271007196, 10428.739281518023, 10430.634927777492, 10470.842937355794, 6894.655267236719, 7245.710171593078, 7345.338919497271, 7456.589887556236, 7472.439567032386, 8572.485650860968, 8583.442076265022, 8596.398252122292, 8624.655013799378, 8724.520151391735, 7551.962240188764, 7793.791962245861, 7810.726624568113, 7859.09620393662, 7901.920980790119, 7327.816804579928, 7366.447516436396, 7510.39916806665, 7536.585487798224, 7588.734394296173, 6732.764353247613, 6735.73057077731, 6810.28492008332, 6810.761623343159, 6869.931300687129, 4931.753412329297, 5044.848654540369, 5077.162268225701, 5160.458151894147, 5201.6098792591465, 5083.771230294572, 5086.440491546001, 5101.7194054327365, 5159.2003239497935, 5171.482851714798], "value": 4554.059623131075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.23991221507305, 311.44407233088936, 317.5411530338662, 334.3847320929489, 339.4433129667344, 5461.481159289871, 5524.812165384442, 5669.0, 5688.544916406683, 5731.51282141018, 5547.944520554794, 5575.135853942646, 5585.575678202063, 5598.188262701916, 5632.38043815181, 4342.1315736852675, 4401.537838526957, 4403.229434848905, 4423.628675110726, 4438.0014496738295, 4118.19695159444, 4316.352547117942, 4335.891602709942, 4419.469663640368, 4429.424174857264, 4270.29188324671, 4271.850485233017, 4276.080642661827, 4321.503027151871, 4325.4593175853015, 4300.311950087987, 4302.935455968163, 4316.9855084055225, 4325.891852703676, 4336.84821031264, 3630.2195028068827, 3763.310445884469, 3768.171002379472, 3791.5829258781514, 3799.183175617228, 5416.864578385533, 5462.726863656841, 5477.780888764484, 5477.917831232535, 5549.445055494459, 4948.826791062295, 4964.528369804862, 4966.652334336598, 4972.8259510917305, 4974.552290293891, 5605.635633683797, 5846.795362162304, 5914.733836977346, 5915.260592425947, 5941.851453713649, 4065.3698676705158, 4076.8369265229353, 4096.32410652242, 4102.794860256975, 4115.73247738899, 6020.939790602081, 6077.24034495688, 6083.9087413688385, 6094.8171554853425, 6146.7541298348015, 4112.897177570585, 4210.305299625527, 4211.305134652809, 4236.533981262059, 4238.3006803877015, 4255.276602977501, 4261.31818908973, 4275.914481710349, 4281.250781113293, 4293.935590966138, 4964.578010869117, 4966.726830024383, 4967.7019378837385, 4982.576480999083, 4998.550130488274, 5754.683492407958, 5894.498967587803, 5895.997680394344, 5968.1942937703725, 6008.849778755566, 1456.1772598481823, 1473.7789331600345, 1474.9822622390516, 1476.6825132596543, 1481.148339704674, 903.7288813355967, 921.6497730862229, 930.2743859789375, 938.887333519982, 945.0879900895669, 5018.290123333359, 5047.217681259411, 5050.393952725696, 5075.213341932006, 5086.389633243961, 5128.8461346159675, 5181.813184891264, 5245.370555533361, 5307.681539107666, 5316.548093412103, 5006.549410552995, 5048.899022019539, 5056.544910958031, 5307.681539107666, 5833.67914764692, 3198.504231844068, 3206.374756922378, 3222.7421806255443, 3227.322262324938, 3246.3507298540385, 6162.26052873658, 6282.32483996867, 6301.149344838388, 6310.864044471948, 6319.0, 6130.816075517741, 6194.535409844189, 6198.411150940653, 6214.8135555933395, 6219.813405597839, 6311.526635502264, 6346.556575718381, 6361.077643741632, 6364.64994425311, 6378.585391949601, 5868.911966320594, 6053.576249662481, 6070.271567411939, 6086.482648974887, 6137.294211165773, 6004.5496587755215, 6024.638521688713, 6053.3946605339115, 6079.908801368071, 6083.513318934386, 6007.7596896125415, 6193.628382297076, 6259.280182779039, 6315.684215789101, 6335.461485773761, 4212.283911734951, 4244.808983595807, 4263.850765223202, 4284.0, 4295.119500502452, 6107.236595425572, 6132.356102609162, 6152.692365381802, 6163.106349579376, 6176.66028368444, 5751.217122691979, 5857.9121313179485, 5881.529477641864, 5893.793717219876, 5911.55663325261, 5841.065429531254, 5949.851253718692, 5956.791512297049, 5962.403759624176, 5971.208637408847, 5809.448102430262, 5871.94128058714, 5875.794347197828, 5897.882042359214, 5910.408959104056, 5599.536204070196, 5886.764529418775, 5911.930824211491, 5915.142304365929, 5920.654830021024, 5729.684867332337, 5765.0, 5835.766569337179, 5845.18167456548, 5849.415058494286], "value": 4422.079622866326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.6572542355938, 777.5023984649825, 785.328544094799, 804.645955779457, 854.367767851789, 14692.926535367322, 15259.847401525982, 15365.923170384132, 15384.0, 15524.146171960552, 13643.18140911546, 13746.450141994308, 13812.93093534531, 13822.723545529108, 13844.169349839016, 632.4181752787435, 753.2730914667345, 772.3126417488439, 773.6866569039548, 774.7946794099568, 767.8579462799372, 769.4882902869585, 775.9418043646721, 776.3401109057313, 777.5334799120511, 833.5457175839152, 834.8413801377719, 835.7242110103651, 837.0666706622103, 841.1336323586685, 812.7764864662206, 815.5432957543765, 821.1049955548422, 822.9135940726227, 828.4490813608973, 602.9336772954971, 603.9607425517328, 605.3039005144076, 606.7087797857009, 608.6530677513819, 14099.78850317246, 14108.92945535276, 14126.081804682663, 14146.787798183035, 14177.85822141786, 14255.358508867126, 14769.70460590793, 14931.25343732809, 15090.17004064776, 15164.545063648107, 11210.215284930058, 11265.49305281256, 11476.885231147666, 11572.016378607828, 13397.464101435931, 3911.550171730259, 3987.7009224308295, 4001.6598589119667, 4031.858884939013, 4036.5963403659694, 79407.0, 80720.59639701822, 81028.18971810266, 81943.59028204822, 82211.0, 11851.940322275685, 11916.344601046852, 12014.33921134346, 12141.514339426323, 12168.452419641137, 23417.297481075595, 23428.0, 23450.179243726387, 23460.0, 23624.0, 8168.9183108169345, 8264.0, 8297.170282971654, 8372.33021358302, 8579.571021448903, 4756.8097276108565, 4840.685355451885, 4909.116359055404, 4931.50684931504, 5006.1739812930455, 3443.8450269737923, 3460.8788692395647, 3517.120719820045, 3534.5581802274714, 3540.91147721309, 593.442164365495, 597.1848426897341, 621.3041393639153, 626.5175814622716, 627.3193584960369, 519.6752029981262, 594.9196858424144, 693.3101563943908, 727.2037119354299, 779.0845756236399, 9366.157045865904, 9428.198603118812, 9555.665551705795, 9831.852522212173, 9967.55146018431, 680.2211467869262, 680.669875110571, 681.8568100698809, 688.879446096931, 716.9749058782918, 4613.930791038137, 4615.123126606001, 4655.557722016403, 4688.8124475021295, 4700.741459219776, 117477.41261293639, 118108.0, 120175.0, 121014.39492802479, 125033.0, 104079.4796026015, 105189.47405262924, 106429.0, 107283.46358268315, 108055.0, 65326.0, 88011.55994220116, 89644.55177724069, 91086.08913910908, 94418.0, 8760.51817150063, 9298.792676101404, 9476.905230947603, 9596.616135354509, 9725.319227653996, 44214.0, 51547.22679159891, 53569.732151340555, 53905.191422127915, 54047.0, 48373.27440088331, 66420.33579664142, 70279.0, 71190.28809711836, 71361.6431917837, 11877.940610297239, 12270.0, 12403.689907752378, 12695.492180312684, 13263.137896036727, 14353.210573418562, 14479.565613031626, 14495.492657756928, 14587.879721822857, 14865.053978408723, 13264.204147751167, 13713.862861371657, 13907.165570065828, 14077.436902523785, 14219.431222751387, 12624.684382890135, 12829.93585032069, 13217.537386191438, 13313.600591982256, 13781.931090344484, 12822.0, 13057.738845223232, 13159.210447373189, 13439.395227214995, 13568.86431135676, 10157.492125393554, 10524.842127367943, 10843.67468975932, 11125.944370278097, 11621.535138594361, 9884.209263259067, 10683.358998460117, 10694.0, 10866.13070954306, 10884.183686223407], "value": 7476.48173330572, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 110.0, 111.0, 111.0, 112.0, 111.0, 115.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 145.0, 166.0, 123.0, 154.0, 150.0, 120.0, 174.0, 119.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 163.0, 162.0, 166.0, 169.0, 167.0, 166.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 157.0, 76.0, 76.0, 76.0, 78.0, 165.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 149.0, 86.0, 85.0, 88.0, 140.0, 83.0, 85.0, 135.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 150.0, 148.0, 150.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 97.0, 96.0, 96.0, 99.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 59.0, 54.0, 54.0, 55.0, 57.0, 55.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 64.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 76.0, 75.0, 77.0, 79.0, 81.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 126.0, 129.0, 121.0, 121.0, 137.0, 129.0, 164.0, 124.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 155.0, 152.0, 158.0, 155.0, 156.0, 159.0, 160.0, 158.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 63.0, 67.0, 63.0, 63.0, 64.0, 67.0, 65.0], "value": 64.7, "unit": "score"}]}]} 11:36:37 INFO - Return code: 0 11:36:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:37 ERROR - # TBPL SUCCESS # 11:36:37 INFO - Running post-action listener: _resource_record_post_action 11:36:37 INFO - ##### 11:36:37 INFO - ##### Finished run-tests step (success) 11:36:37 INFO - ##### 11:36:37 INFO - Running post-run listener: _resource_record_post_run 11:36:38 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 565047296; Read time: 16; Write time: 636444 11:36:38 INFO - TinderboxPrint: CPU usage
13.3% 11:36:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 11:36:38 INFO - TinderboxPrint: I/O write bytes / time
565,047,296 / 636,444 11:36:38 INFO - TinderboxPrint: CPU idle
8,221.8 (86.7%) 11:36:38 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 11:36:38 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:38 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 268132352; Read time: 0; Write time: 336648 11:36:38 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 296914944; Read time: 0; Write time: 299796 11:36:38 INFO - Running post-run listener: _upload_blobber_files 11:36:38 INFO - Blob upload gear active. 11:36:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:38 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 11:36:38 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'] 11:36:38 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 11:36:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:40 INFO - (blobuploader) - INFO - Done attempting. 11:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:44 INFO - (blobuploader) - INFO - Done attempting. 11:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:45 INFO - (blobuploader) - INFO - Done attempting. 11:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:45 INFO - Return code: 0 11:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f388e8643b337326c4b37d27dc4eb82583b2570cc103b370390c592f8f6b8dd4171c1713d974d0796949285014f5437ceb3d71d1dea67e4963bcf0a6553785ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a543ca259e110e0ca2085a5472b1417497762e313c1f3217085abd48bf689a3fa80c054d180843a6d07987e8b55fc6940b62c7ca87223b7506583a0201639a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20595d43ba6c7aff34d5507ca19bb2abe5b8d4cfd8c85e436fd9073b45f30d7a763022b6138761a5725b3def55304380f61cde9bc21148d2b282660910c9c11c"} 11:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:45 INFO - Contents: 11:36:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f388e8643b337326c4b37d27dc4eb82583b2570cc103b370390c592f8f6b8dd4171c1713d974d0796949285014f5437ceb3d71d1dea67e4963bcf0a6553785ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a543ca259e110e0ca2085a5472b1417497762e313c1f3217085abd48bf689a3fa80c054d180843a6d07987e8b55fc6940b62c7ca87223b7506583a0201639a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20595d43ba6c7aff34d5507ca19bb2abe5b8d4cfd8c85e436fd9073b45f30d7a763022b6138761a5725b3def55304380f61cde9bc21148d2b282660910c9c11c"} 11:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:45 INFO - Copying logs to upload dir... 11:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.037677 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 11:36:44.158670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:36:44.162477) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 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/f388e8643b337326c4b37d27dc4eb82583b2570cc103b370390c592f8f6b8dd4171c1713d974d0796949285014f5437ceb3d71d1dea67e4963bcf0a6553785ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a543ca259e110e0ca2085a5472b1417497762e313c1f3217085abd48bf689a3fa80c054d180843a6d07987e8b55fc6940b62c7ca87223b7506583a0201639a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20595d43ba6c7aff34d5507ca19bb2abe5b8d4cfd8c85e436fd9073b45f30d7a763022b6138761a5725b3def55304380f61cde9bc21148d2b282660910c9c11c"} build_url:https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/ZmOHuCQjQPy5D-REGt624A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f388e8643b337326c4b37d27dc4eb82583b2570cc103b370390c592f8f6b8dd4171c1713d974d0796949285014f5437ceb3d71d1dea67e4963bcf0a6553785ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a543ca259e110e0ca2085a5472b1417497762e313c1f3217085abd48bf689a3fa80c054d180843a6d07987e8b55fc6940b62c7ca87223b7506583a0201639a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20595d43ba6c7aff34d5507ca19bb2abe5b8d4cfd8c85e436fd9073b45f30d7a763022b6138761a5725b3def55304380f61cde9bc21148d2b282660910c9c11c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:36:44.188159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:36:44.188502) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467742561.696780-1493262304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:36:44.271426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:36:44.271735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:36:44.272006) ========= ========= Total master_lag: 0.16 =========