builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1467785493.23 results: success (0) buildid: 20160705203035 builduid: 7dd269baf9164a7e8e03346a5c8413c8 revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.227767) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.228170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.228442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.313001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.313309) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 23:11:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.2M=0s 2016-07-05 23:11:33 (87.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202929 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.577956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.578280) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.627958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.628376) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 23:11:33,695 truncating revision to first 12 chars 2016-07-05 23:11:33,695 Setting DEBUG logging. 2016-07-05 23:11:33,696 attempt 1/10 2016-07-05 23:11:33,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8fa10d0a52e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 23:11:33,994 unpacking tar archive at: fx-team-d8fa10d0a52e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.275927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.276285) ========= script_repo_revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.276714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.276982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.290199) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-05 23:11:34.290593) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:11:34 INFO - MultiFileLogger online at 20160705 23:11:34 in /builds/slave/test 23:11:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:11:34 INFO - {'append_to_log': False, 23:11:34 INFO - 'base_work_dir': '/builds/slave/test', 23:11:34 INFO - 'blob_upload_branch': 'Fx-Team', 23:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:11:34 INFO - 'branch': 'Fx-Team', 23:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:11:34 INFO - 'config_files': ('talos/linux_config.py',), 23:11:34 INFO - 'default_actions': ('clobber', 23:11:34 INFO - 'read-buildbot-config', 23:11:34 INFO - 'download-and-extract', 23:11:34 INFO - 'populate-webroot', 23:11:34 INFO - 'create-virtualenv', 23:11:34 INFO - 'install', 23:11:34 INFO - 'run-tests'), 23:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:11:34 INFO - 'download_minidump_stackwalk': True, 23:11:34 INFO - 'download_symbols': 'ondemand', 23:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:11:34 INFO - 'installer_path': 'installer.exe', 23:11:34 INFO - 'log_level': 'info', 23:11:34 INFO - 'log_name': 'talos', 23:11:34 INFO - 'log_to_console': True, 23:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:11:34 INFO - 'opt_config_files': (), 23:11:34 INFO - 'pip_index': False, 23:11:34 INFO - 'sps_profile': False, 23:11:34 INFO - 'sps_profile_interval': 0, 23:11:34 INFO - 'suite': 'dromaeojs', 23:11:34 INFO - 'system_bits': '32', 23:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:11:34 INFO - 'title': 'talos-linux64-ix-022', 23:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:11:34 INFO - 'use_talos_json': True, 23:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:11:34 INFO - 'work_dir': 'build'} 23:11:34 INFO - ##### 23:11:34 INFO - ##### Running clobber step. 23:11:34 INFO - ##### 23:11:34 INFO - Running pre-action listener: _resource_record_pre_action 23:11:34 INFO - Running main action method: clobber 23:11:34 INFO - rmtree: /builds/slave/test/build 23:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:11:34 INFO - Running post-action listener: _resource_record_post_action 23:11:34 INFO - ##### 23:11:34 INFO - ##### Finished clobber step (success) 23:11:34 INFO - ##### 23:11:34 INFO - ##### 23:11:34 INFO - ##### Running read-buildbot-config step. 23:11:34 INFO - ##### 23:11:34 INFO - Running pre-action listener: _resource_record_pre_action 23:11:34 INFO - Running main action method: read_buildbot_config 23:11:34 INFO - Using buildbot properties: 23:11:34 INFO - { 23:11:34 INFO - "project": "", 23:11:34 INFO - "product": "firefox", 23:11:34 INFO - "script_repo_revision": "production", 23:11:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:11:34 INFO - "repository": "", 23:11:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:11:34 INFO - "buildid": "20160705203035", 23:11:34 INFO - "pgo_build": "True", 23:11:34 INFO - "basedir": "/builds/slave/test", 23:11:34 INFO - "buildnumber": 1306, 23:11:34 INFO - "slavename": "talos-linux64-ix-022", 23:11:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:11:34 INFO - "platform": "ubuntu64_hw", 23:11:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:11:34 INFO - "branch": "fx-team", 23:11:34 INFO - "repo_path": "integration/fx-team", 23:11:34 INFO - "revision": "d8fa10d0a52eb52ee1fc46f88c37662c71af37a6", 23:11:34 INFO - "stage_platform": "linux64-pgo", 23:11:34 INFO - "builduid": "7dd269baf9164a7e8e03346a5c8413c8", 23:11:34 INFO - "slavebuilddir": "test" 23:11:34 INFO - } 23:11:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:11:34 INFO - Running post-action listener: _resource_record_post_action 23:11:34 INFO - ##### 23:11:34 INFO - ##### Finished read-buildbot-config step (success) 23:11:34 INFO - ##### 23:11:34 INFO - ##### 23:11:34 INFO - ##### Running download-and-extract step. 23:11:34 INFO - ##### 23:11:34 INFO - Running pre-action listener: _resource_record_pre_action 23:11:34 INFO - Running main action method: download_and_extract 23:11:34 INFO - mkdir: /builds/slave/test/build/tests 23:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:34 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:43 INFO - Downloaded 1361 bytes. 23:11:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:43 INFO - Using the following test package requirements: 23:11:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:11:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:11:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:11:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'jsshell-linux-x86_64.zip'], 23:11:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:11:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:11:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:11:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:11:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:11:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:11:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:11: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')]} 23:11:43 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:45 INFO - Downloaded 24300608 bytes. 23:11:45 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'] 23:11:45 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 23:11:47 INFO - Return code: 0 23:11:47 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 23:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:47 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:57 INFO - Downloaded 24300608 bytes. 23:11:57 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'] 23:11:57 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 23:11:59 INFO - Return code: 0 23:11:59 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')]} 23:11:59 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:12:01 INFO - Downloaded 14403333 bytes. 23:12:01 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'] 23:12:01 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 23:12:01 INFO - Return code: 0 23:12: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')]} 23:12:01 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:12:03 INFO - Downloaded 60337068 bytes. 23:12:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:12:03 INFO - mkdir: /builds/slave/test/properties 23:12:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:12:03 INFO - Writing to file /builds/slave/test/properties/build_url 23:12:03 INFO - Contents: 23:12:03 INFO - build_url:https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:12:04 INFO - Running post-action listener: _resource_record_post_action 23:12:04 INFO - Running post-action listener: set_extra_try_arguments 23:12:04 INFO - ##### 23:12:04 INFO - ##### Finished download-and-extract step (success) 23:12:04 INFO - ##### 23:12:04 INFO - ##### 23:12:04 INFO - ##### Running populate-webroot step. 23:12:04 INFO - ##### 23:12:04 INFO - Running pre-action listener: _resource_record_pre_action 23:12:04 INFO - Running main action method: populate_webroot 23:12:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:12:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:12:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:12:04 INFO - '--tppagecycles', 23:12:04 INFO - '7'], 23:12:04 INFO - 'tests': ['tsvgm']}}, 23:12:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:12:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:12:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:12:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:12:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['damp', 'tps']}, 23:12:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'tests': ['damp', 'tps']}, 23:12:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['dromaeo_dom']}, 23:12:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:12:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['basic_compositor_video']}, 23:12:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:12:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'other-e10s': {'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['a11yr', 23:12:04 INFO - 'ts_paint', 23:12:04 INFO - 'tpaint', 23:12:04 INFO - 'sessionrestore', 23:12:04 INFO - 'sessionrestore_no_auto_restore', 23:12:04 INFO - 'tabpaint']}, 23:12:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['tsvgx', 23:12:04 INFO - 'tsvgr_opacity', 23:12:04 INFO - 'tart', 23:12:04 INFO - 'tscrollx', 23:12:04 INFO - 'cart']}, 23:12:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:12:04 INFO - 'tsvgr_opacity', 23:12:04 INFO - 'tart', 23:12:04 INFO - 'tscrollx', 23:12:04 INFO - 'cart']}, 23:12:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'talos_options': ['--disable-e10s'], 23:12:04 INFO - 'tests': ['tp5o']}, 23:12:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'tests': ['tp5o']}, 23:12:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'talos_options': ['--disable-e10s', 23:12:04 INFO - '--xperf_path', 23:12:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:04 INFO - 'tests': ['tp5n']}, 23:12:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:04 INFO - 'talos_options': ['--xperf_path', 23:12:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:04 INFO - 'tests': ['tp5n']}}, 23:12:04 INFO - 'talos.zip': {'path': '', 23:12:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:12:04 INFO - Running post-action listener: _resource_record_post_action 23:12:04 INFO - ##### 23:12:04 INFO - ##### Finished populate-webroot step (success) 23:12:04 INFO - ##### 23:12:04 INFO - ##### 23:12:04 INFO - ##### Running create-virtualenv step. 23:12:04 INFO - ##### 23:12:04 INFO - Running pre-action listener: _resource_record_pre_action 23:12:04 INFO - Running main action method: create_virtualenv 23:12:04 INFO - Creating virtualenv /builds/slave/test/build/venv 23:12:04 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 23:12:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:12:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:12:04 INFO - Using real prefix '/usr' 23:12:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:12:05 INFO - Installing distribute.............................................................................................................................................................................................done. 23:12:07 INFO - Installing pip.................done. 23:12:07 INFO - Return code: 0 23:12:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:07 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 23:12:07 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 23:12:07 INFO - Using env: {'DISPLAY': ':0', 23:12:07 INFO - 'HOME': '/home/cltbld', 23:12:07 INFO - 'LANG': 'en_US.UTF-8', 23:12:07 INFO - 'LANGUAGE': 'en_US:en', 23:12:07 INFO - 'LOGNAME': 'cltbld', 23:12:07 INFO - 'MAIL': '/var/mail/cltbld', 23:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:07 INFO - 'MOZ_NO_REMOTE': '1', 23:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:07 INFO - 'NO_EM_RESTART': '1', 23:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:07 INFO - 'PWD': '/builds/slave/test', 23:12:07 INFO - 'SHELL': '/bin/bash', 23:12:07 INFO - 'SHLVL': '1', 23:12:07 INFO - 'TERM': 'linux', 23:12:07 INFO - 'TMOUT': '86400', 23:12:07 INFO - 'USER': 'cltbld', 23:12:07 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:07 INFO - '_': '/tools/buildbot/bin/python'} 23:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:08 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 23:12:08 INFO - Cleaning up... 23:12:08 INFO - Return code: 0 23:12:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:08 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:08 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 23:12:08 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 23:12:08 INFO - Using env: {'DISPLAY': ':0', 23:12:08 INFO - 'HOME': '/home/cltbld', 23:12:08 INFO - 'LANG': 'en_US.UTF-8', 23:12:08 INFO - 'LANGUAGE': 'en_US:en', 23:12:08 INFO - 'LOGNAME': 'cltbld', 23:12:08 INFO - 'MAIL': '/var/mail/cltbld', 23:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:08 INFO - 'MOZ_NO_REMOTE': '1', 23:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:08 INFO - 'NO_EM_RESTART': '1', 23:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:08 INFO - 'PWD': '/builds/slave/test', 23:12:08 INFO - 'SHELL': '/bin/bash', 23:12:08 INFO - 'SHLVL': '1', 23:12:08 INFO - 'TERM': 'linux', 23:12:08 INFO - 'TMOUT': '86400', 23:12:08 INFO - 'USER': 'cltbld', 23:12:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:08 INFO - '_': '/tools/buildbot/bin/python'} 23:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:08 INFO - Downloading/unpacking psutil>=3.1.1 23:12:08 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 23:12:08 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 23:12:08 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 23:12:08 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 23:12:08 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 23:12:08 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 23:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:12:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:10 INFO - Installing collected packages: psutil 23:12:10 INFO - Running setup.py install for psutil 23:12:10 INFO - building 'psutil._psutil_linux' extension 23:12:10 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 23:12:11 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 23:12:12 INFO - building 'psutil._psutil_posix' extension 23:12:12 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 23:12:12 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 23:12:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:12 INFO - Successfully installed psutil 23:12:12 INFO - Cleaning up... 23:12:12 INFO - Return code: 0 23:12:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:12: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')]} 23:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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')]} 23:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:12 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:12 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 23:12:12 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 23:12:12 INFO - Using env: {'DISPLAY': ':0', 23:12:12 INFO - 'HOME': '/home/cltbld', 23:12:12 INFO - 'LANG': 'en_US.UTF-8', 23:12:12 INFO - 'LANGUAGE': 'en_US:en', 23:12:12 INFO - 'LOGNAME': 'cltbld', 23:12:12 INFO - 'MAIL': '/var/mail/cltbld', 23:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:12 INFO - 'MOZ_NO_REMOTE': '1', 23:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:12 INFO - 'NO_EM_RESTART': '1', 23:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:12 INFO - 'PWD': '/builds/slave/test', 23:12:12 INFO - 'SHELL': '/bin/bash', 23:12:12 INFO - 'SHLVL': '1', 23:12:12 INFO - 'TERM': 'linux', 23:12:12 INFO - 'TMOUT': '86400', 23:12:12 INFO - 'USER': 'cltbld', 23:12:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:12 INFO - '_': '/tools/buildbot/bin/python'} 23:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:12:12 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 23:12:12 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 23:12:12 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 23:12:12 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 23:12:12 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 23:12:12 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 23:12:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:12:14 INFO - Installing collected packages: mozsystemmonitor 23:12:14 INFO - Running setup.py install for mozsystemmonitor 23:12:14 INFO - Successfully installed mozsystemmonitor 23:12:14 INFO - Cleaning up... 23:12:14 INFO - Return code: 0 23:12:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:12:14 INFO - Using env: {'DISPLAY': ':0', 23:12:14 INFO - 'HOME': '/home/cltbld', 23:12:14 INFO - 'LANG': 'en_US.UTF-8', 23:12:14 INFO - 'LANGUAGE': 'en_US:en', 23:12:14 INFO - 'LOGNAME': 'cltbld', 23:12:14 INFO - 'MAIL': '/var/mail/cltbld', 23:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:14 INFO - 'MOZ_NO_REMOTE': '1', 23:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:14 INFO - 'NO_EM_RESTART': '1', 23:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:14 INFO - 'PWD': '/builds/slave/test', 23:12:14 INFO - 'SHELL': '/bin/bash', 23:12:14 INFO - 'SHLVL': '1', 23:12:14 INFO - 'TERM': 'linux', 23:12:14 INFO - 'TMOUT': '86400', 23:12:14 INFO - 'USER': 'cltbld', 23:12:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:14 INFO - '_': '/tools/buildbot/bin/python'} 23:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:14 INFO - Downloading/unpacking jsonschema==2.5.1 23:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:12:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:12:16 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 23:12:16 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 23:12:16 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 23:12:16 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 23:12:16 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 23:12:16 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 23:12:17 INFO - Downloading functools32-3.2.3-2.tar.gz 23:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:12:17 INFO - warning: no files found matching '*.txt' 23:12:17 INFO - no previously-included directories found matching 'build' 23:12:17 INFO - no previously-included directories found matching 'dist' 23:12:17 INFO - no previously-included directories found matching '.git*' 23:12:17 INFO - Installing collected packages: jsonschema, functools32 23:12:17 INFO - Running setup.py install for functools32 23:12:17 INFO - warning: no files found matching '*.txt' 23:12:17 INFO - no previously-included directories found matching 'build' 23:12:17 INFO - no previously-included directories found matching 'dist' 23:12:17 INFO - no previously-included directories found matching '.git*' 23:12:17 INFO - Successfully installed jsonschema functools32 23:12:17 INFO - Cleaning up... 23:12:17 INFO - Return code: 0 23:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:12: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')]} 23:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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')]} 23:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:12:17 INFO - Using env: {'DISPLAY': ':0', 23:12:17 INFO - 'HOME': '/home/cltbld', 23:12:17 INFO - 'LANG': 'en_US.UTF-8', 23:12:17 INFO - 'LANGUAGE': 'en_US:en', 23:12:17 INFO - 'LOGNAME': 'cltbld', 23:12:17 INFO - 'MAIL': '/var/mail/cltbld', 23:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:17 INFO - 'MOZ_NO_REMOTE': '1', 23:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:17 INFO - 'NO_EM_RESTART': '1', 23:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:17 INFO - 'PWD': '/builds/slave/test', 23:12:17 INFO - 'SHELL': '/bin/bash', 23:12:17 INFO - 'SHLVL': '1', 23:12:17 INFO - 'TERM': 'linux', 23:12:17 INFO - 'TMOUT': '86400', 23:12:17 INFO - 'USER': 'cltbld', 23:12:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:17 INFO - '_': '/tools/buildbot/bin/python'} 23:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:17 INFO - Downloading/unpacking blobuploader==1.2.4 23:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:19 INFO - Downloading blobuploader-1.2.4.tar.gz 23:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:12:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:20 INFO - Downloading docopt-0.6.1.tar.gz 23:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:12:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:12:20 INFO - Running setup.py install for blobuploader 23:12:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:12:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:12:20 INFO - Running setup.py install for requests 23:12:20 INFO - Running setup.py install for docopt 23:12:20 INFO - Successfully installed blobuploader requests docopt 23:12:20 INFO - Cleaning up... 23:12:20 INFO - Return code: 0 23:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:20 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:20 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 23:12:20 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 23:12:20 INFO - Using env: {'DISPLAY': ':0', 23:12:20 INFO - 'HOME': '/home/cltbld', 23:12:20 INFO - 'LANG': 'en_US.UTF-8', 23:12:20 INFO - 'LANGUAGE': 'en_US:en', 23:12:20 INFO - 'LOGNAME': 'cltbld', 23:12:20 INFO - 'MAIL': '/var/mail/cltbld', 23:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:20 INFO - 'MOZ_NO_REMOTE': '1', 23:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:20 INFO - 'NO_EM_RESTART': '1', 23:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:20 INFO - 'PWD': '/builds/slave/test', 23:12:20 INFO - 'SHELL': '/bin/bash', 23:12:20 INFO - 'SHLVL': '1', 23:12:20 INFO - 'TERM': 'linux', 23:12:20 INFO - 'TMOUT': '86400', 23:12:20 INFO - 'USER': 'cltbld', 23:12:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:20 INFO - '_': '/tools/buildbot/bin/python'} 23:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:20 INFO - Running setup.py (path:/tmp/pip-N_mDHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:21 INFO - Running setup.py (path:/tmp/pip-redT7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:21 INFO - Running setup.py (path:/tmp/pip-BRUU_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:21 INFO - Running setup.py (path:/tmp/pip-Vpvd7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:21 INFO - Running setup.py (path:/tmp/pip-Q_HI3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:21 INFO - Running setup.py (path:/tmp/pip-5hklG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:21 INFO - Running setup.py (path:/tmp/pip-pP05VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:21 INFO - Running setup.py (path:/tmp/pip-r_7XfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:21 INFO - Running setup.py (path:/tmp/pip-aUnfm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:21 INFO - Running setup.py (path:/tmp/pip-LJ3MAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:21 INFO - Running setup.py (path:/tmp/pip-BESjfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:21 INFO - Running setup.py (path:/tmp/pip-pxnyxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:21 INFO - Running setup.py (path:/tmp/pip-V9amGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:21 INFO - Running setup.py (path:/tmp/pip-i4kd0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:21 INFO - Running setup.py (path:/tmp/pip-BANZAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:22 INFO - Running setup.py (path:/tmp/pip-SGrxYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:22 INFO - Running setup.py (path:/tmp/pip-2WVw6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:12:22 INFO - Running setup.py install for manifestparser 23:12:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:12:22 INFO - Running setup.py install for mozcrash 23:12:22 INFO - Running setup.py install for mozdebug 23:12:22 INFO - Running setup.py install for mozdevice 23:12:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:12:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:12:22 INFO - Running setup.py install for mozfile 23:12:22 INFO - Running setup.py install for mozhttpd 23:12:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:12:22 INFO - Running setup.py install for mozinfo 23:12:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:12:22 INFO - Running setup.py install for mozInstall 23:12:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Running setup.py install for mozleak 23:12:23 INFO - Running setup.py install for mozlog 23:12:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Running setup.py install for moznetwork 23:12:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Running setup.py install for mozprocess 23:12:23 INFO - Running setup.py install for mozprofile 23:12:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Running setup.py install for mozrunner 23:12:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Running setup.py install for mozscreenshot 23:12:23 INFO - Running setup.py install for moztest 23:12:23 INFO - Running setup.py install for mozversion 23:12:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:12:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:12:23 INFO - Cleaning up... 23:12:23 INFO - Return code: 0 23:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:23 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:23 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 23:12:23 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 23:12:23 INFO - Using env: {'DISPLAY': ':0', 23:12:23 INFO - 'HOME': '/home/cltbld', 23:12:23 INFO - 'LANG': 'en_US.UTF-8', 23:12:23 INFO - 'LANGUAGE': 'en_US:en', 23:12:23 INFO - 'LOGNAME': 'cltbld', 23:12:23 INFO - 'MAIL': '/var/mail/cltbld', 23:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:23 INFO - 'MOZ_NO_REMOTE': '1', 23:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:23 INFO - 'NO_EM_RESTART': '1', 23:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:23 INFO - 'PWD': '/builds/slave/test', 23:12:23 INFO - 'SHELL': '/bin/bash', 23:12:23 INFO - 'SHLVL': '1', 23:12:23 INFO - 'TERM': 'linux', 23:12:23 INFO - 'TMOUT': '86400', 23:12:24 INFO - 'USER': 'cltbld', 23:12:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:24 INFO - '_': '/tools/buildbot/bin/python'} 23:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:24 INFO - Running setup.py (path:/tmp/pip-d79a09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:24 INFO - Running setup.py (path:/tmp/pip-6bhQIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:24 INFO - Running setup.py (path:/tmp/pip-alRW1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:24 INFO - Running setup.py (path:/tmp/pip-M0x01N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:24 INFO - Running setup.py (path:/tmp/pip-z29CCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:24 INFO - Running setup.py (path:/tmp/pip-KQmAZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:24 INFO - Running setup.py (path:/tmp/pip-oyhXDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:24 INFO - Running setup.py (path:/tmp/pip-eob0RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:24 INFO - Running setup.py (path:/tmp/pip-fQIfvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:24 INFO - Running setup.py (path:/tmp/pip-1M1qZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:24 INFO - Running setup.py (path:/tmp/pip-5WjTx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:24 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)) 23:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:24 INFO - Running setup.py (path:/tmp/pip-1fWQUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:25 INFO - Running setup.py (path:/tmp/pip-4z9COG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:25 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)) 23:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:25 INFO - Running setup.py (path:/tmp/pip-EZeknL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:25 INFO - Running setup.py (path:/tmp/pip-EyVX7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:25 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)) 23:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:25 INFO - Running setup.py (path:/tmp/pip-Ut5AyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:25 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)) 23:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:25 INFO - Running setup.py (path:/tmp/pip-HRRYaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:25 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)) 23:12:25 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)) 23:12:25 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)) 23:12:25 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)) 23:12:25 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)) 23:12:25 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)) 23:12:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:12:25 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 23:12:25 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 23:12:25 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 23:12:25 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 23:12:25 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 23:12:25 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 23:12:26 INFO - Downloading blessings-1.6.tar.gz 23:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:12:26 INFO - Installing collected packages: blessings 23:12:26 INFO - Running setup.py install for blessings 23:12:26 INFO - Successfully installed blessings 23:12:26 INFO - Cleaning up... 23:12:26 INFO - Return code: 0 23:12:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:26 INFO - Reading from file tmpfile_stdout 23:12:26 INFO - Current package versions: 23:12:26 INFO - argparse == 1.2.1 23:12:26 INFO - blessings == 1.6 23:12:26 INFO - blobuploader == 1.2.4 23:12:26 INFO - docopt == 0.6.1 23:12:26 INFO - functools32 == 3.2.3-2 23:12:26 INFO - jsonschema == 2.5.1 23:12:26 INFO - manifestparser == 1.1 23:12:26 INFO - mozInstall == 1.12 23:12:26 INFO - mozcrash == 0.17 23:12:26 INFO - mozdebug == 0.1 23:12:26 INFO - mozdevice == 0.48 23:12:26 INFO - mozfile == 1.2 23:12:26 INFO - mozhttpd == 0.7 23:12:26 INFO - mozinfo == 0.9 23:12:26 INFO - mozleak == 0.1 23:12:26 INFO - mozlog == 3.2 23:12:26 INFO - moznetwork == 0.27 23:12:26 INFO - mozprocess == 0.22 23:12:26 INFO - mozprofile == 0.28 23:12:26 INFO - mozrunner == 6.11 23:12:26 INFO - mozscreenshot == 0.1 23:12:26 INFO - mozsystemmonitor == 0.3 23:12:26 INFO - moztest == 0.7 23:12:26 INFO - mozversion == 1.4 23:12:26 INFO - psutil == 3.1.1 23:12:26 INFO - requests == 1.2.3 23:12:26 INFO - wsgiref == 0.1.2 23:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:26 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 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12:26 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 23:12:26 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 23:12:26 INFO - Using env: {'DISPLAY': ':0', 23:12:26 INFO - 'HOME': '/home/cltbld', 23:12:26 INFO - 'LANG': 'en_US.UTF-8', 23:12:26 INFO - 'LANGUAGE': 'en_US:en', 23:12:26 INFO - 'LOGNAME': 'cltbld', 23:12:26 INFO - 'MAIL': '/var/mail/cltbld', 23:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:26 INFO - 'MOZ_NO_REMOTE': '1', 23:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:26 INFO - 'NO_EM_RESTART': '1', 23:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:26 INFO - 'PWD': '/builds/slave/test', 23:12:26 INFO - 'SHELL': '/bin/bash', 23:12:26 INFO - 'SHLVL': '1', 23:12:26 INFO - 'TERM': 'linux', 23:12:26 INFO - 'TMOUT': '86400', 23:12:26 INFO - 'USER': 'cltbld', 23:12:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:26 INFO - '_': '/tools/buildbot/bin/python'} 23:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 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)) 23:12:27 INFO - Cleaning up... 23:12:27 INFO - Return code: 0 23:12:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:12: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')]} 23:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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')]} 23:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', '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 23:12: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', 'jsonschema'] in /builds/slave/test/build 23:12: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 jsonschema 23:12:27 INFO - Using env: {'DISPLAY': ':0', 23:12:27 INFO - 'HOME': '/home/cltbld', 23:12:27 INFO - 'LANG': 'en_US.UTF-8', 23:12:27 INFO - 'LANGUAGE': 'en_US:en', 23:12:27 INFO - 'LOGNAME': 'cltbld', 23:12:27 INFO - 'MAIL': '/var/mail/cltbld', 23:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:27 INFO - 'MOZ_NO_REMOTE': '1', 23:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:27 INFO - 'NO_EM_RESTART': '1', 23:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:27 INFO - 'PWD': '/builds/slave/test', 23:12:27 INFO - 'SHELL': '/bin/bash', 23:12:27 INFO - 'SHLVL': '1', 23:12:27 INFO - 'TERM': 'linux', 23:12:27 INFO - 'TMOUT': '86400', 23:12:27 INFO - 'USER': 'cltbld', 23:12:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:27 INFO - '_': '/tools/buildbot/bin/python'} 23:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:12:27 INFO - Cleaning up... 23:12:27 INFO - Return code: 0 23:12:27 INFO - Running post-action listener: _resource_record_post_action 23:12:27 INFO - Running post-action listener: _start_resource_monitoring 23:12:27 INFO - Starting resource monitoring. 23:12:27 INFO - ##### 23:12:27 INFO - ##### Finished create-virtualenv step (success) 23:12:27 INFO - ##### 23:12:27 INFO - ##### 23:12:27 INFO - ##### Running install step. 23:12:27 INFO - ##### 23:12:27 INFO - Running pre-action listener: _resource_record_pre_action 23:12:27 INFO - Running main action method: install 23:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:27 INFO - Reading from file tmpfile_stdout 23:12:27 INFO - Detecting whether we're running mozinstall >=1.0... 23:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:12:27 INFO - Reading from file tmpfile_stdout 23:12:27 INFO - Output received: 23:12:27 INFO - Usage: mozinstall [options] installer 23:12:27 INFO - Options: 23:12:27 INFO - -h, --help show this help message and exit 23:12:27 INFO - -d DEST, --destination=DEST 23:12:27 INFO - Directory to install application into. [default: 23:12:27 INFO - "/builds/slave/test"] 23:12:27 INFO - --app=APP Application being installed. [default: firefox] 23:12:27 INFO - mkdir: /builds/slave/test/build/application 23:12:27 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'] 23:12:27 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 23:12:44 INFO - Reading from file tmpfile_stdout 23:12:44 INFO - Output received: 23:12:44 INFO - /builds/slave/test/build/application/firefox/firefox 23:12:44 INFO - Running post-action listener: _resource_record_post_action 23:12:44 INFO - ##### 23:12:44 INFO - ##### Finished install step (success) 23:12:44 INFO - ##### 23:12:44 INFO - ##### 23:12:44 INFO - ##### Running run-tests step. 23:12:44 INFO - ##### 23:12:44 INFO - Running pre-action listener: _resource_record_pre_action 23:12:44 INFO - Running main action method: run_tests 23:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:12:44 INFO - Python 2.7.3 23:12:44 INFO - Return code: 0 23:12:44 INFO - grabbing minidump binary from tooltool 23:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:44 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 0xf663b0>, '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 0xf672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:12:44 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 23:12:44 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 23:12:44 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 23:12:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:12:44 INFO - Return code: 0 23:12:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:12:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:12:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:12:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:12:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 23:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 23:12:44 INFO - Using env: {'DISPLAY': ':0', 23:12:44 INFO - 'HOME': '/home/cltbld', 23:12:44 INFO - 'LANG': 'en_US.UTF-8', 23:12:44 INFO - 'LANGUAGE': 'en_US:en', 23:12:44 INFO - 'LOGNAME': 'cltbld', 23:12:44 INFO - 'MAIL': '/var/mail/cltbld', 23:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:44 INFO - 'MOZ_NO_REMOTE': '1', 23:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:44 INFO - 'NO_EM_RESTART': '1', 23:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:44 INFO - 'PWD': '/builds/slave/test', 23:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:12:44 INFO - 'SHELL': '/bin/bash', 23:12:44 INFO - 'SHLVL': '1', 23:12:44 INFO - 'TERM': 'linux', 23:12:44 INFO - 'TMOUT': '86400', 23:12:44 INFO - 'USER': 'cltbld', 23:12:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973', 23:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:44 INFO - '_': '/tools/buildbot/bin/python'} 23:12:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 23:12:45 INFO - mozversion application_buildid: 20160705203035 23:12:45 INFO - mozversion application_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 23:12:45 INFO - mozversion application_display_name: Nightly 23:12:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:12:45 INFO - mozversion application_name: Firefox 23:12:45 INFO - mozversion application_remotingname: firefox 23:12:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:12:45 INFO - mozversion application_vendor: Mozilla 23:12:45 INFO - mozversion application_version: 50.0a1 23:12:45 INFO - mozversion platform_buildid: 20160705203035 23:12:45 INFO - mozversion platform_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 23:12:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:12:45 INFO - mozversion platform_version: 50.0a1 23:12:45 INFO - using testdate: 1467785565 23:12:45 INFO - actual date: 1467785565 23:12:45 INFO - starting webserver on 'localhost:53634' 23:12:45 INFO - SUITE-START | Running 2 tests 23:12:45 INFO - TEST-START | dromaeo_css 23:12:45 INFO - operating with platform_type : linux_ 23:12:45 INFO - Initialising browser for dromaeo_css test... 23:12:45 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbz14P/profile http://localhost:53634/getInfo.html) 23:12:53 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 23:12:53 INFO - PROCESS | 3295 | colorDepth:24 23:12:53 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 23:12:53 INFO - PROCESS | 3295 | __metrics 23:12:54 INFO - PROCESS | 3295 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:12:54 INFO - PROCESS | 3295 | console.error: PushService: 23:12:54 INFO - PROCESS | 3295 | stateChangeProcessEnqueue: Error transitioning state 23:12:54 INFO - PROCESS | 3295 | UnknownError 23:12:55 INFO - TEST-INFO | 3295: exit 0 23:12:55 INFO - Browser initialized. 23:12:55 INFO - Running cycle 1/1 for dromaeo_css test... 23:12:55 INFO - TEST-INFO | started process 3380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbz14P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:07 INFO - PROCESS | 3380 | RSS: Main: 157769728 23:13:07 INFO - PROCESS | 3380 | 23:13:58 INFO - PROCESS | 3380 | 1467785638822 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] 23:16:06 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53634/tests/dromaeo/cssquery-ext.html) 23:16:08 INFO - PROCESS | 3380 | RSS: Main: 283619328 23:16:08 INFO - PROCESS | 3380 | 23:19:10 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-ext.html (next: http://localhost:53634/tests/dromaeo/cssquery-jquery.html) 23:19:11 INFO - PROCESS | 3380 | RSS: Main: 245309440 23:19:11 INFO - PROCESS | 3380 | 23:22:13 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53634/tests/dromaeo/cssquery-mootools.html) 23:22:13 INFO - PROCESS | 3380 | RSS: Main: 245149696 23:22:13 INFO - PROCESS | 3380 | 23:25:15 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53634/tests/dromaeo/cssquery-prototype.html) 23:25:16 INFO - PROCESS | 3380 | RSS: Main: 241635328 23:25:16 INFO - PROCESS | 3380 | 23:28:18 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53634/tests/dromaeo/cssquery-yui.html) 23:28:19 INFO - PROCESS | 3380 | RSS: Main: 224788480 23:28:19 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:53634/tests/dromaeo/cssquery-yui.html (next: http://localhost:53634/tests/dromaeo/cssquery-dojo.html) 23:31:22 INFO - PROCESS | 3380 | RSS: Main: 281919488 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | __start_tp_report 23:31:22 INFO - PROCESS | 3380 | _x_x_mozilla_page_load 23:31:22 INFO - PROCESS | 3380 | _x_x_mozilla_page_load_details 23:31:22 INFO - PROCESS | 3380 | |i|pagename|runs| 23:31:22 INFO - PROCESS | 3380 | |0;dojo.html;3121.9843900780497;3131.091983324836;3150.810951342921;3151.2279491524573;3165.6834316568347;5204.739763011853;5269.262303277545;5285.418603953567;5373.704446255454;5420.078586640271;5336.17289320155;5344.812931547397;5390.5418039466695;5405.945940540593;5416.783328666848;4868.878278043042;4883.902321953558;4919.631027672921;4919.827806026772;5018.071656743514;4940.604751619861;4979.402471703401;4982.352294201749;4996.425411077718;4997.85006449807;4780.354652121954;4791.880202994918;4807.18277892759;4822.565969062801;4966.056449274644;4821.85534433964;4829.806807727722;4835.830745923911;4836.588889944359;4929.605631549503;4842.055799119174;4869.926951095701;4871.878203044952;4880.804767809319;4920.40955085392;5263.710495922723;5315.335583052119;5315.920261196085;5317.388500322474;5421.891562168735;5743.597948143632;5815.185873977646;5856.707164641751;5861.413858614147;5876.3242227144;5878.588498805086;5911.556633252523;5923.407659234085;5928.110783382484;5936.970315148396;5226.686398816083;5367.275417818622;5419.024575576355;5506.862328441781;5506.889862202774;5965.254343207099;5967.1347654589845;5975.611585246945;6000.369961154016;6016;5686.5735069869925;5700.857478562986;5702.771889124471;5703.771849125988;5712.314522257356;5611.102223644279;5703.258576385043;5716.771329146871;5775.826725198251;5787.652740835563;5786.450287222707;5790.218320526675;5794;5804.622699524602;5809.709514524341;5748.683822389725;5757.107648314518;5803.912941305884;5808.883822323614;5819.301683797887;4250.617444430016;4316.762578058174;4320.870373888788;4325.84859529915;4342.370356298319;3954;3954.703397245218;3955.960440395617;3974.7018973577096;3984.621460961204;5522.420145884705;5528.087865502147;5532.170174473861;5533;5578.665280083127;5597.6641401516035;5701.372848986608;5726.226959360433;5796.333421656479;5843.18195452637;5473.589480788877;5481.506664400144;5487.972560137254;5490.533304669068;5524.613277070647;4986.925196122061;4996.275540046673;4996.7001979881325;4999.150144475448;5044.344235249468;5730.77076916927;5834.620749651259;5839.240898683229;5870.970645146747;5945;5752;5761.222234998221;5764.798232062026;5767.625104368202;5775.249217601685;5934.851628709317;5943.197668314895;5947.672877991752;5948.970255148696;5956.404359564009;5493.670379777066;5633.746481408264;5650.152477128299;5676.602637815478;5724.713764311685;5769.884602308014;5816.621919575214;5819.098039803837;5822.5633077518505;5824.650520968756;5380.300560927054;5693.829185124453;5703.714814259353;5705.743241554057;5706.2011318414625;5591.077472217039;5593.916091258553;5635.042042852807;5685.232493613475;5712.885742285214;5590.105583106683;5590.888182236251;5617.382087970402;5632.493075623213;5636.746346414339;5499.725013749377;5546.75039623226;5726.828195154152;5736.827895163152;5792.247007888947;5425.864353391039;5460.017196904437;5478.780848766005;5500;5522.806701765419 23:31:22 INFO - PROCESS | 3380 | |1;ext.html;557.740650597472;606.3360620120967;612.2805703298626;612.8559788449713;626.0546574672244;30567.38865222697;43610;44951.55048449514;45012.99999999992;45036.549634503644;45532.544674553246;45600.77199614006;45928.770356148256;46013.07973840521;46067.53932460675;8983.775405614862;9135.269178465707;9135.908640913573;9139.131782480654;9140.725778226664;8939.284857211407;8977.057408972061;9000.369974101815;9025.593848276843;9028.909710902873;9088.363814532986;9142.314326425545;9142.680006199784;9143.948445928736;9150.542472876363;9056.049114842945;9101.908980910172;9120.817583648357;9122.498262595554;9122.954385228064;8990.235829954461;9050.86423703645;9064.864027039599;9064.864027039599;9071.183593476553;42773;42794.14411711748;43052;43069.784651076545;43141.13717725659;3317.419451595961;3513.49054387115;3570.071781336845;3577.749557530974;3653.1597732521404;32665.183370415692;33255.66744332574;33567.83216083929;33577.108740471434;33808.830955845064;4432.312991486325;4502.5047244803045;4504.076664283814;4647.488776234612;4659;341750;345882;346146;346857;348952;43476.56523434789;43582.78208609;43684.78157609192;43831.78084109559;55437.72281138649;60934.695326523084;62775.6861215691;62979.387164348;67144.32855671478;67206.32793672099;16358.345666173458;16541.338346466247;16542.586435339213;16548.917255413646;16574.08842513649;11709;12144.089193310538;12283.75432491363;12297.508099676092;12372.81440778389;17550.648987020188;17882;18194;18218.08909554517;18415;6336.619802811846;6607.438367738796;6624.86750264992;6630.138082049302;6720.547000344936;934.5700977550403;998.8301988661945;1019.0828254570797;1020.806046851096;1085.5115198160859;32990.67009329924;33191.502127468106;33387.83306083503;33536.664633353845;33813.661863381545;1058.9470526473644;1065.6909496246158;1101;1129.8474705914762;1156.1386766858575;16820.327186912633;17069.48791536256;17232.655346892992;17291.308347666203;17292.827071729374;547440;550192;553004;553771;556372;57942.420575794546;57969;58308.41691583115;58577.414225857196;58583.414165857794;1242.714175739585;1340.892728581711;1352.0468070010618;1375.917444953306;1381.205806661174;32576.674233258313;33684.15789605279;33963;34070;34170.31659366848;41059.384109238985;41459.585404145575;41501.37747933723;41526.377104344065;41581;367494;373238;375813;376190;376785.04467298486;37873.81063094667;41572.79213603913;44021;44778;45802;48179;49304.26043609277;49382.75308623434;50150.49849501604;52620;42386.788066059475;42616;42629;43605.78197108994;44191.779041104586;41916.580834192486;43184.136317274104;43202.975791694276;43381.34927976146;43421.34867977046;41199.58800411958;41669.374959375025;42734.93162670958;42885;42941.355879661205;30951.69048309488;32604.184895377806;32700.50949235716;32752;32928.67071329256;27977.72022279751;28370.290742730773;28395.290117747223;28405.715942840307;28581.714182857904 23:31:22 INFO - PROCESS | 3380 | |2;jquery.html;383.93856982882744;386.5361566120656;399.16176030336317;399.66028875455856;413.86549371454265;18359.632807343845;20688.89655551724;20861.643993140435;21220.787792122075;21225.469363265925;19407.708884366744;19422.931738754363;19651.508712282164;19734.802651973478;19906.402807915787;5324.414314425429;5593.776248950047;5810.680412577307;6428;6433.8391540211405;6391.169148010752;6397.392247736458;6413.134226879358;6424.325445828191;6451.096846441502;7289.453291003169;7697.268759467842;7708.498947568418;7710.691572337099;7847.764567062997;7296.37980771635;7514.812129696774;7686.846263074764;7698.2686644768655;7701.768946931601;7212.098487689039;7392.039034925425;7394.37147842434;7424.443166762514;7533.510321829063;27053.458930821274;27307.45385092287;27913.720862791317;27934.860325698242;28027.85103492386;2563.73339952836;2715.2397328747984;2721.2652583802264;2732.631094802196;3243.335116301176;15415.306311216022;15894.9205253973;16115.516534503984;16935.491935241964;17222;2062.6287268291703;2086.937391878246;2121.193946300396;2132.264368792764;2179.901904414289;94430;100494;101050;101225;103387;17760.822391776175;17911;18028.36900708469;18315;18516.888986660844;32086;32368.83815580907;32687.673123268938;32813.67186328154;32827.1793205167;9803.264755143393;10184.388936663823;10232.53953572091;10236.641717539851;10354.741131471774;8514.106018868053;8549.700760473477;8583.18459746323;8680.262177714965;8698.47809131454;8880.001999550179;9127.178553930178;9245.583948722324;9364.484953327496;9506.575823165187;3410.23269764306;3455.274392377629;3511.754177207622;3520.489529018278;3608.224231790178;890.425675439338;955.5031383680447;957.7557722780647;1055.9472026398803;1069.7111779819404;19673.90163049204;20180.798192017894;20183.293584724463;20230.393088207376;20542.589148216954;964.6720115160739;974.3812678948776;1031.5615863258085;1056.271172890703;1063.3460421840666;10610.787784244427;10989.450527473595;10989.450527473755;11024.779504409868;11064.114870810316;454310;459577;464422;464999;465011;69128;83951;86466;96541.51729241449;97303.51348243213;958.2765012415582;963.9132478077007;989.218517371283;990.6136606723384;991.3407583956732;17820.821791781917;17866.196021178817;18118.45644630663;18263.81736182621;18567.90716046411;34465.48301775526;44555;44816.55183448124;45343.31985020162;45504;58227.4177258222;59212;59504.70247648734;59580;61113.69443152756;8707.651693932172;8709.956450217709;8800.383973122076;8966.058563850962;9236.168744813;9861.408315501092;12540.749185016432;14221.075630084011;14243.287835608386;14323.355449005028;11962.282263064244;12113.33376664292;12129.636110916686;12159.209651372632;12453.501859925502;11860.525578976743;12175.086868485076;12199.817002744789;12247.510099595916;12350.567730129402;11796.823047654121;11870.169088164092;11900.226485278428;12500;12693.301868396957;8839.779005524913;8966;9011.729648110568;9029.683961061332;9251.444913305224;9157.679481218393;12147.574834880737;12167.452464638935;12195.146339756488;12220.144589878622 23:31:22 INFO - PROCESS | 3380 | |3;mootools.html;1419.8154239948808;1478.9852101478984;1510.4486862295266;1640.655462352905;1662.3433743671242;8431.19903609157;8909.554522273877;8992.8651070234;9010.414323068995;9017.639294428223;7587.848243035136;8377.246047855691;8606.95696521518;8625.956870215656;8786.165314295147;2346.7653234676523;2375.8455700379504;2376.0377047295874;2377.869217193054;2378.3459548624096;2320.9535809283802;2334.556434277482;2370;2370.5377451396985;2377.869217193054;2005.368308982666;2079.906404211814;2235.8099561537288;2317.7450480447137;2331.40549159964;2299.1263319938485;2336.707911511061;2339.6958395408574;2345.0854166874933;2350.9412264693347;2315.6873822034145;2321.152779235567;2325.813934885222;2330.4639932815376;2331.1258278145697;8620.439671421338;8622.78443038929;8684.001339845936;8691.60887760046;8717.476951382874;4915.877103072416;5032.798688052473;5054.9241761373605;5061.190209566452;5066.923996140061;3222.130024893289;3244.156519304974;3364;3412.436947903593;3413.0784688134313;1186.0452335869622;1193.9672183561245;1992.1832048859899;2036.5112373030515;2081.2715549557684;11950.402479875971;12140.575079872162;12158.209716368408;12191.878081219164;12289.385530723428;4247.957520424818;4336.588024137702;4404.229259879508;4484.484284307347;4486.12520558488;10313.896861031444;10331.586736530606;10336.793264134676;10342.638007669695;10352.844707329396;5073.162928116893;5076.492350764894;5084.008618319393;5085.262636917701;5086.643934924594;4652.116097941448;4686.250199967989;4693.178693728584;4694.600958918462;4810.326554282403;3814.5994670559194;3869.303525365461;3877.84488620452;3922.3528117860806;3993.101552150743;1127.577158565538;1152.4986630815622;1195.0857593940643;1201.6515210589007;1205.4033253539553;804.4288555125809;812.5165526511717;830.529175702293;847.4999750147442;850.961706723199;5601.719914004365;5620.18507316445;5838.38696936824;5925.911111333334;6026.186464827192;477.4366247827597;485.0735095966757;487.0599742497015;489.22457904221494;634.1122428599905;4008.3987401889367;4064.248114098901;4208.915821683549;4316.5467625899455;4327.1345730853955;10833.458327083772;10996.780064398667;10998.890011099787;11098.889011109946;11124.276922000045;9172.816543669089;10023.2482563808;10359.948200259101;10960.28758130735;11001.119910407147;7940.6029698515995;8069.31410830086;8093.554854482943;8105.351571874236;8109.513429194267;5685.630434021776;5688.175214593778;5843.970780146072;5890.676012819336;6087;10024.398536087567;10047.748806279902;10175.084242418217;10246;10304.072633463024;10460.63387781424;10488;10495.685129446128;10587.523561439908;10595.735106622396;7102.325279098477;7842.686292548462;7990.480618759762;7995;7996.160403157584;8095.797605059685;8468.026176989724;8470.364722645703;8475.40672152968;8479.533625650649;7267.672954717156;7468.215837337001;7533.359664428585;7595.354394876497;7651.808704782425;7236.6019868907715;7364.484486085923;7389;7435.628218589157;7453.739119130804;6809.250982392032;6881.862362752817;6903.585784852925;6908.758193463204;6910.239873613999;4847.248676455155;4928.950710492993;4955.752212389294;5009.499050094962;5055.140626093499;4934.605231581393;4957.628177886745;5004.799808007639;5076.543111120017;5145.07388670028 23:31:22 INFO - PROCESS | 3380 | |4;prototype.html;322.6628173558631;328.36789180826906;336.52045834685583;339.98640054397816;340.16150189782184;5180.7409629518515;5309.73451327433;5322.494363035516;5369.785208591652;5396.892062158754;5315.760790764415;5321.201819727043;5329.520343169114;5332.306800115979;5332.973335133329;4209.4317267169;4210.663146948252;4213.515445723743;4224.986003359202;4244.511881133678;3976.5228172619327;4179.874603761892;4188.308929026707;4207.410962465257;4207.72649777765;4127.422160897477;4147.3778933159965;4154.97922510387;4156.937645935313;4177.916441671165;4150.605692459242;4160.209560183555;4160.355144952538;4170.416141740159;4184.246835569596;3628.929465807567;3696.815159242027;3715.368387374153;3715.925681486382;3723.832427540767;5197.8440646780655;5202.193659982671;5230.215467679878;5257.526822585947;5282.920756188661;4734.834280800155;4760.262159365304;4762.928556071662;4786.305985632099;4808.783604737795;5442.836714898559;5575.804846830382;5576.275084239063;5585.804496842591;5587.38538760736;4048.959510404917;4055.837766489337;4056.9594304057173;4061.7562946223024;4079.2453396121814;5549.084401073818;5708.4576965187825;5837.09525023622;5841.912371314434;5847.590668653196;3877.2051729395407;3883.3592457244804;3918.49059622253;3982.4424580558743;4125.463689720317;4128.958710412918;4129.690273229459;4183.288840897055;4184.100418410057;4190.28765109932;4617.907641847144;4774.708140092775;4785.258284965836;4789.425268967677;4794.640401969797;5569.136783798518;5571.749271282802;5602.775888964396;5604.327480702342;5621.959937411592;1414.2292450614234;1434.6556826361598;1439.7264519741425;1441.8630230128122;1442.624917521452;891.0510306523531;925.6806401791506;931.7484279244566;950.9524523773922;951.3958636266021;4812.494688057704;4820.156472617278;4837.806487740451;4843.515648435199;4853.369062021985;5057.6459647824295;5074.923876141861;5116;5124.871878203075;5133.023785842477;4658.557437043475;4811.158047341702;4833.806647734052;4857.392825896763;4861.392325959255;2686.8656567171565;2705.485957668037;2715.6876959149554;2725.196067160153;2728.4406696627143;5200.323957885451;5216.895946911657;5232.92150617741;5234.633575649744;5256.448072952361;4946.282788995575;5182.922256166161;5198.298229738937;5206.219067139959;5215.956808638288;5114.181730923109;5217.3999990000875;5244.947550524522;5255.264263003182;5270.445218660504;4967.552920237196;5028.617130289053;5037.549278744072;5074.904308371816;5123.666961647481;4669.322948172564;4976.427710813158;5003.54968052877;5033.370828646419;5036.219385995177;5670.404607516151;5731.5701322400155;5896.262967129109;5903;5903.760210355874;3978.6419222270133;3988.561258261647;3988.660963818108;3995.7013970459134;4002.0995276062654;5545.833624991256;5765.91351129725;5783.322836377572;5785.30576330843;5786.508146807569;5616.578756593353;5636.887262254814;5650.463205995424;5655.406182350794;5659.151127330933;5587.636803607753;5601.7759289629585;5612.298462692163;5672.1072253152015;5680.857978550569;5119.436861945258;5481.424450432647;5525.889482210414;5553;5567.860803479945;5637.238972738792;5638.830835074954;5645.802396916252;5652.3217213934595;5656.321241451053;5541.251930989265;5565.693886836101;5569.749361278671;5580.832575022756;5590.204897551224 23:31:22 INFO - PROCESS | 3380 | |5;yui.html;744.8994385757923;782.2529484342454;798.6326289906642;807.3460496997429;822.6791551294996;14136.363863626137;15084;15124.848751512482;15126.470573529916;15144.54566363008;14105.012649114566;14267.785983210235;14273.643158921031;14567.562973110797;14736.336864841081;641.4291280760127;790.134802391382;798.1459837973371;800.4236949396454;802.0736049862418;776.8368642585064;799.188823344306;802.3380710913519;802.4543310548825;803.907550631676;830.5307501261768;831.1148626712562;831.3723139030024;833.1834801894147;833.5707110837923;665.7470161338708;688.2704333406605;813.1137060603941;814.9388795840306;815.7185770909057;501.8670052436107;584.7748616782569;599.0475144520234;602.0667964654767;603.8520562462181;14458.783118253235;14515.201663908481;14567.344469498898;14576.781348279785;14600.634984125481;14228.57314280563;14552.854471455255;14613.853861461355;14719;14730.705385892223;12696.365181740968;12806.23162610237;12811.679708007281;12847.229166250056;13022.544210952572;4422.469303683546;4455.754933478657;4498.077894031716;4531.07113041829;4620.376249206348;72869;73243.26756732418;73257.26742732504;73616.6319168406;73984.26015739827;11464;11523.135764817673;11589.82615260755;11697.23967942081;11922.52309907594;21717.891410542845;21718.45703857416;21747.23884664029;21760.564788704138;21762;8725.083866194085;8740.300775937909;8749.343799215085;8900.688475903313;9001.414908030956;4595.770211489479;4766.523347665206;4818.590419814285;4886.364772579542;4927.802887884444;3194.3291908699434;3272.60728712556;3273.918152046218;3276.5904261967253;3279.770416070852;599.9430054144849;610.6031079798078;614.8493619063358;615.5875563372551;631.340249439337;662.1326062857672;663.1213641924373;673.5655502201053;673.9966300168468;687.8417963868338;8987.370884038055;9111.453312801254;9146.771330716785;9264.212541934012;9706.70879873605;638.8945823938998;658.1969996604231;669.8928171492538;680.306087790451;689.689639662154;4203.873883783492;4223.176480586318;4293.441346930886;4307.612314891675;4356.716813407118;107085;111041.44479277552;111536;112325.4383728076;113236;100988.49505752424;101253;102736.48631756943;103444;103707;88019;89623.55188224016;89915.55042224878;90847.54576227076;93478.53260733653;8455.577221138796;8564.143585641386;8568.828623427622;8626.09426010285;8801.251893589117;52554.73722631362;52796.47203528069;52807.47192528025;53235.73382133064;54958;71217;77392;79502;79977.60011199907;81074.59462702884;11287.774244515227;11404.600838970928;11965.282083074695;12499.813160477668;12689.492420303453;12663.986881049677;12665.493380264686;12959.481620735065;13293.734125317245;13326.600201993955;10922.344659320466;11537.596184133516;11546.82679759821;11886.227395219283;11903.16677832578;11759.529618815151;11802.350870702194;12004.75990480203;12377.133600647869;12489;11681.415929203677;11966.64100076999;12241.816372754594;12509.812352814897;12621;9791.657291994747;9893.406395616286;10027.448490333101;10031.598736050477;10211.591536338463;9455.19630831387;9694.418334899929;9768.706938791847;9877.160441362277;9913.65302214419 23:31:22 INFO - PROCESS | 3380 | __end_tp_report 23:31:22 INFO - PROCESS | 3380 | __start_cc_report 23:31:22 INFO - PROCESS | 3380 | _x_x_mozilla_cycle_collect,1050 23:31:22 INFO - PROCESS | 3380 | __end_cc_report 23:31:22 INFO - PROCESS | 3380 | __startTimestamp1467786682947__endTimestamp 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | ------- Summary: start ------- 23:31:22 INFO - PROCESS | 3380 | Number of tests: 6 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#0] dojo.html Cycles:165 Average:5358.87 Median:5546.75 stddev:613.94 (11.1%) stddev-sans-first:590.21 23:31:22 INFO - PROCESS | 3380 | Values: 3122.0 3131.1 3150.8 3151.2 3165.7 5204.7 5269.3 5285.4 5373.7 5420.1 5336.2 5344.8 5390.5 5405.9 5416.8 4868.9 4883.9 4919.6 4919.8 5018.1 4940.6 4979.4 4982.4 4996.4 4997.9 4780.4 4791.9 4807.2 4822.6 4966.1 4821.9 4829.8 4835.8 4836.6 4929.6 4842.1 4869.9 4871.9 4880.8 4920.4 5263.7 5315.3 5315.9 5317.4 5421.9 5743.6 5815.2 5856.7 5861.4 5876.3 5878.6 5911.6 5923.4 5928.1 5937.0 5226.7 5367.3 5419.0 5506.9 5506.9 5965.3 5967.1 5975.6 6000.4 6016.0 5686.6 5700.9 5702.8 5703.8 5712.3 5611.1 5703.3 5716.8 5775.8 5787.7 5786.5 5790.2 5794.0 5804.6 5809.7 5748.7 5757.1 5803.9 5808.9 5819.3 4250.6 4316.8 4320.9 4325.8 4342.4 3954.0 3954.7 3956.0 3974.7 3984.6 5522.4 5528.1 5532.2 5533.0 5578.7 5597.7 5701.4 5726.2 5796.3 5843.2 5473.6 5481.5 5488.0 5490.5 5524.6 4986.9 4996.3 4996.7 4999.2 5044.3 5730.8 5834.6 5839.2 5871.0 5945.0 5752.0 5761.2 5764.8 5767.6 5775.2 5934.9 5943.2 5947.7 5949.0 5956.4 5493.7 5633.7 5650.2 5676.6 5724.7 5769.9 5816.6 5819.1 5822.6 5824.7 5380.3 5693.8 5703.7 5705.7 5706.2 5591.1 5593.9 5635.0 5685.2 5712.9 5590.1 5590.9 5617.4 5632.5 5636.7 5499.7 5546.8 5726.8 5736.8 5792.2 5425.9 5460.0 5478.8 5500.0 5522.8 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#1] ext.html Cycles:180 Average:58966.84 Median:42913.18 stddev:114930.39 (267.8%) stddev-sans-first:115169.13 23:31:22 INFO - PROCESS | 3380 | Values: 557.7 606.3 612.3 612.9 626.1 30567.4 43610.0 44951.6 45013.0 45036.5 45532.5 45600.8 45928.8 46013.1 46067.5 8983.8 9135.3 9135.9 9139.1 9140.7 8939.3 8977.1 9000.4 9025.6 9028.9 9088.4 9142.3 9142.7 9143.9 9150.5 9056.0 9101.9 9120.8 9122.5 9123.0 8990.2 9050.9 9064.9 9064.9 9071.2 42773.0 42794.1 43052.0 43069.8 43141.1 3317.4 3513.5 3570.1 3577.7 3653.2 32665.2 33255.7 33567.8 33577.1 33808.8 4432.3 4502.5 4504.1 4647.5 4659.0 341750.0 345882.0 346146.0 346857.0 348952.0 43476.6 43582.8 43684.8 43831.8 55437.7 60934.7 62775.7 62979.4 67144.3 67206.3 16358.3 16541.3 16542.6 16548.9 16574.1 11709.0 12144.1 12283.8 12297.5 12372.8 17550.6 17882.0 18194.0 18218.1 18415.0 6336.6 6607.4 6624.9 6630.1 6720.5 934.6 998.8 1019.1 1020.8 1085.5 32990.7 33191.5 33387.8 33536.7 33813.7 1058.9 1065.7 1101.0 1129.8 1156.1 16820.3 17069.5 17232.7 17291.3 17292.8 547440.0 550192.0 553004.0 553771.0 556372.0 57942.4 57969.0 58308.4 58577.4 58583.4 1242.7 1340.9 1352.0 1375.9 1381.2 32576.7 33684.2 33963.0 34070.0 34170.3 41059.4 41459.6 41501.4 41526.4 41581.0 367494.0 373238.0 375813.0 376190.0 376785.0 37873.8 41572.8 44021.0 44778.0 45802.0 48179.0 49304.3 49382.8 50150.5 52620.0 42386.8 42616.0 42629.0 43605.8 44191.8 41916.6 43184.1 43203.0 43381.3 43421.3 41199.6 41669.4 42734.9 42885.0 42941.4 30951.7 32604.2 32700.5 32752.0 32928.7 27977.7 28370.3 28395.3 28405.7 28581.7 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#2] jquery.html Cycles:180 Average:30239.26 Median:18118.71 stddev:76373.53 (421.5%) stddev-sans-first:76554.88 23:31:22 INFO - PROCESS | 3380 | Values: 383.9 386.5 399.2 399.7 413.9 18359.6 20688.9 20861.6 21220.8 21225.5 19407.7 19422.9 19651.5 19734.8 19906.4 5324.4 5593.8 5810.7 6428.0 6433.8 6391.2 6397.4 6413.1 6424.3 6451.1 7289.5 7697.3 7708.5 7710.7 7847.8 7296.4 7514.8 7686.8 7698.3 7701.8 7212.1 7392.0 7394.4 7424.4 7533.5 27053.5 27307.5 27913.7 27934.9 28027.9 2563.7 2715.2 2721.3 2732.6 3243.3 15415.3 15894.9 16115.5 16935.5 17222.0 2062.6 2086.9 2121.2 2132.3 2179.9 94430.0 100494.0 101050.0 101225.0 103387.0 17760.8 17911.0 18028.4 18315.0 18516.9 32086.0 32368.8 32687.7 32813.7 32827.2 9803.3 10184.4 10232.5 10236.6 10354.7 8514.1 8549.7 8583.2 8680.3 8698.5 8880.0 9127.2 9245.6 9364.5 9506.6 3410.2 3455.3 3511.8 3520.5 3608.2 890.4 955.5 957.8 1055.9 1069.7 19673.9 20180.8 20183.3 20230.4 20542.6 964.7 974.4 1031.6 1056.3 1063.3 10610.8 10989.5 10989.5 11024.8 11064.1 454310.0 459577.0 464422.0 464999.0 465011.0 69128.0 83951.0 86466.0 96541.5 97303.5 958.3 963.9 989.2 990.6 991.3 17820.8 17866.2 18118.5 18263.8 18567.9 34465.5 44555.0 44816.6 45343.3 45504.0 58227.4 59212.0 59504.7 59580.0 61113.7 8707.7 8710.0 8800.4 8966.1 9236.2 9861.4 12540.7 14221.1 14243.3 14323.4 11962.3 12113.3 12129.6 12159.2 12453.5 11860.5 12175.1 12199.8 12247.5 12350.6 11796.8 11870.2 11900.2 12500.0 12693.3 8839.8 8966.0 9011.7 9029.7 9251.4 9157.7 12147.6 12167.5 12195.1 12220.1 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#3] mootools.html Cycles:180 Average:5722.45 Median:4689.71 stddev:3279.36 (69.9%) stddev-sans-first:3272.62 23:31:22 INFO - PROCESS | 3380 | Values: 1419.8 1479.0 1510.4 1640.7 1662.3 8431.2 8909.6 8992.9 9010.4 9017.6 7587.8 8377.2 8607.0 8626.0 8786.2 2346.8 2375.8 2376.0 2377.9 2378.3 2321.0 2334.6 2370.0 2370.5 2377.9 2005.4 2079.9 2235.8 2317.7 2331.4 2299.1 2336.7 2339.7 2345.1 2350.9 2315.7 2321.2 2325.8 2330.5 2331.1 8620.4 8622.8 8684.0 8691.6 8717.5 4915.9 5032.8 5054.9 5061.2 5066.9 3222.1 3244.2 3364.0 3412.4 3413.1 1186.0 1194.0 1992.2 2036.5 2081.3 11950.4 12140.6 12158.2 12191.9 12289.4 4248.0 4336.6 4404.2 4484.5 4486.1 10313.9 10331.6 10336.8 10342.6 10352.8 5073.2 5076.5 5084.0 5085.3 5086.6 4652.1 4686.3 4693.2 4694.6 4810.3 3814.6 3869.3 3877.8 3922.4 3993.1 1127.6 1152.5 1195.1 1201.7 1205.4 804.4 812.5 830.5 847.5 851.0 5601.7 5620.2 5838.4 5925.9 6026.2 477.4 485.1 487.1 489.2 634.1 4008.4 4064.2 4208.9 4316.5 4327.1 10833.5 10996.8 10998.9 11098.9 11124.3 9172.8 10023.2 10359.9 10960.3 11001.1 7940.6 8069.3 8093.6 8105.4 8109.5 5685.6 5688.2 5844.0 5890.7 6087.0 10024.4 10047.7 10175.1 10246.0 10304.1 10460.6 10488.0 10495.7 10587.5 10595.7 7102.3 7842.7 7990.5 7995.0 7996.2 8095.8 8468.0 8470.4 8475.4 8479.5 7267.7 7468.2 7533.4 7595.4 7651.8 7236.6 7364.5 7389.0 7435.6 7453.7 6809.3 6881.9 6903.6 6908.8 6910.2 4847.2 4929.0 4955.8 5009.5 5055.1 4934.6 4957.6 5004.8 5076.5 5145.1 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#4] prototype.html Cycles:180 Average:4558.21 Median:5074.91 stddev:1319.26 (26.0%) stddev-sans-first:1284.09 23:31:22 INFO - PROCESS | 3380 | Values: 322.7 328.4 336.5 340.0 340.2 5180.7 5309.7 5322.5 5369.8 5396.9 5315.8 5321.2 5329.5 5332.3 5333.0 4209.4 4210.7 4213.5 4225.0 4244.5 3976.5 4179.9 4188.3 4207.4 4207.7 4127.4 4147.4 4155.0 4156.9 4177.9 4150.6 4160.2 4160.4 4170.4 4184.2 3628.9 3696.8 3715.4 3715.9 3723.8 5197.8 5202.2 5230.2 5257.5 5282.9 4734.8 4760.3 4762.9 4786.3 4808.8 5442.8 5575.8 5576.3 5585.8 5587.4 4049.0 4055.8 4057.0 4061.8 4079.2 5549.1 5708.5 5837.1 5841.9 5847.6 3877.2 3883.4 3918.5 3982.4 4125.5 4129.0 4129.7 4183.3 4184.1 4190.3 4617.9 4774.7 4785.3 4789.4 4794.6 5569.1 5571.7 5602.8 5604.3 5622.0 1414.2 1434.7 1439.7 1441.9 1442.6 891.1 925.7 931.7 951.0 951.4 4812.5 4820.2 4837.8 4843.5 4853.4 5057.6 5074.9 5116.0 5124.9 5133.0 4658.6 4811.2 4833.8 4857.4 4861.4 2686.9 2705.5 2715.7 2725.2 2728.4 5200.3 5216.9 5232.9 5234.6 5256.4 4946.3 5182.9 5198.3 5206.2 5216.0 5114.2 5217.4 5244.9 5255.3 5270.4 4967.6 5028.6 5037.5 5074.9 5123.7 4669.3 4976.4 5003.5 5033.4 5036.2 5670.4 5731.6 5896.3 5903.0 5903.8 3978.6 3988.6 3988.7 3995.7 4002.1 5545.8 5765.9 5783.3 5785.3 5786.5 5616.6 5636.9 5650.5 5655.4 5659.2 5587.6 5601.8 5612.3 5672.1 5680.9 5119.4 5481.4 5525.9 5553.0 5567.9 5637.2 5638.8 5645.8 5652.3 5656.3 5541.3 5565.7 5569.7 5580.8 5590.2 23:31:22 INFO - PROCESS | 3380 | 23:31:22 INFO - PROCESS | 3380 | [#5] yui.html Cycles:180 Average:20653.09 Median:4852.48 stddev:30276.13 (623.9%) stddev-sans-first:30324.16 23:31:22 INFO - PROCESS | 3380 | Values: 744.9 782.3 798.6 807.3 822.7 14136.4 15084.0 15124.8 15126.5 15144.5 14105.0 14267.8 14273.6 14567.6 14736.3 641.4 790.1 798.1 800.4 802.1 776.8 799.2 802.3 802.5 803.9 830.5 831.1 831.4 833.2 833.6 665.7 688.3 813.1 814.9 815.7 501.9 584.8 599.0 602.1 603.9 14458.8 14515.2 14567.3 14576.8 14600.6 14228.6 14552.9 14613.9 14719.0 14730.7 12696.4 12806.2 12811.7 12847.2 13022.5 4422.5 4455.8 4498.1 4531.1 4620.4 72869.0 73243.3 73257.3 73616.6 73984.3 11464.0 11523.1 11589.8 11697.2 11922.5 21717.9 21718.5 21747.2 21760.6 21762.0 8725.1 8740.3 8749.3 8900.7 9001.4 4595.8 4766.5 4818.6 4886.4 4927.8 3194.3 3272.6 3273.9 3276.6 3279.8 599.9 610.6 614.8 615.6 631.3 662.1 663.1 673.6 674.0 687.8 8987.4 9111.5 9146.8 9264.2 9706.7 638.9 658.2 669.9 680.3 689.7 4203.9 4223.2 4293.4 4307.6 4356.7 107085.0 111041.4 111536.0 112325.4 113236.0 100988.5 101253.0 102736.5 103444.0 103707.0 88019.0 89623.6 89915.6 90847.5 93478.5 8455.6 8564.1 8568.8 8626.1 8801.3 52554.7 52796.5 52807.5 53235.7 54958.0 71217.0 77392.0 79502.0 79977.6 81074.6 11287.8 11404.6 11965.3 12499.8 12689.5 12664.0 12665.5 12959.5 13293.7 13326.6 10922.3 11537.6 11546.8 11886.2 11903.2 11759.5 11802.4 12004.8 12377.1 12489.0 11681.4 11966.6 12241.8 12509.8 12621.0 9791.7 9893.4 10027.4 10031.6 10211.6 9455.2 9694.4 9768.7 9877.2 9913.7 23:31:22 INFO - PROCESS | 3380 | -------- Summary: end -------- 23:31:22 INFO - PROCESS | 3380 | 23:31:23 INFO - TEST-INFO | 3380: exit 0 23:31:23 INFO - TEST-OK | dromaeo_css | took 1118532ms 23:31:23 INFO - TEST-START | kraken 23:31:23 INFO - operating with platform_type : linux_ 23:31:23 INFO - Initialising browser for kraken test... 23:31:23 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNEAkE/profile http://localhost:53634/getInfo.html) 23:31:27 INFO - PROCESS | 3574 | __metrics Screen width/height:1600/1200 23:31:27 INFO - PROCESS | 3574 | colorDepth:24 23:31:27 INFO - PROCESS | 3574 | Browser inner width/height: 1024/697 23:31:27 INFO - PROCESS | 3574 | __metrics 23:31:28 INFO - PROCESS | 3574 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:31:29 INFO - TEST-INFO | 3574: exit 0 23:31:29 INFO - Browser initialized. 23:31:29 INFO - Running cycle 1/1 for kraken test... 23:31:29 INFO - TEST-INFO | started process 3657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNEAkE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:41 INFO - PROCESS | 3657 | RSS: Main: 157487104 23:31:41 INFO - PROCESS | 3657 | 23:31:44 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53634/tests/kraken/driver.html?testName=audio-beat-detection) 23:31:44 INFO - PROCESS | 3657 | RSS: Main: 215252992 23:31:44 INFO - PROCESS | 3657 | 23:31:47 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53634/tests/kraken/driver.html?testName=audio-dft) 23:31:48 INFO - PROCESS | 3657 | RSS: Main: 202563584 23:31:48 INFO - PROCESS | 3657 | 23:31:51 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53634/tests/kraken/driver.html?testName=audio-fft) 23:31:51 INFO - PROCESS | 3657 | RSS: Main: 269602816 23:31:51 INFO - PROCESS | 3657 | 23:31:53 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53634/tests/kraken/driver.html?testName=audio-oscillator) 23:31:54 INFO - PROCESS | 3657 | RSS: Main: 180604928 23:31:54 INFO - PROCESS | 3657 | 23:31:56 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:31:57 INFO - PROCESS | 3657 | RSS: Main: 183767040 23:31:57 INFO - PROCESS | 3657 | 23:32:00 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53634/tests/kraken/driver.html?testName=imaging-darkroom) 23:32:00 INFO - PROCESS | 3657 | RSS: Main: 219213824 23:32:00 INFO - PROCESS | 3657 | 23:32:04 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53634/tests/kraken/driver.html?testName=imaging-desaturate) 23:32:04 INFO - PROCESS | 3657 | RSS: Main: 221073408 23:32:04 INFO - PROCESS | 3657 | 23:32:07 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53634/tests/kraken/driver.html?testName=json-parse-financial) 23:32:08 INFO - PROCESS | 3657 | RSS: Main: 221589504 23:32:08 INFO - PROCESS | 3657 | 23:32:09 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:32:10 INFO - PROCESS | 3657 | RSS: Main: 208736256 23:32:10 INFO - PROCESS | 3657 | 23:32:12 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:32:12 INFO - PROCESS | 3657 | RSS: Main: 212537344 23:32:12 INFO - PROCESS | 3657 | 23:32:14 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:32:15 INFO - PROCESS | 3657 | RSS: Main: 211337216 23:32:15 INFO - PROCESS | 3657 | 23:32:17 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:32:18 INFO - PROCESS | 3657 | RSS: Main: 223789056 23:32:18 INFO - PROCESS | 3657 | 23:32:21 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:32:21 INFO - PROCESS | 3657 | RSS: Main: 224387072 23:32:21 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:53634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53634/tests/kraken/driver.html?testName=ai-astar) 23:32:23 INFO - PROCESS | 3657 | RSS: Main: 267177984 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | __start_tp_report 23:32:23 INFO - PROCESS | 3657 | _x_x_mozilla_page_load 23:32:23 INFO - PROCESS | 3657 | _x_x_mozilla_page_load_details 23:32:23 INFO - PROCESS | 3657 | |i|pagename|runs| 23:32:23 INFO - PROCESS | 3657 | |0;ai-astar;100;110;111;110;110;110;111;109;110;110 23:32:23 INFO - PROCESS | 3657 | |1;audio-beat-detection;148;123;118;162;116;116;149;115;147;116 23:32:23 INFO - PROCESS | 3657 | |2;audio-dft;161;161;162;162;160;162;163;162;161;161 23:32:23 INFO - PROCESS | 3657 | |3;audio-fft;74;75;76;131;76;77;76;74;104;75 23:32:23 INFO - PROCESS | 3657 | |4;audio-oscillator;84;83;115;84;85;85;123;85;84;135 23:32:23 INFO - PROCESS | 3657 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;117;116 23:32:23 INFO - PROCESS | 3657 | |6;imaging-darkroom;146;146;146;149;146;146;146;147;147;146 23:32:23 INFO - PROCESS | 3657 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 23:32:23 INFO - PROCESS | 3657 | |8;json-parse-financial;54;53;53;53;53;54;64;53;53;53 23:32:23 INFO - PROCESS | 3657 | |9;json-stringify-tinderbox;62;62;61;62;62;61;63;62;62;62 23:32:23 INFO - PROCESS | 3657 | |10;stanford-crypto-aes;76;76;76;74;75;75;76;76;75;79 23:32:23 INFO - PROCESS | 3657 | |11;stanford-crypto-ccm;118;118;118;118;122;119;122;118;164;125 23:32:23 INFO - PROCESS | 3657 | |12;stanford-crypto-pbkdf2;159;157;154;155;154;156;159;156;152;153 23:32:23 INFO - PROCESS | 3657 | |13;stanford-crypto-sha256-iterative;62;63;63;62;62;62;61;61;61;60 23:32:23 INFO - PROCESS | 3657 | __end_tp_report 23:32:23 INFO - PROCESS | 3657 | __start_cc_report 23:32:23 INFO - PROCESS | 3657 | _x_x_mozilla_cycle_collect,1663 23:32:23 INFO - PROCESS | 3657 | __end_cc_report 23:32:23 INFO - PROCESS | 3657 | __startTimestamp1467786743619__endTimestamp 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | ------- Summary: start ------- 23:32:23 INFO - PROCESS | 3657 | Number of tests: 14 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.25 (3.0%) stddev-sans-first:0.60 23:32:23 INFO - PROCESS | 3657 | Values: 100.0 110.0 111.0 110.0 110.0 110.0 111.0 109.0 110.0 110.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:135.00 stddev:18.24 (13.5%) stddev-sans-first:18.28 23:32:23 INFO - PROCESS | 3657 | Values: 148.0 123.0 118.0 162.0 116.0 116.0 149.0 115.0 147.0 116.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 23:32:23 INFO - PROCESS | 3657 | Values: 161.0 161.0 162.0 162.0 160.0 162.0 163.0 162.0 161.0 161.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.50 stddev:18.89 (25.0%) stddev-sans-first:19.70 23:32:23 INFO - PROCESS | 3657 | Values: 74.0 75.0 76.0 131.0 76.0 77.0 76.0 74.0 104.0 75.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:19.93 (23.7%) stddev-sans-first:20.63 23:32:23 INFO - PROCESS | 3657 | Values: 84.0 83.0 115.0 84.0 85.0 85.0 123.0 85.0 84.0 135.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 23:32:23 INFO - PROCESS | 3657 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 116.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 23:32:23 INFO - PROCESS | 3657 | Values: 146.0 146.0 146.0 149.0 146.0 146.0 146.0 147.0 147.0 146.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:32:23 INFO - PROCESS | 3657 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.00 stddev:3.43 (6.5%) stddev-sans-first:3.64 23:32:23 INFO - PROCESS | 3657 | Values: 54.0 53.0 53.0 53.0 53.0 54.0 64.0 53.0 53.0 53.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:32:23 INFO - PROCESS | 3657 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.32 (1.7%) stddev-sans-first:1.39 23:32:23 INFO - PROCESS | 3657 | Values: 76.0 76.0 76.0 74.0 75.0 75.0 76.0 76.0 75.0 79.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:120.50 stddev:14.20 (11.8%) stddev-sans-first:14.88 23:32:23 INFO - PROCESS | 3657 | Values: 118.0 118.0 118.0 118.0 122.0 119.0 122.0 118.0 164.0 125.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:2.37 (1.5%) stddev-sans-first:2.15 23:32:23 INFO - PROCESS | 3657 | Values: 159.0 157.0 154.0 155.0 154.0 156.0 159.0 156.0 152.0 153.0 23:32:23 INFO - PROCESS | 3657 | 23:32:23 INFO - PROCESS | 3657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 23:32:23 INFO - PROCESS | 3657 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 61.0 61.0 61.0 60.0 23:32:23 INFO - PROCESS | 3657 | -------- Summary: end -------- 23:32:23 INFO - PROCESS | 3657 | 23:32:24 INFO - TEST-INFO | 3657: exit 0 23:32:24 INFO - TEST-OK | kraken | took 60895ms 23:32:24 INFO - SUITE-END | took 1179s 23:32:24 INFO - Completed test suite (00:19:39) 23:32:24 INFO - javascript benchmark 23:32:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.9843900780497, 3131.091983324836, 3150.810951342921, 3151.2279491524573, 3165.6834316568347, 5204.739763011853, 5269.262303277545, 5285.418603953567, 5373.704446255454, 5420.078586640271, 5336.17289320155, 5344.812931547397, 5390.5418039466695, 5405.945940540593, 5416.783328666848, 4868.878278043042, 4883.902321953558, 4919.631027672921, 4919.827806026772, 5018.071656743514, 4940.604751619861, 4979.402471703401, 4982.352294201749, 4996.425411077718, 4997.85006449807, 4780.354652121954, 4791.880202994918, 4807.18277892759, 4822.565969062801, 4966.056449274644, 4821.85534433964, 4829.806807727722, 4835.830745923911, 4836.588889944359, 4929.605631549503, 4842.055799119174, 4869.926951095701, 4871.878203044952, 4880.804767809319, 4920.40955085392, 5263.710495922723, 5315.335583052119, 5315.920261196085, 5317.388500322474, 5421.891562168735, 5743.597948143632, 5815.185873977646, 5856.707164641751, 5861.413858614147, 5876.3242227144, 5878.588498805086, 5911.556633252523, 5923.407659234085, 5928.110783382484, 5936.970315148396, 5226.686398816083, 5367.275417818622, 5419.024575576355, 5506.862328441781, 5506.889862202774, 5965.254343207099, 5967.1347654589845, 5975.611585246945, 6000.369961154016, 6016.0, 5686.5735069869925, 5700.857478562986, 5702.771889124471, 5703.771849125988, 5712.314522257356, 5611.102223644279, 5703.258576385043, 5716.771329146871, 5775.826725198251, 5787.652740835563, 5786.450287222707, 5790.218320526675, 5794.0, 5804.622699524602, 5809.709514524341, 5748.683822389725, 5757.107648314518, 5803.912941305884, 5808.883822323614, 5819.301683797887, 4250.617444430016, 4316.762578058174, 4320.870373888788, 4325.84859529915, 4342.370356298319, 3954.0, 3954.703397245218, 3955.960440395617, 3974.7018973577096, 3984.621460961204, 5522.420145884705, 5528.087865502147, 5532.170174473861, 5533.0, 5578.665280083127, 5597.6641401516035, 5701.372848986608, 5726.226959360433, 5796.333421656479, 5843.18195452637, 5473.589480788877, 5481.506664400144, 5487.972560137254, 5490.533304669068, 5524.613277070647, 4986.925196122061, 4996.275540046673, 4996.7001979881325, 4999.150144475448, 5044.344235249468, 5730.77076916927, 5834.620749651259, 5839.240898683229, 5870.970645146747, 5945.0, 5752.0, 5761.222234998221, 5764.798232062026, 5767.625104368202, 5775.249217601685, 5934.851628709317, 5943.197668314895, 5947.672877991752, 5948.970255148696, 5956.404359564009, 5493.670379777066, 5633.746481408264, 5650.152477128299, 5676.602637815478, 5724.713764311685, 5769.884602308014, 5816.621919575214, 5819.098039803837, 5822.5633077518505, 5824.650520968756, 5380.300560927054, 5693.829185124453, 5703.714814259353, 5705.743241554057, 5706.2011318414625, 5591.077472217039, 5593.916091258553, 5635.042042852807, 5685.232493613475, 5712.885742285214, 5590.105583106683, 5590.888182236251, 5617.382087970402, 5632.493075623213, 5636.746346414339, 5499.725013749377, 5546.75039623226, 5726.828195154152, 5736.827895163152, 5792.247007888947, 5425.864353391039, 5460.017196904437, 5478.780848766005, 5500.0, 5522.806701765419], "value": 5317.3354707648905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.740650597472, 606.3360620120967, 612.2805703298626, 612.8559788449713, 626.0546574672244, 30567.38865222697, 43610.0, 44951.55048449514, 45012.99999999992, 45036.549634503644, 45532.544674553246, 45600.77199614006, 45928.770356148256, 46013.07973840521, 46067.53932460675, 8983.775405614862, 9135.269178465707, 9135.908640913573, 9139.131782480654, 9140.725778226664, 8939.284857211407, 8977.057408972061, 9000.369974101815, 9025.593848276843, 9028.909710902873, 9088.363814532986, 9142.314326425545, 9142.680006199784, 9143.948445928736, 9150.542472876363, 9056.049114842945, 9101.908980910172, 9120.817583648357, 9122.498262595554, 9122.954385228064, 8990.235829954461, 9050.86423703645, 9064.864027039599, 9064.864027039599, 9071.183593476553, 42773.0, 42794.14411711748, 43052.0, 43069.784651076545, 43141.13717725659, 3317.419451595961, 3513.49054387115, 3570.071781336845, 3577.749557530974, 3653.1597732521404, 32665.183370415692, 33255.66744332574, 33567.83216083929, 33577.108740471434, 33808.830955845064, 4432.312991486325, 4502.5047244803045, 4504.076664283814, 4647.488776234612, 4659.0, 341750.0, 345882.0, 346146.0, 346857.0, 348952.0, 43476.56523434789, 43582.78208609, 43684.78157609192, 43831.78084109559, 55437.72281138649, 60934.695326523084, 62775.6861215691, 62979.387164348, 67144.32855671478, 67206.32793672099, 16358.345666173458, 16541.338346466247, 16542.586435339213, 16548.917255413646, 16574.08842513649, 11709.0, 12144.089193310538, 12283.75432491363, 12297.508099676092, 12372.81440778389, 17550.648987020188, 17882.0, 18194.0, 18218.08909554517, 18415.0, 6336.619802811846, 6607.438367738796, 6624.86750264992, 6630.138082049302, 6720.547000344936, 934.5700977550403, 998.8301988661945, 1019.0828254570797, 1020.806046851096, 1085.5115198160859, 32990.67009329924, 33191.502127468106, 33387.83306083503, 33536.664633353845, 33813.661863381545, 1058.9470526473644, 1065.6909496246158, 1101.0, 1129.8474705914762, 1156.1386766858575, 16820.327186912633, 17069.48791536256, 17232.655346892992, 17291.308347666203, 17292.827071729374, 547440.0, 550192.0, 553004.0, 553771.0, 556372.0, 57942.420575794546, 57969.0, 58308.41691583115, 58577.414225857196, 58583.414165857794, 1242.714175739585, 1340.892728581711, 1352.0468070010618, 1375.917444953306, 1381.205806661174, 32576.674233258313, 33684.15789605279, 33963.0, 34070.0, 34170.31659366848, 41059.384109238985, 41459.585404145575, 41501.37747933723, 41526.377104344065, 41581.0, 367494.0, 373238.0, 375813.0, 376190.0, 376785.04467298486, 37873.81063094667, 41572.79213603913, 44021.0, 44778.0, 45802.0, 48179.0, 49304.26043609277, 49382.75308623434, 50150.49849501604, 52620.0, 42386.788066059475, 42616.0, 42629.0, 43605.78197108994, 44191.779041104586, 41916.580834192486, 43184.136317274104, 43202.975791694276, 43381.34927976146, 43421.34867977046, 41199.58800411958, 41669.374959375025, 42734.93162670958, 42885.0, 42941.355879661205, 30951.69048309488, 32604.184895377806, 32700.50949235716, 32752.0, 32928.67071329256, 27977.72022279751, 28370.290742730773, 28395.290117747223, 28405.715942840307, 28581.714182857904], "value": 20141.654939897133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.93856982882744, 386.5361566120656, 399.16176030336317, 399.66028875455856, 413.86549371454265, 18359.632807343845, 20688.89655551724, 20861.643993140435, 21220.787792122075, 21225.469363265925, 19407.708884366744, 19422.931738754363, 19651.508712282164, 19734.802651973478, 19906.402807915787, 5324.414314425429, 5593.776248950047, 5810.680412577307, 6428.0, 6433.8391540211405, 6391.169148010752, 6397.392247736458, 6413.134226879358, 6424.325445828191, 6451.096846441502, 7289.453291003169, 7697.268759467842, 7708.498947568418, 7710.691572337099, 7847.764567062997, 7296.37980771635, 7514.812129696774, 7686.846263074764, 7698.2686644768655, 7701.768946931601, 7212.098487689039, 7392.039034925425, 7394.37147842434, 7424.443166762514, 7533.510321829063, 27053.458930821274, 27307.45385092287, 27913.720862791317, 27934.860325698242, 28027.85103492386, 2563.73339952836, 2715.2397328747984, 2721.2652583802264, 2732.631094802196, 3243.335116301176, 15415.306311216022, 15894.9205253973, 16115.516534503984, 16935.491935241964, 17222.0, 2062.6287268291703, 2086.937391878246, 2121.193946300396, 2132.264368792764, 2179.901904414289, 94430.0, 100494.0, 101050.0, 101225.0, 103387.0, 17760.822391776175, 17911.0, 18028.36900708469, 18315.0, 18516.888986660844, 32086.0, 32368.83815580907, 32687.673123268938, 32813.67186328154, 32827.1793205167, 9803.264755143393, 10184.388936663823, 10232.53953572091, 10236.641717539851, 10354.741131471774, 8514.106018868053, 8549.700760473477, 8583.18459746323, 8680.262177714965, 8698.47809131454, 8880.001999550179, 9127.178553930178, 9245.583948722324, 9364.484953327496, 9506.575823165187, 3410.23269764306, 3455.274392377629, 3511.754177207622, 3520.489529018278, 3608.224231790178, 890.425675439338, 955.5031383680447, 957.7557722780647, 1055.9472026398803, 1069.7111779819404, 19673.90163049204, 20180.798192017894, 20183.293584724463, 20230.393088207376, 20542.589148216954, 964.6720115160739, 974.3812678948776, 1031.5615863258085, 1056.271172890703, 1063.3460421840666, 10610.787784244427, 10989.450527473595, 10989.450527473755, 11024.779504409868, 11064.114870810316, 454310.0, 459577.0, 464422.0, 464999.0, 465011.0, 69128.0, 83951.0, 86466.0, 96541.51729241449, 97303.51348243213, 958.2765012415582, 963.9132478077007, 989.218517371283, 990.6136606723384, 991.3407583956732, 17820.821791781917, 17866.196021178817, 18118.45644630663, 18263.81736182621, 18567.90716046411, 34465.48301775526, 44555.0, 44816.55183448124, 45343.31985020162, 45504.0, 58227.4177258222, 59212.0, 59504.70247648734, 59580.0, 61113.69443152756, 8707.651693932172, 8709.956450217709, 8800.383973122076, 8966.058563850962, 9236.168744813, 9861.408315501092, 12540.749185016432, 14221.075630084011, 14243.287835608386, 14323.355449005028, 11962.282263064244, 12113.33376664292, 12129.636110916686, 12159.209651372632, 12453.501859925502, 11860.525578976743, 12175.086868485076, 12199.817002744789, 12247.510099595916, 12350.567730129402, 11796.823047654121, 11870.169088164092, 11900.226485278428, 12500.0, 12693.301868396957, 8839.779005524913, 8966.0, 9011.729648110568, 9029.683961061332, 9251.444913305224, 9157.679481218393, 12147.574834880737, 12167.452464638935, 12195.146339756488, 12220.144589878622], "value": 10664.39046563106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.8154239948808, 1478.9852101478984, 1510.4486862295266, 1640.655462352905, 1662.3433743671242, 8431.19903609157, 8909.554522273877, 8992.8651070234, 9010.414323068995, 9017.639294428223, 7587.848243035136, 8377.246047855691, 8606.95696521518, 8625.956870215656, 8786.165314295147, 2346.7653234676523, 2375.8455700379504, 2376.0377047295874, 2377.869217193054, 2378.3459548624096, 2320.9535809283802, 2334.556434277482, 2370.0, 2370.5377451396985, 2377.869217193054, 2005.368308982666, 2079.906404211814, 2235.8099561537288, 2317.7450480447137, 2331.40549159964, 2299.1263319938485, 2336.707911511061, 2339.6958395408574, 2345.0854166874933, 2350.9412264693347, 2315.6873822034145, 2321.152779235567, 2325.813934885222, 2330.4639932815376, 2331.1258278145697, 8620.439671421338, 8622.78443038929, 8684.001339845936, 8691.60887760046, 8717.476951382874, 4915.877103072416, 5032.798688052473, 5054.9241761373605, 5061.190209566452, 5066.923996140061, 3222.130024893289, 3244.156519304974, 3364.0, 3412.436947903593, 3413.0784688134313, 1186.0452335869622, 1193.9672183561245, 1992.1832048859899, 2036.5112373030515, 2081.2715549557684, 11950.402479875971, 12140.575079872162, 12158.209716368408, 12191.878081219164, 12289.385530723428, 4247.957520424818, 4336.588024137702, 4404.229259879508, 4484.484284307347, 4486.12520558488, 10313.896861031444, 10331.586736530606, 10336.793264134676, 10342.638007669695, 10352.844707329396, 5073.162928116893, 5076.492350764894, 5084.008618319393, 5085.262636917701, 5086.643934924594, 4652.116097941448, 4686.250199967989, 4693.178693728584, 4694.600958918462, 4810.326554282403, 3814.5994670559194, 3869.303525365461, 3877.84488620452, 3922.3528117860806, 3993.101552150743, 1127.577158565538, 1152.4986630815622, 1195.0857593940643, 1201.6515210589007, 1205.4033253539553, 804.4288555125809, 812.5165526511717, 830.529175702293, 847.4999750147442, 850.961706723199, 5601.719914004365, 5620.18507316445, 5838.38696936824, 5925.911111333334, 6026.186464827192, 477.4366247827597, 485.0735095966757, 487.0599742497015, 489.22457904221494, 634.1122428599905, 4008.3987401889367, 4064.248114098901, 4208.915821683549, 4316.5467625899455, 4327.1345730853955, 10833.458327083772, 10996.780064398667, 10998.890011099787, 11098.889011109946, 11124.276922000045, 9172.816543669089, 10023.2482563808, 10359.948200259101, 10960.28758130735, 11001.119910407147, 7940.6029698515995, 8069.31410830086, 8093.554854482943, 8105.351571874236, 8109.513429194267, 5685.630434021776, 5688.175214593778, 5843.970780146072, 5890.676012819336, 6087.0, 10024.398536087567, 10047.748806279902, 10175.084242418217, 10246.0, 10304.072633463024, 10460.63387781424, 10488.0, 10495.685129446128, 10587.523561439908, 10595.735106622396, 7102.325279098477, 7842.686292548462, 7990.480618759762, 7995.0, 7996.160403157584, 8095.797605059685, 8468.026176989724, 8470.364722645703, 8475.40672152968, 8479.533625650649, 7267.672954717156, 7468.215837337001, 7533.359664428585, 7595.354394876497, 7651.808704782425, 7236.6019868907715, 7364.484486085923, 7389.0, 7435.628218589157, 7453.739119130804, 6809.250982392032, 6881.862362752817, 6903.585784852925, 6908.758193463204, 6910.239873613999, 4847.248676455155, 4928.950710492993, 4955.752212389294, 5009.499050094962, 5055.140626093499, 4934.605231581393, 4957.628177886745, 5004.799808007639, 5076.543111120017, 5145.07388670028], "value": 4530.840236635668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.6628173558631, 328.36789180826906, 336.52045834685583, 339.98640054397816, 340.16150189782184, 5180.7409629518515, 5309.73451327433, 5322.494363035516, 5369.785208591652, 5396.892062158754, 5315.760790764415, 5321.201819727043, 5329.520343169114, 5332.306800115979, 5332.973335133329, 4209.4317267169, 4210.663146948252, 4213.515445723743, 4224.986003359202, 4244.511881133678, 3976.5228172619327, 4179.874603761892, 4188.308929026707, 4207.410962465257, 4207.72649777765, 4127.422160897477, 4147.3778933159965, 4154.97922510387, 4156.937645935313, 4177.916441671165, 4150.605692459242, 4160.209560183555, 4160.355144952538, 4170.416141740159, 4184.246835569596, 3628.929465807567, 3696.815159242027, 3715.368387374153, 3715.925681486382, 3723.832427540767, 5197.8440646780655, 5202.193659982671, 5230.215467679878, 5257.526822585947, 5282.920756188661, 4734.834280800155, 4760.262159365304, 4762.928556071662, 4786.305985632099, 4808.783604737795, 5442.836714898559, 5575.804846830382, 5576.275084239063, 5585.804496842591, 5587.38538760736, 4048.959510404917, 4055.837766489337, 4056.9594304057173, 4061.7562946223024, 4079.2453396121814, 5549.084401073818, 5708.4576965187825, 5837.09525023622, 5841.912371314434, 5847.590668653196, 3877.2051729395407, 3883.3592457244804, 3918.49059622253, 3982.4424580558743, 4125.463689720317, 4128.958710412918, 4129.690273229459, 4183.288840897055, 4184.100418410057, 4190.28765109932, 4617.907641847144, 4774.708140092775, 4785.258284965836, 4789.425268967677, 4794.640401969797, 5569.136783798518, 5571.749271282802, 5602.775888964396, 5604.327480702342, 5621.959937411592, 1414.2292450614234, 1434.6556826361598, 1439.7264519741425, 1441.8630230128122, 1442.624917521452, 891.0510306523531, 925.6806401791506, 931.7484279244566, 950.9524523773922, 951.3958636266021, 4812.494688057704, 4820.156472617278, 4837.806487740451, 4843.515648435199, 4853.369062021985, 5057.6459647824295, 5074.923876141861, 5116.0, 5124.871878203075, 5133.023785842477, 4658.557437043475, 4811.158047341702, 4833.806647734052, 4857.392825896763, 4861.392325959255, 2686.8656567171565, 2705.485957668037, 2715.6876959149554, 2725.196067160153, 2728.4406696627143, 5200.323957885451, 5216.895946911657, 5232.92150617741, 5234.633575649744, 5256.448072952361, 4946.282788995575, 5182.922256166161, 5198.298229738937, 5206.219067139959, 5215.956808638288, 5114.181730923109, 5217.3999990000875, 5244.947550524522, 5255.264263003182, 5270.445218660504, 4967.552920237196, 5028.617130289053, 5037.549278744072, 5074.904308371816, 5123.666961647481, 4669.322948172564, 4976.427710813158, 5003.54968052877, 5033.370828646419, 5036.219385995177, 5670.404607516151, 5731.5701322400155, 5896.262967129109, 5903.0, 5903.760210355874, 3978.6419222270133, 3988.561258261647, 3988.660963818108, 3995.7013970459134, 4002.0995276062654, 5545.833624991256, 5765.91351129725, 5783.322836377572, 5785.30576330843, 5786.508146807569, 5616.578756593353, 5636.887262254814, 5650.463205995424, 5655.406182350794, 5659.151127330933, 5587.636803607753, 5601.7759289629585, 5612.298462692163, 5672.1072253152015, 5680.857978550569, 5119.436861945258, 5481.424450432647, 5525.889482210414, 5553.0, 5567.860803479945, 5637.238972738792, 5638.830835074954, 5645.802396916252, 5652.3217213934595, 5656.321241451053, 5541.251930989265, 5565.693886836101, 5569.749361278671, 5580.832575022756, 5590.204897551224], "value": 4140.9877963787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8994385757923, 782.2529484342454, 798.6326289906642, 807.3460496997429, 822.6791551294996, 14136.363863626137, 15084.0, 15124.848751512482, 15126.470573529916, 15144.54566363008, 14105.012649114566, 14267.785983210235, 14273.643158921031, 14567.562973110797, 14736.336864841081, 641.4291280760127, 790.134802391382, 798.1459837973371, 800.4236949396454, 802.0736049862418, 776.8368642585064, 799.188823344306, 802.3380710913519, 802.4543310548825, 803.907550631676, 830.5307501261768, 831.1148626712562, 831.3723139030024, 833.1834801894147, 833.5707110837923, 665.7470161338708, 688.2704333406605, 813.1137060603941, 814.9388795840306, 815.7185770909057, 501.8670052436107, 584.7748616782569, 599.0475144520234, 602.0667964654767, 603.8520562462181, 14458.783118253235, 14515.201663908481, 14567.344469498898, 14576.781348279785, 14600.634984125481, 14228.57314280563, 14552.854471455255, 14613.853861461355, 14719.0, 14730.705385892223, 12696.365181740968, 12806.23162610237, 12811.679708007281, 12847.229166250056, 13022.544210952572, 4422.469303683546, 4455.754933478657, 4498.077894031716, 4531.07113041829, 4620.376249206348, 72869.0, 73243.26756732418, 73257.26742732504, 73616.6319168406, 73984.26015739827, 11464.0, 11523.135764817673, 11589.82615260755, 11697.23967942081, 11922.52309907594, 21717.891410542845, 21718.45703857416, 21747.23884664029, 21760.564788704138, 21762.0, 8725.083866194085, 8740.300775937909, 8749.343799215085, 8900.688475903313, 9001.414908030956, 4595.770211489479, 4766.523347665206, 4818.590419814285, 4886.364772579542, 4927.802887884444, 3194.3291908699434, 3272.60728712556, 3273.918152046218, 3276.5904261967253, 3279.770416070852, 599.9430054144849, 610.6031079798078, 614.8493619063358, 615.5875563372551, 631.340249439337, 662.1326062857672, 663.1213641924373, 673.5655502201053, 673.9966300168468, 687.8417963868338, 8987.370884038055, 9111.453312801254, 9146.771330716785, 9264.212541934012, 9706.70879873605, 638.8945823938998, 658.1969996604231, 669.8928171492538, 680.306087790451, 689.689639662154, 4203.873883783492, 4223.176480586318, 4293.441346930886, 4307.612314891675, 4356.716813407118, 107085.0, 111041.44479277552, 111536.0, 112325.4383728076, 113236.0, 100988.49505752424, 101253.0, 102736.48631756943, 103444.0, 103707.0, 88019.0, 89623.55188224016, 89915.55042224878, 90847.54576227076, 93478.53260733653, 8455.577221138796, 8564.143585641386, 8568.828623427622, 8626.09426010285, 8801.251893589117, 52554.73722631362, 52796.47203528069, 52807.47192528025, 53235.73382133064, 54958.0, 71217.0, 77392.0, 79502.0, 79977.60011199907, 81074.59462702884, 11287.774244515227, 11404.600838970928, 11965.282083074695, 12499.813160477668, 12689.492420303453, 12663.986881049677, 12665.493380264686, 12959.481620735065, 13293.734125317245, 13326.600201993955, 10922.344659320466, 11537.596184133516, 11546.82679759821, 11886.227395219283, 11903.16677832578, 11759.529618815151, 11802.350870702194, 12004.75990480203, 12377.133600647869, 12489.0, 11681.415929203677, 11966.64100076999, 12241.816372754594, 12509.812352814897, 12621.0, 9791.657291994747, 9893.406395616286, 10027.448490333101, 10031.598736050477, 10211.591536338463, 9455.19630831387, 9694.418334899929, 9768.706938791847, 9877.160441362277, 9913.65302214419], "value": 7306.462934552177, "unit": "score"}], "name": "dromaeo_css", "value": 7341.6563810426, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 118.0, 162.0, 116.0, 116.0, 149.0, 115.0, 147.0, 116.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 163.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 131.0, 76.0, 77.0, 76.0, 74.0, 104.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 85.0, 85.0, 123.0, 85.0, 84.0, 135.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 149.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 64.0, 53.0, 53.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 74.0, 75.0, 75.0, 76.0, 76.0, 75.0, 79.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 122.0, 119.0, 122.0, 118.0, 164.0, 125.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 154.0, 155.0, 154.0, 156.0, 159.0, 156.0, 152.0, 153.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1474.1000000000001, "alertThreshold": 2.0}]} 23:32:24 INFO - Return code: 0 23:32:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:32:24 INFO - # TBPL SUCCESS # 23:32:24 INFO - Running post-action listener: _resource_record_post_action 23:32:24 INFO - ##### 23:32:24 INFO - ##### Finished run-tests step (success) 23:32:24 INFO - ##### 23:32:24 INFO - Running post-run listener: _resource_record_post_run 23:32:24 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7819264; Write bytes: 428875776; Read time: 1788; Write time: 390216 23:32:24 INFO - TinderboxPrint: CPU usage
13.0% 23:32:24 INFO - TinderboxPrint: I/O read bytes / time
7,819,264 / 1,788 23:32:24 INFO - TinderboxPrint: I/O write bytes / time
428,875,776 / 390,216 23:32:24 INFO - TinderboxPrint: CPU idle
8,306.1 (86.9%) 23:32:24 INFO - TinderboxPrint: CPU user
1,197.8 (12.5%) 23:32:24 INFO - TinderboxPrint: Swap in / out
0 / 0 23:32:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 7380992; Read time: 0; Write time: 5668 23:32:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5578752; Write bytes: 421494784; Read time: 1616; Write time: 384548 23:32:25 INFO - Running post-run listener: _upload_blobber_files 23:32:25 INFO - Blob upload gear active. 23:32:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:32:25 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 23:32:25 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:32:25 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:32:25 INFO - (blobuploader) - INFO - Open directory for files ... 23:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:26 INFO - (blobuploader) - INFO - Done attempting. 23:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:30 INFO - (blobuploader) - INFO - Done attempting. 23:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:31 INFO - (blobuploader) - INFO - Done attempting. 23:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 23:32:31 INFO - Return code: 0 23:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b38cf3475ebd5493f69eb3d092568b079dbef4ef5397404b913bcbd89c82eb548b67d311d230ea31bbab56e0aa3d88b509f8f7dd4f936b37e5925e9996c6ebe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d32cfec49780b466f029492a715a5174c9ef887f0c5a59da59069cab31933b3de90caaa2584fe5eaaf74a64262e17bc4894c177e9309d3cb19e09bceb6d55b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb41666963084361a8d29b2cf3b8094a2caab1d73cb63576f8beeefbc321253acd621656b6d9cb73c2426e47203829544780094bfc98a38c6bd33597b053199"} 23:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:32:31 INFO - Contents: 23:32:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b38cf3475ebd5493f69eb3d092568b079dbef4ef5397404b913bcbd89c82eb548b67d311d230ea31bbab56e0aa3d88b509f8f7dd4f936b37e5925e9996c6ebe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d32cfec49780b466f029492a715a5174c9ef887f0c5a59da59069cab31933b3de90caaa2584fe5eaaf74a64262e17bc4894c177e9309d3cb19e09bceb6d55b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb41666963084361a8d29b2cf3b8094a2caab1d73cb63576f8beeefbc321253acd621656b6d9cb73c2426e47203829544780094bfc98a38c6bd33597b053199"} 23:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 23:32:31 INFO - Copying logs to upload dir... 23:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 23:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.885874 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-05 23:32:31.191687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:31.195450) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b38cf3475ebd5493f69eb3d092568b079dbef4ef5397404b913bcbd89c82eb548b67d311d230ea31bbab56e0aa3d88b509f8f7dd4f936b37e5925e9996c6ebe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d32cfec49780b466f029492a715a5174c9ef887f0c5a59da59069cab31933b3de90caaa2584fe5eaaf74a64262e17bc4894c177e9309d3cb19e09bceb6d55b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb41666963084361a8d29b2cf3b8094a2caab1d73cb63576f8beeefbc321253acd621656b6d9cb73c2426e47203829544780094bfc98a38c6bd33597b053199"} build_url:https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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/Fx-Team/sha512/3b38cf3475ebd5493f69eb3d092568b079dbef4ef5397404b913bcbd89c82eb548b67d311d230ea31bbab56e0aa3d88b509f8f7dd4f936b37e5925e9996c6ebe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d32cfec49780b466f029492a715a5174c9ef887f0c5a59da59069cab31933b3de90caaa2584fe5eaaf74a64262e17bc4894c177e9309d3cb19e09bceb6d55b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb41666963084361a8d29b2cf3b8094a2caab1d73cb63576f8beeefbc321253acd621656b6d9cb73c2426e47203829544780094bfc98a38c6bd33597b053199"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:31.220080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:31.220361) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467784274.508773-1563867973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:31.305433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:32:31.305700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:32:31.305947) ========= ========= Total master_lag: 0.21 =========