builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1467825678.06 results: success (0) buildid: 20160706073152 builduid: 74c5b5fd2f6f49809909e8da3cea3315 revision: ad84e1c0463273f7e03ddaf88e82df9422039ff6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.061178) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.061664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.062035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.081007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.081318) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 10:21:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-06 10:21:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.201134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.201463) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015735 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.251213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.251578) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ad84e1c0463273f7e03ddaf88e82df9422039ff6 --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 ad84e1c0463273f7e03ddaf88e82df9422039ff6 --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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 10:21:18,266 truncating revision to first 12 chars 2016-07-06 10:21:18,266 Setting DEBUG logging. 2016-07-06 10:21:18,266 attempt 1/10 2016-07-06 10:21:18,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ad84e1c04632?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 10:21:18,581 unpacking tar archive at: mozilla-inbound-ad84e1c04632/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.947594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.947902) ========= script_repo_revision: ad84e1c0463273f7e03ddaf88e82df9422039ff6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.948336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.948606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:21:18.958483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-06 10:21:18.958841) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:19 INFO - MultiFileLogger online at 20160706 10:21:19 in /builds/slave/test 10:21:19 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 10:21:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:19 INFO - {'append_to_log': False, 10:21:19 INFO - 'base_work_dir': '/builds/slave/test', 10:21:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:21:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:19 INFO - 'branch': 'Mozilla-Inbound', 10:21:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:19 INFO - 'config_files': ('talos/linux_config.py',), 10:21:19 INFO - 'default_actions': ('clobber', 10:21:19 INFO - 'read-buildbot-config', 10:21:19 INFO - 'download-and-extract', 10:21:19 INFO - 'populate-webroot', 10:21:19 INFO - 'create-virtualenv', 10:21:19 INFO - 'install', 10:21:19 INFO - 'run-tests'), 10:21:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:19 INFO - 'download_minidump_stackwalk': True, 10:21:19 INFO - 'download_symbols': 'ondemand', 10:21:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:19 INFO - 'installer_path': 'installer.exe', 10:21:19 INFO - 'log_level': 'info', 10:21:19 INFO - 'log_name': 'talos', 10:21:19 INFO - 'log_to_console': True, 10:21:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:19 INFO - 'opt_config_files': (), 10:21:19 INFO - 'pip_index': False, 10:21:19 INFO - 'sps_profile': False, 10:21:19 INFO - 'sps_profile_interval': 0, 10:21:19 INFO - 'suite': 'dromaeojs-e10s', 10:21:19 INFO - 'system_bits': '32', 10:21:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:19 INFO - 'title': 'talos-linux64-ix-037', 10:21:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:19 INFO - 'use_talos_json': True, 10:21:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:19 INFO - 'work_dir': 'build'} 10:21:19 INFO - ##### 10:21:19 INFO - ##### Running clobber step. 10:21:19 INFO - ##### 10:21:19 INFO - Running pre-action listener: _resource_record_pre_action 10:21:19 INFO - Running main action method: clobber 10:21:19 INFO - rmtree: /builds/slave/test/build 10:21:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:19 INFO - Running post-action listener: _resource_record_post_action 10:21:19 INFO - ##### 10:21:19 INFO - ##### Finished clobber step (success) 10:21:19 INFO - ##### 10:21:19 INFO - ##### 10:21:19 INFO - ##### Running read-buildbot-config step. 10:21:19 INFO - ##### 10:21:19 INFO - Running pre-action listener: _resource_record_pre_action 10:21:19 INFO - Running main action method: read_buildbot_config 10:21:19 INFO - Using buildbot properties: 10:21:19 INFO - { 10:21:19 INFO - "project": "", 10:21:19 INFO - "product": "firefox", 10:21:19 INFO - "script_repo_revision": "production", 10:21:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:21:19 INFO - "repository": "", 10:21:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:21:19 INFO - "buildid": "20160706073152", 10:21:19 INFO - "pgo_build": "True", 10:21:19 INFO - "basedir": "/builds/slave/test", 10:21:19 INFO - "buildnumber": 964, 10:21:19 INFO - "slavename": "talos-linux64-ix-037", 10:21:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:21:19 INFO - "platform": "ubuntu64_hw", 10:21:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:21:19 INFO - "branch": "mozilla-inbound", 10:21:19 INFO - "repo_path": "integration/mozilla-inbound", 10:21:19 INFO - "revision": "ad84e1c0463273f7e03ddaf88e82df9422039ff6", 10:21:19 INFO - "stage_platform": "linux64-pgo", 10:21:19 INFO - "builduid": "74c5b5fd2f6f49809909e8da3cea3315", 10:21:19 INFO - "slavebuilddir": "test" 10:21:19 INFO - } 10:21:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:21:19 INFO - Running post-action listener: _resource_record_post_action 10:21:19 INFO - ##### 10:21:19 INFO - ##### Finished read-buildbot-config step (success) 10:21:19 INFO - ##### 10:21:19 INFO - ##### 10:21:19 INFO - ##### Running download-and-extract step. 10:21:19 INFO - ##### 10:21:19 INFO - Running pre-action listener: _resource_record_pre_action 10:21:19 INFO - Running main action method: download_and_extract 10:21:19 INFO - mkdir: /builds/slave/test/build/tests 10:21: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')]} 10:21:19 INFO - https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:21:20 INFO - Downloaded 1361 bytes. 10:21:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:21:20 INFO - Using the following test package requirements: 10:21:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:21:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'jsshell-linux-x86_64.zip'], 10:21:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:21:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:21:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:20 INFO - https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:21 INFO - Downloaded 24301009 bytes. 10:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:22 INFO - Return code: 0 10:21:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:22 INFO - https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:23 INFO - Downloaded 24301009 bytes. 10:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:25 INFO - Return code: 0 10:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:25 INFO - https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:21:26 INFO - Downloaded 14403333 bytes. 10:21:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:21:26 INFO - Return code: 0 10:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:26 INFO - https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:21:28 INFO - Downloaded 60416453 bytes. 10:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:21:28 INFO - mkdir: /builds/slave/test/properties 10:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:28 INFO - Contents: 10:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - Running post-action listener: set_extra_try_arguments 10:21:28 INFO - ##### 10:21:28 INFO - ##### Finished download-and-extract step (success) 10:21:28 INFO - ##### 10:21:28 INFO - ##### 10:21:28 INFO - ##### Running populate-webroot step. 10:21:28 INFO - ##### 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: populate_webroot 10:21:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:28 INFO - '--tppagecycles', 10:21:28 INFO - '7'], 10:21:28 INFO - 'tests': ['tsvgm']}}, 10:21:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['damp', 'tps']}, 10:21:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'tests': ['damp', 'tps']}, 10:21:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['dromaeo_dom']}, 10:21:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['basic_compositor_video']}, 10:21:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:21:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['a11yr', 10:21:28 INFO - 'ts_paint', 10:21:28 INFO - 'tpaint', 10:21:28 INFO - 'sessionrestore', 10:21:28 INFO - 'sessionrestore_no_auto_restore', 10:21:28 INFO - 'tabpaint']}, 10:21:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['tsvgx', 10:21:28 INFO - 'tsvgr_opacity', 10:21:28 INFO - 'tart', 10:21:28 INFO - 'tscrollx', 10:21:28 INFO - 'cart']}, 10:21:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:28 INFO - 'tsvgr_opacity', 10:21:28 INFO - 'tart', 10:21:28 INFO - 'tscrollx', 10:21:28 INFO - 'cart']}, 10:21:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'talos_options': ['--disable-e10s'], 10:21:28 INFO - 'tests': ['tp5o']}, 10:21:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'tests': ['tp5o']}, 10:21:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'talos_options': ['--disable-e10s', 10:21:28 INFO - '--xperf_path', 10:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:28 INFO - 'tests': ['tp5n']}, 10:21:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:28 INFO - 'talos_options': ['--xperf_path', 10:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:28 INFO - 'tests': ['tp5n']}}, 10:21:28 INFO - 'talos.zip': {'path': '', 10:21:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - ##### 10:21:28 INFO - ##### Finished populate-webroot step (success) 10:21:28 INFO - ##### 10:21:28 INFO - ##### 10:21:28 INFO - ##### Running create-virtualenv step. 10:21:28 INFO - ##### 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: create_virtualenv 10:21:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:21:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:28 INFO - Using real prefix '/usr' 10:21:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:31 INFO - Installing pip.................done. 10:21:31 INFO - Return code: 0 10:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:21:31 INFO - Using env: {'DISPLAY': ':0', 10:21:31 INFO - 'HOME': '/home/cltbld', 10:21:31 INFO - 'LANG': 'en_US.UTF-8', 10:21:31 INFO - 'LANGUAGE': 'en_US:en', 10:21:31 INFO - 'LOGNAME': 'cltbld', 10:21:31 INFO - 'MAIL': '/var/mail/cltbld', 10:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:31 INFO - 'MOZ_NO_REMOTE': '1', 10:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:31 INFO - 'NO_EM_RESTART': '1', 10:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:31 INFO - 'PWD': '/builds/slave/test', 10:21:31 INFO - 'SHELL': '/bin/bash', 10:21:31 INFO - 'SHLVL': '1', 10:21:31 INFO - 'TERM': 'linux', 10:21:31 INFO - 'TMOUT': '86400', 10:21:31 INFO - 'USER': 'cltbld', 10:21:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:31 INFO - '_': '/tools/buildbot/bin/python'} 10:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:21:31 INFO - Cleaning up... 10:21:31 INFO - Return code: 0 10:21:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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', '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 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:21: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 psutil>=3.1.1 10:21:31 INFO - Using env: {'DISPLAY': ':0', 10:21:31 INFO - 'HOME': '/home/cltbld', 10:21:31 INFO - 'LANG': 'en_US.UTF-8', 10:21:31 INFO - 'LANGUAGE': 'en_US:en', 10:21:31 INFO - 'LOGNAME': 'cltbld', 10:21:31 INFO - 'MAIL': '/var/mail/cltbld', 10:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:31 INFO - 'MOZ_NO_REMOTE': '1', 10:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:31 INFO - 'NO_EM_RESTART': '1', 10:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:31 INFO - 'PWD': '/builds/slave/test', 10:21:31 INFO - 'SHELL': '/bin/bash', 10:21:31 INFO - 'SHLVL': '1', 10:21:31 INFO - 'TERM': 'linux', 10:21:31 INFO - 'TMOUT': '86400', 10:21:31 INFO - 'USER': 'cltbld', 10:21:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:31 INFO - '_': '/tools/buildbot/bin/python'} 10:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:31 INFO - Downloading/unpacking psutil>=3.1.1 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:33 INFO - Installing collected packages: psutil 10:21:33 INFO - Running setup.py install for psutil 10:21:33 INFO - building 'psutil._psutil_linux' extension 10:21:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:21:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:21:34 INFO - building 'psutil._psutil_posix' extension 10:21:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:21:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:34 INFO - Successfully installed psutil 10:21:34 INFO - Cleaning up... 10:21:34 INFO - Return code: 0 10:21:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:21:34 INFO - Using env: {'DISPLAY': ':0', 10:21:34 INFO - 'HOME': '/home/cltbld', 10:21:34 INFO - 'LANG': 'en_US.UTF-8', 10:21:34 INFO - 'LANGUAGE': 'en_US:en', 10:21:34 INFO - 'LOGNAME': 'cltbld', 10:21:34 INFO - 'MAIL': '/var/mail/cltbld', 10:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:34 INFO - 'MOZ_NO_REMOTE': '1', 10:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:34 INFO - 'NO_EM_RESTART': '1', 10:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:34 INFO - 'PWD': '/builds/slave/test', 10:21:34 INFO - 'SHELL': '/bin/bash', 10:21:34 INFO - 'SHLVL': '1', 10:21:34 INFO - 'TERM': 'linux', 10:21:34 INFO - 'TMOUT': '86400', 10:21:34 INFO - 'USER': 'cltbld', 10:21:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:34 INFO - '_': '/tools/buildbot/bin/python'} 10:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:21:36 INFO - Installing collected packages: mozsystemmonitor 10:21:36 INFO - Running setup.py install for mozsystemmonitor 10:21:36 INFO - Successfully installed mozsystemmonitor 10:21:36 INFO - Cleaning up... 10:21:36 INFO - Return code: 0 10:21:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:36 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 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:21:36 INFO - Using env: {'DISPLAY': ':0', 10:21:36 INFO - 'HOME': '/home/cltbld', 10:21:36 INFO - 'LANG': 'en_US.UTF-8', 10:21:36 INFO - 'LANGUAGE': 'en_US:en', 10:21:36 INFO - 'LOGNAME': 'cltbld', 10:21:36 INFO - 'MAIL': '/var/mail/cltbld', 10:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:36 INFO - 'MOZ_NO_REMOTE': '1', 10:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:36 INFO - 'NO_EM_RESTART': '1', 10:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:36 INFO - 'PWD': '/builds/slave/test', 10:21:36 INFO - 'SHELL': '/bin/bash', 10:21:36 INFO - 'SHLVL': '1', 10:21:36 INFO - 'TERM': 'linux', 10:21:36 INFO - 'TMOUT': '86400', 10:21:36 INFO - 'USER': 'cltbld', 10:21:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:36 INFO - '_': '/tools/buildbot/bin/python'} 10:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:39 INFO - warning: no files found matching '*.txt' 10:21:39 INFO - no previously-included directories found matching 'build' 10:21:39 INFO - no previously-included directories found matching 'dist' 10:21:39 INFO - no previously-included directories found matching '.git*' 10:21:39 INFO - Installing collected packages: jsonschema, functools32 10:21:39 INFO - Running setup.py install for functools32 10:21:39 INFO - warning: no files found matching '*.txt' 10:21:39 INFO - no previously-included directories found matching 'build' 10:21:39 INFO - no previously-included directories found matching 'dist' 10:21:39 INFO - no previously-included directories found matching '.git*' 10:21:39 INFO - Successfully installed jsonschema functools32 10:21:39 INFO - Cleaning up... 10:21:39 INFO - Return code: 0 10:21:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:21:39 INFO - Using env: {'DISPLAY': ':0', 10:21:39 INFO - 'HOME': '/home/cltbld', 10:21:39 INFO - 'LANG': 'en_US.UTF-8', 10:21:39 INFO - 'LANGUAGE': 'en_US:en', 10:21:39 INFO - 'LOGNAME': 'cltbld', 10:21:39 INFO - 'MAIL': '/var/mail/cltbld', 10:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:39 INFO - 'MOZ_NO_REMOTE': '1', 10:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:39 INFO - 'NO_EM_RESTART': '1', 10:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:39 INFO - 'PWD': '/builds/slave/test', 10:21:39 INFO - 'SHELL': '/bin/bash', 10:21:39 INFO - 'SHLVL': '1', 10:21:39 INFO - 'TERM': 'linux', 10:21:39 INFO - 'TMOUT': '86400', 10:21:39 INFO - 'USER': 'cltbld', 10:21:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:39 INFO - '_': '/tools/buildbot/bin/python'} 10:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:42 INFO - Downloading docopt-0.6.1.tar.gz 10:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:42 INFO - Running setup.py install for blobuploader 10:21:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:42 INFO - Running setup.py install for requests 10:21:42 INFO - Running setup.py install for docopt 10:21:42 INFO - Successfully installed blobuploader requests docopt 10:21:42 INFO - Cleaning up... 10:21:42 INFO - Return code: 0 10:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:42 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 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:21:42 INFO - Using env: {'DISPLAY': ':0', 10:21:42 INFO - 'HOME': '/home/cltbld', 10:21:42 INFO - 'LANG': 'en_US.UTF-8', 10:21:42 INFO - 'LANGUAGE': 'en_US:en', 10:21:42 INFO - 'LOGNAME': 'cltbld', 10:21:42 INFO - 'MAIL': '/var/mail/cltbld', 10:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:42 INFO - 'MOZ_NO_REMOTE': '1', 10:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:42 INFO - 'NO_EM_RESTART': '1', 10:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:42 INFO - 'PWD': '/builds/slave/test', 10:21:42 INFO - 'SHELL': '/bin/bash', 10:21:42 INFO - 'SHLVL': '1', 10:21:42 INFO - 'TERM': 'linux', 10:21:42 INFO - 'TMOUT': '86400', 10:21:42 INFO - 'USER': 'cltbld', 10:21:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:42 INFO - '_': '/tools/buildbot/bin/python'} 10:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:42 INFO - Running setup.py (path:/tmp/pip-xnE4Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:43 INFO - Running setup.py (path:/tmp/pip-yzVb6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:43 INFO - Running setup.py (path:/tmp/pip-arK_xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:43 INFO - Running setup.py (path:/tmp/pip-w7YOzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:43 INFO - Running setup.py (path:/tmp/pip-j2K5JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:43 INFO - Running setup.py (path:/tmp/pip-Et7FbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:43 INFO - Running setup.py (path:/tmp/pip-NLrmS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:43 INFO - Running setup.py (path:/tmp/pip-t8nosI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:43 INFO - Running setup.py (path:/tmp/pip-i2pFeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:43 INFO - Running setup.py (path:/tmp/pip-ZuhuvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:43 INFO - Running setup.py (path:/tmp/pip-gluc9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:43 INFO - Running setup.py (path:/tmp/pip-xJc8pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:43 INFO - Running setup.py (path:/tmp/pip-k5H4uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:43 INFO - Running setup.py (path:/tmp/pip-Yp47Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:43 INFO - Running setup.py (path:/tmp/pip-rRL31O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:44 INFO - Running setup.py (path:/tmp/pip-DS0oZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:44 INFO - Running setup.py (path:/tmp/pip-2PGFSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:44 INFO - Running setup.py install for manifestparser 10:21:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Running setup.py install for mozcrash 10:21:44 INFO - Running setup.py install for mozdebug 10:21:44 INFO - Running setup.py install for mozdevice 10:21:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Running setup.py install for mozfile 10:21:44 INFO - Running setup.py install for mozhttpd 10:21:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Running setup.py install for mozinfo 10:21:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Running setup.py install for mozInstall 10:21:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:44 INFO - Running setup.py install for mozleak 10:21:45 INFO - Running setup.py install for mozlog 10:21:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Running setup.py install for moznetwork 10:21:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Running setup.py install for mozprocess 10:21:45 INFO - Running setup.py install for mozprofile 10:21:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Running setup.py install for mozrunner 10:21:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Running setup.py install for mozscreenshot 10:21:45 INFO - Running setup.py install for moztest 10:21:45 INFO - Running setup.py install for mozversion 10:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:45 INFO - Cleaning up... 10:21:45 INFO - Return code: 0 10:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:45 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 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:21:45 INFO - Using env: {'DISPLAY': ':0', 10:21:45 INFO - 'HOME': '/home/cltbld', 10:21:45 INFO - 'LANG': 'en_US.UTF-8', 10:21:45 INFO - 'LANGUAGE': 'en_US:en', 10:21:45 INFO - 'LOGNAME': 'cltbld', 10:21:45 INFO - 'MAIL': '/var/mail/cltbld', 10:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:45 INFO - 'MOZ_NO_REMOTE': '1', 10:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:45 INFO - 'NO_EM_RESTART': '1', 10:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:45 INFO - 'PWD': '/builds/slave/test', 10:21:45 INFO - 'SHELL': '/bin/bash', 10:21:45 INFO - 'SHLVL': '1', 10:21:45 INFO - 'TERM': 'linux', 10:21:45 INFO - 'TMOUT': '86400', 10:21:45 INFO - 'USER': 'cltbld', 10:21:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:45 INFO - '_': '/tools/buildbot/bin/python'} 10:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:46 INFO - Running setup.py (path:/tmp/pip-SqJHmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:46 INFO - Running setup.py (path:/tmp/pip-SJdlUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:46 INFO - Running setup.py (path:/tmp/pip-1TNfID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:46 INFO - Running setup.py (path:/tmp/pip-4EBsd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:46 INFO - Running setup.py (path:/tmp/pip-r8FKX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:46 INFO - Running setup.py (path:/tmp/pip-RC7tVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:46 INFO - Running setup.py (path:/tmp/pip-Fr6F7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:46 INFO - Running setup.py (path:/tmp/pip-mx6EiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:46 INFO - Running setup.py (path:/tmp/pip-HXEPvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:46 INFO - Running setup.py (path:/tmp/pip-mQO2q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:46 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)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:46 INFO - Running setup.py (path:/tmp/pip-HlTviq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:46 INFO - Running setup.py (path:/tmp/pip-JfnKJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:47 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)) 10:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:47 INFO - Running setup.py (path:/tmp/pip-yQDT6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:47 INFO - Running setup.py (path:/tmp/pip-SZets2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:47 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)) 10:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:47 INFO - Running setup.py (path:/tmp/pip-QQ9vzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:47 INFO - Running setup.py (path:/tmp/pip-u44A8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:47 INFO - Running setup.py (path:/tmp/pip-cQCAo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:49 INFO - Downloading blessings-1.6.tar.gz 10:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:49 INFO - Installing collected packages: blessings 10:21:49 INFO - Running setup.py install for blessings 10:21:49 INFO - Successfully installed blessings 10:21:49 INFO - Cleaning up... 10:21:49 INFO - Return code: 0 10:21:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:49 INFO - Reading from file tmpfile_stdout 10:21:49 INFO - Current package versions: 10:21:49 INFO - argparse == 1.2.1 10:21:49 INFO - blessings == 1.6 10:21:49 INFO - blobuploader == 1.2.4 10:21:49 INFO - docopt == 0.6.1 10:21:49 INFO - functools32 == 3.2.3-2 10:21:49 INFO - jsonschema == 2.5.1 10:21:49 INFO - manifestparser == 1.1 10:21:49 INFO - mozInstall == 1.12 10:21:49 INFO - mozcrash == 0.17 10:21:49 INFO - mozdebug == 0.1 10:21:49 INFO - mozdevice == 0.48 10:21:49 INFO - mozfile == 1.2 10:21:49 INFO - mozhttpd == 0.7 10:21:49 INFO - mozinfo == 0.9 10:21:49 INFO - mozleak == 0.1 10:21:49 INFO - mozlog == 3.2 10:21:49 INFO - moznetwork == 0.27 10:21:49 INFO - mozprocess == 0.22 10:21:49 INFO - mozprofile == 0.28 10:21:49 INFO - mozrunner == 6.11 10:21:49 INFO - mozscreenshot == 0.1 10:21:49 INFO - mozsystemmonitor == 0.3 10:21:49 INFO - moztest == 0.7 10:21:49 INFO - mozversion == 1.4 10:21:49 INFO - psutil == 3.1.1 10:21:49 INFO - requests == 1.2.3 10:21:49 INFO - wsgiref == 0.1.2 10:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:49 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 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:21:49 INFO - Using env: {'DISPLAY': ':0', 10:21:49 INFO - 'HOME': '/home/cltbld', 10:21:49 INFO - 'LANG': 'en_US.UTF-8', 10:21:49 INFO - 'LANGUAGE': 'en_US:en', 10:21:49 INFO - 'LOGNAME': 'cltbld', 10:21:49 INFO - 'MAIL': '/var/mail/cltbld', 10:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:49 INFO - 'MOZ_NO_REMOTE': '1', 10:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:49 INFO - 'NO_EM_RESTART': '1', 10:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:49 INFO - 'PWD': '/builds/slave/test', 10:21:49 INFO - 'SHELL': '/bin/bash', 10:21:49 INFO - 'SHLVL': '1', 10:21:49 INFO - 'TERM': 'linux', 10:21:49 INFO - 'TMOUT': '86400', 10:21:49 INFO - 'USER': 'cltbld', 10:21:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:49 INFO - '_': '/tools/buildbot/bin/python'} 10:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:21:50 INFO - Cleaning up... 10:21:50 INFO - Return code: 0 10:21:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:21:50 INFO - Using env: {'DISPLAY': ':0', 10:21:50 INFO - 'HOME': '/home/cltbld', 10:21:50 INFO - 'LANG': 'en_US.UTF-8', 10:21:50 INFO - 'LANGUAGE': 'en_US:en', 10:21:50 INFO - 'LOGNAME': 'cltbld', 10:21:50 INFO - 'MAIL': '/var/mail/cltbld', 10:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:50 INFO - 'MOZ_NO_REMOTE': '1', 10:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:50 INFO - 'NO_EM_RESTART': '1', 10:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:50 INFO - 'PWD': '/builds/slave/test', 10:21:50 INFO - 'SHELL': '/bin/bash', 10:21:50 INFO - 'SHLVL': '1', 10:21:50 INFO - 'TERM': 'linux', 10:21:50 INFO - 'TMOUT': '86400', 10:21:50 INFO - 'USER': 'cltbld', 10:21:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:50 INFO - '_': '/tools/buildbot/bin/python'} 10:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:21:50 INFO - Cleaning up... 10:21:50 INFO - Return code: 0 10:21:50 INFO - Running post-action listener: _resource_record_post_action 10:21:50 INFO - Running post-action listener: _start_resource_monitoring 10:21:50 INFO - Starting resource monitoring. 10:21:50 INFO - ##### 10:21:50 INFO - ##### Finished create-virtualenv step (success) 10:21:50 INFO - ##### 10:21:50 INFO - ##### 10:21:50 INFO - ##### Running install step. 10:21:50 INFO - ##### 10:21:50 INFO - Running pre-action listener: _resource_record_pre_action 10:21:50 INFO - Running main action method: install 10:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:50 INFO - Reading from file tmpfile_stdout 10:21:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:50 INFO - Reading from file tmpfile_stdout 10:21:50 INFO - Output received: 10:21:50 INFO - Usage: mozinstall [options] installer 10:21:50 INFO - Options: 10:21:50 INFO - -h, --help show this help message and exit 10:21:50 INFO - -d DEST, --destination=DEST 10:21:50 INFO - Directory to install application into. [default: 10:21:50 INFO - "/builds/slave/test"] 10:21:50 INFO - --app=APP Application being installed. [default: firefox] 10:21:50 INFO - mkdir: /builds/slave/test/build/application 10:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:22:07 INFO - Reading from file tmpfile_stdout 10:22:07 INFO - Output received: 10:22:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:22:07 INFO - Running post-action listener: _resource_record_post_action 10:22:07 INFO - ##### 10:22:07 INFO - ##### Finished install step (success) 10:22:07 INFO - ##### 10:22:07 INFO - ##### 10:22:07 INFO - ##### Running run-tests step. 10:22:07 INFO - ##### 10:22:07 INFO - Running pre-action listener: _resource_record_pre_action 10:22:07 INFO - Running main action method: run_tests 10:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:07 INFO - Python 2.7.3 10:22:07 INFO - Return code: 0 10:22:07 INFO - grabbing minidump binary from tooltool 10:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:07 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 0x232a570>, '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 0x232b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:22:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:22:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:22:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:07 INFO - Return code: 0 10:22:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:22:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:22:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:07 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/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:22:07 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/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 10:22:07 INFO - Using env: {'DISPLAY': ':0', 10:22:07 INFO - 'HOME': '/home/cltbld', 10:22:07 INFO - 'LANG': 'en_US.UTF-8', 10:22:07 INFO - 'LANGUAGE': 'en_US:en', 10:22:07 INFO - 'LOGNAME': 'cltbld', 10:22:07 INFO - 'MAIL': '/var/mail/cltbld', 10:22:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:07 INFO - 'MOZ_NO_REMOTE': '1', 10:22:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:07 INFO - 'NO_EM_RESTART': '1', 10:22:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:07 INFO - 'PWD': '/builds/slave/test', 10:22:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:07 INFO - 'SHELL': '/bin/bash', 10:22:07 INFO - 'SHLVL': '1', 10:22:07 INFO - 'TERM': 'linux', 10:22:07 INFO - 'TMOUT': '86400', 10:22:07 INFO - 'USER': 'cltbld', 10:22:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441', 10:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:07 INFO - '_': '/tools/buildbot/bin/python'} 10:22:07 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/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:22:07 INFO - mozversion application_buildid: 20160706073152 10:22:07 INFO - mozversion application_changeset: ad84e1c0463273f7e03ddaf88e82df9422039ff6 10:22:07 INFO - mozversion application_display_name: Nightly 10:22:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:07 INFO - mozversion application_name: Firefox 10:22:07 INFO - mozversion application_remotingname: firefox 10:22:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:22:07 INFO - mozversion application_vendor: Mozilla 10:22:07 INFO - mozversion application_version: 50.0a1 10:22:07 INFO - mozversion platform_buildid: 20160706073152 10:22:07 INFO - mozversion platform_changeset: ad84e1c0463273f7e03ddaf88e82df9422039ff6 10:22:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:22:07 INFO - mozversion platform_version: 50.0a1 10:22:07 INFO - using testdate: 1467825727 10:22:07 INFO - actual date: 1467825727 10:22:07 INFO - starting webserver on 'localhost:37403' 10:22:07 INFO - SUITE-START | Running 2 tests 10:22:07 INFO - TEST-START | dromaeo_css 10:22:07 INFO - operating with platform_type : linux_ 10:22:07 INFO - Initialising browser for dromaeo_css test... 10:22:07 INFO - TEST-INFO | started process 14131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9U4A4K/profile http://localhost:37403/getInfo.html) 10:22:12 INFO - PROCESS | 14131 | __metrics Screen width/height:1600/1200 10:22:12 INFO - PROCESS | 14131 | colorDepth:24 10:22:12 INFO - PROCESS | 14131 | Browser inner width/height: 1024/697 10:22:12 INFO - PROCESS | 14131 | __metrics 10:22:13 ERROR - PROCESS | 14131 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 10:22:13 INFO - TEST-INFO | 14131: exit 0 10:22:13 INFO - Browser initialized. 10:22:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:13 INFO - TEST-INFO | started process 14250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9U4A4K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:25 INFO - PROCESS | 14250 | RSS: Main: 168443904 10:22:25 INFO - PROCESS | 14250 | 10:23:15 INFO - PROCESS | 14250 | 1467825795352 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:25:23 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37403/tests/dromaeo/cssquery-ext.html) 10:25:24 INFO - PROCESS | 14250 | RSS: Main: 171741184 10:25:24 INFO - PROCESS | 14250 | 10:28:26 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-ext.html (next: http://localhost:37403/tests/dromaeo/cssquery-jquery.html) 10:28:27 INFO - PROCESS | 14250 | RSS: Main: 168443904 10:28:27 INFO - PROCESS | 14250 | 10:31:28 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37403/tests/dromaeo/cssquery-mootools.html) 10:31:29 INFO - PROCESS | 14250 | RSS: Main: 171528192 10:31:29 INFO - PROCESS | 14250 | 10:34:31 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37403/tests/dromaeo/cssquery-prototype.html) 10:34:32 INFO - PROCESS | 14250 | RSS: Main: 167059456 10:34:32 INFO - PROCESS | 14250 | 10:37:34 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37403/tests/dromaeo/cssquery-yui.html) 10:37:35 INFO - PROCESS | 14250 | RSS: Main: 169365504 10:37:35 INFO - PROCESS | 14250 | 10:40:37 INFO - PROCESS | 14250 | Cycle 1(1): loaded http://localhost:37403/tests/dromaeo/cssquery-yui.html (next: http://localhost:37403/tests/dromaeo/cssquery-dojo.html) 10:40:38 INFO - PROCESS | 14250 | RSS: Main: 170012672 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | __start_tp_report 10:40:38 INFO - PROCESS | 14250 | _x_x_mozilla_page_load 10:40:38 INFO - PROCESS | 14250 | _x_x_mozilla_page_load_details 10:40:38 INFO - PROCESS | 14250 | |i|pagename|runs| 10:40:38 INFO - PROCESS | 14250 | |0;dojo.html;3127.10877399941;3170.9524357134646;3172.175234439045;3189.728873045791;3201.215702152973;5470.12478003519;5482.342118945727;5507.339119305684;5572.442755724425;5574.414686457924;5402.513773760361;5405.297311349529;5481.205225242337;5486.463790138758;5502.944970550293;5002;5013.097642424362;5139.049275883974;5185.896282074356;5238.4499627539135;574.4385131696359;4993.226049962262;5127.384713834345;5149;5160.406553246368;5003.199488081889;5018.723970181639;5040.092783299005;5043.268726034741;5066.847994560132;4935;5032.396112466491;5042.243663450512;5048.848534543969;5053.8736531587;4968.776405061781;4972.080165169419;5001.074801161797;5009.849704508871;5028.698278103326;5463.289772329572;5487.341519017704;5531.308586426697;5555.388907220243;5637.154426835967;5720.427957204288;5805.303363596353;5936.584439089265;5949.8215053548465;5965.433283838029;5911.704414779244;6025.276966764016;6030.306514750816;6031.1254868044325;6036.3360030396625;5584.776608935678;5591.077472217079;5594.300712410949;5596.2165296858475;5601.551875849963;5903.822885313448;6022.698865056817;6048.395160483917;6084.117802918552;6098.085287206865;5879.088741245114;5882.058870580687;5888.4700376966275;5911.9704401478575;5937.643741375531;5925.555583331267;5970.761169553256;5993.460588547052;5994.310654274815;5999.400059994053;5756.0502517084215;5900.380460051719;5982.820515384546;6008.068749343859;6013.609115407485;5642.7178641067785;5861.3552509223955;5879.764809407576;5886.028805247086;5951.7619295227705;4472.172648060119;4517.209488339593;4524.547545245515;4527.547245275446;4551.795169217327;3910.276598829226;3914.2562913047;3945.9013524662114;4018.1561872007205;4078.2455245779624;5537.529310008695;5591.189277554732;5631.802886898939;5632.859178520488;5673.035583950738;5879.559033072536;5928.170056192136;5935.40645935403;5948.958932186936;5970.611910225822;5510.090835012258;5609.943900560942;5629;5634.802781902696;5652.604317697722;5099.209622508517;5115.181570948705;5125.64120511568;5136.178211486144;5138.871528211825;6160.168377269101;6173.783917562864;6178.907316390258;6187.690615469209;6199.504039676815;5687.744051517609;5860.970695146497;5930.347661757117;5942.435468630473;5981.910271346021;6068.787592434243;6108.908366374419;6110;6118.816435506942;6121.571489995657;5590.888182236251;5819.185314055951;5829.213056237354;5849.210356601974;5859.853503662272;5707.6290041147195;5741.598088133791;5870.706464676664;5926.140709597171;5961.463468287875;5778.104393818965;5795.1017592273265;5814.418558144152;5823.475887170175;5824.271966004249;5770.365259821332;5783.971080144573;5793.855153621024;5803;5816.8947899898885;5541.833744987657;5575.052241118939;5609.018421776254;5652.3217213934595;5672.461116193955;5745;5784.82645520635;5804.738786754522;5806.854828629318;5814.883702325845;5416.8104116355735;5686.459786320293;5688.54491640676;5697.4587414195585;5711.5145212655725 10:40:38 INFO - PROCESS | 14250 | |1;ext.html;547.306212715345;571.9056355701309;599.4694695194752;608.6591508755098;639.1786554277754;36470.08824779382;41171;41247.38128928068;41256.38115428271;41291.79354103225;40492.79753601228;41215.38176927341;41259.381109283386;41259.793701031456;41287.17425651485;8697.08680588537;8814.955925220365;8857.822843543125;8865.734027979139;8882.333824963154;8824.426412283214;8874.20132188103;8880.822383552326;8882.689105881296;8894.555272236395;8877.378583499158;8916.375853690244;8919.643214271422;8933.10668933108;8961.148690874388;8848.646054157825;8872.334574906843;8877.911220887772;8889.333300002494;8921.598528066253;8754.212120909086;8819.955900220459;8831.205191532792;8847.646094156225;8848.336374771854;40968.59031409678;41390.58609413898;41447;41517.58482415167;41526.1694766106;3508.6491350864962;3678.7792732435873;3692.5015122958594;3777.6411240932066;4041.0503531670033;31455.213619659462;32309;32337.736358454917;33070.338593228;33676;4461.353103799964;4468.084042771224;4527.909441811145;4549.863504094849;4704.5765881070865;349766.25116874505;350857;352968;354372;355093;33781.66218337785;56344;57174.42825571774;57183.428165718644;57263;34446.65553344485;36088.27823443569;36210.27579448396;36218.27563448716;36293.81853090718;14570.85429145695;14584.124952502672;14631.536846315283;14653.267336633126;14695.412183512753;11807.645770626896;11884.881151188378;11903.940480297717;11917.046636269077;11918.582849600223;8240.175982401832;8243.340532757366;8314.168583141758;8316.043654979754;8393.412461127662;3202.343519578481;3218.3885061838178;3234.498652708834;3269.019294211727;3337.249118948217;1052.552665117322;1052.6947185316174;1060.2366296266675;1113.554578168739;1141.275290190735;32781;33057;33202.3359532808;33254.83372583122;33518.49722254119;1108.8004159251411;1136.108155098244;1138.4403367386567;1162.7267592115845;1211.2671833540758;17184.742228866326;17238.569035774206;17398.739018914726;17497.38759143424;17551.385701500385;540069;543035;549870;553074;554303;56734;57204.42795572074;57208.42791572031;57217.713911430175;57277;1352.4995751571785;1384.7715127004133;1398.3427788939182;1404.1876305829721;1404.936777844979;31375.215619608778;32708;32761.508577371835;32803.507947380334;33101.834490827394;49894;50149.24776128288;50468.49531504785;50477;50651.74674126753;443493;447495;447538;448872;449735;27767.583486247317;27937.301567460978;28257.293567660974;28422.715772842006;28437.573436398885;48255.517444825105;48765;48905.266421003005;48978.26532601943;49804.25293620526;41770.70380502362;41779;42151;42420;42776.57223427726;41263.793681031406;41581.37627935523;41583;42003.7899810499;42182.36726449044;40498.59501404948;41018;41912.790436047624;42065;42109.36835947402;35779;36953.630463695015;37367.81316093402;37647.81176094102;38071;27915.44169116647;28405.715942840307;28529.572056418754;28645.570316445686;28658.426831462835 10:40:38 INFO - PROCESS | 14250 | |2;jquery.html;387.51560549313365;390.66598058659827;395.9128991621844;399.35504160780346;418.62114786118553;14523.92738036311;18350.44948651541;19917.203311867506;20365;20419;19239;19546.511337216576;19901.601967960632;19979.300724474648;20040.0981955812;5739.282589676301;5827.766889324422;5836.562257830658;5844.766209351621;5846.9183201107935;5677;5761.827145185651;5788.768449262025;5842.152887831262;5852.9707351463185;5679.5740319476;5681.091025435931;5821.505172060359;5825.5048320892565;5827.796027139051;5760.567957403212;5760.8847823043725;5770.2210201622875;5779.768809247625;5789.421057894198;5072.67027643202;5104.923426148611;5183.377994640629;5185.118529849935;5195.896082078338;23605.88197059004;23634.527309453886;23843.88078059616;23941.162059328013;24064.75935240643;2344.7303560090636;2370.4903445759073;2376.3346263046374;2556.846589204654;3077.692230776927;14805.777913331309;14881.627959300995;14935.925320373437;15181.468648597245;15283.770743438858;1925.4993701637675;1943.0867492278605;1951.6194342103295;1971.280482623832;1997.5405656698895;83840.58079709623;85805.57097214536;86163.56918215432;86309.56845215797;87900;10070;10190.796184076276;10467.214958878114;10575.682729518127;10589.258751887448;13799.51701690436;13868.514601988882;13898.51355202563;13922.303884805922;14011.789823152661;7807.219278072147;8015.879761803578;8082.31300339466;8171.223733745284;8315.95842020786;7958.920410795818;8073.192680731997;8111;8303.792405189797;8331.54176520285;6550.737970481127;6564.343565643398;6579.703913323912;6589.308122647149;6616.4045235929;1905.904704764784;1908.7709474862827;1923.422973108062;1980.0396807548327;1987.8210961013579;995.2883688162854;1069.4492336446735;1079.271491743086;1083.5990683447176;1105.7346236903086;19992.700109498368;20483.897580512003;20702.896485517475;20740.896295518727;20860.269890553758;1023.2939271902363;1045.278757657214;1053.931494452858;1070.9089727373105;1093.491526440209;11310.377929213972;11749;11776.293422394683;11908.106891983136;11915.463804128834;499851;501118;505964;510135;510569;91691.69069305655;96844;101969;102381.48809256055;102456;1019.0980981831133;1034.9793004139874;1071.796358691846;1076.7200527862656;1077.6282182646974;17567.82432175713;17674.823251767317;18080.90959545194;18255.452336429396;18316.26734930588;37146.8142659285;42455;45108;45902.77048614869;47101.764491177324;61216.387836121066;61868.69065654823;62501.37498625137;63755.362446374944;63850.04224936537;7689.9615501922135;8286.544240066612;8629.784255393666;8678.913210867811;8851.291896648125;13522.18866867991;13803.861961380659;14367.568972930829;14455.710885782435;14564.563063108124;6024.789132380346;12126.393680315772;12185;12265.018798495921;12296.20074695142;11899.762004759683;12016.759664806481;12080.75838483208;12176.939115304367;12551.184173028723;12513.124081314221;12625.747485050431;12779.808302875279;12828.230306181658;12959.222446653232;8056.516609003478;8135.471194372347;8143.83712325762;8150.062742784418;8336.83326333482;6488;12220.572279970158;12462.31457269859;12605.621831345074;12708.809367859674 10:40:38 INFO - PROCESS | 14250 | |3;mootools.html;1461.634591352162;1511.9319630616621;1633.901965882047;1794.2195145111868;1801.234475347976;7895.723649672263;8614;8662.95668521658;9188.310876684242;9201.723948281546;8709.608067636957;8973.596188171532;9004.594793234304;9050.456972581633;9050.72847814565;2118.1739121742494;2144.6997420361163;2164.5021645021657;2164.8159906407973;2174.5433458973635;2182.4434769133927;2182.6507758758603;2248.1007596961263;2249.7862703043265;2250.3811451850706;2106.8946552672382;2123.384218576619;2124.3945475539476;2125.5855108253895;2149.269248455525;2128.414685961365;2128.6700561413004;2140.56118495708;2142.828573714099;2142.978570214309;2059.3101311060814;2081.354780018199;2085.937421877331;2105.1684584589;2105.673620588811;8969.641214351419;9096.272298216192;9101.681441149594;9116.179543841086;9116.361854670176;5230.869228269324;5325.760340784674;5363.517283444469;5364.8122315718765;5367.785288588452;3247.9188020299443;3330.6169790474164;3360.4455264881267;3361.8319084045943;3418.4701371287492;1110.4059328259343;1133.4899295317057;1161.0479406886357;1163.3136449494755;1167.8890505401973;12725.745485090247;12924.224546527144;12939.353032348345;12946.093773435863;12948.611541653765;4599.264117741145;4611.469680986663;4825.686330388584;4831.830885918976;4838.854834354975;10760.139188864872;10764.13886889047;10775.568977240979;10778.622748203776;10780.676579702622;5482.479164479368;5488.341399032061;5498.285222921075;5502.449755024546;5514.062609356419;4361.825526978949;4720.905581888412;4867.780949857265;5020.071286811952;5030.773615187325;3969.3450580653866;3994.8601798936897;4092.856750013735;4113.650339721097;4290.592393722592;1219.4390580333147;1244.402686710366;1253.893419059372;1259.055708218836;1272.4782839035952;956.1299217711988;1019.6074511313197;1020.6631811502335;1044.5247412427327;1047.8061558611682;6292.150559674477;6296.779612713533;6302.684865756785;6363.077353783676;6386.16979792624;440.88096214022033;451.07529564392865;454.3525476196407;455.89286517668984;460.3991790713085;4395.208862404734;4510.481294651091;4512.571305725951;4537.523560026216;4619.030003699194;11152.442377881236;11302.604408845651;11345.886541134483;11479.598214062467;11521.884781152248;11336.319820810777;11363;11387.316760994367;11389.259698119597;11407.429628518541;7979.880301795478;8363.790905227417;8371.41400101987;8545.829083418297;8600.698975535826;6291.96854015727;6512.869742605027;6546.476281897532;6584.308647592125;6626.072349870926;10514.57941682324;10550.419726914786;10600.25798194119;10622.787544249226;10704.197185211297;10052.64815731446;10448.582056717647;10524.421156836448;10718.517666705173;10763.408012559385;7287.890681639674;7735.845283094419;7990.6004699765945;8014.278714915686;8174.591270436335;9016.819663606822;9028.81942361136;9050.321225907952;9076.047015063587;9087.772805679911;7571.924280757342;7795.41534384912;7994.360451163777;8039.316658084128;8076.152004039492;7704.114026886979;7725.961370193113;7769.650365733669;7874.921250787648;8006.59967001636;6979.581225126509;7103.751368702071;7147.571145731273;7195.316444937723;7198.74804381865;4384.824607015684;4393.62654174386;4427.6236519896165;4428.468583769968;4428.778561071869;5291.100512912891;5571.526420254324;5629.483057135791;5668.404817494269;5746.597738158456 10:40:38 INFO - PROCESS | 14250 | |4;prototype.html;325.5019819675896;328.31873861736887;334.41644330643027;336.6566102575372;338.0770496544434;5661.235733176025;5714.799982000631;5756.913646295309;5781.508571771399;5812.738426770795;5622.678670512437;5693.800716974907;5708.857278568038;5716.456936591027;5727.599068065237;4197.496300443943;4321.351797230425;4376.496702879178;4394.8901277468;4395.208862404782;4353.934690979638;4371.475422949235;4371.7103454481;4381.561843815609;4407.360932664762;4364.236258654739;4365.476142862861;4374.737515749065;4379.956200438002;4397.406350142738;4288.463942007249;4338.457692788402;4350.825966961318;4363.018320877793;4374.212641724488;3815.313243616148;3816.580176180618;3823.388257878726;3862.864799732024;3868.497095377611;5562.610617256793;5574.247476590649;5594;5599.32808063031;5617.8033768817895;4833.782479788418;4965.801367945278;4966.205407134841;4974.651774375795;5046.646734728571;5870.823875283749;5872.295324561037;5877.823665290048;5927.110933359987;5932.614380065282;4214.536400995888;4216.64158546524;4222.704410691222;4232.936505952413;4238.894027649302;6004.769022350451;6125.264968203844;6154.784582539634;6157.291911430153;6158.445739883387;4289;4305.16049370376;4320.157569274024;4321.351797230378;4326.329418940069;4357.542458041923;4376.277914144131;4377.233984052778;4383.539728328544;4395.208862404734;4815.3499277597075;4976.850694479172;4979.751012449363;4994.300797888299;5020.1214787412055;5891.730089800117;5933.614315069507;5945.524358051432;6016.849578760566;6033.607815492067;1497.169071165492;1516.5374560758853;1533.9079655220723;1540.1837026376038;1541.3757428241356;959.194276807485;962.3119469579284;967.8451447768323;982.381099907054;991.7966816802539;5633.6619802811965;5700.629459085146;5721.084626459747;5740.856478588069;5756.280464941882;5909.763609455659;5969.552283578749;5989.281286245591;6003.279606447167;6012.669303188279;5526.171074338881;5661.820199223246;5661.943380566224;5680.8863822723315;5699;3174.1429813950567;3218.9839050804594;3221.130294820385;3237.838108094586;3248.9837550812094;5991.850203744854;6192.730490249488;6195.96902015487;6253.6560489172625;6255.655938923403;6112.51099912006;6119.571629985859;6165.859316026549;6204.5967012144065;6208.255009398901;5996.460318571262;6201.56589038772;6232.657203853741;6267;6269.937300626935;5964.777220669665;5998.190244316961;6035.18524999137;6040.818775436744;6041;5962.672053036951;5984.700764961822;5990.38259669878;5991.310999234969;6014.36849130835;5923.526117910471;6148.108524263867;6180.002698691221;6215.285242197025;6223.471004964629;4257.9148417030865;4259.42497762798;4259.510156332061;4267.103908179317;4281.828726850891;5890.911636325544;6039.48664363534;6048.334683184934;6063.636181829104;6065.909011364922;5791.623544469596;5800.535957123336;5816.883662326814;5845.1232315153065;5928.569286592477;5880.911786323294;5910.7931222407005;5921.230240068763;5955.285365756137;5961.105834124916;5305.867353316198;5791.7683292667825;5807.651540907559;5889.617174883619;5906.557008224487;5984.341722410619;6008;6012.579119461596;6021.133448630763;6026.216591843032;5625.409332020243;5791.507721843691;5825.155352473952;5845.240118784531;5847.44449277318 10:40:38 INFO - PROCESS | 14250 | |5;yui.html;751.4627041665211;772.2316295286189;778.3811869563697;809.8420807942446;876.9473831570108;15378.769318460218;16022.43921462746;16414.917925410355;16470.423535176255;16506;14434.06178598393;14540.054896431724;14583.562493125197;14591.197484138369;14629.853701462982;657.6843115304657;788.9684412623517;803.6062329458567;819.4796304346723;826.1944604011101;812.9105798362175;819.983600327993;821.1911267401605;823.3742355809568;824.1511243419287;856.9914300856974;858.0604238359018;859.8624220124781;860.6256278518833;861.2248975921658;841.5119230846125;844.7845799321195;849.6091797773032;851.3317046118798;851.6082602003024;628.1551313483358;629.408356145222;630.8927482328015;631.0313668518847;631.782035197856;14192.432302707879;14272.643183920381;14288.928555357157;14308;14311.499097531536;15116.470923517623;15174.696506069817;15189.088654680643;15214.923925380303;15635;12109.273443593325;12353.567625133168;12389.194702344319;12644.178128421716;13256.86743132566;3809.8285577148818;3813.103920578662;3837.347650899354;3908.8241029153755;3980.124372638044;78951.21048789553;79278;79704;79912.60043699744;80210.59894700548;10600.257981941344;10617.84073238902;11211.495482703298;11321.547138114383;11823.408829558488;20692.896535517226;20908.68636970447;20923;20952.58094838125;23046.7695323048;7861.371090312761;8231.259186673227;8399.202075802788;8629.827403451896;8965.865512017324;4910.8772280693265;4916.70499770015;4923.679960802537;5021.046001259749;5057.848264552069;3481.8433170507387;3632.9091772705365;3648.2338708870902;3651.123730304708;3669.6146904574634;626.7806267806232;646.12127506591;646.2600322630561;653.1182903080897;671.4292851076546;554.5314209492972;590.4803772680015;654.4175683641467;672.7611697847292;692.1175501235864;8869.645214191489;8924.776880578038;8979.371443998858;9183.95408022969;9196.08039196075;647.970841312142;649.1398896462207;662.6388618203091;673.373881647323;675.1796567170911;4243.68172387066;4249.405083288342;4307.138572285556;4339.978300108479;4434.397269297617;104614;115944;118590;118804.40597796955;121658;103429;103611.48194259132;103619.48190259;104589;104617.24605146638;65430.67284663546;88296;89286.55356723175;89542.55228723945;91256.08743912609;8445.66217351299;8463.873041904499;8603.365360581469;8616.328938029232;8685.397155740648;49446;49831.252531211336;51042;51858.48141518688;52360;66383;72779;75791;76650.2334976643;76739.61630191813;10619.256652034283;11062.889371106508;11107.166962477684;11165.832512512481;11429.657110286706;12787.104902656725;12822.23066616006;12834.55079072228;12914.547990820276;13173.209607423585;11974.22167559106;12031.578894738643;12153.756924861631;12518.436670350038;12553.623391298275;11900.285982841056;12087.879121208676;12143.332116733665;12492.25046497213;12639.87360126387;11822.172447928562;12009.979151772197;12127.636170914886;12589.559365422167;12630.43163057683;9500.619975200914;9595.088466595662;9680.75798105053;9746.26902982265;9838.803223935623;9460.479673618018;10269.383836969806;10338.638147664795;10351.534180962026;10446.164306855586 10:40:38 INFO - PROCESS | 14250 | __end_tp_report 10:40:38 INFO - PROCESS | 14250 | __start_cc_report 10:40:38 INFO - PROCESS | 14250 | _x_x_mozilla_cycle_collect,344 10:40:38 INFO - PROCESS | 14250 | __end_cc_report 10:40:38 INFO - PROCESS | 14250 | __startTimestamp1467826838076__endTimestamp 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | ------- Summary: start ------- 10:40:38 INFO - PROCESS | 14250 | Number of tests: 6 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#0] dojo.html Cycles:165 Average:5467.34 Median:5686.46 stddev:737.27 (13.0%) stddev-sans-first:716.31 10:40:38 INFO - PROCESS | 14250 | Values: 3127.1 3171.0 3172.2 3189.7 3201.2 5470.1 5482.3 5507.3 5572.4 5574.4 5402.5 5405.3 5481.2 5486.5 5502.9 5002.0 5013.1 5139.0 5185.9 5238.4 574.4 4993.2 5127.4 5149.0 5160.4 5003.2 5018.7 5040.1 5043.3 5066.8 4935.0 5032.4 5042.2 5048.8 5053.9 4968.8 4972.1 5001.1 5009.8 5028.7 5463.3 5487.3 5531.3 5555.4 5637.2 5720.4 5805.3 5936.6 5949.8 5965.4 5911.7 6025.3 6030.3 6031.1 6036.3 5584.8 5591.1 5594.3 5596.2 5601.6 5903.8 6022.7 6048.4 6084.1 6098.1 5879.1 5882.1 5888.5 5912.0 5937.6 5925.6 5970.8 5993.5 5994.3 5999.4 5756.1 5900.4 5982.8 6008.1 6013.6 5642.7 5861.4 5879.8 5886.0 5951.8 4472.2 4517.2 4524.5 4527.5 4551.8 3910.3 3914.3 3945.9 4018.2 4078.2 5537.5 5591.2 5631.8 5632.9 5673.0 5879.6 5928.2 5935.4 5949.0 5970.6 5510.1 5609.9 5629.0 5634.8 5652.6 5099.2 5115.2 5125.6 5136.2 5138.9 6160.2 6173.8 6178.9 6187.7 6199.5 5687.7 5861.0 5930.3 5942.4 5981.9 6068.8 6108.9 6110.0 6118.8 6121.6 5590.9 5819.2 5829.2 5849.2 5859.9 5707.6 5741.6 5870.7 5926.1 5961.5 5778.1 5795.1 5814.4 5823.5 5824.3 5770.4 5784.0 5793.9 5803.0 5816.9 5541.8 5575.1 5609.0 5652.3 5672.5 5745.0 5784.8 5804.7 5806.9 5814.9 5416.8 5686.5 5688.5 5697.5 5711.5 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#1] ext.html Cycles:180 Average:59588.66 Median:41259.59 stddev:121336.55 (294.1%) stddev-sans-first:121595.96 10:40:38 INFO - PROCESS | 14250 | Values: 547.3 571.9 599.5 608.7 639.2 36470.1 41171.0 41247.4 41256.4 41291.8 40492.8 41215.4 41259.4 41259.8 41287.2 8697.1 8815.0 8857.8 8865.7 8882.3 8824.4 8874.2 8880.8 8882.7 8894.6 8877.4 8916.4 8919.6 8933.1 8961.1 8848.6 8872.3 8877.9 8889.3 8921.6 8754.2 8820.0 8831.2 8847.6 8848.3 40968.6 41390.6 41447.0 41517.6 41526.2 3508.6 3678.8 3692.5 3777.6 4041.1 31455.2 32309.0 32337.7 33070.3 33676.0 4461.4 4468.1 4527.9 4549.9 4704.6 349766.3 350857.0 352968.0 354372.0 355093.0 33781.7 56344.0 57174.4 57183.4 57263.0 34446.7 36088.3 36210.3 36218.3 36293.8 14570.9 14584.1 14631.5 14653.3 14695.4 11807.6 11884.9 11903.9 11917.0 11918.6 8240.2 8243.3 8314.2 8316.0 8393.4 3202.3 3218.4 3234.5 3269.0 3337.2 1052.6 1052.7 1060.2 1113.6 1141.3 32781.0 33057.0 33202.3 33254.8 33518.5 1108.8 1136.1 1138.4 1162.7 1211.3 17184.7 17238.6 17398.7 17497.4 17551.4 540069.0 543035.0 549870.0 553074.0 554303.0 56734.0 57204.4 57208.4 57217.7 57277.0 1352.5 1384.8 1398.3 1404.2 1404.9 31375.2 32708.0 32761.5 32803.5 33101.8 49894.0 50149.2 50468.5 50477.0 50651.7 443493.0 447495.0 447538.0 448872.0 449735.0 27767.6 27937.3 28257.3 28422.7 28437.6 48255.5 48765.0 48905.3 48978.3 49804.3 41770.7 41779.0 42151.0 42420.0 42776.6 41263.8 41581.4 41583.0 42003.8 42182.4 40498.6 41018.0 41912.8 42065.0 42109.4 35779.0 36953.6 37367.8 37647.8 38071.0 27915.4 28405.7 28529.6 28645.6 28658.4 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#2] jquery.html Cycles:180 Average:30212.35 Median:12975.31 stddev:83526.56 (643.7%) stddev-sans-first:83730.85 10:40:38 INFO - PROCESS | 14250 | Values: 387.5 390.7 395.9 399.4 418.6 14523.9 18350.4 19917.2 20365.0 20419.0 19239.0 19546.5 19901.6 19979.3 20040.1 5739.3 5827.8 5836.6 5844.8 5846.9 5677.0 5761.8 5788.8 5842.2 5853.0 5679.6 5681.1 5821.5 5825.5 5827.8 5760.6 5760.9 5770.2 5779.8 5789.4 5072.7 5104.9 5183.4 5185.1 5195.9 23605.9 23634.5 23843.9 23941.2 24064.8 2344.7 2370.5 2376.3 2556.8 3077.7 14805.8 14881.6 14935.9 15181.5 15283.8 1925.5 1943.1 1951.6 1971.3 1997.5 83840.6 85805.6 86163.6 86309.6 87900.0 10070.0 10190.8 10467.2 10575.7 10589.3 13799.5 13868.5 13898.5 13922.3 14011.8 7807.2 8015.9 8082.3 8171.2 8316.0 7958.9 8073.2 8111.0 8303.8 8331.5 6550.7 6564.3 6579.7 6589.3 6616.4 1905.9 1908.8 1923.4 1980.0 1987.8 995.3 1069.4 1079.3 1083.6 1105.7 19992.7 20483.9 20702.9 20740.9 20860.3 1023.3 1045.3 1053.9 1070.9 1093.5 11310.4 11749.0 11776.3 11908.1 11915.5 499851.0 501118.0 505964.0 510135.0 510569.0 91691.7 96844.0 101969.0 102381.5 102456.0 1019.1 1035.0 1071.8 1076.7 1077.6 17567.8 17674.8 18080.9 18255.5 18316.3 37146.8 42455.0 45108.0 45902.8 47101.8 61216.4 61868.7 62501.4 63755.4 63850.0 7690.0 8286.5 8629.8 8678.9 8851.3 13522.2 13803.9 14367.6 14455.7 14564.6 6024.8 12126.4 12185.0 12265.0 12296.2 11899.8 12016.8 12080.8 12176.9 12551.2 12513.1 12625.7 12779.8 12828.2 12959.2 8056.5 8135.5 8143.8 8150.1 8336.8 6488.0 12220.6 12462.3 12605.6 12708.8 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#3] mootools.html Cycles:180 Average:5937.41 Median:4428.62 stddev:3492.77 (78.9%) stddev-sans-first:3486.38 10:40:38 INFO - PROCESS | 14250 | Values: 1461.6 1511.9 1633.9 1794.2 1801.2 7895.7 8614.0 8663.0 9188.3 9201.7 8709.6 8973.6 9004.6 9050.5 9050.7 2118.2 2144.7 2164.5 2164.8 2174.5 2182.4 2182.7 2248.1 2249.8 2250.4 2106.9 2123.4 2124.4 2125.6 2149.3 2128.4 2128.7 2140.6 2142.8 2143.0 2059.3 2081.4 2085.9 2105.2 2105.7 8969.6 9096.3 9101.7 9116.2 9116.4 5230.9 5325.8 5363.5 5364.8 5367.8 3247.9 3330.6 3360.4 3361.8 3418.5 1110.4 1133.5 1161.0 1163.3 1167.9 12725.7 12924.2 12939.4 12946.1 12948.6 4599.3 4611.5 4825.7 4831.8 4838.9 10760.1 10764.1 10775.6 10778.6 10780.7 5482.5 5488.3 5498.3 5502.4 5514.1 4361.8 4720.9 4867.8 5020.1 5030.8 3969.3 3994.9 4092.9 4113.7 4290.6 1219.4 1244.4 1253.9 1259.1 1272.5 956.1 1019.6 1020.7 1044.5 1047.8 6292.2 6296.8 6302.7 6363.1 6386.2 440.9 451.1 454.4 455.9 460.4 4395.2 4510.5 4512.6 4537.5 4619.0 11152.4 11302.6 11345.9 11479.6 11521.9 11336.3 11363.0 11387.3 11389.3 11407.4 7979.9 8363.8 8371.4 8545.8 8600.7 6292.0 6512.9 6546.5 6584.3 6626.1 10514.6 10550.4 10600.3 10622.8 10704.2 10052.6 10448.6 10524.4 10718.5 10763.4 7287.9 7735.8 7990.6 8014.3 8174.6 9016.8 9028.8 9050.3 9076.0 9087.8 7571.9 7795.4 7994.4 8039.3 8076.2 7704.1 7726.0 7769.7 7874.9 8006.6 6979.6 7103.8 7147.6 7195.3 7198.7 4384.8 4393.6 4427.6 4428.5 4428.8 5291.1 5571.5 5629.5 5668.4 5746.6 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#4] prototype.html Cycles:180 Average:4965.52 Median:5724.34 stddev:1465.09 (25.6%) stddev-sans-first:1427.20 10:40:38 INFO - PROCESS | 14250 | Values: 325.5 328.3 334.4 336.7 338.1 5661.2 5714.8 5756.9 5781.5 5812.7 5622.7 5693.8 5708.9 5716.5 5727.6 4197.5 4321.4 4376.5 4394.9 4395.2 4353.9 4371.5 4371.7 4381.6 4407.4 4364.2 4365.5 4374.7 4380.0 4397.4 4288.5 4338.5 4350.8 4363.0 4374.2 3815.3 3816.6 3823.4 3862.9 3868.5 5562.6 5574.2 5594.0 5599.3 5617.8 4833.8 4965.8 4966.2 4974.7 5046.6 5870.8 5872.3 5877.8 5927.1 5932.6 4214.5 4216.6 4222.7 4232.9 4238.9 6004.8 6125.3 6154.8 6157.3 6158.4 4289.0 4305.2 4320.2 4321.4 4326.3 4357.5 4376.3 4377.2 4383.5 4395.2 4815.3 4976.9 4979.8 4994.3 5020.1 5891.7 5933.6 5945.5 6016.8 6033.6 1497.2 1516.5 1533.9 1540.2 1541.4 959.2 962.3 967.8 982.4 991.8 5633.7 5700.6 5721.1 5740.9 5756.3 5909.8 5969.6 5989.3 6003.3 6012.7 5526.2 5661.8 5661.9 5680.9 5699.0 3174.1 3219.0 3221.1 3237.8 3249.0 5991.9 6192.7 6196.0 6253.7 6255.7 6112.5 6119.6 6165.9 6204.6 6208.3 5996.5 6201.6 6232.7 6267.0 6269.9 5964.8 5998.2 6035.2 6040.8 6041.0 5962.7 5984.7 5990.4 5991.3 6014.4 5923.5 6148.1 6180.0 6215.3 6223.5 4257.9 4259.4 4259.5 4267.1 4281.8 5890.9 6039.5 6048.3 6063.6 6065.9 5791.6 5800.5 5816.9 5845.1 5928.6 5880.9 5910.8 5921.2 5955.3 5961.1 5305.9 5791.8 5807.7 5889.6 5906.6 5984.3 6008.0 6012.6 6021.1 6026.2 5625.4 5791.5 5825.2 5845.2 5847.4 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - PROCESS | 14250 | [#5] yui.html Cycles:180 Average:20669.19 Median:4920.19 stddev:30563.38 (621.2%) stddev-sans-first:30612.53 10:40:38 INFO - PROCESS | 14250 | Values: 751.5 772.2 778.4 809.8 876.9 15378.8 16022.4 16414.9 16470.4 16506.0 14434.1 14540.1 14583.6 14591.2 14629.9 657.7 789.0 803.6 819.5 826.2 812.9 820.0 821.2 823.4 824.2 857.0 858.1 859.9 860.6 861.2 841.5 844.8 849.6 851.3 851.6 628.2 629.4 630.9 631.0 631.8 14192.4 14272.6 14288.9 14308.0 14311.5 15116.5 15174.7 15189.1 15214.9 15635.0 12109.3 12353.6 12389.2 12644.2 13256.9 3809.8 3813.1 3837.3 3908.8 3980.1 78951.2 79278.0 79704.0 79912.6 80210.6 10600.3 10617.8 11211.5 11321.5 11823.4 20692.9 20908.7 20923.0 20952.6 23046.8 7861.4 8231.3 8399.2 8629.8 8965.9 4910.9 4916.7 4923.7 5021.0 5057.8 3481.8 3632.9 3648.2 3651.1 3669.6 626.8 646.1 646.3 653.1 671.4 554.5 590.5 654.4 672.8 692.1 8869.6 8924.8 8979.4 9184.0 9196.1 648.0 649.1 662.6 673.4 675.2 4243.7 4249.4 4307.1 4340.0 4434.4 104614.0 115944.0 118590.0 118804.4 121658.0 103429.0 103611.5 103619.5 104589.0 104617.2 65430.7 88296.0 89286.6 89542.6 91256.1 8445.7 8463.9 8603.4 8616.3 8685.4 49446.0 49831.3 51042.0 51858.5 52360.0 66383.0 72779.0 75791.0 76650.2 76739.6 10619.3 11062.9 11107.2 11165.8 11429.7 12787.1 12822.2 12834.6 12914.5 13173.2 11974.2 12031.6 12153.8 12518.4 12553.6 11900.3 12087.9 12143.3 12492.3 12639.9 11822.2 12010.0 12127.6 12589.6 12630.4 9500.6 9595.1 9680.8 9746.3 9838.8 9460.5 10269.4 10338.6 10351.5 10446.2 10:40:38 INFO - PROCESS | 14250 | -------- Summary: end -------- 10:40:38 INFO - PROCESS | 14250 | 10:40:38 INFO - TEST-INFO | 14250: exit 0 10:40:38 INFO - TEST-OK | dromaeo_css | took 1110841ms 10:40:38 INFO - TEST-START | kraken 10:40:38 INFO - operating with platform_type : linux_ 10:40:38 INFO - Initialising browser for kraken test... 10:40:38 INFO - TEST-INFO | started process 14493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgR0GB/profile http://localhost:37403/getInfo.html) 10:40:43 INFO - PROCESS | 14493 | __metrics Screen width/height:1600/1200 10:40:43 INFO - PROCESS | 14493 | colorDepth:24 10:40:43 INFO - PROCESS | 14493 | Browser inner width/height: 1024/697 10:40:43 INFO - PROCESS | 14493 | __metrics 10:40:44 ERROR - PROCESS | 14493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 10:40:44 INFO - TEST-INFO | 14493: exit 0 10:40:44 INFO - Browser initialized. 10:40:44 INFO - Running cycle 1/1 for kraken test... 10:40:44 INFO - TEST-INFO | started process 14613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgR0GB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:56 INFO - PROCESS | 14613 | RSS: Main: 168603648 10:40:56 INFO - PROCESS | 14613 | 10:40:59 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37403/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:00 INFO - PROCESS | 14613 | RSS: Main: 173522944 10:41:00 INFO - PROCESS | 14613 | 10:41:02 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37403/tests/kraken/driver.html?testName=audio-dft) 10:41:03 INFO - PROCESS | 14613 | RSS: Main: 173248512 10:41:03 INFO - PROCESS | 14613 | 10:41:06 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37403/tests/kraken/driver.html?testName=audio-fft) 10:41:06 INFO - PROCESS | 14613 | RSS: Main: 167870464 10:41:06 INFO - PROCESS | 14613 | 10:41:09 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37403/tests/kraken/driver.html?testName=audio-oscillator) 10:41:09 INFO - PROCESS | 14613 | RSS: Main: 168947712 10:41:09 INFO - PROCESS | 14613 | 10:41:11 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:12 INFO - PROCESS | 14613 | RSS: Main: 168857600 10:41:12 INFO - PROCESS | 14613 | 10:41:15 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37403/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:16 INFO - PROCESS | 14613 | RSS: Main: 169226240 10:41:16 INFO - PROCESS | 14613 | 10:41:19 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37403/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:20 INFO - PROCESS | 14613 | RSS: Main: 169738240 10:41:20 INFO - PROCESS | 14613 | 10:41:23 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37403/tests/kraken/driver.html?testName=json-parse-financial) 10:41:23 INFO - PROCESS | 14613 | RSS: Main: 169738240 10:41:23 INFO - PROCESS | 14613 | 10:41:25 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:25 INFO - PROCESS | 14613 | RSS: Main: 169693184 10:41:25 INFO - PROCESS | 14613 | 10:41:27 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:28 INFO - PROCESS | 14613 | RSS: Main: 169807872 10:41:28 INFO - PROCESS | 14613 | 10:41:30 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:31 INFO - PROCESS | 14613 | RSS: Main: 170409984 10:41:31 INFO - PROCESS | 14613 | 10:41:33 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:34 INFO - PROCESS | 14613 | RSS: Main: 170098688 10:41:34 INFO - PROCESS | 14613 | 10:41:37 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:37 INFO - PROCESS | 14613 | RSS: Main: 170164224 10:41:37 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | Cycle 1(1): loaded http://localhost:37403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37403/tests/kraken/driver.html?testName=ai-astar) 10:41:39 INFO - PROCESS | 14613 | RSS: Main: 171335680 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | __start_tp_report 10:41:39 INFO - PROCESS | 14613 | _x_x_mozilla_page_load 10:41:39 INFO - PROCESS | 14613 | _x_x_mozilla_page_load_details 10:41:39 INFO - PROCESS | 14613 | |i|pagename|runs| 10:41:39 INFO - PROCESS | 14613 | |0;ai-astar;101;112;106;112;113;113;113;113;110;111 10:41:39 INFO - PROCESS | 14613 | |1;audio-beat-detection;150;115;143;183;118;148;145;120;180;120 10:41:39 INFO - PROCESS | 14613 | |2;audio-dft;163;161;162;164;164;170;175;163;166;162 10:41:39 INFO - PROCESS | 14613 | |3;audio-fft;75;75;75;167;75;75;76;78;176;76 10:41:39 INFO - PROCESS | 14613 | |4;audio-oscillator;86;85;147;85;84;84;145;84;84;150 10:41:39 INFO - PROCESS | 14613 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;121 10:41:39 INFO - PROCESS | 14613 | |6;imaging-darkroom;148;147;147;147;148;146;148;148;147;146 10:41:39 INFO - PROCESS | 14613 | |7;imaging-desaturate;95;97;95;96;96;96;95;96;95;95 10:41:39 INFO - PROCESS | 14613 | |8;json-parse-financial;56;56;62;57;57;59;55;59;58;55 10:41:39 INFO - PROCESS | 14613 | |9;json-stringify-tinderbox;63;63;62;64;63;61;63;62;65;62 10:41:39 INFO - PROCESS | 14613 | |10;stanford-crypto-aes;79;76;76;77;75;84;76;85;83;76 10:41:39 INFO - PROCESS | 14613 | |11;stanford-crypto-ccm;124;129;122;123;120;123;127;130;153;127 10:41:39 INFO - PROCESS | 14613 | |12;stanford-crypto-pbkdf2;159;158;156;159;156;157;161;168;156;158 10:41:39 INFO - PROCESS | 14613 | |13;stanford-crypto-sha256-iterative;65;67;64;68;65;63;67;65;61;63 10:41:39 INFO - PROCESS | 14613 | __end_tp_report 10:41:39 INFO - PROCESS | 14613 | __start_cc_report 10:41:39 INFO - PROCESS | 14613 | _x_x_mozilla_cycle_collect,946 10:41:39 INFO - PROCESS | 14613 | __end_cc_report 10:41:39 INFO - PROCESS | 14613 | __startTimestamp1467826899583__endTimestamp 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | ------- Summary: start ------- 10:41:39 INFO - PROCESS | 14613 | Number of tests: 14 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:2.30 10:41:39 INFO - PROCESS | 14613 | Values: 101.0 112.0 106.0 112.0 113.0 113.0 113.0 113.0 110.0 111.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:146.50 stddev:24.74 (16.9%) stddev-sans-first:26.08 10:41:39 INFO - PROCESS | 14613 | Values: 150.0 115.0 143.0 183.0 118.0 148.0 145.0 120.0 180.0 120.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.35 (2.7%) stddev-sans-first:4.55 10:41:39 INFO - PROCESS | 14613 | Values: 163.0 161.0 162.0 164.0 164.0 170.0 175.0 163.0 166.0 162.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:40.49 (54.0%) stddev-sans-first:42.31 10:41:39 INFO - PROCESS | 14613 | Values: 75.0 75.0 75.0 167.0 75.0 75.0 76.0 78.0 176.0 76.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.00 stddev:30.35 (36.1%) stddev-sans-first:31.53 10:41:39 INFO - PROCESS | 14613 | Values: 86.0 85.0 147.0 85.0 84.0 84.0 145.0 84.0 84.0 150.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 10:41:39 INFO - PROCESS | 14613 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 121.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:41:39 INFO - PROCESS | 14613 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 148.0 148.0 147.0 146.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:41:39 INFO - PROCESS | 14613 | Values: 95.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.17 (3.8%) stddev-sans-first:2.24 10:41:39 INFO - PROCESS | 14613 | Values: 56.0 56.0 62.0 57.0 57.0 59.0 55.0 59.0 58.0 55.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 10:41:39 INFO - PROCESS | 14613 | Values: 63.0 63.0 62.0 64.0 63.0 61.0 63.0 62.0 65.0 62.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:3.83 (4.9%) stddev-sans-first:4.06 10:41:39 INFO - PROCESS | 14613 | Values: 79.0 76.0 76.0 77.0 75.0 84.0 76.0 85.0 83.0 76.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.00 stddev:9.41 (7.4%) stddev-sans-first:9.88 10:41:39 INFO - PROCESS | 14613 | Values: 124.0 129.0 122.0 123.0 120.0 123.0 127.0 130.0 153.0 127.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:3.61 (2.3%) stddev-sans-first:3.83 10:41:39 INFO - PROCESS | 14613 | Values: 159.0 158.0 156.0 159.0 156.0 157.0 161.0 168.0 156.0 158.0 10:41:39 INFO - PROCESS | 14613 | 10:41:39 INFO - PROCESS | 14613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:2.15 (3.3%) stddev-sans-first:2.28 10:41:39 INFO - PROCESS | 14613 | Values: 65.0 67.0 64.0 68.0 65.0 63.0 67.0 65.0 61.0 63.0 10:41:39 INFO - PROCESS | 14613 | -------- Summary: end -------- 10:41:39 INFO - PROCESS | 14613 | 10:41:40 INFO - TEST-INFO | 14613: exit 0 10:41:40 INFO - TEST-OK | kraken | took 61716ms 10:41:40 INFO - SUITE-END | took 1172s 10:41:40 INFO - Completed test suite (00:19:32) 10:41:40 INFO - javascript benchmark 10:41:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.988037672177, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.10877399941, 3170.9524357134646, 3172.175234439045, 3189.728873045791, 3201.215702152973, 5470.12478003519, 5482.342118945727, 5507.339119305684, 5572.442755724425, 5574.414686457924, 5402.513773760361, 5405.297311349529, 5481.205225242337, 5486.463790138758, 5502.944970550293, 5002.0, 5013.097642424362, 5139.049275883974, 5185.896282074356, 5238.4499627539135, 574.4385131696359, 4993.226049962262, 5127.384713834345, 5149.0, 5160.406553246368, 5003.199488081889, 5018.723970181639, 5040.092783299005, 5043.268726034741, 5066.847994560132, 4935.0, 5032.396112466491, 5042.243663450512, 5048.848534543969, 5053.8736531587, 4968.776405061781, 4972.080165169419, 5001.074801161797, 5009.849704508871, 5028.698278103326, 5463.289772329572, 5487.341519017704, 5531.308586426697, 5555.388907220243, 5637.154426835967, 5720.427957204288, 5805.303363596353, 5936.584439089265, 5949.8215053548465, 5965.433283838029, 5911.704414779244, 6025.276966764016, 6030.306514750816, 6031.1254868044325, 6036.3360030396625, 5584.776608935678, 5591.077472217079, 5594.300712410949, 5596.2165296858475, 5601.551875849963, 5903.822885313448, 6022.698865056817, 6048.395160483917, 6084.117802918552, 6098.085287206865, 5879.088741245114, 5882.058870580687, 5888.4700376966275, 5911.9704401478575, 5937.643741375531, 5925.555583331267, 5970.761169553256, 5993.460588547052, 5994.310654274815, 5999.400059994053, 5756.0502517084215, 5900.380460051719, 5982.820515384546, 6008.068749343859, 6013.609115407485, 5642.7178641067785, 5861.3552509223955, 5879.764809407576, 5886.028805247086, 5951.7619295227705, 4472.172648060119, 4517.209488339593, 4524.547545245515, 4527.547245275446, 4551.795169217327, 3910.276598829226, 3914.2562913047, 3945.9013524662114, 4018.1561872007205, 4078.2455245779624, 5537.529310008695, 5591.189277554732, 5631.802886898939, 5632.859178520488, 5673.035583950738, 5879.559033072536, 5928.170056192136, 5935.40645935403, 5948.958932186936, 5970.611910225822, 5510.090835012258, 5609.943900560942, 5629.0, 5634.802781902696, 5652.604317697722, 5099.209622508517, 5115.181570948705, 5125.64120511568, 5136.178211486144, 5138.871528211825, 6160.168377269101, 6173.783917562864, 6178.907316390258, 6187.690615469209, 6199.504039676815, 5687.744051517609, 5860.970695146497, 5930.347661757117, 5942.435468630473, 5981.910271346021, 6068.787592434243, 6108.908366374419, 6110.0, 6118.816435506942, 6121.571489995657, 5590.888182236251, 5819.185314055951, 5829.213056237354, 5849.210356601974, 5859.853503662272, 5707.6290041147195, 5741.598088133791, 5870.706464676664, 5926.140709597171, 5961.463468287875, 5778.104393818965, 5795.1017592273265, 5814.418558144152, 5823.475887170175, 5824.271966004249, 5770.365259821332, 5783.971080144573, 5793.855153621024, 5803.0, 5816.8947899898885, 5541.833744987657, 5575.052241118939, 5609.018421776254, 5652.3217213934595, 5672.461116193955, 5745.0, 5784.82645520635, 5804.738786754522, 5806.854828629318, 5814.883702325845, 5416.8104116355735, 5686.459786320293, 5688.54491640676, 5697.4587414195585, 5711.5145212655725], "value": 5419.395221290076, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.306212715345, 571.9056355701309, 599.4694695194752, 608.6591508755098, 639.1786554277754, 36470.08824779382, 41171.0, 41247.38128928068, 41256.38115428271, 41291.79354103225, 40492.79753601228, 41215.38176927341, 41259.381109283386, 41259.793701031456, 41287.17425651485, 8697.08680588537, 8814.955925220365, 8857.822843543125, 8865.734027979139, 8882.333824963154, 8824.426412283214, 8874.20132188103, 8880.822383552326, 8882.689105881296, 8894.555272236395, 8877.378583499158, 8916.375853690244, 8919.643214271422, 8933.10668933108, 8961.148690874388, 8848.646054157825, 8872.334574906843, 8877.911220887772, 8889.333300002494, 8921.598528066253, 8754.212120909086, 8819.955900220459, 8831.205191532792, 8847.646094156225, 8848.336374771854, 40968.59031409678, 41390.58609413898, 41447.0, 41517.58482415167, 41526.1694766106, 3508.6491350864962, 3678.7792732435873, 3692.5015122958594, 3777.6411240932066, 4041.0503531670033, 31455.213619659462, 32309.0, 32337.736358454917, 33070.338593228, 33676.0, 4461.353103799964, 4468.084042771224, 4527.909441811145, 4549.863504094849, 4704.5765881070865, 349766.25116874505, 350857.0, 352968.0, 354372.0, 355093.0, 33781.66218337785, 56344.0, 57174.42825571774, 57183.428165718644, 57263.0, 34446.65553344485, 36088.27823443569, 36210.27579448396, 36218.27563448716, 36293.81853090718, 14570.85429145695, 14584.124952502672, 14631.536846315283, 14653.267336633126, 14695.412183512753, 11807.645770626896, 11884.881151188378, 11903.940480297717, 11917.046636269077, 11918.582849600223, 8240.175982401832, 8243.340532757366, 8314.168583141758, 8316.043654979754, 8393.412461127662, 3202.343519578481, 3218.3885061838178, 3234.498652708834, 3269.019294211727, 3337.249118948217, 1052.552665117322, 1052.6947185316174, 1060.2366296266675, 1113.554578168739, 1141.275290190735, 32781.0, 33057.0, 33202.3359532808, 33254.83372583122, 33518.49722254119, 1108.8004159251411, 1136.108155098244, 1138.4403367386567, 1162.7267592115845, 1211.2671833540758, 17184.742228866326, 17238.569035774206, 17398.739018914726, 17497.38759143424, 17551.385701500385, 540069.0, 543035.0, 549870.0, 553074.0, 554303.0, 56734.0, 57204.42795572074, 57208.42791572031, 57217.713911430175, 57277.0, 1352.4995751571785, 1384.7715127004133, 1398.3427788939182, 1404.1876305829721, 1404.936777844979, 31375.215619608778, 32708.0, 32761.508577371835, 32803.507947380334, 33101.834490827394, 49894.0, 50149.24776128288, 50468.49531504785, 50477.0, 50651.74674126753, 443493.0, 447495.0, 447538.0, 448872.0, 449735.0, 27767.583486247317, 27937.301567460978, 28257.293567660974, 28422.715772842006, 28437.573436398885, 48255.517444825105, 48765.0, 48905.266421003005, 48978.26532601943, 49804.25293620526, 41770.70380502362, 41779.0, 42151.0, 42420.0, 42776.57223427726, 41263.793681031406, 41581.37627935523, 41583.0, 42003.7899810499, 42182.36726449044, 40498.59501404948, 41018.0, 41912.790436047624, 42065.0, 42109.36835947402, 35779.0, 36953.630463695015, 37367.81316093402, 37647.81176094102, 38071.0, 27915.44169116647, 28405.715942840307, 28529.572056418754, 28645.570316445686, 28658.426831462835], "value": 18922.879832967516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.51560549313365, 390.66598058659827, 395.9128991621844, 399.35504160780346, 418.62114786118553, 14523.92738036311, 18350.44948651541, 19917.203311867506, 20365.0, 20419.0, 19239.0, 19546.511337216576, 19901.601967960632, 19979.300724474648, 20040.0981955812, 5739.282589676301, 5827.766889324422, 5836.562257830658, 5844.766209351621, 5846.9183201107935, 5677.0, 5761.827145185651, 5788.768449262025, 5842.152887831262, 5852.9707351463185, 5679.5740319476, 5681.091025435931, 5821.505172060359, 5825.5048320892565, 5827.796027139051, 5760.567957403212, 5760.8847823043725, 5770.2210201622875, 5779.768809247625, 5789.421057894198, 5072.67027643202, 5104.923426148611, 5183.377994640629, 5185.118529849935, 5195.896082078338, 23605.88197059004, 23634.527309453886, 23843.88078059616, 23941.162059328013, 24064.75935240643, 2344.7303560090636, 2370.4903445759073, 2376.3346263046374, 2556.846589204654, 3077.692230776927, 14805.777913331309, 14881.627959300995, 14935.925320373437, 15181.468648597245, 15283.770743438858, 1925.4993701637675, 1943.0867492278605, 1951.6194342103295, 1971.280482623832, 1997.5405656698895, 83840.58079709623, 85805.57097214536, 86163.56918215432, 86309.56845215797, 87900.0, 10070.0, 10190.796184076276, 10467.214958878114, 10575.682729518127, 10589.258751887448, 13799.51701690436, 13868.514601988882, 13898.51355202563, 13922.303884805922, 14011.789823152661, 7807.219278072147, 8015.879761803578, 8082.31300339466, 8171.223733745284, 8315.95842020786, 7958.920410795818, 8073.192680731997, 8111.0, 8303.792405189797, 8331.54176520285, 6550.737970481127, 6564.343565643398, 6579.703913323912, 6589.308122647149, 6616.4045235929, 1905.904704764784, 1908.7709474862827, 1923.422973108062, 1980.0396807548327, 1987.8210961013579, 995.2883688162854, 1069.4492336446735, 1079.271491743086, 1083.5990683447176, 1105.7346236903086, 19992.700109498368, 20483.897580512003, 20702.896485517475, 20740.896295518727, 20860.269890553758, 1023.2939271902363, 1045.278757657214, 1053.931494452858, 1070.9089727373105, 1093.491526440209, 11310.377929213972, 11749.0, 11776.293422394683, 11908.106891983136, 11915.463804128834, 499851.0, 501118.0, 505964.0, 510135.0, 510569.0, 91691.69069305655, 96844.0, 101969.0, 102381.48809256055, 102456.0, 1019.0980981831133, 1034.9793004139874, 1071.796358691846, 1076.7200527862656, 1077.6282182646974, 17567.82432175713, 17674.823251767317, 18080.90959545194, 18255.452336429396, 18316.26734930588, 37146.8142659285, 42455.0, 45108.0, 45902.77048614869, 47101.764491177324, 61216.387836121066, 61868.69065654823, 62501.37498625137, 63755.362446374944, 63850.04224936537, 7689.9615501922135, 8286.544240066612, 8629.784255393666, 8678.913210867811, 8851.291896648125, 13522.18866867991, 13803.861961380659, 14367.568972930829, 14455.710885782435, 14564.563063108124, 6024.789132380346, 12126.393680315772, 12185.0, 12265.018798495921, 12296.20074695142, 11899.762004759683, 12016.759664806481, 12080.75838483208, 12176.939115304367, 12551.184173028723, 12513.124081314221, 12625.747485050431, 12779.808302875279, 12828.230306181658, 12959.222446653232, 8056.516609003478, 8135.471194372347, 8143.83712325762, 8150.062742784418, 8336.83326333482, 6488.0, 12220.572279970158, 12462.31457269859, 12605.621831345074, 12708.809367859674], "value": 9574.973017165505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.634591352162, 1511.9319630616621, 1633.901965882047, 1794.2195145111868, 1801.234475347976, 7895.723649672263, 8614.0, 8662.95668521658, 9188.310876684242, 9201.723948281546, 8709.608067636957, 8973.596188171532, 9004.594793234304, 9050.456972581633, 9050.72847814565, 2118.1739121742494, 2144.6997420361163, 2164.5021645021657, 2164.8159906407973, 2174.5433458973635, 2182.4434769133927, 2182.6507758758603, 2248.1007596961263, 2249.7862703043265, 2250.3811451850706, 2106.8946552672382, 2123.384218576619, 2124.3945475539476, 2125.5855108253895, 2149.269248455525, 2128.414685961365, 2128.6700561413004, 2140.56118495708, 2142.828573714099, 2142.978570214309, 2059.3101311060814, 2081.354780018199, 2085.937421877331, 2105.1684584589, 2105.673620588811, 8969.641214351419, 9096.272298216192, 9101.681441149594, 9116.179543841086, 9116.361854670176, 5230.869228269324, 5325.760340784674, 5363.517283444469, 5364.8122315718765, 5367.785288588452, 3247.9188020299443, 3330.6169790474164, 3360.4455264881267, 3361.8319084045943, 3418.4701371287492, 1110.4059328259343, 1133.4899295317057, 1161.0479406886357, 1163.3136449494755, 1167.8890505401973, 12725.745485090247, 12924.224546527144, 12939.353032348345, 12946.093773435863, 12948.611541653765, 4599.264117741145, 4611.469680986663, 4825.686330388584, 4831.830885918976, 4838.854834354975, 10760.139188864872, 10764.13886889047, 10775.568977240979, 10778.622748203776, 10780.676579702622, 5482.479164479368, 5488.341399032061, 5498.285222921075, 5502.449755024546, 5514.062609356419, 4361.825526978949, 4720.905581888412, 4867.780949857265, 5020.071286811952, 5030.773615187325, 3969.3450580653866, 3994.8601798936897, 4092.856750013735, 4113.650339721097, 4290.592393722592, 1219.4390580333147, 1244.402686710366, 1253.893419059372, 1259.055708218836, 1272.4782839035952, 956.1299217711988, 1019.6074511313197, 1020.6631811502335, 1044.5247412427327, 1047.8061558611682, 6292.150559674477, 6296.779612713533, 6302.684865756785, 6363.077353783676, 6386.16979792624, 440.88096214022033, 451.07529564392865, 454.3525476196407, 455.89286517668984, 460.3991790713085, 4395.208862404734, 4510.481294651091, 4512.571305725951, 4537.523560026216, 4619.030003699194, 11152.442377881236, 11302.604408845651, 11345.886541134483, 11479.598214062467, 11521.884781152248, 11336.319820810777, 11363.0, 11387.316760994367, 11389.259698119597, 11407.429628518541, 7979.880301795478, 8363.790905227417, 8371.41400101987, 8545.829083418297, 8600.698975535826, 6291.96854015727, 6512.869742605027, 6546.476281897532, 6584.308647592125, 6626.072349870926, 10514.57941682324, 10550.419726914786, 10600.25798194119, 10622.787544249226, 10704.197185211297, 10052.64815731446, 10448.582056717647, 10524.421156836448, 10718.517666705173, 10763.408012559385, 7287.890681639674, 7735.845283094419, 7990.6004699765945, 8014.278714915686, 8174.591270436335, 9016.819663606822, 9028.81942361136, 9050.321225907952, 9076.047015063587, 9087.772805679911, 7571.924280757342, 7795.41534384912, 7994.360451163777, 8039.316658084128, 8076.152004039492, 7704.114026886979, 7725.961370193113, 7769.650365733669, 7874.921250787648, 8006.59967001636, 6979.581225126509, 7103.751368702071, 7147.571145731273, 7195.316444937723, 7198.74804381865, 4384.824607015684, 4393.62654174386, 4427.6236519896165, 4428.468583769968, 4428.778561071869, 5291.100512912891, 5571.526420254324, 5629.483057135791, 5668.404817494269, 5746.597738158456], "value": 4606.9804061617915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.5019819675896, 328.31873861736887, 334.41644330643027, 336.6566102575372, 338.0770496544434, 5661.235733176025, 5714.799982000631, 5756.913646295309, 5781.508571771399, 5812.738426770795, 5622.678670512437, 5693.800716974907, 5708.857278568038, 5716.456936591027, 5727.599068065237, 4197.496300443943, 4321.351797230425, 4376.496702879178, 4394.8901277468, 4395.208862404782, 4353.934690979638, 4371.475422949235, 4371.7103454481, 4381.561843815609, 4407.360932664762, 4364.236258654739, 4365.476142862861, 4374.737515749065, 4379.956200438002, 4397.406350142738, 4288.463942007249, 4338.457692788402, 4350.825966961318, 4363.018320877793, 4374.212641724488, 3815.313243616148, 3816.580176180618, 3823.388257878726, 3862.864799732024, 3868.497095377611, 5562.610617256793, 5574.247476590649, 5594.0, 5599.32808063031, 5617.8033768817895, 4833.782479788418, 4965.801367945278, 4966.205407134841, 4974.651774375795, 5046.646734728571, 5870.823875283749, 5872.295324561037, 5877.823665290048, 5927.110933359987, 5932.614380065282, 4214.536400995888, 4216.64158546524, 4222.704410691222, 4232.936505952413, 4238.894027649302, 6004.769022350451, 6125.264968203844, 6154.784582539634, 6157.291911430153, 6158.445739883387, 4289.0, 4305.16049370376, 4320.157569274024, 4321.351797230378, 4326.329418940069, 4357.542458041923, 4376.277914144131, 4377.233984052778, 4383.539728328544, 4395.208862404734, 4815.3499277597075, 4976.850694479172, 4979.751012449363, 4994.300797888299, 5020.1214787412055, 5891.730089800117, 5933.614315069507, 5945.524358051432, 6016.849578760566, 6033.607815492067, 1497.169071165492, 1516.5374560758853, 1533.9079655220723, 1540.1837026376038, 1541.3757428241356, 959.194276807485, 962.3119469579284, 967.8451447768323, 982.381099907054, 991.7966816802539, 5633.6619802811965, 5700.629459085146, 5721.084626459747, 5740.856478588069, 5756.280464941882, 5909.763609455659, 5969.552283578749, 5989.281286245591, 6003.279606447167, 6012.669303188279, 5526.171074338881, 5661.820199223246, 5661.943380566224, 5680.8863822723315, 5699.0, 3174.1429813950567, 3218.9839050804594, 3221.130294820385, 3237.838108094586, 3248.9837550812094, 5991.850203744854, 6192.730490249488, 6195.96902015487, 6253.6560489172625, 6255.655938923403, 6112.51099912006, 6119.571629985859, 6165.859316026549, 6204.5967012144065, 6208.255009398901, 5996.460318571262, 6201.56589038772, 6232.657203853741, 6267.0, 6269.937300626935, 5964.777220669665, 5998.190244316961, 6035.18524999137, 6040.818775436744, 6041.0, 5962.672053036951, 5984.700764961822, 5990.38259669878, 5991.310999234969, 6014.36849130835, 5923.526117910471, 6148.108524263867, 6180.002698691221, 6215.285242197025, 6223.471004964629, 4257.9148417030865, 4259.42497762798, 4259.510156332061, 4267.103908179317, 4281.828726850891, 5890.911636325544, 6039.48664363534, 6048.334683184934, 6063.636181829104, 6065.909011364922, 5791.623544469596, 5800.535957123336, 5816.883662326814, 5845.1232315153065, 5928.569286592477, 5880.911786323294, 5910.7931222407005, 5921.230240068763, 5955.285365756137, 5961.105834124916, 5305.867353316198, 5791.7683292667825, 5807.651540907559, 5889.617174883619, 5906.557008224487, 5984.341722410619, 6008.0, 6012.579119461596, 6021.133448630763, 6026.216591843032, 5625.409332020243, 5791.507721843691, 5825.155352473952, 5845.240118784531, 5847.44449277318], "value": 4490.379684712592, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.4627041665211, 772.2316295286189, 778.3811869563697, 809.8420807942446, 876.9473831570108, 15378.769318460218, 16022.43921462746, 16414.917925410355, 16470.423535176255, 16506.0, 14434.06178598393, 14540.054896431724, 14583.562493125197, 14591.197484138369, 14629.853701462982, 657.6843115304657, 788.9684412623517, 803.6062329458567, 819.4796304346723, 826.1944604011101, 812.9105798362175, 819.983600327993, 821.1911267401605, 823.3742355809568, 824.1511243419287, 856.9914300856974, 858.0604238359018, 859.8624220124781, 860.6256278518833, 861.2248975921658, 841.5119230846125, 844.7845799321195, 849.6091797773032, 851.3317046118798, 851.6082602003024, 628.1551313483358, 629.408356145222, 630.8927482328015, 631.0313668518847, 631.782035197856, 14192.432302707879, 14272.643183920381, 14288.928555357157, 14308.0, 14311.499097531536, 15116.470923517623, 15174.696506069817, 15189.088654680643, 15214.923925380303, 15635.0, 12109.273443593325, 12353.567625133168, 12389.194702344319, 12644.178128421716, 13256.86743132566, 3809.8285577148818, 3813.103920578662, 3837.347650899354, 3908.8241029153755, 3980.124372638044, 78951.21048789553, 79278.0, 79704.0, 79912.60043699744, 80210.59894700548, 10600.257981941344, 10617.84073238902, 11211.495482703298, 11321.547138114383, 11823.408829558488, 20692.896535517226, 20908.68636970447, 20923.0, 20952.58094838125, 23046.7695323048, 7861.371090312761, 8231.259186673227, 8399.202075802788, 8629.827403451896, 8965.865512017324, 4910.8772280693265, 4916.70499770015, 4923.679960802537, 5021.046001259749, 5057.848264552069, 3481.8433170507387, 3632.9091772705365, 3648.2338708870902, 3651.123730304708, 3669.6146904574634, 626.7806267806232, 646.12127506591, 646.2600322630561, 653.1182903080897, 671.4292851076546, 554.5314209492972, 590.4803772680015, 654.4175683641467, 672.7611697847292, 692.1175501235864, 8869.645214191489, 8924.776880578038, 8979.371443998858, 9183.95408022969, 9196.08039196075, 647.970841312142, 649.1398896462207, 662.6388618203091, 673.373881647323, 675.1796567170911, 4243.68172387066, 4249.405083288342, 4307.138572285556, 4339.978300108479, 4434.397269297617, 104614.0, 115944.0, 118590.0, 118804.40597796955, 121658.0, 103429.0, 103611.48194259132, 103619.48190259, 104589.0, 104617.24605146638, 65430.67284663546, 88296.0, 89286.55356723175, 89542.55228723945, 91256.08743912609, 8445.66217351299, 8463.873041904499, 8603.365360581469, 8616.328938029232, 8685.397155740648, 49446.0, 49831.252531211336, 51042.0, 51858.48141518688, 52360.0, 66383.0, 72779.0, 75791.0, 76650.2334976643, 76739.61630191813, 10619.256652034283, 11062.889371106508, 11107.166962477684, 11165.832512512481, 11429.657110286706, 12787.104902656725, 12822.23066616006, 12834.55079072228, 12914.547990820276, 13173.209607423585, 11974.22167559106, 12031.578894738643, 12153.756924861631, 12518.436670350038, 12553.623391298275, 11900.285982841056, 12087.879121208676, 12143.332116733665, 12492.25046497213, 12639.87360126387, 11822.172447928562, 12009.979151772197, 12127.636170914886, 12589.559365422167, 12630.43163057683, 9500.619975200914, 9595.088466595662, 9680.75798105053, 9746.26902982265, 9838.803223935623, 9460.479673618018, 10269.383836969806, 10338.638147664795, 10351.534180962026, 10446.164306855586], "value": 7345.845387948078, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 106.0, 112.0, 113.0, 113.0, 113.0, 113.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 143.0, 183.0, 118.0, 148.0, 145.0, 120.0, 180.0, 120.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 164.0, 170.0, 175.0, 163.0, 166.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 167.0, 75.0, 75.0, 76.0, 78.0, 176.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 147.0, 85.0, 84.0, 84.0, 145.0, 84.0, 84.0, 150.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 121.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 148.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 62.0, 57.0, 57.0, 59.0, 55.0, 59.0, 58.0, 55.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 63.0, 61.0, 63.0, 62.0, 65.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 76.0, 77.0, 75.0, 84.0, 76.0, 85.0, 83.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 122.0, 123.0, 120.0, 123.0, 127.0, 130.0, 153.0, 127.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 156.0, 159.0, 156.0, 157.0, 161.0, 168.0, 156.0, 158.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 68.0, 65.0, 63.0, 67.0, 65.0, 61.0, 63.0], "value": 64.8, "unit": "score"}]}]} 10:41:40 INFO - Return code: 0 10:41:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:41:40 ERROR - # TBPL SUCCESS # 10:41:40 INFO - Running post-action listener: _resource_record_post_action 10:41:40 INFO - ##### 10:41:40 INFO - ##### Finished run-tests step (success) 10:41:40 INFO - ##### 10:41:40 INFO - Running post-run listener: _resource_record_post_run 10:41:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 563818496; Read time: 0; Write time: 548268 10:41:40 INFO - TinderboxPrint: CPU usage
13.3% 10:41:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:41:40 INFO - TinderboxPrint: I/O write bytes / time
563,818,496 / 548,268 10:41:40 INFO - TinderboxPrint: CPU idle
8,230.2 (86.7%) 10:41:40 INFO - TinderboxPrint: CPU user
1,212.0 (12.8%) 10:41:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:41:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267591680; Read time: 0; Write time: 271600 10:41:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 296226816; Read time: 0; Write time: 276668 10:41:41 INFO - Running post-run listener: _upload_blobber_files 10:41:41 INFO - Blob upload gear active. 10:41:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:41:41 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'] 10:41:41 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 10:41:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:42 INFO - (blobuploader) - INFO - Done attempting. 10:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:46 INFO - (blobuploader) - INFO - Done attempting. 10:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:46 INFO - (blobuploader) - INFO - Done attempting. 10:41:46 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:46 INFO - Return code: 0 10:41:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36832ff5dcd4249352d525fb9bd0f6313d1efb1780a9e382f08b164d1d25e05911611dcb0d4ed8f7e73fefe65dc1d7a6b372f9caa2f5d4bf9ce7547f88a7e54d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bac4389f7a8b10c8e94d8ec81f591df96e5b6f9a8bd23a51fb2f4640581fb96db7dc0cd15a0b328553b067f778a5c41f88921874168cf02cda11397e11f07a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88676f62417d01c4889c5fc8dfea27f94b47db29ce9a0b5f8e4ec0ade9836d745a4b2837980298e7d1ac40ac8a94fda0b1c7bc03ca54165cd0461b9a93ba8397"} 10:41:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:46 INFO - Contents: 10:41:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36832ff5dcd4249352d525fb9bd0f6313d1efb1780a9e382f08b164d1d25e05911611dcb0d4ed8f7e73fefe65dc1d7a6b372f9caa2f5d4bf9ce7547f88a7e54d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bac4389f7a8b10c8e94d8ec81f591df96e5b6f9a8bd23a51fb2f4640581fb96db7dc0cd15a0b328553b067f778a5c41f88921874168cf02cda11397e11f07a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88676f62417d01c4889c5fc8dfea27f94b47db29ce9a0b5f8e4ec0ade9836d745a4b2837980298e7d1ac40ac8a94fda0b1c7bc03ca54165cd0461b9a93ba8397"} 10:41:46 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:46 INFO - Copying logs to upload dir... 10:41:46 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.055912 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-06 10:41:47.038000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:41:47.041625) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 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/36832ff5dcd4249352d525fb9bd0f6313d1efb1780a9e382f08b164d1d25e05911611dcb0d4ed8f7e73fefe65dc1d7a6b372f9caa2f5d4bf9ce7547f88a7e54d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bac4389f7a8b10c8e94d8ec81f591df96e5b6f9a8bd23a51fb2f4640581fb96db7dc0cd15a0b328553b067f778a5c41f88921874168cf02cda11397e11f07a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88676f62417d01c4889c5fc8dfea27f94b47db29ce9a0b5f8e4ec0ade9836d745a4b2837980298e7d1ac40ac8a94fda0b1c7bc03ca54165cd0461b9a93ba8397"} build_url:https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/ZMXeu16IQxGfTmzNoOk0fg/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/36832ff5dcd4249352d525fb9bd0f6313d1efb1780a9e382f08b164d1d25e05911611dcb0d4ed8f7e73fefe65dc1d7a6b372f9caa2f5d4bf9ce7547f88a7e54d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bac4389f7a8b10c8e94d8ec81f591df96e5b6f9a8bd23a51fb2f4640581fb96db7dc0cd15a0b328553b067f778a5c41f88921874168cf02cda11397e11f07a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88676f62417d01c4889c5fc8dfea27f94b47db29ce9a0b5f8e4ec0ade9836d745a4b2837980298e7d1ac40ac8a94fda0b1c7bc03ca54165cd0461b9a93ba8397"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:41:47.071892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:41:47.072651) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467825620.629448-1339705441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:41:47.157027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:41:47.157703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:41:47.158349) ========= ========= Total master_lag: 0.18 =========