builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1468474260.74 results: success (0) buildid: 20160713193238 builduid: 004ed187fec5449ea2030cbe672ec6cb revision: c3792b13e44350100962143db01c7ff6e15a7ee1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.741866) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.742355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.742748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.797096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.797867) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 22:31:01-- 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-07-13 22:31:01 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.927726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.928067) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015053 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.998845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:00.999398) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c3792b13e44350100962143db01c7ff6e15a7ee1 --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 c3792b13e44350100962143db01c7ff6e15a7ee1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 22:31:01,322 truncating revision to first 12 chars 2016-07-13 22:31:01,322 Setting DEBUG logging. 2016-07-13 22:31:01,322 attempt 1/10 2016-07-13 22:31:01,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c3792b13e443?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 22:31:01,651 unpacking tar archive at: mozilla-inbound-c3792b13e443/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756705 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:01.792360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:01.795873) ========= script_repo_revision: c3792b13e44350100962143db01c7ff6e15a7ee1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:01.796397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:01.796710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:31:01.807900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 22:31:01.808327) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:31:02 INFO - MultiFileLogger online at 20160713 22:31:02 in /builds/slave/test 22:31:02 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 22:31:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:31:02 INFO - {'append_to_log': False, 22:31:02 INFO - 'base_work_dir': '/builds/slave/test', 22:31:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:31:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:31:02 INFO - 'branch': 'Mozilla-Inbound', 22:31:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:31:02 INFO - 'config_files': ('talos/linux_config.py',), 22:31:02 INFO - 'default_actions': ('clobber', 22:31:02 INFO - 'read-buildbot-config', 22:31:02 INFO - 'download-and-extract', 22:31:02 INFO - 'populate-webroot', 22:31:02 INFO - 'create-virtualenv', 22:31:02 INFO - 'install', 22:31:02 INFO - 'run-tests'), 22:31:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:31:02 INFO - 'download_minidump_stackwalk': True, 22:31:02 INFO - 'download_symbols': 'ondemand', 22:31:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:31:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:31:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:31:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:31:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:31:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:31:02 INFO - 'installer_path': 'installer.exe', 22:31:02 INFO - 'log_level': 'info', 22:31:02 INFO - 'log_name': 'talos', 22:31:02 INFO - 'log_to_console': True, 22:31:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:31:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:31:02 INFO - 'opt_config_files': (), 22:31:02 INFO - 'pip_index': False, 22:31:02 INFO - 'sps_profile': False, 22:31:02 INFO - 'sps_profile_interval': 0, 22:31:02 INFO - 'suite': 'dromaeojs-e10s', 22:31:02 INFO - 'system_bits': '32', 22:31:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:31:02 INFO - 'title': 'talos-linux64-ix-019', 22:31:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:31:02 INFO - 'use_talos_json': True, 22:31:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:31:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:31:02 INFO - 'work_dir': 'build'} 22:31:02 INFO - ##### 22:31:02 INFO - ##### Running clobber step. 22:31:02 INFO - ##### 22:31:02 INFO - Running pre-action listener: _resource_record_pre_action 22:31:02 INFO - Running main action method: clobber 22:31:02 INFO - rmtree: /builds/slave/test/build 22:31:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:31:03 INFO - Running post-action listener: _resource_record_post_action 22:31:03 INFO - ##### 22:31:03 INFO - ##### Finished clobber step (success) 22:31:03 INFO - ##### 22:31:03 INFO - ##### 22:31:03 INFO - ##### Running read-buildbot-config step. 22:31:03 INFO - ##### 22:31:03 INFO - Running pre-action listener: _resource_record_pre_action 22:31:03 INFO - Running main action method: read_buildbot_config 22:31:03 INFO - Using buildbot properties: 22:31:03 INFO - { 22:31:03 INFO - "project": "", 22:31:03 INFO - "product": "firefox", 22:31:03 INFO - "script_repo_revision": "production", 22:31:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:31:03 INFO - "repository": "", 22:31:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:31:03 INFO - "buildid": "20160713193238", 22:31:03 INFO - "pgo_build": "True", 22:31:03 INFO - "basedir": "/builds/slave/test", 22:31:03 INFO - "buildnumber": 824, 22:31:03 INFO - "slavename": "talos-linux64-ix-019", 22:31:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:31:03 INFO - "platform": "ubuntu64_hw", 22:31:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:31:03 INFO - "branch": "mozilla-inbound", 22:31:03 INFO - "repo_path": "integration/mozilla-inbound", 22:31:03 INFO - "revision": "c3792b13e44350100962143db01c7ff6e15a7ee1", 22:31:03 INFO - "stage_platform": "linux64-pgo", 22:31:03 INFO - "builduid": "004ed187fec5449ea2030cbe672ec6cb", 22:31:03 INFO - "slavebuilddir": "test" 22:31:03 INFO - } 22:31:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:31:03 INFO - Running post-action listener: _resource_record_post_action 22:31:03 INFO - ##### 22:31:03 INFO - ##### Finished read-buildbot-config step (success) 22:31:03 INFO - ##### 22:31:03 INFO - ##### 22:31:03 INFO - ##### Running download-and-extract step. 22:31:03 INFO - ##### 22:31:03 INFO - Running pre-action listener: _resource_record_pre_action 22:31:03 INFO - Running main action method: download_and_extract 22:31:03 INFO - mkdir: /builds/slave/test/build/tests 22:31:03 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')]} 22:31:03 INFO - https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:31:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:31:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:31:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:08 INFO - Downloaded 1361 bytes. 22:31:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:31:08 INFO - Using the following test package requirements: 22:31:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:31:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:31:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:31:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'jsshell-linux-x86_64.zip'], 22:31:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:31:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:31:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:31:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:31:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:31:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:31:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:08 INFO - https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:31:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:31:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:31:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:19 INFO - Downloaded 24327007 bytes. 22:31:19 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'] 22:31:19 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 22:31:20 INFO - Return code: 0 22:31:20 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 22:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:20 INFO - https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:21 INFO - Downloaded 24327007 bytes. 22:31:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:31:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:31:23 INFO - Return code: 0 22:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:23 INFO - https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:24 INFO - Downloaded 14403317 bytes. 22:31:24 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'] 22:31:24 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 22:31:24 INFO - Return code: 0 22:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:24 INFO - https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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 22:31:26 INFO - Downloaded 60818180 bytes. 22:31:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:31:26 INFO - mkdir: /builds/slave/test/properties 22:31:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:31:26 INFO - Writing to file /builds/slave/test/properties/build_url 22:31:26 INFO - Contents: 22:31:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:31:26 INFO - Running post-action listener: _resource_record_post_action 22:31:26 INFO - Running post-action listener: set_extra_try_arguments 22:31:26 INFO - ##### 22:31:26 INFO - ##### Finished download-and-extract step (success) 22:31:26 INFO - ##### 22:31:26 INFO - ##### 22:31:26 INFO - ##### Running populate-webroot step. 22:31:26 INFO - ##### 22:31:26 INFO - Running pre-action listener: _resource_record_pre_action 22:31:26 INFO - Running main action method: populate_webroot 22:31:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:31:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:31:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:31:26 INFO - '--tppagecycles', 22:31:26 INFO - '7'], 22:31:26 INFO - 'tests': ['tsvgm']}}, 22:31:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:31:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:31:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:31:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:31:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['damp', 'tps']}, 22:31:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'tests': ['damp', 'tps']}, 22:31:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['dromaeo_dom']}, 22:31:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:31:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['basic_compositor_video']}, 22:31:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:31:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'other-e10s': {'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['a11yr', 22:31:26 INFO - 'ts_paint', 22:31:26 INFO - 'tpaint', 22:31:26 INFO - 'sessionrestore', 22:31:26 INFO - 'sessionrestore_no_auto_restore', 22:31:26 INFO - 'tabpaint']}, 22:31:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['tsvgx', 22:31:26 INFO - 'tsvgr_opacity', 22:31:26 INFO - 'tart', 22:31:26 INFO - 'tscrollx', 22:31:26 INFO - 'cart']}, 22:31:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:31:26 INFO - 'tsvgr_opacity', 22:31:26 INFO - 'tart', 22:31:26 INFO - 'tscrollx', 22:31:26 INFO - 'cart']}, 22:31:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'talos_options': ['--disable-e10s'], 22:31:26 INFO - 'tests': ['tp5o']}, 22:31:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'tests': ['tp5o']}, 22:31:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'talos_options': ['--disable-e10s', 22:31:26 INFO - '--xperf_path', 22:31:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:26 INFO - 'tests': ['tp5n']}, 22:31:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:26 INFO - 'talos_options': ['--xperf_path', 22:31:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:26 INFO - 'tests': ['tp5n']}}, 22:31:26 INFO - 'talos.zip': {'path': '', 22:31:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:31:26 INFO - Running post-action listener: _resource_record_post_action 22:31:26 INFO - ##### 22:31:26 INFO - ##### Finished populate-webroot step (success) 22:31:26 INFO - ##### 22:31:26 INFO - ##### 22:31:26 INFO - ##### Running create-virtualenv step. 22:31:26 INFO - ##### 22:31:26 INFO - Running pre-action listener: _resource_record_pre_action 22:31:26 INFO - Running main action method: create_virtualenv 22:31:26 INFO - Creating virtualenv /builds/slave/test/build/venv 22:31:26 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 22:31:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:31:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:31:26 INFO - Using real prefix '/usr' 22:31:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:31:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:31:29 INFO - Installing pip.................done. 22:31:29 INFO - Return code: 0 22:31:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:31:29 INFO - Using env: {'DISPLAY': ':0', 22:31:29 INFO - 'HOME': '/home/cltbld', 22:31:29 INFO - 'LANG': 'en_US.UTF-8', 22:31:29 INFO - 'LANGUAGE': 'en_US:en', 22:31:29 INFO - 'LOGNAME': 'cltbld', 22:31:29 INFO - 'MAIL': '/var/mail/cltbld', 22:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:29 INFO - 'MOZ_NO_REMOTE': '1', 22:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:29 INFO - 'NO_EM_RESTART': '1', 22:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:29 INFO - 'PWD': '/builds/slave/test', 22:31:29 INFO - 'SHELL': '/bin/bash', 22:31:29 INFO - 'SHLVL': '1', 22:31:29 INFO - 'TERM': 'linux', 22:31:29 INFO - 'TMOUT': '86400', 22:31:29 INFO - 'USER': 'cltbld', 22:31:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:29 INFO - '_': '/tools/buildbot/bin/python'} 22:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:29 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 22:31:29 INFO - Cleaning up... 22:31:29 INFO - Return code: 0 22:31:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:31:29 INFO - Using env: {'DISPLAY': ':0', 22:31:29 INFO - 'HOME': '/home/cltbld', 22:31:29 INFO - 'LANG': 'en_US.UTF-8', 22:31:29 INFO - 'LANGUAGE': 'en_US:en', 22:31:29 INFO - 'LOGNAME': 'cltbld', 22:31:29 INFO - 'MAIL': '/var/mail/cltbld', 22:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:29 INFO - 'MOZ_NO_REMOTE': '1', 22:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:29 INFO - 'NO_EM_RESTART': '1', 22:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:29 INFO - 'PWD': '/builds/slave/test', 22:31:29 INFO - 'SHELL': '/bin/bash', 22:31:29 INFO - 'SHLVL': '1', 22:31:29 INFO - 'TERM': 'linux', 22:31:29 INFO - 'TMOUT': '86400', 22:31:29 INFO - 'USER': 'cltbld', 22:31:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:29 INFO - '_': '/tools/buildbot/bin/python'} 22:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:29 INFO - Downloading/unpacking psutil>=3.1.1 22:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:31 INFO - Installing collected packages: psutil 22:31:31 INFO - Running setup.py install for psutil 22:31:31 INFO - building 'psutil._psutil_linux' extension 22:31:31 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 22:31:32 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 22:31:32 INFO - building 'psutil._psutil_posix' extension 22:31:32 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 22:31:32 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 22:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:32 INFO - Successfully installed psutil 22:31:32 INFO - Cleaning up... 22:31:32 INFO - Return code: 0 22:31:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:31:32 INFO - Using env: {'DISPLAY': ':0', 22:31:32 INFO - 'HOME': '/home/cltbld', 22:31:32 INFO - 'LANG': 'en_US.UTF-8', 22:31:32 INFO - 'LANGUAGE': 'en_US:en', 22:31:32 INFO - 'LOGNAME': 'cltbld', 22:31:32 INFO - 'MAIL': '/var/mail/cltbld', 22:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:32 INFO - 'MOZ_NO_REMOTE': '1', 22:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:32 INFO - 'NO_EM_RESTART': '1', 22:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:32 INFO - 'PWD': '/builds/slave/test', 22:31:32 INFO - 'SHELL': '/bin/bash', 22:31:32 INFO - 'SHLVL': '1', 22:31:32 INFO - 'TERM': 'linux', 22:31:32 INFO - 'TMOUT': '86400', 22:31:32 INFO - 'USER': 'cltbld', 22:31:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:32 INFO - '_': '/tools/buildbot/bin/python'} 22:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:31:34 INFO - Installing collected packages: mozsystemmonitor 22:31:34 INFO - Running setup.py install for mozsystemmonitor 22:31:34 INFO - Successfully installed mozsystemmonitor 22:31:34 INFO - Cleaning up... 22:31:34 INFO - Return code: 0 22:31:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:31:34 INFO - Using env: {'DISPLAY': ':0', 22:31:34 INFO - 'HOME': '/home/cltbld', 22:31:34 INFO - 'LANG': 'en_US.UTF-8', 22:31:34 INFO - 'LANGUAGE': 'en_US:en', 22:31:34 INFO - 'LOGNAME': 'cltbld', 22:31:34 INFO - 'MAIL': '/var/mail/cltbld', 22:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:34 INFO - 'MOZ_NO_REMOTE': '1', 22:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:34 INFO - 'NO_EM_RESTART': '1', 22:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:34 INFO - 'PWD': '/builds/slave/test', 22:31:34 INFO - 'SHELL': '/bin/bash', 22:31:34 INFO - 'SHLVL': '1', 22:31:34 INFO - 'TERM': 'linux', 22:31:34 INFO - 'TMOUT': '86400', 22:31:34 INFO - 'USER': 'cltbld', 22:31:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:34 INFO - '_': '/tools/buildbot/bin/python'} 22:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:34 INFO - Downloading/unpacking jsonschema==2.5.1 22:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:31:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 22:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:31:37 INFO - warning: no files found matching '*.txt' 22:31:37 INFO - no previously-included directories found matching 'build' 22:31:37 INFO - no previously-included directories found matching 'dist' 22:31:37 INFO - no previously-included directories found matching '.git*' 22:31:37 INFO - Installing collected packages: jsonschema, functools32 22:31:37 INFO - Running setup.py install for functools32 22:31:37 INFO - warning: no files found matching '*.txt' 22:31:37 INFO - no previously-included directories found matching 'build' 22:31:37 INFO - no previously-included directories found matching 'dist' 22:31:37 INFO - no previously-included directories found matching '.git*' 22:31:37 INFO - Successfully installed jsonschema functools32 22:31:37 INFO - Cleaning up... 22:31:37 INFO - Return code: 0 22:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:31:37 INFO - Using env: {'DISPLAY': ':0', 22:31:37 INFO - 'HOME': '/home/cltbld', 22:31:37 INFO - 'LANG': 'en_US.UTF-8', 22:31:37 INFO - 'LANGUAGE': 'en_US:en', 22:31:37 INFO - 'LOGNAME': 'cltbld', 22:31:37 INFO - 'MAIL': '/var/mail/cltbld', 22:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:37 INFO - 'MOZ_NO_REMOTE': '1', 22:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:37 INFO - 'NO_EM_RESTART': '1', 22:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:37 INFO - 'PWD': '/builds/slave/test', 22:31:37 INFO - 'SHELL': '/bin/bash', 22:31:37 INFO - 'SHLVL': '1', 22:31:37 INFO - 'TERM': 'linux', 22:31:37 INFO - 'TMOUT': '86400', 22:31:37 INFO - 'USER': 'cltbld', 22:31:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:37 INFO - '_': '/tools/buildbot/bin/python'} 22:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:37 INFO - Downloading/unpacking blobuploader==1.2.4 22:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:40 INFO - Downloading docopt-0.6.1.tar.gz 22:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 22:31:40 INFO - Running setup.py install for blobuploader 22:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:31:40 INFO - Running setup.py install for requests 22:31:40 INFO - Running setup.py install for docopt 22:31:40 INFO - Successfully installed blobuploader requests docopt 22:31:40 INFO - Cleaning up... 22:31:40 INFO - Return code: 0 22:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:31:40 INFO - Using env: {'DISPLAY': ':0', 22:31:40 INFO - 'HOME': '/home/cltbld', 22:31:40 INFO - 'LANG': 'en_US.UTF-8', 22:31:40 INFO - 'LANGUAGE': 'en_US:en', 22:31:40 INFO - 'LOGNAME': 'cltbld', 22:31:40 INFO - 'MAIL': '/var/mail/cltbld', 22:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:40 INFO - 'MOZ_NO_REMOTE': '1', 22:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:40 INFO - 'NO_EM_RESTART': '1', 22:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:40 INFO - 'PWD': '/builds/slave/test', 22:31:40 INFO - 'SHELL': '/bin/bash', 22:31:40 INFO - 'SHLVL': '1', 22:31:40 INFO - 'TERM': 'linux', 22:31:40 INFO - 'TMOUT': '86400', 22:31:40 INFO - 'USER': 'cltbld', 22:31:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:40 INFO - '_': '/tools/buildbot/bin/python'} 22:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:41 INFO - Running setup.py (path:/tmp/pip-RHN3kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:41 INFO - Running setup.py (path:/tmp/pip-jAmx0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:41 INFO - Running setup.py (path:/tmp/pip-4kw3At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:41 INFO - Running setup.py (path:/tmp/pip-AVnSXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:41 INFO - Running setup.py (path:/tmp/pip-vdETqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:41 INFO - Running setup.py (path:/tmp/pip-vjd8Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:41 INFO - Running setup.py (path:/tmp/pip-CEAwFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:41 INFO - Running setup.py (path:/tmp/pip-qjm79U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:41 INFO - Running setup.py (path:/tmp/pip-TpuIHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:41 INFO - Running setup.py (path:/tmp/pip-8Iw91S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:41 INFO - Running setup.py (path:/tmp/pip-ZWH0gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:41 INFO - Running setup.py (path:/tmp/pip-ifRZPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:41 INFO - Running setup.py (path:/tmp/pip-MdHIos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:42 INFO - Running setup.py (path:/tmp/pip-xVU8pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:42 INFO - Running setup.py (path:/tmp/pip-wnK6Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:42 INFO - Running setup.py (path:/tmp/pip-AE3mFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:42 INFO - Running setup.py (path:/tmp/pip-ne65K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:31:42 INFO - Running setup.py install for manifestparser 22:31:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:31:42 INFO - Running setup.py install for mozcrash 22:31:42 INFO - Running setup.py install for mozdebug 22:31:42 INFO - Running setup.py install for mozdevice 22:31:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:31:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:31:42 INFO - Running setup.py install for mozfile 22:31:42 INFO - Running setup.py install for mozhttpd 22:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:31:42 INFO - Running setup.py install for mozinfo 22:31:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozInstall 22:31:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozleak 22:31:43 INFO - Running setup.py install for mozlog 22:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for moznetwork 22:31:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozprocess 22:31:43 INFO - Running setup.py install for mozprofile 22:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozrunner 22:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozscreenshot 22:31:43 INFO - Running setup.py install for moztest 22:31:44 INFO - Running setup.py install for mozversion 22:31:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:31:44 INFO - Cleaning up... 22:31:44 INFO - Return code: 0 22:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:44 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 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:44 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 22:31:44 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 22:31:44 INFO - Using env: {'DISPLAY': ':0', 22:31:44 INFO - 'HOME': '/home/cltbld', 22:31:44 INFO - 'LANG': 'en_US.UTF-8', 22:31:44 INFO - 'LANGUAGE': 'en_US:en', 22:31:44 INFO - 'LOGNAME': 'cltbld', 22:31:44 INFO - 'MAIL': '/var/mail/cltbld', 22:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:44 INFO - 'MOZ_NO_REMOTE': '1', 22:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:44 INFO - 'NO_EM_RESTART': '1', 22:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:44 INFO - 'PWD': '/builds/slave/test', 22:31:44 INFO - 'SHELL': '/bin/bash', 22:31:44 INFO - 'SHLVL': '1', 22:31:44 INFO - 'TERM': 'linux', 22:31:44 INFO - 'TMOUT': '86400', 22:31:44 INFO - 'USER': 'cltbld', 22:31:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:44 INFO - '_': '/tools/buildbot/bin/python'} 22:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:44 INFO - Running setup.py (path:/tmp/pip-FK24P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:44 INFO - Running setup.py (path:/tmp/pip-LQGpMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:44 INFO - Running setup.py (path:/tmp/pip-j8jE_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:44 INFO - Running setup.py (path:/tmp/pip-dram2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:44 INFO - Running setup.py (path:/tmp/pip-YIwviN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:44 INFO - Running setup.py (path:/tmp/pip-p5zzP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:44 INFO - Running setup.py (path:/tmp/pip-DbGcoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:44 INFO - Running setup.py (path:/tmp/pip-dl1KR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:44 INFO - Running setup.py (path:/tmp/pip-mNrRr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:45 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)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:45 INFO - Running setup.py (path:/tmp/pip-byKFQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:45 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)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:45 INFO - Running setup.py (path:/tmp/pip-aoufrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:45 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)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:45 INFO - Running setup.py (path:/tmp/pip-rGvctb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:45 INFO - Running setup.py (path:/tmp/pip-CttUmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:45 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)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:45 INFO - Running setup.py (path:/tmp/pip-nC35xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:45 INFO - Running setup.py (path:/tmp/pip-vRLkAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:45 INFO - Running setup.py (path:/tmp/pip-xA5DZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:45 INFO - Running setup.py (path:/tmp/pip-86_4QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:47 INFO - Downloading blessings-1.6.tar.gz 22:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:31:47 INFO - Installing collected packages: blessings 22:31:47 INFO - Running setup.py install for blessings 22:31:47 INFO - Successfully installed blessings 22:31:47 INFO - Cleaning up... 22:31:47 INFO - Return code: 0 22:31:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:47 INFO - Reading from file tmpfile_stdout 22:31:47 INFO - Current package versions: 22:31:47 INFO - argparse == 1.2.1 22:31:47 INFO - blessings == 1.6 22:31:47 INFO - blobuploader == 1.2.4 22:31:47 INFO - docopt == 0.6.1 22:31:47 INFO - functools32 == 3.2.3-2 22:31:47 INFO - jsonschema == 2.5.1 22:31:47 INFO - manifestparser == 1.1 22:31:47 INFO - mozInstall == 1.12 22:31:47 INFO - mozcrash == 0.17 22:31:47 INFO - mozdebug == 0.1 22:31:47 INFO - mozdevice == 0.48 22:31:47 INFO - mozfile == 1.2 22:31:47 INFO - mozhttpd == 0.7 22:31:47 INFO - mozinfo == 0.9 22:31:47 INFO - mozleak == 0.1 22:31:47 INFO - mozlog == 3.2 22:31:47 INFO - moznetwork == 0.27 22:31:47 INFO - mozprocess == 0.23 22:31:47 INFO - mozprofile == 0.28 22:31:47 INFO - mozrunner == 6.12 22:31:47 INFO - mozscreenshot == 0.1 22:31:47 INFO - mozsystemmonitor == 0.3 22:31:47 INFO - moztest == 0.7 22:31:47 INFO - mozversion == 1.4 22:31:47 INFO - psutil == 3.1.1 22:31:47 INFO - requests == 1.2.3 22:31:47 INFO - wsgiref == 0.1.2 22:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:31:47 INFO - Using env: {'DISPLAY': ':0', 22:31:47 INFO - 'HOME': '/home/cltbld', 22:31:47 INFO - 'LANG': 'en_US.UTF-8', 22:31:47 INFO - 'LANGUAGE': 'en_US:en', 22:31:47 INFO - 'LOGNAME': 'cltbld', 22:31:47 INFO - 'MAIL': '/var/mail/cltbld', 22:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:47 INFO - 'MOZ_NO_REMOTE': '1', 22:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:47 INFO - 'NO_EM_RESTART': '1', 22:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:47 INFO - 'PWD': '/builds/slave/test', 22:31:47 INFO - 'SHELL': '/bin/bash', 22:31:47 INFO - 'SHLVL': '1', 22:31:47 INFO - 'TERM': 'linux', 22:31:47 INFO - 'TMOUT': '86400', 22:31:47 INFO - 'USER': 'cltbld', 22:31:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:47 INFO - '_': '/tools/buildbot/bin/python'} 22:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:31:48 INFO - Cleaning up... 22:31:48 INFO - Return code: 0 22:31:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:31:48 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')]} 22:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:48 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')]} 22:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:48 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 0x239b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', '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 22:31:48 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 22:31:48 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 22:31:48 INFO - Using env: {'DISPLAY': ':0', 22:31:48 INFO - 'HOME': '/home/cltbld', 22:31:48 INFO - 'LANG': 'en_US.UTF-8', 22:31:48 INFO - 'LANGUAGE': 'en_US:en', 22:31:48 INFO - 'LOGNAME': 'cltbld', 22:31:48 INFO - 'MAIL': '/var/mail/cltbld', 22:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:48 INFO - 'MOZ_NO_REMOTE': '1', 22:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:48 INFO - 'NO_EM_RESTART': '1', 22:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:48 INFO - 'PWD': '/builds/slave/test', 22:31:48 INFO - 'SHELL': '/bin/bash', 22:31:48 INFO - 'SHLVL': '1', 22:31:48 INFO - 'TERM': 'linux', 22:31:48 INFO - 'TMOUT': '86400', 22:31:48 INFO - 'USER': 'cltbld', 22:31:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:48 INFO - '_': '/tools/buildbot/bin/python'} 22:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:31:48 INFO - Cleaning up... 22:31:48 INFO - Return code: 0 22:31:48 INFO - Running post-action listener: _resource_record_post_action 22:31:48 INFO - Running post-action listener: _start_resource_monitoring 22:31:48 INFO - Starting resource monitoring. 22:31:48 INFO - ##### 22:31:48 INFO - ##### Finished create-virtualenv step (success) 22:31:48 INFO - ##### 22:31:48 INFO - ##### 22:31:48 INFO - ##### Running install step. 22:31:48 INFO - ##### 22:31:48 INFO - Running pre-action listener: _resource_record_pre_action 22:31:48 INFO - Running main action method: install 22:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:48 INFO - Reading from file tmpfile_stdout 22:31:48 INFO - Detecting whether we're running mozinstall >=1.0... 22:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:31:48 INFO - Reading from file tmpfile_stdout 22:31:48 INFO - Output received: 22:31:48 INFO - Usage: mozinstall [options] installer 22:31:48 INFO - Options: 22:31:48 INFO - -h, --help show this help message and exit 22:31:48 INFO - -d DEST, --destination=DEST 22:31:48 INFO - Directory to install application into. [default: 22:31:48 INFO - "/builds/slave/test"] 22:31:48 INFO - --app=APP Application being installed. [default: firefox] 22:31:48 INFO - mkdir: /builds/slave/test/build/application 22:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:32:05 INFO - Reading from file tmpfile_stdout 22:32:05 INFO - Output received: 22:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 22:32:05 INFO - Running post-action listener: _resource_record_post_action 22:32:05 INFO - ##### 22:32:05 INFO - ##### Finished install step (success) 22:32:05 INFO - ##### 22:32:05 INFO - ##### 22:32:05 INFO - ##### Running run-tests step. 22:32:05 INFO - ##### 22:32:05 INFO - Running pre-action listener: _resource_record_pre_action 22:32:05 INFO - Running main action method: run_tests 22:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:32:05 INFO - Python 2.7.3 22:32:05 INFO - Return code: 0 22:32:05 INFO - grabbing minidump binary from tooltool 22:32: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')]} 22:32:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2659570>, '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 0x265a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:32:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:32:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:32:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:32:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:32:06 INFO - Return code: 0 22:32:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:32:06 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/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:32:06 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/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:32:06 INFO - Using env: {'DISPLAY': ':0', 22:32:06 INFO - 'HOME': '/home/cltbld', 22:32:06 INFO - 'LANG': 'en_US.UTF-8', 22:32:06 INFO - 'LANGUAGE': 'en_US:en', 22:32:06 INFO - 'LOGNAME': 'cltbld', 22:32:06 INFO - 'MAIL': '/var/mail/cltbld', 22:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:06 INFO - 'MOZ_NO_REMOTE': '1', 22:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:06 INFO - 'NO_EM_RESTART': '1', 22:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:06 INFO - 'PWD': '/builds/slave/test', 22:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:32:06 INFO - 'SHELL': '/bin/bash', 22:32:06 INFO - 'SHLVL': '1', 22:32:06 INFO - 'TERM': 'linux', 22:32:06 INFO - 'TMOUT': '86400', 22:32:06 INFO - 'USER': 'cltbld', 22:32:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227', 22:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:06 INFO - '_': '/tools/buildbot/bin/python'} 22:32:06 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/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:32:06 INFO - mozversion application_buildid: 20160713193238 22:32:06 INFO - mozversion application_changeset: c3792b13e44350100962143db01c7ff6e15a7ee1 22:32:06 INFO - mozversion application_display_name: Nightly 22:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:32:06 INFO - mozversion application_name: Firefox 22:32:06 INFO - mozversion application_remotingname: firefox 22:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:32:06 INFO - mozversion application_vendor: Mozilla 22:32:06 INFO - mozversion application_version: 50.0a1 22:32:06 INFO - mozversion platform_buildid: 20160713193238 22:32:06 INFO - mozversion platform_changeset: c3792b13e44350100962143db01c7ff6e15a7ee1 22:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:32:06 INFO - mozversion platform_version: 50.0a1 22:32:06 INFO - using testdate: 1468474326 22:32:06 INFO - actual date: 1468474326 22:32:06 INFO - starting webserver on 'localhost:59600' 22:32:06 INFO - SUITE-START | Running 2 tests 22:32:06 INFO - TEST-START | dromaeo_css 22:32:06 INFO - operating with platform_type : linux_ 22:32:06 INFO - Initialising browser for dromaeo_css test... 22:32:06 INFO - TEST-INFO | started process 23167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZPBXP/profile http://localhost:59600/getInfo.html) 22:32:11 INFO - PROCESS | 23167 | __metrics Screen width/height:1600/1200 22:32:11 INFO - PROCESS | 23167 | colorDepth:24 22:32:11 INFO - PROCESS | 23167 | Browser inner width/height: 1024/697 22:32:11 INFO - PROCESS | 23167 | __metrics 22:32:11 ERROR - PROCESS | 23167 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 22:32:12 INFO - TEST-INFO | 23167: exit 0 22:32:12 INFO - Browser initialized. 22:32:12 INFO - Running cycle 1/1 for dromaeo_css test... 22:32:12 INFO - TEST-INFO | started process 23287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZPBXP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:24 INFO - PROCESS | 23287 | RSS: Main: 167841792 22:32:24 INFO - PROCESS | 23287 | 22:33:14 INFO - PROCESS | 23287 | 1468474394028 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] 22:35:21 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59600/tests/dromaeo/cssquery-ext.html) 22:35:22 INFO - PROCESS | 23287 | RSS: Main: 172175360 22:35:22 INFO - PROCESS | 23287 | 22:38:24 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-ext.html (next: http://localhost:59600/tests/dromaeo/cssquery-jquery.html) 22:38:25 INFO - PROCESS | 23287 | RSS: Main: 167936000 22:38:25 INFO - PROCESS | 23287 | 22:41:27 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59600/tests/dromaeo/cssquery-mootools.html) 22:41:27 INFO - PROCESS | 23287 | RSS: Main: 171106304 22:41:27 INFO - PROCESS | 23287 | 22:44:29 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59600/tests/dromaeo/cssquery-prototype.html) 22:44:30 INFO - PROCESS | 23287 | RSS: Main: 167211008 22:44:30 INFO - PROCESS | 23287 | 22:47:32 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59600/tests/dromaeo/cssquery-yui.html) 22:47:33 INFO - PROCESS | 23287 | RSS: Main: 169373696 22:47:33 INFO - PROCESS | 23287 | 22:50:35 INFO - PROCESS | 23287 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-yui.html (next: http://localhost:59600/tests/dromaeo/cssquery-dojo.html) 22:50:36 INFO - PROCESS | 23287 | RSS: Main: 170360832 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | __start_tp_report 22:50:36 INFO - PROCESS | 23287 | _x_x_mozilla_page_load 22:50:36 INFO - PROCESS | 23287 | _x_x_mozilla_page_load_details 22:50:36 INFO - PROCESS | 23287 | |i|pagename|runs| 22:50:36 INFO - PROCESS | 23287 | |0;dojo.html;3050.557669137975;3082.1215953453257;3094.45846976779;3097.194729370363;3113.2528193233616;5427.240186373911;5451.482109199625;5466.835994920149;5554.91667624986;5579.330480342354;5353.544948679367;5376.973115134429;5412.323459567554;5422.511973922346;5434.347878254615;4873.951260487403;4879.536444037811;4990.9768497457935;5018.397792264934;5068.695878247298;719.5478728059686;4785.377900872882;4800.951990480103;4882.511748825124;4979.8008079676765;4790.80836766529;4878.560929516325;4885.022995400934;4896.706197628154;4910.582600478963;4902.975485122587;4907.950920490785;4908.877278068041;4919.532644398776;4969.950300496985;4846.9579040506105;4879.487653796371;4882.487338829407;4910.852674419773;4961.107000739866;5364.704941228231;5398.406175320712;5430.266913966603;5441.945580544183;5445.428230035829;5582.609217354787;5761.654300741927;5774.076147816371;5820.30156381237;5825.271841019872;5849.502792262663;5911.379305172981;5913.645181289094;5952.4642782149385;5973.492253158487;5551.444855514456;5561.916571251434;5566.83096549721;5571.944280557183;5589.608727389084;5766.682832444256;5805.071188609802;5940.168376427304;5983.04271316596;6004.039353703386;5610.97194514033;5654.038813401731;5654.180143879114;5661.915071273934;5672.914906276409;5796.449337313033;5797.449242321973;5799.681017544076;5804.738786754606;5810.244668193192;5734.111212762028;5744.626599271034;5782.768689252467;5794.594378393472;5796.072628379439;5791.3339965903615;5795.043817770105;5798.478136967693;5835.241418615553;5864.44287792659;4387.517373088957;4412.139632771643;4414.867553973386;4419.447569053868;4450.132224216247;3876.1666241757594;3887.5723670396233;3911.002694312932;3928.4303775952326;3948.1116748731306;5400.108982018001;5497.422770609109;5546.4453554644215;5547.389787123413;5592.608517403743;5859.824205273849;5862.472377486047;5870.589058765845;5871.031279838779;5873.353931067579;5379.78480860769;5407.134858422633;5436.755346009439;5442.727863606804;5443.265159203457;4833.927491087637;4840.370751802243;4855.781489832966;4963.90072198554;4995.325631039763;6086.430886010694;6087.512325156257;6090.318742874174;6091.2397546061475;6137.938620613826;5861.0915308127305;5906.025505791582;5909.906667266398;5910.911336330045;5916.934951708734;5887.352391236875;5905.143754155538;5943.64338139713;5959.642421454727;6088.756449741961;5770.855728606818;5783.045797443375;5787.565932554991;5788.768449262151;5794.391588883106;5788.421157884346;5799.362070172362;5854.092615644582;5857.8535536610225;5867.383924687846;5652.406497317723;5673.120666296731;5687.3459552152035;5710.885782284414;5771;5702.287214098238;5723.627964182315;5726.770929162787;5746.42535746422;5757.769689212385;5523.171524271392;5630.4369563043365;5640.238567793295;5642.689652069175;5644.85887852807;5687.687177205128;5714.942850571608;5730.226419433323;5826.242588463472;5840.2991641003355;5649.6327738696855;5655.632383895034;5656.85857853557;5662.915056274077;5664.405237450009 22:50:36 INFO - PROCESS | 23287 | |1;ext.html;599.206051981125;601.2604496469343;610.3682688417489;620.1349117980418;654.5614438326321;37246.25507489849;37942;41159.58840411595;41175.38236926449;41215.58784412155;41823;42160.57839421605;42372.78813605928;42538.57461425385;42640.78679606598;8575.356848236375;8722.476651400937;8757.51833649149;8770.429922055078;8784.429012114193;8660.133986601353;8778.868316975251;8781.34139939504;8800.779980500474;8802.51586162764;8692.56537173142;8759.211670949613;8770.868436973418;8801.735947921572;8808.691695790649;8747.78130546735;8749.7812554686;8781.56092195391;8800.515971621558;8810.559472026373;8554.486730796172;8665.566721663954;8701.608427620773;8701.608427620773;8720;29502;29722;29855.25361865949;29863.552046719316;29874.253143671365;2637.274749443899;3197.9680203197904;3414.5048967899766;3471.5486986691567;3531.94702079469;31750.682493175005;32085.6791432085;32175.678243217502;32593.67406325954;33016.174595635064;4320.725386011134;4333.544977777351;4357.932306584876;4358.542353052915;4407.9416798479115;315210;317249;317927;318078;318181;34915.30169396649;35336.64663353334;35453.290934181176;35496;35502.91716452641;36599.634003660154;36657.63342366595;37083.814580926926;37225;38663.226735465134;17440.12799360027;17593.47219583389;17636.823631763516;17674.91162544179;17681.823181768275;13459.865401346056;13514.932425338007;13590.864091359157;13597.456101756017;13608.183508989492;19918.800811991696;20026.3965684463;20106.296279630144;20110;20161.899190503955;7038.8264625500215;7055.576665400093;7168.139823221247;7170.749023784247;7271;982.9066238707311;1055.6410820320973;1106.2090605217309;1122.8820973797797;1123.084685980923;33747.32505349879;33786;33816.66183338135;33935.32129357399;34291.31417371638;1107.363266121983;1113.5156207049959;1115.3809635652128;1125.8536390269376;1226.1233218248994;16676.74984875228;17600.735988960176;17636.735448968277;17924.641507169785;17981.280748769903;555608;559448;560504;560561;560912;58598.121028184614;59623.40376596178;60072.39927600668;60078;60247;1345.7039451320693;1374.415873253863;1382.8064071029862;1398.531491950208;1399.1115641567678;31234.062978110695;32883;32993.67006329906;33271.66728332686;33566.99299021033;52045.7397713009;52235.73882130565;52578.73710631422;52758.736206318725;52783.47216527785;343322;347543;348647.25676371454;350806;352340;28184.85907570449;28646.57030144591;28674.283142921595;28674.426511469235;28728.856355718923;50098.49901500938;50863;51043;51111;51313.48686513087;41709.58290417178;42693.573064270204;42826;42975.355369668854;43402.782986084865;41855.7907210462;42626.360604590336;42667.78666106774;42780.78609606932;44630;41465;43074;43152.784236078616;45400.318995215755;45760.313595296764;37396.81301593475;37675.2464950694;38977.80511097427;39495;39747;28554.85780568754;29163.562546561396;29450;29870.701292986792;30033.249168770082 22:50:36 INFO - PROCESS | 23287 | |2;jquery.html;380.20737681727707;384.8595262729104;392.82126632382267;398.7926278335266;402.0307961487612;18858;20391.184352625896;20441.386758397235;20837.895810520928;21249.893750531264;19872.70190947137;20333.085011174495;20651.17395304186;20770.584588308226;20829;5713.857153571163;5932.110183472492;5985.072313791369;5991.490723288504;5996.130561068642;5780.942190578104;5837.562182836283;5860.413958604148;5919.704014799265;5924.022536281508;5749.223854779593;5851.268591426072;5870.618409803349;5908.468237858592;5922.58541902067;5780.942190578083;5786.82639520813;5846.50304724099;5853.122031695238;5856.560757943172;5164.380274367062;5177.948220517822;5186.844394668128;5192.350956130484;5193.610479214036;17108.48674539766;24301.756982430124;24650;24731.752682473125;24774.752252477425;2590.352411897026;2723.8229515081457;2926.853657317147;3201.103690966533;3234.110619579611;14917.403303867832;15318.540443786704;15404.845951540565;15474.767878481833;15639.296231669488;1869.943901682938;1894.602133551942;1974.555724961872;1977.5550501137272;2004.1382205651564;82840.58579707063;85517;85549.57225213897;86218;87848;9828.262880283864;9986.051325124101;10408.115310198718;10533.736656583647;10684.198685098649;13916.512922047883;13944.511942082181;14053.22707251111;14071.648208794657;14097.436102555988;8306.335493160532;8325.583720813935;8329.416940814206;8420.957895210608;8489.872651910226;8416.74749757496;8442.282405995558;8473.618687158969;8631.568421578895;8762.211400973943;6434.935650643527;6618;6644.634545100066;6794.490413219029;6829.248782633907;1784.3583902809187;1819.1813683842324;1819.9272029118688;1847.8798878072882;1870.0556219109262;969.6121551379505;980.1864452504547;1026.3687831983277;1032.0762917189074;1036.4921188617523;20681.172753089708;21057.578848422945;21137.471563211042;21283.78716212849;21425.89287053586;948.1229862377273;1020.8417695257247;1024.7438140464883;1067.9679609611724;1100.4387762241154;11364.602238921598;11914.106442016884;12032.27806331623;12074.00778871494;12138.271703697807;493321;494882;497476;503704;506487;79080;82744.58627706823;83578;86476;86788.56605717057;1006.8873894346788;1040.5629635553087;1046.40877903984;1063.7978784031009;1078.5793540519046;16806.57983550421;18224.544386389916;19031.809681903003;19033.904830476313;19045.44348491074;44897.32654010258;45313.320300194864;45340.77329613331;45510.77244613888;45899;64042.359576405506;64071;64562;65411;65568;8305;8727;8888.73333799987;8943;8970.37207395476;9360.4383736976;12908.677283067998;12975.870241297465;13079.803802943154;13133.34333283351;11103.5558577656;11152.721181970515;11164.385958772345;11240.943795280971;11309.773804524028;10914.563417463212;11051.17116216271;11339;11381.089512839118;11587.362695051854;11037.944810275898;11368.090552755924;11382.658520244406;11421.885781142415;11615.883841161818;7286.672099755418;8565;8728.912710873064;8853.29173666118;8962.68630597926;10016.64941727036;11636.301821890713;12343.19769214998;12473.376331183223;12481.126321157431 22:50:36 INFO - PROCESS | 23287 | |3;mootools.html;1475.8488379064331;1510.7960425342578;1650.273879493023;1793.8833975791565;1804.251235737169;8050.879236811453;8759.343049271307;8895.955520222406;9292.488913109777;9362.953185234073;8865.468071915673;9155.725328240147;9190.862137067948;9197.448153110818;9226.815463690722;2371.7509661485556;2414.6740190074293;2428.405040765015;2433.197044975154;2437.390652336916;2363.527294541099;2376.976230237701;2379.167291447988;2402.5795485790004;2409.8072154227707;2380.1550449590404;2380.571497130516;2381.2380038387723;2408.638704194367;2408.9879550602222;2324.23300310897;2332.521833024226;2332.7667233276707;2339.157903154863;2350.9412264693347;2315.7568455312285;2319.8724070176136;2338.8128949683983;2341.7424083350816;2359.09174967637;9240.676576319864;9267.953660231655;9356.578953947088;9357.906420935771;9362.95318523403;5337.706426146599;5448.400675925645;5451.48210919962;5483.890322193573;5498.3127109111365;3475.6871881530783;3542.734294927891;3564.500969864221;3578.1233597768714;3581.4627805829073;1143.1540659911605;1145.936973466459;1148.7415331550417;1151.585429245471;1157.9594714185048;13030.153040052366;13062.542811001664;13102.541411050663;13111.14777539457;13138.343082845915;4747.192977193886;4754.263089221176;4810.574884648959;4862.70823750569;4907.7300748458465;10938.289011214405;10943.83584246237;10962.725931851608;10984.945075274572;11024.283421577733;5453.945460545344;5475.835724928259;5483.588730845203;5490.752916118784;5499.532539734168;4546.909061818745;4995.100881841231;5060.974695126501;5116.386033675983;5167.6641018333685;4132.16118827119;4132.5454200037975;4246.044639955985;4249.723767955073;4274.871753847389;1327.1638867513404;1337.2444568818587;1348.5549768576345;1357.6130802721375;1363.795430685405;918.9402688825205;990.2721499697716;1022.3712416863575;1023.1610079734546;1043.8903915088958;6281.748730050746;6386.201724784402;6390.7763228286785;6416.165898433173;6451.258105317855;462.4058085360296;471.2154263151882;471.70754132437423;472.25855407010664;479.41511356145446;4177.665786737054;4315.223259813264;4373.825046998148;4376.212281789245;4414.955850441519;10755.795062012268;11157.330560166254;11253.774924501464;11258.774824503464;11264.549418023187;10724.249302548902;11010.614628487965;11051.502682379152;11078.833817492745;11183.888161118284;8235.588220588947;8246.670133194724;8281.875771863426;8365.874511882326;8404.621792019374;6327.462165715966;6343.9365606343345;6378.298387177314;6413.647249401328;6421.068945002855;10066.540351649117;10170.694879153638;10286.691399258034;10341.069303762697;10371.429571373646;10459.58161673555;10490.108340791117;10530.684079477627;10541.420221887869;10549.367037977747;7358.264173582599;7839.372850171859;7937.365010799007;7987.361011119213;8079.717209897625;8843.204111629984;8890.06654301289;8933.419327743675;8955.507447090473;8961.059088795582;7916.643751031333;8067.636956336862;8116.513009219466;8243.629036693483;8248.752537423887;7820.257075577811;7909.7231596893835;8047.718329858427;8101;8195.057568379712;7347.742829001173;7363.77908662741;7410.258974102547;7451.776446706607;7453.291937265951;5300.840974770763;5374.865628359166;5393.487618676219;5518.365387980273;5537.224788529689;5426.186072089218;5452.037266583948;5569.387367389503;5588.189712491747;5635.239242702182 22:50:36 INFO - PROCESS | 23287 | |4;prototype.html;313.8822941396976;314.86460821846606;315.25756842635593;318.5238069086714;322.1736246527658;5704.629199102061;5778.410936992329;5781.855453613656;5798.6230894991795;5831.212786273857;5601.915971260424;5623.465770751783;5625.40933202014;5654.660720356771;5670.177824215486;4157.210130075284;4226.197022565718;4337.63130133939;4349.347248045754;4355.128974205171;4328.350747387885;4363.934540981888;4373.781310934456;4374.971881607819;4385.912281754363;4338.674599405042;4353.434053573047;4360.470926862428;4376;4377.562243775629;4257.956800583861;4267.701260911737;4308.547602501755;4314.395984562164;4331.155424692186;3778.7165962552917;3782.6217378262227;3798.2783271178664;3802.3345914465135;3823.9617603823885;5433.673979561239;5480.945190548084;5495.093309603911;5512.173174023928;5519.558435325164;4868.17443458703;4996.775145118479;5017.2724954881705;5021.372328458906;5024.899502009939;5830.5044071254;5904.350521442638;5919.733611987428;5921.467067963904;5937.198478205431;4197.685173611992;4204.159168166379;4208.600182982612;4208.72643278189;4214.115035842477;5924.2298501195;6029.54778391618;6050.939490605082;6054.485368743662;6118.7128055989315;4270.914581708348;4278.657707383401;4282.143571285756;4283.593058659422;4293.291606884829;4338.436003319548;4345.391645169679;4347.478302603708;4350.369196466495;4366.388705581221;4699.953000469952;4925.950740492621;4927.310176575283;4949.381327334083;5011.123053465629;5935.614185077956;5972.492338151305;5984.611000284967;5998.850028749316;6020.638761674313;1483.1027228526802;1487.7024595081027;1492.4552538323435;1499.7600383938518;1511.8034655494716;912.6668765900398;937.5452905340904;951.8381875081253;969.3747532841278;984.3700031979539;5663.122216056518;5680.14797780328;5706.8871570044275;5752.539796816244;5800.158976948319;6073.848153796191;6110.358412366638;6112.816615501453;6115.205023346936;6138.355472675394;5490;5752.913706294409;5832.533397328203;5835.453604794733;5864.677442740605;3273.2471531547876;3286.9342613147605;3295.670432956685;3301.3397320535987;3304.067120734397;6150.261968563712;6300.369963003663;6300.369963003663;6355.3644635536075;6374.426301632875;6244.656543890039;6257.904866648319;6264.5301602379095;6285.685715714196;6300.708354787258;6100.816975490831;6275.968620156961;6327.968360158262;6394.104825324458;6400.967995160087;6161.322254551906;6163.582376053443;6205.069239613914;6228.937710622836;6242.219722534684;6074.42292982166;6101.420365065312;6110.388961103854;6112.266528016667;6144.600600960924;6041.335453100243;6143.447089761943;6210.254769427517;6238.469730072813;6252.373623298567;4246.341817018367;4265.9146817062865;4298.312270036904;4307.181635489247;4316.611504964569;5906.704664766658;6171.47542458896;6235.158253635701;6237.812865613857;6242.563020588696;6085.421884920926;6095.725692343944;6116.816495505142;6130.203073600582;6154.692265386802;5995.2206213192;6057.697115144137;6060.181875446935;6089.325435505271;6124.510039196764;5595.153599312299;5750.539956803362;5915.290165180206;5922.230110085834;5938.643681378958;6058.151858739692;6067.544934130046;6073.180120683651;6112.402229052724;6125.571210015256;5659.26429564154;5955.201055503906;5966.731497082555;5974.6713930732485;5975.820725378246 22:50:36 INFO - PROCESS | 23287 | |5;yui.html;758.4880205861045;831.9542425166613;852.9445586036907;859.9828003439935;887.7558671365374;14984.400623975042;15721.292541835617;15848.68302633948;16248.918755406236;16352.509424717247;16093.195340233;16180.27188776505;16276.593085172877;16307.59231019225;16308.918455407736;670.9463242940553;798.5448294472153;799.0531220503692;800.8598495263335;824.7814329202766;817.1256755271861;819.983600327993;820.3888103362973;821.5481485183126;821.9219174178444;856.3235044314983;859.0936561927165;860.2086080805674;860.2257967828941;865.5931712095337;855.9914400855974;856.5374697663254;858.5878778186443;858.9570521473963;860.7116615933638;622.6762083716487;625.1591609285504;626.7743612299569;626.7837596029362;629.6159342800888;16033.759493607606;16042.83957160425;16059.759103613454;16061.277242524115;16117.113558754263;15226;15354.385824567116;15395.769063464057;15659.451919182888;15859.682806343924;12869.613911582668;12914.54799082037;13121.606351809462;13136.211827290394;13230.867691323156;3908.55051669056;3960.920781584352;3964.8742692540095;4087.2234275487563;4096.836126554964;82650.44941367858;83406.58296708477;84188.57905710493;84417.57791211066;84701;11818.527258909719;11828.88171118295;11937.104717146249;12111.212771170021;12158.209716368408;21315.25396611111;21443.57112857734;21459.356219313446;21462.892685536473;21576.78423215748;8327.375446841512;8353.20644538768;8692.521911294813;8746.825063498694;8790.736277911672;4922.1140194765285;4970.975145124251;4974.427940786856;5119.718415487184;5168.793248270103;3554.8578056877955;3637.3634613942454;3680.0983758979223;3687.1335236219466;3704.351738445815;633.9904901426482;640.2061443809736;651.4007113455632;656.0552803962279;669.8961660942562;691.7751730687446;707.6943040091024;714.731975509184;720.1753991679602;722.5953466059024;9672.468014259142;10248.282620216662;10261.589536418609;10325;10440.738981525523;631.5137344244906;684.2439104789236;744.2706147975015;756.8297133144998;780.867252567065;4906.386701662293;4984.551390374883;5022.347094877642;5023.120953833138;5027.296178535008;118177;120170;121507;121596.39201803935;122951;102624;107143.46428267809;107976;108251.45874270578;108400;75009.24990750132;87618.80952976226;88693;89123;89260.5536972311;9108.726738197865;9266.44401335922;9424.905750942402;9429.717108486757;9446.433214007182;52789.208161876835;53304.4669553315;53606.463935360145;54152.45847541474;55839.720801395735;46712.76643616896;56945.43054569401;75951;77578.61210693911;77740;12361.505539778309;12555.93722031384;12556.497740090294;12567.43446544926;12665.240085594894;13350.666233344244;13519.864801352254;13916.930415347859;14007.299635018004;14773.556793296219;12716.872831271568;13138.343082846011;13212.867871321163;13314.134581252187;13361.599152025456;13365.66585835362;13438.529651462151;13438.596842094752;13463.259520726455;13572.321383930961;12662.113652044636;12896.696449389907;13185.868141318848;13269.601911942656;13520.864791352355;10513.474326283807;10767.784644307227;10903.618373356894;11027.83458248111;11063.612773552886;10791.489191513037;11138.611410864416;11188.657471011797;11369.147313951653;11408.885911140782 22:50:36 INFO - PROCESS | 23287 | __end_tp_report 22:50:36 INFO - PROCESS | 23287 | __start_cc_report 22:50:36 INFO - PROCESS | 23287 | _x_x_mozilla_cycle_collect,364 22:50:36 INFO - PROCESS | 23287 | __end_cc_report 22:50:36 INFO - PROCESS | 23287 | __startTimestamp1468475436037__endTimestamp 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | ------- Summary: start ------- 22:50:36 INFO - PROCESS | 23287 | Number of tests: 6 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#0] dojo.html Cycles:165 Average:5373.98 Median:5652.41 stddev:733.98 (13.0%) stddev-sans-first:713.24 22:50:36 INFO - PROCESS | 23287 | Values: 3050.6 3082.1 3094.5 3097.2 3113.3 5427.2 5451.5 5466.8 5554.9 5579.3 5353.5 5377.0 5412.3 5422.5 5434.3 4874.0 4879.5 4991.0 5018.4 5068.7 719.5 4785.4 4801.0 4882.5 4979.8 4790.8 4878.6 4885.0 4896.7 4910.6 4903.0 4908.0 4908.9 4919.5 4970.0 4847.0 4879.5 4882.5 4910.9 4961.1 5364.7 5398.4 5430.3 5441.9 5445.4 5582.6 5761.7 5774.1 5820.3 5825.3 5849.5 5911.4 5913.6 5952.5 5973.5 5551.4 5561.9 5566.8 5571.9 5589.6 5766.7 5805.1 5940.2 5983.0 6004.0 5611.0 5654.0 5654.2 5661.9 5672.9 5796.4 5797.4 5799.7 5804.7 5810.2 5734.1 5744.6 5782.8 5794.6 5796.1 5791.3 5795.0 5798.5 5835.2 5864.4 4387.5 4412.1 4414.9 4419.4 4450.1 3876.2 3887.6 3911.0 3928.4 3948.1 5400.1 5497.4 5546.4 5547.4 5592.6 5859.8 5862.5 5870.6 5871.0 5873.4 5379.8 5407.1 5436.8 5442.7 5443.3 4833.9 4840.4 4855.8 4963.9 4995.3 6086.4 6087.5 6090.3 6091.2 6137.9 5861.1 5906.0 5909.9 5910.9 5916.9 5887.4 5905.1 5943.6 5959.6 6088.8 5770.9 5783.0 5787.6 5788.8 5794.4 5788.4 5799.4 5854.1 5857.9 5867.4 5652.4 5673.1 5687.3 5710.9 5771.0 5702.3 5723.6 5726.8 5746.4 5757.8 5523.2 5630.4 5640.2 5642.7 5644.9 5687.7 5714.9 5730.2 5826.2 5840.3 5649.6 5655.6 5656.9 5662.9 5664.4 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#1] ext.html Cycles:180 Average:56369.43 Median:37808.62 stddev:112145.94 (296.6%) stddev-sans-first:112382.37 22:50:36 INFO - PROCESS | 23287 | Values: 599.2 601.3 610.4 620.1 654.6 37246.3 37942.0 41159.6 41175.4 41215.6 41823.0 42160.6 42372.8 42538.6 42640.8 8575.4 8722.5 8757.5 8770.4 8784.4 8660.1 8778.9 8781.3 8800.8 8802.5 8692.6 8759.2 8770.9 8801.7 8808.7 8747.8 8749.8 8781.6 8800.5 8810.6 8554.5 8665.6 8701.6 8701.6 8720.0 29502.0 29722.0 29855.3 29863.6 29874.3 2637.3 3198.0 3414.5 3471.5 3531.9 31750.7 32085.7 32175.7 32593.7 33016.2 4320.7 4333.5 4357.9 4358.5 4407.9 315210.0 317249.0 317927.0 318078.0 318181.0 34915.3 35336.6 35453.3 35496.0 35502.9 36599.6 36657.6 37083.8 37225.0 38663.2 17440.1 17593.5 17636.8 17674.9 17681.8 13459.9 13514.9 13590.9 13597.5 13608.2 19918.8 20026.4 20106.3 20110.0 20161.9 7038.8 7055.6 7168.1 7170.7 7271.0 982.9 1055.6 1106.2 1122.9 1123.1 33747.3 33786.0 33816.7 33935.3 34291.3 1107.4 1113.5 1115.4 1125.9 1226.1 16676.7 17600.7 17636.7 17924.6 17981.3 555608.0 559448.0 560504.0 560561.0 560912.0 58598.1 59623.4 60072.4 60078.0 60247.0 1345.7 1374.4 1382.8 1398.5 1399.1 31234.1 32883.0 32993.7 33271.7 33567.0 52045.7 52235.7 52578.7 52758.7 52783.5 343322.0 347543.0 348647.3 350806.0 352340.0 28184.9 28646.6 28674.3 28674.4 28728.9 50098.5 50863.0 51043.0 51111.0 51313.5 41709.6 42693.6 42826.0 42975.4 43402.8 41855.8 42626.4 42667.8 42780.8 44630.0 41465.0 43074.0 43152.8 45400.3 45760.3 37396.8 37675.2 38977.8 39495.0 39747.0 28554.9 29163.6 29450.0 29870.7 30033.2 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#2] jquery.html Cycles:180 Average:29757.28 Median:2825.34 stddev:82211.34 (2909.8%) stddev-sans-first:82412.37 22:50:36 INFO - PROCESS | 23287 | Values: 380.2 384.9 392.8 398.8 402.0 18858.0 20391.2 20441.4 20837.9 21249.9 19872.7 20333.1 20651.2 20770.6 20829.0 5713.9 5932.1 5985.1 5991.5 5996.1 5780.9 5837.6 5860.4 5919.7 5924.0 5749.2 5851.3 5870.6 5908.5 5922.6 5780.9 5786.8 5846.5 5853.1 5856.6 5164.4 5177.9 5186.8 5192.4 5193.6 17108.5 24301.8 24650.0 24731.8 24774.8 2590.4 2723.8 2926.9 3201.1 3234.1 14917.4 15318.5 15404.8 15474.8 15639.3 1869.9 1894.6 1974.6 1977.6 2004.1 82840.6 85517.0 85549.6 86218.0 87848.0 9828.3 9986.1 10408.1 10533.7 10684.2 13916.5 13944.5 14053.2 14071.6 14097.4 8306.3 8325.6 8329.4 8421.0 8489.9 8416.7 8442.3 8473.6 8631.6 8762.2 6434.9 6618.0 6644.6 6794.5 6829.2 1784.4 1819.2 1819.9 1847.9 1870.1 969.6 980.2 1026.4 1032.1 1036.5 20681.2 21057.6 21137.5 21283.8 21425.9 948.1 1020.8 1024.7 1068.0 1100.4 11364.6 11914.1 12032.3 12074.0 12138.3 493321.0 494882.0 497476.0 503704.0 506487.0 79080.0 82744.6 83578.0 86476.0 86788.6 1006.9 1040.6 1046.4 1063.8 1078.6 16806.6 18224.5 19031.8 19033.9 19045.4 44897.3 45313.3 45340.8 45510.8 45899.0 64042.4 64071.0 64562.0 65411.0 65568.0 8305.0 8727.0 8888.7 8943.0 8970.4 9360.4 12908.7 12975.9 13079.8 13133.3 11103.6 11152.7 11164.4 11240.9 11309.8 10914.6 11051.2 11339.0 11381.1 11587.4 11037.9 11368.1 11382.7 11421.9 11615.9 7286.7 8565.0 8728.9 8853.3 8962.7 10016.6 11636.3 12343.2 12473.4 12481.1 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#3] mootools.html Cycles:180 Average:6024.91 Median:471.46 stddev:3439.43 (729.5%) stddev-sans-first:3432.09 22:50:36 INFO - PROCESS | 23287 | Values: 1475.8 1510.8 1650.3 1793.9 1804.3 8050.9 8759.3 8896.0 9292.5 9363.0 8865.5 9155.7 9190.9 9197.4 9226.8 2371.8 2414.7 2428.4 2433.2 2437.4 2363.5 2377.0 2379.2 2402.6 2409.8 2380.2 2380.6 2381.2 2408.6 2409.0 2324.2 2332.5 2332.8 2339.2 2350.9 2315.8 2319.9 2338.8 2341.7 2359.1 9240.7 9268.0 9356.6 9357.9 9363.0 5337.7 5448.4 5451.5 5483.9 5498.3 3475.7 3542.7 3564.5 3578.1 3581.5 1143.2 1145.9 1148.7 1151.6 1158.0 13030.2 13062.5 13102.5 13111.1 13138.3 4747.2 4754.3 4810.6 4862.7 4907.7 10938.3 10943.8 10962.7 10984.9 11024.3 5453.9 5475.8 5483.6 5490.8 5499.5 4546.9 4995.1 5061.0 5116.4 5167.7 4132.2 4132.5 4246.0 4249.7 4274.9 1327.2 1337.2 1348.6 1357.6 1363.8 918.9 990.3 1022.4 1023.2 1043.9 6281.7 6386.2 6390.8 6416.2 6451.3 462.4 471.2 471.7 472.3 479.4 4177.7 4315.2 4373.8 4376.2 4415.0 10755.8 11157.3 11253.8 11258.8 11264.5 10724.2 11010.6 11051.5 11078.8 11183.9 8235.6 8246.7 8281.9 8365.9 8404.6 6327.5 6343.9 6378.3 6413.6 6421.1 10066.5 10170.7 10286.7 10341.1 10371.4 10459.6 10490.1 10530.7 10541.4 10549.4 7358.3 7839.4 7937.4 7987.4 8079.7 8843.2 8890.1 8933.4 8955.5 8961.1 7916.6 8067.6 8116.5 8243.6 8248.8 7820.3 7909.7 8047.7 8101.0 8195.1 7347.7 7363.8 7410.3 7451.8 7453.3 5300.8 5374.9 5393.5 5518.4 5537.2 5426.2 5452.0 5569.4 5588.2 5635.2 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#4] prototype.html Cycles:180 Average:5002.61 Median:5780.13 stddev:1503.09 (26.0%) stddev-sans-first:1465.53 22:50:36 INFO - PROCESS | 23287 | Values: 313.9 314.9 315.3 318.5 322.2 5704.6 5778.4 5781.9 5798.6 5831.2 5601.9 5623.5 5625.4 5654.7 5670.2 4157.2 4226.2 4337.6 4349.3 4355.1 4328.4 4363.9 4373.8 4375.0 4385.9 4338.7 4353.4 4360.5 4376.0 4377.6 4258.0 4267.7 4308.5 4314.4 4331.2 3778.7 3782.6 3798.3 3802.3 3824.0 5433.7 5480.9 5495.1 5512.2 5519.6 4868.2 4996.8 5017.3 5021.4 5024.9 5830.5 5904.4 5919.7 5921.5 5937.2 4197.7 4204.2 4208.6 4208.7 4214.1 5924.2 6029.5 6050.9 6054.5 6118.7 4270.9 4278.7 4282.1 4283.6 4293.3 4338.4 4345.4 4347.5 4350.4 4366.4 4700.0 4926.0 4927.3 4949.4 5011.1 5935.6 5972.5 5984.6 5998.9 6020.6 1483.1 1487.7 1492.5 1499.8 1511.8 912.7 937.5 951.8 969.4 984.4 5663.1 5680.1 5706.9 5752.5 5800.2 6073.8 6110.4 6112.8 6115.2 6138.4 5490.0 5752.9 5832.5 5835.5 5864.7 3273.2 3286.9 3295.7 3301.3 3304.1 6150.3 6300.4 6300.4 6355.4 6374.4 6244.7 6257.9 6264.5 6285.7 6300.7 6100.8 6276.0 6328.0 6394.1 6401.0 6161.3 6163.6 6205.1 6228.9 6242.2 6074.4 6101.4 6110.4 6112.3 6144.6 6041.3 6143.4 6210.3 6238.5 6252.4 4246.3 4265.9 4298.3 4307.2 4316.6 5906.7 6171.5 6235.2 6237.8 6242.6 6085.4 6095.7 6116.8 6130.2 6154.7 5995.2 6057.7 6060.2 6089.3 6124.5 5595.2 5750.5 5915.3 5922.2 5938.6 6058.2 6067.5 6073.2 6112.4 6125.6 5659.3 5955.2 5966.7 5974.7 5975.8 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - PROCESS | 23287 | [#5] yui.html Cycles:180 Average:21373.67 Median:3962.90 stddev:31207.31 (787.5%) stddev-sans-first:31256.46 22:50:36 INFO - PROCESS | 23287 | Values: 758.5 832.0 852.9 860.0 887.8 14984.4 15721.3 15848.7 16248.9 16352.5 16093.2 16180.3 16276.6 16307.6 16308.9 670.9 798.5 799.1 800.9 824.8 817.1 820.0 820.4 821.5 821.9 856.3 859.1 860.2 860.2 865.6 856.0 856.5 858.6 859.0 860.7 622.7 625.2 626.8 626.8 629.6 16033.8 16042.8 16059.8 16061.3 16117.1 15226.0 15354.4 15395.8 15659.5 15859.7 12869.6 12914.5 13121.6 13136.2 13230.9 3908.6 3960.9 3964.9 4087.2 4096.8 82650.4 83406.6 84188.6 84417.6 84701.0 11818.5 11828.9 11937.1 12111.2 12158.2 21315.3 21443.6 21459.4 21462.9 21576.8 8327.4 8353.2 8692.5 8746.8 8790.7 4922.1 4971.0 4974.4 5119.7 5168.8 3554.9 3637.4 3680.1 3687.1 3704.4 634.0 640.2 651.4 656.1 669.9 691.8 707.7 714.7 720.2 722.6 9672.5 10248.3 10261.6 10325.0 10440.7 631.5 684.2 744.3 756.8 780.9 4906.4 4984.6 5022.3 5023.1 5027.3 118177.0 120170.0 121507.0 121596.4 122951.0 102624.0 107143.5 107976.0 108251.5 108400.0 75009.2 87618.8 88693.0 89123.0 89260.6 9108.7 9266.4 9424.9 9429.7 9446.4 52789.2 53304.5 53606.5 54152.5 55839.7 46712.8 56945.4 75951.0 77578.6 77740.0 12361.5 12555.9 12556.5 12567.4 12665.2 13350.7 13519.9 13916.9 14007.3 14773.6 12716.9 13138.3 13212.9 13314.1 13361.6 13365.7 13438.5 13438.6 13463.3 13572.3 12662.1 12896.7 13185.9 13269.6 13520.9 10513.5 10767.8 10903.6 11027.8 11063.6 10791.5 11138.6 11188.7 11369.1 11408.9 22:50:36 INFO - PROCESS | 23287 | -------- Summary: end -------- 22:50:36 INFO - PROCESS | 23287 | 22:50:36 INFO - TEST-INFO | 23287: exit 0 22:50:36 INFO - TEST-OK | dromaeo_css | took 1110562ms 22:50:36 INFO - TEST-START | kraken 22:50:36 INFO - operating with platform_type : linux_ 22:50:36 INFO - Initialising browser for kraken test... 22:50:36 INFO - TEST-INFO | started process 23535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMxbumq/profile http://localhost:59600/getInfo.html) 22:50:41 INFO - PROCESS | 23535 | __metrics Screen width/height:1600/1200 22:50:41 INFO - PROCESS | 23535 | colorDepth:24 22:50:41 INFO - PROCESS | 23535 | Browser inner width/height: 1024/697 22:50:41 INFO - PROCESS | 23535 | __metrics 22:50:42 ERROR - PROCESS | 23535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 22:50:43 INFO - TEST-INFO | 23535: exit 0 22:50:43 INFO - Browser initialized. 22:50:43 INFO - Running cycle 1/1 for kraken test... 22:50:43 INFO - TEST-INFO | started process 23657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMxbumq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:50:54 INFO - PROCESS | 23657 | RSS: Main: 167591936 22:50:54 INFO - PROCESS | 23657 | 22:50:57 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-beat-detection) 22:50:58 INFO - PROCESS | 23657 | RSS: Main: 172941312 22:50:58 INFO - PROCESS | 23657 | 22:51:00 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-dft) 22:51:01 INFO - PROCESS | 23657 | RSS: Main: 172347392 22:51:01 INFO - PROCESS | 23657 | 22:51:04 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-fft) 22:51:05 INFO - PROCESS | 23657 | RSS: Main: 167219200 22:51:05 INFO - PROCESS | 23657 | 22:51:07 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-oscillator) 22:51:07 INFO - PROCESS | 23657 | RSS: Main: 168452096 22:51:07 INFO - PROCESS | 23657 | 22:51:09 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:51:10 INFO - PROCESS | 23657 | RSS: Main: 169000960 22:51:10 INFO - PROCESS | 23657 | 22:51:13 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-darkroom) 22:51:14 INFO - PROCESS | 23657 | RSS: Main: 168235008 22:51:14 INFO - PROCESS | 23657 | 22:51:17 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-desaturate) 22:51:18 INFO - PROCESS | 23657 | RSS: Main: 169476096 22:51:18 INFO - PROCESS | 23657 | 22:51:21 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59600/tests/kraken/driver.html?testName=json-parse-financial) 22:51:21 INFO - PROCESS | 23657 | RSS: Main: 169185280 22:51:21 INFO - PROCESS | 23657 | 22:51:23 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:51:24 INFO - PROCESS | 23657 | RSS: Main: 169009152 22:51:24 INFO - PROCESS | 23657 | 22:51:25 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:51:26 INFO - PROCESS | 23657 | RSS: Main: 169787392 22:51:26 INFO - PROCESS | 23657 | 22:51:28 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:51:29 INFO - PROCESS | 23657 | RSS: Main: 169930752 22:51:29 INFO - PROCESS | 23657 | 22:51:31 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:51:32 INFO - PROCESS | 23657 | RSS: Main: 170389504 22:51:32 INFO - PROCESS | 23657 | 22:51:35 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:51:35 INFO - PROCESS | 23657 | RSS: Main: 169865216 22:51:35 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59600/tests/kraken/driver.html?testName=ai-astar) 22:51:37 INFO - PROCESS | 23657 | RSS: Main: 170831872 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | __start_tp_report 22:51:37 INFO - PROCESS | 23657 | _x_x_mozilla_page_load 22:51:37 INFO - PROCESS | 23657 | _x_x_mozilla_page_load_details 22:51:37 INFO - PROCESS | 23657 | |i|pagename|runs| 22:51:37 INFO - PROCESS | 23657 | |0;ai-astar;104;112;105;111;112;112;113;112;112;112 22:51:37 INFO - PROCESS | 23657 | |1;audio-beat-detection;143;121;146;179;126;153;142;123;181;116 22:51:37 INFO - PROCESS | 23657 | |2;audio-dft;163;164;162;170;163;164;177;163;162;164 22:51:37 INFO - PROCESS | 23657 | |3;audio-fft;76;76;74;166;76;74;75;75;161;77 22:51:37 INFO - PROCESS | 23657 | |4;audio-oscillator;84;85;154;85;84;83;151;84;84;140 22:51:37 INFO - PROCESS | 23657 | |5;imaging-gaussian-blur;118;118;117;117;119;117;117;117;118;117 22:51:37 INFO - PROCESS | 23657 | |6;imaging-darkroom;147;146;148;147;149;147;146;147;147;146 22:51:37 INFO - PROCESS | 23657 | |7;imaging-desaturate;95;95;96;100;97;96;96;96;96;96 22:51:37 INFO - PROCESS | 23657 | |8;json-parse-financial;53;55;53;54;53;54;54;57;54;53 22:51:37 INFO - PROCESS | 23657 | |9;json-stringify-tinderbox;63;63;62;63;64;62;62;63;63;63 22:51:37 INFO - PROCESS | 23657 | |10;stanford-crypto-aes;77;86;78;80;75;75;80;87;81;75 22:51:37 INFO - PROCESS | 23657 | |11;stanford-crypto-ccm;121;125;134;143;122;129;122;127;165;128 22:51:37 INFO - PROCESS | 23657 | |12;stanford-crypto-pbkdf2;157;158;158;159;158;167;157;155;154;158 22:51:37 INFO - PROCESS | 23657 | |13;stanford-crypto-sha256-iterative;64;64;67;63;64;63;69;66;62;62 22:51:37 INFO - PROCESS | 23657 | __end_tp_report 22:51:37 INFO - PROCESS | 23657 | __start_cc_report 22:51:37 INFO - PROCESS | 23657 | _x_x_mozilla_cycle_collect,909 22:51:37 INFO - PROCESS | 23657 | __end_cc_report 22:51:37 INFO - PROCESS | 23657 | __startTimestamp1468475497665__endTimestamp 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | ------- Summary: start ------- 22:51:37 INFO - PROCESS | 23657 | Number of tests: 14 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.21 (2.9%) stddev-sans-first:2.39 22:51:37 INFO - PROCESS | 23657 | Values: 104.0 112.0 105.0 111.0 112.0 112.0 113.0 112.0 112.0 112.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:144.50 stddev:22.98 (15.9%) stddev-sans-first:24.37 22:51:37 INFO - PROCESS | 23657 | Values: 143.0 121.0 146.0 179.0 126.0 153.0 142.0 123.0 181.0 116.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:4.73 (2.9%) stddev-sans-first:4.95 22:51:37 INFO - PROCESS | 23657 | Values: 163.0 164.0 162.0 170.0 163.0 164.0 177.0 163.0 162.0 164.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:37.19 (49.3%) stddev-sans-first:38.93 22:51:37 INFO - PROCESS | 23657 | Values: 76.0 76.0 74.0 166.0 76.0 74.0 75.0 75.0 161.0 77.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.00 stddev:31.21 (37.2%) stddev-sans-first:32.30 22:51:37 INFO - PROCESS | 23657 | Values: 84.0 85.0 154.0 85.0 84.0 83.0 151.0 84.0 84.0 140.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 22:51:37 INFO - PROCESS | 23657 | Values: 118.0 118.0 117.0 117.0 119.0 117.0 117.0 117.0 118.0 117.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 22:51:37 INFO - PROCESS | 23657 | Values: 147.0 146.0 148.0 147.0 149.0 147.0 146.0 147.0 147.0 146.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 22:51:37 INFO - PROCESS | 23657 | Values: 95.0 95.0 96.0 100.0 97.0 96.0 96.0 96.0 96.0 96.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.25 (2.3%) stddev-sans-first:1.27 22:51:37 INFO - PROCESS | 23657 | Values: 53.0 55.0 53.0 54.0 53.0 54.0 54.0 57.0 54.0 53.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 22:51:37 INFO - PROCESS | 23657 | Values: 63.0 63.0 62.0 63.0 64.0 62.0 62.0 63.0 63.0 63.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:4.35 (5.4%) stddev-sans-first:4.53 22:51:37 INFO - PROCESS | 23657 | Values: 77.0 86.0 78.0 80.0 75.0 75.0 80.0 87.0 81.0 75.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:128.50 stddev:13.47 (10.5%) stddev-sans-first:13.73 22:51:37 INFO - PROCESS | 23657 | Values: 121.0 125.0 134.0 143.0 122.0 129.0 122.0 127.0 165.0 128.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:3.48 (2.2%) stddev-sans-first:3.67 22:51:37 INFO - PROCESS | 23657 | Values: 157.0 158.0 158.0 159.0 158.0 167.0 157.0 155.0 154.0 158.0 22:51:37 INFO - PROCESS | 23657 | 22:51:37 INFO - PROCESS | 23657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.27 (3.5%) stddev-sans-first:2.40 22:51:37 INFO - PROCESS | 23657 | Values: 64.0 64.0 67.0 63.0 64.0 63.0 69.0 66.0 62.0 62.0 22:51:37 INFO - PROCESS | 23657 | -------- Summary: end -------- 22:51:37 INFO - PROCESS | 23657 | 22:51:38 INFO - TEST-INFO | 23657: exit 0 22:51:38 INFO - TEST-OK | kraken | took 61832ms 22:51:38 INFO - SUITE-END | took 1172s 22:51:38 INFO - Completed test suite (00:19:32) 22:51:38 INFO - javascript benchmark 22:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7396.659188804861, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3050.557669137975, 3082.1215953453257, 3094.45846976779, 3097.194729370363, 3113.2528193233616, 5427.240186373911, 5451.482109199625, 5466.835994920149, 5554.91667624986, 5579.330480342354, 5353.544948679367, 5376.973115134429, 5412.323459567554, 5422.511973922346, 5434.347878254615, 4873.951260487403, 4879.536444037811, 4990.9768497457935, 5018.397792264934, 5068.695878247298, 719.5478728059686, 4785.377900872882, 4800.951990480103, 4882.511748825124, 4979.8008079676765, 4790.80836766529, 4878.560929516325, 4885.022995400934, 4896.706197628154, 4910.582600478963, 4902.975485122587, 4907.950920490785, 4908.877278068041, 4919.532644398776, 4969.950300496985, 4846.9579040506105, 4879.487653796371, 4882.487338829407, 4910.852674419773, 4961.107000739866, 5364.704941228231, 5398.406175320712, 5430.266913966603, 5441.945580544183, 5445.428230035829, 5582.609217354787, 5761.654300741927, 5774.076147816371, 5820.30156381237, 5825.271841019872, 5849.502792262663, 5911.379305172981, 5913.645181289094, 5952.4642782149385, 5973.492253158487, 5551.444855514456, 5561.916571251434, 5566.83096549721, 5571.944280557183, 5589.608727389084, 5766.682832444256, 5805.071188609802, 5940.168376427304, 5983.04271316596, 6004.039353703386, 5610.97194514033, 5654.038813401731, 5654.180143879114, 5661.915071273934, 5672.914906276409, 5796.449337313033, 5797.449242321973, 5799.681017544076, 5804.738786754606, 5810.244668193192, 5734.111212762028, 5744.626599271034, 5782.768689252467, 5794.594378393472, 5796.072628379439, 5791.3339965903615, 5795.043817770105, 5798.478136967693, 5835.241418615553, 5864.44287792659, 4387.517373088957, 4412.139632771643, 4414.867553973386, 4419.447569053868, 4450.132224216247, 3876.1666241757594, 3887.5723670396233, 3911.002694312932, 3928.4303775952326, 3948.1116748731306, 5400.108982018001, 5497.422770609109, 5546.4453554644215, 5547.389787123413, 5592.608517403743, 5859.824205273849, 5862.472377486047, 5870.589058765845, 5871.031279838779, 5873.353931067579, 5379.78480860769, 5407.134858422633, 5436.755346009439, 5442.727863606804, 5443.265159203457, 4833.927491087637, 4840.370751802243, 4855.781489832966, 4963.90072198554, 4995.325631039763, 6086.430886010694, 6087.512325156257, 6090.318742874174, 6091.2397546061475, 6137.938620613826, 5861.0915308127305, 5906.025505791582, 5909.906667266398, 5910.911336330045, 5916.934951708734, 5887.352391236875, 5905.143754155538, 5943.64338139713, 5959.642421454727, 6088.756449741961, 5770.855728606818, 5783.045797443375, 5787.565932554991, 5788.768449262151, 5794.391588883106, 5788.421157884346, 5799.362070172362, 5854.092615644582, 5857.8535536610225, 5867.383924687846, 5652.406497317723, 5673.120666296731, 5687.3459552152035, 5710.885782284414, 5771.0, 5702.287214098238, 5723.627964182315, 5726.770929162787, 5746.42535746422, 5757.769689212385, 5523.171524271392, 5630.4369563043365, 5640.238567793295, 5642.689652069175, 5644.85887852807, 5687.687177205128, 5714.942850571608, 5730.226419433323, 5826.242588463472, 5840.2991641003355, 5649.6327738696855, 5655.632383895034, 5656.85857853557, 5662.915056274077, 5664.405237450009], "value": 5323.734524629252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.206051981125, 601.2604496469343, 610.3682688417489, 620.1349117980418, 654.5614438326321, 37246.25507489849, 37942.0, 41159.58840411595, 41175.38236926449, 41215.58784412155, 41823.0, 42160.57839421605, 42372.78813605928, 42538.57461425385, 42640.78679606598, 8575.356848236375, 8722.476651400937, 8757.51833649149, 8770.429922055078, 8784.429012114193, 8660.133986601353, 8778.868316975251, 8781.34139939504, 8800.779980500474, 8802.51586162764, 8692.56537173142, 8759.211670949613, 8770.868436973418, 8801.735947921572, 8808.691695790649, 8747.78130546735, 8749.7812554686, 8781.56092195391, 8800.515971621558, 8810.559472026373, 8554.486730796172, 8665.566721663954, 8701.608427620773, 8701.608427620773, 8720.0, 29502.0, 29722.0, 29855.25361865949, 29863.552046719316, 29874.253143671365, 2637.274749443899, 3197.9680203197904, 3414.5048967899766, 3471.5486986691567, 3531.94702079469, 31750.682493175005, 32085.6791432085, 32175.678243217502, 32593.67406325954, 33016.174595635064, 4320.725386011134, 4333.544977777351, 4357.932306584876, 4358.542353052915, 4407.9416798479115, 315210.0, 317249.0, 317927.0, 318078.0, 318181.0, 34915.30169396649, 35336.64663353334, 35453.290934181176, 35496.0, 35502.91716452641, 36599.634003660154, 36657.63342366595, 37083.814580926926, 37225.0, 38663.226735465134, 17440.12799360027, 17593.47219583389, 17636.823631763516, 17674.91162544179, 17681.823181768275, 13459.865401346056, 13514.932425338007, 13590.864091359157, 13597.456101756017, 13608.183508989492, 19918.800811991696, 20026.3965684463, 20106.296279630144, 20110.0, 20161.899190503955, 7038.8264625500215, 7055.576665400093, 7168.139823221247, 7170.749023784247, 7271.0, 982.9066238707311, 1055.6410820320973, 1106.2090605217309, 1122.8820973797797, 1123.084685980923, 33747.32505349879, 33786.0, 33816.66183338135, 33935.32129357399, 34291.31417371638, 1107.363266121983, 1113.5156207049959, 1115.3809635652128, 1125.8536390269376, 1226.1233218248994, 16676.74984875228, 17600.735988960176, 17636.735448968277, 17924.641507169785, 17981.280748769903, 555608.0, 559448.0, 560504.0, 560561.0, 560912.0, 58598.121028184614, 59623.40376596178, 60072.39927600668, 60078.0, 60247.0, 1345.7039451320693, 1374.415873253863, 1382.8064071029862, 1398.531491950208, 1399.1115641567678, 31234.062978110695, 32883.0, 32993.67006329906, 33271.66728332686, 33566.99299021033, 52045.7397713009, 52235.73882130565, 52578.73710631422, 52758.736206318725, 52783.47216527785, 343322.0, 347543.0, 348647.25676371454, 350806.0, 352340.0, 28184.85907570449, 28646.57030144591, 28674.283142921595, 28674.426511469235, 28728.856355718923, 50098.49901500938, 50863.0, 51043.0, 51111.0, 51313.48686513087, 41709.58290417178, 42693.573064270204, 42826.0, 42975.355369668854, 43402.782986084865, 41855.7907210462, 42626.360604590336, 42667.78666106774, 42780.78609606932, 44630.0, 41465.0, 43074.0, 43152.784236078616, 45400.318995215755, 45760.313595296764, 37396.81301593475, 37675.2464950694, 38977.80511097427, 39495.0, 39747.0, 28554.85780568754, 29163.562546561396, 29450.0, 29870.701292986792, 30033.249168770082], "value": 19502.007324010738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.20737681727707, 384.8595262729104, 392.82126632382267, 398.7926278335266, 402.0307961487612, 18858.0, 20391.184352625896, 20441.386758397235, 20837.895810520928, 21249.893750531264, 19872.70190947137, 20333.085011174495, 20651.17395304186, 20770.584588308226, 20829.0, 5713.857153571163, 5932.110183472492, 5985.072313791369, 5991.490723288504, 5996.130561068642, 5780.942190578104, 5837.562182836283, 5860.413958604148, 5919.704014799265, 5924.022536281508, 5749.223854779593, 5851.268591426072, 5870.618409803349, 5908.468237858592, 5922.58541902067, 5780.942190578083, 5786.82639520813, 5846.50304724099, 5853.122031695238, 5856.560757943172, 5164.380274367062, 5177.948220517822, 5186.844394668128, 5192.350956130484, 5193.610479214036, 17108.48674539766, 24301.756982430124, 24650.0, 24731.752682473125, 24774.752252477425, 2590.352411897026, 2723.8229515081457, 2926.853657317147, 3201.103690966533, 3234.110619579611, 14917.403303867832, 15318.540443786704, 15404.845951540565, 15474.767878481833, 15639.296231669488, 1869.943901682938, 1894.602133551942, 1974.555724961872, 1977.5550501137272, 2004.1382205651564, 82840.58579707063, 85517.0, 85549.57225213897, 86218.0, 87848.0, 9828.262880283864, 9986.051325124101, 10408.115310198718, 10533.736656583647, 10684.198685098649, 13916.512922047883, 13944.511942082181, 14053.22707251111, 14071.648208794657, 14097.436102555988, 8306.335493160532, 8325.583720813935, 8329.416940814206, 8420.957895210608, 8489.872651910226, 8416.74749757496, 8442.282405995558, 8473.618687158969, 8631.568421578895, 8762.211400973943, 6434.935650643527, 6618.0, 6644.634545100066, 6794.490413219029, 6829.248782633907, 1784.3583902809187, 1819.1813683842324, 1819.9272029118688, 1847.8798878072882, 1870.0556219109262, 969.6121551379505, 980.1864452504547, 1026.3687831983277, 1032.0762917189074, 1036.4921188617523, 20681.172753089708, 21057.578848422945, 21137.471563211042, 21283.78716212849, 21425.89287053586, 948.1229862377273, 1020.8417695257247, 1024.7438140464883, 1067.9679609611724, 1100.4387762241154, 11364.602238921598, 11914.106442016884, 12032.27806331623, 12074.00778871494, 12138.271703697807, 493321.0, 494882.0, 497476.0, 503704.0, 506487.0, 79080.0, 82744.58627706823, 83578.0, 86476.0, 86788.56605717057, 1006.8873894346788, 1040.5629635553087, 1046.40877903984, 1063.7978784031009, 1078.5793540519046, 16806.57983550421, 18224.544386389916, 19031.809681903003, 19033.904830476313, 19045.44348491074, 44897.32654010258, 45313.320300194864, 45340.77329613331, 45510.77244613888, 45899.0, 64042.359576405506, 64071.0, 64562.0, 65411.0, 65568.0, 8305.0, 8727.0, 8888.73333799987, 8943.0, 8970.37207395476, 9360.4383736976, 12908.677283067998, 12975.870241297465, 13079.803802943154, 13133.34333283351, 11103.5558577656, 11152.721181970515, 11164.385958772345, 11240.943795280971, 11309.773804524028, 10914.563417463212, 11051.17116216271, 11339.0, 11381.089512839118, 11587.362695051854, 11037.944810275898, 11368.090552755924, 11382.658520244406, 11421.885781142415, 11615.883841161818, 7286.672099755418, 8565.0, 8728.912710873064, 8853.29173666118, 8962.68630597926, 10016.64941727036, 11636.301821890713, 12343.19769214998, 12473.376331183223, 12481.126321157431], "value": 9576.662603478648, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.8488379064331, 1510.7960425342578, 1650.273879493023, 1793.8833975791565, 1804.251235737169, 8050.879236811453, 8759.343049271307, 8895.955520222406, 9292.488913109777, 9362.953185234073, 8865.468071915673, 9155.725328240147, 9190.862137067948, 9197.448153110818, 9226.815463690722, 2371.7509661485556, 2414.6740190074293, 2428.405040765015, 2433.197044975154, 2437.390652336916, 2363.527294541099, 2376.976230237701, 2379.167291447988, 2402.5795485790004, 2409.8072154227707, 2380.1550449590404, 2380.571497130516, 2381.2380038387723, 2408.638704194367, 2408.9879550602222, 2324.23300310897, 2332.521833024226, 2332.7667233276707, 2339.157903154863, 2350.9412264693347, 2315.7568455312285, 2319.8724070176136, 2338.8128949683983, 2341.7424083350816, 2359.09174967637, 9240.676576319864, 9267.953660231655, 9356.578953947088, 9357.906420935771, 9362.95318523403, 5337.706426146599, 5448.400675925645, 5451.48210919962, 5483.890322193573, 5498.3127109111365, 3475.6871881530783, 3542.734294927891, 3564.500969864221, 3578.1233597768714, 3581.4627805829073, 1143.1540659911605, 1145.936973466459, 1148.7415331550417, 1151.585429245471, 1157.9594714185048, 13030.153040052366, 13062.542811001664, 13102.541411050663, 13111.14777539457, 13138.343082845915, 4747.192977193886, 4754.263089221176, 4810.574884648959, 4862.70823750569, 4907.7300748458465, 10938.289011214405, 10943.83584246237, 10962.725931851608, 10984.945075274572, 11024.283421577733, 5453.945460545344, 5475.835724928259, 5483.588730845203, 5490.752916118784, 5499.532539734168, 4546.909061818745, 4995.100881841231, 5060.974695126501, 5116.386033675983, 5167.6641018333685, 4132.16118827119, 4132.5454200037975, 4246.044639955985, 4249.723767955073, 4274.871753847389, 1327.1638867513404, 1337.2444568818587, 1348.5549768576345, 1357.6130802721375, 1363.795430685405, 918.9402688825205, 990.2721499697716, 1022.3712416863575, 1023.1610079734546, 1043.8903915088958, 6281.748730050746, 6386.201724784402, 6390.7763228286785, 6416.165898433173, 6451.258105317855, 462.4058085360296, 471.2154263151882, 471.70754132437423, 472.25855407010664, 479.41511356145446, 4177.665786737054, 4315.223259813264, 4373.825046998148, 4376.212281789245, 4414.955850441519, 10755.795062012268, 11157.330560166254, 11253.774924501464, 11258.774824503464, 11264.549418023187, 10724.249302548902, 11010.614628487965, 11051.502682379152, 11078.833817492745, 11183.888161118284, 8235.588220588947, 8246.670133194724, 8281.875771863426, 8365.874511882326, 8404.621792019374, 6327.462165715966, 6343.9365606343345, 6378.298387177314, 6413.647249401328, 6421.068945002855, 10066.540351649117, 10170.694879153638, 10286.691399258034, 10341.069303762697, 10371.429571373646, 10459.58161673555, 10490.108340791117, 10530.684079477627, 10541.420221887869, 10549.367037977747, 7358.264173582599, 7839.372850171859, 7937.365010799007, 7987.361011119213, 8079.717209897625, 8843.204111629984, 8890.06654301289, 8933.419327743675, 8955.507447090473, 8961.059088795582, 7916.643751031333, 8067.636956336862, 8116.513009219466, 8243.629036693483, 8248.752537423887, 7820.257075577811, 7909.7231596893835, 8047.718329858427, 8101.0, 8195.057568379712, 7347.742829001173, 7363.77908662741, 7410.258974102547, 7451.776446706607, 7453.291937265951, 5300.840974770763, 5374.865628359166, 5393.487618676219, 5518.365387980273, 5537.224788529689, 5426.186072089218, 5452.037266583948, 5569.387367389503, 5588.189712491747, 5635.239242702182], "value": 4735.449126485039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8822941396976, 314.86460821846606, 315.25756842635593, 318.5238069086714, 322.1736246527658, 5704.629199102061, 5778.410936992329, 5781.855453613656, 5798.6230894991795, 5831.212786273857, 5601.915971260424, 5623.465770751783, 5625.40933202014, 5654.660720356771, 5670.177824215486, 4157.210130075284, 4226.197022565718, 4337.63130133939, 4349.347248045754, 4355.128974205171, 4328.350747387885, 4363.934540981888, 4373.781310934456, 4374.971881607819, 4385.912281754363, 4338.674599405042, 4353.434053573047, 4360.470926862428, 4376.0, 4377.562243775629, 4257.956800583861, 4267.701260911737, 4308.547602501755, 4314.395984562164, 4331.155424692186, 3778.7165962552917, 3782.6217378262227, 3798.2783271178664, 3802.3345914465135, 3823.9617603823885, 5433.673979561239, 5480.945190548084, 5495.093309603911, 5512.173174023928, 5519.558435325164, 4868.17443458703, 4996.775145118479, 5017.2724954881705, 5021.372328458906, 5024.899502009939, 5830.5044071254, 5904.350521442638, 5919.733611987428, 5921.467067963904, 5937.198478205431, 4197.685173611992, 4204.159168166379, 4208.600182982612, 4208.72643278189, 4214.115035842477, 5924.2298501195, 6029.54778391618, 6050.939490605082, 6054.485368743662, 6118.7128055989315, 4270.914581708348, 4278.657707383401, 4282.143571285756, 4283.593058659422, 4293.291606884829, 4338.436003319548, 4345.391645169679, 4347.478302603708, 4350.369196466495, 4366.388705581221, 4699.953000469952, 4925.950740492621, 4927.310176575283, 4949.381327334083, 5011.123053465629, 5935.614185077956, 5972.492338151305, 5984.611000284967, 5998.850028749316, 6020.638761674313, 1483.1027228526802, 1487.7024595081027, 1492.4552538323435, 1499.7600383938518, 1511.8034655494716, 912.6668765900398, 937.5452905340904, 951.8381875081253, 969.3747532841278, 984.3700031979539, 5663.122216056518, 5680.14797780328, 5706.8871570044275, 5752.539796816244, 5800.158976948319, 6073.848153796191, 6110.358412366638, 6112.816615501453, 6115.205023346936, 6138.355472675394, 5490.0, 5752.913706294409, 5832.533397328203, 5835.453604794733, 5864.677442740605, 3273.2471531547876, 3286.9342613147605, 3295.670432956685, 3301.3397320535987, 3304.067120734397, 6150.261968563712, 6300.369963003663, 6300.369963003663, 6355.3644635536075, 6374.426301632875, 6244.656543890039, 6257.904866648319, 6264.5301602379095, 6285.685715714196, 6300.708354787258, 6100.816975490831, 6275.968620156961, 6327.968360158262, 6394.104825324458, 6400.967995160087, 6161.322254551906, 6163.582376053443, 6205.069239613914, 6228.937710622836, 6242.219722534684, 6074.42292982166, 6101.420365065312, 6110.388961103854, 6112.266528016667, 6144.600600960924, 6041.335453100243, 6143.447089761943, 6210.254769427517, 6238.469730072813, 6252.373623298567, 4246.341817018367, 4265.9146817062865, 4298.312270036904, 4307.181635489247, 4316.611504964569, 5906.704664766658, 6171.47542458896, 6235.158253635701, 6237.812865613857, 6242.563020588696, 6085.421884920926, 6095.725692343944, 6116.816495505142, 6130.203073600582, 6154.692265386802, 5995.2206213192, 6057.697115144137, 6060.181875446935, 6089.325435505271, 6124.510039196764, 5595.153599312299, 5750.539956803362, 5915.290165180206, 5922.230110085834, 5938.643681378958, 6058.151858739692, 6067.544934130046, 6073.180120683651, 6112.402229052724, 6125.571210015256, 5659.26429564154, 5955.201055503906, 5966.731497082555, 5974.6713930732485, 5975.820725378246], "value": 4507.095092067933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.4880205861045, 831.9542425166613, 852.9445586036907, 859.9828003439935, 887.7558671365374, 14984.400623975042, 15721.292541835617, 15848.68302633948, 16248.918755406236, 16352.509424717247, 16093.195340233, 16180.27188776505, 16276.593085172877, 16307.59231019225, 16308.918455407736, 670.9463242940553, 798.5448294472153, 799.0531220503692, 800.8598495263335, 824.7814329202766, 817.1256755271861, 819.983600327993, 820.3888103362973, 821.5481485183126, 821.9219174178444, 856.3235044314983, 859.0936561927165, 860.2086080805674, 860.2257967828941, 865.5931712095337, 855.9914400855974, 856.5374697663254, 858.5878778186443, 858.9570521473963, 860.7116615933638, 622.6762083716487, 625.1591609285504, 626.7743612299569, 626.7837596029362, 629.6159342800888, 16033.759493607606, 16042.83957160425, 16059.759103613454, 16061.277242524115, 16117.113558754263, 15226.0, 15354.385824567116, 15395.769063464057, 15659.451919182888, 15859.682806343924, 12869.613911582668, 12914.54799082037, 13121.606351809462, 13136.211827290394, 13230.867691323156, 3908.55051669056, 3960.920781584352, 3964.8742692540095, 4087.2234275487563, 4096.836126554964, 82650.44941367858, 83406.58296708477, 84188.57905710493, 84417.57791211066, 84701.0, 11818.527258909719, 11828.88171118295, 11937.104717146249, 12111.212771170021, 12158.209716368408, 21315.25396611111, 21443.57112857734, 21459.356219313446, 21462.892685536473, 21576.78423215748, 8327.375446841512, 8353.20644538768, 8692.521911294813, 8746.825063498694, 8790.736277911672, 4922.1140194765285, 4970.975145124251, 4974.427940786856, 5119.718415487184, 5168.793248270103, 3554.8578056877955, 3637.3634613942454, 3680.0983758979223, 3687.1335236219466, 3704.351738445815, 633.9904901426482, 640.2061443809736, 651.4007113455632, 656.0552803962279, 669.8961660942562, 691.7751730687446, 707.6943040091024, 714.731975509184, 720.1753991679602, 722.5953466059024, 9672.468014259142, 10248.282620216662, 10261.589536418609, 10325.0, 10440.738981525523, 631.5137344244906, 684.2439104789236, 744.2706147975015, 756.8297133144998, 780.867252567065, 4906.386701662293, 4984.551390374883, 5022.347094877642, 5023.120953833138, 5027.296178535008, 118177.0, 120170.0, 121507.0, 121596.39201803935, 122951.0, 102624.0, 107143.46428267809, 107976.0, 108251.45874270578, 108400.0, 75009.24990750132, 87618.80952976226, 88693.0, 89123.0, 89260.5536972311, 9108.726738197865, 9266.44401335922, 9424.905750942402, 9429.717108486757, 9446.433214007182, 52789.208161876835, 53304.4669553315, 53606.463935360145, 54152.45847541474, 55839.720801395735, 46712.76643616896, 56945.43054569401, 75951.0, 77578.61210693911, 77740.0, 12361.505539778309, 12555.93722031384, 12556.497740090294, 12567.43446544926, 12665.240085594894, 13350.666233344244, 13519.864801352254, 13916.930415347859, 14007.299635018004, 14773.556793296219, 12716.872831271568, 13138.343082846011, 13212.867871321163, 13314.134581252187, 13361.599152025456, 13365.66585835362, 13438.529651462151, 13438.596842094752, 13463.259520726455, 13572.321383930961, 12662.113652044636, 12896.696449389907, 13185.868141318848, 13269.601911942656, 13520.864791352355, 10513.474326283807, 10767.784644307227, 10903.618373356894, 11027.83458248111, 11063.612773552886, 10791.489191513037, 11138.611410864416, 11188.657471011797, 11369.147313951653, 11408.885911140782], "value": 7716.220220112756, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 105.0, 111.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 146.0, 179.0, 126.0, 153.0, 142.0, 123.0, 181.0, 116.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 170.0, 163.0, 164.0, 177.0, 163.0, 162.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 166.0, 76.0, 74.0, 75.0, 75.0, 161.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 154.0, 85.0, 84.0, 83.0, 151.0, 84.0, 84.0, 140.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 100.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 53.0, 54.0, 54.0, 57.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 78.0, 80.0, 75.0, 75.0, 80.0, 87.0, 81.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 125.0, 134.0, 143.0, 122.0, 129.0, 122.0, 127.0, 165.0, 128.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 158.0, 159.0, 158.0, 167.0, 157.0, 155.0, 154.0, 158.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 63.0, 64.0, 63.0, 69.0, 66.0, 62.0, 62.0], "value": 64.4, "unit": "score"}]}]} 22:51:38 INFO - Return code: 0 22:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:51:38 ERROR - # TBPL SUCCESS # 22:51:38 INFO - Running post-action listener: _resource_record_post_action 22:51:38 INFO - ##### 22:51:38 INFO - ##### Finished run-tests step (success) 22:51:38 INFO - ##### 22:51:38 INFO - Running post-run listener: _resource_record_post_run 22:51:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552677376; Read time: 4; Write time: 568244 22:51:39 INFO - TinderboxPrint: CPU usage
13.3% 22:51:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 22:51:39 INFO - TinderboxPrint: I/O write bytes / time
552,677,376 / 568,244 22:51:39 INFO - TinderboxPrint: CPU idle
8,231.3 (86.7%) 22:51:39 INFO - TinderboxPrint: CPU user
1,209.5 (12.7%) 22:51:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:51:39 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257097728; Read time: 0; Write time: 281028 22:51:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295350272; Read time: 0; Write time: 287188 22:51:39 INFO - Running post-run listener: _upload_blobber_files 22:51:39 INFO - Blob upload gear active. 22:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:51:39 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 22:51:39 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'] 22:51:39 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 22:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:40 INFO - (blobuploader) - INFO - Done attempting. 22:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:41 INFO - (blobuploader) - INFO - Done attempting. 22:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:45 INFO - (blobuploader) - INFO - Done attempting. 22:51:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:51:45 INFO - Return code: 0 22:51:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:51:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:51:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2cb5dc3eae9067562c9a01e1757f79dbdff3cda325946f39c3c751a790806d526a2adc260a87c3881b15c4abb21d68b62dd0f9253289d542629b133ae9f90863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94293b1d6d9e1efd5a493adf59d146c42f004e16f172a2e5fd70632e8b2da04f34cd646dad266d3e8726dce90b664bac0f804e11c0ef9953b8a398c41a0badcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c49cb3244b234bee602f889c7a761a64032adad0a8e4a3f01d5be23f89d84c45935c98ff51b63603873b7d4cc41cc48052204f9620f4bb2b492be5b1b0cc6285"} 22:51:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:51:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:51:45 INFO - Contents: 22:51:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2cb5dc3eae9067562c9a01e1757f79dbdff3cda325946f39c3c751a790806d526a2adc260a87c3881b15c4abb21d68b62dd0f9253289d542629b133ae9f90863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94293b1d6d9e1efd5a493adf59d146c42f004e16f172a2e5fd70632e8b2da04f34cd646dad266d3e8726dce90b664bac0f804e11c0ef9953b8a398c41a0badcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c49cb3244b234bee602f889c7a761a64032adad0a8e4a3f01d5be23f89d84c45935c98ff51b63603873b7d4cc41cc48052204f9620f4bb2b492be5b1b0cc6285"} 22:51:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:51:45 INFO - Copying logs to upload dir... 22:51:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:51:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.343296 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 22:51:45.169111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 22:51:45.173005) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 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/2cb5dc3eae9067562c9a01e1757f79dbdff3cda325946f39c3c751a790806d526a2adc260a87c3881b15c4abb21d68b62dd0f9253289d542629b133ae9f90863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94293b1d6d9e1efd5a493adf59d146c42f004e16f172a2e5fd70632e8b2da04f34cd646dad266d3e8726dce90b664bac0f804e11c0ef9953b8a398c41a0badcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c49cb3244b234bee602f889c7a761a64032adad0a8e4a3f01d5be23f89d84c45935c98ff51b63603873b7d4cc41cc48052204f9620f4bb2b492be5b1b0cc6285"} build_url:https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Xtlh7AloTIeqnzM4vIrBZA/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/2cb5dc3eae9067562c9a01e1757f79dbdff3cda325946f39c3c751a790806d526a2adc260a87c3881b15c4abb21d68b62dd0f9253289d542629b133ae9f90863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94293b1d6d9e1efd5a493adf59d146c42f004e16f172a2e5fd70632e8b2da04f34cd646dad266d3e8726dce90b664bac0f804e11c0ef9953b8a398c41a0badcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c49cb3244b234bee602f889c7a761a64032adad0a8e4a3f01d5be23f89d84c45935c98ff51b63603873b7d4cc41cc48052204f9620f4bb2b492be5b1b0cc6285"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 22:51:45.200903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:51:45.201286) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1468473089.503025-1545188227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:51:45.285778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 22:51:45.286124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 22:51:45.286447) ========= ========= Total master_lag: 0.23 =========