builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1467123600.2 results: success (0) buildid: 20160628043018 builduid: 345a7297b3cb4547971e9adcaa7bb4c8 revision: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.203113) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.203582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.203864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.219316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.219615) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 07:20:00-- 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% 223M=0s 2016-06-28 07:20:00 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080468 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.314361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.314682) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.364345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:00.364690) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 170e18a9341f79cdebd6cfa5114c1b4a2469c030 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 170e18a9341f79cdebd6cfa5114c1b4a2469c030 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 07:20:00,695 truncating revision to first 12 chars 2016-06-28 07:20:00,695 Setting DEBUG logging. 2016-06-28 07:20:00,695 attempt 1/10 2016-06-28 07:20:00,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/170e18a9341f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 07:20:01,012 unpacking tar archive at: mozilla-inbound-170e18a9341f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:01.097719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:01.098483) ========= script_repo_revision: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:01.099220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:01.099534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:20:01.110554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-28 07:20:01.110939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:01 INFO - MultiFileLogger online at 20160628 07:20:01 in /builds/slave/test 07:20:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:01 INFO - {'append_to_log': False, 07:20:01 INFO - 'base_work_dir': '/builds/slave/test', 07:20:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:01 INFO - 'branch': 'Mozilla-Inbound', 07:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:01 INFO - 'config_files': ('talos/linux_config.py',), 07:20:01 INFO - 'default_actions': ('clobber', 07:20:01 INFO - 'read-buildbot-config', 07:20:01 INFO - 'download-and-extract', 07:20:01 INFO - 'populate-webroot', 07:20:01 INFO - 'create-virtualenv', 07:20:01 INFO - 'install', 07:20:01 INFO - 'run-tests'), 07:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:01 INFO - 'download_minidump_stackwalk': True, 07:20:01 INFO - 'download_symbols': 'ondemand', 07:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:01 INFO - 'installer_path': 'installer.exe', 07:20:01 INFO - 'log_level': 'info', 07:20:01 INFO - 'log_name': 'talos', 07:20:01 INFO - 'log_to_console': True, 07:20:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:01 INFO - 'opt_config_files': (), 07:20:01 INFO - 'pip_index': False, 07:20:01 INFO - 'sps_profile': False, 07:20:01 INFO - 'sps_profile_interval': 0, 07:20:01 INFO - 'suite': 'dromaeojs-e10s', 07:20:01 INFO - 'system_bits': '32', 07:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:01 INFO - 'title': 'talos-linux64-ix-006', 07:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:01 INFO - 'use_talos_json': True, 07:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:01 INFO - 'work_dir': 'build'} 07:20:01 INFO - ##### 07:20:01 INFO - ##### Running clobber step. 07:20:01 INFO - ##### 07:20:01 INFO - Running pre-action listener: _resource_record_pre_action 07:20:01 INFO - Running main action method: clobber 07:20:01 INFO - rmtree: /builds/slave/test/build 07:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:02 INFO - Running post-action listener: _resource_record_post_action 07:20:02 INFO - ##### 07:20:02 INFO - ##### Finished clobber step (success) 07:20:02 INFO - ##### 07:20:02 INFO - ##### 07:20:02 INFO - ##### Running read-buildbot-config step. 07:20:02 INFO - ##### 07:20:02 INFO - Running pre-action listener: _resource_record_pre_action 07:20:02 INFO - Running main action method: read_buildbot_config 07:20:02 INFO - Using buildbot properties: 07:20:02 INFO - { 07:20:02 INFO - "project": "", 07:20:02 INFO - "product": "firefox", 07:20:02 INFO - "script_repo_revision": "production", 07:20:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:20:02 INFO - "repository": "", 07:20:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:20:02 INFO - "buildid": "20160628043018", 07:20:02 INFO - "pgo_build": "True", 07:20:02 INFO - "basedir": "/builds/slave/test", 07:20:02 INFO - "buildnumber": 784, 07:20:02 INFO - "slavename": "talos-linux64-ix-006", 07:20:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:20:02 INFO - "platform": "ubuntu64_hw", 07:20:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:20:02 INFO - "branch": "mozilla-inbound", 07:20:02 INFO - "repo_path": "integration/mozilla-inbound", 07:20:02 INFO - "revision": "170e18a9341f79cdebd6cfa5114c1b4a2469c030", 07:20:02 INFO - "stage_platform": "linux64-pgo", 07:20:02 INFO - "builduid": "345a7297b3cb4547971e9adcaa7bb4c8", 07:20:02 INFO - "slavebuilddir": "test" 07:20:02 INFO - } 07:20:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:20:02 INFO - Running post-action listener: _resource_record_post_action 07:20:02 INFO - ##### 07:20:02 INFO - ##### Finished read-buildbot-config step (success) 07:20:02 INFO - ##### 07:20:02 INFO - ##### 07:20:02 INFO - ##### Running download-and-extract step. 07:20:02 INFO - ##### 07:20:02 INFO - Running pre-action listener: _resource_record_pre_action 07:20:02 INFO - Running main action method: download_and_extract 07:20:02 INFO - mkdir: /builds/slave/test/build/tests 07:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:02 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:20:02 INFO - Downloaded 1361 bytes. 07:20:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:02 INFO - Using the following test package requirements: 07:20:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:20:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:20:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'jsshell-linux-x86_64.zip'], 07:20:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:20:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:20:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:20:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:20:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:20:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:02 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:20:04 INFO - Downloaded 24266499 bytes. 07:20:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:20:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:20:05 INFO - Return code: 0 07:20:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:05 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:20:06 INFO - Downloaded 24266499 bytes. 07:20:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:20:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:20:07 INFO - Return code: 0 07:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:07 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:20:08 INFO - Downloaded 14405240 bytes. 07:20:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:20:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:20:09 INFO - Return code: 0 07:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:09 INFO - https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:20:10 INFO - Downloaded 60326127 bytes. 07:20:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:10 INFO - mkdir: /builds/slave/test/properties 07:20:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:20:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:20:10 INFO - Contents: 07:20:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:11 INFO - Running post-action listener: _resource_record_post_action 07:20:11 INFO - Running post-action listener: set_extra_try_arguments 07:20:11 INFO - ##### 07:20:11 INFO - ##### Finished download-and-extract step (success) 07:20:11 INFO - ##### 07:20:11 INFO - ##### 07:20:11 INFO - ##### Running populate-webroot step. 07:20:11 INFO - ##### 07:20:11 INFO - Running pre-action listener: _resource_record_pre_action 07:20:11 INFO - Running main action method: populate_webroot 07:20:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:20:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:20:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:20:11 INFO - '--tppagecycles', 07:20:11 INFO - '7'], 07:20:11 INFO - 'tests': ['tsvgm']}}, 07:20:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:20:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:20:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:20:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:20:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['damp', 'tps']}, 07:20:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'tests': ['damp', 'tps']}, 07:20:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['dromaeo_dom']}, 07:20:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:20:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['basic_compositor_video']}, 07:20:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:20:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['a11yr', 07:20:11 INFO - 'ts_paint', 07:20:11 INFO - 'tpaint', 07:20:11 INFO - 'sessionrestore', 07:20:11 INFO - 'sessionrestore_no_auto_restore', 07:20:11 INFO - 'tabpaint']}, 07:20:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['tsvgx', 07:20:11 INFO - 'tsvgr_opacity', 07:20:11 INFO - 'tart', 07:20:11 INFO - 'tscrollx', 07:20:11 INFO - 'cart']}, 07:20:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:20:11 INFO - 'tsvgr_opacity', 07:20:11 INFO - 'tart', 07:20:11 INFO - 'tscrollx', 07:20:11 INFO - 'cart']}, 07:20:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'talos_options': ['--disable-e10s'], 07:20:11 INFO - 'tests': ['tp5o']}, 07:20:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'tests': ['tp5o']}, 07:20:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'talos_options': ['--disable-e10s', 07:20:11 INFO - '--xperf_path', 07:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:11 INFO - 'tests': ['tp5n']}, 07:20:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:11 INFO - 'talos_options': ['--xperf_path', 07:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:11 INFO - 'tests': ['tp5n']}}, 07:20:11 INFO - 'talos.zip': {'path': '', 07:20:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:20:11 INFO - Running post-action listener: _resource_record_post_action 07:20:11 INFO - ##### 07:20:11 INFO - ##### Finished populate-webroot step (success) 07:20:11 INFO - ##### 07:20:11 INFO - ##### 07:20:11 INFO - ##### Running create-virtualenv step. 07:20:11 INFO - ##### 07:20:11 INFO - Running pre-action listener: _resource_record_pre_action 07:20:11 INFO - Running main action method: create_virtualenv 07:20:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:20:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:20:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:20:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:20:11 INFO - Using real prefix '/usr' 07:20:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:20:14 INFO - Installing pip.................done. 07:20:14 INFO - Return code: 0 07:20:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:14 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:20:14 INFO - Using env: {'DISPLAY': ':0', 07:20:14 INFO - 'HOME': '/home/cltbld', 07:20:14 INFO - 'LANG': 'en_US.UTF-8', 07:20:14 INFO - 'LANGUAGE': 'en_US:en', 07:20:14 INFO - 'LOGNAME': 'cltbld', 07:20:14 INFO - 'MAIL': '/var/mail/cltbld', 07:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:14 INFO - 'MOZ_NO_REMOTE': '1', 07:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:14 INFO - 'NO_EM_RESTART': '1', 07:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:14 INFO - 'PWD': '/builds/slave/test', 07:20:14 INFO - 'SHELL': '/bin/bash', 07:20:14 INFO - 'SHLVL': '1', 07:20:14 INFO - 'TERM': 'linux', 07:20:14 INFO - 'TMOUT': '86400', 07:20:14 INFO - 'USER': 'cltbld', 07:20:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:14 INFO - '_': '/tools/buildbot/bin/python'} 07:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:20:14 INFO - Cleaning up... 07:20:14 INFO - Return code: 0 07:20:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:14 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:20:14 INFO - Using env: {'DISPLAY': ':0', 07:20:14 INFO - 'HOME': '/home/cltbld', 07:20:14 INFO - 'LANG': 'en_US.UTF-8', 07:20:14 INFO - 'LANGUAGE': 'en_US:en', 07:20:14 INFO - 'LOGNAME': 'cltbld', 07:20:14 INFO - 'MAIL': '/var/mail/cltbld', 07:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:14 INFO - 'MOZ_NO_REMOTE': '1', 07:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:14 INFO - 'NO_EM_RESTART': '1', 07:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:14 INFO - 'PWD': '/builds/slave/test', 07:20:14 INFO - 'SHELL': '/bin/bash', 07:20:14 INFO - 'SHLVL': '1', 07:20:14 INFO - 'TERM': 'linux', 07:20:14 INFO - 'TMOUT': '86400', 07:20:14 INFO - 'USER': 'cltbld', 07:20:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:14 INFO - '_': '/tools/buildbot/bin/python'} 07:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:14 INFO - Downloading/unpacking psutil>=3.1.1 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:16 INFO - Installing collected packages: psutil 07:20:16 INFO - Running setup.py install for psutil 07:20:16 INFO - building 'psutil._psutil_linux' extension 07:20:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:20:17 INFO - building 'psutil._psutil_posix' extension 07:20:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:17 INFO - Successfully installed psutil 07:20:17 INFO - Cleaning up... 07:20:17 INFO - Return code: 0 07:20:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:17 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:20:17 INFO - Using env: {'DISPLAY': ':0', 07:20:17 INFO - 'HOME': '/home/cltbld', 07:20:17 INFO - 'LANG': 'en_US.UTF-8', 07:20:17 INFO - 'LANGUAGE': 'en_US:en', 07:20:17 INFO - 'LOGNAME': 'cltbld', 07:20:17 INFO - 'MAIL': '/var/mail/cltbld', 07:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:17 INFO - 'MOZ_NO_REMOTE': '1', 07:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:17 INFO - 'NO_EM_RESTART': '1', 07:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:17 INFO - 'PWD': '/builds/slave/test', 07:20:17 INFO - 'SHELL': '/bin/bash', 07:20:17 INFO - 'SHLVL': '1', 07:20:17 INFO - 'TERM': 'linux', 07:20:17 INFO - 'TMOUT': '86400', 07:20:17 INFO - 'USER': 'cltbld', 07:20:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:17 INFO - '_': '/tools/buildbot/bin/python'} 07:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:20:19 INFO - Installing collected packages: mozsystemmonitor 07:20:19 INFO - Running setup.py install for mozsystemmonitor 07:20:19 INFO - Successfully installed mozsystemmonitor 07:20:19 INFO - Cleaning up... 07:20:19 INFO - Return code: 0 07:20:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:19 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:20:19 INFO - Using env: {'DISPLAY': ':0', 07:20:19 INFO - 'HOME': '/home/cltbld', 07:20:19 INFO - 'LANG': 'en_US.UTF-8', 07:20:19 INFO - 'LANGUAGE': 'en_US:en', 07:20:19 INFO - 'LOGNAME': 'cltbld', 07:20:19 INFO - 'MAIL': '/var/mail/cltbld', 07:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:19 INFO - 'MOZ_NO_REMOTE': '1', 07:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:19 INFO - 'NO_EM_RESTART': '1', 07:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:19 INFO - 'PWD': '/builds/slave/test', 07:20:19 INFO - 'SHELL': '/bin/bash', 07:20:19 INFO - 'SHLVL': '1', 07:20:19 INFO - 'TERM': 'linux', 07:20:19 INFO - 'TMOUT': '86400', 07:20:19 INFO - 'USER': 'cltbld', 07:20:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:19 INFO - '_': '/tools/buildbot/bin/python'} 07:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:20:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:20:22 INFO - warning: no files found matching '*.txt' 07:20:22 INFO - no previously-included directories found matching 'build' 07:20:22 INFO - no previously-included directories found matching 'dist' 07:20:22 INFO - no previously-included directories found matching '.git*' 07:20:22 INFO - Installing collected packages: jsonschema, functools32 07:20:22 INFO - Running setup.py install for functools32 07:20:22 INFO - warning: no files found matching '*.txt' 07:20:22 INFO - no previously-included directories found matching 'build' 07:20:22 INFO - no previously-included directories found matching 'dist' 07:20:22 INFO - no previously-included directories found matching '.git*' 07:20:22 INFO - Successfully installed jsonschema functools32 07:20:22 INFO - Cleaning up... 07:20:22 INFO - Return code: 0 07:20:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:22 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:20:22 INFO - Using env: {'DISPLAY': ':0', 07:20:22 INFO - 'HOME': '/home/cltbld', 07:20:22 INFO - 'LANG': 'en_US.UTF-8', 07:20:22 INFO - 'LANGUAGE': 'en_US:en', 07:20:22 INFO - 'LOGNAME': 'cltbld', 07:20:22 INFO - 'MAIL': '/var/mail/cltbld', 07:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:22 INFO - 'MOZ_NO_REMOTE': '1', 07:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:22 INFO - 'NO_EM_RESTART': '1', 07:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:22 INFO - 'PWD': '/builds/slave/test', 07:20:22 INFO - 'SHELL': '/bin/bash', 07:20:22 INFO - 'SHLVL': '1', 07:20:22 INFO - 'TERM': 'linux', 07:20:22 INFO - 'TMOUT': '86400', 07:20:22 INFO - 'USER': 'cltbld', 07:20:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:22 INFO - '_': '/tools/buildbot/bin/python'} 07:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:24 INFO - Downloading blobuploader-1.2.4.tar.gz 07:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:20:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:20:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:25 INFO - Downloading docopt-0.6.1.tar.gz 07:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:20:25 INFO - Installing collected packages: blobuploader, requests, docopt 07:20:25 INFO - Running setup.py install for blobuploader 07:20:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:20:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:20:25 INFO - Running setup.py install for requests 07:20:25 INFO - Running setup.py install for docopt 07:20:25 INFO - Successfully installed blobuploader requests docopt 07:20:25 INFO - Cleaning up... 07:20:25 INFO - Return code: 0 07:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:25 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:25 INFO - Using env: {'DISPLAY': ':0', 07:20:25 INFO - 'HOME': '/home/cltbld', 07:20:25 INFO - 'LANG': 'en_US.UTF-8', 07:20:25 INFO - 'LANGUAGE': 'en_US:en', 07:20:25 INFO - 'LOGNAME': 'cltbld', 07:20:25 INFO - 'MAIL': '/var/mail/cltbld', 07:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:25 INFO - 'MOZ_NO_REMOTE': '1', 07:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:25 INFO - 'NO_EM_RESTART': '1', 07:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:25 INFO - 'PWD': '/builds/slave/test', 07:20:25 INFO - 'SHELL': '/bin/bash', 07:20:25 INFO - 'SHLVL': '1', 07:20:25 INFO - 'TERM': 'linux', 07:20:25 INFO - 'TMOUT': '86400', 07:20:25 INFO - 'USER': 'cltbld', 07:20:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:25 INFO - '_': '/tools/buildbot/bin/python'} 07:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:25 INFO - Running setup.py (path:/tmp/pip-XNPmUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:26 INFO - Running setup.py (path:/tmp/pip-NTCRs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:26 INFO - Running setup.py (path:/tmp/pip-j9vmah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:26 INFO - Running setup.py (path:/tmp/pip-U0YTU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:26 INFO - Running setup.py (path:/tmp/pip-grJ3jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:26 INFO - Running setup.py (path:/tmp/pip-sXNKge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:26 INFO - Running setup.py (path:/tmp/pip-cIZYfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:26 INFO - Running setup.py (path:/tmp/pip-ZCK9Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:26 INFO - Running setup.py (path:/tmp/pip-g3Xhy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:26 INFO - Running setup.py (path:/tmp/pip-k8ruJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:26 INFO - Running setup.py (path:/tmp/pip-X_ksB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:26 INFO - Running setup.py (path:/tmp/pip-s6963u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:26 INFO - Running setup.py (path:/tmp/pip-lMmLg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:26 INFO - Running setup.py (path:/tmp/pip-S41au3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:26 INFO - Running setup.py (path:/tmp/pip-w7FcuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:27 INFO - Running setup.py (path:/tmp/pip-GnfyFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:27 INFO - Running setup.py (path:/tmp/pip-amD7sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:20:27 INFO - Running setup.py install for manifestparser 07:20:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Running setup.py install for mozcrash 07:20:27 INFO - Running setup.py install for mozdebug 07:20:27 INFO - Running setup.py install for mozdevice 07:20:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Running setup.py install for mozfile 07:20:27 INFO - Running setup.py install for mozhttpd 07:20:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Running setup.py install for mozinfo 07:20:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Running setup.py install for mozInstall 07:20:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:20:27 INFO - Running setup.py install for mozleak 07:20:28 INFO - Running setup.py install for mozlog 07:20:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Running setup.py install for moznetwork 07:20:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Running setup.py install for mozprocess 07:20:28 INFO - Running setup.py install for mozprofile 07:20:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Running setup.py install for mozrunner 07:20:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Running setup.py install for mozscreenshot 07:20:28 INFO - Running setup.py install for moztest 07:20:28 INFO - Running setup.py install for mozversion 07:20:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:20:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:20:28 INFO - Cleaning up... 07:20:28 INFO - Return code: 0 07:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:28 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:28 INFO - Using env: {'DISPLAY': ':0', 07:20:28 INFO - 'HOME': '/home/cltbld', 07:20:28 INFO - 'LANG': 'en_US.UTF-8', 07:20:28 INFO - 'LANGUAGE': 'en_US:en', 07:20:28 INFO - 'LOGNAME': 'cltbld', 07:20:28 INFO - 'MAIL': '/var/mail/cltbld', 07:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:28 INFO - 'MOZ_NO_REMOTE': '1', 07:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:28 INFO - 'NO_EM_RESTART': '1', 07:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:28 INFO - 'PWD': '/builds/slave/test', 07:20:28 INFO - 'SHELL': '/bin/bash', 07:20:28 INFO - 'SHLVL': '1', 07:20:28 INFO - 'TERM': 'linux', 07:20:28 INFO - 'TMOUT': '86400', 07:20:28 INFO - 'USER': 'cltbld', 07:20:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:28 INFO - '_': '/tools/buildbot/bin/python'} 07:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:29 INFO - Running setup.py (path:/tmp/pip-JDOyP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:29 INFO - Running setup.py (path:/tmp/pip-PSlWw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:29 INFO - Running setup.py (path:/tmp/pip-41HhDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:29 INFO - Running setup.py (path:/tmp/pip-i6CpE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:29 INFO - Running setup.py (path:/tmp/pip-KnxdrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:29 INFO - Running setup.py (path:/tmp/pip-8rEOKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:29 INFO - Running setup.py (path:/tmp/pip-ujWNuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:29 INFO - Running setup.py (path:/tmp/pip-R8iP5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:29 INFO - Running setup.py (path:/tmp/pip-IP9SMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:29 INFO - Running setup.py (path:/tmp/pip-70PXE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:29 INFO - Running setup.py (path:/tmp/pip-BMXEAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:29 INFO - Running setup.py (path:/tmp/pip-B9sMof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:30 INFO - Running setup.py (path:/tmp/pip-T3P6GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:30 INFO - Running setup.py (path:/tmp/pip-2yis8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:30 INFO - Running setup.py (path:/tmp/pip-XGPRhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:30 INFO - Running setup.py (path:/tmp/pip-_AaMhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:30 INFO - Running setup.py (path:/tmp/pip-bO7J4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:32 INFO - Downloading blessings-1.6.tar.gz 07:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:20:32 INFO - Installing collected packages: blessings 07:20:32 INFO - Running setup.py install for blessings 07:20:32 INFO - Successfully installed blessings 07:20:32 INFO - Cleaning up... 07:20:32 INFO - Return code: 0 07:20:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:20:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:32 INFO - Reading from file tmpfile_stdout 07:20:32 INFO - Current package versions: 07:20:32 INFO - argparse == 1.2.1 07:20:32 INFO - blessings == 1.6 07:20:32 INFO - blobuploader == 1.2.4 07:20:32 INFO - docopt == 0.6.1 07:20:32 INFO - functools32 == 3.2.3-2 07:20:32 INFO - jsonschema == 2.5.1 07:20:32 INFO - manifestparser == 1.1 07:20:32 INFO - mozInstall == 1.12 07:20:32 INFO - mozcrash == 0.17 07:20:32 INFO - mozdebug == 0.1 07:20:32 INFO - mozdevice == 0.48 07:20:32 INFO - mozfile == 1.2 07:20:32 INFO - mozhttpd == 0.7 07:20:32 INFO - mozinfo == 0.9 07:20:32 INFO - mozleak == 0.1 07:20:32 INFO - mozlog == 3.2 07:20:32 INFO - moznetwork == 0.27 07:20:32 INFO - mozprocess == 0.22 07:20:32 INFO - mozprofile == 0.28 07:20:32 INFO - mozrunner == 6.11 07:20:32 INFO - mozscreenshot == 0.1 07:20:32 INFO - mozsystemmonitor == 0.3 07:20:32 INFO - moztest == 0.7 07:20:32 INFO - mozversion == 1.4 07:20:32 INFO - psutil == 3.1.1 07:20:32 INFO - requests == 1.2.3 07:20:32 INFO - wsgiref == 0.1.2 07:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 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 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:32 INFO - Using env: {'DISPLAY': ':0', 07:20:32 INFO - 'HOME': '/home/cltbld', 07:20:32 INFO - 'LANG': 'en_US.UTF-8', 07:20:32 INFO - 'LANGUAGE': 'en_US:en', 07:20:32 INFO - 'LOGNAME': 'cltbld', 07:20:32 INFO - 'MAIL': '/var/mail/cltbld', 07:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:32 INFO - 'MOZ_NO_REMOTE': '1', 07:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:32 INFO - 'NO_EM_RESTART': '1', 07:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:32 INFO - 'PWD': '/builds/slave/test', 07:20:32 INFO - 'SHELL': '/bin/bash', 07:20:32 INFO - 'SHLVL': '1', 07:20:32 INFO - 'TERM': 'linux', 07:20:32 INFO - 'TMOUT': '86400', 07:20:32 INFO - 'USER': 'cltbld', 07:20:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:32 INFO - '_': '/tools/buildbot/bin/python'} 07:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:20:32 INFO - Cleaning up... 07:20:32 INFO - Return code: 0 07:20:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:20:32 INFO - Using env: {'DISPLAY': ':0', 07:20:32 INFO - 'HOME': '/home/cltbld', 07:20:32 INFO - 'LANG': 'en_US.UTF-8', 07:20:32 INFO - 'LANGUAGE': 'en_US:en', 07:20:32 INFO - 'LOGNAME': 'cltbld', 07:20:32 INFO - 'MAIL': '/var/mail/cltbld', 07:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:32 INFO - 'MOZ_NO_REMOTE': '1', 07:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:32 INFO - 'NO_EM_RESTART': '1', 07:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:32 INFO - 'PWD': '/builds/slave/test', 07:20:32 INFO - 'SHELL': '/bin/bash', 07:20:32 INFO - 'SHLVL': '1', 07:20:32 INFO - 'TERM': 'linux', 07:20:32 INFO - 'TMOUT': '86400', 07:20:32 INFO - 'USER': 'cltbld', 07:20:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:32 INFO - '_': '/tools/buildbot/bin/python'} 07:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:20:33 INFO - Cleaning up... 07:20:33 INFO - Return code: 0 07:20:33 INFO - Running post-action listener: _resource_record_post_action 07:20:33 INFO - Running post-action listener: _start_resource_monitoring 07:20:33 INFO - Starting resource monitoring. 07:20:33 INFO - ##### 07:20:33 INFO - ##### Finished create-virtualenv step (success) 07:20:33 INFO - ##### 07:20:33 INFO - ##### 07:20:33 INFO - ##### Running install step. 07:20:33 INFO - ##### 07:20:33 INFO - Running pre-action listener: _resource_record_pre_action 07:20:33 INFO - Running main action method: install 07:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:33 INFO - Reading from file tmpfile_stdout 07:20:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:20:33 INFO - Reading from file tmpfile_stdout 07:20:33 INFO - Output received: 07:20:33 INFO - Usage: mozinstall [options] installer 07:20:33 INFO - Options: 07:20:33 INFO - -h, --help show this help message and exit 07:20:33 INFO - -d DEST, --destination=DEST 07:20:33 INFO - Directory to install application into. [default: 07:20:33 INFO - "/builds/slave/test"] 07:20:33 INFO - --app=APP Application being installed. [default: firefox] 07:20:33 INFO - mkdir: /builds/slave/test/build/application 07:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:20:50 INFO - Reading from file tmpfile_stdout 07:20:50 INFO - Output received: 07:20:50 INFO - /builds/slave/test/build/application/firefox/firefox 07:20:50 INFO - Running post-action listener: _resource_record_post_action 07:20:50 INFO - ##### 07:20:50 INFO - ##### Finished install step (success) 07:20:50 INFO - ##### 07:20:50 INFO - ##### 07:20:50 INFO - ##### Running run-tests step. 07:20:50 INFO - ##### 07:20:50 INFO - Running pre-action listener: _resource_record_pre_action 07:20:50 INFO - Running main action method: run_tests 07:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:20:50 INFO - Python 2.7.3 07:20:50 INFO - Return code: 0 07:20:50 INFO - grabbing minidump binary from tooltool 07:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:50 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 0xf1b570>, '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 0xf1c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:20:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:20:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:20:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:20:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:20:50 INFO - Return code: 0 07:20:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:20:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:20:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:20:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:20:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:20:50 INFO - Using env: {'DISPLAY': ':0', 07:20:50 INFO - 'HOME': '/home/cltbld', 07:20:50 INFO - 'LANG': 'en_US.UTF-8', 07:20:50 INFO - 'LANGUAGE': 'en_US:en', 07:20:50 INFO - 'LOGNAME': 'cltbld', 07:20:50 INFO - 'MAIL': '/var/mail/cltbld', 07:20:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:20:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:50 INFO - 'MOZ_NO_REMOTE': '1', 07:20:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:50 INFO - 'NO_EM_RESTART': '1', 07:20:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:50 INFO - 'PWD': '/builds/slave/test', 07:20:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:20:50 INFO - 'SHELL': '/bin/bash', 07:20:50 INFO - 'SHLVL': '1', 07:20:50 INFO - 'TERM': 'linux', 07:20:50 INFO - 'TMOUT': '86400', 07:20:50 INFO - 'USER': 'cltbld', 07:20:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523', 07:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:50 INFO - '_': '/tools/buildbot/bin/python'} 07:20:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:20:50 INFO - mozversion application_buildid: 20160628043018 07:20:50 INFO - mozversion application_changeset: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 07:20:50 INFO - mozversion application_display_name: Nightly 07:20:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:20:50 INFO - mozversion application_name: Firefox 07:20:50 INFO - mozversion application_remotingname: firefox 07:20:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:20:50 INFO - mozversion application_vendor: Mozilla 07:20:50 INFO - mozversion application_version: 50.0a1 07:20:50 INFO - mozversion platform_buildid: 20160628043018 07:20:50 INFO - mozversion platform_changeset: 170e18a9341f79cdebd6cfa5114c1b4a2469c030 07:20:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:20:50 INFO - mozversion platform_version: 50.0a1 07:20:50 INFO - using testdate: 1467123650 07:20:50 INFO - actual date: 1467123650 07:20:50 INFO - starting webserver on 'localhost:33346' 07:20:50 INFO - SUITE-START | Running 2 tests 07:20:50 INFO - TEST-START | dromaeo_css 07:20:50 INFO - operating with platform_type : linux_ 07:20:50 INFO - Initialising browser for dromaeo_css test... 07:20:50 INFO - TEST-INFO | started process 5903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu5xF0C/profile http://localhost:33346/getInfo.html) 07:20:55 INFO - PROCESS | 5903 | __metrics Screen width/height:1600/1200 07:20:55 INFO - PROCESS | 5903 | colorDepth:24 07:20:55 INFO - PROCESS | 5903 | Browser inner width/height: 1024/697 07:20:55 INFO - PROCESS | 5903 | __metrics 07:20:56 ERROR - PROCESS | 5903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:20:56 INFO - TEST-INFO | 5903: exit 0 07:20:56 INFO - Browser initialized. 07:20:56 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:56 INFO - TEST-INFO | started process 6023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu5xF0C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:08 INFO - PROCESS | 6023 | RSS: Main: 168095744 07:21:08 INFO - PROCESS | 6023 | 07:21:58 INFO - PROCESS | 6023 | 1467123718226 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:24:06 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33346/tests/dromaeo/cssquery-ext.html) 07:24:07 INFO - PROCESS | 6023 | RSS: Main: 170614784 07:24:07 INFO - PROCESS | 6023 | 07:27:09 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-ext.html (next: http://localhost:33346/tests/dromaeo/cssquery-jquery.html) 07:27:10 INFO - PROCESS | 6023 | RSS: Main: 170106880 07:27:10 INFO - PROCESS | 6023 | 07:30:12 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33346/tests/dromaeo/cssquery-mootools.html) 07:30:12 INFO - PROCESS | 6023 | RSS: Main: 171708416 07:30:12 INFO - PROCESS | 6023 | 07:33:14 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33346/tests/dromaeo/cssquery-prototype.html) 07:33:15 INFO - PROCESS | 6023 | RSS: Main: 169332736 07:33:15 INFO - PROCESS | 6023 | 07:36:17 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33346/tests/dromaeo/cssquery-yui.html) 07:36:18 INFO - PROCESS | 6023 | RSS: Main: 171175936 07:36:18 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | Cycle 1(1): loaded http://localhost:33346/tests/dromaeo/cssquery-yui.html (next: http://localhost:33346/tests/dromaeo/cssquery-dojo.html) 07:39:20 INFO - PROCESS | 6023 | RSS: Main: 172433408 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | __start_tp_report 07:39:20 INFO - PROCESS | 6023 | _x_x_mozilla_page_load 07:39:20 INFO - PROCESS | 6023 | _x_x_mozilla_page_load_details 07:39:20 INFO - PROCESS | 6023 | |i|pagename|runs| 07:39:20 INFO - PROCESS | 6023 | |0;dojo.html;3069.1559821049213;3087.0275863103107;3106.8912588059416;3131.1545882611695;3139.356431931454;5276.577873770104;5306.946930530694;5327.653702509339;5395.10980688186;5398.568114550836;5286.524212820846;5340.973295133528;5350.732463376835;5405.567554595623;5434.0218760623075;4900.926486102702;4966.701997880121;4982.302477653131;5020.7489625518765;5026.371703537058;4942.357493525837;5078.898422031557;5084.949150508503;5100.566451851597;5119.078565858144;4948.529889660476;5021.6735912165595;5033.219850923113;5054;5062.0888240116765;4955.182394904837;4964.652474326798;4973.403191616993;4979.07887040895;5032.6477146599755;4956.950430495685;4958.528939750718;4976.900461990776;4978.6017118630425;4994.87512812179;5304.92042619361;5312.415634280226;5313.973430132824;5397.8110766123;5416.214648875891;5770.076787713988;5782.56630752691;5784.566157538159;5800.332961709373;5822.417758224186;5590.888182236373;5851.268591426072;5855.795047173328;5857.4435428634215;5894.852628684274;5283.128283833163;5329.600279979017;5386.1920711893135;5399.3250843644155;5441.5102640762525;5846.152307915413;5866.823995280149;5878.676672782953;5886.175935369051;5898.085796701518;5458.317710286215;5644;5682.715864206773;5687.03320435527;5695.1741997410145;5714.514266287329;5744.511716504144;5757.337906140764;5785.537157027427;5795.275590551181;5728.627639203439;5765.711714414262;5777.62445441045;5789.536837053026;5798.188253644493;5627.296587926509;5733.0540460823495;5779.219805326311;5788.45009724084;5791.681457519792;4235.2800023996;4327.891802704895;4330.155619654137;4387.758673272937;4398.186335527937;3924.0974575847713;3960.6237407446247;3962.0689138052535;3962.3660214365564;3968.6428221460205;5501.697406642593;5530.972345138329;5537.501624853782;5553.972230138824;5597.916031259534;5612.270404847425;5668.206451096849;5669.376368599451;5831.912521312183;5932.525397968152;5551.72241387929;5565.276514053228;5574.358948720868;5590.217369568264;5628.04323265046;5032.370953630796;5054.570361519239;5064.949350506447;5064.974675126601;5100.234964755242;5802.883942321215;5963.731632076567;6017.157597936292;6028.487578555872;6083.391660833881;5886.3525012247765;5894.646321220741;5911.586188966731;5920.822375328747;5955.67243801595;6039.818805435844;6063.393660633901;6067.575269731076;6069.939300606938;6094.963856144377;5463.235147079492;5611.8877622448135;5633.690147041952;5669.291338582677;5763.02028655138;5777.8555536111935;5800.1299805029585;5803.709814509342;5804.21643078179;5815.563832712648;5625.268715067179;5658.321001479849;5665.093585026376;5668;5673.290838645169;5393.919091213556;5540.556755459635;5597.804076857454;5602.551795856403;5653.632513886584;5532.557395408438;5549.611527193219;5557.583181261502;5564.888702226014;5586.608937374344;5510.283663123768;5635.380108188178;5683.062294721325;5706.372299047184;5713.285839270091;5417.1061774808295;5457.454254574511;5475.589330800126;5501.0648189807025;5520.36515800672 07:39:20 INFO - PROCESS | 6023 | |1;ext.html;549.7361266592036;599.3048064245476;614.9292831324398;629.0407129128076;648.377557544757;42536.36195457067;43487.565124348745;43529;43631.12737745243;43631.34552981704;36617.45073823895;36897;36938.63061369386;37056.62943370565;37184;8912.955435222815;9001.77495562613;9026.729198124067;9047.411918225294;9050.77373065672;8846.115388461167;8866.157715017096;8935.731928042169;8953.373263871532;8978.057303983085;8903.109689031078;8935.06181850906;8940.821183576325;8945.463272203657;8957.417767845069;8819.735407937773;8887.822243555158;8935.553222338922;8940.240079593243;8943.150400711955;8874.511901845395;8898.466092034434;8939.74843521901;8955;8965.820683586357;41941.79029104865;42070.579294206975;42277;42404.363934541005;42448.36327455091;3306.553615261933;3432.7940323580415;3452.7928324300624;3490.4764285357146;3836.271108489378;33312.50031249533;33488.83255583731;33523.49714754256;33569.16077098068;33694.49458258128;4458.554144585548;4467.660254654661;4483.910321793546;4507.481639611454;4533.818647254106;371432;372092;372947;374500.99999999726;375264;61426;61431;61497.38502615006;61712.69143654253;61736.38263617306;34776;35684.82157589247;64800.67599662066;64902;64930;16627.168641567874;16674.082925439216;16779.412720554723;16856.831431685772;16888.240029198714;12735.299558524184;12851.036172287117;12867.678308042186;12895.290759008345;12899;15615.765763513557;15865.127417991891;15904.681906361808;16126.75809862853;16130.193490325437;7135.464840136907;7146.39206178616;7323.304286092813;7361.975446763054;7394.186639469654;921.4885738415244;982.5185659027026;1041.5885725138528;1070.421972135054;1086.0822604898847;32547.349053018806;32657;33060.17349566232;33124.34743946469;33222.50166247508;1095.5782023920847;1136.420425582942;1157.3576664950865;1164.976700465986;1181.8640856301636;17285.91357043232;17355.21901514435;17363.652726945642;17446.389376371768;17453.47639570815;566706;569482;574507;575644;575916;59023;59643.403565964654;59650;59698.70150649219;59823.401765981784;1276.7401698992917;1304.4390911907972;1316.7300703355788;1318.5055604148445;1344.1867670059669;31283.37433251368;31739;32642.673573263964;33282.500762489064;33295.50056749102;52549.21176182284;55702.44297557135;57614.423855760906;57785.42214577801;61925.38074619376;526893;530797;534884;535102;536208;45675.54324456713;46093.76953115213;46617;46893.29660055033;47280;51022.74488627533;51218.23172652339;51824.222636659724;52337;52707.20939185992;43109.628970405676;43360.783196083816;43693.56306436895;43724.56275437332;44007.119857603306;43029.139417210856;43155.78422107869;43252.783736082376;43459.34810977775;44375;40945.79527102345;42408;42418.363724544775;43702.56297436985;45201.773991129834;35141.297174055864;36397.818010909774;36501.53235442629;36901;37474;28865.7113428863;29396;29443.558346625246;29630.703692963656;29843.403131937674 07:39:20 INFO - PROCESS | 6023 | |2;jquery.html;388.8949983504454;392.5583718316893;393.36471598368627;395.74078978269245;412.77091214376026;13880.917862320632;18009.819901800976;18022.819771802293;19496.41510754676;19550.608987820237;17445.476635700918;17988.82011179888;18294.451166464994;18309;18334.908325458353;5155.871103222431;5562.082256427695;5755.2230448889495;5764.365919748845;5772;5691.743871525791;5721.570882183832;5733.426657334275;5737.713114344287;5745.368009518949;5572.331320241577;5687.345955215141;5697.6296540724725;5706.3722990471015;5744.4829965303115;5501.504864562208;5649.406812284733;5670.829875103733;5686.2039314496005;5693;4953.826616068421;5057.216131499624;5280.102382594968;5283.524482796567;5287.074761916688;13036.217826930415;13394.464221431132;13462.663433414244;13497.730045399136;13506.257155856423;2181.5854987552475;2187.9015444305046;2423.8303318767694;2621.5150197213384;2932.2522756697117;9270;9826.4104153751;10646.25476216665;12125.575604853788;13549.52576659822;1850.4826042645036;1865.813418658137;1896.9146388412555;1955.9608807823906;2016.8487363447653;79004.60497697532;79429.60285198595;79934;81045;83163;10664.146868250522;10735.194860385502;10859.479672845808;10948.069414099891;11029.393383363831;14916.328765205591;15046.097234165765;15122.470713524974;15173.468928587446;15207.239638018276;7010.719571217196;7128.893066604005;7228.602426866572;7326.926730732731;7365.631718414058;6678.699458524378;6686.398224159751;6707.765228216989;6764.680887226944;6814.897776533356;4609.723416595015;4613.607843333354;4614.815407383667;4634.050019745944;4711;1923.5479662279354;1944.1251436853472;1944.474991752219;1992.900354982245;2005.5888542848681;959.8320293948531;999.7250756042147;1002.9598816047277;1028.2904546519974;1047.9109275711498;17575.824241757673;18136.45590632283;18287.72568411475;18493.260269589067;18545.165467553994;970.112347202302;987.2398253344884;987.9604815807287;1046.2676126711333;1067.4876059491487;9714.659986900424;10335.914728953352;10337.793244135226;10344.431056291825;10441.477926103664;336872;343586;460373;475089;477161;93760.53119734357;97974.51012744891;101789.49105254427;102179;102505;1018.2922868606396;1033.0341131042348;1048.1876545677162;1057.9947100264449;1059.9523021464054;16456.588585285463;16671.333146674482;16972.06653634062;17159.7426038607;17443.476695699148;30319;35972.64027359693;37779.62220377761;42266;42496;60339.698301508215;62026;62551.37448625456;63082.684586576775;63636.04545931907;7379.188289288067;7734.917111604267;8113.3509319253135;8243.83512329762;8272.875906861282;12247.938760306142;12385.133040687066;12441.937790311353;12482.875171248172;12537.498500059895;10196.949015254877;10221.897781022095;10234.48827558634;10294.742631434274;10553.683389498327;10041.096301332915;10146.898531014594;10188.439635820101;10208.081272685495;10354.534045968101;10477.31897426665;10506.530965223319;10529.315594486334;10736.785264294827;11066.059384952368;7450.7392241273465;7887.881681774893;7935.722249721232;7950.204979502004;7962.562059086806;9837.409755414697;9860.30977831545;10036.096751292127;10068;10219.59121635156 07:39:20 INFO - PROCESS | 6023 | |3;mootools.html;1459.3287087939548;1499.3702644889147;1597.1455271429788;1712.2808420463405;1728.213662783433;7927.6828926843;8439.071702112762;8789.604467798948;8875.644974201032;8881.245094166996;8821.117888211176;9080.682176123837;9179.403338782975;9193.172614464696;9193.448393096402;2352.5882970480184;2391.4260577461373;2393.0308225168833;2393.198278576679;2394.0184524345023;2338.649202619612;2353.082297903819;2358.5282943411303;2368.6683864259016;2369.4194922244073;2328.208409140892;2344.284993077111;2348.377679914824;2372.110458578033;2384.8688322142275;2272.2728726807427;2278.737945136314;2286.8399212055165;2309.872956987365;2342.461233916209;2286.3826766772877;2297.9655305170436;2314.9421264468524;2323.7095363079616;2331.661909023182;9149.908500914973;9209.76975575616;9226.169644732006;9242.12199841014;9304.348695591312;5309.601779866525;5323.22813192085;5443.918341224885;5451.64564303323;5461.42655021221;3219.17910932713;3240.837958102109;3242.3029048754397;3283.770136090475;3322.568066151409;1139.6865861888048;1151.1366475143643;1152.7406333574963;1158.3050169898079;1162.1980833225048;12990.415431305613;13007.739845203043;13032.999999999905;13050.804237936438;13064.21614703121;4670.416197975253;4695.859124226278;4799.112164249625;4807.495213002654;4832.057748738962;10679.893201068046;10862.945685271523;10867.402292873969;10884.836727449094;10896.61861834832;5397.487238712316;5414.566834653218;5468.890622187534;5469.890602187934;5472.5348345391085;4322.502912165141;4620.653450991122;4689.273162659793;4753.5959443447;4841.782119804618;3858.170493343888;3903.434002069741;3915;3963.2271707016853;3970.9205815884097;1260.6785269756338;1294.825198598196;1315.5658632651202;1317.0451422718452;1320.7424552212226;988.1255089245925;999.1107913956585;1003.6637726361605;1003.7590978165334;1016.7051555048953;6203.131561581382;6278.717457714414;6366.299707032223;6370.872582548323;6391.712372943229;449.6717396300719;462.08507155831643;464.1019627021656;469.3382330913396;469.80972706054104;4264.445622069111;4298.2263192625005;4361.498427680857;4368.563143685669;4425.889352766207;9979.800403992025;10002.699919002442;10070.69787906364;10232.59069637206;10256.846147307797;9889.406635601887;10113.64602238918;10178.541965611565;10411.219158563137;10523.789524209473;8235.29999950011;8281;8290.668373265122;8343.165683431609;8420.242178203991;6019.969900150471;6206.875862482815;6246.344133865879;6336.841578960563;6354.23749150105;9940;10125.746856328651;10163.644272450429;10207.336523125972;10319.535620896928;9728.221742260745;10026;10088.041636044563;10272.435016073889;10465.476726163814;7150.821229469305;7670.309672129312;7824.530528168328;8017.478863873829;8205.917940820755;8589.44168629037;8690.478571285743;8715.215630593277;8726.91273087261;8759.868601971102;7700.768976930701;7809.258120478546;7958.482698624571;8038.598070096588;8163.469374490639;7867.213278672087;8036.638351274323;8040.638171282423;8064.596770161351;8178.223068808454;6693.330666933268;6904.344087311697;6998.195207551197;7006.334398232159;7026.754063607749;5309.681419114711;5357.249985002025;5422.783088676409;5432.565394768488;5577.8047768327915;5060.266261392151;5124.180131178993;5270.367555893164;5376.892462150813;5560.054790685674 07:39:20 INFO - PROCESS | 6023 | |4;prototype.html;322.18005176824977;324.4241471388286;325.57187298702206;329.0195218249616;330.33767296570375;5644.54843612511;5687.886242275152;5717.9999999999945;5749.712514374285;5788.565857560689;5587.888242235153;5614.719264036792;5618.859528511789;5626.127950167731;5634.239377684012;4175.6659467242625;4306.913861722764;4403.273459879116;4417.514073451917;4424.513303536608;4398.350618518056;4423.225935461298;4430.806750658428;4442.62237709795;4449.775112443778;4422.734635921839;4423.230707716923;4424.203643344197;4426.557344265564;4430.335449682558;4311.33174357975;4328.826846926119;4353.390525326457;4372.912541749147;4380.299152135675;3830.7893065881367;3837.865674701372;3840.1743625120453;3842.385218365076;3851.114243723931;5508.421615730331;5515.503604675599;5532.059549876491;5547.861303467405;5573.578737421932;4683.367745354368;4966.354373931365;4971.6271279654175;4976.825811096594;5073.162928116856;5883.441073098092;5885.4986630682215;5885.588008839383;5922.289325280951;5939.46544810969;4148.709590328678;4151.564085771011;4166.749995000309;4171.165766846612;4183.435236243129;5946.396996006575;6006.489448396847;6096.603720758181;6132.294786099611;6134.846628834271;4207.179599977975;4222.345536441856;4258.530052569502;4278.229918614617;4283.978580107079;4271.675780508052;4272.700910936267;4285.164392943346;4301.677374196947;4303.440552728125;4633.49031606523;4877.926831097537;4880.19300988526;4884.95115048852;4978.65149439543;5841.795537156179;5865.853353666107;5923.940760592425;5961.970190149022;5968;1485.0124667096477;1489.4861272860846;1494.7234761569146;1506.540505145919;1507.811523559555;924.117467818232;941.8540126280301;948.0993056596261;980.6616717232544;996.8006398720285;5654.519365853948;5677.290338707661;5695.800646977336;5698.66081470854;5704.375987045923;6003.547959923062;6023.27720673522;6062.393760623902;6067.75728970845;6083.330833608299;5528;5621.8594535136945;5673.886522269531;5753.4534219249945;5781.219535362757;3282.3763484937786;3285.7535684823733;3297.5878015248095;3306.9007929762147;3308.6856748608843;6142.662153581596;6197.628142311476;6327.987521996459;6363.013732871413;6386.712597933104;6197.760447910346;6244.46922011625;6287.559870808999;6287.811365659038;6290.308066112724;6066.726997285133;6273.780417685359;6309.810705678837;6317.96841015792;6376.458001069868;5979.551533634908;6078.6048906820915;6111.908321375272;6113.419225173601;6121.602095863755;5890.410958904075;5929.52563794904;5932.478696554033;5962.777630585806;6001.879962400815;5948.524118070457;6215.285242197205;6224.346443623354;6285.654289014148;6295.307516173126;4204.411382406404;4208.558101399309;4251.638610718;4261.936070958876;4280.01559641278;5824.388439213991;5986.4013598639785;6070.848228794315;6071.392860713893;6141.7543298267565;5837.6497410155525;5857.941420585739;5858.150568167506;5863.530917526502;5873.23647925784;5791.971040144772;5826.883462330815;5831.7375718091935;5837.270341207349;5837.474627283565;5256.290400795843;5721.427857214246;5726.484616384545;5826.300843898759;5855.970720146543;5909.852253693692;5938.970305148619;5970;6018.247719035121;6052.213212282375;5659.292588426447;5831.562632802472;5858.681796595732;5863.472287494146;5914.881702365842 07:39:20 INFO - PROCESS | 6023 | |5;yui.html;708.2280314457238;726.9745558905438;734.9044624198854;768.7469424837515;784.6390660296263;14629.195394253326;15523.92238038811;15613.063216207021;15663.921680391597;16938.745918811226;15049.398024079024;15265.618359541017;15312.234388280596;15384.84615153848;15500.379984800595;771.6296177834629;773.8065483629093;788.0936922539069;801.234820746186;801.5431204213601;794.1423262876109;795.4193438789687;796.2714116583319;798.1101072304368;801.2388231180373;835.2774849754949;835.2983493865152;837.4514692876176;839.5927974932154;840.1094839470151;827.4456114403304;828.3083625172987;829.7635173975449;830.4436027861348;832.3632421197818;598.937111603284;600.7596961215505;601.8164459839747;603.8430008197856;605.3341324543012;15520;15698.293576789072;15756.921215393964;15790.763138552931;15834.76247856283;13942.58172254834;13978.231197284145;14662.340194691158;14734.410623575044;14899.106053636708;11898.524059037629;12011.159218854684;12212.511499540007;12380.938095309555;12548.623541293775;3914.3737002079815;3914.412838074312;3936.648440523567;3967.662748666367;4070.857519986816;79139;79421;79573;79956;81408.59295703543;11217.439128043565;11263.887361126284;11348.25560080462;11424.086073114131;11581.594644187413;20832.895835520725;20924.476888077614;20944.685829712565;21113.577728445343;21220.151193952068;8291.792705182297;8546.743597692079;8643.438176518632;8667.739967800977;8789.560521973875;4775.474697783241;4783.354247176587;4865.854024379274;4876.780544875489;4972.328735620717;3493.9126521837156;3570.4644303354185;3587.677109060197;3598.064503229179;3606.2967721294094;596.0969131765379;600.1627729317664;606.375433303698;611.1230384398402;614.7909710698384;713.162034609332;743.85494828509;754.8754455514888;789.7117552093445;796.303234669664;9264.675736349196;9925.751856203507;10218.489075546193;10416.635417760343;10470.267081304235;619.7335145887222;674.3155696967582;746.943979201562;749.6851322444477;770.6763159473035;4691.437027556715;4852.102361063215;4916.70499770015;5003.724795136302;5151.356080489939;110526;118455;118766;118927;119051;97364;97629.51185244028;99903;102016;102533.48733256286;87580;89041.55479222692;89174.10825891788;89443;92026;9191.172794448532;9357.251419886528;9468.242540596873;9518.167063298373;9562.713118606453;48663.513364865896;49785;50025;51219.48780512147;52017;70842.29157708357;76650.40097594162;77198;78844;79940;12234.87765122373;12282.508699651913;12287.324197169242;12532.812007820072;12636.873631263938;13987.860121398655;14058.159288497887;14133.717325653635;14442.711145777235;14930.10419374841;12490.500379984698;12983.221006739626;13105.672358191121;13129.73740525165;13610.9791765616;13079.411426486022;13281.468741250628;13364.799528006894;13484.12353197039;13575.79636305476;13150.21098734079;13230.603081907559;13536.120152190077;13748.587542373745;13986;10452.529636166542;10850.782984340427;11139.220254582102;11181.944090279496;11661.825072623747;11088.889111108785;11124.221304508606;11532.827007594726;12051.216670916363;12451.813222801484 07:39:20 INFO - PROCESS | 6023 | __end_tp_report 07:39:20 INFO - PROCESS | 6023 | __start_cc_report 07:39:20 INFO - PROCESS | 6023 | _x_x_mozilla_cycle_collect,356 07:39:20 INFO - PROCESS | 6023 | __end_cc_report 07:39:20 INFO - PROCESS | 6023 | __startTimestamp1467124760884__endTimestamp 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | ------- Summary: start ------- 07:39:20 INFO - PROCESS | 6023 | Number of tests: 6 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#0] dojo.html Cycles:165 Average:5377.20 Median:5557.58 stddev:606.68 (10.9%) stddev-sans-first:580.90 07:39:20 INFO - PROCESS | 6023 | Values: 3069.2 3087.0 3106.9 3131.2 3139.4 5276.6 5306.9 5327.7 5395.1 5398.6 5286.5 5341.0 5350.7 5405.6 5434.0 4900.9 4966.7 4982.3 5020.7 5026.4 4942.4 5078.9 5084.9 5100.6 5119.1 4948.5 5021.7 5033.2 5054.0 5062.1 4955.2 4964.7 4973.4 4979.1 5032.6 4957.0 4958.5 4976.9 4978.6 4994.9 5304.9 5312.4 5314.0 5397.8 5416.2 5770.1 5782.6 5784.6 5800.3 5822.4 5590.9 5851.3 5855.8 5857.4 5894.9 5283.1 5329.6 5386.2 5399.3 5441.5 5846.2 5866.8 5878.7 5886.2 5898.1 5458.3 5644.0 5682.7 5687.0 5695.2 5714.5 5744.5 5757.3 5785.5 5795.3 5728.6 5765.7 5777.6 5789.5 5798.2 5627.3 5733.1 5779.2 5788.5 5791.7 4235.3 4327.9 4330.2 4387.8 4398.2 3924.1 3960.6 3962.1 3962.4 3968.6 5501.7 5531.0 5537.5 5554.0 5597.9 5612.3 5668.2 5669.4 5831.9 5932.5 5551.7 5565.3 5574.4 5590.2 5628.0 5032.4 5054.6 5064.9 5065.0 5100.2 5802.9 5963.7 6017.2 6028.5 6083.4 5886.4 5894.6 5911.6 5920.8 5955.7 6039.8 6063.4 6067.6 6069.9 6095.0 5463.2 5611.9 5633.7 5669.3 5763.0 5777.9 5800.1 5803.7 5804.2 5815.6 5625.3 5658.3 5665.1 5668.0 5673.3 5393.9 5540.6 5597.8 5602.6 5653.6 5532.6 5549.6 5557.6 5564.9 5586.6 5510.3 5635.4 5683.1 5706.4 5713.3 5417.1 5457.5 5475.6 5501.1 5520.4 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#1] ext.html Cycles:180 Average:65343.02 Median:43508.28 stddev:133001.06 (305.7%) stddev-sans-first:133285.19 07:39:20 INFO - PROCESS | 6023 | Values: 549.7 599.3 614.9 629.0 648.4 42536.4 43487.6 43529.0 43631.1 43631.3 36617.5 36897.0 36938.6 37056.6 37184.0 8913.0 9001.8 9026.7 9047.4 9050.8 8846.1 8866.2 8935.7 8953.4 8978.1 8903.1 8935.1 8940.8 8945.5 8957.4 8819.7 8887.8 8935.6 8940.2 8943.2 8874.5 8898.5 8939.7 8955.0 8965.8 41941.8 42070.6 42277.0 42404.4 42448.4 3306.6 3432.8 3452.8 3490.5 3836.3 33312.5 33488.8 33523.5 33569.2 33694.5 4458.6 4467.7 4483.9 4507.5 4533.8 371432.0 372092.0 372947.0 374501.0 375264.0 61426.0 61431.0 61497.4 61712.7 61736.4 34776.0 35684.8 64800.7 64902.0 64930.0 16627.2 16674.1 16779.4 16856.8 16888.2 12735.3 12851.0 12867.7 12895.3 12899.0 15615.8 15865.1 15904.7 16126.8 16130.2 7135.5 7146.4 7323.3 7362.0 7394.2 921.5 982.5 1041.6 1070.4 1086.1 32547.3 32657.0 33060.2 33124.3 33222.5 1095.6 1136.4 1157.4 1165.0 1181.9 17285.9 17355.2 17363.7 17446.4 17453.5 566706.0 569482.0 574507.0 575644.0 575916.0 59023.0 59643.4 59650.0 59698.7 59823.4 1276.7 1304.4 1316.7 1318.5 1344.2 31283.4 31739.0 32642.7 33282.5 33295.5 52549.2 55702.4 57614.4 57785.4 61925.4 526893.0 530797.0 534884.0 535102.0 536208.0 45675.5 46093.8 46617.0 46893.3 47280.0 51022.7 51218.2 51824.2 52337.0 52707.2 43109.6 43360.8 43693.6 43724.6 44007.1 43029.1 43155.8 43252.8 43459.3 44375.0 40945.8 42408.0 42418.4 43702.6 45201.8 35141.3 36397.8 36501.5 36901.0 37474.0 28865.7 29396.0 29443.6 29630.7 29843.4 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#2] jquery.html Cycles:180 Average:26558.08 Median:2522.67 stddev:70662.07 (2801.1%) stddev-sans-first:70832.97 07:39:20 INFO - PROCESS | 6023 | Values: 388.9 392.6 393.4 395.7 412.8 13880.9 18009.8 18022.8 19496.4 19550.6 17445.5 17988.8 18294.5 18309.0 18334.9 5155.9 5562.1 5755.2 5764.4 5772.0 5691.7 5721.6 5733.4 5737.7 5745.4 5572.3 5687.3 5697.6 5706.4 5744.5 5501.5 5649.4 5670.8 5686.2 5693.0 4953.8 5057.2 5280.1 5283.5 5287.1 13036.2 13394.5 13462.7 13497.7 13506.3 2181.6 2187.9 2423.8 2621.5 2932.3 9270.0 9826.4 10646.3 12125.6 13549.5 1850.5 1865.8 1896.9 1956.0 2016.8 79004.6 79429.6 79934.0 81045.0 83163.0 10664.1 10735.2 10859.5 10948.1 11029.4 14916.3 15046.1 15122.5 15173.5 15207.2 7010.7 7128.9 7228.6 7326.9 7365.6 6678.7 6686.4 6707.8 6764.7 6814.9 4609.7 4613.6 4614.8 4634.1 4711.0 1923.5 1944.1 1944.5 1992.9 2005.6 959.8 999.7 1003.0 1028.3 1047.9 17575.8 18136.5 18287.7 18493.3 18545.2 970.1 987.2 988.0 1046.3 1067.5 9714.7 10335.9 10337.8 10344.4 10441.5 336872.0 343586.0 460373.0 475089.0 477161.0 93760.5 97974.5 101789.5 102179.0 102505.0 1018.3 1033.0 1048.2 1058.0 1060.0 16456.6 16671.3 16972.1 17159.7 17443.5 30319.0 35972.6 37779.6 42266.0 42496.0 60339.7 62026.0 62551.4 63082.7 63636.0 7379.2 7734.9 8113.4 8243.8 8272.9 12247.9 12385.1 12441.9 12482.9 12537.5 10196.9 10221.9 10234.5 10294.7 10553.7 10041.1 10146.9 10188.4 10208.1 10354.5 10477.3 10506.5 10529.3 10736.8 11066.1 7450.7 7887.9 7935.7 7950.2 7962.6 9837.4 9860.3 10036.1 10068.0 10219.6 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#3] mootools.html Cycles:180 Average:5869.65 Median:2579.31 stddev:3342.63 (129.6%) stddev-sans-first:3335.58 07:39:20 INFO - PROCESS | 6023 | Values: 1459.3 1499.4 1597.1 1712.3 1728.2 7927.7 8439.1 8789.6 8875.6 8881.2 8821.1 9080.7 9179.4 9193.2 9193.4 2352.6 2391.4 2393.0 2393.2 2394.0 2338.6 2353.1 2358.5 2368.7 2369.4 2328.2 2344.3 2348.4 2372.1 2384.9 2272.3 2278.7 2286.8 2309.9 2342.5 2286.4 2298.0 2314.9 2323.7 2331.7 9149.9 9209.8 9226.2 9242.1 9304.3 5309.6 5323.2 5443.9 5451.6 5461.4 3219.2 3240.8 3242.3 3283.8 3322.6 1139.7 1151.1 1152.7 1158.3 1162.2 12990.4 13007.7 13033.0 13050.8 13064.2 4670.4 4695.9 4799.1 4807.5 4832.1 10679.9 10862.9 10867.4 10884.8 10896.6 5397.5 5414.6 5468.9 5469.9 5472.5 4322.5 4620.7 4689.3 4753.6 4841.8 3858.2 3903.4 3915.0 3963.2 3970.9 1260.7 1294.8 1315.6 1317.0 1320.7 988.1 999.1 1003.7 1003.8 1016.7 6203.1 6278.7 6366.3 6370.9 6391.7 449.7 462.1 464.1 469.3 469.8 4264.4 4298.2 4361.5 4368.6 4425.9 9979.8 10002.7 10070.7 10232.6 10256.8 9889.4 10113.6 10178.5 10411.2 10523.8 8235.3 8281.0 8290.7 8343.2 8420.2 6020.0 6206.9 6246.3 6336.8 6354.2 9940.0 10125.7 10163.6 10207.3 10319.5 9728.2 10026.0 10088.0 10272.4 10465.5 7150.8 7670.3 7824.5 8017.5 8205.9 8589.4 8690.5 8715.2 8726.9 8759.9 7700.8 7809.3 7958.5 8038.6 8163.5 7867.2 8036.6 8040.6 8064.6 8178.2 6693.3 6904.3 6998.2 7006.3 7026.8 5309.7 5357.2 5422.8 5432.6 5577.8 5060.3 5124.2 5270.4 5376.9 5560.1 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#4] prototype.html Cycles:180 Average:4960.14 Median:5701.52 stddev:1471.94 (25.8%) stddev-sans-first:1434.31 07:39:20 INFO - PROCESS | 6023 | Values: 322.2 324.4 325.6 329.0 330.3 5644.5 5687.9 5718.0 5749.7 5788.6 5587.9 5614.7 5618.9 5626.1 5634.2 4175.7 4306.9 4403.3 4417.5 4424.5 4398.4 4423.2 4430.8 4442.6 4449.8 4422.7 4423.2 4424.2 4426.6 4430.3 4311.3 4328.8 4353.4 4372.9 4380.3 3830.8 3837.9 3840.2 3842.4 3851.1 5508.4 5515.5 5532.1 5547.9 5573.6 4683.4 4966.4 4971.6 4976.8 5073.2 5883.4 5885.5 5885.6 5922.3 5939.5 4148.7 4151.6 4166.7 4171.2 4183.4 5946.4 6006.5 6096.6 6132.3 6134.8 4207.2 4222.3 4258.5 4278.2 4284.0 4271.7 4272.7 4285.2 4301.7 4303.4 4633.5 4877.9 4880.2 4885.0 4978.7 5841.8 5865.9 5923.9 5962.0 5968.0 1485.0 1489.5 1494.7 1506.5 1507.8 924.1 941.9 948.1 980.7 996.8 5654.5 5677.3 5695.8 5698.7 5704.4 6003.5 6023.3 6062.4 6067.8 6083.3 5528.0 5621.9 5673.9 5753.5 5781.2 3282.4 3285.8 3297.6 3306.9 3308.7 6142.7 6197.6 6328.0 6363.0 6386.7 6197.8 6244.5 6287.6 6287.8 6290.3 6066.7 6273.8 6309.8 6318.0 6376.5 5979.6 6078.6 6111.9 6113.4 6121.6 5890.4 5929.5 5932.5 5962.8 6001.9 5948.5 6215.3 6224.3 6285.7 6295.3 4204.4 4208.6 4251.6 4261.9 4280.0 5824.4 5986.4 6070.8 6071.4 6141.8 5837.6 5857.9 5858.2 5863.5 5873.2 5792.0 5826.9 5831.7 5837.3 5837.5 5256.3 5721.4 5726.5 5826.3 5856.0 5909.9 5939.0 5970.0 6018.2 6052.2 5659.3 5831.6 5858.7 5863.5 5914.9 07:39:20 INFO - PROCESS | 6023 | 07:39:20 INFO - PROCESS | 6023 | [#5] yui.html Cycles:180 Average:21126.78 Median:4733.46 stddev:30642.52 (647.4%) stddev-sans-first:30690.13 07:39:20 INFO - PROCESS | 6023 | Values: 708.2 727.0 734.9 768.7 784.6 14629.2 15523.9 15613.1 15663.9 16938.7 15049.4 15265.6 15312.2 15384.8 15500.4 771.6 773.8 788.1 801.2 801.5 794.1 795.4 796.3 798.1 801.2 835.3 835.3 837.5 839.6 840.1 827.4 828.3 829.8 830.4 832.4 598.9 600.8 601.8 603.8 605.3 15520.0 15698.3 15756.9 15790.8 15834.8 13942.6 13978.2 14662.3 14734.4 14899.1 11898.5 12011.2 12212.5 12380.9 12548.6 3914.4 3914.4 3936.6 3967.7 4070.9 79139.0 79421.0 79573.0 79956.0 81408.6 11217.4 11263.9 11348.3 11424.1 11581.6 20832.9 20924.5 20944.7 21113.6 21220.2 8291.8 8546.7 8643.4 8667.7 8789.6 4775.5 4783.4 4865.9 4876.8 4972.3 3493.9 3570.5 3587.7 3598.1 3606.3 596.1 600.2 606.4 611.1 614.8 713.2 743.9 754.9 789.7 796.3 9264.7 9925.8 10218.5 10416.6 10470.3 619.7 674.3 746.9 749.7 770.7 4691.4 4852.1 4916.7 5003.7 5151.4 110526.0 118455.0 118766.0 118927.0 119051.0 97364.0 97629.5 99903.0 102016.0 102533.5 87580.0 89041.6 89174.1 89443.0 92026.0 9191.2 9357.3 9468.2 9518.2 9562.7 48663.5 49785.0 50025.0 51219.5 52017.0 70842.3 76650.4 77198.0 78844.0 79940.0 12234.9 12282.5 12287.3 12532.8 12636.9 13987.9 14058.2 14133.7 14442.7 14930.1 12490.5 12983.2 13105.7 13129.7 13611.0 13079.4 13281.5 13364.8 13484.1 13575.8 13150.2 13230.6 13536.1 13748.6 13986.0 10452.5 10850.8 11139.2 11181.9 11661.8 11088.9 11124.2 11532.8 12051.2 12451.8 07:39:20 INFO - PROCESS | 6023 | -------- Summary: end -------- 07:39:20 INFO - PROCESS | 6023 | 07:39:21 INFO - TEST-INFO | 6023: exit 0 07:39:21 INFO - TEST-OK | dromaeo_css | took 1110723ms 07:39:21 INFO - TEST-START | kraken 07:39:21 INFO - operating with platform_type : linux_ 07:39:21 INFO - Initialising browser for kraken test... 07:39:21 INFO - TEST-INFO | started process 6298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_Ft47/profile http://localhost:33346/getInfo.html) 07:39:26 INFO - PROCESS | 6298 | __metrics Screen width/height:1600/1200 07:39:26 INFO - PROCESS | 6298 | colorDepth:24 07:39:26 INFO - PROCESS | 6298 | Browser inner width/height: 1024/697 07:39:26 INFO - PROCESS | 6298 | __metrics 07:39:26 ERROR - PROCESS | 6298 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:39:27 INFO - TEST-INFO | 6298: exit 0 07:39:27 INFO - Browser initialized. 07:39:27 INFO - Running cycle 1/1 for kraken test... 07:39:27 INFO - TEST-INFO | started process 6420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_Ft47/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:39 INFO - PROCESS | 6420 | RSS: Main: 168247296 07:39:39 INFO - PROCESS | 6420 | 07:39:41 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33346/tests/kraken/driver.html?testName=audio-beat-detection) 07:39:42 INFO - PROCESS | 6420 | RSS: Main: 173727744 07:39:42 INFO - PROCESS | 6420 | 07:39:45 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33346/tests/kraken/driver.html?testName=audio-dft) 07:39:46 INFO - PROCESS | 6420 | RSS: Main: 173170688 07:39:46 INFO - PROCESS | 6420 | 07:39:48 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33346/tests/kraken/driver.html?testName=audio-fft) 07:39:49 INFO - PROCESS | 6420 | RSS: Main: 167677952 07:39:49 INFO - PROCESS | 6420 | 07:39:51 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33346/tests/kraken/driver.html?testName=audio-oscillator) 07:39:52 INFO - PROCESS | 6420 | RSS: Main: 168529920 07:39:52 INFO - PROCESS | 6420 | 07:39:54 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:55 INFO - PROCESS | 6420 | RSS: Main: 168783872 07:39:55 INFO - PROCESS | 6420 | 07:39:58 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33346/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:58 INFO - PROCESS | 6420 | RSS: Main: 168570880 07:39:58 INFO - PROCESS | 6420 | 07:40:02 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33346/tests/kraken/driver.html?testName=imaging-desaturate) 07:40:02 INFO - PROCESS | 6420 | RSS: Main: 169779200 07:40:02 INFO - PROCESS | 6420 | 07:40:05 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33346/tests/kraken/driver.html?testName=json-parse-financial) 07:40:06 INFO - PROCESS | 6420 | RSS: Main: 169779200 07:40:06 INFO - PROCESS | 6420 | 07:40:07 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:40:08 INFO - PROCESS | 6420 | RSS: Main: 169885696 07:40:08 INFO - PROCESS | 6420 | 07:40:10 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:40:11 INFO - PROCESS | 6420 | RSS: Main: 170225664 07:40:11 INFO - PROCESS | 6420 | 07:40:13 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:40:13 INFO - PROCESS | 6420 | RSS: Main: 170438656 07:40:13 INFO - PROCESS | 6420 | 07:40:16 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:40:17 INFO - PROCESS | 6420 | RSS: Main: 170532864 07:40:17 INFO - PROCESS | 6420 | 07:40:19 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:40:20 INFO - PROCESS | 6420 | RSS: Main: 170209280 07:40:20 INFO - PROCESS | 6420 | 07:40:21 INFO - PROCESS | 6420 | Cycle 1(1): loaded http://localhost:33346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33346/tests/kraken/driver.html?testName=ai-astar) 07:40:22 INFO - PROCESS | 6420 | RSS: Main: 170897408 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | __start_tp_report 07:40:22 INFO - PROCESS | 6420 | _x_x_mozilla_page_load 07:40:22 INFO - PROCESS | 6420 | _x_x_mozilla_page_load_details 07:40:22 INFO - PROCESS | 6420 | |i|pagename|runs| 07:40:22 INFO - PROCESS | 6420 | |0;ai-astar;102;111;107;111;112;112;114;111;113;110 07:40:22 INFO - PROCESS | 6420 | |1;audio-beat-detection;149;126;151;182;126;153;150;129;187;129 07:40:22 INFO - PROCESS | 6420 | |2;audio-dft;164;162;162;161;163;167;172;162;162;161 07:40:22 INFO - PROCESS | 6420 | |3;audio-fft;75;75;77;160;76;76;74;74;169;76 07:40:22 INFO - PROCESS | 6420 | |4;audio-oscillator;85;87;142;86;85;84;147;85;86;142 07:40:22 INFO - PROCESS | 6420 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;117;117;117 07:40:22 INFO - PROCESS | 6420 | |6;imaging-darkroom;147;148;147;147;148;147;147;147;147;148 07:40:22 INFO - PROCESS | 6420 | |7;imaging-desaturate;95;96;95;96;96;95;97;101;99;100 07:40:22 INFO - PROCESS | 6420 | |8;json-parse-financial;55;59;55;54;56;54;55;54;54;54 07:40:22 INFO - PROCESS | 6420 | |9;json-stringify-tinderbox;63;64;62;63;66;63;64;63;63;64 07:40:22 INFO - PROCESS | 6420 | |10;stanford-crypto-aes;79;79;81;85;82;80;80;80;82;84 07:40:22 INFO - PROCESS | 6420 | |11;stanford-crypto-ccm;125;130;135;134;138;119;127;123;124;128 07:40:22 INFO - PROCESS | 6420 | |12;stanford-crypto-pbkdf2;167;159;171;162;158;161;156;155;157;156 07:40:22 INFO - PROCESS | 6420 | |13;stanford-crypto-sha256-iterative;68;66;64;64;64;65;61;61;62;62 07:40:22 INFO - PROCESS | 6420 | __end_tp_report 07:40:22 INFO - PROCESS | 6420 | __start_cc_report 07:40:22 INFO - PROCESS | 6420 | _x_x_mozilla_cycle_collect,879 07:40:22 INFO - PROCESS | 6420 | __end_cc_report 07:40:22 INFO - PROCESS | 6420 | __startTimestamp1467124822217__endTimestamp 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | ------- Summary: start ------- 07:40:22 INFO - PROCESS | 6420 | Number of tests: 14 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.47 (3.1%) stddev-sans-first:1.99 07:40:22 INFO - PROCESS | 6420 | Values: 102.0 111.0 107.0 111.0 112.0 112.0 114.0 111.0 113.0 110.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:150.50 stddev:22.12 (14.7%) stddev-sans-first:23.47 07:40:22 INFO - PROCESS | 6420 | Values: 149.0 126.0 151.0 182.0 126.0 153.0 150.0 129.0 187.0 129.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.44 (2.1%) stddev-sans-first:3.64 07:40:22 INFO - PROCESS | 6420 | Values: 164.0 162.0 162.0 161.0 163.0 167.0 172.0 162.0 162.0 161.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:37.65 (49.9%) stddev-sans-first:39.35 07:40:22 INFO - PROCESS | 6420 | Values: 75.0 75.0 77.0 160.0 76.0 76.0 74.0 74.0 169.0 76.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:85.00 stddev:28.18 (33.1%) stddev-sans-first:29.13 07:40:22 INFO - PROCESS | 6420 | Values: 85.0 87.0 142.0 86.0 85.0 84.0 147.0 85.0 86.0 142.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:40:22 INFO - PROCESS | 6420 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:40:22 INFO - PROCESS | 6420 | Values: 147.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.21 (2.3%) stddev-sans-first:2.22 07:40:22 INFO - PROCESS | 6420 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 97.0 101.0 99.0 100.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.56 (2.8%) stddev-sans-first:1.66 07:40:22 INFO - PROCESS | 6420 | Values: 55.0 59.0 55.0 54.0 56.0 54.0 55.0 54.0 54.0 54.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 07:40:22 INFO - PROCESS | 6420 | Values: 63.0 64.0 62.0 63.0 66.0 63.0 64.0 63.0 63.0 64.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:2.04 (2.5%) stddev-sans-first:2.01 07:40:22 INFO - PROCESS | 6420 | Values: 79.0 79.0 81.0 85.0 82.0 80.0 80.0 80.0 82.0 84.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:129.00 stddev:5.96 (4.6%) stddev-sans-first:6.20 07:40:22 INFO - PROCESS | 6420 | Values: 125.0 130.0 135.0 134.0 138.0 119.0 127.0 123.0 124.0 128.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:5.22 (3.3%) stddev-sans-first:4.93 07:40:22 INFO - PROCESS | 6420 | Values: 167.0 159.0 171.0 162.0 158.0 161.0 156.0 155.0 157.0 156.0 07:40:22 INFO - PROCESS | 6420 | 07:40:22 INFO - PROCESS | 6420 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.26 (3.5%) stddev-sans-first:1.79 07:40:22 INFO - PROCESS | 6420 | Values: 68.0 66.0 64.0 64.0 64.0 65.0 61.0 61.0 62.0 62.0 07:40:22 INFO - PROCESS | 6420 | -------- Summary: end -------- 07:40:22 INFO - PROCESS | 6420 | 07:40:23 INFO - TEST-INFO | 6420: exit 0 07:40:23 INFO - TEST-OK | kraken | took 61508ms 07:40:23 INFO - SUITE-END | took 1172s 07:40:23 INFO - Completed test suite (00:19:32) 07:40:23 INFO - javascript benchmark 07:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.756628535069, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.1559821049213, 3087.0275863103107, 3106.8912588059416, 3131.1545882611695, 3139.356431931454, 5276.577873770104, 5306.946930530694, 5327.653702509339, 5395.10980688186, 5398.568114550836, 5286.524212820846, 5340.973295133528, 5350.732463376835, 5405.567554595623, 5434.0218760623075, 4900.926486102702, 4966.701997880121, 4982.302477653131, 5020.7489625518765, 5026.371703537058, 4942.357493525837, 5078.898422031557, 5084.949150508503, 5100.566451851597, 5119.078565858144, 4948.529889660476, 5021.6735912165595, 5033.219850923113, 5054.0, 5062.0888240116765, 4955.182394904837, 4964.652474326798, 4973.403191616993, 4979.07887040895, 5032.6477146599755, 4956.950430495685, 4958.528939750718, 4976.900461990776, 4978.6017118630425, 4994.87512812179, 5304.92042619361, 5312.415634280226, 5313.973430132824, 5397.8110766123, 5416.214648875891, 5770.076787713988, 5782.56630752691, 5784.566157538159, 5800.332961709373, 5822.417758224186, 5590.888182236373, 5851.268591426072, 5855.795047173328, 5857.4435428634215, 5894.852628684274, 5283.128283833163, 5329.600279979017, 5386.1920711893135, 5399.3250843644155, 5441.5102640762525, 5846.152307915413, 5866.823995280149, 5878.676672782953, 5886.175935369051, 5898.085796701518, 5458.317710286215, 5644.0, 5682.715864206773, 5687.03320435527, 5695.1741997410145, 5714.514266287329, 5744.511716504144, 5757.337906140764, 5785.537157027427, 5795.275590551181, 5728.627639203439, 5765.711714414262, 5777.62445441045, 5789.536837053026, 5798.188253644493, 5627.296587926509, 5733.0540460823495, 5779.219805326311, 5788.45009724084, 5791.681457519792, 4235.2800023996, 4327.891802704895, 4330.155619654137, 4387.758673272937, 4398.186335527937, 3924.0974575847713, 3960.6237407446247, 3962.0689138052535, 3962.3660214365564, 3968.6428221460205, 5501.697406642593, 5530.972345138329, 5537.501624853782, 5553.972230138824, 5597.916031259534, 5612.270404847425, 5668.206451096849, 5669.376368599451, 5831.912521312183, 5932.525397968152, 5551.72241387929, 5565.276514053228, 5574.358948720868, 5590.217369568264, 5628.04323265046, 5032.370953630796, 5054.570361519239, 5064.949350506447, 5064.974675126601, 5100.234964755242, 5802.883942321215, 5963.731632076567, 6017.157597936292, 6028.487578555872, 6083.391660833881, 5886.3525012247765, 5894.646321220741, 5911.586188966731, 5920.822375328747, 5955.67243801595, 6039.818805435844, 6063.393660633901, 6067.575269731076, 6069.939300606938, 6094.963856144377, 5463.235147079492, 5611.8877622448135, 5633.690147041952, 5669.291338582677, 5763.02028655138, 5777.8555536111935, 5800.1299805029585, 5803.709814509342, 5804.21643078179, 5815.563832712648, 5625.268715067179, 5658.321001479849, 5665.093585026376, 5668.0, 5673.290838645169, 5393.919091213556, 5540.556755459635, 5597.804076857454, 5602.551795856403, 5653.632513886584, 5532.557395408438, 5549.611527193219, 5557.583181261502, 5564.888702226014, 5586.608937374344, 5510.283663123768, 5635.380108188178, 5683.062294721325, 5706.372299047184, 5713.285839270091, 5417.1061774808295, 5457.454254574511, 5475.589330800126, 5501.0648189807025, 5520.36515800672], "value": 5336.185081938733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.7361266592036, 599.3048064245476, 614.9292831324398, 629.0407129128076, 648.377557544757, 42536.36195457067, 43487.565124348745, 43529.0, 43631.12737745243, 43631.34552981704, 36617.45073823895, 36897.0, 36938.63061369386, 37056.62943370565, 37184.0, 8912.955435222815, 9001.77495562613, 9026.729198124067, 9047.411918225294, 9050.77373065672, 8846.115388461167, 8866.157715017096, 8935.731928042169, 8953.373263871532, 8978.057303983085, 8903.109689031078, 8935.06181850906, 8940.821183576325, 8945.463272203657, 8957.417767845069, 8819.735407937773, 8887.822243555158, 8935.553222338922, 8940.240079593243, 8943.150400711955, 8874.511901845395, 8898.466092034434, 8939.74843521901, 8955.0, 8965.820683586357, 41941.79029104865, 42070.579294206975, 42277.0, 42404.363934541005, 42448.36327455091, 3306.553615261933, 3432.7940323580415, 3452.7928324300624, 3490.4764285357146, 3836.271108489378, 33312.50031249533, 33488.83255583731, 33523.49714754256, 33569.16077098068, 33694.49458258128, 4458.554144585548, 4467.660254654661, 4483.910321793546, 4507.481639611454, 4533.818647254106, 371432.0, 372092.0, 372947.0, 374500.99999999726, 375264.0, 61426.0, 61431.0, 61497.38502615006, 61712.69143654253, 61736.38263617306, 34776.0, 35684.82157589247, 64800.67599662066, 64902.0, 64930.0, 16627.168641567874, 16674.082925439216, 16779.412720554723, 16856.831431685772, 16888.240029198714, 12735.299558524184, 12851.036172287117, 12867.678308042186, 12895.290759008345, 12899.0, 15615.765763513557, 15865.127417991891, 15904.681906361808, 16126.75809862853, 16130.193490325437, 7135.464840136907, 7146.39206178616, 7323.304286092813, 7361.975446763054, 7394.186639469654, 921.4885738415244, 982.5185659027026, 1041.5885725138528, 1070.421972135054, 1086.0822604898847, 32547.349053018806, 32657.0, 33060.17349566232, 33124.34743946469, 33222.50166247508, 1095.5782023920847, 1136.420425582942, 1157.3576664950865, 1164.976700465986, 1181.8640856301636, 17285.91357043232, 17355.21901514435, 17363.652726945642, 17446.389376371768, 17453.47639570815, 566706.0, 569482.0, 574507.0, 575644.0, 575916.0, 59023.0, 59643.403565964654, 59650.0, 59698.70150649219, 59823.401765981784, 1276.7401698992917, 1304.4390911907972, 1316.7300703355788, 1318.5055604148445, 1344.1867670059669, 31283.37433251368, 31739.0, 32642.673573263964, 33282.500762489064, 33295.50056749102, 52549.21176182284, 55702.44297557135, 57614.423855760906, 57785.42214577801, 61925.38074619376, 526893.0, 530797.0, 534884.0, 535102.0, 536208.0, 45675.54324456713, 46093.76953115213, 46617.0, 46893.29660055033, 47280.0, 51022.74488627533, 51218.23172652339, 51824.222636659724, 52337.0, 52707.20939185992, 43109.628970405676, 43360.783196083816, 43693.56306436895, 43724.56275437332, 44007.119857603306, 43029.139417210856, 43155.78422107869, 43252.783736082376, 43459.34810977775, 44375.0, 40945.79527102345, 42408.0, 42418.363724544775, 43702.56297436985, 45201.773991129834, 35141.297174055864, 36397.818010909774, 36501.53235442629, 36901.0, 37474.0, 28865.7113428863, 29396.0, 29443.558346625246, 29630.703692963656, 29843.403131937674], "value": 20695.9200898636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8949983504454, 392.5583718316893, 393.36471598368627, 395.74078978269245, 412.77091214376026, 13880.917862320632, 18009.819901800976, 18022.819771802293, 19496.41510754676, 19550.608987820237, 17445.476635700918, 17988.82011179888, 18294.451166464994, 18309.0, 18334.908325458353, 5155.871103222431, 5562.082256427695, 5755.2230448889495, 5764.365919748845, 5772.0, 5691.743871525791, 5721.570882183832, 5733.426657334275, 5737.713114344287, 5745.368009518949, 5572.331320241577, 5687.345955215141, 5697.6296540724725, 5706.3722990471015, 5744.4829965303115, 5501.504864562208, 5649.406812284733, 5670.829875103733, 5686.2039314496005, 5693.0, 4953.826616068421, 5057.216131499624, 5280.102382594968, 5283.524482796567, 5287.074761916688, 13036.217826930415, 13394.464221431132, 13462.663433414244, 13497.730045399136, 13506.257155856423, 2181.5854987552475, 2187.9015444305046, 2423.8303318767694, 2621.5150197213384, 2932.2522756697117, 9270.0, 9826.4104153751, 10646.25476216665, 12125.575604853788, 13549.52576659822, 1850.4826042645036, 1865.813418658137, 1896.9146388412555, 1955.9608807823906, 2016.8487363447653, 79004.60497697532, 79429.60285198595, 79934.0, 81045.0, 83163.0, 10664.146868250522, 10735.194860385502, 10859.479672845808, 10948.069414099891, 11029.393383363831, 14916.328765205591, 15046.097234165765, 15122.470713524974, 15173.468928587446, 15207.239638018276, 7010.719571217196, 7128.893066604005, 7228.602426866572, 7326.926730732731, 7365.631718414058, 6678.699458524378, 6686.398224159751, 6707.765228216989, 6764.680887226944, 6814.897776533356, 4609.723416595015, 4613.607843333354, 4614.815407383667, 4634.050019745944, 4711.0, 1923.5479662279354, 1944.1251436853472, 1944.474991752219, 1992.900354982245, 2005.5888542848681, 959.8320293948531, 999.7250756042147, 1002.9598816047277, 1028.2904546519974, 1047.9109275711498, 17575.824241757673, 18136.45590632283, 18287.72568411475, 18493.260269589067, 18545.165467553994, 970.112347202302, 987.2398253344884, 987.9604815807287, 1046.2676126711333, 1067.4876059491487, 9714.659986900424, 10335.914728953352, 10337.793244135226, 10344.431056291825, 10441.477926103664, 336872.0, 343586.0, 460373.0, 475089.0, 477161.0, 93760.53119734357, 97974.51012744891, 101789.49105254427, 102179.0, 102505.0, 1018.2922868606396, 1033.0341131042348, 1048.1876545677162, 1057.9947100264449, 1059.9523021464054, 16456.588585285463, 16671.333146674482, 16972.06653634062, 17159.7426038607, 17443.476695699148, 30319.0, 35972.64027359693, 37779.62220377761, 42266.0, 42496.0, 60339.698301508215, 62026.0, 62551.37448625456, 63082.684586576775, 63636.04545931907, 7379.188289288067, 7734.917111604267, 8113.3509319253135, 8243.83512329762, 8272.875906861282, 12247.938760306142, 12385.133040687066, 12441.937790311353, 12482.875171248172, 12537.498500059895, 10196.949015254877, 10221.897781022095, 10234.48827558634, 10294.742631434274, 10553.683389498327, 10041.096301332915, 10146.898531014594, 10188.439635820101, 10208.081272685495, 10354.534045968101, 10477.31897426665, 10506.530965223319, 10529.315594486334, 10736.785264294827, 11066.059384952368, 7450.7392241273465, 7887.881681774893, 7935.722249721232, 7950.204979502004, 7962.562059086806, 9837.409755414697, 9860.30977831545, 10036.096751292127, 10068.0, 10219.59121635156], "value": 8743.693949052318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.3287087939548, 1499.3702644889147, 1597.1455271429788, 1712.2808420463405, 1728.213662783433, 7927.6828926843, 8439.071702112762, 8789.604467798948, 8875.644974201032, 8881.245094166996, 8821.117888211176, 9080.682176123837, 9179.403338782975, 9193.172614464696, 9193.448393096402, 2352.5882970480184, 2391.4260577461373, 2393.0308225168833, 2393.198278576679, 2394.0184524345023, 2338.649202619612, 2353.082297903819, 2358.5282943411303, 2368.6683864259016, 2369.4194922244073, 2328.208409140892, 2344.284993077111, 2348.377679914824, 2372.110458578033, 2384.8688322142275, 2272.2728726807427, 2278.737945136314, 2286.8399212055165, 2309.872956987365, 2342.461233916209, 2286.3826766772877, 2297.9655305170436, 2314.9421264468524, 2323.7095363079616, 2331.661909023182, 9149.908500914973, 9209.76975575616, 9226.169644732006, 9242.12199841014, 9304.348695591312, 5309.601779866525, 5323.22813192085, 5443.918341224885, 5451.64564303323, 5461.42655021221, 3219.17910932713, 3240.837958102109, 3242.3029048754397, 3283.770136090475, 3322.568066151409, 1139.6865861888048, 1151.1366475143643, 1152.7406333574963, 1158.3050169898079, 1162.1980833225048, 12990.415431305613, 13007.739845203043, 13032.999999999905, 13050.804237936438, 13064.21614703121, 4670.416197975253, 4695.859124226278, 4799.112164249625, 4807.495213002654, 4832.057748738962, 10679.893201068046, 10862.945685271523, 10867.402292873969, 10884.836727449094, 10896.61861834832, 5397.487238712316, 5414.566834653218, 5468.890622187534, 5469.890602187934, 5472.5348345391085, 4322.502912165141, 4620.653450991122, 4689.273162659793, 4753.5959443447, 4841.782119804618, 3858.170493343888, 3903.434002069741, 3915.0, 3963.2271707016853, 3970.9205815884097, 1260.6785269756338, 1294.825198598196, 1315.5658632651202, 1317.0451422718452, 1320.7424552212226, 988.1255089245925, 999.1107913956585, 1003.6637726361605, 1003.7590978165334, 1016.7051555048953, 6203.131561581382, 6278.717457714414, 6366.299707032223, 6370.872582548323, 6391.712372943229, 449.6717396300719, 462.08507155831643, 464.1019627021656, 469.3382330913396, 469.80972706054104, 4264.445622069111, 4298.2263192625005, 4361.498427680857, 4368.563143685669, 4425.889352766207, 9979.800403992025, 10002.699919002442, 10070.69787906364, 10232.59069637206, 10256.846147307797, 9889.406635601887, 10113.64602238918, 10178.541965611565, 10411.219158563137, 10523.789524209473, 8235.29999950011, 8281.0, 8290.668373265122, 8343.165683431609, 8420.242178203991, 6019.969900150471, 6206.875862482815, 6246.344133865879, 6336.841578960563, 6354.23749150105, 9940.0, 10125.746856328651, 10163.644272450429, 10207.336523125972, 10319.535620896928, 9728.221742260745, 10026.0, 10088.041636044563, 10272.435016073889, 10465.476726163814, 7150.821229469305, 7670.309672129312, 7824.530528168328, 8017.478863873829, 8205.917940820755, 8589.44168629037, 8690.478571285743, 8715.215630593277, 8726.91273087261, 8759.868601971102, 7700.768976930701, 7809.258120478546, 7958.482698624571, 8038.598070096588, 8163.469374490639, 7867.213278672087, 8036.638351274323, 8040.638171282423, 8064.596770161351, 8178.223068808454, 6693.330666933268, 6904.344087311697, 6998.195207551197, 7006.334398232159, 7026.754063607749, 5309.681419114711, 5357.249985002025, 5422.783088676409, 5432.565394768488, 5577.8047768327915, 5060.266261392151, 5124.180131178993, 5270.367555893164, 5376.892462150813, 5560.054790685674], "value": 4621.844455106494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.18005176824977, 324.4241471388286, 325.57187298702206, 329.0195218249616, 330.33767296570375, 5644.54843612511, 5687.886242275152, 5717.9999999999945, 5749.712514374285, 5788.565857560689, 5587.888242235153, 5614.719264036792, 5618.859528511789, 5626.127950167731, 5634.239377684012, 4175.6659467242625, 4306.913861722764, 4403.273459879116, 4417.514073451917, 4424.513303536608, 4398.350618518056, 4423.225935461298, 4430.806750658428, 4442.62237709795, 4449.775112443778, 4422.734635921839, 4423.230707716923, 4424.203643344197, 4426.557344265564, 4430.335449682558, 4311.33174357975, 4328.826846926119, 4353.390525326457, 4372.912541749147, 4380.299152135675, 3830.7893065881367, 3837.865674701372, 3840.1743625120453, 3842.385218365076, 3851.114243723931, 5508.421615730331, 5515.503604675599, 5532.059549876491, 5547.861303467405, 5573.578737421932, 4683.367745354368, 4966.354373931365, 4971.6271279654175, 4976.825811096594, 5073.162928116856, 5883.441073098092, 5885.4986630682215, 5885.588008839383, 5922.289325280951, 5939.46544810969, 4148.709590328678, 4151.564085771011, 4166.749995000309, 4171.165766846612, 4183.435236243129, 5946.396996006575, 6006.489448396847, 6096.603720758181, 6132.294786099611, 6134.846628834271, 4207.179599977975, 4222.345536441856, 4258.530052569502, 4278.229918614617, 4283.978580107079, 4271.675780508052, 4272.700910936267, 4285.164392943346, 4301.677374196947, 4303.440552728125, 4633.49031606523, 4877.926831097537, 4880.19300988526, 4884.95115048852, 4978.65149439543, 5841.795537156179, 5865.853353666107, 5923.940760592425, 5961.970190149022, 5968.0, 1485.0124667096477, 1489.4861272860846, 1494.7234761569146, 1506.540505145919, 1507.811523559555, 924.117467818232, 941.8540126280301, 948.0993056596261, 980.6616717232544, 996.8006398720285, 5654.519365853948, 5677.290338707661, 5695.800646977336, 5698.66081470854, 5704.375987045923, 6003.547959923062, 6023.27720673522, 6062.393760623902, 6067.75728970845, 6083.330833608299, 5528.0, 5621.8594535136945, 5673.886522269531, 5753.4534219249945, 5781.219535362757, 3282.3763484937786, 3285.7535684823733, 3297.5878015248095, 3306.9007929762147, 3308.6856748608843, 6142.662153581596, 6197.628142311476, 6327.987521996459, 6363.013732871413, 6386.712597933104, 6197.760447910346, 6244.46922011625, 6287.559870808999, 6287.811365659038, 6290.308066112724, 6066.726997285133, 6273.780417685359, 6309.810705678837, 6317.96841015792, 6376.458001069868, 5979.551533634908, 6078.6048906820915, 6111.908321375272, 6113.419225173601, 6121.602095863755, 5890.410958904075, 5929.52563794904, 5932.478696554033, 5962.777630585806, 6001.879962400815, 5948.524118070457, 6215.285242197205, 6224.346443623354, 6285.654289014148, 6295.307516173126, 4204.411382406404, 4208.558101399309, 4251.638610718, 4261.936070958876, 4280.01559641278, 5824.388439213991, 5986.4013598639785, 6070.848228794315, 6071.392860713893, 6141.7543298267565, 5837.6497410155525, 5857.941420585739, 5858.150568167506, 5863.530917526502, 5873.23647925784, 5791.971040144772, 5826.883462330815, 5831.7375718091935, 5837.270341207349, 5837.474627283565, 5256.290400795843, 5721.427857214246, 5726.484616384545, 5826.300843898759, 5855.970720146543, 5909.852253693692, 5938.970305148619, 5970.0, 6018.247719035121, 6052.213212282375, 5659.292588426447, 5831.562632802472, 5858.681796595732, 5863.472287494146, 5914.881702365842], "value": 4479.883627837114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2280314457238, 726.9745558905438, 734.9044624198854, 768.7469424837515, 784.6390660296263, 14629.195394253326, 15523.92238038811, 15613.063216207021, 15663.921680391597, 16938.745918811226, 15049.398024079024, 15265.618359541017, 15312.234388280596, 15384.84615153848, 15500.379984800595, 771.6296177834629, 773.8065483629093, 788.0936922539069, 801.234820746186, 801.5431204213601, 794.1423262876109, 795.4193438789687, 796.2714116583319, 798.1101072304368, 801.2388231180373, 835.2774849754949, 835.2983493865152, 837.4514692876176, 839.5927974932154, 840.1094839470151, 827.4456114403304, 828.3083625172987, 829.7635173975449, 830.4436027861348, 832.3632421197818, 598.937111603284, 600.7596961215505, 601.8164459839747, 603.8430008197856, 605.3341324543012, 15520.0, 15698.293576789072, 15756.921215393964, 15790.763138552931, 15834.76247856283, 13942.58172254834, 13978.231197284145, 14662.340194691158, 14734.410623575044, 14899.106053636708, 11898.524059037629, 12011.159218854684, 12212.511499540007, 12380.938095309555, 12548.623541293775, 3914.3737002079815, 3914.412838074312, 3936.648440523567, 3967.662748666367, 4070.857519986816, 79139.0, 79421.0, 79573.0, 79956.0, 81408.59295703543, 11217.439128043565, 11263.887361126284, 11348.25560080462, 11424.086073114131, 11581.594644187413, 20832.895835520725, 20924.476888077614, 20944.685829712565, 21113.577728445343, 21220.151193952068, 8291.792705182297, 8546.743597692079, 8643.438176518632, 8667.739967800977, 8789.560521973875, 4775.474697783241, 4783.354247176587, 4865.854024379274, 4876.780544875489, 4972.328735620717, 3493.9126521837156, 3570.4644303354185, 3587.677109060197, 3598.064503229179, 3606.2967721294094, 596.0969131765379, 600.1627729317664, 606.375433303698, 611.1230384398402, 614.7909710698384, 713.162034609332, 743.85494828509, 754.8754455514888, 789.7117552093445, 796.303234669664, 9264.675736349196, 9925.751856203507, 10218.489075546193, 10416.635417760343, 10470.267081304235, 619.7335145887222, 674.3155696967582, 746.943979201562, 749.6851322444477, 770.6763159473035, 4691.437027556715, 4852.102361063215, 4916.70499770015, 5003.724795136302, 5151.356080489939, 110526.0, 118455.0, 118766.0, 118927.0, 119051.0, 97364.0, 97629.51185244028, 99903.0, 102016.0, 102533.48733256286, 87580.0, 89041.55479222692, 89174.10825891788, 89443.0, 92026.0, 9191.172794448532, 9357.251419886528, 9468.242540596873, 9518.167063298373, 9562.713118606453, 48663.513364865896, 49785.0, 50025.0, 51219.48780512147, 52017.0, 70842.29157708357, 76650.40097594162, 77198.0, 78844.0, 79940.0, 12234.87765122373, 12282.508699651913, 12287.324197169242, 12532.812007820072, 12636.873631263938, 13987.860121398655, 14058.159288497887, 14133.717325653635, 14442.711145777235, 14930.10419374841, 12490.500379984698, 12983.221006739626, 13105.672358191121, 13129.73740525165, 13610.9791765616, 13079.411426486022, 13281.468741250628, 13364.799528006894, 13484.12353197039, 13575.79636305476, 13150.21098734079, 13230.603081907559, 13536.120152190077, 13748.587542373745, 13986.0, 10452.529636166542, 10850.782984340427, 11139.220254582102, 11181.944090279496, 11661.825072623747, 11088.889111108785, 11124.221304508606, 11532.827007594726, 12051.216670916363, 12451.813222801484], "value": 7591.747549692214, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 107.0, 111.0, 112.0, 112.0, 114.0, 111.0, 113.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 151.0, 182.0, 126.0, 153.0, 150.0, 129.0, 187.0, 129.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 163.0, 167.0, 172.0, 162.0, 162.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 160.0, 76.0, 76.0, 74.0, 74.0, 169.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 142.0, 86.0, 85.0, 84.0, 147.0, 85.0, 86.0, 142.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 101.0, 99.0, 100.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 55.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 66.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 85.0, 82.0, 80.0, 80.0, 80.0, 82.0, 84.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 135.0, 134.0, 138.0, 119.0, 127.0, 123.0, 124.0, 128.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 171.0, 162.0, 158.0, 161.0, 156.0, 155.0, 157.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 64.0, 64.0, 64.0, 65.0, 61.0, 61.0, 62.0, 62.0], "value": 63.7, "unit": "score"}]}]} 07:40:23 INFO - Return code: 0 07:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:40:23 ERROR - # TBPL SUCCESS # 07:40:23 INFO - Running post-action listener: _resource_record_post_action 07:40:23 INFO - ##### 07:40:23 INFO - ##### Finished run-tests step (success) 07:40:23 INFO - ##### 07:40:23 INFO - Running post-run listener: _resource_record_post_run 07:40:23 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2338816; Write bytes: 559202304; Read time: 1320; Write time: 527032 07:40:23 INFO - TinderboxPrint: CPU usage
13.4% 07:40:23 INFO - TinderboxPrint: I/O read bytes / time
2,338,816 / 1,320 07:40:23 INFO - TinderboxPrint: I/O write bytes / time
559,202,304 / 527,032 07:40:23 INFO - TinderboxPrint: CPU idle
8,220.1 (86.6%) 07:40:23 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 07:40:23 INFO - TinderboxPrint: Swap in / out
0 / 0 07:40:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260157440; Read time: 0; Write time: 288852 07:40:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 2338816; Write bytes: 292179968; Read time: 1320; Write time: 236604 07:40:24 INFO - Running post-run listener: _upload_blobber_files 07:40:24 INFO - Blob upload gear active. 07:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:40:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:40:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:25 INFO - (blobuploader) - INFO - Done attempting. 07:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:40:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:28 INFO - (blobuploader) - INFO - Done attempting. 07:40:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:40:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:29 INFO - (blobuploader) - INFO - Done attempting. 07:40:29 INFO - (blobuploader) - INFO - Iteration through files over. 07:40:29 INFO - Return code: 0 07:40:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:40:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:40:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76fe9bff019bbbc359c3cd96b4ba4070030a91898c601b29639de60f8dc504d0beb5492186cd78c39221e83c2b367df6770535ce1074bcf26299f9813bb23756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e10313c19bd6f0cd9a8ca825c5d8cb81fb79ed773107033fa76200fe0653fcae6b0f3bc1e7a84888e6fcfec4ace4cf65aea40e9c3d28fb5ef247d0acad5c901", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c9ef5363714f9a867539221098048b772c27709fb6d490adcca2e568ba4845161ce692fe28e3e20f1d6808b4b1e9836c8201cddda7cebc0e0d08d3b43c1013"} 07:40:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:40:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:40:29 INFO - Contents: 07:40:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76fe9bff019bbbc359c3cd96b4ba4070030a91898c601b29639de60f8dc504d0beb5492186cd78c39221e83c2b367df6770535ce1074bcf26299f9813bb23756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e10313c19bd6f0cd9a8ca825c5d8cb81fb79ed773107033fa76200fe0653fcae6b0f3bc1e7a84888e6fcfec4ace4cf65aea40e9c3d28fb5ef247d0acad5c901", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c9ef5363714f9a867539221098048b772c27709fb6d490adcca2e568ba4845161ce692fe28e3e20f1d6808b4b1e9836c8201cddda7cebc0e0d08d3b43c1013"} 07:40:29 INFO - Running post-run listener: copy_logs_to_upload_dir 07:40:29 INFO - Copying logs to upload dir... 07:40:29 INFO - mkdir: /builds/slave/test/build/upload/logs 07:40:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.216121 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-28 07:40:29.339961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:40:29.343948) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76fe9bff019bbbc359c3cd96b4ba4070030a91898c601b29639de60f8dc504d0beb5492186cd78c39221e83c2b367df6770535ce1074bcf26299f9813bb23756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e10313c19bd6f0cd9a8ca825c5d8cb81fb79ed773107033fa76200fe0653fcae6b0f3bc1e7a84888e6fcfec4ace4cf65aea40e9c3d28fb5ef247d0acad5c901", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c9ef5363714f9a867539221098048b772c27709fb6d490adcca2e568ba4845161ce692fe28e3e20f1d6808b4b1e9836c8201cddda7cebc0e0d08d3b43c1013"} build_url:https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/MSDLVg-gRZe8Z-15gFGgWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76fe9bff019bbbc359c3cd96b4ba4070030a91898c601b29639de60f8dc504d0beb5492186cd78c39221e83c2b367df6770535ce1074bcf26299f9813bb23756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e10313c19bd6f0cd9a8ca825c5d8cb81fb79ed773107033fa76200fe0653fcae6b0f3bc1e7a84888e6fcfec4ace4cf65aea40e9c3d28fb5ef247d0acad5c901", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c9ef5363714f9a867539221098048b772c27709fb6d490adcca2e568ba4845161ce692fe28e3e20f1d6808b4b1e9836c8201cddda7cebc0e0d08d3b43c1013"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:40:29.369284) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:40:29.369632) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467123599.788368-1600436523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:40:29.451523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:40:29.451875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:40:29.452168) ========= ========= Total master_lag: 0.17 =========