builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1468941791.12 results: success (0) buildid: 20160719070321 builduid: 6dcc9418a9ba4f6a988882a6618acef9 revision: 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.122228) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.122719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.123006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.138361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.138749) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 08:23:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-19 08:23:11 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.245597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.245942) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.296358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.296710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 --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=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 08:23:11,646 truncating revision to first 12 chars 2016-07-19 08:23:11,646 Setting DEBUG logging. 2016-07-19 08:23:11,646 attempt 1/10 2016-07-19 08:23:11,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37cc0da01187?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 08:23:11,950 unpacking tar archive at: mozilla-central-37cc0da01187/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.960743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.961127) ========= script_repo_revision: 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.961575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.961876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:23:11.972346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-19 08:23:11.972752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:12 INFO - MultiFileLogger online at 20160719 08:23:12 in /builds/slave/test 08:23:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:23:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:12 INFO - {'append_to_log': False, 08:23:12 INFO - 'base_work_dir': '/builds/slave/test', 08:23:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:23:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:12 INFO - 'branch': 'Firefox-Non-PGO', 08:23:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:12 INFO - 'config_files': ('talos/linux_config.py',), 08:23:12 INFO - 'default_actions': ('clobber', 08:23:12 INFO - 'read-buildbot-config', 08:23:12 INFO - 'download-and-extract', 08:23:12 INFO - 'populate-webroot', 08:23:12 INFO - 'create-virtualenv', 08:23:12 INFO - 'install', 08:23:12 INFO - 'run-tests'), 08:23:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:12 INFO - 'download_minidump_stackwalk': True, 08:23:12 INFO - 'download_symbols': 'ondemand', 08:23:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:12 INFO - 'installer_path': 'installer.exe', 08:23:12 INFO - 'log_level': 'info', 08:23:12 INFO - 'log_name': 'talos', 08:23:12 INFO - 'log_to_console': True, 08:23:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:12 INFO - 'opt_config_files': (), 08:23:12 INFO - 'pip_index': False, 08:23:12 INFO - 'sps_profile': False, 08:23:12 INFO - 'sps_profile_interval': 0, 08:23:12 INFO - 'suite': 'dromaeojs-e10s', 08:23:12 INFO - 'system_bits': '32', 08:23:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:12 INFO - 'title': 'talos-linux64-ix-019', 08:23:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:12 INFO - 'use_talos_json': True, 08:23:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:12 INFO - 'work_dir': 'build'} 08:23:12 INFO - ##### 08:23:12 INFO - ##### Running clobber step. 08:23:12 INFO - ##### 08:23:12 INFO - Running pre-action listener: _resource_record_pre_action 08:23:12 INFO - Running main action method: clobber 08:23:12 INFO - rmtree: /builds/slave/test/build 08:23:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:12 INFO - Running post-action listener: _resource_record_post_action 08:23:12 INFO - ##### 08:23:12 INFO - ##### Finished clobber step (success) 08:23:12 INFO - ##### 08:23:12 INFO - ##### 08:23:12 INFO - ##### Running read-buildbot-config step. 08:23:12 INFO - ##### 08:23:12 INFO - Running pre-action listener: _resource_record_pre_action 08:23:12 INFO - Running main action method: read_buildbot_config 08:23:12 INFO - Using buildbot properties: 08:23:12 INFO - { 08:23:12 INFO - "project": "", 08:23:12 INFO - "product": "firefox", 08:23:12 INFO - "script_repo_revision": "production", 08:23:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:23:12 INFO - "repository": "", 08:23:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:23:12 INFO - "buildid": "20160719070321", 08:23:12 INFO - "pgo_build": "False", 08:23:12 INFO - "basedir": "/builds/slave/test", 08:23:12 INFO - "buildnumber": 383, 08:23:12 INFO - "slavename": "talos-linux64-ix-019", 08:23:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:23:12 INFO - "platform": "ubuntu64_hw", 08:23:12 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:23:12 INFO - "branch": "mozilla-central", 08:23:12 INFO - "repo_path": "mozilla-central", 08:23:12 INFO - "revision": "37cc0da01187534ea9f8d384c0c9c5c57eb67b56", 08:23:12 INFO - "stage_platform": "linux64", 08:23:12 INFO - "builduid": "6dcc9418a9ba4f6a988882a6618acef9", 08:23:12 INFO - "slavebuilddir": "test" 08:23:12 INFO - } 08:23:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:23:12 INFO - Running post-action listener: _resource_record_post_action 08:23:12 INFO - ##### 08:23:12 INFO - ##### Finished read-buildbot-config step (success) 08:23:12 INFO - ##### 08:23:12 INFO - ##### 08:23:12 INFO - ##### Running download-and-extract step. 08:23:12 INFO - ##### 08:23:12 INFO - Running pre-action listener: _resource_record_pre_action 08:23:12 INFO - Running main action method: download_and_extract 08:23:12 INFO - mkdir: /builds/slave/test/build/tests 08:23:12 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')]} 08:23:12 INFO - https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:13 INFO - Downloaded 1361 bytes. 08:23:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:23:13 INFO - Using the following test package requirements: 08:23:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:23:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'jsshell-linux-x86_64.zip'], 08:23:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:13 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')]} 08:23:13 INFO - https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:14 INFO - Downloaded 22765022 bytes. 08:23:14 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'] 08:23:14 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 08:23:16 INFO - Return code: 0 08:23:16 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 08:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:16 INFO - https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:17 INFO - Downloaded 22765022 bytes. 08:23:17 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'] 08:23:17 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 08:23:19 INFO - Return code: 0 08:23: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')]} 08:23:19 INFO - https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:20 INFO - Downloaded 14403317 bytes. 08:23:20 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'] 08:23:20 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 08:23:20 INFO - Return code: 0 08:23: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')]} 08:23:20 INFO - https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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 08:23:22 INFO - Downloaded 57139771 bytes. 08:23:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:23:22 INFO - mkdir: /builds/slave/test/properties 08:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:22 INFO - Contents: 08:23:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:23:23 INFO - Running post-action listener: _resource_record_post_action 08:23:23 INFO - Running post-action listener: set_extra_try_arguments 08:23:23 INFO - ##### 08:23:23 INFO - ##### Finished download-and-extract step (success) 08:23:23 INFO - ##### 08:23:23 INFO - ##### 08:23:23 INFO - ##### Running populate-webroot step. 08:23:23 INFO - ##### 08:23:23 INFO - Running pre-action listener: _resource_record_pre_action 08:23:23 INFO - Running main action method: populate_webroot 08:23:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:23 INFO - '--tppagecycles', 08:23:23 INFO - '7'], 08:23:23 INFO - 'tests': ['tsvgm']}}, 08:23:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['damp', 'tps']}, 08:23:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'tests': ['damp', 'tps']}, 08:23:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['dromaeo_dom']}, 08:23:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['basic_compositor_video']}, 08:23:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['a11yr', 08:23:23 INFO - 'ts_paint', 08:23:23 INFO - 'tpaint', 08:23:23 INFO - 'sessionrestore', 08:23:23 INFO - 'sessionrestore_no_auto_restore', 08:23:23 INFO - 'tabpaint']}, 08:23:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['tsvgx', 08:23:23 INFO - 'tsvgr_opacity', 08:23:23 INFO - 'tart', 08:23:23 INFO - 'tscrollx', 08:23:23 INFO - 'cart']}, 08:23:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:23 INFO - 'tsvgr_opacity', 08:23:23 INFO - 'tart', 08:23:23 INFO - 'tscrollx', 08:23:23 INFO - 'cart']}, 08:23:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'talos_options': ['--disable-e10s'], 08:23:23 INFO - 'tests': ['tp5o']}, 08:23:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'tests': ['tp5o']}, 08:23:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'talos_options': ['--disable-e10s', 08:23:23 INFO - '--xperf_path', 08:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:23 INFO - 'tests': ['tp5n']}, 08:23:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:23 INFO - 'talos_options': ['--xperf_path', 08:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:23 INFO - 'tests': ['tp5n']}}, 08:23:23 INFO - 'talos.zip': {'path': '', 08:23:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:23 INFO - Running post-action listener: _resource_record_post_action 08:23:23 INFO - ##### 08:23:23 INFO - ##### Finished populate-webroot step (success) 08:23:23 INFO - ##### 08:23:23 INFO - ##### 08:23:23 INFO - ##### Running create-virtualenv step. 08:23:23 INFO - ##### 08:23:23 INFO - Running pre-action listener: _resource_record_pre_action 08:23:23 INFO - Running main action method: create_virtualenv 08:23:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:23 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 08:23:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:23 INFO - Using real prefix '/usr' 08:23:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:25 INFO - Installing pip.................done. 08:23:25 INFO - Return code: 0 08:23:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:25 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:25 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 08:23:25 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 08:23:25 INFO - Using env: {'DISPLAY': ':0', 08:23:25 INFO - 'HOME': '/home/cltbld', 08:23:25 INFO - 'LANG': 'en_US.UTF-8', 08:23:25 INFO - 'LANGUAGE': 'en_US:en', 08:23:25 INFO - 'LOGNAME': 'cltbld', 08:23:25 INFO - 'MAIL': '/var/mail/cltbld', 08:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:25 INFO - 'MOZ_NO_REMOTE': '1', 08:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:25 INFO - 'NO_EM_RESTART': '1', 08:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:25 INFO - 'PWD': '/builds/slave/test', 08:23:25 INFO - 'SHELL': '/bin/bash', 08:23:25 INFO - 'SHLVL': '1', 08:23:25 INFO - 'TERM': 'linux', 08:23:25 INFO - 'TMOUT': '86400', 08:23:25 INFO - 'USER': 'cltbld', 08:23:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:25 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 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 08:23:26 INFO - Cleaning up... 08:23:26 INFO - Return code: 0 08:23:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:26 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 08:23:26 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 08:23:26 INFO - Using env: {'DISPLAY': ':0', 08:23:26 INFO - 'HOME': '/home/cltbld', 08:23:26 INFO - 'LANG': 'en_US.UTF-8', 08:23:26 INFO - 'LANGUAGE': 'en_US:en', 08:23:26 INFO - 'LOGNAME': 'cltbld', 08:23:26 INFO - 'MAIL': '/var/mail/cltbld', 08:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:26 INFO - 'MOZ_NO_REMOTE': '1', 08:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:26 INFO - 'NO_EM_RESTART': '1', 08:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:26 INFO - 'PWD': '/builds/slave/test', 08:23:26 INFO - 'SHELL': '/bin/bash', 08:23:26 INFO - 'SHLVL': '1', 08:23:26 INFO - 'TERM': 'linux', 08:23:26 INFO - 'TMOUT': '86400', 08:23:26 INFO - 'USER': 'cltbld', 08:23:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:26 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 INFO - Downloading/unpacking psutil>=3.1.1 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:26 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 08:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:28 INFO - Installing collected packages: psutil 08:23:28 INFO - Running setup.py install for psutil 08:23:28 INFO - building 'psutil._psutil_linux' extension 08:23:28 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 08:23:28 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 08:23:28 INFO - building 'psutil._psutil_posix' extension 08:23:28 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 08:23:29 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 08:23:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:29 INFO - Successfully installed psutil 08:23:29 INFO - Cleaning up... 08:23:29 INFO - Return code: 0 08:23:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:29 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 08:23:29 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 08:23:29 INFO - Using env: {'DISPLAY': ':0', 08:23:29 INFO - 'HOME': '/home/cltbld', 08:23:29 INFO - 'LANG': 'en_US.UTF-8', 08:23:29 INFO - 'LANGUAGE': 'en_US:en', 08:23:29 INFO - 'LOGNAME': 'cltbld', 08:23:29 INFO - 'MAIL': '/var/mail/cltbld', 08:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:29 INFO - 'MOZ_NO_REMOTE': '1', 08:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:29 INFO - 'NO_EM_RESTART': '1', 08:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:29 INFO - 'PWD': '/builds/slave/test', 08:23:29 INFO - 'SHELL': '/bin/bash', 08:23:29 INFO - 'SHLVL': '1', 08:23:29 INFO - 'TERM': 'linux', 08:23:29 INFO - 'TMOUT': '86400', 08:23:29 INFO - 'USER': 'cltbld', 08:23:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:29 INFO - '_': '/tools/buildbot/bin/python'} 08:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:29 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 08:23:29 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 08:23:29 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 08:23:29 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 08:23:29 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 08:23:29 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 08:23:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:31 INFO - Installing collected packages: mozsystemmonitor 08:23:31 INFO - Running setup.py install for mozsystemmonitor 08:23:31 INFO - Successfully installed mozsystemmonitor 08:23:31 INFO - Cleaning up... 08:23:31 INFO - Return code: 0 08:23:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', '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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:23: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 jsonschema==2.5.1 08:23:31 INFO - Using env: {'DISPLAY': ':0', 08:23:31 INFO - 'HOME': '/home/cltbld', 08:23:31 INFO - 'LANG': 'en_US.UTF-8', 08:23:31 INFO - 'LANGUAGE': 'en_US:en', 08:23:31 INFO - 'LOGNAME': 'cltbld', 08:23:31 INFO - 'MAIL': '/var/mail/cltbld', 08:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:31 INFO - 'MOZ_NO_REMOTE': '1', 08:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:31 INFO - 'NO_EM_RESTART': '1', 08:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:31 INFO - 'PWD': '/builds/slave/test', 08:23:31 INFO - 'SHELL': '/bin/bash', 08:23:31 INFO - 'SHLVL': '1', 08:23:31 INFO - 'TERM': 'linux', 08:23:31 INFO - 'TMOUT': '86400', 08:23:31 INFO - 'USER': 'cltbld', 08:23:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:31 INFO - '_': '/tools/buildbot/bin/python'} 08:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:33 INFO - warning: no files found matching '*.txt' 08:23:33 INFO - no previously-included directories found matching 'build' 08:23:33 INFO - no previously-included directories found matching 'dist' 08:23:33 INFO - no previously-included directories found matching '.git*' 08:23:33 INFO - Installing collected packages: jsonschema, functools32 08:23:33 INFO - Running setup.py install for functools32 08:23:33 INFO - warning: no files found matching '*.txt' 08:23:33 INFO - no previously-included directories found matching 'build' 08:23:33 INFO - no previously-included directories found matching 'dist' 08:23:33 INFO - no previously-included directories found matching '.git*' 08:23:33 INFO - Successfully installed jsonschema functools32 08:23:33 INFO - Cleaning up... 08:23:34 INFO - Return code: 0 08:23:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', '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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23: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 blobuploader==1.2.4 08:23:34 INFO - Using env: {'DISPLAY': ':0', 08:23:34 INFO - 'HOME': '/home/cltbld', 08:23:34 INFO - 'LANG': 'en_US.UTF-8', 08:23:34 INFO - 'LANGUAGE': 'en_US:en', 08:23:34 INFO - 'LOGNAME': 'cltbld', 08:23:34 INFO - 'MAIL': '/var/mail/cltbld', 08:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:34 INFO - 'MOZ_NO_REMOTE': '1', 08:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:34 INFO - 'NO_EM_RESTART': '1', 08:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:34 INFO - 'PWD': '/builds/slave/test', 08:23:34 INFO - 'SHELL': '/bin/bash', 08:23:34 INFO - 'SHLVL': '1', 08:23:34 INFO - 'TERM': 'linux', 08:23:34 INFO - 'TMOUT': '86400', 08:23:34 INFO - 'USER': 'cltbld', 08:23:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:34 INFO - '_': '/tools/buildbot/bin/python'} 08:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:36 INFO - Downloading docopt-0.6.1.tar.gz 08:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:36 INFO - Running setup.py install for blobuploader 08:23:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:37 INFO - Running setup.py install for requests 08:23:37 INFO - Running setup.py install for docopt 08:23:37 INFO - Successfully installed blobuploader requests docopt 08:23:37 INFO - Cleaning up... 08:23:37 INFO - Return code: 0 08:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:37 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:37 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 08:23:37 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 08:23:37 INFO - Using env: {'DISPLAY': ':0', 08:23:37 INFO - 'HOME': '/home/cltbld', 08:23:37 INFO - 'LANG': 'en_US.UTF-8', 08:23:37 INFO - 'LANGUAGE': 'en_US:en', 08:23:37 INFO - 'LOGNAME': 'cltbld', 08:23:37 INFO - 'MAIL': '/var/mail/cltbld', 08:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:37 INFO - 'MOZ_NO_REMOTE': '1', 08:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:37 INFO - 'NO_EM_RESTART': '1', 08:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:37 INFO - 'PWD': '/builds/slave/test', 08:23:37 INFO - 'SHELL': '/bin/bash', 08:23:37 INFO - 'SHLVL': '1', 08:23:37 INFO - 'TERM': 'linux', 08:23:37 INFO - 'TMOUT': '86400', 08:23:37 INFO - 'USER': 'cltbld', 08:23:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:37 INFO - '_': '/tools/buildbot/bin/python'} 08:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:37 INFO - Running setup.py (path:/tmp/pip-VyDoOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:37 INFO - Running setup.py (path:/tmp/pip-gcat79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:37 INFO - Running setup.py (path:/tmp/pip-pfIewA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:37 INFO - Running setup.py (path:/tmp/pip-nRdb_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:38 INFO - Running setup.py (path:/tmp/pip-n1F3OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:38 INFO - Running setup.py (path:/tmp/pip-9BaOVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:38 INFO - Running setup.py (path:/tmp/pip-v2XYlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:38 INFO - Running setup.py (path:/tmp/pip-dr_7HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:38 INFO - Running setup.py (path:/tmp/pip-VE1Y14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:38 INFO - Running setup.py (path:/tmp/pip-jBIyBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:38 INFO - Running setup.py (path:/tmp/pip-yifbWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:38 INFO - Running setup.py (path:/tmp/pip-H_wapv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:38 INFO - Running setup.py (path:/tmp/pip-E4PllC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:38 INFO - Running setup.py (path:/tmp/pip-D7xqmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:38 INFO - Running setup.py (path:/tmp/pip-RQkUey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:38 INFO - Running setup.py (path:/tmp/pip-FWFLNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:38 INFO - Running setup.py (path:/tmp/pip-wt1owA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:38 INFO - Running setup.py install for manifestparser 08:23:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Running setup.py install for mozcrash 08:23:39 INFO - Running setup.py install for mozdebug 08:23:39 INFO - Running setup.py install for mozdevice 08:23:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Running setup.py install for mozfile 08:23:39 INFO - Running setup.py install for mozhttpd 08:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Running setup.py install for mozinfo 08:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Running setup.py install for mozInstall 08:23:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:39 INFO - Running setup.py install for mozleak 08:23:39 INFO - Running setup.py install for mozlog 08:23:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Running setup.py install for moznetwork 08:23:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Running setup.py install for mozprocess 08:23:40 INFO - Running setup.py install for mozprofile 08:23:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Running setup.py install for mozrunner 08:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Running setup.py install for mozscreenshot 08:23:40 INFO - Running setup.py install for moztest 08:23:40 INFO - Running setup.py install for mozversion 08:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:40 INFO - Cleaning up... 08:23:40 INFO - Return code: 0 08:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:40 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:40 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 08:23:40 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 08:23:40 INFO - Using env: {'DISPLAY': ':0', 08:23:40 INFO - 'HOME': '/home/cltbld', 08:23:40 INFO - 'LANG': 'en_US.UTF-8', 08:23:40 INFO - 'LANGUAGE': 'en_US:en', 08:23:40 INFO - 'LOGNAME': 'cltbld', 08:23:40 INFO - 'MAIL': '/var/mail/cltbld', 08:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:40 INFO - 'MOZ_NO_REMOTE': '1', 08:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:40 INFO - 'NO_EM_RESTART': '1', 08:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:40 INFO - 'PWD': '/builds/slave/test', 08:23:40 INFO - 'SHELL': '/bin/bash', 08:23:40 INFO - 'SHLVL': '1', 08:23:40 INFO - 'TERM': 'linux', 08:23:40 INFO - 'TMOUT': '86400', 08:23:40 INFO - 'USER': 'cltbld', 08:23:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:40 INFO - '_': '/tools/buildbot/bin/python'} 08:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:41 INFO - Running setup.py (path:/tmp/pip-7xHokq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:41 INFO - Running setup.py (path:/tmp/pip-6pbMba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:41 INFO - Running setup.py (path:/tmp/pip-AZAxsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:41 INFO - Running setup.py (path:/tmp/pip-Woq1je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:41 INFO - Running setup.py (path:/tmp/pip-8KAYbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:41 INFO - Running setup.py (path:/tmp/pip-_UrJ3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:41 INFO - Running setup.py (path:/tmp/pip-rVfE3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:41 INFO - Running setup.py (path:/tmp/pip-yXqYu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:41 INFO - Running setup.py (path:/tmp/pip-9SAUOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:41 INFO - Running setup.py (path:/tmp/pip-SbYUlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:41 INFO - Running setup.py (path:/tmp/pip-sXK9l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:41 INFO - Running setup.py (path:/tmp/pip-qmX3XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:41 INFO - Running setup.py (path:/tmp/pip-DRlzBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:41 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)) 08:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:41 INFO - Running setup.py (path:/tmp/pip-8sAoYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:42 INFO - Running setup.py (path:/tmp/pip-N7RR12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:42 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)) 08:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:42 INFO - Running setup.py (path:/tmp/pip-anYD8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:42 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)) 08:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:42 INFO - Running setup.py (path:/tmp/pip-O4dMfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:42 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)) 08:23:42 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)) 08:23:42 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)) 08:23:42 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)) 08:23:42 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)) 08:23:42 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)) 08:23:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:44 INFO - Downloading blessings-1.6.tar.gz 08:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:44 INFO - Installing collected packages: blessings 08:23:44 INFO - Running setup.py install for blessings 08:23:44 INFO - Successfully installed blessings 08:23:44 INFO - Cleaning up... 08:23:44 INFO - Return code: 0 08:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:44 INFO - Reading from file tmpfile_stdout 08:23:44 INFO - Current package versions: 08:23:44 INFO - argparse == 1.2.1 08:23:44 INFO - blessings == 1.6 08:23:44 INFO - blobuploader == 1.2.4 08:23:44 INFO - docopt == 0.6.1 08:23:44 INFO - functools32 == 3.2.3-2 08:23:44 INFO - jsonschema == 2.5.1 08:23:44 INFO - manifestparser == 1.1 08:23:44 INFO - mozInstall == 1.12 08:23:44 INFO - mozcrash == 0.17 08:23:44 INFO - mozdebug == 0.1 08:23:44 INFO - mozdevice == 0.48 08:23:44 INFO - mozfile == 1.2 08:23:44 INFO - mozhttpd == 0.7 08:23:44 INFO - mozinfo == 0.9 08:23:44 INFO - mozleak == 0.1 08:23:44 INFO - mozlog == 3.3 08:23:44 INFO - moznetwork == 0.27 08:23:44 INFO - mozprocess == 0.23 08:23:44 INFO - mozprofile == 0.28 08:23:44 INFO - mozrunner == 6.12 08:23:44 INFO - mozscreenshot == 0.1 08:23:44 INFO - mozsystemmonitor == 0.3 08:23:44 INFO - moztest == 0.7 08:23:44 INFO - mozversion == 1.4 08:23:44 INFO - psutil == 3.1.1 08:23:44 INFO - requests == 1.2.3 08:23:44 INFO - wsgiref == 0.1.2 08:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:44 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')]} 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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')]} 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:44 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 08:23:44 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 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 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)) 08:23:44 INFO - Cleaning up... 08:23:44 INFO - Return code: 0 08:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:44 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')]} 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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')]} 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', '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 08:23:44 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 08:23:44 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 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:45 INFO - Cleaning up... 08:23:45 INFO - Return code: 0 08:23:45 INFO - Running post-action listener: _resource_record_post_action 08:23:45 INFO - Running post-action listener: _start_resource_monitoring 08:23:45 INFO - Starting resource monitoring. 08:23:45 INFO - ##### 08:23:45 INFO - ##### Finished create-virtualenv step (success) 08:23:45 INFO - ##### 08:23:45 INFO - ##### 08:23:45 INFO - ##### Running install step. 08:23:45 INFO - ##### 08:23:45 INFO - Running pre-action listener: _resource_record_pre_action 08:23:45 INFO - Running main action method: install 08:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:45 INFO - Reading from file tmpfile_stdout 08:23:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:45 INFO - Reading from file tmpfile_stdout 08:23:45 INFO - Output received: 08:23:45 INFO - Usage: mozinstall [options] installer 08:23:45 INFO - Options: 08:23:45 INFO - -h, --help show this help message and exit 08:23:45 INFO - -d DEST, --destination=DEST 08:23:45 INFO - Directory to install application into. [default: 08:23:45 INFO - "/builds/slave/test"] 08:23:45 INFO - --app=APP Application being installed. [default: firefox] 08:23:45 INFO - mkdir: /builds/slave/test/build/application 08:23:45 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'] 08:23:45 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 08:24:01 INFO - Reading from file tmpfile_stdout 08:24:01 INFO - Output received: 08:24:01 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:01 INFO - Running post-action listener: _resource_record_post_action 08:24:01 INFO - ##### 08:24:01 INFO - ##### Finished install step (success) 08:24:01 INFO - ##### 08:24:01 INFO - ##### 08:24:01 INFO - ##### Running run-tests step. 08:24:01 INFO - ##### 08:24:01 INFO - Running pre-action listener: _resource_record_pre_action 08:24:01 INFO - Running main action method: run_tests 08:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:01 INFO - Python 2.7.3 08:24:01 INFO - Return code: 0 08:24:01 INFO - grabbing minidump binary from tooltool 08:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:01 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 0x1ff0570>, '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 0x1ff1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:01 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 08:24:01 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 08:24:01 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 08:24:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:01 INFO - Return code: 0 08:24:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:24:01 INFO - Using env: {'DISPLAY': ':0', 08:24:01 INFO - 'HOME': '/home/cltbld', 08:24:01 INFO - 'LANG': 'en_US.UTF-8', 08:24:01 INFO - 'LANGUAGE': 'en_US:en', 08:24:01 INFO - 'LOGNAME': 'cltbld', 08:24:01 INFO - 'MAIL': '/var/mail/cltbld', 08:24:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:01 INFO - 'MOZ_NO_REMOTE': '1', 08:24:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:01 INFO - 'NO_EM_RESTART': '1', 08:24:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:01 INFO - 'PWD': '/builds/slave/test', 08:24:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:01 INFO - 'SHELL': '/bin/bash', 08:24:01 INFO - 'SHLVL': '1', 08:24:01 INFO - 'TERM': 'linux', 08:24:01 INFO - 'TMOUT': '86400', 08:24:01 INFO - 'USER': 'cltbld', 08:24:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756', 08:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:01 INFO - '_': '/tools/buildbot/bin/python'} 08:24:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:24:02 INFO - mozversion application_buildid: 20160719070321 08:24:02 INFO - mozversion application_changeset: 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 08:24:02 INFO - mozversion application_display_name: Nightly 08:24:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:02 INFO - mozversion application_name: Firefox 08:24:02 INFO - mozversion application_remotingname: firefox 08:24:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:24:02 INFO - mozversion application_vendor: Mozilla 08:24:02 INFO - mozversion application_version: 50.0a1 08:24:02 INFO - mozversion platform_buildid: 20160719070321 08:24:02 INFO - mozversion platform_changeset: 37cc0da01187534ea9f8d384c0c9c5c57eb67b56 08:24:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:24:02 INFO - mozversion platform_version: 50.0a1 08:24:02 INFO - using testdate: 1468941842 08:24:02 INFO - actual date: 1468941842 08:24:02 INFO - starting webserver on 'localhost:44444' 08:24:02 INFO - SUITE-START | Running 2 tests 08:24:02 INFO - TEST-START | dromaeo_css 08:24:02 INFO - operating with platform_type : linux_ 08:24:02 INFO - Initialising browser for dromaeo_css test... 08:24:02 INFO - TEST-INFO | started process 25058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47eigU/profile http://localhost:44444/getInfo.html) 08:24:07 INFO - PROCESS | 25058 | __metrics Screen width/height:1600/1200 08:24:07 INFO - PROCESS | 25058 | colorDepth:24 08:24:07 INFO - PROCESS | 25058 | Browser inner width/height: 1024/697 08:24:07 INFO - PROCESS | 25058 | __metrics 08:24:07 ERROR - PROCESS | 25058 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:24:08 INFO - TEST-INFO | 25058: exit 0 08:24:08 INFO - Browser initialized. 08:24:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:08 INFO - TEST-INFO | started process 25176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47eigU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:20 INFO - PROCESS | 25176 | RSS: Main: 168595456 08:24:20 INFO - PROCESS | 25176 | 08:25:10 INFO - PROCESS | 25176 | 1468941910356 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] 08:27:23 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44444/tests/dromaeo/cssquery-ext.html) 08:27:24 INFO - PROCESS | 25176 | RSS: Main: 170266624 08:27:24 INFO - PROCESS | 25176 | 08:30:26 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-ext.html (next: http://localhost:44444/tests/dromaeo/cssquery-jquery.html) 08:30:27 INFO - PROCESS | 25176 | RSS: Main: 169820160 08:30:27 INFO - PROCESS | 25176 | 08:33:29 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44444/tests/dromaeo/cssquery-mootools.html) 08:33:29 INFO - PROCESS | 25176 | RSS: Main: 172363776 08:33:29 INFO - PROCESS | 25176 | 08:36:31 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44444/tests/dromaeo/cssquery-prototype.html) 08:36:32 INFO - PROCESS | 25176 | RSS: Main: 167649280 08:36:32 INFO - PROCESS | 25176 | 08:39:35 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44444/tests/dromaeo/cssquery-yui.html) 08:39:35 INFO - PROCESS | 25176 | RSS: Main: 168882176 08:39:35 INFO - PROCESS | 25176 | 08:42:38 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:44444/tests/dromaeo/cssquery-yui.html (next: http://localhost:44444/tests/dromaeo/cssquery-dojo.html) 08:42:38 INFO - PROCESS | 25176 | RSS: Main: 170430464 08:42:38 INFO - PROCESS | 25176 | 08:42:38 INFO - PROCESS | 25176 | __start_tp_report 08:42:38 INFO - PROCESS | 25176 | _x_x_mozilla_page_load 08:42:38 INFO - PROCESS | 25176 | _x_x_mozilla_page_load_details 08:42:38 INFO - PROCESS | 25176 | |i|pagename|runs| 08:42:38 INFO - PROCESS | 25176 | |0;dojo.html;2571.6785401824773;2637.5384307746144;2642.4847154804797;2671.3321669582606;2681.45030268795;4703.5061318561575;4762.976185119074;4840.4191497020365;4842.394700662418;4862.319275301452;4653.930191047137;4699.835505757299;4727.432708075027;4788.976055119728;4843.079814835179;4423.292273236283;4468.195724769532;4469.530699276578;4500.279955207167;4539.4098767160385;645.2505791146634;4527.2530032544755;4542.114287713897;4547.545245475442;4571.9314210286875;4383.452068491439;4464.598186163261;4481.126180394825;4491.797869095866;4513.255312873372;4441.600255976945;4456.621187199092;4456.955430445686;4470.865874023784;4505.43682039745;4233.7883105844585;4429.623482004034;4430.579094985971;4457.442819647544;4479.3504941783585;4713.033828065239;4724.362211101526;4749.810007599692;4764.523547645243;4810.39870016248;5066.847994560169;5161.8193363232485;5169.948300517022;5189.987952349294;5197.870053248699;5102.974485127551;5131.281620573122;5185.2999845021195;5185.844424667266;5220.060389129955;4801.063792560487;4805.495422980606;4808.422989241313;4847.61219102478;4855.417349918032;5233.633645644844;5276.868078298074;5280.419153893069;5283.498067683564;5285.68285902847;5024.422191447957;5037.19404895215;5040.39515258164;5080.949190508121;5102.872428189325;5148.227765835155;5150.97424512875;5162.97418512905;5164.483551644806;5242.9737851311265;4972.279019542146;5143.897122057613;5148.794048238028;5151.124308867502;5162.199859021857;5124.48755124492;5137;5150.356205474316;5189.481051894781;5195.818146364934;4235.42821719064;4407.669424793154;4422.690411671152;4441.977790111029;4486.192485352668;3881.573026967031;3895.610438956082;3896.3571010782903;3911.2177564487215;3912.1197730510407;4279.507856596531;4385.736855788663;4386.407834942242;4398.956010439854;4439.711418757771;5129.820456284012;5161.612879034087;5220.738963051832;5220.92168617471;5233.058049551041;4366.607005369532;4429.180601588717;4451.643868490513;4460.553944605578;4479.395281637003;4509.098180363941;4627.467841198305;4628.861134165981;4629.051044535862;4707.199776038082;4869.586085182799;4904.2643603459055;4906.1659517881335;4922.138625740553;4938.654294199371;5188.948110518846;5194.532492075731;5201.063808514504;5215;5260.579153667621;4693.436787585511;4907.877303067452;4924.901501969869;4928.359313289249;4937.506249375034;5158.6131040171385;5178;5203.687778733288;5205.427402985744;5278.736063196901;5266.236395722675;5272.9736351318;5299.629025968299;5337.919931201112;5363.27595774581;4885.389326334208;5022.296878436949;5051.267566202807;5148.6910785353;5151.819686311111;5045.369328833895;5083.822066227664;5096.643234973664;5112.079825631274;5132;4932.679375840559;5003.224500202475;5036.597072234139;5049.974750126373;5056;4871.537203965618;4941.407031156285;5006.824761133343;5007.649464537593;5152.407473140637;4943.085529177114;4950.45544990058;4955.207166853286;4956.083124621957;5002.899942001212 08:42:38 INFO - PROCESS | 25176 | |1;ext.html;556.8635684257356;561.4946548106703;569.5557465177161;576.3544829790634;586.0388962102151;36167.63832361675;41097;41115.17769644605;41160.38259426111;41188.38217426733;40380.394294085614;41222.17555648885;41228;41245.38131928023;41250.38124428136;7799.376049916007;7905.328047116002;7969.282764551189;7973.441859069868;7985.361171106298;7816.921830781676;7878.1334053254095;7907.44647874649;7908.090569584485;7935.841283174333;7826.921730782705;7842.882356764653;7901.96049019757;7929.841403171933;7934.920650793476;7868.763937081897;7885.408594355446;7886.408519361071;7909.485883417559;7913.366930645535;7726.845463090763;7769.494982826155;7805.531668099932;7844.529328240324;7850.450468467209;39215.41176882349;39397;39503.20993580141;39563;39774.60225397738;3211.983940080308;3444.4144495435835;3482.338355712432;3556.110972256936;3573.4997100405703;30415.847920760476;30946.381072378652;31048.844755776303;31105.688943110505;31480.842595786875;3367.9054307349966;3449.8275086245585;3479.7216222702123;3500.5099286099967;3564.9821750891338;260040;260235;261565;261845;262194.68902655557;32147.196320092185;54506.18240726392;54935;54937.450625493235;55039.724801376535;34490.65509344925;34580.65419345825;34687.13282167915;34723.30553388918;34758.30483390318;14022.368993395321;14096.71806563863;14127.929360353339;14150.646233844236;14271.643208919653;11475.081993440672;11522;11583.884161158448;11619.6514104577;11623.360715160577;7896.921030789734;7915.920840791634;7916.445848790645;8014.438989270695;8032.919670803217;3106.580611617448;3126.9218269543444;3152.984235078856;3179.1734149120934;3217.6943190396873;899.1278459893892;917.4082716647724;922.7739203895088;924.8208534119052;970.45169479244;28309.15072547827;28706.425871482454;28999.42001159965;29027;29151.7084829149;947.1475671895212;975.4829940131741;1007.2445665750687;1025.9281850270409;1080.1520806167277;14873.256337183098;14965.625859353386;15238.390464381522;15338.079715217124;15379;390311;391586;392318;393865;394147;50761.74619126881;51002.23496647553;51187;51192.488075118774;51362;1196.8683444821063;1197.0276704222454;1223.6023292429818;1254.6737848159362;1255.32212605194;26354.472910542067;27626.44747105087;27632.44735105327;27770.305742356602;28374.85812570924;44196.337054944845;44244;44529;44533.33200001938;44700.77649611731;338425;339183;339382;341875;343996;25509.61735574005;25514.362140945883;25978.870105649352;25983.610245846707;26245.73754262433;42305.5769442314;42362.788186058875;42397.36403954005;42556.36165457459;43424;36031;37526.81236593799;37805.81097094497;37826.62173378231;38016.809915950245;37124.25751485009;38028.2394352117;38145.618543814206;38443;38913;36714.8164259177;36854.07864803401;38051;38058;40738.38892416676;31940.36119277555;33892;33978.660213398536;34614.30771384609;34920.82539587387;25876.741232587432;26086;26336.736632634194;26590.202293931212;26690.733092668826 08:42:39 INFO - PROCESS | 25176 | |2;jquery.html;366.8880991297654;371.93677074897283;378.9014856137404;385.5238780106568;386.8452618952417;16515.917420412898;17713.64572708545;18229.270829166817;18492.075396230186;18564.35024774133;17564.473065808015;17770.733438998424;18134.274629014824;18310.816891831077;18363.540911477186;5084.644074914758;5183.766730497118;5196.844094677147;5203.323567936163;5217.5565076968505;3835.5013848199833;4004.9599504004877;5123.231515272721;6008.7296071676665;6222.502199824004;6156.445919867211;6158.414950579688;6172.07418887166;6193.102000209967;6194.101855230989;5932.822015339547;6031.185789918392;6074.817755467343;6086.786962456337;6088.330283668815;5154.329937108152;5296.602754793406;5321.5210631043;5330.600204984603;5332.040232758102;21707.45731356713;21755.456113597127;21796.128154873786;21870.78129218703;21965.121395144175;1977.831884289837;1978.5548251643409;1982.7719812221635;2025.929092481756;2098.674705420662;13574.592762217051;13611;13734.244616546086;13904.304784760823;14373.281335933161;1706.436875830973;1792.6414717056641;1855.1466325490292;1985.5234743661563;2035;72353.63823180903;75433.62283188548;76426.23573764246;76595;77339.6133019337;9326.813463730687;9613.327067105236;9907.711997440287;10123.190144788547;10317.84523232152;13501.459941602423;13672.384742686603;13732.107413018122;14328.283585820667;14336.426542938374;7203.171635261907;7420.220876807857;7452.776416707507;7511.211322811136;7527.473076884675;7178.24628414009;7208.207097219301;7316.488085718778;7434.747430352305;7555.584442855696;4329.242382583036;4361.0841723237845;4398.758068306274;4410.404595379647;4510.075434535912;1740.520468242703;1798.8021317655048;1866.5147061763766;1873.2226126157493;1975.1506852053467;876.4522173641474;956.4070276428658;961.918236949853;992.3252188511881;993.1855878179967;17400.73898891518;17524.91237543804;17960;18107.909460452614;18334.908325458553;880.6125304865839;885.9911400886037;897.8339007283673;904.7195369435497;965.1603105298435;9717.951410242904;10132.442715650563;10150.492475376202;10232.488375581192;10252.538635761408;395433;400941;404925;406405;407239;77410.61294693491;89665;89684;91357;91475;931.9207867331218;953.7758626722715;955.8709574207533;957.5643082397493;974.9756256093655;16104.758428623814;16629.83370166283;16850.831491685418;16875.07187104721;17065.232064557375;37605.05987350338;39376.606233937295;39783.40324895071;40668.79665601653;41151.971200719025;56847;56866.597673220975;56957;57127;57227.42772572387;7612.238776122565;7762.262585054411;7852.646630901509;7854.72508462201;7929.563873986986;10346.32748871321;12019.098567607289;12347.38263086824;12348;12651.810222846481;10530.31552949056;10832.891671083189;10843.240973131806;10987.780244395228;11124.888751112709;9937.751556211153;10835.620753273597;10877.619283325363;10921.399323037309;11026.558937642405;10164.542595583365;10713.625023124154;10725.624603138853;10932.180086493387;11012.119030477383;7749.263819937322;7758.107817601048;7764;7880.566568838769;7957.880631790412;9722.708318750449;10525.894741052798;10610.89389106099;10687.091597214323;10737.570497180026 08:42:39 INFO - PROCESS | 25176 | |3;mootools.html;1389.5067251125854;1405.4448492845327;1484.547213100004;1699.8810083294175;1719.6044909670775;6811.829704257384;7552.282533159355;7698.34564062054;8147.429679922408;8149.1443398443125;7827.882581761278;7989;8067.596620168997;8104.635291411886;8104.959475202616;2174.3694328644674;2226.877521736312;2233.3523278249368;2241.697370854938;2242.091952759135;2170.8806015669134;2173.858699184556;2230.698855654482;2233.9106435742633;2234.5642599693065;2207.0840601150503;2214.8560343577615;2217.2350539064078;2223.455253462904;2249.662550617404;2154.084514081509;2176.738791345049;2180.062573093569;2185.104107316001;2194.264921251383;2121.9151233950624;2139.475828422031;2140;2142.1966762464076;2143.3784202581232;8090.190980901922;8094.9595252023955;8113.472624279403;8160.551169685665;8165.918340816635;4511.120331535352;4630.560096790799;4640.489546149921;4643.489216186217;4644.396228490275;2813.5638975958555;2867.211516832867;2916.1105862711865;2972.346083861569;3001.519756838917;901.5041727050162;939.7885475767965;941.3457646935383;947.7677968897596;950.0689324462066;10749.731256718567;10821.945890270577;10829.133669306515;10835.891641083646;10939.453027348602;4167.499900012018;4227.471566054243;4372.103718737651;4385.956140438619;4387.552107804417;9243.537823108818;9271.721848344561;9312.068793120634;9316;9339.392939458914;4730.739809310452;4739.691920025188;4753.405824271966;4756.881077973078;4769.165396055746;3801.885943421702;4233.068724880522;4261.74429534229;4269.786510674454;4411.448568928884;3686.5391826021746;3694.058015206105;3806.2197249563774;3812.5615554211067;3821.560520540118;1234.2779474007807;1235.8702336254564;1258.539555169641;1269.3843485909326;1286.6590353556314;782.4053719173355;869.452245085592;881.2157180109707;889.4174315823146;904.7738065483629;5346.732663366816;5452.536534394541;5456.836294911159;5618.213450116987;5725.713714314351;415.28363572836616;422.4381572508556;427.83100675233106;428.3510481620348;433.8980339620187;3868.226354729009;3881.825317860703;3899.805009749501;3955.7626542407547;3962.4650672159464;9440.95279523598;9729.854052189223;9869.851952220723;9875.308728389087;9950;9579.616815327308;9733.853992190123;9804.803903922024;9899.752506187402;9925.801483970281;7352.5956072415465;7453.701851925971;7490.063742032246;7557.697692092364;7564.697412103455;5407.0537655909275;5528.419515950767;5540.529055030368;5545.611807173621;5565.8051968182535;9147.176754092163;9208.079192080739;9250.306227033134;9262.44425334482;9276.814463710552;9094.818103638023;9152.816943660957;9311.348205625542;9443.905560944302;9449;6825.829354266183;6873.347032031949;6920.065791118134;6966.094407726963;6968.651567421507;7584.051993500812;7626.885596716164;7646.120696119795;7668.693252269847;7704.191059938626;6399.584027038228;6672.466202703869;6700.2964688708935;6828.556143850634;6917.861642767016;6851.828704282433;6867.313268673092;6896.172459304916;6924.861502769816;6974.58152510851;5972.731227094704;6170.5372097092;6340.778072767431;6396.264429590657;6406.0390941359165;4715.269133284346;4758.643101767312;4780.6414518911915;4789.832355867528;4794.832180873653;4839.128956787812;4909.852704418873;4922.089413458521;4940.555350018516;4945.085159245551 08:42:39 INFO - PROCESS | 25176 | |4;prototype.html;293.08849478123034;303.88604273397476;305.65613684604824;308.08191589064603;308.84557721139447;5081.339425874636;5085.821996230133;5086.313347698059;5086.567641750456;5131.435542090377;4972.32873562069;4986.326845875806;4997.275395067713;5002.24966255061;5071.112555302817;3749.475073489707;3874.4769456123345;3889.8055097245165;3906.9255954612427;3930.0764320384687;3876.4960555127795;3907.9804600976954;3908.237893610747;3921.1962497251156;3922;3902.2975864344407;3911.706622003361;3918.118423354751;3923.6272554107313;3942.19185067062;3839.558450778168;3935.76385416873;3937.6849852011915;3943.1719338938856;3947.6052394760436;3451.119964409085;3458.4812278158224;3462.7056700180515;3468.9653103468895;3470.670286322795;4908.435529914034;4941.20940649498;4952.752362381866;4954.9594585137165;4968.726720030397;4357.085012147453;4519.661025423074;4522.525134860825;4543.182227199103;4551.613112885409;5232.717984093922;5253.264542963988;5262.842114736564;5263.921041184385;5325.866853328659;3769.792661403622;3794.4877441545314;3804.144067584799;3805.162864169878;3806.847726090953;5349.903269829676;5462.371827239878;5502.284702988586;5508.9724551377385;5545.77816887324;3865.6714179295077;3894.1432884765304;3907.433422153772;3909.6285852843935;3913.3934240192816;3962.5443074046275;3970.3250447424007;3976.741511801724;3977.880663580097;3982.900427489278;4502.482214545304;4510;4517.141743068806;4520.615747661485;4536.296873984537;5160.819371321985;5223.686578805284;5227.3988491323225;5296.4703529647495;5368.651037682538;1353.5465619017543;1364.5496985994598;1369.9794503082462;1370.8012338211104;1379.8068270442145;862.3618522293458;864.2610567964425;878.2359347367703;898.6540182029835;912.2792993535033;4512.255477846119;4628.328892310664;4643.419572553431;4643.535646435329;4657.090592856913;5452.618316717871;5471.50756431923;5476.91784623231;5515.4760297771645;5522.889542209214;4473.642108631302;4620.884477888079;4663.626909847204;4670.673052886334;4694.342792009122;2881.755050820662;2886.737986075721;2894.696056914036;2905.142982820073;2907.694692057346;5106.387233532;5106.4382917879;5140.948590514122;5146.176611742103;5146.588272938231;5349.253731343284;5526.944730552643;5535.086710692691;5536.501714845684;5605.271314729059;5103.8724031898755;5122.410922743858;5123.38519377677;5128.692183493185;5133;5407.351117865881;5437.592180586393;5449.5640348772795;5453.7818487260065;5474.863128421821;5094.617903657315;5328.413874473727;5378.09077777399;5397.190421436816;5399.757010934596;5095.847124586268;5166.560842328294;5182.922256166236;5189.636725429184;5196.584273258055;3778.8852288574385;3782.508273924372;3799.6580307772433;3806.657400833938;3810.8285127169897;5190.117679994334;5469.854833470691;5486.862828429321;5487.451254874481;5501.807436739695;5259.947400525945;5294.629375943647;5322.281491998686;5336.706481143575;5338.332708411449;5178.71517066565;5299.311089558333;5308.681479111266;5316.760745766527;5317.282166907573;5218.6868787872845;5220;5232.189010703347;5236.502532259429;5257.868553286198;5104.770285337095;5229.686218826882;5359.276497672764;5374.140137577969;5374.274472946102;5235.947640523546;5249;5269.367675878919;5282.550983166474;5282.652923504482 08:42:39 INFO - PROCESS | 25176 | |5;yui.html;665.6472069803003;695.5339922252094;718.0342439418982;741.9183889772124;765.2653452685422;12684.873151268484;14038.649033774162;14596.927015364934;14656.974011819164;15077.396904123849;14108.43566257351;14194.219317937535;14322.856771432282;14325.57023289303;14368.856311436883;619.3404024713687;760.6843160088571;788.3771820262015;788.5702292250709;793.4128744728916;757.6704133701829;777.2848978939361;779.9961000194991;781.2929298984428;781.9139894611588;821.0352835418389;821.2608652213027;828.6436832162168;834.4159088637947;837.2590257622018;815.7634286057066;817.5217497763786;819.1071731812353;819.2585709932521;823.2261674026396;602.593249556552;602.9849253768647;603.5895590998119;605.8909396308662;606.3966353478318;13269.800952985714;13279.800802987962;13282.601521954357;13294.534691285855;13311.73376532464;13080.345982700923;13080.803787943189;13248;13427;13497.797533037012;10679.572817087308;10755.569777208902;10774.138068954544;10819.945900270448;10896.455177241185;3350.162459385154;3353.295807880348;3378.1048022274117;3466.6533346665383;3475.461303497962;59781.701091494266;60539.69730151321;60607;60706.39293607096;60927;9865.009342432653;10097.798044039226;10172.796544069226;10187.235957303232;10231.232657550714;18209.271629134688;18446.35437759699;18467.16897739605;18549.81450185508;18556.907215464107;6564.245111812107;6606.339366063451;6846.075779769767;6895.55178913369;7086.964565177244;3799.715021373408;3831.65515103642;3880.3791393376923;3922.78424686645;3930.1353702185475;2929.838858862783;3048.8018278811805;3052.2979714665753;3053.541968704668;3054.7098025687524;510.61448606302;525.3748039832587;531.0997858629586;534.7620308962474;541.3233458177278;545.3346916761544;574.1129954220739;576.6770608459276;577.6505214345344;582.2056599484032;7865.292123708779;8065.153158918229;8238.629261683238;8272;8434.15658434164;487.39562941951726;505.91399462091533;509.66362200947935;523.2883278740909;529.7086602368681;3896.7272290939363;3897.590752970954;3959.604039596017;3962.900927476836;3978.3833505806647;91035;91312;93329;94861.5256923711;95306.52346738221;48608.513914861105;67233;80658;81950;82893;46657.30014049792;62712.68643656844;65418.67290663516;69698;71478.64260678663;8243.134470880712;8890.24432923183;8959.328050396116;8962.86555701652;9139.680111196076;30982.380352393277;38193.80903095467;45349.09301814011;45660.771696142634;46054.078918422114;54325.185122223986;61945;62541;62718;62730.37269627428;11192.272502287326;11253.943730281297;11339.433028348714;11486.712832179262;11540.365279909685;12402.25586464815;12521.749565008831;12547;12553.748925021266;13689.247091410069;11562;11730.354830484064;11775.52897884075;12316.938415307866;12486.18839775448;11938.343391113573;12181.223820615638;12325.876741232833;12532.642280474216;12536.37184881298;11498.48256828428;11713.824292635787;11809.64571062835;11959;12337.074719396262;10094.596216151565;10231.334963227366;10264.178865690577;10299.12457441096;10435.217358697977;9892.455914924749;10246.6413675521;10256.333338332985;10274.383536987805;10314.896851031393 08:42:39 INFO - PROCESS | 25176 | __end_tp_report 08:42:39 INFO - PROCESS | 25176 | __start_cc_report 08:42:39 INFO - PROCESS | 25176 | _x_x_mozilla_cycle_collect,404 08:42:39 INFO - PROCESS | 25176 | __end_cc_report 08:42:39 INFO - PROCESS | 25176 | __startTimestamp1468942958995__endTimestamp 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | ------- Summary: start ------- 08:42:39 INFO - PROCESS | 25176 | Number of tests: 6 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#0] dojo.html Cycles:165 Average:4757.78 Median:4924.90 stddev:603.28 (12.2%) stddev-sans-first:580.24 08:42:39 INFO - PROCESS | 25176 | Values: 2571.7 2637.5 2642.5 2671.3 2681.5 4703.5 4763.0 4840.4 4842.4 4862.3 4653.9 4699.8 4727.4 4789.0 4843.1 4423.3 4468.2 4469.5 4500.3 4539.4 645.3 4527.3 4542.1 4547.5 4571.9 4383.5 4464.6 4481.1 4491.8 4513.3 4441.6 4456.6 4457.0 4470.9 4505.4 4233.8 4429.6 4430.6 4457.4 4479.4 4713.0 4724.4 4749.8 4764.5 4810.4 5066.8 5161.8 5169.9 5190.0 5197.9 5103.0 5131.3 5185.3 5185.8 5220.1 4801.1 4805.5 4808.4 4847.6 4855.4 5233.6 5276.9 5280.4 5283.5 5285.7 5024.4 5037.2 5040.4 5080.9 5102.9 5148.2 5151.0 5163.0 5164.5 5243.0 4972.3 5143.9 5148.8 5151.1 5162.2 5124.5 5137.0 5150.4 5189.5 5195.8 4235.4 4407.7 4422.7 4442.0 4486.2 3881.6 3895.6 3896.4 3911.2 3912.1 4279.5 4385.7 4386.4 4399.0 4439.7 5129.8 5161.6 5220.7 5220.9 5233.1 4366.6 4429.2 4451.6 4460.6 4479.4 4509.1 4627.5 4628.9 4629.1 4707.2 4869.6 4904.3 4906.2 4922.1 4938.7 5188.9 5194.5 5201.1 5215.0 5260.6 4693.4 4907.9 4924.9 4928.4 4937.5 5158.6 5178.0 5203.7 5205.4 5278.7 5266.2 5273.0 5299.6 5337.9 5363.3 4885.4 5022.3 5051.3 5148.7 5151.8 5045.4 5083.8 5096.6 5112.1 5132.0 4932.7 5003.2 5036.6 5050.0 5056.0 4871.5 4941.4 5006.8 5007.6 5152.4 4943.1 4950.5 4955.2 4956.1 5002.9 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#1] ext.html Cycles:180 Average:47975.14 Median:37816.22 stddev:88562.07 (234.2%) stddev-sans-first:88738.95 08:42:39 INFO - PROCESS | 25176 | Values: 556.9 561.5 569.6 576.4 586.0 36167.6 41097.0 41115.2 41160.4 41188.4 40380.4 41222.2 41228.0 41245.4 41250.4 7799.4 7905.3 7969.3 7973.4 7985.4 7816.9 7878.1 7907.4 7908.1 7935.8 7826.9 7842.9 7902.0 7929.8 7934.9 7868.8 7885.4 7886.4 7909.5 7913.4 7726.8 7769.5 7805.5 7844.5 7850.5 39215.4 39397.0 39503.2 39563.0 39774.6 3212.0 3444.4 3482.3 3556.1 3573.5 30415.8 30946.4 31048.8 31105.7 31480.8 3367.9 3449.8 3479.7 3500.5 3565.0 260040.0 260235.0 261565.0 261845.0 262194.7 32147.2 54506.2 54935.0 54937.5 55039.7 34490.7 34580.7 34687.1 34723.3 34758.3 14022.4 14096.7 14127.9 14150.6 14271.6 11475.1 11522.0 11583.9 11619.7 11623.4 7896.9 7915.9 7916.4 8014.4 8032.9 3106.6 3126.9 3153.0 3179.2 3217.7 899.1 917.4 922.8 924.8 970.5 28309.2 28706.4 28999.4 29027.0 29151.7 947.1 975.5 1007.2 1025.9 1080.2 14873.3 14965.6 15238.4 15338.1 15379.0 390311.0 391586.0 392318.0 393865.0 394147.0 50761.7 51002.2 51187.0 51192.5 51362.0 1196.9 1197.0 1223.6 1254.7 1255.3 26354.5 27626.4 27632.4 27770.3 28374.9 44196.3 44244.0 44529.0 44533.3 44700.8 338425.0 339183.0 339382.0 341875.0 343996.0 25509.6 25514.4 25978.9 25983.6 26245.7 42305.6 42362.8 42397.4 42556.4 43424.0 36031.0 37526.8 37805.8 37826.6 38016.8 37124.3 38028.2 38145.6 38443.0 38913.0 36714.8 36854.1 38051.0 38058.0 40738.4 31940.4 33892.0 33978.7 34614.3 34920.8 25876.7 26086.0 26336.7 26590.2 26690.7 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#2] jquery.html Cycles:180 Average:25817.35 Median:402933.00 stddev:66864.94 (16.6%) stddev-sans-first:67025.20 08:42:39 INFO - PROCESS | 25176 | Values: 366.9 371.9 378.9 385.5 386.8 16515.9 17713.6 18229.3 18492.1 18564.4 17564.5 17770.7 18134.3 18310.8 18363.5 5084.6 5183.8 5196.8 5203.3 5217.6 3835.5 4005.0 5123.2 6008.7 6222.5 6156.4 6158.4 6172.1 6193.1 6194.1 5932.8 6031.2 6074.8 6086.8 6088.3 5154.3 5296.6 5321.5 5330.6 5332.0 21707.5 21755.5 21796.1 21870.8 21965.1 1977.8 1978.6 1982.8 2025.9 2098.7 13574.6 13611.0 13734.2 13904.3 14373.3 1706.4 1792.6 1855.1 1985.5 2035.0 72353.6 75433.6 76426.2 76595.0 77339.6 9326.8 9613.3 9907.7 10123.2 10317.8 13501.5 13672.4 13732.1 14328.3 14336.4 7203.2 7420.2 7452.8 7511.2 7527.5 7178.2 7208.2 7316.5 7434.7 7555.6 4329.2 4361.1 4398.8 4410.4 4510.1 1740.5 1798.8 1866.5 1873.2 1975.2 876.5 956.4 961.9 992.3 993.2 17400.7 17524.9 17960.0 18107.9 18334.9 880.6 886.0 897.8 904.7 965.2 9718.0 10132.4 10150.5 10232.5 10252.5 395433.0 400941.0 404925.0 406405.0 407239.0 77410.6 89665.0 89684.0 91357.0 91475.0 931.9 953.8 955.9 957.6 975.0 16104.8 16629.8 16850.8 16875.1 17065.2 37605.1 39376.6 39783.4 40668.8 41152.0 56847.0 56866.6 56957.0 57127.0 57227.4 7612.2 7762.3 7852.6 7854.7 7929.6 10346.3 12019.1 12347.4 12348.0 12651.8 10530.3 10832.9 10843.2 10987.8 11124.9 9937.8 10835.6 10877.6 10921.4 11026.6 10164.5 10713.6 10725.6 10932.2 11012.1 7749.3 7758.1 7764.0 7880.6 7957.9 9722.7 10525.9 10610.9 10687.1 10737.6 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#3] mootools.html Cycles:180 Average:5252.88 Median:5376.89 stddev:2954.77 (55.0%) stddev-sans-first:2948.80 08:42:39 INFO - PROCESS | 25176 | Values: 1389.5 1405.4 1484.5 1699.9 1719.6 6811.8 7552.3 7698.3 8147.4 8149.1 7827.9 7989.0 8067.6 8104.6 8105.0 2174.4 2226.9 2233.4 2241.7 2242.1 2170.9 2173.9 2230.7 2233.9 2234.6 2207.1 2214.9 2217.2 2223.5 2249.7 2154.1 2176.7 2180.1 2185.1 2194.3 2121.9 2139.5 2140.0 2142.2 2143.4 8090.2 8095.0 8113.5 8160.6 8165.9 4511.1 4630.6 4640.5 4643.5 4644.4 2813.6 2867.2 2916.1 2972.3 3001.5 901.5 939.8 941.3 947.8 950.1 10749.7 10821.9 10829.1 10835.9 10939.5 4167.5 4227.5 4372.1 4386.0 4387.6 9243.5 9271.7 9312.1 9316.0 9339.4 4730.7 4739.7 4753.4 4756.9 4769.2 3801.9 4233.1 4261.7 4269.8 4411.4 3686.5 3694.1 3806.2 3812.6 3821.6 1234.3 1235.9 1258.5 1269.4 1286.7 782.4 869.5 881.2 889.4 904.8 5346.7 5452.5 5456.8 5618.2 5725.7 415.3 422.4 427.8 428.4 433.9 3868.2 3881.8 3899.8 3955.8 3962.5 9441.0 9729.9 9869.9 9875.3 9950.0 9579.6 9733.9 9804.8 9899.8 9925.8 7352.6 7453.7 7490.1 7557.7 7564.7 5407.1 5528.4 5540.5 5545.6 5565.8 9147.2 9208.1 9250.3 9262.4 9276.8 9094.8 9152.8 9311.3 9443.9 9449.0 6825.8 6873.3 6920.1 6966.1 6968.7 7584.1 7626.9 7646.1 7668.7 7704.2 6399.6 6672.5 6700.3 6828.6 6917.9 6851.8 6867.3 6896.2 6924.9 6974.6 5972.7 6170.5 6340.8 6396.3 6406.0 4715.3 4758.6 4780.6 4789.8 4794.8 4839.1 4909.9 4922.1 4940.6 4945.1 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#4] prototype.html Cycles:180 Average:4396.72 Median:5083.58 stddev:1278.47 (25.1%) stddev-sans-first:1244.40 08:42:39 INFO - PROCESS | 25176 | Values: 293.1 303.9 305.7 308.1 308.8 5081.3 5085.8 5086.3 5086.6 5131.4 4972.3 4986.3 4997.3 5002.2 5071.1 3749.5 3874.5 3889.8 3906.9 3930.1 3876.5 3908.0 3908.2 3921.2 3922.0 3902.3 3911.7 3918.1 3923.6 3942.2 3839.6 3935.8 3937.7 3943.2 3947.6 3451.1 3458.5 3462.7 3469.0 3470.7 4908.4 4941.2 4952.8 4955.0 4968.7 4357.1 4519.7 4522.5 4543.2 4551.6 5232.7 5253.3 5262.8 5263.9 5325.9 3769.8 3794.5 3804.1 3805.2 3806.8 5349.9 5462.4 5502.3 5509.0 5545.8 3865.7 3894.1 3907.4 3909.6 3913.4 3962.5 3970.3 3976.7 3977.9 3982.9 4502.5 4510.0 4517.1 4520.6 4536.3 5160.8 5223.7 5227.4 5296.5 5368.7 1353.5 1364.5 1370.0 1370.8 1379.8 862.4 864.3 878.2 898.7 912.3 4512.3 4628.3 4643.4 4643.5 4657.1 5452.6 5471.5 5476.9 5515.5 5522.9 4473.6 4620.9 4663.6 4670.7 4694.3 2881.8 2886.7 2894.7 2905.1 2907.7 5106.4 5106.4 5140.9 5146.2 5146.6 5349.3 5526.9 5535.1 5536.5 5605.3 5103.9 5122.4 5123.4 5128.7 5133.0 5407.4 5437.6 5449.6 5453.8 5474.9 5094.6 5328.4 5378.1 5397.2 5399.8 5095.8 5166.6 5182.9 5189.6 5196.6 3778.9 3782.5 3799.7 3806.7 3810.8 5190.1 5469.9 5486.9 5487.5 5501.8 5259.9 5294.6 5322.3 5336.7 5338.3 5178.7 5299.3 5308.7 5316.8 5317.3 5218.7 5220.0 5232.2 5236.5 5257.9 5104.8 5229.7 5359.3 5374.1 5374.3 5235.9 5249.0 5269.4 5282.6 5282.7 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - PROCESS | 25176 | [#5] yui.html Cycles:180 Average:16957.95 Median:45504.93 stddev:23285.04 (51.2%) stddev-sans-first:23318.22 08:42:39 INFO - PROCESS | 25176 | Values: 665.6 695.5 718.0 741.9 765.3 12684.9 14038.6 14596.9 14657.0 15077.4 14108.4 14194.2 14322.9 14325.6 14368.9 619.3 760.7 788.4 788.6 793.4 757.7 777.3 780.0 781.3 781.9 821.0 821.3 828.6 834.4 837.3 815.8 817.5 819.1 819.3 823.2 602.6 603.0 603.6 605.9 606.4 13269.8 13279.8 13282.6 13294.5 13311.7 13080.3 13080.8 13248.0 13427.0 13497.8 10679.6 10755.6 10774.1 10819.9 10896.5 3350.2 3353.3 3378.1 3466.7 3475.5 59781.7 60539.7 60607.0 60706.4 60927.0 9865.0 10097.8 10172.8 10187.2 10231.2 18209.3 18446.4 18467.2 18549.8 18556.9 6564.2 6606.3 6846.1 6895.6 7087.0 3799.7 3831.7 3880.4 3922.8 3930.1 2929.8 3048.8 3052.3 3053.5 3054.7 510.6 525.4 531.1 534.8 541.3 545.3 574.1 576.7 577.7 582.2 7865.3 8065.2 8238.6 8272.0 8434.2 487.4 505.9 509.7 523.3 529.7 3896.7 3897.6 3959.6 3962.9 3978.4 91035.0 91312.0 93329.0 94861.5 95306.5 48608.5 67233.0 80658.0 81950.0 82893.0 46657.3 62712.7 65418.7 69698.0 71478.6 8243.1 8890.2 8959.3 8962.9 9139.7 30982.4 38193.8 45349.1 45660.8 46054.1 54325.2 61945.0 62541.0 62718.0 62730.4 11192.3 11253.9 11339.4 11486.7 11540.4 12402.3 12521.7 12547.0 12553.7 13689.2 11562.0 11730.4 11775.5 12316.9 12486.2 11938.3 12181.2 12325.9 12532.6 12536.4 11498.5 11713.8 11809.6 11959.0 12337.1 10094.6 10231.3 10264.2 10299.1 10435.2 9892.5 10246.6 10256.3 10274.4 10314.9 08:42:39 INFO - PROCESS | 25176 | -------- Summary: end -------- 08:42:39 INFO - PROCESS | 25176 | 08:42:39 INFO - TEST-INFO | 25176: exit 0 08:42:39 INFO - TEST-OK | dromaeo_css | took 1117686ms 08:42:39 INFO - TEST-START | kraken 08:42:39 INFO - operating with platform_type : linux_ 08:42:39 INFO - Initialising browser for kraken test... 08:42:39 INFO - TEST-INFO | started process 25422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObMqmM/profile http://localhost:44444/getInfo.html) 08:42:44 INFO - PROCESS | 25422 | __metrics Screen width/height:1600/1200 08:42:44 INFO - PROCESS | 25422 | colorDepth:24 08:42:44 INFO - PROCESS | 25422 | Browser inner width/height: 1024/697 08:42:44 INFO - PROCESS | 25422 | __metrics 08:42:45 ERROR - PROCESS | 25422 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:42:46 INFO - TEST-INFO | 25422: exit 0 08:42:46 INFO - Browser initialized. 08:42:46 INFO - Running cycle 1/1 for kraken test... 08:42:46 INFO - TEST-INFO | started process 25540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObMqmM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:58 INFO - PROCESS | 25540 | RSS: Main: 168898560 08:42:58 INFO - PROCESS | 25540 | 08:43:01 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44444/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:02 INFO - PROCESS | 25540 | RSS: Main: 174264320 08:43:02 INFO - PROCESS | 25540 | 08:43:04 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44444/tests/kraken/driver.html?testName=audio-dft) 08:43:05 INFO - PROCESS | 25540 | RSS: Main: 174473216 08:43:05 INFO - PROCESS | 25540 | 08:43:08 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44444/tests/kraken/driver.html?testName=audio-fft) 08:43:09 INFO - PROCESS | 25540 | RSS: Main: 168345600 08:43:09 INFO - PROCESS | 25540 | 08:43:11 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44444/tests/kraken/driver.html?testName=audio-oscillator) 08:43:11 INFO - PROCESS | 25540 | RSS: Main: 169148416 08:43:11 INFO - PROCESS | 25540 | 08:43:14 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:14 INFO - PROCESS | 25540 | RSS: Main: 169541632 08:43:14 INFO - PROCESS | 25540 | 08:43:17 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44444/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:18 INFO - PROCESS | 25540 | RSS: Main: 169611264 08:43:18 INFO - PROCESS | 25540 | 08:43:22 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44444/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:22 INFO - PROCESS | 25540 | RSS: Main: 166928384 08:43:22 INFO - PROCESS | 25540 | 08:43:25 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44444/tests/kraken/driver.html?testName=json-parse-financial) 08:43:26 INFO - PROCESS | 25540 | RSS: Main: 168435712 08:43:26 INFO - PROCESS | 25540 | 08:43:28 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:28 INFO - PROCESS | 25540 | RSS: Main: 168615936 08:43:28 INFO - PROCESS | 25540 | 08:43:30 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:31 INFO - PROCESS | 25540 | RSS: Main: 168767488 08:43:31 INFO - PROCESS | 25540 | 08:43:33 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:34 INFO - PROCESS | 25540 | RSS: Main: 169033728 08:43:34 INFO - PROCESS | 25540 | 08:43:36 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:37 INFO - PROCESS | 25540 | RSS: Main: 169209856 08:43:37 INFO - PROCESS | 25540 | 08:43:40 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:41 INFO - PROCESS | 25540 | RSS: Main: 169697280 08:43:41 INFO - PROCESS | 25540 | 08:43:42 INFO - PROCESS | 25540 | Cycle 1(1): loaded http://localhost:44444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44444/tests/kraken/driver.html?testName=ai-astar) 08:43:43 INFO - PROCESS | 25540 | RSS: Main: 170209280 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | __start_tp_report 08:43:43 INFO - PROCESS | 25540 | _x_x_mozilla_page_load 08:43:43 INFO - PROCESS | 25540 | _x_x_mozilla_page_load_details 08:43:43 INFO - PROCESS | 25540 | |i|pagename|runs| 08:43:43 INFO - PROCESS | 25540 | |0;ai-astar;105;115;110;114;114;116;115;115;114;113 08:43:43 INFO - PROCESS | 25540 | |1;audio-beat-detection;153;131;146;190;125;150;153;129;180;124 08:43:43 INFO - PROCESS | 25540 | |2;audio-dft;163;164;165;175;164;163;162;164;166;163 08:43:43 INFO - PROCESS | 25540 | |3;audio-fft;75;78;80;148;79;79;76;77;169;77 08:43:43 INFO - PROCESS | 25540 | |4;audio-oscillator;85;86;138;86;85;85;135;86;87;139 08:43:43 INFO - PROCESS | 25540 | |5;imaging-gaussian-blur;118;117;119;117;117;118;119;118;118;119 08:43:43 INFO - PROCESS | 25540 | |6;imaging-darkroom;149;147;147;147;147;149;148;148;148;148 08:43:43 INFO - PROCESS | 25540 | |7;imaging-desaturate;96;98;95;95;96;97;96;96;95;96 08:43:43 INFO - PROCESS | 25540 | |8;json-parse-financial;64;66;65;65;68;64;65;66;66;65 08:43:43 INFO - PROCESS | 25540 | |9;json-stringify-tinderbox;66;66;65;66;67;66;66;65;69;66 08:43:43 INFO - PROCESS | 25540 | |10;stanford-crypto-aes;81;79;80;85;80;87;79;84;84;84 08:43:43 INFO - PROCESS | 25540 | |11;stanford-crypto-ccm;132;133;152;139;135;138;129;140;174;142 08:43:43 INFO - PROCESS | 25540 | |12;stanford-crypto-pbkdf2;166;170;182;167;165;170;167;164;165;165 08:43:43 INFO - PROCESS | 25540 | |13;stanford-crypto-sha256-iterative;69;68;71;68;69;70;65;68;70;70 08:43:43 INFO - PROCESS | 25540 | __end_tp_report 08:43:43 INFO - PROCESS | 25540 | __start_cc_report 08:43:43 INFO - PROCESS | 25540 | _x_x_mozilla_cycle_collect,1007 08:43:43 INFO - PROCESS | 25540 | __end_cc_report 08:43:43 INFO - PROCESS | 25540 | __startTimestamp1468943023036__endTimestamp 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | ------- Summary: start ------- 08:43:43 INFO - PROCESS | 25540 | Number of tests: 14 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.28 (2.9%) stddev-sans-first:1.73 08:43:43 INFO - PROCESS | 25540 | Values: 105.0 115.0 110.0 114.0 114.0 116.0 115.0 115.0 114.0 113.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.50 stddev:22.61 (14.9%) stddev-sans-first:23.91 08:43:43 INFO - PROCESS | 25540 | Values: 153.0 131.0 146.0 190.0 125.0 150.0 153.0 129.0 180.0 124.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.73 (2.3%) stddev-sans-first:3.89 08:43:43 INFO - PROCESS | 25540 | Values: 163.0 164.0 165.0 175.0 164.0 163.0 162.0 164.0 166.0 163.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#3] audio-fft Cycles:10 Average:93.80 Median:77.50 stddev:34.49 (44.5%) stddev-sans-first:35.90 08:43:43 INFO - PROCESS | 25540 | Values: 75.0 78.0 80.0 148.0 79.0 79.0 76.0 77.0 169.0 77.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:85.50 stddev:24.96 (29.2%) stddev-sans-first:25.78 08:43:43 INFO - PROCESS | 25540 | Values: 85.0 86.0 138.0 86.0 85.0 85.0 135.0 86.0 87.0 139.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:43:43 INFO - PROCESS | 25540 | Values: 118.0 117.0 119.0 117.0 117.0 118.0 119.0 118.0 118.0 119.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 08:43:43 INFO - PROCESS | 25540 | Values: 149.0 147.0 147.0 147.0 147.0 149.0 148.0 148.0 148.0 148.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 08:43:43 INFO - PROCESS | 25540 | Values: 96.0 98.0 95.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:1.13 08:43:43 INFO - PROCESS | 25540 | Values: 64.0 66.0 65.0 65.0 68.0 64.0 65.0 66.0 66.0 65.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 08:43:43 INFO - PROCESS | 25540 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 69.0 66.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:84.00 stddev:2.83 (3.4%) stddev-sans-first:2.96 08:43:43 INFO - PROCESS | 25540 | Values: 81.0 79.0 80.0 85.0 80.0 87.0 79.0 84.0 84.0 84.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.50 stddev:13.12 (9.4%) stddev-sans-first:13.46 08:43:43 INFO - PROCESS | 25540 | Values: 132.0 133.0 152.0 139.0 135.0 138.0 129.0 140.0 174.0 142.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:167.00 stddev:5.30 (3.2%) stddev-sans-first:5.57 08:43:43 INFO - PROCESS | 25540 | Values: 166.0 170.0 182.0 167.0 165.0 170.0 167.0 164.0 165.0 165.0 08:43:43 INFO - PROCESS | 25540 | 08:43:43 INFO - PROCESS | 25540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.69 (2.4%) stddev-sans-first:1.79 08:43:43 INFO - PROCESS | 25540 | Values: 69.0 68.0 71.0 68.0 69.0 70.0 65.0 68.0 70.0 70.0 08:43:43 INFO - PROCESS | 25540 | -------- Summary: end -------- 08:43:43 INFO - PROCESS | 25540 | 08:43:44 INFO - TEST-INFO | 25540: exit 0 08:43:44 INFO - TEST-OK | kraken | took 64339ms 08:43:44 INFO - SUITE-END | took 1182s 08:43:44 INFO - Completed test suite (00:19:42) 08:43:44 INFO - javascript benchmark 08:43:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6502.7131194819995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.6785401824773, 2637.5384307746144, 2642.4847154804797, 2671.3321669582606, 2681.45030268795, 4703.5061318561575, 4762.976185119074, 4840.4191497020365, 4842.394700662418, 4862.319275301452, 4653.930191047137, 4699.835505757299, 4727.432708075027, 4788.976055119728, 4843.079814835179, 4423.292273236283, 4468.195724769532, 4469.530699276578, 4500.279955207167, 4539.4098767160385, 645.2505791146634, 4527.2530032544755, 4542.114287713897, 4547.545245475442, 4571.9314210286875, 4383.452068491439, 4464.598186163261, 4481.126180394825, 4491.797869095866, 4513.255312873372, 4441.600255976945, 4456.621187199092, 4456.955430445686, 4470.865874023784, 4505.43682039745, 4233.7883105844585, 4429.623482004034, 4430.579094985971, 4457.442819647544, 4479.3504941783585, 4713.033828065239, 4724.362211101526, 4749.810007599692, 4764.523547645243, 4810.39870016248, 5066.847994560169, 5161.8193363232485, 5169.948300517022, 5189.987952349294, 5197.870053248699, 5102.974485127551, 5131.281620573122, 5185.2999845021195, 5185.844424667266, 5220.060389129955, 4801.063792560487, 4805.495422980606, 4808.422989241313, 4847.61219102478, 4855.417349918032, 5233.633645644844, 5276.868078298074, 5280.419153893069, 5283.498067683564, 5285.68285902847, 5024.422191447957, 5037.19404895215, 5040.39515258164, 5080.949190508121, 5102.872428189325, 5148.227765835155, 5150.97424512875, 5162.97418512905, 5164.483551644806, 5242.9737851311265, 4972.279019542146, 5143.897122057613, 5148.794048238028, 5151.124308867502, 5162.199859021857, 5124.48755124492, 5137.0, 5150.356205474316, 5189.481051894781, 5195.818146364934, 4235.42821719064, 4407.669424793154, 4422.690411671152, 4441.977790111029, 4486.192485352668, 3881.573026967031, 3895.610438956082, 3896.3571010782903, 3911.2177564487215, 3912.1197730510407, 4279.507856596531, 4385.736855788663, 4386.407834942242, 4398.956010439854, 4439.711418757771, 5129.820456284012, 5161.612879034087, 5220.738963051832, 5220.92168617471, 5233.058049551041, 4366.607005369532, 4429.180601588717, 4451.643868490513, 4460.553944605578, 4479.395281637003, 4509.098180363941, 4627.467841198305, 4628.861134165981, 4629.051044535862, 4707.199776038082, 4869.586085182799, 4904.2643603459055, 4906.1659517881335, 4922.138625740553, 4938.654294199371, 5188.948110518846, 5194.532492075731, 5201.063808514504, 5215.0, 5260.579153667621, 4693.436787585511, 4907.877303067452, 4924.901501969869, 4928.359313289249, 4937.506249375034, 5158.6131040171385, 5178.0, 5203.687778733288, 5205.427402985744, 5278.736063196901, 5266.236395722675, 5272.9736351318, 5299.629025968299, 5337.919931201112, 5363.27595774581, 4885.389326334208, 5022.296878436949, 5051.267566202807, 5148.6910785353, 5151.819686311111, 5045.369328833895, 5083.822066227664, 5096.643234973664, 5112.079825631274, 5132.0, 4932.679375840559, 5003.224500202475, 5036.597072234139, 5049.974750126373, 5056.0, 4871.537203965618, 4941.407031156285, 5006.824761133343, 5007.649464537593, 5152.407473140637, 4943.085529177114, 4950.45544990058, 4955.207166853286, 4956.083124621957, 5002.899942001212], "value": 4720.962439614837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8635684257356, 561.4946548106703, 569.5557465177161, 576.3544829790634, 586.0388962102151, 36167.63832361675, 41097.0, 41115.17769644605, 41160.38259426111, 41188.38217426733, 40380.394294085614, 41222.17555648885, 41228.0, 41245.38131928023, 41250.38124428136, 7799.376049916007, 7905.328047116002, 7969.282764551189, 7973.441859069868, 7985.361171106298, 7816.921830781676, 7878.1334053254095, 7907.44647874649, 7908.090569584485, 7935.841283174333, 7826.921730782705, 7842.882356764653, 7901.96049019757, 7929.841403171933, 7934.920650793476, 7868.763937081897, 7885.408594355446, 7886.408519361071, 7909.485883417559, 7913.366930645535, 7726.845463090763, 7769.494982826155, 7805.531668099932, 7844.529328240324, 7850.450468467209, 39215.41176882349, 39397.0, 39503.20993580141, 39563.0, 39774.60225397738, 3211.983940080308, 3444.4144495435835, 3482.338355712432, 3556.110972256936, 3573.4997100405703, 30415.847920760476, 30946.381072378652, 31048.844755776303, 31105.688943110505, 31480.842595786875, 3367.9054307349966, 3449.8275086245585, 3479.7216222702123, 3500.5099286099967, 3564.9821750891338, 260040.0, 260235.0, 261565.0, 261845.0, 262194.68902655557, 32147.196320092185, 54506.18240726392, 54935.0, 54937.450625493235, 55039.724801376535, 34490.65509344925, 34580.65419345825, 34687.13282167915, 34723.30553388918, 34758.30483390318, 14022.368993395321, 14096.71806563863, 14127.929360353339, 14150.646233844236, 14271.643208919653, 11475.081993440672, 11522.0, 11583.884161158448, 11619.6514104577, 11623.360715160577, 7896.921030789734, 7915.920840791634, 7916.445848790645, 8014.438989270695, 8032.919670803217, 3106.580611617448, 3126.9218269543444, 3152.984235078856, 3179.1734149120934, 3217.6943190396873, 899.1278459893892, 917.4082716647724, 922.7739203895088, 924.8208534119052, 970.45169479244, 28309.15072547827, 28706.425871482454, 28999.42001159965, 29027.0, 29151.7084829149, 947.1475671895212, 975.4829940131741, 1007.2445665750687, 1025.9281850270409, 1080.1520806167277, 14873.256337183098, 14965.625859353386, 15238.390464381522, 15338.079715217124, 15379.0, 390311.0, 391586.0, 392318.0, 393865.0, 394147.0, 50761.74619126881, 51002.23496647553, 51187.0, 51192.488075118774, 51362.0, 1196.8683444821063, 1197.0276704222454, 1223.6023292429818, 1254.6737848159362, 1255.32212605194, 26354.472910542067, 27626.44747105087, 27632.44735105327, 27770.305742356602, 28374.85812570924, 44196.337054944845, 44244.0, 44529.0, 44533.33200001938, 44700.77649611731, 338425.0, 339183.0, 339382.0, 341875.0, 343996.0, 25509.61735574005, 25514.362140945883, 25978.870105649352, 25983.610245846707, 26245.73754262433, 42305.5769442314, 42362.788186058875, 42397.36403954005, 42556.36165457459, 43424.0, 36031.0, 37526.81236593799, 37805.81097094497, 37826.62173378231, 38016.809915950245, 37124.25751485009, 38028.2394352117, 38145.618543814206, 38443.0, 38913.0, 36714.8164259177, 36854.07864803401, 38051.0, 38058.0, 40738.38892416676, 31940.36119277555, 33892.0, 33978.660213398536, 34614.30771384609, 34920.82539587387, 25876.741232587432, 26086.0, 26336.736632634194, 26590.202293931212, 26690.733092668826], "value": 16944.030314341384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8880991297654, 371.93677074897283, 378.9014856137404, 385.5238780106568, 386.8452618952417, 16515.917420412898, 17713.64572708545, 18229.270829166817, 18492.075396230186, 18564.35024774133, 17564.473065808015, 17770.733438998424, 18134.274629014824, 18310.816891831077, 18363.540911477186, 5084.644074914758, 5183.766730497118, 5196.844094677147, 5203.323567936163, 5217.5565076968505, 3835.5013848199833, 4004.9599504004877, 5123.231515272721, 6008.7296071676665, 6222.502199824004, 6156.445919867211, 6158.414950579688, 6172.07418887166, 6193.102000209967, 6194.101855230989, 5932.822015339547, 6031.185789918392, 6074.817755467343, 6086.786962456337, 6088.330283668815, 5154.329937108152, 5296.602754793406, 5321.5210631043, 5330.600204984603, 5332.040232758102, 21707.45731356713, 21755.456113597127, 21796.128154873786, 21870.78129218703, 21965.121395144175, 1977.831884289837, 1978.5548251643409, 1982.7719812221635, 2025.929092481756, 2098.674705420662, 13574.592762217051, 13611.0, 13734.244616546086, 13904.304784760823, 14373.281335933161, 1706.436875830973, 1792.6414717056641, 1855.1466325490292, 1985.5234743661563, 2035.0, 72353.63823180903, 75433.62283188548, 76426.23573764246, 76595.0, 77339.6133019337, 9326.813463730687, 9613.327067105236, 9907.711997440287, 10123.190144788547, 10317.84523232152, 13501.459941602423, 13672.384742686603, 13732.107413018122, 14328.283585820667, 14336.426542938374, 7203.171635261907, 7420.220876807857, 7452.776416707507, 7511.211322811136, 7527.473076884675, 7178.24628414009, 7208.207097219301, 7316.488085718778, 7434.747430352305, 7555.584442855696, 4329.242382583036, 4361.0841723237845, 4398.758068306274, 4410.404595379647, 4510.075434535912, 1740.520468242703, 1798.8021317655048, 1866.5147061763766, 1873.2226126157493, 1975.1506852053467, 876.4522173641474, 956.4070276428658, 961.918236949853, 992.3252188511881, 993.1855878179967, 17400.73898891518, 17524.91237543804, 17960.0, 18107.909460452614, 18334.908325458553, 880.6125304865839, 885.9911400886037, 897.8339007283673, 904.7195369435497, 965.1603105298435, 9717.951410242904, 10132.442715650563, 10150.492475376202, 10232.488375581192, 10252.538635761408, 395433.0, 400941.0, 404925.0, 406405.0, 407239.0, 77410.61294693491, 89665.0, 89684.0, 91357.0, 91475.0, 931.9207867331218, 953.7758626722715, 955.8709574207533, 957.5643082397493, 974.9756256093655, 16104.758428623814, 16629.83370166283, 16850.831491685418, 16875.07187104721, 17065.232064557375, 37605.05987350338, 39376.606233937295, 39783.40324895071, 40668.79665601653, 41151.971200719025, 56847.0, 56866.597673220975, 56957.0, 57127.0, 57227.42772572387, 7612.238776122565, 7762.262585054411, 7852.646630901509, 7854.72508462201, 7929.563873986986, 10346.32748871321, 12019.098567607289, 12347.38263086824, 12348.0, 12651.810222846481, 10530.31552949056, 10832.891671083189, 10843.240973131806, 10987.780244395228, 11124.888751112709, 9937.751556211153, 10835.620753273597, 10877.619283325363, 10921.399323037309, 11026.558937642405, 10164.542595583365, 10713.625023124154, 10725.624603138853, 10932.180086493387, 11012.119030477383, 7749.263819937322, 7758.107817601048, 7764.0, 7880.566568838769, 7957.880631790412, 9722.708318750449, 10525.894741052798, 10610.89389106099, 10687.091597214323, 10737.570497180026], "value": 8687.204693507687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.5067251125854, 1405.4448492845327, 1484.547213100004, 1699.8810083294175, 1719.6044909670775, 6811.829704257384, 7552.282533159355, 7698.34564062054, 8147.429679922408, 8149.1443398443125, 7827.882581761278, 7989.0, 8067.596620168997, 8104.635291411886, 8104.959475202616, 2174.3694328644674, 2226.877521736312, 2233.3523278249368, 2241.697370854938, 2242.091952759135, 2170.8806015669134, 2173.858699184556, 2230.698855654482, 2233.9106435742633, 2234.5642599693065, 2207.0840601150503, 2214.8560343577615, 2217.2350539064078, 2223.455253462904, 2249.662550617404, 2154.084514081509, 2176.738791345049, 2180.062573093569, 2185.104107316001, 2194.264921251383, 2121.9151233950624, 2139.475828422031, 2140.0, 2142.1966762464076, 2143.3784202581232, 8090.190980901922, 8094.9595252023955, 8113.472624279403, 8160.551169685665, 8165.918340816635, 4511.120331535352, 4630.560096790799, 4640.489546149921, 4643.489216186217, 4644.396228490275, 2813.5638975958555, 2867.211516832867, 2916.1105862711865, 2972.346083861569, 3001.519756838917, 901.5041727050162, 939.7885475767965, 941.3457646935383, 947.7677968897596, 950.0689324462066, 10749.731256718567, 10821.945890270577, 10829.133669306515, 10835.891641083646, 10939.453027348602, 4167.499900012018, 4227.471566054243, 4372.103718737651, 4385.956140438619, 4387.552107804417, 9243.537823108818, 9271.721848344561, 9312.068793120634, 9316.0, 9339.392939458914, 4730.739809310452, 4739.691920025188, 4753.405824271966, 4756.881077973078, 4769.165396055746, 3801.885943421702, 4233.068724880522, 4261.74429534229, 4269.786510674454, 4411.448568928884, 3686.5391826021746, 3694.058015206105, 3806.2197249563774, 3812.5615554211067, 3821.560520540118, 1234.2779474007807, 1235.8702336254564, 1258.539555169641, 1269.3843485909326, 1286.6590353556314, 782.4053719173355, 869.452245085592, 881.2157180109707, 889.4174315823146, 904.7738065483629, 5346.732663366816, 5452.536534394541, 5456.836294911159, 5618.213450116987, 5725.713714314351, 415.28363572836616, 422.4381572508556, 427.83100675233106, 428.3510481620348, 433.8980339620187, 3868.226354729009, 3881.825317860703, 3899.805009749501, 3955.7626542407547, 3962.4650672159464, 9440.95279523598, 9729.854052189223, 9869.851952220723, 9875.308728389087, 9950.0, 9579.616815327308, 9733.853992190123, 9804.803903922024, 9899.752506187402, 9925.801483970281, 7352.5956072415465, 7453.701851925971, 7490.063742032246, 7557.697692092364, 7564.697412103455, 5407.0537655909275, 5528.419515950767, 5540.529055030368, 5545.611807173621, 5565.8051968182535, 9147.176754092163, 9208.079192080739, 9250.306227033134, 9262.44425334482, 9276.814463710552, 9094.818103638023, 9152.816943660957, 9311.348205625542, 9443.905560944302, 9449.0, 6825.829354266183, 6873.347032031949, 6920.065791118134, 6966.094407726963, 6968.651567421507, 7584.051993500812, 7626.885596716164, 7646.120696119795, 7668.693252269847, 7704.191059938626, 6399.584027038228, 6672.466202703869, 6700.2964688708935, 6828.556143850634, 6917.861642767016, 6851.828704282433, 6867.313268673092, 6896.172459304916, 6924.861502769816, 6974.58152510851, 5972.731227094704, 6170.5372097092, 6340.778072767431, 6396.264429590657, 6406.0390941359165, 4715.269133284346, 4758.643101767312, 4780.6414518911915, 4789.832355867528, 4794.832180873653, 4839.128956787812, 4909.852704418873, 4922.089413458521, 4940.555350018516, 4945.085159245551], "value": 4160.874656822893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.08849478123034, 303.88604273397476, 305.65613684604824, 308.08191589064603, 308.84557721139447, 5081.339425874636, 5085.821996230133, 5086.313347698059, 5086.567641750456, 5131.435542090377, 4972.32873562069, 4986.326845875806, 4997.275395067713, 5002.24966255061, 5071.112555302817, 3749.475073489707, 3874.4769456123345, 3889.8055097245165, 3906.9255954612427, 3930.0764320384687, 3876.4960555127795, 3907.9804600976954, 3908.237893610747, 3921.1962497251156, 3922.0, 3902.2975864344407, 3911.706622003361, 3918.118423354751, 3923.6272554107313, 3942.19185067062, 3839.558450778168, 3935.76385416873, 3937.6849852011915, 3943.1719338938856, 3947.6052394760436, 3451.119964409085, 3458.4812278158224, 3462.7056700180515, 3468.9653103468895, 3470.670286322795, 4908.435529914034, 4941.20940649498, 4952.752362381866, 4954.9594585137165, 4968.726720030397, 4357.085012147453, 4519.661025423074, 4522.525134860825, 4543.182227199103, 4551.613112885409, 5232.717984093922, 5253.264542963988, 5262.842114736564, 5263.921041184385, 5325.866853328659, 3769.792661403622, 3794.4877441545314, 3804.144067584799, 3805.162864169878, 3806.847726090953, 5349.903269829676, 5462.371827239878, 5502.284702988586, 5508.9724551377385, 5545.77816887324, 3865.6714179295077, 3894.1432884765304, 3907.433422153772, 3909.6285852843935, 3913.3934240192816, 3962.5443074046275, 3970.3250447424007, 3976.741511801724, 3977.880663580097, 3982.900427489278, 4502.482214545304, 4510.0, 4517.141743068806, 4520.615747661485, 4536.296873984537, 5160.819371321985, 5223.686578805284, 5227.3988491323225, 5296.4703529647495, 5368.651037682538, 1353.5465619017543, 1364.5496985994598, 1369.9794503082462, 1370.8012338211104, 1379.8068270442145, 862.3618522293458, 864.2610567964425, 878.2359347367703, 898.6540182029835, 912.2792993535033, 4512.255477846119, 4628.328892310664, 4643.419572553431, 4643.535646435329, 4657.090592856913, 5452.618316717871, 5471.50756431923, 5476.91784623231, 5515.4760297771645, 5522.889542209214, 4473.642108631302, 4620.884477888079, 4663.626909847204, 4670.673052886334, 4694.342792009122, 2881.755050820662, 2886.737986075721, 2894.696056914036, 2905.142982820073, 2907.694692057346, 5106.387233532, 5106.4382917879, 5140.948590514122, 5146.176611742103, 5146.588272938231, 5349.253731343284, 5526.944730552643, 5535.086710692691, 5536.501714845684, 5605.271314729059, 5103.8724031898755, 5122.410922743858, 5123.38519377677, 5128.692183493185, 5133.0, 5407.351117865881, 5437.592180586393, 5449.5640348772795, 5453.7818487260065, 5474.863128421821, 5094.617903657315, 5328.413874473727, 5378.09077777399, 5397.190421436816, 5399.757010934596, 5095.847124586268, 5166.560842328294, 5182.922256166236, 5189.636725429184, 5196.584273258055, 3778.8852288574385, 3782.508273924372, 3799.6580307772433, 3806.657400833938, 3810.8285127169897, 5190.117679994334, 5469.854833470691, 5486.862828429321, 5487.451254874481, 5501.807436739695, 5259.947400525945, 5294.629375943647, 5322.281491998686, 5336.706481143575, 5338.332708411449, 5178.71517066565, 5299.311089558333, 5308.681479111266, 5316.760745766527, 5317.282166907573, 5218.6868787872845, 5220.0, 5232.189010703347, 5236.502532259429, 5257.868553286198, 5104.770285337095, 5229.686218826882, 5359.276497672764, 5374.140137577969, 5374.274472946102, 5235.947640523546, 5249.0, 5269.367675878919, 5282.550983166474, 5282.652923504482], "value": 3986.7014050695516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.6472069803003, 695.5339922252094, 718.0342439418982, 741.9183889772124, 765.2653452685422, 12684.873151268484, 14038.649033774162, 14596.927015364934, 14656.974011819164, 15077.396904123849, 14108.43566257351, 14194.219317937535, 14322.856771432282, 14325.57023289303, 14368.856311436883, 619.3404024713687, 760.6843160088571, 788.3771820262015, 788.5702292250709, 793.4128744728916, 757.6704133701829, 777.2848978939361, 779.9961000194991, 781.2929298984428, 781.9139894611588, 821.0352835418389, 821.2608652213027, 828.6436832162168, 834.4159088637947, 837.2590257622018, 815.7634286057066, 817.5217497763786, 819.1071731812353, 819.2585709932521, 823.2261674026396, 602.593249556552, 602.9849253768647, 603.5895590998119, 605.8909396308662, 606.3966353478318, 13269.800952985714, 13279.800802987962, 13282.601521954357, 13294.534691285855, 13311.73376532464, 13080.345982700923, 13080.803787943189, 13248.0, 13427.0, 13497.797533037012, 10679.572817087308, 10755.569777208902, 10774.138068954544, 10819.945900270448, 10896.455177241185, 3350.162459385154, 3353.295807880348, 3378.1048022274117, 3466.6533346665383, 3475.461303497962, 59781.701091494266, 60539.69730151321, 60607.0, 60706.39293607096, 60927.0, 9865.009342432653, 10097.798044039226, 10172.796544069226, 10187.235957303232, 10231.232657550714, 18209.271629134688, 18446.35437759699, 18467.16897739605, 18549.81450185508, 18556.907215464107, 6564.245111812107, 6606.339366063451, 6846.075779769767, 6895.55178913369, 7086.964565177244, 3799.715021373408, 3831.65515103642, 3880.3791393376923, 3922.78424686645, 3930.1353702185475, 2929.838858862783, 3048.8018278811805, 3052.2979714665753, 3053.541968704668, 3054.7098025687524, 510.61448606302, 525.3748039832587, 531.0997858629586, 534.7620308962474, 541.3233458177278, 545.3346916761544, 574.1129954220739, 576.6770608459276, 577.6505214345344, 582.2056599484032, 7865.292123708779, 8065.153158918229, 8238.629261683238, 8272.0, 8434.15658434164, 487.39562941951726, 505.91399462091533, 509.66362200947935, 523.2883278740909, 529.7086602368681, 3896.7272290939363, 3897.590752970954, 3959.604039596017, 3962.900927476836, 3978.3833505806647, 91035.0, 91312.0, 93329.0, 94861.5256923711, 95306.52346738221, 48608.513914861105, 67233.0, 80658.0, 81950.0, 82893.0, 46657.30014049792, 62712.68643656844, 65418.67290663516, 69698.0, 71478.64260678663, 8243.134470880712, 8890.24432923183, 8959.328050396116, 8962.86555701652, 9139.680111196076, 30982.380352393277, 38193.80903095467, 45349.09301814011, 45660.771696142634, 46054.078918422114, 54325.185122223986, 61945.0, 62541.0, 62718.0, 62730.37269627428, 11192.272502287326, 11253.943730281297, 11339.433028348714, 11486.712832179262, 11540.365279909685, 12402.25586464815, 12521.749565008831, 12547.0, 12553.748925021266, 13689.247091410069, 11562.0, 11730.354830484064, 11775.52897884075, 12316.938415307866, 12486.18839775448, 11938.343391113573, 12181.223820615638, 12325.876741232833, 12532.642280474216, 12536.37184881298, 11498.48256828428, 11713.824292635787, 11809.64571062835, 11959.0, 12337.074719396262, 10094.596216151565, 10231.334963227366, 10264.178865690577, 10299.12457441096, 10435.217358697977, 9892.455914924749, 10246.6413675521, 10256.333338332985, 10274.383536987805, 10314.896851031393], "value": 6558.363616738653, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 110.0, 114.0, 114.0, 116.0, 115.0, 115.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 146.0, 190.0, 125.0, 150.0, 153.0, 129.0, 180.0, 124.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 175.0, 164.0, 163.0, 162.0, 164.0, 166.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 80.0, 148.0, 79.0, 79.0, 76.0, 77.0, 169.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 138.0, 86.0, 85.0, 85.0, 135.0, 86.0, 87.0, 139.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 68.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 69.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 85.0, 80.0, 87.0, 79.0, 84.0, 84.0, 84.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 152.0, 139.0, 135.0, 138.0, 129.0, 140.0, 174.0, 142.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 182.0, 167.0, 165.0, 170.0, 167.0, 164.0, 165.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 68.0, 69.0, 70.0, 65.0, 68.0, 70.0, 70.0], "value": 68.8, "unit": "score"}]}]} 08:43:44 INFO - Return code: 0 08:43:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:44 ERROR - # TBPL SUCCESS # 08:43:44 INFO - Running post-action listener: _resource_record_post_action 08:43:44 INFO - ##### 08:43:44 INFO - ##### Finished run-tests step (success) 08:43:44 INFO - ##### 08:43:44 INFO - Running post-run listener: _resource_record_post_run 08:43:44 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550088704; Read time: 12; Write time: 446488 08:43:44 INFO - TinderboxPrint: CPU usage
13.3% 08:43:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:43:44 INFO - TinderboxPrint: I/O write bytes / time
550,088,704 / 446,488 08:43:44 INFO - TinderboxPrint: CPU idle
8,294.0 (86.7%) 08:43:44 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 08:43:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247451648; Read time: 0; Write time: 234388 08:43:44 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302637056; Read time: 12; Write time: 212100 08:43:44 INFO - Running post-run listener: _upload_blobber_files 08:43:44 INFO - Blob upload gear active. 08:43:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:44 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 08:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:47 INFO - (blobuploader) - INFO - Done attempting. 08:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:47 INFO - (blobuploader) - INFO - Done attempting. 08:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:52 INFO - (blobuploader) - INFO - Done attempting. 08:43:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:52 INFO - Return code: 0 08:43:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a0e32e3a934ee31d4d9f0775641554866031b01fce1e2f6ba16b45088e2874fe0a07d18d4b9a419cb668d42c51f6459d135204792e65c27c83d3353a5741c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8abc42f64c79259fab78bb22da2f245212ef38926feb6af4fd8b81700ed56f07ace8406da6d0191a46a95a600a287618f3e77b0ceaefc2558320889c843ee73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8422f885aca8e61c69df94380c007ba488e4fb0160f0d1720a26637be9cf143a5a5fc07595144ba41adf7ee24a83d95ce10a230980b3e7cd2da84d1f4a6a9db1"} 08:43:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:52 INFO - Contents: 08:43:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a0e32e3a934ee31d4d9f0775641554866031b01fce1e2f6ba16b45088e2874fe0a07d18d4b9a419cb668d42c51f6459d135204792e65c27c83d3353a5741c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8abc42f64c79259fab78bb22da2f245212ef38926feb6af4fd8b81700ed56f07ace8406da6d0191a46a95a600a287618f3e77b0ceaefc2558320889c843ee73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8422f885aca8e61c69df94380c007ba488e4fb0160f0d1720a26637be9cf143a5a5fc07595144ba41adf7ee24a83d95ce10a230980b3e7cd2da84d1f4a6a9db1"} 08:43:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:52 INFO - Copying logs to upload dir... 08:43:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.194937 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-19 08:43:52.184331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:43:52.187766) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 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/Firefox-Non-PGO/sha512/3a0e32e3a934ee31d4d9f0775641554866031b01fce1e2f6ba16b45088e2874fe0a07d18d4b9a419cb668d42c51f6459d135204792e65c27c83d3353a5741c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8abc42f64c79259fab78bb22da2f245212ef38926feb6af4fd8b81700ed56f07ace8406da6d0191a46a95a600a287618f3e77b0ceaefc2558320889c843ee73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8422f885aca8e61c69df94380c007ba488e4fb0160f0d1720a26637be9cf143a5a5fc07595144ba41adf7ee24a83d95ce10a230980b3e7cd2da84d1f4a6a9db1"} build_url:https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/EdaZFpt-S1GPoxLv4mIS3Q/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/Firefox-Non-PGO/sha512/3a0e32e3a934ee31d4d9f0775641554866031b01fce1e2f6ba16b45088e2874fe0a07d18d4b9a419cb668d42c51f6459d135204792e65c27c83d3353a5741c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8abc42f64c79259fab78bb22da2f245212ef38926feb6af4fd8b81700ed56f07ace8406da6d0191a46a95a600a287618f3e77b0ceaefc2558320889c843ee73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8422f885aca8e61c69df94380c007ba488e4fb0160f0d1720a26637be9cf143a5a5fc07595144ba41adf7ee24a83d95ce10a230980b3e7cd2da84d1f4a6a9db1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:43:52.217088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:43:52.217443) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468941790.713115-30754756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:43:52.301126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:43:52.301451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:43:52.301752) ========= ========= Total master_lag: 0.18 =========