builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1468037580.85 results: success (0) buildid: 20160708183001 builduid: 71688b99c8fb4310b0cc17eb62da4297 revision: 64e752c0270c0dfebdf4004e8f7d19029807994d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:00.849007) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:00.849431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:00.849734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:00.889678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:00.889955) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 21:13:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-07-08 21:13:01 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:01.021961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:01.022267) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:01.071767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 21:13:01.072121) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 64e752c0270c0dfebdf4004e8f7d19029807994d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 64e752c0270c0dfebdf4004e8f7d19029807994d --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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 21:13:01,132 truncating revision to first 12 chars 2016-07-08 21:13:01,132 Setting DEBUG logging. 2016-07-08 21:13:01,132 attempt 1/10 2016-07-08 21:13:01,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/64e752c0270c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 21:13:01,711 unpacking tar archive at: autoland-64e752c0270c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927747 ========= master_lag: 1.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 21:13:03.041829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:03.042234) ========= script_repo_revision: 64e752c0270c0dfebdf4004e8f7d19029807994d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:03.042710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:03.042980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 21:13:03.086488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-08 21:13:03.089814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:13:03 INFO - MultiFileLogger online at 20160708 21:13:03 in /builds/slave/test 21:13:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:13:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:03 INFO - {'append_to_log': False, 21:13:03 INFO - 'base_work_dir': '/builds/slave/test', 21:13:03 INFO - 'blob_upload_branch': 'Autoland', 21:13:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:03 INFO - 'branch': 'Autoland', 21:13:03 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:03 INFO - 'config_files': ('talos/linux_config.py',), 21:13:03 INFO - 'default_actions': ('clobber', 21:13:03 INFO - 'read-buildbot-config', 21:13:03 INFO - 'download-and-extract', 21:13:03 INFO - 'populate-webroot', 21:13:03 INFO - 'create-virtualenv', 21:13:03 INFO - 'install', 21:13:03 INFO - 'run-tests'), 21:13:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:03 INFO - 'download_minidump_stackwalk': True, 21:13:03 INFO - 'download_symbols': 'ondemand', 21:13:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:03 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:03 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:03 INFO - 'installer_path': 'installer.exe', 21:13:03 INFO - 'log_level': 'info', 21:13:03 INFO - 'log_name': 'talos', 21:13:03 INFO - 'log_to_console': True, 21:13:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:13:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:13:03 INFO - 'opt_config_files': (), 21:13:03 INFO - 'pip_index': False, 21:13:03 INFO - 'sps_profile': False, 21:13:03 INFO - 'sps_profile_interval': 0, 21:13:03 INFO - 'suite': 'dromaeojs', 21:13:03 INFO - 'system_bits': '32', 21:13:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:03 INFO - 'title': 'talos-linux64-ix-036', 21:13:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:03 INFO - 'use_talos_json': True, 21:13:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:03 INFO - 'work_dir': 'build'} 21:13:03 INFO - ##### 21:13:03 INFO - ##### Running clobber step. 21:13:03 INFO - ##### 21:13:03 INFO - Running pre-action listener: _resource_record_pre_action 21:13:03 INFO - Running main action method: clobber 21:13:03 INFO - rmtree: /builds/slave/test/build 21:13:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:03 INFO - Running post-action listener: _resource_record_post_action 21:13:03 INFO - ##### 21:13:03 INFO - ##### Finished clobber step (success) 21:13:03 INFO - ##### 21:13:03 INFO - ##### 21:13:03 INFO - ##### Running read-buildbot-config step. 21:13:03 INFO - ##### 21:13:03 INFO - Running pre-action listener: _resource_record_pre_action 21:13:03 INFO - Running main action method: read_buildbot_config 21:13:03 INFO - Using buildbot properties: 21:13:03 INFO - { 21:13:03 INFO - "project": "", 21:13:03 INFO - "product": "firefox", 21:13:03 INFO - "script_repo_revision": "production", 21:13:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:13:03 INFO - "repository": "", 21:13:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:13:03 INFO - "buildid": "20160708183001", 21:13:03 INFO - "pgo_build": "True", 21:13:03 INFO - "basedir": "/builds/slave/test", 21:13:03 INFO - "buildnumber": 28, 21:13:03 INFO - "slavename": "talos-linux64-ix-036", 21:13:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:13:03 INFO - "platform": "ubuntu64_hw", 21:13:03 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:13:03 INFO - "branch": "autoland", 21:13:03 INFO - "repo_path": "integration/autoland", 21:13:03 INFO - "revision": "64e752c0270c0dfebdf4004e8f7d19029807994d", 21:13:03 INFO - "stage_platform": "linux64-pgo", 21:13:03 INFO - "builduid": "71688b99c8fb4310b0cc17eb62da4297", 21:13:03 INFO - "slavebuilddir": "test" 21:13:03 INFO - } 21:13:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:13:03 INFO - Running post-action listener: _resource_record_post_action 21:13:03 INFO - ##### 21:13:03 INFO - ##### Finished read-buildbot-config step (success) 21:13:03 INFO - ##### 21:13:03 INFO - ##### 21:13:03 INFO - ##### Running download-and-extract step. 21:13:03 INFO - ##### 21:13:03 INFO - Running pre-action listener: _resource_record_pre_action 21:13:03 INFO - Running main action method: download_and_extract 21:13:03 INFO - mkdir: /builds/slave/test/build/tests 21:13: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')]} 21:13:03 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:09 INFO - Downloaded 1361 bytes. 21:13:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:13:09 INFO - Using the following test package requirements: 21:13:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:13:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:13:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:13:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'jsshell-linux-x86_64.zip'], 21:13:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:13:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:13:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:13:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:13:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:13:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:13:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:09 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:13:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:13:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:13:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:11 INFO - Downloaded 24303241 bytes. 21:13:11 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'] 21:13:11 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 21:13:12 INFO - Return code: 0 21:13:12 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 21:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:12 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:15 INFO - Downloaded 24303241 bytes. 21:13:15 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'] 21:13:15 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 21:13:17 INFO - Return code: 0 21:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:17 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:18 INFO - Downloaded 14403333 bytes. 21:13:18 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'] 21:13:18 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 21:13:18 INFO - Return code: 0 21:13:18 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')]} 21:13:18 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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 21:13:20 INFO - Downloaded 60434003 bytes. 21:13:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:13:20 INFO - mkdir: /builds/slave/test/properties 21:13:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:20 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:20 INFO - Contents: 21:13:20 INFO - build_url:https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:13:21 INFO - Running post-action listener: _resource_record_post_action 21:13:21 INFO - Running post-action listener: set_extra_try_arguments 21:13:21 INFO - ##### 21:13:21 INFO - ##### Finished download-and-extract step (success) 21:13:21 INFO - ##### 21:13:21 INFO - ##### 21:13:21 INFO - ##### Running populate-webroot step. 21:13:21 INFO - ##### 21:13:21 INFO - Running pre-action listener: _resource_record_pre_action 21:13:21 INFO - Running main action method: populate_webroot 21:13:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:21 INFO - '--tppagecycles', 21:13:21 INFO - '7'], 21:13:21 INFO - 'tests': ['tsvgm']}}, 21:13:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:13:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:13:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:13:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['damp', 'tps']}, 21:13:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'tests': ['damp', 'tps']}, 21:13:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['dromaeo_dom']}, 21:13:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['basic_compositor_video']}, 21:13:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:13:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'other-e10s': {'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['a11yr', 21:13:21 INFO - 'ts_paint', 21:13:21 INFO - 'tpaint', 21:13:21 INFO - 'sessionrestore', 21:13:21 INFO - 'sessionrestore_no_auto_restore', 21:13:21 INFO - 'tabpaint']}, 21:13:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['tsvgx', 21:13:21 INFO - 'tsvgr_opacity', 21:13:21 INFO - 'tart', 21:13:21 INFO - 'tscrollx', 21:13:21 INFO - 'cart']}, 21:13:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:13:21 INFO - 'tsvgr_opacity', 21:13:21 INFO - 'tart', 21:13:21 INFO - 'tscrollx', 21:13:21 INFO - 'cart']}, 21:13:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'talos_options': ['--disable-e10s'], 21:13:21 INFO - 'tests': ['tp5o']}, 21:13:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'tests': ['tp5o']}, 21:13:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'talos_options': ['--disable-e10s', 21:13:21 INFO - '--xperf_path', 21:13:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:21 INFO - 'tests': ['tp5n']}, 21:13:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:21 INFO - 'talos_options': ['--xperf_path', 21:13:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:21 INFO - 'tests': ['tp5n']}}, 21:13:21 INFO - 'talos.zip': {'path': '', 21:13:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:21 INFO - Running post-action listener: _resource_record_post_action 21:13:21 INFO - ##### 21:13:21 INFO - ##### Finished populate-webroot step (success) 21:13:21 INFO - ##### 21:13:21 INFO - ##### 21:13:21 INFO - ##### Running create-virtualenv step. 21:13:21 INFO - ##### 21:13:21 INFO - Running pre-action listener: _resource_record_pre_action 21:13:21 INFO - Running main action method: create_virtualenv 21:13:21 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:21 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 21:13:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:21 INFO - Using real prefix '/usr' 21:13:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:22 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:23 INFO - Installing pip.................done. 21:13:24 INFO - Return code: 0 21:13:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:24 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:24 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 21:13:24 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 21:13:24 INFO - Using env: {'DISPLAY': ':0', 21:13:24 INFO - 'HOME': '/home/cltbld', 21:13:24 INFO - 'LANG': 'en_US.UTF-8', 21:13:24 INFO - 'LANGUAGE': 'en_US:en', 21:13:24 INFO - 'LOGNAME': 'cltbld', 21:13:24 INFO - 'MAIL': '/var/mail/cltbld', 21:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:24 INFO - 'MOZ_NO_REMOTE': '1', 21:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:24 INFO - 'NO_EM_RESTART': '1', 21:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:24 INFO - 'PWD': '/builds/slave/test', 21:13:24 INFO - 'SHELL': '/bin/bash', 21:13:24 INFO - 'SHLVL': '1', 21:13:24 INFO - 'TERM': 'linux', 21:13:24 INFO - 'TMOUT': '86400', 21:13:24 INFO - 'USER': 'cltbld', 21:13:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:24 INFO - '_': '/tools/buildbot/bin/python'} 21:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:24 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 21:13:24 INFO - Cleaning up... 21:13:24 INFO - Return code: 0 21:13:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:24 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:24 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 21:13:24 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 21:13:24 INFO - Using env: {'DISPLAY': ':0', 21:13:24 INFO - 'HOME': '/home/cltbld', 21:13:24 INFO - 'LANG': 'en_US.UTF-8', 21:13:24 INFO - 'LANGUAGE': 'en_US:en', 21:13:24 INFO - 'LOGNAME': 'cltbld', 21:13:24 INFO - 'MAIL': '/var/mail/cltbld', 21:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:24 INFO - 'MOZ_NO_REMOTE': '1', 21:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:24 INFO - 'NO_EM_RESTART': '1', 21:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:24 INFO - 'PWD': '/builds/slave/test', 21:13:24 INFO - 'SHELL': '/bin/bash', 21:13:24 INFO - 'SHLVL': '1', 21:13:24 INFO - 'TERM': 'linux', 21:13:24 INFO - 'TMOUT': '86400', 21:13:24 INFO - 'USER': 'cltbld', 21:13:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:24 INFO - '_': '/tools/buildbot/bin/python'} 21:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:24 INFO - Downloading/unpacking psutil>=3.1.1 21:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:26 INFO - Installing collected packages: psutil 21:13:26 INFO - Running setup.py install for psutil 21:13:26 INFO - building 'psutil._psutil_linux' extension 21:13:26 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 21:13:26 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 21:13:26 INFO - building 'psutil._psutil_posix' extension 21:13:26 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 21:13:26 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 21:13:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:27 INFO - Successfully installed psutil 21:13:27 INFO - Cleaning up... 21:13:27 INFO - Return code: 0 21:13:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:13:27 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')]} 21:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:27 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')]} 21:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:27 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:27 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 21:13:27 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 21:13:27 INFO - Using env: {'DISPLAY': ':0', 21:13:27 INFO - 'HOME': '/home/cltbld', 21:13:27 INFO - 'LANG': 'en_US.UTF-8', 21:13:27 INFO - 'LANGUAGE': 'en_US:en', 21:13:27 INFO - 'LOGNAME': 'cltbld', 21:13:27 INFO - 'MAIL': '/var/mail/cltbld', 21:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:27 INFO - 'MOZ_NO_REMOTE': '1', 21:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:27 INFO - 'NO_EM_RESTART': '1', 21:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:27 INFO - 'PWD': '/builds/slave/test', 21:13:27 INFO - 'SHELL': '/bin/bash', 21:13:27 INFO - 'SHLVL': '1', 21:13:27 INFO - 'TERM': 'linux', 21:13:27 INFO - 'TMOUT': '86400', 21:13:27 INFO - 'USER': 'cltbld', 21:13:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:27 INFO - '_': '/tools/buildbot/bin/python'} 21:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:13:30 INFO - Installing collected packages: mozsystemmonitor 21:13:30 INFO - Running setup.py install for mozsystemmonitor 21:13:30 INFO - Successfully installed mozsystemmonitor 21:13:30 INFO - Cleaning up... 21:13:30 INFO - Return code: 0 21:13:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:13:30 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')]} 21:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 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')]} 21:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:30 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 21:13:30 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 21:13:30 INFO - Using env: {'DISPLAY': ':0', 21:13:30 INFO - 'HOME': '/home/cltbld', 21:13:30 INFO - 'LANG': 'en_US.UTF-8', 21:13:30 INFO - 'LANGUAGE': 'en_US:en', 21:13:30 INFO - 'LOGNAME': 'cltbld', 21:13:30 INFO - 'MAIL': '/var/mail/cltbld', 21:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:30 INFO - 'MOZ_NO_REMOTE': '1', 21:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:30 INFO - 'NO_EM_RESTART': '1', 21:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:30 INFO - 'PWD': '/builds/slave/test', 21:13:30 INFO - 'SHELL': '/bin/bash', 21:13:30 INFO - 'SHLVL': '1', 21:13:30 INFO - 'TERM': 'linux', 21:13:30 INFO - 'TMOUT': '86400', 21:13:30 INFO - 'USER': 'cltbld', 21:13:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:30 INFO - '_': '/tools/buildbot/bin/python'} 21:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:30 INFO - Downloading/unpacking jsonschema==2.5.1 21:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:13:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13:32 INFO - Downloading functools32-3.2.3-2.tar.gz 21:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:13:32 INFO - warning: no files found matching '*.txt' 21:13:32 INFO - no previously-included directories found matching 'build' 21:13:32 INFO - no previously-included directories found matching 'dist' 21:13:32 INFO - no previously-included directories found matching '.git*' 21:13:32 INFO - Installing collected packages: jsonschema, functools32 21:13:32 INFO - Running setup.py install for functools32 21:13:32 INFO - warning: no files found matching '*.txt' 21:13:32 INFO - no previously-included directories found matching 'build' 21:13:32 INFO - no previously-included directories found matching 'dist' 21:13:32 INFO - no previously-included directories found matching '.git*' 21:13:32 INFO - Successfully installed jsonschema functools32 21:13:32 INFO - Cleaning up... 21:13:32 INFO - Return code: 0 21:13:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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', '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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:13: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 blobuploader==1.2.4 21:13:32 INFO - Using env: {'DISPLAY': ':0', 21:13:32 INFO - 'HOME': '/home/cltbld', 21:13:32 INFO - 'LANG': 'en_US.UTF-8', 21:13:32 INFO - 'LANGUAGE': 'en_US:en', 21:13:32 INFO - 'LOGNAME': 'cltbld', 21:13:32 INFO - 'MAIL': '/var/mail/cltbld', 21:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:32 INFO - 'MOZ_NO_REMOTE': '1', 21:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:32 INFO - 'NO_EM_RESTART': '1', 21:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:32 INFO - 'PWD': '/builds/slave/test', 21:13:32 INFO - 'SHELL': '/bin/bash', 21:13:32 INFO - 'SHLVL': '1', 21:13:32 INFO - 'TERM': 'linux', 21:13:32 INFO - 'TMOUT': '86400', 21:13:32 INFO - 'USER': 'cltbld', 21:13:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:32 INFO - '_': '/tools/buildbot/bin/python'} 21:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - Downloading docopt-0.6.1.tar.gz 21:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:36 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:36 INFO - Running setup.py install for blobuploader 21:13:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:36 INFO - Running setup.py install for requests 21:13:36 INFO - Running setup.py install for docopt 21:13:36 INFO - Successfully installed blobuploader requests docopt 21:13:36 INFO - Cleaning up... 21:13:36 INFO - Return code: 0 21:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:36 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:36 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 21:13:36 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 21:13:36 INFO - Using env: {'DISPLAY': ':0', 21:13:36 INFO - 'HOME': '/home/cltbld', 21:13:36 INFO - 'LANG': 'en_US.UTF-8', 21:13:36 INFO - 'LANGUAGE': 'en_US:en', 21:13:36 INFO - 'LOGNAME': 'cltbld', 21:13:36 INFO - 'MAIL': '/var/mail/cltbld', 21:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:36 INFO - 'MOZ_NO_REMOTE': '1', 21:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:36 INFO - 'NO_EM_RESTART': '1', 21:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:36 INFO - 'PWD': '/builds/slave/test', 21:13:36 INFO - 'SHELL': '/bin/bash', 21:13:36 INFO - 'SHLVL': '1', 21:13:36 INFO - 'TERM': 'linux', 21:13:36 INFO - 'TMOUT': '86400', 21:13:36 INFO - 'USER': 'cltbld', 21:13:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:36 INFO - '_': '/tools/buildbot/bin/python'} 21:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:36 INFO - Running setup.py (path:/tmp/pip-E8bZKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:36 INFO - Running setup.py (path:/tmp/pip-K6Ia9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:37 INFO - Running setup.py (path:/tmp/pip-bHYv5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:37 INFO - Running setup.py (path:/tmp/pip-HHlc7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:37 INFO - Running setup.py (path:/tmp/pip-r1r2jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:37 INFO - Running setup.py (path:/tmp/pip-puwzxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:37 INFO - Running setup.py (path:/tmp/pip-2_uuU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:37 INFO - Running setup.py (path:/tmp/pip-PXzUL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:37 INFO - Running setup.py (path:/tmp/pip-k8BYWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:37 INFO - Running setup.py (path:/tmp/pip-y38Glu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:37 INFO - Running setup.py (path:/tmp/pip-gIojbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:37 INFO - Running setup.py (path:/tmp/pip-uHeHCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:37 INFO - Running setup.py (path:/tmp/pip-GvIdOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:37 INFO - Running setup.py (path:/tmp/pip-W51rzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:37 INFO - Running setup.py (path:/tmp/pip-2g_dIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:37 INFO - Running setup.py (path:/tmp/pip-5NFaWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:38 INFO - Running setup.py (path:/tmp/pip-QCOufB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:38 INFO - Running setup.py install for manifestparser 21:13:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Running setup.py install for mozcrash 21:13:38 INFO - Running setup.py install for mozdebug 21:13:38 INFO - Running setup.py install for mozdevice 21:13:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Running setup.py install for mozfile 21:13:38 INFO - Running setup.py install for mozhttpd 21:13:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Running setup.py install for mozinfo 21:13:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Running setup.py install for mozInstall 21:13:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:38 INFO - Running setup.py install for mozleak 21:13:39 INFO - Running setup.py install for mozlog 21:13:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Running setup.py install for moznetwork 21:13:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Running setup.py install for mozprocess 21:13:39 INFO - Running setup.py install for mozprofile 21:13:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Running setup.py install for mozrunner 21:13:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Running setup.py install for mozscreenshot 21:13:39 INFO - Running setup.py install for moztest 21:13:39 INFO - Running setup.py install for mozversion 21:13:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:39 INFO - Cleaning up... 21:13:39 INFO - Return code: 0 21:13:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:39 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:39 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 21:13:39 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 21:13:39 INFO - Using env: {'DISPLAY': ':0', 21:13:39 INFO - 'HOME': '/home/cltbld', 21:13:39 INFO - 'LANG': 'en_US.UTF-8', 21:13:39 INFO - 'LANGUAGE': 'en_US:en', 21:13:39 INFO - 'LOGNAME': 'cltbld', 21:13:39 INFO - 'MAIL': '/var/mail/cltbld', 21:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:39 INFO - 'MOZ_NO_REMOTE': '1', 21:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:39 INFO - 'NO_EM_RESTART': '1', 21:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:39 INFO - 'PWD': '/builds/slave/test', 21:13:39 INFO - 'SHELL': '/bin/bash', 21:13:39 INFO - 'SHLVL': '1', 21:13:39 INFO - 'TERM': 'linux', 21:13:39 INFO - 'TMOUT': '86400', 21:13:39 INFO - 'USER': 'cltbld', 21:13:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:39 INFO - '_': '/tools/buildbot/bin/python'} 21:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:40 INFO - Running setup.py (path:/tmp/pip-eHflm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:40 INFO - Running setup.py (path:/tmp/pip-ISysQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:40 INFO - Running setup.py (path:/tmp/pip-pRtdW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:40 INFO - Running setup.py (path:/tmp/pip-SZ_8k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:40 INFO - Running setup.py (path:/tmp/pip-TQ4qUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:40 INFO - Running setup.py (path:/tmp/pip-Tz685W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:40 INFO - Running setup.py (path:/tmp/pip-lSydoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:40 INFO - Running setup.py (path:/tmp/pip-CtSzKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:40 INFO - Running setup.py (path:/tmp/pip-Kz5bKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:40 INFO - Running setup.py (path:/tmp/pip-mlshU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:40 INFO - Running setup.py (path:/tmp/pip-PJZttU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:40 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)) 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:40 INFO - Running setup.py (path:/tmp/pip-JYIq_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:41 INFO - Running setup.py (path:/tmp/pip-MfMukY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:41 INFO - Running setup.py (path:/tmp/pip-ZLFgs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:41 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)) 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:41 INFO - Running setup.py (path:/tmp/pip-y7VAaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:41 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)) 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:41 INFO - Running setup.py (path:/tmp/pip-RNDyGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:41 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)) 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:41 INFO - Running setup.py (path:/tmp/pip-YBJssG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:41 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)) 21:13:41 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)) 21:13:41 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)) 21:13:41 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)) 21:13:41 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)) 21:13:41 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)) 21:13:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:43 INFO - Downloading blessings-1.6.tar.gz 21:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:43 INFO - Installing collected packages: blessings 21:13:43 INFO - Running setup.py install for blessings 21:13:43 INFO - Successfully installed blessings 21:13:43 INFO - Cleaning up... 21:13:43 INFO - Return code: 0 21:13:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:43 INFO - Reading from file tmpfile_stdout 21:13:43 INFO - Current package versions: 21:13:43 INFO - argparse == 1.2.1 21:13:43 INFO - blessings == 1.6 21:13:43 INFO - blobuploader == 1.2.4 21:13:43 INFO - docopt == 0.6.1 21:13:43 INFO - functools32 == 3.2.3-2 21:13:43 INFO - jsonschema == 2.5.1 21:13:43 INFO - manifestparser == 1.1 21:13:43 INFO - mozInstall == 1.12 21:13:43 INFO - mozcrash == 0.17 21:13:43 INFO - mozdebug == 0.1 21:13:43 INFO - mozdevice == 0.48 21:13:43 INFO - mozfile == 1.2 21:13:43 INFO - mozhttpd == 0.7 21:13:43 INFO - mozinfo == 0.9 21:13:43 INFO - mozleak == 0.1 21:13:43 INFO - mozlog == 3.2 21:13:43 INFO - moznetwork == 0.27 21:13:43 INFO - mozprocess == 0.23 21:13:43 INFO - mozprofile == 0.28 21:13:43 INFO - mozrunner == 6.12 21:13:43 INFO - mozscreenshot == 0.1 21:13:43 INFO - mozsystemmonitor == 0.3 21:13:43 INFO - moztest == 0.7 21:13:43 INFO - mozversion == 1.4 21:13:43 INFO - psutil == 3.1.1 21:13:43 INFO - requests == 1.2.3 21:13:43 INFO - wsgiref == 0.1.2 21:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:43 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:43 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 21:13:43 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 21:13:43 INFO - Using env: {'DISPLAY': ':0', 21:13:43 INFO - 'HOME': '/home/cltbld', 21:13:43 INFO - 'LANG': 'en_US.UTF-8', 21:13:43 INFO - 'LANGUAGE': 'en_US:en', 21:13:43 INFO - 'LOGNAME': 'cltbld', 21:13:43 INFO - 'MAIL': '/var/mail/cltbld', 21:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:43 INFO - 'MOZ_NO_REMOTE': '1', 21:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:43 INFO - 'NO_EM_RESTART': '1', 21:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:43 INFO - 'PWD': '/builds/slave/test', 21:13:43 INFO - 'SHELL': '/bin/bash', 21:13:43 INFO - 'SHLVL': '1', 21:13:43 INFO - 'TERM': 'linux', 21:13:43 INFO - 'TMOUT': '86400', 21:13:43 INFO - 'USER': 'cltbld', 21:13:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:43 INFO - '_': '/tools/buildbot/bin/python'} 21:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 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)) 21:13:43 INFO - Cleaning up... 21:13:43 INFO - Return code: 0 21:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:43 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 0x233d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', '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 21:13:43 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 21:13:43 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 21:13:43 INFO - Using env: {'DISPLAY': ':0', 21:13:43 INFO - 'HOME': '/home/cltbld', 21:13:43 INFO - 'LANG': 'en_US.UTF-8', 21:13:43 INFO - 'LANGUAGE': 'en_US:en', 21:13:43 INFO - 'LOGNAME': 'cltbld', 21:13:43 INFO - 'MAIL': '/var/mail/cltbld', 21:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:43 INFO - 'MOZ_NO_REMOTE': '1', 21:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:43 INFO - 'NO_EM_RESTART': '1', 21:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:43 INFO - 'PWD': '/builds/slave/test', 21:13:43 INFO - 'SHELL': '/bin/bash', 21:13:43 INFO - 'SHLVL': '1', 21:13:43 INFO - 'TERM': 'linux', 21:13:43 INFO - 'TMOUT': '86400', 21:13:43 INFO - 'USER': 'cltbld', 21:13:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:43 INFO - '_': '/tools/buildbot/bin/python'} 21:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:13:44 INFO - Cleaning up... 21:13:44 INFO - Return code: 0 21:13:44 INFO - Running post-action listener: _resource_record_post_action 21:13:44 INFO - Running post-action listener: _start_resource_monitoring 21:13:44 INFO - Starting resource monitoring. 21:13:44 INFO - ##### 21:13:44 INFO - ##### Finished create-virtualenv step (success) 21:13:44 INFO - ##### 21:13:44 INFO - ##### 21:13:44 INFO - ##### Running install step. 21:13:44 INFO - ##### 21:13:44 INFO - Running pre-action listener: _resource_record_pre_action 21:13:44 INFO - Running main action method: install 21:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:44 INFO - Reading from file tmpfile_stdout 21:13:44 INFO - Detecting whether we're running mozinstall >=1.0... 21:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:13:44 INFO - Reading from file tmpfile_stdout 21:13:44 INFO - Output received: 21:13:44 INFO - Usage: mozinstall [options] installer 21:13:44 INFO - Options: 21:13:44 INFO - -h, --help show this help message and exit 21:13:44 INFO - -d DEST, --destination=DEST 21:13:44 INFO - Directory to install application into. [default: 21:13:44 INFO - "/builds/slave/test"] 21:13:44 INFO - --app=APP Application being installed. [default: firefox] 21:13:44 INFO - mkdir: /builds/slave/test/build/application 21:13:44 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'] 21:13:44 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 21:14:01 INFO - Reading from file tmpfile_stdout 21:14:01 INFO - Output received: 21:14:01 INFO - /builds/slave/test/build/application/firefox/firefox 21:14:01 INFO - Running post-action listener: _resource_record_post_action 21:14:01 INFO - ##### 21:14:01 INFO - ##### Finished install step (success) 21:14:01 INFO - ##### 21:14:01 INFO - ##### 21:14:01 INFO - ##### Running run-tests step. 21:14:01 INFO - ##### 21:14:01 INFO - Running pre-action listener: _resource_record_pre_action 21:14:01 INFO - Running main action method: run_tests 21:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:01 INFO - Python 2.7.3 21:14:01 INFO - Return code: 0 21:14:01 INFO - grabbing minidump binary from tooltool 21:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc3b0>, '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 0x25fd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:14:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:14:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:14:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:01 INFO - Return code: 0 21:14:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:14:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:14:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:14:01 INFO - Using env: {'DISPLAY': ':0', 21:14:01 INFO - 'HOME': '/home/cltbld', 21:14:01 INFO - 'LANG': 'en_US.UTF-8', 21:14:01 INFO - 'LANGUAGE': 'en_US:en', 21:14:01 INFO - 'LOGNAME': 'cltbld', 21:14:01 INFO - 'MAIL': '/var/mail/cltbld', 21:14:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:01 INFO - 'MOZ_NO_REMOTE': '1', 21:14:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:01 INFO - 'NO_EM_RESTART': '1', 21:14:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:01 INFO - 'PWD': '/builds/slave/test', 21:14:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:01 INFO - 'SHELL': '/bin/bash', 21:14:01 INFO - 'SHLVL': '1', 21:14:01 INFO - 'TERM': 'linux', 21:14:01 INFO - 'TMOUT': '86400', 21:14:01 INFO - 'USER': 'cltbld', 21:14:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248', 21:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:01 INFO - '_': '/tools/buildbot/bin/python'} 21:14:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:14:01 INFO - mozversion application_buildid: 20160708183001 21:14:01 INFO - mozversion application_changeset: 64e752c0270c0dfebdf4004e8f7d19029807994d 21:14:01 INFO - mozversion application_display_name: Nightly 21:14:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:01 INFO - mozversion application_name: Firefox 21:14:01 INFO - mozversion application_remotingname: firefox 21:14:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:14:01 INFO - mozversion application_vendor: Mozilla 21:14:01 INFO - mozversion application_version: 50.0a1 21:14:01 INFO - mozversion platform_buildid: 20160708183001 21:14:01 INFO - mozversion platform_changeset: 64e752c0270c0dfebdf4004e8f7d19029807994d 21:14:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:14:01 INFO - mozversion platform_version: 50.0a1 21:14:01 INFO - using testdate: 1468037641 21:14:01 INFO - actual date: 1468037641 21:14:01 INFO - starting webserver on 'localhost:46353' 21:14:01 INFO - SUITE-START | Running 2 tests 21:14:01 INFO - TEST-START | dromaeo_css 21:14:01 INFO - operating with platform_type : linux_ 21:14:01 INFO - Initialising browser for dromaeo_css test... 21:14:01 INFO - TEST-INFO | started process 6239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVYMYn3/profile http://localhost:46353/getInfo.html) 21:14:07 INFO - PROCESS | 6239 | __metrics Screen width/height:1600/1200 21:14:07 INFO - PROCESS | 6239 | colorDepth:24 21:14:07 INFO - PROCESS | 6239 | Browser inner width/height: 1024/697 21:14:07 INFO - PROCESS | 6239 | __metrics 21:14:10 INFO - PROCESS | 6239 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:14:10 INFO - PROCESS | 6239 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:14:11 INFO - TEST-INFO | 6239: exit 0 21:14:11 INFO - Browser initialized. 21:14:11 INFO - Running cycle 1/1 for dromaeo_css test... 21:14:11 INFO - TEST-INFO | started process 6321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVYMYn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:14:22 INFO - PROCESS | 6321 | RSS: Main: 156983296 21:14:22 INFO - PROCESS | 6321 | 21:15:14 INFO - PROCESS | 6321 | 1468037714536 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] 21:17:22 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46353/tests/dromaeo/cssquery-ext.html) 21:17:23 INFO - PROCESS | 6321 | RSS: Main: 235425792 21:17:23 INFO - PROCESS | 6321 | 21:20:25 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-ext.html (next: http://localhost:46353/tests/dromaeo/cssquery-jquery.html) 21:20:26 INFO - PROCESS | 6321 | RSS: Main: 242950144 21:20:26 INFO - PROCESS | 6321 | 21:23:28 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46353/tests/dromaeo/cssquery-mootools.html) 21:23:29 INFO - PROCESS | 6321 | RSS: Main: 239206400 21:23:29 INFO - PROCESS | 6321 | 21:26:31 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46353/tests/dromaeo/cssquery-prototype.html) 21:26:31 INFO - PROCESS | 6321 | RSS: Main: 237547520 21:26:31 INFO - PROCESS | 6321 | 21:29:34 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46353/tests/dromaeo/cssquery-yui.html) 21:29:34 INFO - PROCESS | 6321 | RSS: Main: 216838144 21:29:34 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | Cycle 1(1): loaded http://localhost:46353/tests/dromaeo/cssquery-yui.html (next: http://localhost:46353/tests/dromaeo/cssquery-dojo.html) 21:32:37 INFO - PROCESS | 6321 | RSS: Main: 270471168 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | __start_tp_report 21:32:37 INFO - PROCESS | 6321 | _x_x_mozilla_page_load 21:32:37 INFO - PROCESS | 6321 | _x_x_mozilla_page_load_details 21:32:37 INFO - PROCESS | 6321 | |i|pagename|runs| 21:32:37 INFO - PROCESS | 6321 | |0;dojo.html;2983.164713880113;3020.5167173252257;3027.8486075696223;3035.3929214157174;3038.286002789344;5197.350331208599;5252.842414727559;5273.393559740631;5328.307320048393;5382.461753824616;5243.4232234454275;5244.68531888087;5250.133727934895;5271.710055946922;5317.8404647860625;4680.929786053221;4777.952220477786;4792.353032340624;4792.353032340642;4923.236898280755;4824.300476430933;4834.202356611155;4869.123557759602;4884.535969082949;4908.361912951312;4700.694454860423;4742.19382704941;4743.407074115718;4805.038992201574;4840.878978025542;4746.762661866927;4764.547368000034;4766.070616229837;4769.642276829217;4879.243717223836;4759.643026773006;4784.712917224978;4793.976030119862;4803.807847686088;4864.878378040542;5129.666571672829;5188.5849132069725;5246.711430871301;5248.291480650139;5263.605229607795;5662.065759149736;5666.688332141731;5682.119271512922;5686.715664216773;5691.231683722686;5679.801206957778;5713.428657134295;5719.914201286984;5730.34101078373;5735.311762588516;5213.165893457067;5311.309529761145;5356.276902618136;5361.544268737123;5364.1417373220875;5783.595148339576;5840.036393995028;5845.064789633639;5845.444682755132;5846.795362162304;5597.104463285855;5609.607327487037;5614.691191984399;5616.045272303718;5619.971900140473;5554.91667624986;5563.388027316992;5610.775568977195;5615.101583746581;5689.061304884731;5606.775728970795;5607.7476513556985;5608.214849921014;5611.410801865827;5618.016847051749;5483.698396588226;5604.355499117572;5611.242482264842;5615.971920140373;5616.5787565932715;4293.527711951683;4294.441722576107;4304.7632380218765;4322.308430651081;4323.308270676676;3855.1904100139286;3859.2474467479133;3869.7484663496784;3899.980500097481;3901.785401802928;5258.8159414420315;5357.303550538405;5398.1632846908005;5408.8377348679605;5410.8917821643345;5584.720763961785;5616.382197958222;5617.32592088952;5625.690587017753;5656.264685590929;5350.91973620396;5358.678479291255;5363.168708850135;5365.6244062916;5369.48989845964;4652.162610730101;4755.167845627071;4766.642501812378;4776.761161941889;4792.520747925179;5916.585838991229;5932.169496270526;5933.792317268875;5937.346891841894;5992.280926288873;5680.460356266148;5709.143628455765;5713.514351280188;5718.542516598745;5737.91393129095;5722.971385143048;5763.106718458645;5790.623609465371;5895.911561326498;5902.4097590240635;5565.02612042899;5581.358143813513;5581.916271255853;5623.297087864017;5630.408807075362;5636.5208957237455;5646.2942132233475;5651.463111004448;5652.180433837153;5655.604107712586;5373.247745315581;5464.699441530754;5528.778848846001;5537;5542.501174894279;5497.340319161726;5548.361938377138;5548.667079975215;5551.444855514416;5586.190002449704;5496.148097044965;5525.751341189736;5543.611947163821;5549.084401073777;5549.889002220014;5459.590530710292;5530.5022547970875;5596.076647353141;5596.3284405871555;5644.209810626434;5481.506664400223;5486.561075114061;5488.69812160335;5504.22940788298;5507.9449205507435 21:32:37 INFO - PROCESS | 6321 | |1;ext.html;570.0935512535068;601.0503404620699;609.4788955443097;621.496587763911;628.1802248066277;42346.57653423465;43598;43775;43817.78091109544;47957.760211198896;44970.1005979881;45399.546004539945;45435.54564454354;45449.77275113628;45520;8952.418092823962;9130.406523575979;9134.17792398684;9134.725958221265;9137.131972462605;8939.374243802937;8999.685011024616;9020.2783777298;9038.141376569216;9046.050164732707;9133.132352426543;9142.634294628207;9166.175044246016;9167.358284920057;9171;9064.00295967443;9065.954670226673;9091.954540227323;9100.362974591748;9101;8995.370324077317;8996.235319997808;9007.279417646638;9019.774505637346;9067.410618309788;37077.629223707685;37219.25561488755;37355.626443735484;37399.50401983917;37460;3438.054535002869;3514.912127196815;3540.4713698040046;3575.213453040327;4099.836006559734;33322.166945826306;34190.316193675986;34706.479402808975;35134;35242.647573524446;4278.486581610196;4279.1013887083745;4291.35629655551;4388.605025547684;4460.553944605546;366977;370693;372753;373279;374041;48613;49008.509914900395;51001;55867.44132558704;57977;62476.68761656163;62619;62721.11836644908;62752;62769.37230627727;16709.248083836257;16821.83178168227;16924.57688557796;16930.492085237463;16955.49133525996;11679.941600291944;11986.340751258764;12924.224546527239;13081;13111.14777539457;17654.382096626556;17658;18070.277188912558;18694.34569790051;18858.81141188598;6498.805035848932;6548.934510654928;6688.933110668929;6690.96654516734;6720.395164435225;976.9413835169912;1046.9895301047045;1071.3839542263074;1102.6967583914327;1196.234409977615;32421.351572968408;32664.49737946823;32679;33086;33124.3375132496;1122.5060973171778;1134.7900638381925;1151.7351009267916;1192.9164958452998;1194.2535915053093;16759.41342053022;16971.06659133735;17159;17186.235828796984;17197.57006074858;552590;598745;612692;612889;614475;56042.71978640162;56370.154447683315;56806.147907781415;62263;62327;1189.1735244005333;1300.8048792681172;1343.4894739998738;1345.2399394342165;1382.523029554802;29913.401731964805;34166.487502687974;34259.314813704084;34588.48117278293;34605.48091778676;51377.7431112842;55132.44867551273;56380.718096409255;56573.43426565682;61772.38227617846;520680;521652;524599;525243;525671;35859.64140358563;37171;37463.43804842875;39040.80479597584;39325;45694.54305457036;48525.757371212916;49383.25925111198;50036.74981625069;50667.49332506775;39019.41470877882;42125.1574968505;42383.36424953566;43415.34876976911;43629.34555981599;41946.86903226398;42615;42985;42995.57004429916;43795.78102109469;41271.1745765089;42561.14877702366;42665.786671066446;42671.57328426676;42708.5729142717;35961.28077438489;38244.42633360446;38726;39114.21771564496;39207.41188882226;28599.28501787472;28769.56845647359;28813;28964.13107606775;29214.56178157287 21:32:37 INFO - PROCESS | 6321 | |2;jquery.html;388.6366247558533;390.8671051842373;394.8321963165654;399.3111882003544;418.5939638550605;13107.92697704556;18325.358612448552;18776.530586735338;20363.49091272719;20396.184152633912;17874;18187.545311367223;18428.07859607021;18452.169652365643;18704.81295187051;5756.769729210827;5849.356570777211;5885.352611212763;5895.43993320636;5937.52499800015;5688.63023903445;5783.479486846183;5787.652740835542;5798.217240672498;5835.5039821615;4236.1104168124575;6221.222347206599;6586.80239592813;6590.538662293641;6591;6449.6130232186215;6483.935160648381;6534.183227096613;6574.704138313763;6644.368784965421;5847.298324201123;5851.590388672795;5856.590038697293;5867.266591676041;5879.794207202727;23108.42228944273;24181.637275440884;25232.87383563089;25334.873325633438;25363.239102826945;2265.5770889528044;2285.645724912641;2320.6635037919577;2435.305937807734;2510.497900419905;15761.29074191664;15954.680906381807;16144.515664530083;16340.918295408446;16514.174291285388;1878.5397577593576;1939.787632729544;2150.6773983902385;2310.3415526575013;2363.9645405318934;88184;89866.55066724625;90405.54797226038;91846.54076729574;96678.51660741652;17356.3057477702;17549.649007019787;17843.553911152067;17846.19692113858;17869.123742007163;31286;31646.683533164833;31674;31775.68224317727;32026.83986580052;9494.572744226527;9497.145256926771;10153.289269751194;10209.438480883622;10368.615218499788;8454.253020087435;8550.78623034429;8586.141385861489;8727.60725767342;8778.29773618109;8634.827303454022;8826.86759698605;8857.424267422597;8937.642494300286;9034.057677599216;3159.304952910356;3264.7061764441314;3395.8811441599423;3528.5723551923347;3548.8757893473603;953.0374321934896;974.201155052864;984.5372674842955;1007.0282177698409;1008.6973907827622;19329.80670193308;19631.411057668294;19690.50773730668;19865.106070226873;20006.199752009758;953.9379940303858;960.514939955332;962.9855552166723;981.190517822799;994.229472159068;10668.573257069786;10842.403667798348;10906.948885742891;10997.780044399067;11051.613193538187;442584;447506;533037;539786;546648;92709.07078543016;92780.53609731908;93562.0643793567;103982;108337.91662083278;992.9950350248203;1014.497823577334;1014.6398028699853;1034.5603118674533;1045.5242864496636;15554.533363999099;17138.31446742116;18060.729089063938;18544;19079;34681.13297167591;38547.42178867263;44065.77967110144;44922.77538612286;45575;59042.40957590369;59654.40345596662;59798.70100649469;60519.39480605314;61828;8707.25988290977;8893.599788009426;9004.099590040943;9043.366964312436;9106.772330691785;10211.73224568131;12816.295103769382;13547.119437236548;13795.655108622364;14047.648808779863;12061.276323420272;12123.515059397525;12279.938600306941;12525.74948501043;12953.158044727063;12015.639530814089;12040.819387709016;12078.27530348182;12189.451474683483;12411.75176496483;12386.62840114798;12638.747225055631;12649.557265495663;12762.936185319015;12986.220826750425;7728.381729461742;7979.162187970412;8618.181272779077;8799.12008799115;8893.866592001255;12272.447739851907;12422.37888105609;12554.435050422935;12627.621171364874;12684 21:32:37 INFO - PROCESS | 6321 | |3;mootools.html;1281.7500587385462;1290.2452065541654;1303.86309437509;1349.8245228120343;1741.9216135273903;8247.340212782978;8626.22363987241;8649.09184535624;8902.287816974642;8908.910910890889;8620.913790862089;8823.735287941372;8828.51443170627;8837.602307896144;8839.160279773427;2168.4687251623373;2196.077647388101;2198.8021078102965;2202.41635966469;2205.547862688153;2255.357223191391;2278.2481781012307;2308.676785250058;2308.8499247548857;2311.456807650201;2276.8064714499205;2289.5306462175213;2303.9193628223015;2304.124432715574;2313.3406979010983;2183.3559100065518;2191.3206905859233;2196.3191410662666;2202.1411649456722;2208.2491952735986;2141.550274442369;2142.3251675722254;2143.474848662072;2144.356692992096;2145.410012246629;8521.659133634646;8692.43499172558;8769.561521923943;8854.734357969206;8902;5185.870353241199;5276.366835979707;5276.841694749163;5281;5284.207368894658;3173.0956677346844;3188.872445102193;3205.871765129392;3220.855061522237;3224.564683767685;1065.3661071662348;1070.9625163119254;1073.538378497246;1091.8744344400416;1096.6216655253925;12105.636830895088;12179.4519246635;12202.633920982385;12221.266723996589;12231.938840305831;4408.889777755582;4463.776811159494;4592.816287348469;4637.675362724577;4642.3500709900645;9712.223022158352;9718.95140524307;9765.658201963039;9786.5596048178;9793;5256.053910296183;5291.417944026154;5295.364556253275;5300.628955973122;5308.044551980681;4215.641670458045;4373.300271956472;4815.085133824562;4954.033963377179;4957.677750946177;3830.0616348994677;3843.807809609564;3903.531576210816;3926.6466018058513;3973.642372186517;1147.0536807134147;1152.6714886257544;1155.6995181252935;1157.745296034871;1165.1086918507349;810.1776696652902;829.3738227638095;871.5424402188775;920.4661296448178;958.6548842416724;5868.23712917318;5873.353931067579;6019.729112189962;6140.662263575547;6300;892.8258989497116;911.2163539356148;932.1843387036344;934.7849994501166;967.4195482710318;3925.725199236083;3932.6264004919485;4001.419794129835;4016.879493615196;4065.10567675111;11006.779864402828;11215.495302711397;11241.325520468798;11402.885971140182;11415.543378264943;11169.664910052712;11171.608993685344;11173.553057877756;11183.105351571854;11231.71920701989;7596.924030759732;8189.836203275901;8343.791405214919;8348.457350272212;8379.916200837913;5647.5481961442165;5663.292088488939;5809.128630705428;5891.293044834647;5949.1076338549565;9706.56320465595;10405.47972601382;10426.113780328757;10442.947785261025;10551.788964220827;9418.529073546433;9926.751831204278;10135.391876487434;10442.269041167045;10445.268831181744;7841.215878412113;7895.249951254622;8066.637001335072;8073.5963201838495;8077.7576672699915;8465;8545.786355341166;8551.759994800843;8554.230119289045;8590.699325523827;7258.201597824341;7527.322540971339;7539.47223694358;7551.962240188984;7685.308322251024;7320.707171713072;7500.887486687813;7507.436942229246;7541.773746787605;7702.5763583001235;6731.32686731323;6829.52193346461;6829.89755153683;6830.214525329452;6835.7949261522235;4766.761661916821;4865.099956508057;4903.705777653352;4950.306957025947;5025.497450254945;4967.528084831935;5003.649744517995;5003.674761140514;5008.499150084962;5139.563137133386 21:32:37 INFO - PROCESS | 6321 | |4;prototype.html;323.2984423800353;330.9851056702448;332.84023668639054;337.5577992829395;338.84413169941826;5281.973590132054;5286.2334961430615;5301.1783173608155;5311.78752849886;5347.304850369446;5192.636515443921;5218.895622087556;5252.343457067866;5255.789768409259;5271.472852714726;3962.62355076268;4021.457103291062;4120.187117668232;4128.195001974616;4154.43915071466;4068.9186216275657;4096.180763847227;4098.180363927211;4105;4110.239605672945;3926.7447615905016;4068.3694027425795;4072.3484242521204;4073.572274911136;4094.263032654121;3803.2013277211818;3957.960420395788;4035.919281614366;4067.3085575451946;4127.2983592789;3592.1558433768046;3610.2418492116685;3612.6026137124895;3616.6383361663884;3659.6157403472516;5135.483613029626;5164.974175129138;5166.560842328407;5171.965606878639;5210.218467229908;4555.362249285103;4658.998315362213;4690.132325519789;4691;4700.9059818803435;5378.005069062236;5396.381085674321;5398.757055932453;5436.972815135899;5457.836264912059;3984.5218573771044;4003.719739618228;4007.2786898358286;4013.71561100448;4020.698447616411;5342;5664.178694089375;5670.319561652628;5675.489205971441;5676.2620859288445;3994.08136128692;4006.579309172553;4008.3586626139677;4031.7580945143386;4041.1109555897656;4017.634004438505;4031.254217969685;4049.635532802062;4068.247374235776;4079.449274347925;4525.705829121097;4630.236011058138;4636.721796692209;4704.411948506437;4714.693544919569;5457.945420545744;5489.533389661844;5495.120780675153;5501.394846566875;5519.972400137974;1380.6134282400944;1385.1758203868683;1386.9167849928835;1399.930003499821;1400.6358346829898;849.1847826087026;892.9642814287356;893.6916763716507;895.8521843895684;909.5906841921162;5146.356705411824;5249.632525723163;5267.209918512177;5269.973650131725;5275.894482110336;5539.806106786243;5654.886902261932;5660.745266463019;5663.490285874291;5672.744726487318;5249.790008399621;5352.223927530564;5358.54452371545;5359.22291267764;5389.56883449331;2985.6417229932113;3001.8198908065588;3004.3690824926575;3005.72256790863;3013.2165636934556;5757.971210144006;5790.971045144832;5795.275590551181;5812.738426770806;5855.443732845373;5673.404292549306;5746.683932383676;5773.220615216892;5779.595428319977;5812.534997200214;5788.21859049023;5789.739461724233;5815.79644712433;5818.970905145447;5848.941510584839;5448.536874365724;5596.776128954959;5611.326640802967;5613.719314034201;5615.354234263112;5541.445855414427;5543.473370029841;5549.361823390362;5559.610827242054;5590.44095590454;5804.941950580609;5811.53507719373;5821.185034095145;5832.24180856486;5835.183074369506;3959.346707793182;4049.635532802062;4068.7762173080764;4080.3879418086335;4089.2843752343815;5632.295963004624;5675.148727690879;5677.77288908439;5681.375048744718;5709.800156994652;5498.230247765236;5548.278723765885;5584.888302233851;5600.215969764155;5626.43735626434;5284.987557092574;5436.3147424298595;5458.454154584669;5469.863253418696;5510.641808282448;5474.8905021898545;5476.2607048048;5477.835664930059;5479.589030822784;5512.586556008235;5294.549963253013;5339.919901201562;5511.740186523506;5524.618845288678;5534.52956498686;5366.329208848894;5408.323959505062;5410.61932749589;5415.810446634349;5420.4037555868035 21:32:37 INFO - PROCESS | 6321 | |5;yui.html;592.9347771745105;604.314103492536;652.1326635574685;657.0505619379998;667.4360165660015;13208.537701180461;13744.518941837037;13762.72474550511;13788.931055344721;13861.23763193024;12048.57829975951;12077.879221207786;12129.696757581065;12310.138290319659;12527.874721252807;648.7210499485219;662.3244290823358;767.5970115689266;775.1550809617515;789.3921680306161;779.5517577393022;793.020619534874;793.5516433215244;794.3248238996864;794.6741835847304;820.5856042698429;821.954792486416;822.251750906675;822.2887202569764;822.6997146041682;670.9228438729535;800.6877317846045;808.7816289601775;818.382121498268;819.3690858039306;597.6623207887529;599.4964230046781;601.1253625974197;601.1313651773189;601.4226342711003;12436.626901192978;12440.81338779919;12441.253524788543;12452.31512266825;12457.93771031148;11379.601713939972;11516.884831151665;11808;11982.101342399355;12230.571929982498;11187.32876027441;11318.20772545922;11377.658670239905;11377.886221137765;11583.94208028963;3624.0282123085626;4151.6886233532305;4171.666266698687;4185;4286.185624731291;79538.60230698809;80977.19022809755;81171;81219.5939020307;81579;9153.130452606993;9555.952220238854;9570.473623950611;9773.169280611086;9893.258005649604;15906.9204653976;16014.519564413085;16084.919575402047;16167.110808905389;16289.755653665205;7203.459740519482;7228.241034691387;7270;7288.979542864004;7481.251874812584;4374.321980093091;4381.496127945264;4451.9554804451545;4462.464504259509;4544.795484203219;3122.7189552940345;3222.8066316021113;3234.5956755405573;3254.6419893811662;3255.918602034968;610.8533951851524;611.3672349118641;618.6164577961603;635.0569404434411;650.6453982579411;537.8547792096113;589.19280585598;604.9122877182784;638.1958731997717;661.576590981772;8319.251267385844;8415.663373464993;8822.647094116292;8926.24257354003;8957.731268061969;529.4414392815617;632.5540493951753;644.9613023218621;647.2750519418281;671.1677519875417;4165.66674666026;4260.829566817354;4301.849435269751;4398.450193725785;4432.224360736858;72845;114865.4256728711;117212;118836;118895;63371;98615.50692246636;99027.50486247666;99660;101906.49046754868;89802;90380.09619903717;90524.99999999868;92151;92517;8086.757397278091;8142.715004974797;8277.4619649725;8413.789655258668;9279.582418791306;38312.616873830906;49302.26046609376;51441;54286;54500.54994500518;79548.60225698835;79854;80051.59974200092;80730.59634701788;84389.57805210934;11291.43542822872;11691.883081169419;11826.526938922347;11996.040316774812;12114.273143611412;12480.438380272728;12923.15999460032;12937.482500699867;12968.8054679178;13411.597652070453;7545.811354716176;10904.945475272572;12180.086493512845;12284.201526900722;12464.5014199431;12493.75012499763;12587.559435419716;12621.368931553201;12660.493580256687;12722.809157862454;12323.630291091282;12352.814707779571;12403.689907752378;12861;13036.869631303945;9396;9486.478243696663;9608.75978100553;9959.253056020683;10282.840478768267;10227.897721022991;10452.581896724047;10541.20940929418;10542.789144217226;10577.735556611146 21:32:37 INFO - PROCESS | 6321 | __end_tp_report 21:32:37 INFO - PROCESS | 6321 | __start_cc_report 21:32:37 INFO - PROCESS | 6321 | _x_x_mozilla_cycle_collect,1008 21:32:37 INFO - PROCESS | 6321 | __end_cc_report 21:32:37 INFO - PROCESS | 6321 | __startTimestamp1468038757850__endTimestamp 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | ------- Summary: start ------- 21:32:37 INFO - PROCESS | 6321 | Number of tests: 6 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#0] dojo.html Cycles:165 Average:5254.10 Median:5496.15 stddev:608.35 (11.1%) stddev-sans-first:583.55 21:32:37 INFO - PROCESS | 6321 | Values: 2983.2 3020.5 3027.8 3035.4 3038.3 5197.4 5252.8 5273.4 5328.3 5382.5 5243.4 5244.7 5250.1 5271.7 5317.8 4680.9 4778.0 4792.4 4792.4 4923.2 4824.3 4834.2 4869.1 4884.5 4908.4 4700.7 4742.2 4743.4 4805.0 4840.9 4746.8 4764.5 4766.1 4769.6 4879.2 4759.6 4784.7 4794.0 4803.8 4864.9 5129.7 5188.6 5246.7 5248.3 5263.6 5662.1 5666.7 5682.1 5686.7 5691.2 5679.8 5713.4 5719.9 5730.3 5735.3 5213.2 5311.3 5356.3 5361.5 5364.1 5783.6 5840.0 5845.1 5845.4 5846.8 5597.1 5609.6 5614.7 5616.0 5620.0 5554.9 5563.4 5610.8 5615.1 5689.1 5606.8 5607.7 5608.2 5611.4 5618.0 5483.7 5604.4 5611.2 5616.0 5616.6 4293.5 4294.4 4304.8 4322.3 4323.3 3855.2 3859.2 3869.7 3900.0 3901.8 5258.8 5357.3 5398.2 5408.8 5410.9 5584.7 5616.4 5617.3 5625.7 5656.3 5350.9 5358.7 5363.2 5365.6 5369.5 4652.2 4755.2 4766.6 4776.8 4792.5 5916.6 5932.2 5933.8 5937.3 5992.3 5680.5 5709.1 5713.5 5718.5 5737.9 5723.0 5763.1 5790.6 5895.9 5902.4 5565.0 5581.4 5581.9 5623.3 5630.4 5636.5 5646.3 5651.5 5652.2 5655.6 5373.2 5464.7 5528.8 5537.0 5542.5 5497.3 5548.4 5548.7 5551.4 5586.2 5496.1 5525.8 5543.6 5549.1 5549.9 5459.6 5530.5 5596.1 5596.3 5644.2 5481.5 5486.6 5488.7 5504.2 5507.9 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#1] ext.html Cycles:180 Average:65590.21 Median:4278.79 stddev:134852.00 (3151.6%) stddev-sans-first:135141.94 21:32:37 INFO - PROCESS | 6321 | Values: 570.1 601.1 609.5 621.5 628.2 42346.6 43598.0 43775.0 43817.8 47957.8 44970.1 45399.5 45435.5 45449.8 45520.0 8952.4 9130.4 9134.2 9134.7 9137.1 8939.4 8999.7 9020.3 9038.1 9046.1 9133.1 9142.6 9166.2 9167.4 9171.0 9064.0 9066.0 9092.0 9100.4 9101.0 8995.4 8996.2 9007.3 9019.8 9067.4 37077.6 37219.3 37355.6 37399.5 37460.0 3438.1 3514.9 3540.5 3575.2 4099.8 33322.2 34190.3 34706.5 35134.0 35242.6 4278.5 4279.1 4291.4 4388.6 4460.6 366977.0 370693.0 372753.0 373279.0 374041.0 48613.0 49008.5 51001.0 55867.4 57977.0 62476.7 62619.0 62721.1 62752.0 62769.4 16709.2 16821.8 16924.6 16930.5 16955.5 11679.9 11986.3 12924.2 13081.0 13111.1 17654.4 17658.0 18070.3 18694.3 18858.8 6498.8 6548.9 6688.9 6691.0 6720.4 976.9 1047.0 1071.4 1102.7 1196.2 32421.4 32664.5 32679.0 33086.0 33124.3 1122.5 1134.8 1151.7 1192.9 1194.3 16759.4 16971.1 17159.0 17186.2 17197.6 552590.0 598745.0 612692.0 612889.0 614475.0 56042.7 56370.2 56806.1 62263.0 62327.0 1189.2 1300.8 1343.5 1345.2 1382.5 29913.4 34166.5 34259.3 34588.5 34605.5 51377.7 55132.4 56380.7 56573.4 61772.4 520680.0 521652.0 524599.0 525243.0 525671.0 35859.6 37171.0 37463.4 39040.8 39325.0 45694.5 48525.8 49383.3 50036.7 50667.5 39019.4 42125.2 42383.4 43415.3 43629.3 41946.9 42615.0 42985.0 42995.6 43795.8 41271.2 42561.1 42665.8 42671.6 42708.6 35961.3 38244.4 38726.0 39114.2 39207.4 28599.3 28769.6 28813.0 28964.1 29214.6 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#2] jquery.html Cycles:180 Average:31027.65 Median:31901.26 stddev:83221.02 (260.9%) stddev-sans-first:83422.68 21:32:37 INFO - PROCESS | 6321 | Values: 388.6 390.9 394.8 399.3 418.6 13107.9 18325.4 18776.5 20363.5 20396.2 17874.0 18187.5 18428.1 18452.2 18704.8 5756.8 5849.4 5885.4 5895.4 5937.5 5688.6 5783.5 5787.7 5798.2 5835.5 4236.1 6221.2 6586.8 6590.5 6591.0 6449.6 6483.9 6534.2 6574.7 6644.4 5847.3 5851.6 5856.6 5867.3 5879.8 23108.4 24181.6 25232.9 25334.9 25363.2 2265.6 2285.6 2320.7 2435.3 2510.5 15761.3 15954.7 16144.5 16340.9 16514.2 1878.5 1939.8 2150.7 2310.3 2364.0 88184.0 89866.6 90405.5 91846.5 96678.5 17356.3 17549.6 17843.6 17846.2 17869.1 31286.0 31646.7 31674.0 31775.7 32026.8 9494.6 9497.1 10153.3 10209.4 10368.6 8454.3 8550.8 8586.1 8727.6 8778.3 8634.8 8826.9 8857.4 8937.6 9034.1 3159.3 3264.7 3395.9 3528.6 3548.9 953.0 974.2 984.5 1007.0 1008.7 19329.8 19631.4 19690.5 19865.1 20006.2 953.9 960.5 963.0 981.2 994.2 10668.6 10842.4 10906.9 10997.8 11051.6 442584.0 447506.0 533037.0 539786.0 546648.0 92709.1 92780.5 93562.1 103982.0 108337.9 993.0 1014.5 1014.6 1034.6 1045.5 15554.5 17138.3 18060.7 18544.0 19079.0 34681.1 38547.4 44065.8 44922.8 45575.0 59042.4 59654.4 59798.7 60519.4 61828.0 8707.3 8893.6 9004.1 9043.4 9106.8 10211.7 12816.3 13547.1 13795.7 14047.6 12061.3 12123.5 12279.9 12525.7 12953.2 12015.6 12040.8 12078.3 12189.5 12411.8 12386.6 12638.7 12649.6 12762.9 12986.2 7728.4 7979.2 8618.2 8799.1 8893.9 12272.4 12422.4 12554.4 12627.6 12684.0 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#3] mootools.html Cycles:180 Average:5741.15 Median:4962.60 stddev:3337.37 (67.3%) stddev-sans-first:3329.90 21:32:37 INFO - PROCESS | 6321 | Values: 1281.8 1290.2 1303.9 1349.8 1741.9 8247.3 8626.2 8649.1 8902.3 8908.9 8620.9 8823.7 8828.5 8837.6 8839.2 2168.5 2196.1 2198.8 2202.4 2205.5 2255.4 2278.2 2308.7 2308.8 2311.5 2276.8 2289.5 2303.9 2304.1 2313.3 2183.4 2191.3 2196.3 2202.1 2208.2 2141.6 2142.3 2143.5 2144.4 2145.4 8521.7 8692.4 8769.6 8854.7 8902.0 5185.9 5276.4 5276.8 5281.0 5284.2 3173.1 3188.9 3205.9 3220.9 3224.6 1065.4 1071.0 1073.5 1091.9 1096.6 12105.6 12179.5 12202.6 12221.3 12231.9 4408.9 4463.8 4592.8 4637.7 4642.4 9712.2 9719.0 9765.7 9786.6 9793.0 5256.1 5291.4 5295.4 5300.6 5308.0 4215.6 4373.3 4815.1 4954.0 4957.7 3830.1 3843.8 3903.5 3926.6 3973.6 1147.1 1152.7 1155.7 1157.7 1165.1 810.2 829.4 871.5 920.5 958.7 5868.2 5873.4 6019.7 6140.7 6300.0 892.8 911.2 932.2 934.8 967.4 3925.7 3932.6 4001.4 4016.9 4065.1 11006.8 11215.5 11241.3 11402.9 11415.5 11169.7 11171.6 11173.6 11183.1 11231.7 7596.9 8189.8 8343.8 8348.5 8379.9 5647.5 5663.3 5809.1 5891.3 5949.1 9706.6 10405.5 10426.1 10442.9 10551.8 9418.5 9926.8 10135.4 10442.3 10445.3 7841.2 7895.2 8066.6 8073.6 8077.8 8465.0 8545.8 8551.8 8554.2 8590.7 7258.2 7527.3 7539.5 7552.0 7685.3 7320.7 7500.9 7507.4 7541.8 7702.6 6731.3 6829.5 6829.9 6830.2 6835.8 4766.8 4865.1 4903.7 4950.3 5025.5 4967.5 5003.6 5003.7 5008.5 5139.6 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#4] prototype.html Cycles:180 Average:4629.35 Median:5306.48 stddev:1364.43 (25.7%) stddev-sans-first:1329.43 21:32:37 INFO - PROCESS | 6321 | Values: 323.3 331.0 332.8 337.6 338.8 5282.0 5286.2 5301.2 5311.8 5347.3 5192.6 5218.9 5252.3 5255.8 5271.5 3962.6 4021.5 4120.2 4128.2 4154.4 4068.9 4096.2 4098.2 4105.0 4110.2 3926.7 4068.4 4072.3 4073.6 4094.3 3803.2 3958.0 4035.9 4067.3 4127.3 3592.2 3610.2 3612.6 3616.6 3659.6 5135.5 5165.0 5166.6 5172.0 5210.2 4555.4 4659.0 4690.1 4691.0 4700.9 5378.0 5396.4 5398.8 5437.0 5457.8 3984.5 4003.7 4007.3 4013.7 4020.7 5342.0 5664.2 5670.3 5675.5 5676.3 3994.1 4006.6 4008.4 4031.8 4041.1 4017.6 4031.3 4049.6 4068.2 4079.4 4525.7 4630.2 4636.7 4704.4 4714.7 5457.9 5489.5 5495.1 5501.4 5520.0 1380.6 1385.2 1386.9 1399.9 1400.6 849.2 893.0 893.7 895.9 909.6 5146.4 5249.6 5267.2 5270.0 5275.9 5539.8 5654.9 5660.7 5663.5 5672.7 5249.8 5352.2 5358.5 5359.2 5389.6 2985.6 3001.8 3004.4 3005.7 3013.2 5758.0 5791.0 5795.3 5812.7 5855.4 5673.4 5746.7 5773.2 5779.6 5812.5 5788.2 5789.7 5815.8 5819.0 5848.9 5448.5 5596.8 5611.3 5613.7 5615.4 5541.4 5543.5 5549.4 5559.6 5590.4 5804.9 5811.5 5821.2 5832.2 5835.2 3959.3 4049.6 4068.8 4080.4 4089.3 5632.3 5675.1 5677.8 5681.4 5709.8 5498.2 5548.3 5584.9 5600.2 5626.4 5285.0 5436.3 5458.5 5469.9 5510.6 5474.9 5476.3 5477.8 5479.6 5512.6 5294.5 5339.9 5511.7 5524.6 5534.5 5366.3 5408.3 5410.6 5415.8 5420.4 21:32:37 INFO - PROCESS | 6321 | 21:32:37 INFO - PROCESS | 6321 | [#5] yui.html Cycles:180 Average:19961.19 Median:54393.27 stddev:30244.51 (55.6%) stddev-sans-first:30294.39 21:32:37 INFO - PROCESS | 6321 | Values: 592.9 604.3 652.1 657.1 667.4 13208.5 13744.5 13762.7 13788.9 13861.2 12048.6 12077.9 12129.7 12310.1 12527.9 648.7 662.3 767.6 775.2 789.4 779.6 793.0 793.6 794.3 794.7 820.6 822.0 822.3 822.3 822.7 670.9 800.7 808.8 818.4 819.4 597.7 599.5 601.1 601.1 601.4 12436.6 12440.8 12441.3 12452.3 12457.9 11379.6 11516.9 11808.0 11982.1 12230.6 11187.3 11318.2 11377.7 11377.9 11583.9 3624.0 4151.7 4171.7 4185.0 4286.2 79538.6 80977.2 81171.0 81219.6 81579.0 9153.1 9556.0 9570.5 9773.2 9893.3 15906.9 16014.5 16084.9 16167.1 16289.8 7203.5 7228.2 7270.0 7289.0 7481.3 4374.3 4381.5 4452.0 4462.5 4544.8 3122.7 3222.8 3234.6 3254.6 3255.9 610.9 611.4 618.6 635.1 650.6 537.9 589.2 604.9 638.2 661.6 8319.3 8415.7 8822.6 8926.2 8957.7 529.4 632.6 645.0 647.3 671.2 4165.7 4260.8 4301.8 4398.5 4432.2 72845.0 114865.4 117212.0 118836.0 118895.0 63371.0 98615.5 99027.5 99660.0 101906.5 89802.0 90380.1 90525.0 92151.0 92517.0 8086.8 8142.7 8277.5 8413.8 9279.6 38312.6 49302.3 51441.0 54286.0 54500.5 79548.6 79854.0 80051.6 80730.6 84389.6 11291.4 11691.9 11826.5 11996.0 12114.3 12480.4 12923.2 12937.5 12968.8 13411.6 7545.8 10904.9 12180.1 12284.2 12464.5 12493.8 12587.6 12621.4 12660.5 12722.8 12323.6 12352.8 12403.7 12861.0 13036.9 9396.0 9486.5 9608.8 9959.3 10282.8 10227.9 10452.6 10541.2 10542.8 10577.7 21:32:37 INFO - PROCESS | 6321 | -------- Summary: end -------- 21:32:37 INFO - PROCESS | 6321 | 21:32:38 INFO - TEST-INFO | 6321: exit 0 21:32:38 INFO - TEST-OK | dromaeo_css | took 1116823ms 21:32:38 INFO - TEST-START | kraken 21:32:38 INFO - operating with platform_type : linux_ 21:32:38 INFO - Initialising browser for kraken test... 21:32:38 INFO - TEST-INFO | started process 6520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPQNRl/profile http://localhost:46353/getInfo.html) 21:32:42 INFO - PROCESS | 6520 | __metrics Screen width/height:1600/1200 21:32:42 INFO - PROCESS | 6520 | colorDepth:24 21:32:42 INFO - PROCESS | 6520 | Browser inner width/height: 1024/697 21:32:42 INFO - PROCESS | 6520 | __metrics 21:32:43 INFO - PROCESS | 6520 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:32:43 INFO - PROCESS | 6520 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:32:44 INFO - TEST-INFO | 6520: exit 0 21:32:44 INFO - Browser initialized. 21:32:44 INFO - Running cycle 1/1 for kraken test... 21:32:44 INFO - TEST-INFO | started process 6604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPQNRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:32:56 INFO - PROCESS | 6604 | RSS: Main: 157245440 21:32:56 INFO - PROCESS | 6604 | 21:32:58 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46353/tests/kraken/driver.html?testName=audio-beat-detection) 21:32:59 INFO - PROCESS | 6604 | RSS: Main: 215289856 21:32:59 INFO - PROCESS | 6604 | 21:33:02 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46353/tests/kraken/driver.html?testName=audio-dft) 21:33:02 INFO - PROCESS | 6604 | RSS: Main: 202870784 21:33:02 INFO - PROCESS | 6604 | 21:33:06 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46353/tests/kraken/driver.html?testName=audio-fft) 21:33:06 INFO - PROCESS | 6604 | RSS: Main: 269508608 21:33:06 INFO - PROCESS | 6604 | 21:33:08 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46353/tests/kraken/driver.html?testName=audio-oscillator) 21:33:09 INFO - PROCESS | 6604 | RSS: Main: 179830784 21:33:09 INFO - PROCESS | 6604 | 21:33:11 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:12 INFO - PROCESS | 6604 | RSS: Main: 184311808 21:33:12 INFO - PROCESS | 6604 | 21:33:15 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46353/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:15 INFO - PROCESS | 6604 | RSS: Main: 220254208 21:33:15 INFO - PROCESS | 6604 | 21:33:19 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46353/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:19 INFO - PROCESS | 6604 | RSS: Main: 221270016 21:33:19 INFO - PROCESS | 6604 | 21:33:22 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46353/tests/kraken/driver.html?testName=json-parse-financial) 21:33:23 INFO - PROCESS | 6604 | RSS: Main: 220925952 21:33:23 INFO - PROCESS | 6604 | 21:33:24 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:33:25 INFO - PROCESS | 6604 | RSS: Main: 207675392 21:33:25 INFO - PROCESS | 6604 | 21:33:27 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:33:27 INFO - PROCESS | 6604 | RSS: Main: 209887232 21:33:27 INFO - PROCESS | 6604 | 21:33:29 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:33:30 INFO - PROCESS | 6604 | RSS: Main: 209498112 21:33:30 INFO - PROCESS | 6604 | 21:33:32 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:33:33 INFO - PROCESS | 6604 | RSS: Main: 223825920 21:33:33 INFO - PROCESS | 6604 | 21:33:36 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:33:36 INFO - PROCESS | 6604 | RSS: Main: 224231424 21:33:36 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | Cycle 1(1): loaded http://localhost:46353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46353/tests/kraken/driver.html?testName=ai-astar) 21:33:38 INFO - PROCESS | 6604 | RSS: Main: 266637312 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | __start_tp_report 21:33:38 INFO - PROCESS | 6604 | _x_x_mozilla_page_load 21:33:38 INFO - PROCESS | 6604 | _x_x_mozilla_page_load_details 21:33:38 INFO - PROCESS | 6604 | |i|pagename|runs| 21:33:38 INFO - PROCESS | 6604 | |0;ai-astar;102;111;111;109;112;111;112;112;112;113 21:33:38 INFO - PROCESS | 6604 | |1;audio-beat-detection;147;120;118;188;117;118;151;117;145;121 21:33:38 INFO - PROCESS | 6604 | |2;audio-dft;162;161;159;159;160;160;158;162;161;161 21:33:38 INFO - PROCESS | 6604 | |3;audio-fft;74;75;74;135;75;76;74;73;102;74 21:33:38 INFO - PROCESS | 6604 | |4;audio-oscillator;84;84;116;84;84;83;111;83;85;130 21:33:38 INFO - PROCESS | 6604 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 21:33:38 INFO - PROCESS | 6604 | |6;imaging-darkroom;146;146;146;146;146;145;145;146;146;145 21:33:38 INFO - PROCESS | 6604 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;96;95 21:33:38 INFO - PROCESS | 6604 | |8;json-parse-financial;54;53;55;57;55;56;56;55;56;54 21:33:38 INFO - PROCESS | 6604 | |9;json-stringify-tinderbox;62;62;63;61;61;62;63;62;61;63 21:33:38 INFO - PROCESS | 6604 | |10;stanford-crypto-aes;75;75;74;75;80;74;83;76;74;75 21:33:38 INFO - PROCESS | 6604 | |11;stanford-crypto-ccm;119;119;126;129;131;119;119;120;163;120 21:33:38 INFO - PROCESS | 6604 | |12;stanford-crypto-pbkdf2;158;159;155;156;156;160;155;158;159;158 21:33:38 INFO - PROCESS | 6604 | |13;stanford-crypto-sha256-iterative;63;63;66;63;62;62;63;61;63;63 21:33:38 INFO - PROCESS | 6604 | __end_tp_report 21:33:38 INFO - PROCESS | 6604 | __start_cc_report 21:33:38 INFO - PROCESS | 6604 | _x_x_mozilla_cycle_collect,1669 21:33:38 INFO - PROCESS | 6604 | __end_cc_report 21:33:38 INFO - PROCESS | 6604 | __startTimestamp1468038818606__endTimestamp 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | ------- Summary: start ------- 21:33:38 INFO - PROCESS | 6604 | Number of tests: 14 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.17 (2.8%) stddev-sans-first:1.13 21:33:38 INFO - PROCESS | 6604 | Values: 102.0 111.0 111.0 109.0 112.0 111.0 112.0 112.0 112.0 113.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:133.00 stddev:23.45 (17.6%) stddev-sans-first:24.41 21:33:38 INFO - PROCESS | 6604 | Values: 147.0 120.0 118.0 188.0 117.0 118.0 151.0 117.0 145.0 121.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.27 21:33:38 INFO - PROCESS | 6604 | Values: 162.0 161.0 159.0 159.0 160.0 160.0 158.0 162.0 161.0 161.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#3] audio-fft Cycles:10 Average:83.20 Median:74.00 stddev:20.18 (27.3%) stddev-sans-first:21.13 21:33:38 INFO - PROCESS | 6604 | Values: 74.0 75.0 74.0 135.0 75.0 76.0 74.0 73.0 102.0 74.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:17.61 (21.0%) stddev-sans-first:18.27 21:33:38 INFO - PROCESS | 6604 | Values: 84.0 84.0 116.0 84.0 84.0 83.0 111.0 83.0 85.0 130.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:33:38 INFO - PROCESS | 6604 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:33:38 INFO - PROCESS | 6604 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:33:38 INFO - PROCESS | 6604 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.20 (2.2%) stddev-sans-first:1.20 21:33:38 INFO - PROCESS | 6604 | Values: 54.0 53.0 55.0 57.0 55.0 56.0 56.0 55.0 56.0 54.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 21:33:38 INFO - PROCESS | 6604 | Values: 62.0 62.0 63.0 61.0 61.0 62.0 63.0 62.0 61.0 63.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:3.00 (4.0%) stddev-sans-first:3.15 21:33:38 INFO - PROCESS | 6604 | Values: 75.0 75.0 74.0 75.0 80.0 74.0 83.0 76.0 74.0 75.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:123.00 stddev:13.62 (11.1%) stddev-sans-first:14.17 21:33:38 INFO - PROCESS | 6604 | Values: 119.0 119.0 126.0 129.0 131.0 119.0 119.0 120.0 163.0 120.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.00 stddev:1.78 (1.1%) stddev-sans-first:1.87 21:33:38 INFO - PROCESS | 6604 | Values: 158.0 159.0 155.0 156.0 156.0 160.0 155.0 158.0 159.0 158.0 21:33:38 INFO - PROCESS | 6604 | 21:33:38 INFO - PROCESS | 6604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 21:33:38 INFO - PROCESS | 6604 | Values: 63.0 63.0 66.0 63.0 62.0 62.0 63.0 61.0 63.0 63.0 21:33:38 INFO - PROCESS | 6604 | -------- Summary: end -------- 21:33:38 INFO - PROCESS | 6604 | 21:33:39 INFO - TEST-INFO | 6604: exit 0 21:33:39 INFO - TEST-OK | kraken | took 60938ms 21:33:39 INFO - SUITE-END | took 1177s 21:33:39 INFO - Completed test suite (00:19:37) 21:33:39 INFO - javascript benchmark 21:33:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.164713880113, 3020.5167173252257, 3027.8486075696223, 3035.3929214157174, 3038.286002789344, 5197.350331208599, 5252.842414727559, 5273.393559740631, 5328.307320048393, 5382.461753824616, 5243.4232234454275, 5244.68531888087, 5250.133727934895, 5271.710055946922, 5317.8404647860625, 4680.929786053221, 4777.952220477786, 4792.353032340624, 4792.353032340642, 4923.236898280755, 4824.300476430933, 4834.202356611155, 4869.123557759602, 4884.535969082949, 4908.361912951312, 4700.694454860423, 4742.19382704941, 4743.407074115718, 4805.038992201574, 4840.878978025542, 4746.762661866927, 4764.547368000034, 4766.070616229837, 4769.642276829217, 4879.243717223836, 4759.643026773006, 4784.712917224978, 4793.976030119862, 4803.807847686088, 4864.878378040542, 5129.666571672829, 5188.5849132069725, 5246.711430871301, 5248.291480650139, 5263.605229607795, 5662.065759149736, 5666.688332141731, 5682.119271512922, 5686.715664216773, 5691.231683722686, 5679.801206957778, 5713.428657134295, 5719.914201286984, 5730.34101078373, 5735.311762588516, 5213.165893457067, 5311.309529761145, 5356.276902618136, 5361.544268737123, 5364.1417373220875, 5783.595148339576, 5840.036393995028, 5845.064789633639, 5845.444682755132, 5846.795362162304, 5597.104463285855, 5609.607327487037, 5614.691191984399, 5616.045272303718, 5619.971900140473, 5554.91667624986, 5563.388027316992, 5610.775568977195, 5615.101583746581, 5689.061304884731, 5606.775728970795, 5607.7476513556985, 5608.214849921014, 5611.410801865827, 5618.016847051749, 5483.698396588226, 5604.355499117572, 5611.242482264842, 5615.971920140373, 5616.5787565932715, 4293.527711951683, 4294.441722576107, 4304.7632380218765, 4322.308430651081, 4323.308270676676, 3855.1904100139286, 3859.2474467479133, 3869.7484663496784, 3899.980500097481, 3901.785401802928, 5258.8159414420315, 5357.303550538405, 5398.1632846908005, 5408.8377348679605, 5410.8917821643345, 5584.720763961785, 5616.382197958222, 5617.32592088952, 5625.690587017753, 5656.264685590929, 5350.91973620396, 5358.678479291255, 5363.168708850135, 5365.6244062916, 5369.48989845964, 4652.162610730101, 4755.167845627071, 4766.642501812378, 4776.761161941889, 4792.520747925179, 5916.585838991229, 5932.169496270526, 5933.792317268875, 5937.346891841894, 5992.280926288873, 5680.460356266148, 5709.143628455765, 5713.514351280188, 5718.542516598745, 5737.91393129095, 5722.971385143048, 5763.106718458645, 5790.623609465371, 5895.911561326498, 5902.4097590240635, 5565.02612042899, 5581.358143813513, 5581.916271255853, 5623.297087864017, 5630.408807075362, 5636.5208957237455, 5646.2942132233475, 5651.463111004448, 5652.180433837153, 5655.604107712586, 5373.247745315581, 5464.699441530754, 5528.778848846001, 5537.0, 5542.501174894279, 5497.340319161726, 5548.361938377138, 5548.667079975215, 5551.444855514416, 5586.190002449704, 5496.148097044965, 5525.751341189736, 5543.611947163821, 5549.084401073777, 5549.889002220014, 5459.590530710292, 5530.5022547970875, 5596.076647353141, 5596.3284405871555, 5644.209810626434, 5481.506664400223, 5486.561075114061, 5488.69812160335, 5504.22940788298, 5507.9449205507435], "value": 5212.049683791703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.0935512535068, 601.0503404620699, 609.4788955443097, 621.496587763911, 628.1802248066277, 42346.57653423465, 43598.0, 43775.0, 43817.78091109544, 47957.760211198896, 44970.1005979881, 45399.546004539945, 45435.54564454354, 45449.77275113628, 45520.0, 8952.418092823962, 9130.406523575979, 9134.17792398684, 9134.725958221265, 9137.131972462605, 8939.374243802937, 8999.685011024616, 9020.2783777298, 9038.141376569216, 9046.050164732707, 9133.132352426543, 9142.634294628207, 9166.175044246016, 9167.358284920057, 9171.0, 9064.00295967443, 9065.954670226673, 9091.954540227323, 9100.362974591748, 9101.0, 8995.370324077317, 8996.235319997808, 9007.279417646638, 9019.774505637346, 9067.410618309788, 37077.629223707685, 37219.25561488755, 37355.626443735484, 37399.50401983917, 37460.0, 3438.054535002869, 3514.912127196815, 3540.4713698040046, 3575.213453040327, 4099.836006559734, 33322.166945826306, 34190.316193675986, 34706.479402808975, 35134.0, 35242.647573524446, 4278.486581610196, 4279.1013887083745, 4291.35629655551, 4388.605025547684, 4460.553944605546, 366977.0, 370693.0, 372753.0, 373279.0, 374041.0, 48613.0, 49008.509914900395, 51001.0, 55867.44132558704, 57977.0, 62476.68761656163, 62619.0, 62721.11836644908, 62752.0, 62769.37230627727, 16709.248083836257, 16821.83178168227, 16924.57688557796, 16930.492085237463, 16955.49133525996, 11679.941600291944, 11986.340751258764, 12924.224546527239, 13081.0, 13111.14777539457, 17654.382096626556, 17658.0, 18070.277188912558, 18694.34569790051, 18858.81141188598, 6498.805035848932, 6548.934510654928, 6688.933110668929, 6690.96654516734, 6720.395164435225, 976.9413835169912, 1046.9895301047045, 1071.3839542263074, 1102.6967583914327, 1196.234409977615, 32421.351572968408, 32664.49737946823, 32679.0, 33086.0, 33124.3375132496, 1122.5060973171778, 1134.7900638381925, 1151.7351009267916, 1192.9164958452998, 1194.2535915053093, 16759.41342053022, 16971.06659133735, 17159.0, 17186.235828796984, 17197.57006074858, 552590.0, 598745.0, 612692.0, 612889.0, 614475.0, 56042.71978640162, 56370.154447683315, 56806.147907781415, 62263.0, 62327.0, 1189.1735244005333, 1300.8048792681172, 1343.4894739998738, 1345.2399394342165, 1382.523029554802, 29913.401731964805, 34166.487502687974, 34259.314813704084, 34588.48117278293, 34605.48091778676, 51377.7431112842, 55132.44867551273, 56380.718096409255, 56573.43426565682, 61772.38227617846, 520680.0, 521652.0, 524599.0, 525243.0, 525671.0, 35859.64140358563, 37171.0, 37463.43804842875, 39040.80479597584, 39325.0, 45694.54305457036, 48525.757371212916, 49383.25925111198, 50036.74981625069, 50667.49332506775, 39019.41470877882, 42125.1574968505, 42383.36424953566, 43415.34876976911, 43629.34555981599, 41946.86903226398, 42615.0, 42985.0, 42995.57004429916, 43795.78102109469, 41271.1745765089, 42561.14877702366, 42665.786671066446, 42671.57328426676, 42708.5729142717, 35961.28077438489, 38244.42633360446, 38726.0, 39114.21771564496, 39207.41188882226, 28599.28501787472, 28769.56845647359, 28813.0, 28964.13107606775, 29214.56178157287], "value": 20698.762537091243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.6366247558533, 390.8671051842373, 394.8321963165654, 399.3111882003544, 418.5939638550605, 13107.92697704556, 18325.358612448552, 18776.530586735338, 20363.49091272719, 20396.184152633912, 17874.0, 18187.545311367223, 18428.07859607021, 18452.169652365643, 18704.81295187051, 5756.769729210827, 5849.356570777211, 5885.352611212763, 5895.43993320636, 5937.52499800015, 5688.63023903445, 5783.479486846183, 5787.652740835542, 5798.217240672498, 5835.5039821615, 4236.1104168124575, 6221.222347206599, 6586.80239592813, 6590.538662293641, 6591.0, 6449.6130232186215, 6483.935160648381, 6534.183227096613, 6574.704138313763, 6644.368784965421, 5847.298324201123, 5851.590388672795, 5856.590038697293, 5867.266591676041, 5879.794207202727, 23108.42228944273, 24181.637275440884, 25232.87383563089, 25334.873325633438, 25363.239102826945, 2265.5770889528044, 2285.645724912641, 2320.6635037919577, 2435.305937807734, 2510.497900419905, 15761.29074191664, 15954.680906381807, 16144.515664530083, 16340.918295408446, 16514.174291285388, 1878.5397577593576, 1939.787632729544, 2150.6773983902385, 2310.3415526575013, 2363.9645405318934, 88184.0, 89866.55066724625, 90405.54797226038, 91846.54076729574, 96678.51660741652, 17356.3057477702, 17549.649007019787, 17843.553911152067, 17846.19692113858, 17869.123742007163, 31286.0, 31646.683533164833, 31674.0, 31775.68224317727, 32026.83986580052, 9494.572744226527, 9497.145256926771, 10153.289269751194, 10209.438480883622, 10368.615218499788, 8454.253020087435, 8550.78623034429, 8586.141385861489, 8727.60725767342, 8778.29773618109, 8634.827303454022, 8826.86759698605, 8857.424267422597, 8937.642494300286, 9034.057677599216, 3159.304952910356, 3264.7061764441314, 3395.8811441599423, 3528.5723551923347, 3548.8757893473603, 953.0374321934896, 974.201155052864, 984.5372674842955, 1007.0282177698409, 1008.6973907827622, 19329.80670193308, 19631.411057668294, 19690.50773730668, 19865.106070226873, 20006.199752009758, 953.9379940303858, 960.514939955332, 962.9855552166723, 981.190517822799, 994.229472159068, 10668.573257069786, 10842.403667798348, 10906.948885742891, 10997.780044399067, 11051.613193538187, 442584.0, 447506.0, 533037.0, 539786.0, 546648.0, 92709.07078543016, 92780.53609731908, 93562.0643793567, 103982.0, 108337.91662083278, 992.9950350248203, 1014.497823577334, 1014.6398028699853, 1034.5603118674533, 1045.5242864496636, 15554.533363999099, 17138.31446742116, 18060.729089063938, 18544.0, 19079.0, 34681.13297167591, 38547.42178867263, 44065.77967110144, 44922.77538612286, 45575.0, 59042.40957590369, 59654.40345596662, 59798.70100649469, 60519.39480605314, 61828.0, 8707.25988290977, 8893.599788009426, 9004.099590040943, 9043.366964312436, 9106.772330691785, 10211.73224568131, 12816.295103769382, 13547.119437236548, 13795.655108622364, 14047.648808779863, 12061.276323420272, 12123.515059397525, 12279.938600306941, 12525.74948501043, 12953.158044727063, 12015.639530814089, 12040.819387709016, 12078.27530348182, 12189.451474683483, 12411.75176496483, 12386.62840114798, 12638.747225055631, 12649.557265495663, 12762.936185319015, 12986.220826750425, 7728.381729461742, 7979.162187970412, 8618.181272779077, 8799.12008799115, 8893.866592001255, 12272.447739851907, 12422.37888105609, 12554.435050422935, 12627.621171364874, 12684.0], "value": 10301.914024317339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.7500587385462, 1290.2452065541654, 1303.86309437509, 1349.8245228120343, 1741.9216135273903, 8247.340212782978, 8626.22363987241, 8649.09184535624, 8902.287816974642, 8908.910910890889, 8620.913790862089, 8823.735287941372, 8828.51443170627, 8837.602307896144, 8839.160279773427, 2168.4687251623373, 2196.077647388101, 2198.8021078102965, 2202.41635966469, 2205.547862688153, 2255.357223191391, 2278.2481781012307, 2308.676785250058, 2308.8499247548857, 2311.456807650201, 2276.8064714499205, 2289.5306462175213, 2303.9193628223015, 2304.124432715574, 2313.3406979010983, 2183.3559100065518, 2191.3206905859233, 2196.3191410662666, 2202.1411649456722, 2208.2491952735986, 2141.550274442369, 2142.3251675722254, 2143.474848662072, 2144.356692992096, 2145.410012246629, 8521.659133634646, 8692.43499172558, 8769.561521923943, 8854.734357969206, 8902.0, 5185.870353241199, 5276.366835979707, 5276.841694749163, 5281.0, 5284.207368894658, 3173.0956677346844, 3188.872445102193, 3205.871765129392, 3220.855061522237, 3224.564683767685, 1065.3661071662348, 1070.9625163119254, 1073.538378497246, 1091.8744344400416, 1096.6216655253925, 12105.636830895088, 12179.4519246635, 12202.633920982385, 12221.266723996589, 12231.938840305831, 4408.889777755582, 4463.776811159494, 4592.816287348469, 4637.675362724577, 4642.3500709900645, 9712.223022158352, 9718.95140524307, 9765.658201963039, 9786.5596048178, 9793.0, 5256.053910296183, 5291.417944026154, 5295.364556253275, 5300.628955973122, 5308.044551980681, 4215.641670458045, 4373.300271956472, 4815.085133824562, 4954.033963377179, 4957.677750946177, 3830.0616348994677, 3843.807809609564, 3903.531576210816, 3926.6466018058513, 3973.642372186517, 1147.0536807134147, 1152.6714886257544, 1155.6995181252935, 1157.745296034871, 1165.1086918507349, 810.1776696652902, 829.3738227638095, 871.5424402188775, 920.4661296448178, 958.6548842416724, 5868.23712917318, 5873.353931067579, 6019.729112189962, 6140.662263575547, 6300.0, 892.8258989497116, 911.2163539356148, 932.1843387036344, 934.7849994501166, 967.4195482710318, 3925.725199236083, 3932.6264004919485, 4001.419794129835, 4016.879493615196, 4065.10567675111, 11006.779864402828, 11215.495302711397, 11241.325520468798, 11402.885971140182, 11415.543378264943, 11169.664910052712, 11171.608993685344, 11173.553057877756, 11183.105351571854, 11231.71920701989, 7596.924030759732, 8189.836203275901, 8343.791405214919, 8348.457350272212, 8379.916200837913, 5647.5481961442165, 5663.292088488939, 5809.128630705428, 5891.293044834647, 5949.1076338549565, 9706.56320465595, 10405.47972601382, 10426.113780328757, 10442.947785261025, 10551.788964220827, 9418.529073546433, 9926.751831204278, 10135.391876487434, 10442.269041167045, 10445.268831181744, 7841.215878412113, 7895.249951254622, 8066.637001335072, 8073.5963201838495, 8077.7576672699915, 8465.0, 8545.786355341166, 8551.759994800843, 8554.230119289045, 8590.699325523827, 7258.201597824341, 7527.322540971339, 7539.47223694358, 7551.962240188984, 7685.308322251024, 7320.707171713072, 7500.887486687813, 7507.436942229246, 7541.773746787605, 7702.5763583001235, 6731.32686731323, 6829.52193346461, 6829.89755153683, 6830.214525329452, 6835.7949261522235, 4766.761661916821, 4865.099956508057, 4903.705777653352, 4950.306957025947, 5025.497450254945, 4967.528084831935, 5003.649744517995, 5003.674761140514, 5008.499150084962, 5139.563137133386], "value": 4535.423883782392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.2984423800353, 330.9851056702448, 332.84023668639054, 337.5577992829395, 338.84413169941826, 5281.973590132054, 5286.2334961430615, 5301.1783173608155, 5311.78752849886, 5347.304850369446, 5192.636515443921, 5218.895622087556, 5252.343457067866, 5255.789768409259, 5271.472852714726, 3962.62355076268, 4021.457103291062, 4120.187117668232, 4128.195001974616, 4154.43915071466, 4068.9186216275657, 4096.180763847227, 4098.180363927211, 4105.0, 4110.239605672945, 3926.7447615905016, 4068.3694027425795, 4072.3484242521204, 4073.572274911136, 4094.263032654121, 3803.2013277211818, 3957.960420395788, 4035.919281614366, 4067.3085575451946, 4127.2983592789, 3592.1558433768046, 3610.2418492116685, 3612.6026137124895, 3616.6383361663884, 3659.6157403472516, 5135.483613029626, 5164.974175129138, 5166.560842328407, 5171.965606878639, 5210.218467229908, 4555.362249285103, 4658.998315362213, 4690.132325519789, 4691.0, 4700.9059818803435, 5378.005069062236, 5396.381085674321, 5398.757055932453, 5436.972815135899, 5457.836264912059, 3984.5218573771044, 4003.719739618228, 4007.2786898358286, 4013.71561100448, 4020.698447616411, 5342.0, 5664.178694089375, 5670.319561652628, 5675.489205971441, 5676.2620859288445, 3994.08136128692, 4006.579309172553, 4008.3586626139677, 4031.7580945143386, 4041.1109555897656, 4017.634004438505, 4031.254217969685, 4049.635532802062, 4068.247374235776, 4079.449274347925, 4525.705829121097, 4630.236011058138, 4636.721796692209, 4704.411948506437, 4714.693544919569, 5457.945420545744, 5489.533389661844, 5495.120780675153, 5501.394846566875, 5519.972400137974, 1380.6134282400944, 1385.1758203868683, 1386.9167849928835, 1399.930003499821, 1400.6358346829898, 849.1847826087026, 892.9642814287356, 893.6916763716507, 895.8521843895684, 909.5906841921162, 5146.356705411824, 5249.632525723163, 5267.209918512177, 5269.973650131725, 5275.894482110336, 5539.806106786243, 5654.886902261932, 5660.745266463019, 5663.490285874291, 5672.744726487318, 5249.790008399621, 5352.223927530564, 5358.54452371545, 5359.22291267764, 5389.56883449331, 2985.6417229932113, 3001.8198908065588, 3004.3690824926575, 3005.72256790863, 3013.2165636934556, 5757.971210144006, 5790.971045144832, 5795.275590551181, 5812.738426770806, 5855.443732845373, 5673.404292549306, 5746.683932383676, 5773.220615216892, 5779.595428319977, 5812.534997200214, 5788.21859049023, 5789.739461724233, 5815.79644712433, 5818.970905145447, 5848.941510584839, 5448.536874365724, 5596.776128954959, 5611.326640802967, 5613.719314034201, 5615.354234263112, 5541.445855414427, 5543.473370029841, 5549.361823390362, 5559.610827242054, 5590.44095590454, 5804.941950580609, 5811.53507719373, 5821.185034095145, 5832.24180856486, 5835.183074369506, 3959.346707793182, 4049.635532802062, 4068.7762173080764, 4080.3879418086335, 4089.2843752343815, 5632.295963004624, 5675.148727690879, 5677.77288908439, 5681.375048744718, 5709.800156994652, 5498.230247765236, 5548.278723765885, 5584.888302233851, 5600.215969764155, 5626.43735626434, 5284.987557092574, 5436.3147424298595, 5458.454154584669, 5469.863253418696, 5510.641808282448, 5474.8905021898545, 5476.2607048048, 5477.835664930059, 5479.589030822784, 5512.586556008235, 5294.549963253013, 5339.919901201562, 5511.740186523506, 5524.618845288678, 5534.52956498686, 5366.329208848894, 5408.323959505062, 5410.61932749589, 5415.810446634349, 5420.4037555868035], "value": 4191.0726738387275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.9347771745105, 604.314103492536, 652.1326635574685, 657.0505619379998, 667.4360165660015, 13208.537701180461, 13744.518941837037, 13762.72474550511, 13788.931055344721, 13861.23763193024, 12048.57829975951, 12077.879221207786, 12129.696757581065, 12310.138290319659, 12527.874721252807, 648.7210499485219, 662.3244290823358, 767.5970115689266, 775.1550809617515, 789.3921680306161, 779.5517577393022, 793.020619534874, 793.5516433215244, 794.3248238996864, 794.6741835847304, 820.5856042698429, 821.954792486416, 822.251750906675, 822.2887202569764, 822.6997146041682, 670.9228438729535, 800.6877317846045, 808.7816289601775, 818.382121498268, 819.3690858039306, 597.6623207887529, 599.4964230046781, 601.1253625974197, 601.1313651773189, 601.4226342711003, 12436.626901192978, 12440.81338779919, 12441.253524788543, 12452.31512266825, 12457.93771031148, 11379.601713939972, 11516.884831151665, 11808.0, 11982.101342399355, 12230.571929982498, 11187.32876027441, 11318.20772545922, 11377.658670239905, 11377.886221137765, 11583.94208028963, 3624.0282123085626, 4151.6886233532305, 4171.666266698687, 4185.0, 4286.185624731291, 79538.60230698809, 80977.19022809755, 81171.0, 81219.5939020307, 81579.0, 9153.130452606993, 9555.952220238854, 9570.473623950611, 9773.169280611086, 9893.258005649604, 15906.9204653976, 16014.519564413085, 16084.919575402047, 16167.110808905389, 16289.755653665205, 7203.459740519482, 7228.241034691387, 7270.0, 7288.979542864004, 7481.251874812584, 4374.321980093091, 4381.496127945264, 4451.9554804451545, 4462.464504259509, 4544.795484203219, 3122.7189552940345, 3222.8066316021113, 3234.5956755405573, 3254.6419893811662, 3255.918602034968, 610.8533951851524, 611.3672349118641, 618.6164577961603, 635.0569404434411, 650.6453982579411, 537.8547792096113, 589.19280585598, 604.9122877182784, 638.1958731997717, 661.576590981772, 8319.251267385844, 8415.663373464993, 8822.647094116292, 8926.24257354003, 8957.731268061969, 529.4414392815617, 632.5540493951753, 644.9613023218621, 647.2750519418281, 671.1677519875417, 4165.66674666026, 4260.829566817354, 4301.849435269751, 4398.450193725785, 4432.224360736858, 72845.0, 114865.4256728711, 117212.0, 118836.0, 118895.0, 63371.0, 98615.50692246636, 99027.50486247666, 99660.0, 101906.49046754868, 89802.0, 90380.09619903717, 90524.99999999868, 92151.0, 92517.0, 8086.757397278091, 8142.715004974797, 8277.4619649725, 8413.789655258668, 9279.582418791306, 38312.616873830906, 49302.26046609376, 51441.0, 54286.0, 54500.54994500518, 79548.60225698835, 79854.0, 80051.59974200092, 80730.59634701788, 84389.57805210934, 11291.43542822872, 11691.883081169419, 11826.526938922347, 11996.040316774812, 12114.273143611412, 12480.438380272728, 12923.15999460032, 12937.482500699867, 12968.8054679178, 13411.597652070453, 7545.811354716176, 10904.945475272572, 12180.086493512845, 12284.201526900722, 12464.5014199431, 12493.75012499763, 12587.559435419716, 12621.368931553201, 12660.493580256687, 12722.809157862454, 12323.630291091282, 12352.814707779571, 12403.689907752378, 12861.0, 13036.869631303945, 9396.0, 9486.478243696663, 9608.75978100553, 9959.253056020683, 10282.840478768267, 10227.897721022991, 10452.581896724047, 10541.20940929418, 10542.789144217226, 10577.735556611146], "value": 6901.744959070078, "unit": "score"}], "name": "dromaeo_css", "value": 7254.994201349599, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 109.0, 112.0, 111.0, 112.0, 112.0, 112.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 118.0, 188.0, 117.0, 118.0, 151.0, 117.0, 145.0, 121.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 159.0, 160.0, 160.0, 158.0, 162.0, 161.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 135.0, 75.0, 76.0, 74.0, 73.0, 102.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 84.0, 83.0, 111.0, 83.0, 85.0, 130.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 57.0, 55.0, 56.0, 56.0, 55.0, 56.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 61.0, 62.0, 63.0, 62.0, 61.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 75.0, 80.0, 74.0, 83.0, 76.0, 74.0, 75.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 126.0, 129.0, 131.0, 119.0, 119.0, 120.0, 163.0, 120.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 155.0, 156.0, 156.0, 160.0, 155.0, 158.0, 159.0, 158.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 63.0, 62.0, 62.0, 63.0, 61.0, 63.0, 63.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1480.7000000000003, "alertThreshold": 2.0}]} 21:33:39 INFO - Return code: 0 21:33:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:33:39 INFO - # TBPL SUCCESS # 21:33:39 INFO - Running post-action listener: _resource_record_post_action 21:33:39 INFO - ##### 21:33:39 INFO - ##### Finished run-tests step (success) 21:33:39 INFO - ##### 21:33:39 INFO - Running post-run listener: _resource_record_post_run 21:33:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 532480; Write bytes: 307171328; Read time: 92; Write time: 285672 21:33:39 INFO - TinderboxPrint: CPU usage
13.0% 21:33:39 INFO - TinderboxPrint: I/O read bytes / time
532,480 / 92 21:33:39 INFO - TinderboxPrint: I/O write bytes / time
307,171,328 / 285,672 21:33:39 INFO - TinderboxPrint: CPU idle
8,297.8 (87.0%) 21:33:39 INFO - TinderboxPrint: CPU user
1,194.2 (12.5%) 21:33:39 INFO - TinderboxPrint: Swap in / out
0 / 0 21:33:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13926400; Read time: 0; Write time: 3424 21:33:40 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 528384; Write bytes: 293244928; Read time: 84; Write time: 282248 21:33:40 INFO - Running post-run listener: _upload_blobber_files 21:33:40 INFO - Blob upload gear active. 21:33:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:33:40 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 21:33:40 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:33:40 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 21:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:41 INFO - (blobuploader) - INFO - Done attempting. 21:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:42 INFO - (blobuploader) - INFO - Done attempting. 21:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:45 INFO - (blobuploader) - INFO - Done attempting. 21:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 21:33:45 INFO - Return code: 0 21:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a77d3855e88d76ae443cafcd91bd2da4a6f9a165a3c10840ab971c8c5330777d96d200a071168e1eccea68c3b533f9b11f5fc2b4c4a10c7e66e774e4ee0f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9fb3b3f652cecaae60d53b4215f81552f3e45a96a1ff8fa17ec772e9a392e392928f348b6a67a268190db9ce273e0f1550619bb5c6ea64e99bc87d2f9d3007ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a99fcaaab7e199ea3545c682d48092929a5deddec16dada93cacae343e5c2471803c23fca4a7216fadecbba6bfd5b3ecae8f434b93400027196b5b1b87c07f8"} 21:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:33:45 INFO - Contents: 21:33:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a77d3855e88d76ae443cafcd91bd2da4a6f9a165a3c10840ab971c8c5330777d96d200a071168e1eccea68c3b533f9b11f5fc2b4c4a10c7e66e774e4ee0f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9fb3b3f652cecaae60d53b4215f81552f3e45a96a1ff8fa17ec772e9a392e392928f348b6a67a268190db9ce273e0f1550619bb5c6ea64e99bc87d2f9d3007ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a99fcaaab7e199ea3545c682d48092929a5deddec16dada93cacae343e5c2471803c23fca4a7216fadecbba6bfd5b3ecae8f434b93400027196b5b1b87c07f8"} 21:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 21:33:45 INFO - Copying logs to upload dir... 21:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 21:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.537013 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-08 21:33:45.651568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 21:33:45.655100) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a77d3855e88d76ae443cafcd91bd2da4a6f9a165a3c10840ab971c8c5330777d96d200a071168e1eccea68c3b533f9b11f5fc2b4c4a10c7e66e774e4ee0f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9fb3b3f652cecaae60d53b4215f81552f3e45a96a1ff8fa17ec772e9a392e392928f348b6a67a268190db9ce273e0f1550619bb5c6ea64e99bc87d2f9d3007ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a99fcaaab7e199ea3545c682d48092929a5deddec16dada93cacae343e5c2471803c23fca4a7216fadecbba6bfd5b3ecae8f434b93400027196b5b1b87c07f8"} build_url:https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a77d3855e88d76ae443cafcd91bd2da4a6f9a165a3c10840ab971c8c5330777d96d200a071168e1eccea68c3b533f9b11f5fc2b4c4a10c7e66e774e4ee0f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9fb3b3f652cecaae60d53b4215f81552f3e45a96a1ff8fa17ec772e9a392e392928f348b6a67a268190db9ce273e0f1550619bb5c6ea64e99bc87d2f9d3007ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a99fcaaab7e199ea3545c682d48092929a5deddec16dada93cacae343e5c2471803c23fca4a7216fadecbba6bfd5b3ecae8f434b93400027196b5b1b87c07f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 21:33:45.680893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:33:45.681232) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468036633.796110-1617047248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:33:45.763440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 21:33:45.763797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 21:33:45.764109) ========= ========= Total master_lag: 1.20 =========