builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1468880097.91 results: success (0) buildid: 20160718124149 builduid: 77455f5ef6a9475dab8ef32eea89f417 revision: 2a69345f4f4eeb804e6a96c70f086f10e9849724 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:57.912148) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:57.912733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:57.913009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:57.988765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:57.989036) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 15:14:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-07-18 15:14:58 (13.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.199277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.199564) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.248883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.249207) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2a69345f4f4eeb804e6a96c70f086f10e9849724 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2a69345f4f4eeb804e6a96c70f086f10e9849724 --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=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 15:14:58,753 truncating revision to first 12 chars 2016-07-18 15:14:58,753 Setting DEBUG logging. 2016-07-18 15:14:58,753 attempt 1/10 2016-07-18 15:14:58,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2a69345f4f4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 15:14:59,052 unpacking tar archive at: autoland-2a69345f4f4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.901583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.901952) ========= script_repo_revision: 2a69345f4f4eeb804e6a96c70f086f10e9849724 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.902462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.902825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 15:14:58.913149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-18 15:14:58.913440) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:59 INFO - MultiFileLogger online at 20160718 15:14:59 in /builds/slave/test 15:14:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:14:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:59 INFO - {'append_to_log': False, 15:14:59 INFO - 'base_work_dir': '/builds/slave/test', 15:14:59 INFO - 'blob_upload_branch': 'Autoland', 15:14:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:59 INFO - 'branch': 'Autoland', 15:14:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:59 INFO - 'config_files': ('talos/linux_config.py',), 15:14:59 INFO - 'default_actions': ('clobber', 15:14:59 INFO - 'read-buildbot-config', 15:14:59 INFO - 'download-and-extract', 15:14:59 INFO - 'populate-webroot', 15:14:59 INFO - 'create-virtualenv', 15:14:59 INFO - 'install', 15:14:59 INFO - 'run-tests'), 15:14:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:59 INFO - 'download_minidump_stackwalk': True, 15:14:59 INFO - 'download_symbols': 'ondemand', 15:14:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:59 INFO - 'installer_path': 'installer.exe', 15:14:59 INFO - 'log_level': 'info', 15:14:59 INFO - 'log_name': 'talos', 15:14:59 INFO - 'log_to_console': True, 15:14:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:59 INFO - 'opt_config_files': (), 15:14:59 INFO - 'pip_index': False, 15:14:59 INFO - 'sps_profile': False, 15:14:59 INFO - 'sps_profile_interval': 0, 15:14:59 INFO - 'suite': 'dromaeojs-e10s', 15:14:59 INFO - 'system_bits': '32', 15:14:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:59 INFO - 'title': 'talos-linux64-ix-067', 15:14:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:59 INFO - 'use_talos_json': True, 15:14:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:59 INFO - 'work_dir': 'build'} 15:14:59 INFO - ##### 15:14:59 INFO - ##### Running clobber step. 15:14:59 INFO - ##### 15:14:59 INFO - Running pre-action listener: _resource_record_pre_action 15:14:59 INFO - Running main action method: clobber 15:14:59 INFO - rmtree: /builds/slave/test/build 15:14:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:59 INFO - Running post-action listener: _resource_record_post_action 15:14:59 INFO - ##### 15:14:59 INFO - ##### Finished clobber step (success) 15:14:59 INFO - ##### 15:14:59 INFO - ##### 15:14:59 INFO - ##### Running read-buildbot-config step. 15:14:59 INFO - ##### 15:14:59 INFO - Running pre-action listener: _resource_record_pre_action 15:14:59 INFO - Running main action method: read_buildbot_config 15:14:59 INFO - Using buildbot properties: 15:14:59 INFO - { 15:14:59 INFO - "project": "", 15:14:59 INFO - "product": "firefox", 15:14:59 INFO - "script_repo_revision": "production", 15:14:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:14:59 INFO - "repository": "", 15:14:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:14:59 INFO - "buildid": "20160718124149", 15:14:59 INFO - "pgo_build": "True", 15:14:59 INFO - "basedir": "/builds/slave/test", 15:14:59 INFO - "buildnumber": 43, 15:14:59 INFO - "slavename": "talos-linux64-ix-067", 15:14:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:14:59 INFO - "platform": "ubuntu64_hw", 15:14:59 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:14:59 INFO - "branch": "autoland", 15:14:59 INFO - "repo_path": "integration/autoland", 15:14:59 INFO - "revision": "2a69345f4f4eeb804e6a96c70f086f10e9849724", 15:14:59 INFO - "stage_platform": "linux64-pgo", 15:14:59 INFO - "builduid": "77455f5ef6a9475dab8ef32eea89f417", 15:14:59 INFO - "slavebuilddir": "test" 15:14:59 INFO - } 15:14:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:14:59 INFO - Running post-action listener: _resource_record_post_action 15:14:59 INFO - ##### 15:14:59 INFO - ##### Finished read-buildbot-config step (success) 15:14:59 INFO - ##### 15:14:59 INFO - ##### 15:14:59 INFO - ##### Running download-and-extract step. 15:14:59 INFO - ##### 15:14:59 INFO - Running pre-action listener: _resource_record_pre_action 15:14:59 INFO - Running main action method: download_and_extract 15:14:59 INFO - mkdir: /builds/slave/test/build/tests 15:14: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')]} 15:14:59 INFO - https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:01 INFO - Downloaded 1361 bytes. 15:15:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:15:01 INFO - Using the following test package requirements: 15:15:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:15:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:15:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:15:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'jsshell-linux-x86_64.zip'], 15:15:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:15:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:15:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:15:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:15:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:15:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:15:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:15: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')]} 15:15:01 INFO - https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:16 INFO - Downloaded 24335295 bytes. 15:15:16 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'] 15:15:16 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 15:15:17 INFO - Return code: 0 15:15:17 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 15:15: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')]} 15:15:17 INFO - https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:15:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:15:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:15:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:25 INFO - Downloaded 24335295 bytes. 15:15:25 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'] 15:15:25 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 15:15:26 INFO - Return code: 0 15:15: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')]} 15:15:26 INFO - https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:27 INFO - Downloaded 14403317 bytes. 15:15:27 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'] 15:15:27 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 15:15:28 INFO - Return code: 0 15:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:28 INFO - https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHtqAl6kQvaD74dyISGAhg/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 15:15:29 INFO - Downloaded 60858976 bytes. 15:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:15:29 INFO - mkdir: /builds/slave/test/properties 15:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:29 INFO - Contents: 15:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:15:30 INFO - Running post-action listener: _resource_record_post_action 15:15:30 INFO - Running post-action listener: set_extra_try_arguments 15:15:30 INFO - ##### 15:15:30 INFO - ##### Finished download-and-extract step (success) 15:15:30 INFO - ##### 15:15:30 INFO - ##### 15:15:30 INFO - ##### Running populate-webroot step. 15:15:30 INFO - ##### 15:15:30 INFO - Running pre-action listener: _resource_record_pre_action 15:15:30 INFO - Running main action method: populate_webroot 15:15:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:30 INFO - '--tppagecycles', 15:15:30 INFO - '7'], 15:15:30 INFO - 'tests': ['tsvgm']}}, 15:15:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['damp', 'tps']}, 15:15:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'tests': ['damp', 'tps']}, 15:15:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['dromaeo_dom']}, 15:15:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['basic_compositor_video']}, 15:15:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:15:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['a11yr', 15:15:30 INFO - 'ts_paint', 15:15:30 INFO - 'tpaint', 15:15:30 INFO - 'sessionrestore', 15:15:30 INFO - 'sessionrestore_no_auto_restore', 15:15:30 INFO - 'tabpaint']}, 15:15:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['tsvgx', 15:15:30 INFO - 'tsvgr_opacity', 15:15:30 INFO - 'tart', 15:15:30 INFO - 'tscrollx', 15:15:30 INFO - 'cart']}, 15:15:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:30 INFO - 'tsvgr_opacity', 15:15:30 INFO - 'tart', 15:15:30 INFO - 'tscrollx', 15:15:30 INFO - 'cart']}, 15:15:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'talos_options': ['--disable-e10s'], 15:15:30 INFO - 'tests': ['tp5o']}, 15:15:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'tests': ['tp5o']}, 15:15:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'talos_options': ['--disable-e10s', 15:15:30 INFO - '--xperf_path', 15:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:30 INFO - 'tests': ['tp5n']}, 15:15:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:30 INFO - 'talos_options': ['--xperf_path', 15:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:30 INFO - 'tests': ['tp5n']}}, 15:15:30 INFO - 'talos.zip': {'path': '', 15:15:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:30 INFO - Running post-action listener: _resource_record_post_action 15:15:30 INFO - ##### 15:15:30 INFO - ##### Finished populate-webroot step (success) 15:15:30 INFO - ##### 15:15:30 INFO - ##### 15:15:30 INFO - ##### Running create-virtualenv step. 15:15:30 INFO - ##### 15:15:30 INFO - Running pre-action listener: _resource_record_pre_action 15:15:30 INFO - Running main action method: create_virtualenv 15:15:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:30 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 15:15:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:30 INFO - Using real prefix '/usr' 15:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:32 INFO - Installing pip.................done. 15:15:32 INFO - Return code: 0 15:15:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:15:32 INFO - Using env: {'DISPLAY': ':0', 15:15:32 INFO - 'HOME': '/home/cltbld', 15:15:32 INFO - 'LANG': 'en_US.UTF-8', 15:15:32 INFO - 'LANGUAGE': 'en_US:en', 15:15:32 INFO - 'LOGNAME': 'cltbld', 15:15:32 INFO - 'MAIL': '/var/mail/cltbld', 15:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:32 INFO - 'MOZ_NO_REMOTE': '1', 15:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:32 INFO - 'NO_EM_RESTART': '1', 15:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:32 INFO - 'PWD': '/builds/slave/test', 15:15:32 INFO - 'SHELL': '/bin/bash', 15:15:32 INFO - 'SHLVL': '1', 15:15:32 INFO - 'TERM': 'linux', 15:15:32 INFO - 'TMOUT': '86400', 15:15:32 INFO - 'USER': 'cltbld', 15:15:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:32 INFO - '_': '/tools/buildbot/bin/python'} 15:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:32 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 15:15:32 INFO - Cleaning up... 15:15:33 INFO - Return code: 0 15:15:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:15:33 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')]} 15:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:33 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')]} 15:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:33 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:33 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 15:15:33 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 15:15:33 INFO - Using env: {'DISPLAY': ':0', 15:15:33 INFO - 'HOME': '/home/cltbld', 15:15:33 INFO - 'LANG': 'en_US.UTF-8', 15:15:33 INFO - 'LANGUAGE': 'en_US:en', 15:15:33 INFO - 'LOGNAME': 'cltbld', 15:15:33 INFO - 'MAIL': '/var/mail/cltbld', 15:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:33 INFO - 'MOZ_NO_REMOTE': '1', 15:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:33 INFO - 'NO_EM_RESTART': '1', 15:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:33 INFO - 'PWD': '/builds/slave/test', 15:15:33 INFO - 'SHELL': '/bin/bash', 15:15:33 INFO - 'SHLVL': '1', 15:15:33 INFO - 'TERM': 'linux', 15:15:33 INFO - 'TMOUT': '86400', 15:15:33 INFO - 'USER': 'cltbld', 15:15:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:33 INFO - '_': '/tools/buildbot/bin/python'} 15:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:33 INFO - Downloading/unpacking psutil>=3.1.1 15:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:35 INFO - Installing collected packages: psutil 15:15:35 INFO - Running setup.py install for psutil 15:15:35 INFO - building 'psutil._psutil_linux' extension 15:15:35 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 15:15:35 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 15:15:35 INFO - building 'psutil._psutil_posix' extension 15:15:35 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 15:15:35 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 15:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:35 INFO - Successfully installed psutil 15:15:35 INFO - Cleaning up... 15:15:35 INFO - Return code: 0 15:15:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:15:35 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')]} 15:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:35 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')]} 15:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:35 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:35 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 15:15:35 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 15:15:35 INFO - Using env: {'DISPLAY': ':0', 15:15:35 INFO - 'HOME': '/home/cltbld', 15:15:35 INFO - 'LANG': 'en_US.UTF-8', 15:15:35 INFO - 'LANGUAGE': 'en_US:en', 15:15:35 INFO - 'LOGNAME': 'cltbld', 15:15:35 INFO - 'MAIL': '/var/mail/cltbld', 15:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:35 INFO - 'MOZ_NO_REMOTE': '1', 15:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:35 INFO - 'NO_EM_RESTART': '1', 15:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:35 INFO - 'PWD': '/builds/slave/test', 15:15:35 INFO - 'SHELL': '/bin/bash', 15:15:35 INFO - 'SHLVL': '1', 15:15:35 INFO - 'TERM': 'linux', 15:15:35 INFO - 'TMOUT': '86400', 15:15:35 INFO - 'USER': 'cltbld', 15:15:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:35 INFO - '_': '/tools/buildbot/bin/python'} 15:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:15:37 INFO - Installing collected packages: mozsystemmonitor 15:15:37 INFO - Running setup.py install for mozsystemmonitor 15:15:38 INFO - Successfully installed mozsystemmonitor 15:15:38 INFO - Cleaning up... 15:15:38 INFO - Return code: 0 15:15:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:15:38 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')]} 15:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:38 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')]} 15:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:38 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:38 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 15:15:38 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 15:15:38 INFO - Using env: {'DISPLAY': ':0', 15:15:38 INFO - 'HOME': '/home/cltbld', 15:15:38 INFO - 'LANG': 'en_US.UTF-8', 15:15:38 INFO - 'LANGUAGE': 'en_US:en', 15:15:38 INFO - 'LOGNAME': 'cltbld', 15:15:38 INFO - 'MAIL': '/var/mail/cltbld', 15:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:38 INFO - 'MOZ_NO_REMOTE': '1', 15:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:38 INFO - 'NO_EM_RESTART': '1', 15:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:38 INFO - 'PWD': '/builds/slave/test', 15:15:38 INFO - 'SHELL': '/bin/bash', 15:15:38 INFO - 'SHLVL': '1', 15:15:38 INFO - 'TERM': 'linux', 15:15:38 INFO - 'TMOUT': '86400', 15:15:38 INFO - 'USER': 'cltbld', 15:15:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:38 INFO - '_': '/tools/buildbot/bin/python'} 15:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:15:38 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 15:15:38 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 15:15:38 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 15:15:38 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 15:15:38 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 15:15:38 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 15:15:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:40 INFO - warning: no files found matching '*.txt' 15:15:40 INFO - no previously-included directories found matching 'build' 15:15:40 INFO - no previously-included directories found matching 'dist' 15:15:40 INFO - no previously-included directories found matching '.git*' 15:15:40 INFO - Installing collected packages: jsonschema, functools32 15:15:40 INFO - Running setup.py install for functools32 15:15:40 INFO - warning: no files found matching '*.txt' 15:15:40 INFO - no previously-included directories found matching 'build' 15:15:40 INFO - no previously-included directories found matching 'dist' 15:15:40 INFO - no previously-included directories found matching '.git*' 15:15:40 INFO - Successfully installed jsonschema functools32 15:15:40 INFO - Cleaning up... 15:15:40 INFO - Return code: 0 15:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:40 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:40 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 15:15:40 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 15:15:40 INFO - Using env: {'DISPLAY': ':0', 15:15:40 INFO - 'HOME': '/home/cltbld', 15:15:40 INFO - 'LANG': 'en_US.UTF-8', 15:15:40 INFO - 'LANGUAGE': 'en_US:en', 15:15:40 INFO - 'LOGNAME': 'cltbld', 15:15:40 INFO - 'MAIL': '/var/mail/cltbld', 15:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:40 INFO - 'MOZ_NO_REMOTE': '1', 15:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:40 INFO - 'NO_EM_RESTART': '1', 15:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:40 INFO - 'PWD': '/builds/slave/test', 15:15:40 INFO - 'SHELL': '/bin/bash', 15:15:40 INFO - 'SHLVL': '1', 15:15:40 INFO - 'TERM': 'linux', 15:15:40 INFO - 'TMOUT': '86400', 15:15:40 INFO - 'USER': 'cltbld', 15:15:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:40 INFO - '_': '/tools/buildbot/bin/python'} 15:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:43 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 15:15:43 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 15:15:43 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 15:15:43 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 15:15:43 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 15:15:43 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 15:15:43 INFO - Downloading docopt-0.6.1.tar.gz 15:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:43 INFO - Running setup.py install for blobuploader 15:15:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:43 INFO - Running setup.py install for requests 15:15:43 INFO - Running setup.py install for docopt 15:15:44 INFO - Successfully installed blobuploader requests docopt 15:15:44 INFO - Cleaning up... 15:15:44 INFO - Return code: 0 15:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:44 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:44 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 15:15:44 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 15:15:44 INFO - Using env: {'DISPLAY': ':0', 15:15:44 INFO - 'HOME': '/home/cltbld', 15:15:44 INFO - 'LANG': 'en_US.UTF-8', 15:15:44 INFO - 'LANGUAGE': 'en_US:en', 15:15:44 INFO - 'LOGNAME': 'cltbld', 15:15:44 INFO - 'MAIL': '/var/mail/cltbld', 15:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:44 INFO - 'MOZ_NO_REMOTE': '1', 15:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:44 INFO - 'NO_EM_RESTART': '1', 15:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:44 INFO - 'PWD': '/builds/slave/test', 15:15:44 INFO - 'SHELL': '/bin/bash', 15:15:44 INFO - 'SHLVL': '1', 15:15:44 INFO - 'TERM': 'linux', 15:15:44 INFO - 'TMOUT': '86400', 15:15:44 INFO - 'USER': 'cltbld', 15:15:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:44 INFO - '_': '/tools/buildbot/bin/python'} 15:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:44 INFO - Running setup.py (path:/tmp/pip-ouCqNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:44 INFO - Running setup.py (path:/tmp/pip-HJqaM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:44 INFO - Running setup.py (path:/tmp/pip-geuCCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:44 INFO - Running setup.py (path:/tmp/pip-HdTxvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:44 INFO - Running setup.py (path:/tmp/pip-p8ItGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:44 INFO - Running setup.py (path:/tmp/pip-3AVgZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:44 INFO - Running setup.py (path:/tmp/pip-8WP80R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:44 INFO - Running setup.py (path:/tmp/pip-YrFZGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:44 INFO - Running setup.py (path:/tmp/pip-HT4VGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:45 INFO - Running setup.py (path:/tmp/pip-RV2E99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:45 INFO - Running setup.py (path:/tmp/pip-H_Bca9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:45 INFO - Running setup.py (path:/tmp/pip-9ee5lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:45 INFO - Running setup.py (path:/tmp/pip-Zn3drG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:45 INFO - Running setup.py (path:/tmp/pip-U2sFK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:45 INFO - Running setup.py (path:/tmp/pip-bGn2rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:45 INFO - Running setup.py (path:/tmp/pip-iwZJ_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:45 INFO - Running setup.py (path:/tmp/pip-5PzSrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:45 INFO - Running setup.py install for manifestparser 15:15:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Running setup.py install for mozcrash 15:15:45 INFO - Running setup.py install for mozdebug 15:15:45 INFO - Running setup.py install for mozdevice 15:15:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozfile 15:15:46 INFO - Running setup.py install for mozhttpd 15:15:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozinfo 15:15:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozInstall 15:15:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozleak 15:15:46 INFO - Running setup.py install for mozlog 15:15:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for moznetwork 15:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozprocess 15:15:46 INFO - Running setup.py install for mozprofile 15:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozrunner 15:15:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:47 INFO - Running setup.py install for mozscreenshot 15:15:47 INFO - Running setup.py install for moztest 15:15:47 INFO - Running setup.py install for mozversion 15:15:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:47 INFO - Cleaning up... 15:15:47 INFO - Return code: 0 15:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:47 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:47 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 15:15:47 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 15:15:47 INFO - Using env: {'DISPLAY': ':0', 15:15:47 INFO - 'HOME': '/home/cltbld', 15:15:47 INFO - 'LANG': 'en_US.UTF-8', 15:15:47 INFO - 'LANGUAGE': 'en_US:en', 15:15:47 INFO - 'LOGNAME': 'cltbld', 15:15:47 INFO - 'MAIL': '/var/mail/cltbld', 15:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:47 INFO - 'MOZ_NO_REMOTE': '1', 15:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:47 INFO - 'NO_EM_RESTART': '1', 15:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:47 INFO - 'PWD': '/builds/slave/test', 15:15:47 INFO - 'SHELL': '/bin/bash', 15:15:47 INFO - 'SHLVL': '1', 15:15:47 INFO - 'TERM': 'linux', 15:15:47 INFO - 'TMOUT': '86400', 15:15:47 INFO - 'USER': 'cltbld', 15:15:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:47 INFO - '_': '/tools/buildbot/bin/python'} 15:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:47 INFO - Running setup.py (path:/tmp/pip-BaRS_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:47 INFO - Running setup.py (path:/tmp/pip-rq8UKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:47 INFO - Running setup.py (path:/tmp/pip-53Y6QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:47 INFO - Running setup.py (path:/tmp/pip-t_OODT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:47 INFO - Running setup.py (path:/tmp/pip-gTv62d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:47 INFO - Running setup.py (path:/tmp/pip-MFEe9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:48 INFO - Running setup.py (path:/tmp/pip-JFo0I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:48 INFO - Running setup.py (path:/tmp/pip-XDymUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:48 INFO - Running setup.py (path:/tmp/pip-o4fTYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:48 INFO - Running setup.py (path:/tmp/pip-zOIdgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:48 INFO - Running setup.py (path:/tmp/pip-AfALXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:48 INFO - Running setup.py (path:/tmp/pip-V7Cz68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:48 INFO - Running setup.py (path:/tmp/pip-q6rh_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:48 INFO - Running setup.py (path:/tmp/pip-KnVuQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:48 INFO - Running setup.py (path:/tmp/pip-do6QvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:48 INFO - Running setup.py (path:/tmp/pip-TxEyyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:48 INFO - Running setup.py (path:/tmp/pip-crMeSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:48 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 15:15:48 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 15:15:48 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 15:15:48 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 15:15:48 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 15:15:48 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 15:15:50 INFO - Downloading blessings-1.6.tar.gz 15:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:50 INFO - Installing collected packages: blessings 15:15:50 INFO - Running setup.py install for blessings 15:15:50 INFO - Successfully installed blessings 15:15:50 INFO - Cleaning up... 15:15:51 INFO - Return code: 0 15:15:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:51 INFO - Reading from file tmpfile_stdout 15:15:51 INFO - Current package versions: 15:15:51 INFO - argparse == 1.2.1 15:15:51 INFO - blessings == 1.6 15:15:51 INFO - blobuploader == 1.2.4 15:15:51 INFO - docopt == 0.6.1 15:15:51 INFO - functools32 == 3.2.3-2 15:15:51 INFO - jsonschema == 2.5.1 15:15:51 INFO - manifestparser == 1.1 15:15:51 INFO - mozInstall == 1.12 15:15:51 INFO - mozcrash == 0.17 15:15:51 INFO - mozdebug == 0.1 15:15:51 INFO - mozdevice == 0.48 15:15:51 INFO - mozfile == 1.2 15:15:51 INFO - mozhttpd == 0.7 15:15:51 INFO - mozinfo == 0.9 15:15:51 INFO - mozleak == 0.1 15:15:51 INFO - mozlog == 3.2 15:15:51 INFO - moznetwork == 0.27 15:15:51 INFO - mozprocess == 0.23 15:15:51 INFO - mozprofile == 0.28 15:15:51 INFO - mozrunner == 6.12 15:15:51 INFO - mozscreenshot == 0.1 15:15:51 INFO - mozsystemmonitor == 0.3 15:15:51 INFO - moztest == 0.7 15:15:51 INFO - mozversion == 1.4 15:15:51 INFO - psutil == 3.1.1 15:15:51 INFO - requests == 1.2.3 15:15:51 INFO - wsgiref == 0.1.2 15:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:51 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')]} 15:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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')]} 15:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:51 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 15:15:51 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 15:15:51 INFO - Using env: {'DISPLAY': ':0', 15:15:51 INFO - 'HOME': '/home/cltbld', 15:15:51 INFO - 'LANG': 'en_US.UTF-8', 15:15:51 INFO - 'LANGUAGE': 'en_US:en', 15:15:51 INFO - 'LOGNAME': 'cltbld', 15:15:51 INFO - 'MAIL': '/var/mail/cltbld', 15:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:51 INFO - 'MOZ_NO_REMOTE': '1', 15:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:51 INFO - 'NO_EM_RESTART': '1', 15:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:51 INFO - 'PWD': '/builds/slave/test', 15:15:51 INFO - 'SHELL': '/bin/bash', 15:15:51 INFO - 'SHLVL': '1', 15:15:51 INFO - 'TERM': 'linux', 15:15:51 INFO - 'TMOUT': '86400', 15:15:51 INFO - 'USER': 'cltbld', 15:15:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:51 INFO - '_': '/tools/buildbot/bin/python'} 15:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 INFO - Cleaning up... 15:15:51 INFO - Return code: 0 15:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15:51 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')]} 15:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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')]} 15:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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 0x1f14030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', '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 15:15:51 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 15:15:51 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 15:15:51 INFO - Using env: {'DISPLAY': ':0', 15:15:51 INFO - 'HOME': '/home/cltbld', 15:15:51 INFO - 'LANG': 'en_US.UTF-8', 15:15:51 INFO - 'LANGUAGE': 'en_US:en', 15:15:51 INFO - 'LOGNAME': 'cltbld', 15:15:51 INFO - 'MAIL': '/var/mail/cltbld', 15:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:51 INFO - 'MOZ_NO_REMOTE': '1', 15:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:51 INFO - 'NO_EM_RESTART': '1', 15:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:51 INFO - 'PWD': '/builds/slave/test', 15:15:51 INFO - 'SHELL': '/bin/bash', 15:15:51 INFO - 'SHLVL': '1', 15:15:51 INFO - 'TERM': 'linux', 15:15:51 INFO - 'TMOUT': '86400', 15:15:51 INFO - 'USER': 'cltbld', 15:15:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:51 INFO - '_': '/tools/buildbot/bin/python'} 15:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:15:51 INFO - Cleaning up... 15:15:51 INFO - Return code: 0 15:15:51 INFO - Running post-action listener: _resource_record_post_action 15:15:51 INFO - Running post-action listener: _start_resource_monitoring 15:15:51 INFO - Starting resource monitoring. 15:15:51 INFO - ##### 15:15:51 INFO - ##### Finished create-virtualenv step (success) 15:15:51 INFO - ##### 15:15:51 INFO - ##### 15:15:51 INFO - ##### Running install step. 15:15:51 INFO - ##### 15:15:51 INFO - Running pre-action listener: _resource_record_pre_action 15:15:51 INFO - Running main action method: install 15:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:51 INFO - Reading from file tmpfile_stdout 15:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:51 INFO - Reading from file tmpfile_stdout 15:15:51 INFO - Output received: 15:15:51 INFO - Usage: mozinstall [options] installer 15:15:51 INFO - Options: 15:15:51 INFO - -h, --help show this help message and exit 15:15:51 INFO - -d DEST, --destination=DEST 15:15:51 INFO - Directory to install application into. [default: 15:15:51 INFO - "/builds/slave/test"] 15:15:51 INFO - --app=APP Application being installed. [default: firefox] 15:15:51 INFO - mkdir: /builds/slave/test/build/application 15:15:51 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'] 15:15:51 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 15:16:09 INFO - Reading from file tmpfile_stdout 15:16:09 INFO - Output received: 15:16:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:16:09 INFO - Running post-action listener: _resource_record_post_action 15:16:09 INFO - ##### 15:16:09 INFO - ##### Finished install step (success) 15:16:09 INFO - ##### 15:16:09 INFO - ##### 15:16:09 INFO - ##### Running run-tests step. 15:16:09 INFO - ##### 15:16:09 INFO - Running pre-action listener: _resource_record_pre_action 15:16:09 INFO - Running main action method: run_tests 15:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:09 INFO - Python 2.7.3 15:16:09 INFO - Return code: 0 15:16:09 INFO - grabbing minidump binary from tooltool 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:09 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 0x21d33b0>, '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 0x21d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:09 INFO - Return code: 0 15:16:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:16:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:16:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:16:09 INFO - Using env: {'DISPLAY': ':0', 15:16:09 INFO - 'HOME': '/home/cltbld', 15:16:09 INFO - 'LANG': 'en_US.UTF-8', 15:16:09 INFO - 'LANGUAGE': 'en_US:en', 15:16:09 INFO - 'LOGNAME': 'cltbld', 15:16:09 INFO - 'MAIL': '/var/mail/cltbld', 15:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:09 INFO - 'MOZ_NO_REMOTE': '1', 15:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:09 INFO - 'NO_EM_RESTART': '1', 15:16:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:09 INFO - 'PWD': '/builds/slave/test', 15:16:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:09 INFO - 'SHELL': '/bin/bash', 15:16:09 INFO - 'SHLVL': '1', 15:16:09 INFO - 'TERM': 'linux', 15:16:09 INFO - 'TMOUT': '86400', 15:16:09 INFO - 'USER': 'cltbld', 15:16:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499', 15:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:09 INFO - '_': '/tools/buildbot/bin/python'} 15:16:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:16:09 INFO - mozversion application_buildid: 20160718124149 15:16:09 INFO - mozversion application_changeset: 2a69345f4f4eeb804e6a96c70f086f10e9849724 15:16:09 INFO - mozversion application_display_name: Nightly 15:16:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:09 INFO - mozversion application_name: Firefox 15:16:09 INFO - mozversion application_remotingname: firefox 15:16:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:16:09 INFO - mozversion application_vendor: Mozilla 15:16:09 INFO - mozversion application_version: 50.0a1 15:16:09 INFO - mozversion platform_buildid: 20160718124149 15:16:09 INFO - mozversion platform_changeset: 2a69345f4f4eeb804e6a96c70f086f10e9849724 15:16:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:16:09 INFO - mozversion platform_version: 50.0a1 15:16:09 INFO - using testdate: 1468880169 15:16:09 INFO - actual date: 1468880169 15:16:09 INFO - starting webserver on 'localhost:59145' 15:16:09 INFO - SUITE-START | Running 2 tests 15:16:09 INFO - TEST-START | dromaeo_css 15:16:09 INFO - operating with platform_type : linux_ 15:16:09 INFO - Initialising browser for dromaeo_css test... 15:16:09 INFO - TEST-INFO | started process 25166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_az5Lv/profile http://localhost:59145/getInfo.html) 15:16:13 INFO - PROCESS | 25166 | __metrics Screen width/height:1600/1200 15:16:13 INFO - PROCESS | 25166 | colorDepth:24 15:16:13 INFO - PROCESS | 25166 | Browser inner width/height: 1024/697 15:16:13 INFO - PROCESS | 25166 | __metrics 15:16:14 ERROR - PROCESS | 25166 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:16:15 INFO - TEST-INFO | 25166: exit 0 15:16:15 INFO - Browser initialized. 15:16:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:15 INFO - TEST-INFO | started process 25286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_az5Lv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:26 INFO - PROCESS | 25286 | RSS: Main: 168116224 15:16:26 INFO - PROCESS | 25286 | 15:17:16 INFO - PROCESS | 25286 | 1468880236527 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] 15:19:24 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59145/tests/dromaeo/cssquery-ext.html) 15:19:25 INFO - PROCESS | 25286 | RSS: Main: 173051904 15:19:25 INFO - PROCESS | 25286 | 15:22:27 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-ext.html (next: http://localhost:59145/tests/dromaeo/cssquery-jquery.html) 15:22:28 INFO - PROCESS | 25286 | RSS: Main: 168468480 15:22:28 INFO - PROCESS | 25286 | 15:25:29 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59145/tests/dromaeo/cssquery-mootools.html) 15:25:30 INFO - PROCESS | 25286 | RSS: Main: 172609536 15:25:30 INFO - PROCESS | 25286 | 15:28:32 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59145/tests/dromaeo/cssquery-prototype.html) 15:28:32 INFO - PROCESS | 25286 | RSS: Main: 167211008 15:28:32 INFO - PROCESS | 25286 | 15:31:35 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59145/tests/dromaeo/cssquery-yui.html) 15:31:36 INFO - PROCESS | 25286 | RSS: Main: 169115648 15:31:36 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | Cycle 1(1): loaded http://localhost:59145/tests/dromaeo/cssquery-yui.html (next: http://localhost:59145/tests/dromaeo/cssquery-dojo.html) 15:34:38 INFO - PROCESS | 25286 | RSS: Main: 170958848 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | __start_tp_report 15:34:38 INFO - PROCESS | 25286 | _x_x_mozilla_page_load 15:34:38 INFO - PROCESS | 25286 | _x_x_mozilla_page_load_details 15:34:38 INFO - PROCESS | 25286 | |i|pagename|runs| 15:34:38 INFO - PROCESS | 25286 | |0;dojo.html;3060.678628743982;3108.0209733933807;3112.3619657970116;3115.081051089928;3116.7506599472044;5441.9455805441985;5515.61390702651;5558.221848941146;5566.387697353288;5567.749451274693;5452.509274165324;5494.423085576007;5510.614257002011;5524.14375771755;5545.251391062206;4971.279164521142;4999.075171093359;5096.413912400066;5153.793848246066;5180.378354597454;711.6067046033671;4926.531979461945;4997.700137991732;5058.0895438821;5060.569851562604;5004.299398084271;5012.924806127911;5030.748462576893;5032.899342013157;5034.924476132861;5038.445770965191;5051.6716413433005;5057.140286151363;5066.36670416198;5069.645124841262;4943.530364615356;4947.134251506008;4961.05739909416;5008.649394542384;5016.974915125401;5456.7544460499375;5467.125259958388;5478;5529.585281103893;5539.307586551681;5592.077307244341;5883.8529036774;5886.852828679274;5892.057270836645;5935.881282374372;5896.321922978869;5942.910856337158;5962.910556341615;6015.939840601582;6038.57729958903;5555.749991250404;5558.221848941152;5572.108462645957;5574.721263936827;5597.076482380402;5920.4967577755515;5922.911156332659;6103.176071230327;6111.633302001894;6118.5716999810475;5716.314042314949;5724.570657200727;5733.799317023884;5734.16854556087;5739.655620662774;5843.795467158714;5848.590598658053;5855.063189889597;5872.677002764804;5879.941200588025;5799.82600521985;5826.592138550261;5871.236739223874;5894.233749612523;5922.052471604608;5884.794032208938;5919.082542205965;5930.28836539618;5931.881362372815;5954.523638108941;4384.583464570861;4409.845655402046;4421.9336709949375;4423.358613001097;4425.668074894395;3803.7337386382687;3913.2173565287057;3951.7628942263555;3973.006748312922;3976.324024915771;5423.891522169534;5427.213054107132;5436.891262174813;5447.455254474521;5484.478974497416;5792.044312688444;5813.331466881363;5830.650160990354;5846.853828654318;5849.415058494116;5561.916571251434;5566.332040155207;5574.08027675429;5575.553955683536;5607.327120745536;4919.1391506486225;4937.530934561211;4987.725675087832;4987.725675087905;4990.550850423407;6093.847653808691;6100.816975490742;6102.847428814315;6116.66358350295;6185.84535386619;5829.76680932758;5934.228550288435;5952.166696662384;5981.192539007178;6009.849753756191;6134.263888333428;6153.292371377349;6171.352008039091;6196.318404975359;6205.751769929333;5839.474447299764;5909.645421274738;5910.52715782745;5921.467067963904;5926.940730592639;5886.6173698709445;5911.054231322968;5943.465088142088;6004.099385092271;6016.909746353721;5844.649321040752;5848.619839710405;5849.64902105875;5862.618929769551;5899.17411562373;5830.62100963436;5831.7375718093635;5840.970795145997;5844.386339434298;5863.736131874161;5623.550115990793;5739.512141468022;5740.741666625096;5751.396103409082;5794.797182098607;5841.883162336814;5916.142159386779;5932.13983972313;5946.316173640087;5949.405059494016;5775.422457754191;5791.102379131073;5797.971010145091;5801.5938884279385;5812.3025236971835 15:34:38 INFO - PROCESS | 25286 | |1;ext.html;557.9834555954426;589.6285340235651;602.7498588085945;608.4068033667176;611.22069361564;42586.14827703448;44205;44298.77850610746;44509.554904450946;48191.27713084307;46103;46237.30644040342;46564.301535476996;46599;46659.033982111476;8854.955725221365;8947.955260223689;8951.865722014176;8982;9002.684906028291;8859.335549833788;8950.462972221654;8952;8954.86567701485;8965.32760042996;8950.015498295183;8979.506127163004;8988.910110898905;8990.955045224797;9022.278217742565;8917.73246802597;8929.866052009225;8946.955265223633;8947.19475247231;8954.37319387643;8834.983976842681;8875.378723489359;8895.822083558292;8901.243394311492;8926;43502;43677.12645747067;43923;44000.55999439997;44013.559864401264;3548.201654627714;3677.2093999790172;3795.6963442924775;3806.4480650305827;3808.3906574947873;30778.384432311228;31600;31641.20896977594;33908;33931.830340848384;4268.722533035343;4344.804483798237;4377.321515165155;4398.780060996937;4553.840615578472;375736;376017;377201;378576;379844;61942.38057619456;62481;62829.371706283266;62978;63082.36917630765;65089;65223;65223.673881631235;65688;65703;17233.913830430767;17466.214020369112;17505.38731144404;17547.385841495485;17723.556911077067;13222.272774997275;13228.867711322764;13237.271950042648;13284;13328.00039997004;19243.51891202731;19298.22807087729;19469.805301947083;19544.70682939757;19761.209551617776;7244.203137654854;7388;7431.405487560982;7442;7470.252974702595;976.1800087926176;1025.6666583360438;1035.6737627647417;1079.7192729890285;1185.9978318321005;32811.17972050718;33404.33191336208;33499.82785032496;33507.83246083803;33614.32771344559;1109.9611513596985;1141.406468636321;1142.177632104883;1176.952921883115;1191.8939254269133;16456.506304810875;17440.82559174392;17489.31480068412;17494.65010699779;17665.205065772072;157486.21256893643;157832;158099;158620;158917;59431.40568594345;60036.69981650151;60163.398366016656;60194.39805601888;60251.698741506014;1309.5220244610648;1358.7758019926798;1373.663452454135;1394.2262044565161;1401.985980140206;30591.847040765544;32854;32963.011109666746;33023.834880825445;33408.49887251742;51735.741321294656;52281;52314.21528676997;52411;52447.21329180142;436184;436458;438060;440808;443979;28077.859610701817;28293;28525.714742853135;28926.13221603355;29015.56476652894;47905.76047119742;48020;48946.51053489562;49288.75355623342;49504;40690.59309406987;42015;42649.78675106604;42833;44150.33774493321;42467;42767;42988.78505607452;43054.78472607617;43503.564964351215;36234.27531449409;40902.1819563613;40914.79542602387;41261.38107928324;42606;36591.63408365882;38081.2383752329;38243.42634860424;38422.615773841906;38621.80689096537;28862.567061494516;29050.41899162047;29218;29363.265918352212;29604.703952960193 15:34:38 INFO - PROCESS | 25286 | |2;jquery.html;360.8791054996576;376.0673529646475;377.39428217710577;378.4965995226348;395.8733205374281;18878.43364699058;19819.603607927867;20138;20716.585668286625;20761.480962975933;19511.121999510022;20132.396028119143;20352;20497.180112795508;20659.69010464844;5707.4577915098;5788.102844059156;5856.648601083949;5876.44173803488;5894.852628684274;5606.074997625387;5767.913481297784;5794.449527294922;5795.681237531934;5812.041013232812;5596.496315331619;5623.887522249573;5694.943050569504;5718.285214348207;5719.571032172583;5718.971405142947;5720.427957204288;5741.598088133853;5753.597248192628;5754.625949313281;4778.259369797687;5047;5063.443021267658;5117.33474648297;5117.385913690381;13555.25446100464;13663;13669.794953075712;14676;22664.206752763574;2330.545543618995;2361.8228632852606;2515.7484251574697;2670.9599356009676;2686.449277898026;9957.302988790787;10187.49062546877;10241.180705543613;10252.33359831616;10255.743606409826;1930.7007413850877;1948.405736250443;2000.349886286948;2041.9387418377473;2051.6819892916624;86998.56500717519;92276.53861730716;92311.53844230736;93550.06449935482;94993.52503237508;10149.492525373702;10567.471626418803;10599.682009539727;10836.024757771838;10850.782984340269;14227.85772142286;14365;14387.712245755236;14426.639334016734;14461.349239284258;7713.845723085619;7732.188120247405;8112.351011919032;8123.065847427503;8232.34141268697;7818.8827167592535;7836.92163078362;7860.606969651494;8060.113387527367;8072.636731347104;4212.662986961036;4320.524742278347;4385.232584297735;4427.645788336926;4591.908161836812;1740.8781385302907;1892.8958907260233;1903.847692184622;1905.1331644101901;1906.218450435315;958.8513780364054;1026.5380578739598;1028.3983869436313;1054.314695447965;1123.713453069462;19578.314758983368;20067;20078.397648070582;20230.494237644176;20394.388168354675;981.7300242433388;996.5814357969671;1033.3696445168441;1034.1571619130384;1035.539185062655;9759.26805489591;11138;11172.385518796544;11251.662450126509;11267.774644507064;344611;347616;348639;509280;513471;97647.51176244073;104657;104981.47509262405;105587;105613.47193263985;1002.2633364477103;1049.8530205771199;1053.1364281289423;1064.8775390830153;1067.9359238445563;15977.440789572309;17765.822341776933;18542.907285463487;18549.81450185481;18624.5343866399;42408.78795606002;42512;43027.56972430235;43118.78440607777;43722;55794.72102639623;55869.16196256978;59816.40183598108;60847.39152608594;61342;8471.364647651328;8482;8504.702335418231;8510.531920744172;8521.147885211429;12644.30456324911;13237.470501179845;13281.40233689467;13998.090124141898;14175.29123543798;11805.940970295436;11889.464974076014;11974.341411222467;12173.756524869275;12262.570810021607;11916.642500724993;12117.757644846877;12295.44670489848;12421.19262247951;12496.687582810138;12226.083043771574;12259.632211033684;12340.938295308824;12418.37908104573;12616.873831261937;8032.076311224284;8393.874091888505;8455.534945578052;8544.658213671632;8804.64781408762;11332.716682083013;11664.708382290512;11773.941130294294;11816.70458238551;12280.38598070075 15:34:38 INFO - PROCESS | 25286 | |3;mootools.html;1515.408990493707;1541.606890242988;1681.9747703784446;1797.5146710388187;1819.9363022294222;7983.044154182219;8601.225889669928;8723.563821808915;9251.398659087155;9298.72103836885;8823.911760882389;9049.321300902426;9130.04134565871;9165.083491650832;9169.312301577374;2311.9537609247845;2312.1098377124845;2332.8950197241165;2333.649952507129;2335.4278201840575;2261.118163916074;2297.0811675329833;2335.474518233401;2339.2280547419396;2343.414146463384;2251.1445650652813;2260.7965283124518;2267.3651377614297;2271.1710225767642;2275.8293128015384;2221.8555793873347;2267.875266860322;2271.318604418676;2271.4889149941214;2272.6477396003647;2240.137547044383;2253.526759380532;2259.0399080390766;2274.931752047441;2279.6010698127925;9149.634014639407;9150.130737579919;9171.954140229323;9199.310051746079;9217.723468295962;5275.472452754732;5376.516113549799;5387.0303345397815;5397.973010134963;5412.539934105605;3323.5513205717402;3359.260962588227;3470.496777967206;3485.7037151842123;3490.162361033359;1027.6505987964129;1035.808375450544;1036.0830664861576;1046.5447530324334;1054.7679510507676;12813.10308278421;12858.871411285862;12863.42114604845;12890.87109128906;12910;4506.346579745984;4545.227311357077;4621.23749581322;4692.718436893797;4778.4982576829625;10674.519646615921;10733.409662468483;10738.087262582612;10741.19441041925;10748.462576871125;5431.646942948775;5452.291202143696;5460.044492213847;5477.780888764484;5480.808171713971;4403.515613282536;4799.136155491975;4935.506449355035;4939.160342741742;5000.974995125001;3915.804209789499;3961.6632586230494;4106.568810274938;4106.815193316308;4144;1247.9812802807965;1262.8232047513357;1282.3780466473752;1283.0697744135614;1293.5537239652306;899.9965038981488;955.7467271173144;964.4309857184295;971.6502059258661;986.9851952220722;5757.193992841006;5963.701814909237;6065.3934606539;6111.57218994675;6155.230596175478;425.6403339178389;425.8254115812564;430.5672798837149;431.9092990472036;435.53615399599323;4079.1637714268504;4099.692523060782;4111.342185250345;4149.045719484536;4186.204621121977;11224.102071834397;11425.485853136628;11612.071034317403;11685;11742.354170520532;11272.830907536394;11278.774424511465;11332.660020199242;11341.489632966537;11354.432278386048;8486.74539763808;8546.829063418822;8618.052014278424;8781.999999999873;8791.824163516821;5860.443257890493;5911.231539899785;5981.820545383645;6025.096235564701;6037.396260373927;10494.10800081971;10570.894291056991;10634.361938283728;10742.570297188026;10767;10577.735556610838;10812.5134368952;10915.139436260972;11040.392778397265;11057.778844422906;7299;7741.5742134183165;8054.879176812469;8232.711855085043;8308.750737477885;8954.686585969459;8962.820743585222;9019.32355073359;9056.184943355129;9072.183503484717;7658.540487570764;7678.884816727866;7778.0666320041955;7936.841263174589;7938.56337901421;7817.218278172138;8000.6399712011935;8005.439619226599;8018.3184429324165;8042.195780421911;7100.893486597602;7137.250588688113;7201.171865235565;7204.0994875640545;7212.675429605785;4997.150484417585;5061.443241243386;5192.792288308426;5232.534890230741;5233.319668443078;4844.61243100544;4954.355933728736;4980.726060066731;5113.233015047773;5198.038362902875 15:34:38 INFO - PROCESS | 25286 | |4;prototype.html;310.8740959911237;319.9536067270246;324.3852898756856;324.66559443772906;326.0414381717748;5204.219367094937;5616.606837521375;5671.1776792365135;5674.290713660793;5721.227634269372;5613.663180209191;5626.634268772527;5629.408912064236;5630.5495560355175;5639.605227634067;4378.715383500063;4396.428464299636;4417.757023363713;4422.987540669004;4434.911301773978;4339.218940590692;4352.869413917588;4356.607905288523;4378.452693413324;4435.356873253377;4306.676999225055;4314.180305741915;4325.870223893273;4349.565043495657;4366.912661746779;4178.331466965271;4367.366731823884;4370.38814565961;4386.166628340605;4406.471223453174;3753.7372383933134;3755.9248815023548;3760.52993375828;3775.301569209705;3784.1485665725268;5500.917486237709;5541.556675465953;5557.527610153142;5562.749676264578;5582;4815.542523460265;4966.205407134841;4985.850424487271;4999.275105109775;5009.173486374744;5851.132944857032;5856.76572937082;5865.912011319833;5875.206847075633;5892.58577941291;4112.753234805921;4115.691323150776;4138.710290279681;4149.315362965107;4150.667946564297;5804.216430781833;6120.20437343147;6143.293521245069;6173.938260617381;6214.720337584819;4195.160967806451;4210.179015092089;4214.831406743757;4219.98720307124;4230.386593943923;4259.680523960716;4264.744115353089;4266.893327666771;4268.530461649216;4281.721688090264;4788.688735232199;4939.2838038484215;4956.256561515802;4962.478939711351;4969.304297398295;5593.188987596775;5744.856378590569;5914.58597898143;5930.584859059824;5936.9406305937255;1444.162385816224;1452.8595052883647;1453.32420424501;1454.163855782929;1454.4182327069045;900.230303090861;917.7659696777413;919.3656377099779;937.6577549194495;941.2187884056217;4865.053978408665;4965.652404331734;4983.9252411213865;5055.9241611375855;5065.594752419797;5286.841394758163;5293.973530132402;5338.439463856317;5353.9732301338245;5357.866053348619;5061.696298222045;5072.427547460299;5074.314967479417;5320.2817619620855;5749.68376739275;3197.328561002216;3214.5981752280964;3232.321212545392;3233.3371658810356;3234.207619133327;6134;6242.344553821874;6262.6868656566985;6279.905801412982;6322.620642761357;6213.409726076015;6216.160818289473;6217.378262173836;6227.314995350508;6264.744691910909;6229.729392069109;6235.469985051322;6238.563300569007;6261.843453913689;6296.685165741695;5839.386864379179;5999.670018149044;6020.819375418744;6021.729022193924;6026.578139530191;5982.35485241562;6010.9699451502465;6027.095935609694;6027.457528822427;6034.24571928509;5970.671613061323;6213.1922850029205;6222.62664240147;6272.59228150187;6294.464970477561;4279.550647182001;4340.544242854455;4344.218040752695;4345.891352716208;4352;5885.557493640092;5910.970445147746;6060.787872424444;6089.786857459968;6133.877322453437;5906.26171728534;5935.614185077956;5948.643081415129;5965.9105113422465;5974.701264936823;5947.947957954499;5948.73230704628;5953.791617293374;5975.880482390415;5989.251343582052;5696.914546281726;5772.960867043972;5889.499392551681;5894.852628684317;5931.1399847021075;5972.5367285015445;6005.609635373687;6010.759569617341;6014.097885317063;6031.306399763907;5700.1858104733765;5834.212381328466;5843.503302219189;5851.590388672922;5923.703814809329 15:34:38 INFO - PROCESS | 25286 | |5;yui.html;760.6501009535614;797.0873350014234;818.9631466584003;819.5328662662283;905.7192270396174;15078.47225347113;16016.75974860375;16032.118233497153;16085.99999999997;16148;15070.849291507082;15319.080855148699;15322.15728134952;15361.15513646749;15368.923155384235;655.954083214174;788.787027502574;808.0828259924998;809.720646376999;813.0974618173823;809.6720828064614;809.9919000809975;816.6325153680838;818.7339114787688;820.1675299570941;866.4238281542798;873.8164985353084;874.1477059866611;878.6002368922157;879.3273146043282;856.9485830850169;865.3855762408697;866.0257210638032;866.4281574161055;869.1395518436765;630.5932673425615;630.9747610095591;632.4213344789512;637.5760119520513;638.2723694987718;14846.70306593873;14927.776083358758;15013;15053.548393548212;15080.472183473526;15657.451989180438;15676.137812420313;15712.764308535381;15802.525924222176;15851.920740396225;12339.136260461772;12425.44085516154;12518.311492867888;12623.87376126236;12670.303133327663;3921.4313924481075;4047.392891066334;4091.284025295561;4114.979425102855;4126.546079931205;75121;78432;78517.60741196315;78709;78772;11787.587434439753;11918.523259069714;12071.517139314328;12433.502659893504;12742.235465872078;20671.966401679856;20690;20710.896445517676;20720.79279207219;20726.274580389614;8390.538520381315;8452.535110568977;8574.785630359167;8646.52444115567;8803.559822008874;4372.672049596293;4471.530489298577;4570.840020599263;4595.9080818383445;4686.179918514246;3534;3615.9276814463565;3625.9456108158397;3650.2699460108083;3655.1593133578895;629.8834715577541;643.3341491556217;661.4014317042987;677.2584020497547;690.4821383962028;725.3363172696924;747.8392145688703;763.1681467200777;769.54981335918;805.9314958228616;9462.668806591737;9706.369086009387;9792.265580081523;9833.950830245803;9875.7161568997;695.8330000799772;703.0298188499837;706.523096909584;710.4316546762569;735.9448041396917;4612.5156858530045;4873.439554451213;4878.95121048792;4911.705297682151;4940.407151141814;107418.46290768497;128739;128751;128946.35526822307;130216;66549.66725166343;71722;84293;100117;108230.45884770683;76860.61569692116;79484.6025769879;93480;96510;96565.51717241369;10058.084694434849;10156.238282128723;10535.4732263385;10548.789024219626;10557.52491137916;37577.81211093927;47313.763431182626;48983;51348.22977655263;55065.44934550603;73916;74298;74365.6281718588;76727.23272767424;79131;13081.149725267827;13409.994250431451;13469;13923;14145.222012789396;14420.134791912518;14572.708545829237;15532.796032238066;15752;16153.838461615704;13963.441462341392;14620.85379146195;14804.185769782765;14947.25263736787;14991.2504374783;14519.92740036293;14805.619534763247;14827.110373377633;15341.693166136838;15454.922725386301;14120.364583593968;14333.498327558902;14673;14750.2624868754;15286.388544458097;11911.523539058688;11994.220375675553;11998.98008669238;12375.69060773488;12416.255024698547;11741.530338786353;11743.76512469763;11845.407729613313;12365.567205147776;12498.315691764237 15:34:38 INFO - PROCESS | 25286 | __end_tp_report 15:34:38 INFO - PROCESS | 25286 | __start_cc_report 15:34:38 INFO - PROCESS | 25286 | _x_x_mozilla_cycle_collect,348 15:34:38 INFO - PROCESS | 25286 | __end_cc_report 15:34:38 INFO - PROCESS | 25286 | __startTimestamp1468881278972__endTimestamp 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | ------- Summary: start ------- 15:34:38 INFO - PROCESS | 25286 | Number of tests: 6 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#0] dojo.html Cycles:165 Average:5457.39 Median:5740.74 stddev:752.18 (13.1%) stddev-sans-first:730.61 15:34:38 INFO - PROCESS | 25286 | Values: 3060.7 3108.0 3112.4 3115.1 3116.8 5441.9 5515.6 5558.2 5566.4 5567.7 5452.5 5494.4 5510.6 5524.1 5545.3 4971.3 4999.1 5096.4 5153.8 5180.4 711.6 4926.5 4997.7 5058.1 5060.6 5004.3 5012.9 5030.7 5032.9 5034.9 5038.4 5051.7 5057.1 5066.4 5069.6 4943.5 4947.1 4961.1 5008.6 5017.0 5456.8 5467.1 5478.0 5529.6 5539.3 5592.1 5883.9 5886.9 5892.1 5935.9 5896.3 5942.9 5962.9 6015.9 6038.6 5555.7 5558.2 5572.1 5574.7 5597.1 5920.5 5922.9 6103.2 6111.6 6118.6 5716.3 5724.6 5733.8 5734.2 5739.7 5843.8 5848.6 5855.1 5872.7 5879.9 5799.8 5826.6 5871.2 5894.2 5922.1 5884.8 5919.1 5930.3 5931.9 5954.5 4384.6 4409.8 4421.9 4423.4 4425.7 3803.7 3913.2 3951.8 3973.0 3976.3 5423.9 5427.2 5436.9 5447.5 5484.5 5792.0 5813.3 5830.7 5846.9 5849.4 5561.9 5566.3 5574.1 5575.6 5607.3 4919.1 4937.5 4987.7 4987.7 4990.6 6093.8 6100.8 6102.8 6116.7 6185.8 5829.8 5934.2 5952.2 5981.2 6009.8 6134.3 6153.3 6171.4 6196.3 6205.8 5839.5 5909.6 5910.5 5921.5 5926.9 5886.6 5911.1 5943.5 6004.1 6016.9 5844.6 5848.6 5849.6 5862.6 5899.2 5830.6 5831.7 5841.0 5844.4 5863.7 5623.6 5739.5 5740.7 5751.4 5794.8 5841.9 5916.1 5932.1 5946.3 5949.4 5775.4 5791.1 5798.0 5801.6 5812.3 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#1] ext.html Cycles:180 Average:51406.03 Median:42800.00 stddev:91765.07 (214.4%) stddev-sans-first:91943.07 15:34:38 INFO - PROCESS | 25286 | Values: 558.0 589.6 602.7 608.4 611.2 42586.1 44205.0 44298.8 44509.6 48191.3 46103.0 46237.3 46564.3 46599.0 46659.0 8855.0 8948.0 8951.9 8982.0 9002.7 8859.3 8950.5 8952.0 8954.9 8965.3 8950.0 8979.5 8988.9 8991.0 9022.3 8917.7 8929.9 8947.0 8947.2 8954.4 8835.0 8875.4 8895.8 8901.2 8926.0 43502.0 43677.1 43923.0 44000.6 44013.6 3548.2 3677.2 3795.7 3806.4 3808.4 30778.4 31600.0 31641.2 33908.0 33931.8 4268.7 4344.8 4377.3 4398.8 4553.8 375736.0 376017.0 377201.0 378576.0 379844.0 61942.4 62481.0 62829.4 62978.0 63082.4 65089.0 65223.0 65223.7 65688.0 65703.0 17233.9 17466.2 17505.4 17547.4 17723.6 13222.3 13228.9 13237.3 13284.0 13328.0 19243.5 19298.2 19469.8 19544.7 19761.2 7244.2 7388.0 7431.4 7442.0 7470.3 976.2 1025.7 1035.7 1079.7 1186.0 32811.2 33404.3 33499.8 33507.8 33614.3 1110.0 1141.4 1142.2 1177.0 1191.9 16456.5 17440.8 17489.3 17494.7 17665.2 157486.2 157832.0 158099.0 158620.0 158917.0 59431.4 60036.7 60163.4 60194.4 60251.7 1309.5 1358.8 1373.7 1394.2 1402.0 30591.8 32854.0 32963.0 33023.8 33408.5 51735.7 52281.0 52314.2 52411.0 52447.2 436184.0 436458.0 438060.0 440808.0 443979.0 28077.9 28293.0 28525.7 28926.1 29015.6 47905.8 48020.0 48946.5 49288.8 49504.0 40690.6 42015.0 42649.8 42833.0 44150.3 42467.0 42767.0 42988.8 43054.8 43503.6 36234.3 40902.2 40914.8 41261.4 42606.0 36591.6 38081.2 38243.4 38422.6 38621.8 28862.6 29050.4 29218.0 29363.3 29604.7 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#2] jquery.html Cycles:180 Average:27419.70 Median:20688.14 stddev:70487.89 (340.7%) stddev-sans-first:70656.35 15:34:38 INFO - PROCESS | 25286 | Values: 360.9 376.1 377.4 378.5 395.9 18878.4 19819.6 20138.0 20716.6 20761.5 19511.1 20132.4 20352.0 20497.2 20659.7 5707.5 5788.1 5856.6 5876.4 5894.9 5606.1 5767.9 5794.4 5795.7 5812.0 5596.5 5623.9 5694.9 5718.3 5719.6 5719.0 5720.4 5741.6 5753.6 5754.6 4778.3 5047.0 5063.4 5117.3 5117.4 13555.3 13663.0 13669.8 14676.0 22664.2 2330.5 2361.8 2515.7 2671.0 2686.4 9957.3 10187.5 10241.2 10252.3 10255.7 1930.7 1948.4 2000.3 2041.9 2051.7 86998.6 92276.5 92311.5 93550.1 94993.5 10149.5 10567.5 10599.7 10836.0 10850.8 14227.9 14365.0 14387.7 14426.6 14461.3 7713.8 7732.2 8112.4 8123.1 8232.3 7818.9 7836.9 7860.6 8060.1 8072.6 4212.7 4320.5 4385.2 4427.6 4591.9 1740.9 1892.9 1903.8 1905.1 1906.2 958.9 1026.5 1028.4 1054.3 1123.7 19578.3 20067.0 20078.4 20230.5 20394.4 981.7 996.6 1033.4 1034.2 1035.5 9759.3 11138.0 11172.4 11251.7 11267.8 344611.0 347616.0 348639.0 509280.0 513471.0 97647.5 104657.0 104981.5 105587.0 105613.5 1002.3 1049.9 1053.1 1064.9 1067.9 15977.4 17765.8 18542.9 18549.8 18624.5 42408.8 42512.0 43027.6 43118.8 43722.0 55794.7 55869.2 59816.4 60847.4 61342.0 8471.4 8482.0 8504.7 8510.5 8521.1 12644.3 13237.5 13281.4 13998.1 14175.3 11805.9 11889.5 11974.3 12173.8 12262.6 11916.6 12117.8 12295.4 12421.2 12496.7 12226.1 12259.6 12340.9 12418.4 12616.9 8032.1 8393.9 8455.5 8544.7 8804.6 11332.7 11664.7 11773.9 11816.7 12280.4 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#3] mootools.html Cycles:180 Average:5953.52 Median:4454.93 stddev:3508.25 (78.7%) stddev-sans-first:3502.24 15:34:38 INFO - PROCESS | 25286 | Values: 1515.4 1541.6 1682.0 1797.5 1819.9 7983.0 8601.2 8723.6 9251.4 9298.7 8823.9 9049.3 9130.0 9165.1 9169.3 2312.0 2312.1 2332.9 2333.6 2335.4 2261.1 2297.1 2335.5 2339.2 2343.4 2251.1 2260.8 2267.4 2271.2 2275.8 2221.9 2267.9 2271.3 2271.5 2272.6 2240.1 2253.5 2259.0 2274.9 2279.6 9149.6 9150.1 9172.0 9199.3 9217.7 5275.5 5376.5 5387.0 5398.0 5412.5 3323.6 3359.3 3470.5 3485.7 3490.2 1027.7 1035.8 1036.1 1046.5 1054.8 12813.1 12858.9 12863.4 12890.9 12910.0 4506.3 4545.2 4621.2 4692.7 4778.5 10674.5 10733.4 10738.1 10741.2 10748.5 5431.6 5452.3 5460.0 5477.8 5480.8 4403.5 4799.1 4935.5 4939.2 5001.0 3915.8 3961.7 4106.6 4106.8 4144.0 1248.0 1262.8 1282.4 1283.1 1293.6 900.0 955.7 964.4 971.7 987.0 5757.2 5963.7 6065.4 6111.6 6155.2 425.6 425.8 430.6 431.9 435.5 4079.2 4099.7 4111.3 4149.0 4186.2 11224.1 11425.5 11612.1 11685.0 11742.4 11272.8 11278.8 11332.7 11341.5 11354.4 8486.7 8546.8 8618.1 8782.0 8791.8 5860.4 5911.2 5981.8 6025.1 6037.4 10494.1 10570.9 10634.4 10742.6 10767.0 10577.7 10812.5 10915.1 11040.4 11057.8 7299.0 7741.6 8054.9 8232.7 8308.8 8954.7 8962.8 9019.3 9056.2 9072.2 7658.5 7678.9 7778.1 7936.8 7938.6 7817.2 8000.6 8005.4 8018.3 8042.2 7100.9 7137.3 7201.2 7204.1 7212.7 4997.2 5061.4 5192.8 5232.5 5233.3 4844.6 4954.4 4980.7 5113.2 5198.0 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#4] prototype.html Cycles:180 Average:4905.47 Median:5603.43 stddev:1464.72 (26.1%) stddev-sans-first:1427.66 15:34:38 INFO - PROCESS | 25286 | Values: 310.9 320.0 324.4 324.7 326.0 5204.2 5616.6 5671.2 5674.3 5721.2 5613.7 5626.6 5629.4 5630.5 5639.6 4378.7 4396.4 4417.8 4423.0 4434.9 4339.2 4352.9 4356.6 4378.5 4435.4 4306.7 4314.2 4325.9 4349.6 4366.9 4178.3 4367.4 4370.4 4386.2 4406.5 3753.7 3755.9 3760.5 3775.3 3784.1 5500.9 5541.6 5557.5 5562.7 5582.0 4815.5 4966.2 4985.9 4999.3 5009.2 5851.1 5856.8 5865.9 5875.2 5892.6 4112.8 4115.7 4138.7 4149.3 4150.7 5804.2 6120.2 6143.3 6173.9 6214.7 4195.2 4210.2 4214.8 4220.0 4230.4 4259.7 4264.7 4266.9 4268.5 4281.7 4788.7 4939.3 4956.3 4962.5 4969.3 5593.2 5744.9 5914.6 5930.6 5936.9 1444.2 1452.9 1453.3 1454.2 1454.4 900.2 917.8 919.4 937.7 941.2 4865.1 4965.7 4983.9 5055.9 5065.6 5286.8 5294.0 5338.4 5354.0 5357.9 5061.7 5072.4 5074.3 5320.3 5749.7 3197.3 3214.6 3232.3 3233.3 3234.2 6134.0 6242.3 6262.7 6279.9 6322.6 6213.4 6216.2 6217.4 6227.3 6264.7 6229.7 6235.5 6238.6 6261.8 6296.7 5839.4 5999.7 6020.8 6021.7 6026.6 5982.4 6011.0 6027.1 6027.5 6034.2 5970.7 6213.2 6222.6 6272.6 6294.5 4279.6 4340.5 4344.2 4345.9 4352.0 5885.6 5911.0 6060.8 6089.8 6133.9 5906.3 5935.6 5948.6 5965.9 5974.7 5947.9 5948.7 5953.8 5975.9 5989.3 5696.9 5773.0 5889.5 5894.9 5931.1 5972.5 6005.6 6010.8 6014.1 6031.3 5700.2 5834.2 5843.5 5851.6 5923.7 15:34:38 INFO - PROCESS | 25286 | 15:34:38 INFO - PROCESS | 25286 | [#5] yui.html Cycles:180 Average:21070.59 Median:4103.13 stddev:30285.83 (738.1%) stddev-sans-first:30332.40 15:34:38 INFO - PROCESS | 25286 | Values: 760.7 797.1 819.0 819.5 905.7 15078.5 16016.8 16032.1 16086.0 16148.0 15070.8 15319.1 15322.2 15361.2 15368.9 656.0 788.8 808.1 809.7 813.1 809.7 810.0 816.6 818.7 820.2 866.4 873.8 874.1 878.6 879.3 856.9 865.4 866.0 866.4 869.1 630.6 631.0 632.4 637.6 638.3 14846.7 14927.8 15013.0 15053.5 15080.5 15657.5 15676.1 15712.8 15802.5 15851.9 12339.1 12425.4 12518.3 12623.9 12670.3 3921.4 4047.4 4091.3 4115.0 4126.5 75121.0 78432.0 78517.6 78709.0 78772.0 11787.6 11918.5 12071.5 12433.5 12742.2 20672.0 20690.0 20710.9 20720.8 20726.3 8390.5 8452.5 8574.8 8646.5 8803.6 4372.7 4471.5 4570.8 4595.9 4686.2 3534.0 3615.9 3625.9 3650.3 3655.2 629.9 643.3 661.4 677.3 690.5 725.3 747.8 763.2 769.5 805.9 9462.7 9706.4 9792.3 9834.0 9875.7 695.8 703.0 706.5 710.4 735.9 4612.5 4873.4 4879.0 4911.7 4940.4 107418.5 128739.0 128751.0 128946.4 130216.0 66549.7 71722.0 84293.0 100117.0 108230.5 76860.6 79484.6 93480.0 96510.0 96565.5 10058.1 10156.2 10535.5 10548.8 10557.5 37577.8 47313.8 48983.0 51348.2 55065.4 73916.0 74298.0 74365.6 76727.2 79131.0 13081.1 13410.0 13469.0 13923.0 14145.2 14420.1 14572.7 15532.8 15752.0 16153.8 13963.4 14620.9 14804.2 14947.3 14991.3 14519.9 14805.6 14827.1 15341.7 15454.9 14120.4 14333.5 14673.0 14750.3 15286.4 11911.5 11994.2 11999.0 12375.7 12416.3 11741.5 11743.8 11845.4 12365.6 12498.3 15:34:38 INFO - PROCESS | 25286 | -------- Summary: end -------- 15:34:38 INFO - PROCESS | 25286 | 15:34:39 INFO - TEST-INFO | 25286: exit 0 15:34:39 INFO - TEST-OK | dromaeo_css | took 1110189ms 15:34:39 INFO - TEST-START | kraken 15:34:39 INFO - operating with platform_type : linux_ 15:34:39 INFO - Initialising browser for kraken test... 15:34:39 INFO - TEST-INFO | started process 25533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9F3cdM/profile http://localhost:59145/getInfo.html) 15:34:43 INFO - PROCESS | 25533 | __metrics Screen width/height:1600/1200 15:34:43 INFO - PROCESS | 25533 | colorDepth:24 15:34:43 INFO - PROCESS | 25533 | Browser inner width/height: 1024/697 15:34:43 INFO - PROCESS | 25533 | __metrics 15:34:44 ERROR - PROCESS | 25533 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:34:44 INFO - TEST-INFO | 25533: exit 0 15:34:44 INFO - Browser initialized. 15:34:44 INFO - Running cycle 1/1 for kraken test... 15:34:44 INFO - TEST-INFO | started process 25650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9F3cdM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:56 INFO - PROCESS | 25650 | RSS: Main: 168013824 15:34:56 INFO - PROCESS | 25650 | 15:34:59 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59145/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:00 INFO - PROCESS | 25650 | RSS: Main: 173174784 15:35:00 INFO - PROCESS | 25650 | 15:35:02 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59145/tests/kraken/driver.html?testName=audio-dft) 15:35:03 INFO - PROCESS | 25650 | RSS: Main: 172810240 15:35:03 INFO - PROCESS | 25650 | 15:35:06 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59145/tests/kraken/driver.html?testName=audio-fft) 15:35:06 INFO - PROCESS | 25650 | RSS: Main: 166785024 15:35:06 INFO - PROCESS | 25650 | 15:35:08 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59145/tests/kraken/driver.html?testName=audio-oscillator) 15:35:09 INFO - PROCESS | 25650 | RSS: Main: 167829504 15:35:09 INFO - PROCESS | 25650 | 15:35:11 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:12 INFO - PROCESS | 25650 | RSS: Main: 168919040 15:35:12 INFO - PROCESS | 25650 | 15:35:15 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59145/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:16 INFO - PROCESS | 25650 | RSS: Main: 168341504 15:35:16 INFO - PROCESS | 25650 | 15:35:19 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59145/tests/kraken/driver.html?testName=imaging-desaturate) 15:35:20 INFO - PROCESS | 25650 | RSS: Main: 166141952 15:35:20 INFO - PROCESS | 25650 | 15:35:23 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59145/tests/kraken/driver.html?testName=json-parse-financial) 15:35:23 INFO - PROCESS | 25650 | RSS: Main: 167755776 15:35:23 INFO - PROCESS | 25650 | 15:35:25 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:25 INFO - PROCESS | 25650 | RSS: Main: 167940096 15:35:25 INFO - PROCESS | 25650 | 15:35:27 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:28 INFO - PROCESS | 25650 | RSS: Main: 168493056 15:35:28 INFO - PROCESS | 25650 | 15:35:30 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:31 INFO - PROCESS | 25650 | RSS: Main: 169484288 15:35:31 INFO - PROCESS | 25650 | 15:35:33 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:34 INFO - PROCESS | 25650 | RSS: Main: 169717760 15:35:34 INFO - PROCESS | 25650 | 15:35:37 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:37 INFO - PROCESS | 25650 | RSS: Main: 168640512 15:35:37 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | Cycle 1(1): loaded http://localhost:59145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59145/tests/kraken/driver.html?testName=ai-astar) 15:35:39 INFO - PROCESS | 25650 | RSS: Main: 169885696 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | __start_tp_report 15:35:39 INFO - PROCESS | 25650 | _x_x_mozilla_page_load 15:35:39 INFO - PROCESS | 25650 | _x_x_mozilla_page_load_details 15:35:39 INFO - PROCESS | 25650 | |i|pagename|runs| 15:35:39 INFO - PROCESS | 25650 | |0;ai-astar;101;111;106;110;111;112;112;111;111;111 15:35:39 INFO - PROCESS | 25650 | |1;audio-beat-detection;152;117;146;165;118;151;148;124;178;123 15:35:39 INFO - PROCESS | 25650 | |2;audio-dft;162;162;161;162;162;164;168;166;163;162 15:35:39 INFO - PROCESS | 25650 | |3;audio-fft;76;75;76;135;77;74;75;77;177;75 15:35:39 INFO - PROCESS | 25650 | |4;audio-oscillator;84;83;149;84;85;83;151;84;84;144 15:35:39 INFO - PROCESS | 25650 | |5;imaging-gaussian-blur;118;118;117;117;118;117;118;118;118;118 15:35:39 INFO - PROCESS | 25650 | |6;imaging-darkroom;148;147;148;148;150;148;147;147;148;147 15:35:39 INFO - PROCESS | 25650 | |7;imaging-desaturate;96;95;95;96;95;95;96;96;96;95 15:35:39 INFO - PROCESS | 25650 | |8;json-parse-financial;55;56;53;53;52;55;56;52;52;51 15:35:39 INFO - PROCESS | 25650 | |9;json-stringify-tinderbox;64;64;63;64;64;64;63;64;64;65 15:35:39 INFO - PROCESS | 25650 | |10;stanford-crypto-aes;76;77;76;77;76;75;77;79;80;76 15:35:39 INFO - PROCESS | 25650 | |11;stanford-crypto-ccm;121;124;121;129;134;132;125;121;158;133 15:35:39 INFO - PROCESS | 25650 | |12;stanford-crypto-pbkdf2;160;159;160;161;163;161;159;160;160;161 15:35:39 INFO - PROCESS | 25650 | |13;stanford-crypto-sha256-iterative;67;70;67;65;66;67;63;65;62;65 15:35:39 INFO - PROCESS | 25650 | __end_tp_report 15:35:39 INFO - PROCESS | 25650 | __start_cc_report 15:35:39 INFO - PROCESS | 25650 | _x_x_mozilla_cycle_collect,916 15:35:39 INFO - PROCESS | 25650 | __end_cc_report 15:35:39 INFO - PROCESS | 25650 | __startTimestamp1468881339613__endTimestamp 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | ------- Summary: start ------- 15:35:39 INFO - PROCESS | 25650 | Number of tests: 14 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:1.81 15:35:39 INFO - PROCESS | 25650 | Values: 101.0 111.0 106.0 110.0 111.0 112.0 112.0 111.0 111.0 111.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:149.50 stddev:20.93 (14.0%) stddev-sans-first:21.90 15:35:39 INFO - PROCESS | 25650 | Values: 152.0 117.0 146.0 165.0 118.0 151.0 148.0 124.0 178.0 123.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.20 (1.4%) stddev-sans-first:2.29 15:35:39 INFO - PROCESS | 25650 | Values: 162.0 162.0 161.0 162.0 162.0 164.0 168.0 166.0 163.0 162.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.50 stddev:35.32 (46.8%) stddev-sans-first:37.00 15:35:39 INFO - PROCESS | 25650 | Values: 76.0 75.0 76.0 135.0 77.0 74.0 75.0 77.0 177.0 75.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:31.04 (36.9%) stddev-sans-first:32.14 15:35:39 INFO - PROCESS | 25650 | Values: 84.0 83.0 149.0 84.0 85.0 83.0 151.0 84.0 84.0 144.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:35:39 INFO - PROCESS | 25650 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:35:39 INFO - PROCESS | 25650 | Values: 148.0 147.0 148.0 148.0 150.0 148.0 147.0 147.0 148.0 147.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:35:39 INFO - PROCESS | 25650 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.84 (3.4%) stddev-sans-first:1.87 15:35:39 INFO - PROCESS | 25650 | Values: 55.0 56.0 53.0 53.0 52.0 55.0 56.0 52.0 52.0 51.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 15:35:39 INFO - PROCESS | 25650 | Values: 64.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:1.52 (2.0%) stddev-sans-first:1.58 15:35:39 INFO - PROCESS | 25650 | Values: 76.0 77.0 76.0 77.0 76.0 75.0 77.0 79.0 80.0 76.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:130.50 stddev:11.14 (8.5%) stddev-sans-first:11.36 15:35:39 INFO - PROCESS | 25650 | Values: 121.0 124.0 121.0 129.0 134.0 132.0 125.0 121.0 158.0 133.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 15:35:39 INFO - PROCESS | 25650 | Values: 160.0 159.0 160.0 161.0 163.0 161.0 159.0 160.0 160.0 161.0 15:35:39 INFO - PROCESS | 25650 | 15:35:39 INFO - PROCESS | 25650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:2.26 (3.4%) stddev-sans-first:2.35 15:35:39 INFO - PROCESS | 25650 | Values: 67.0 70.0 67.0 65.0 66.0 67.0 63.0 65.0 62.0 65.0 15:35:39 INFO - PROCESS | 25650 | -------- Summary: end -------- 15:35:39 INFO - PROCESS | 25650 | 15:35:40 INFO - TEST-INFO | 25650: exit 0 15:35:40 INFO - TEST-OK | kraken | took 60921ms 15:35:40 INFO - SUITE-END | took 1171s 15:35:40 INFO - Completed test suite (00:19:31) 15:35:40 INFO - javascript benchmark 15:35:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.939947361096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.678628743982, 3108.0209733933807, 3112.3619657970116, 3115.081051089928, 3116.7506599472044, 5441.9455805441985, 5515.61390702651, 5558.221848941146, 5566.387697353288, 5567.749451274693, 5452.509274165324, 5494.423085576007, 5510.614257002011, 5524.14375771755, 5545.251391062206, 4971.279164521142, 4999.075171093359, 5096.413912400066, 5153.793848246066, 5180.378354597454, 711.6067046033671, 4926.531979461945, 4997.700137991732, 5058.0895438821, 5060.569851562604, 5004.299398084271, 5012.924806127911, 5030.748462576893, 5032.899342013157, 5034.924476132861, 5038.445770965191, 5051.6716413433005, 5057.140286151363, 5066.36670416198, 5069.645124841262, 4943.530364615356, 4947.134251506008, 4961.05739909416, 5008.649394542384, 5016.974915125401, 5456.7544460499375, 5467.125259958388, 5478.0, 5529.585281103893, 5539.307586551681, 5592.077307244341, 5883.8529036774, 5886.852828679274, 5892.057270836645, 5935.881282374372, 5896.321922978869, 5942.910856337158, 5962.910556341615, 6015.939840601582, 6038.57729958903, 5555.749991250404, 5558.221848941152, 5572.108462645957, 5574.721263936827, 5597.076482380402, 5920.4967577755515, 5922.911156332659, 6103.176071230327, 6111.633302001894, 6118.5716999810475, 5716.314042314949, 5724.570657200727, 5733.799317023884, 5734.16854556087, 5739.655620662774, 5843.795467158714, 5848.590598658053, 5855.063189889597, 5872.677002764804, 5879.941200588025, 5799.82600521985, 5826.592138550261, 5871.236739223874, 5894.233749612523, 5922.052471604608, 5884.794032208938, 5919.082542205965, 5930.28836539618, 5931.881362372815, 5954.523638108941, 4384.583464570861, 4409.845655402046, 4421.9336709949375, 4423.358613001097, 4425.668074894395, 3803.7337386382687, 3913.2173565287057, 3951.7628942263555, 3973.006748312922, 3976.324024915771, 5423.891522169534, 5427.213054107132, 5436.891262174813, 5447.455254474521, 5484.478974497416, 5792.044312688444, 5813.331466881363, 5830.650160990354, 5846.853828654318, 5849.415058494116, 5561.916571251434, 5566.332040155207, 5574.08027675429, 5575.553955683536, 5607.327120745536, 4919.1391506486225, 4937.530934561211, 4987.725675087832, 4987.725675087905, 4990.550850423407, 6093.847653808691, 6100.816975490742, 6102.847428814315, 6116.66358350295, 6185.84535386619, 5829.76680932758, 5934.228550288435, 5952.166696662384, 5981.192539007178, 6009.849753756191, 6134.263888333428, 6153.292371377349, 6171.352008039091, 6196.318404975359, 6205.751769929333, 5839.474447299764, 5909.645421274738, 5910.52715782745, 5921.467067963904, 5926.940730592639, 5886.6173698709445, 5911.054231322968, 5943.465088142088, 6004.099385092271, 6016.909746353721, 5844.649321040752, 5848.619839710405, 5849.64902105875, 5862.618929769551, 5899.17411562373, 5830.62100963436, 5831.7375718093635, 5840.970795145997, 5844.386339434298, 5863.736131874161, 5623.550115990793, 5739.512141468022, 5740.741666625096, 5751.396103409082, 5794.797182098607, 5841.883162336814, 5916.142159386779, 5932.13983972313, 5946.316173640087, 5949.405059494016, 5775.422457754191, 5791.102379131073, 5797.971010145091, 5801.5938884279385, 5812.3025236971835], "value": 5405.412574241652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9834555954426, 589.6285340235651, 602.7498588085945, 608.4068033667176, 611.22069361564, 42586.14827703448, 44205.0, 44298.77850610746, 44509.554904450946, 48191.27713084307, 46103.0, 46237.30644040342, 46564.301535476996, 46599.0, 46659.033982111476, 8854.955725221365, 8947.955260223689, 8951.865722014176, 8982.0, 9002.684906028291, 8859.335549833788, 8950.462972221654, 8952.0, 8954.86567701485, 8965.32760042996, 8950.015498295183, 8979.506127163004, 8988.910110898905, 8990.955045224797, 9022.278217742565, 8917.73246802597, 8929.866052009225, 8946.955265223633, 8947.19475247231, 8954.37319387643, 8834.983976842681, 8875.378723489359, 8895.822083558292, 8901.243394311492, 8926.0, 43502.0, 43677.12645747067, 43923.0, 44000.55999439997, 44013.559864401264, 3548.201654627714, 3677.2093999790172, 3795.6963442924775, 3806.4480650305827, 3808.3906574947873, 30778.384432311228, 31600.0, 31641.20896977594, 33908.0, 33931.830340848384, 4268.722533035343, 4344.804483798237, 4377.321515165155, 4398.780060996937, 4553.840615578472, 375736.0, 376017.0, 377201.0, 378576.0, 379844.0, 61942.38057619456, 62481.0, 62829.371706283266, 62978.0, 63082.36917630765, 65089.0, 65223.0, 65223.673881631235, 65688.0, 65703.0, 17233.913830430767, 17466.214020369112, 17505.38731144404, 17547.385841495485, 17723.556911077067, 13222.272774997275, 13228.867711322764, 13237.271950042648, 13284.0, 13328.00039997004, 19243.51891202731, 19298.22807087729, 19469.805301947083, 19544.70682939757, 19761.209551617776, 7244.203137654854, 7388.0, 7431.405487560982, 7442.0, 7470.252974702595, 976.1800087926176, 1025.6666583360438, 1035.6737627647417, 1079.7192729890285, 1185.9978318321005, 32811.17972050718, 33404.33191336208, 33499.82785032496, 33507.83246083803, 33614.32771344559, 1109.9611513596985, 1141.406468636321, 1142.177632104883, 1176.952921883115, 1191.8939254269133, 16456.506304810875, 17440.82559174392, 17489.31480068412, 17494.65010699779, 17665.205065772072, 157486.21256893643, 157832.0, 158099.0, 158620.0, 158917.0, 59431.40568594345, 60036.69981650151, 60163.398366016656, 60194.39805601888, 60251.698741506014, 1309.5220244610648, 1358.7758019926798, 1373.663452454135, 1394.2262044565161, 1401.985980140206, 30591.847040765544, 32854.0, 32963.011109666746, 33023.834880825445, 33408.49887251742, 51735.741321294656, 52281.0, 52314.21528676997, 52411.0, 52447.21329180142, 436184.0, 436458.0, 438060.0, 440808.0, 443979.0, 28077.859610701817, 28293.0, 28525.714742853135, 28926.13221603355, 29015.56476652894, 47905.76047119742, 48020.0, 48946.51053489562, 49288.75355623342, 49504.0, 40690.59309406987, 42015.0, 42649.78675106604, 42833.0, 44150.33774493321, 42467.0, 42767.0, 42988.78505607452, 43054.78472607617, 43503.564964351215, 36234.27531449409, 40902.1819563613, 40914.79542602387, 41261.38107928324, 42606.0, 36591.63408365882, 38081.2383752329, 38243.42634860424, 38422.615773841906, 38621.80689096537, 28862.567061494516, 29050.41899162047, 29218.0, 29363.265918352212, 29604.703952960193], "value": 19978.63378053848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.8791054996576, 376.0673529646475, 377.39428217710577, 378.4965995226348, 395.8733205374281, 18878.43364699058, 19819.603607927867, 20138.0, 20716.585668286625, 20761.480962975933, 19511.121999510022, 20132.396028119143, 20352.0, 20497.180112795508, 20659.69010464844, 5707.4577915098, 5788.102844059156, 5856.648601083949, 5876.44173803488, 5894.852628684274, 5606.074997625387, 5767.913481297784, 5794.449527294922, 5795.681237531934, 5812.041013232812, 5596.496315331619, 5623.887522249573, 5694.943050569504, 5718.285214348207, 5719.571032172583, 5718.971405142947, 5720.427957204288, 5741.598088133853, 5753.597248192628, 5754.625949313281, 4778.259369797687, 5047.0, 5063.443021267658, 5117.33474648297, 5117.385913690381, 13555.25446100464, 13663.0, 13669.794953075712, 14676.0, 22664.206752763574, 2330.545543618995, 2361.8228632852606, 2515.7484251574697, 2670.9599356009676, 2686.449277898026, 9957.302988790787, 10187.49062546877, 10241.180705543613, 10252.33359831616, 10255.743606409826, 1930.7007413850877, 1948.405736250443, 2000.349886286948, 2041.9387418377473, 2051.6819892916624, 86998.56500717519, 92276.53861730716, 92311.53844230736, 93550.06449935482, 94993.52503237508, 10149.492525373702, 10567.471626418803, 10599.682009539727, 10836.024757771838, 10850.782984340269, 14227.85772142286, 14365.0, 14387.712245755236, 14426.639334016734, 14461.349239284258, 7713.845723085619, 7732.188120247405, 8112.351011919032, 8123.065847427503, 8232.34141268697, 7818.8827167592535, 7836.92163078362, 7860.606969651494, 8060.113387527367, 8072.636731347104, 4212.662986961036, 4320.524742278347, 4385.232584297735, 4427.645788336926, 4591.908161836812, 1740.8781385302907, 1892.8958907260233, 1903.847692184622, 1905.1331644101901, 1906.218450435315, 958.8513780364054, 1026.5380578739598, 1028.3983869436313, 1054.314695447965, 1123.713453069462, 19578.314758983368, 20067.0, 20078.397648070582, 20230.494237644176, 20394.388168354675, 981.7300242433388, 996.5814357969671, 1033.3696445168441, 1034.1571619130384, 1035.539185062655, 9759.26805489591, 11138.0, 11172.385518796544, 11251.662450126509, 11267.774644507064, 344611.0, 347616.0, 348639.0, 509280.0, 513471.0, 97647.51176244073, 104657.0, 104981.47509262405, 105587.0, 105613.47193263985, 1002.2633364477103, 1049.8530205771199, 1053.1364281289423, 1064.8775390830153, 1067.9359238445563, 15977.440789572309, 17765.822341776933, 18542.907285463487, 18549.81450185481, 18624.5343866399, 42408.78795606002, 42512.0, 43027.56972430235, 43118.78440607777, 43722.0, 55794.72102639623, 55869.16196256978, 59816.40183598108, 60847.39152608594, 61342.0, 8471.364647651328, 8482.0, 8504.702335418231, 8510.531920744172, 8521.147885211429, 12644.30456324911, 13237.470501179845, 13281.40233689467, 13998.090124141898, 14175.29123543798, 11805.940970295436, 11889.464974076014, 11974.341411222467, 12173.756524869275, 12262.570810021607, 11916.642500724993, 12117.757644846877, 12295.44670489848, 12421.19262247951, 12496.687582810138, 12226.083043771574, 12259.632211033684, 12340.938295308824, 12418.37908104573, 12616.873831261937, 8032.076311224284, 8393.874091888505, 8455.534945578052, 8544.658213671632, 8804.64781408762, 11332.716682083013, 11664.708382290512, 11773.941130294294, 11816.70458238551, 12280.38598070075], "value": 9189.366165935851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.408990493707, 1541.606890242988, 1681.9747703784446, 1797.5146710388187, 1819.9363022294222, 7983.044154182219, 8601.225889669928, 8723.563821808915, 9251.398659087155, 9298.72103836885, 8823.911760882389, 9049.321300902426, 9130.04134565871, 9165.083491650832, 9169.312301577374, 2311.9537609247845, 2312.1098377124845, 2332.8950197241165, 2333.649952507129, 2335.4278201840575, 2261.118163916074, 2297.0811675329833, 2335.474518233401, 2339.2280547419396, 2343.414146463384, 2251.1445650652813, 2260.7965283124518, 2267.3651377614297, 2271.1710225767642, 2275.8293128015384, 2221.8555793873347, 2267.875266860322, 2271.318604418676, 2271.4889149941214, 2272.6477396003647, 2240.137547044383, 2253.526759380532, 2259.0399080390766, 2274.931752047441, 2279.6010698127925, 9149.634014639407, 9150.130737579919, 9171.954140229323, 9199.310051746079, 9217.723468295962, 5275.472452754732, 5376.516113549799, 5387.0303345397815, 5397.973010134963, 5412.539934105605, 3323.5513205717402, 3359.260962588227, 3470.496777967206, 3485.7037151842123, 3490.162361033359, 1027.6505987964129, 1035.808375450544, 1036.0830664861576, 1046.5447530324334, 1054.7679510507676, 12813.10308278421, 12858.871411285862, 12863.42114604845, 12890.87109128906, 12910.0, 4506.346579745984, 4545.227311357077, 4621.23749581322, 4692.718436893797, 4778.4982576829625, 10674.519646615921, 10733.409662468483, 10738.087262582612, 10741.19441041925, 10748.462576871125, 5431.646942948775, 5452.291202143696, 5460.044492213847, 5477.780888764484, 5480.808171713971, 4403.515613282536, 4799.136155491975, 4935.506449355035, 4939.160342741742, 5000.974995125001, 3915.804209789499, 3961.6632586230494, 4106.568810274938, 4106.815193316308, 4144.0, 1247.9812802807965, 1262.8232047513357, 1282.3780466473752, 1283.0697744135614, 1293.5537239652306, 899.9965038981488, 955.7467271173144, 964.4309857184295, 971.6502059258661, 986.9851952220722, 5757.193992841006, 5963.701814909237, 6065.3934606539, 6111.57218994675, 6155.230596175478, 425.6403339178389, 425.8254115812564, 430.5672798837149, 431.9092990472036, 435.53615399599323, 4079.1637714268504, 4099.692523060782, 4111.342185250345, 4149.045719484536, 4186.204621121977, 11224.102071834397, 11425.485853136628, 11612.071034317403, 11685.0, 11742.354170520532, 11272.830907536394, 11278.774424511465, 11332.660020199242, 11341.489632966537, 11354.432278386048, 8486.74539763808, 8546.829063418822, 8618.052014278424, 8781.999999999873, 8791.824163516821, 5860.443257890493, 5911.231539899785, 5981.820545383645, 6025.096235564701, 6037.396260373927, 10494.10800081971, 10570.894291056991, 10634.361938283728, 10742.570297188026, 10767.0, 10577.735556610838, 10812.5134368952, 10915.139436260972, 11040.392778397265, 11057.778844422906, 7299.0, 7741.5742134183165, 8054.879176812469, 8232.711855085043, 8308.750737477885, 8954.686585969459, 8962.820743585222, 9019.32355073359, 9056.184943355129, 9072.183503484717, 7658.540487570764, 7678.884816727866, 7778.0666320041955, 7936.841263174589, 7938.56337901421, 7817.218278172138, 8000.6399712011935, 8005.439619226599, 8018.3184429324165, 8042.195780421911, 7100.893486597602, 7137.250588688113, 7201.171865235565, 7204.0994875640545, 7212.675429605785, 4997.150484417585, 5061.443241243386, 5192.792288308426, 5232.534890230741, 5233.319668443078, 4844.61243100544, 4954.355933728736, 4980.726060066731, 5113.233015047773, 5198.038362902875], "value": 4617.1446523454415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.8740959911237, 319.9536067270246, 324.3852898756856, 324.66559443772906, 326.0414381717748, 5204.219367094937, 5616.606837521375, 5671.1776792365135, 5674.290713660793, 5721.227634269372, 5613.663180209191, 5626.634268772527, 5629.408912064236, 5630.5495560355175, 5639.605227634067, 4378.715383500063, 4396.428464299636, 4417.757023363713, 4422.987540669004, 4434.911301773978, 4339.218940590692, 4352.869413917588, 4356.607905288523, 4378.452693413324, 4435.356873253377, 4306.676999225055, 4314.180305741915, 4325.870223893273, 4349.565043495657, 4366.912661746779, 4178.331466965271, 4367.366731823884, 4370.38814565961, 4386.166628340605, 4406.471223453174, 3753.7372383933134, 3755.9248815023548, 3760.52993375828, 3775.301569209705, 3784.1485665725268, 5500.917486237709, 5541.556675465953, 5557.527610153142, 5562.749676264578, 5582.0, 4815.542523460265, 4966.205407134841, 4985.850424487271, 4999.275105109775, 5009.173486374744, 5851.132944857032, 5856.76572937082, 5865.912011319833, 5875.206847075633, 5892.58577941291, 4112.753234805921, 4115.691323150776, 4138.710290279681, 4149.315362965107, 4150.667946564297, 5804.216430781833, 6120.20437343147, 6143.293521245069, 6173.938260617381, 6214.720337584819, 4195.160967806451, 4210.179015092089, 4214.831406743757, 4219.98720307124, 4230.386593943923, 4259.680523960716, 4264.744115353089, 4266.893327666771, 4268.530461649216, 4281.721688090264, 4788.688735232199, 4939.2838038484215, 4956.256561515802, 4962.478939711351, 4969.304297398295, 5593.188987596775, 5744.856378590569, 5914.58597898143, 5930.584859059824, 5936.9406305937255, 1444.162385816224, 1452.8595052883647, 1453.32420424501, 1454.163855782929, 1454.4182327069045, 900.230303090861, 917.7659696777413, 919.3656377099779, 937.6577549194495, 941.2187884056217, 4865.053978408665, 4965.652404331734, 4983.9252411213865, 5055.9241611375855, 5065.594752419797, 5286.841394758163, 5293.973530132402, 5338.439463856317, 5353.9732301338245, 5357.866053348619, 5061.696298222045, 5072.427547460299, 5074.314967479417, 5320.2817619620855, 5749.68376739275, 3197.328561002216, 3214.5981752280964, 3232.321212545392, 3233.3371658810356, 3234.207619133327, 6134.0, 6242.344553821874, 6262.6868656566985, 6279.905801412982, 6322.620642761357, 6213.409726076015, 6216.160818289473, 6217.378262173836, 6227.314995350508, 6264.744691910909, 6229.729392069109, 6235.469985051322, 6238.563300569007, 6261.843453913689, 6296.685165741695, 5839.386864379179, 5999.670018149044, 6020.819375418744, 6021.729022193924, 6026.578139530191, 5982.35485241562, 6010.9699451502465, 6027.095935609694, 6027.457528822427, 6034.24571928509, 5970.671613061323, 6213.1922850029205, 6222.62664240147, 6272.59228150187, 6294.464970477561, 4279.550647182001, 4340.544242854455, 4344.218040752695, 4345.891352716208, 4352.0, 5885.557493640092, 5910.970445147746, 6060.787872424444, 6089.786857459968, 6133.877322453437, 5906.26171728534, 5935.614185077956, 5948.643081415129, 5965.9105113422465, 5974.701264936823, 5947.947957954499, 5948.73230704628, 5953.791617293374, 5975.880482390415, 5989.251343582052, 5696.914546281726, 5772.960867043972, 5889.499392551681, 5894.852628684317, 5931.1399847021075, 5972.5367285015445, 6005.609635373687, 6010.759569617341, 6014.097885317063, 6031.306399763907, 5700.1858104733765, 5834.212381328466, 5843.503302219189, 5851.590388672922, 5923.703814809329], "value": 4424.922381702979, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.6501009535614, 797.0873350014234, 818.9631466584003, 819.5328662662283, 905.7192270396174, 15078.47225347113, 16016.75974860375, 16032.118233497153, 16085.99999999997, 16148.0, 15070.849291507082, 15319.080855148699, 15322.15728134952, 15361.15513646749, 15368.923155384235, 655.954083214174, 788.787027502574, 808.0828259924998, 809.720646376999, 813.0974618173823, 809.6720828064614, 809.9919000809975, 816.6325153680838, 818.7339114787688, 820.1675299570941, 866.4238281542798, 873.8164985353084, 874.1477059866611, 878.6002368922157, 879.3273146043282, 856.9485830850169, 865.3855762408697, 866.0257210638032, 866.4281574161055, 869.1395518436765, 630.5932673425615, 630.9747610095591, 632.4213344789512, 637.5760119520513, 638.2723694987718, 14846.70306593873, 14927.776083358758, 15013.0, 15053.548393548212, 15080.472183473526, 15657.451989180438, 15676.137812420313, 15712.764308535381, 15802.525924222176, 15851.920740396225, 12339.136260461772, 12425.44085516154, 12518.311492867888, 12623.87376126236, 12670.303133327663, 3921.4313924481075, 4047.392891066334, 4091.284025295561, 4114.979425102855, 4126.546079931205, 75121.0, 78432.0, 78517.60741196315, 78709.0, 78772.0, 11787.587434439753, 11918.523259069714, 12071.517139314328, 12433.502659893504, 12742.235465872078, 20671.966401679856, 20690.0, 20710.896445517676, 20720.79279207219, 20726.274580389614, 8390.538520381315, 8452.535110568977, 8574.785630359167, 8646.52444115567, 8803.559822008874, 4372.672049596293, 4471.530489298577, 4570.840020599263, 4595.9080818383445, 4686.179918514246, 3534.0, 3615.9276814463565, 3625.9456108158397, 3650.2699460108083, 3655.1593133578895, 629.8834715577541, 643.3341491556217, 661.4014317042987, 677.2584020497547, 690.4821383962028, 725.3363172696924, 747.8392145688703, 763.1681467200777, 769.54981335918, 805.9314958228616, 9462.668806591737, 9706.369086009387, 9792.265580081523, 9833.950830245803, 9875.7161568997, 695.8330000799772, 703.0298188499837, 706.523096909584, 710.4316546762569, 735.9448041396917, 4612.5156858530045, 4873.439554451213, 4878.95121048792, 4911.705297682151, 4940.407151141814, 107418.46290768497, 128739.0, 128751.0, 128946.35526822307, 130216.0, 66549.66725166343, 71722.0, 84293.0, 100117.0, 108230.45884770683, 76860.61569692116, 79484.6025769879, 93480.0, 96510.0, 96565.51717241369, 10058.084694434849, 10156.238282128723, 10535.4732263385, 10548.789024219626, 10557.52491137916, 37577.81211093927, 47313.763431182626, 48983.0, 51348.22977655263, 55065.44934550603, 73916.0, 74298.0, 74365.6281718588, 76727.23272767424, 79131.0, 13081.149725267827, 13409.994250431451, 13469.0, 13923.0, 14145.222012789396, 14420.134791912518, 14572.708545829237, 15532.796032238066, 15752.0, 16153.838461615704, 13963.441462341392, 14620.85379146195, 14804.185769782765, 14947.25263736787, 14991.2504374783, 14519.92740036293, 14805.619534763247, 14827.110373377633, 15341.693166136838, 15454.922725386301, 14120.364583593968, 14333.498327558902, 14673.0, 14750.2624868754, 15286.388544458097, 11911.523539058688, 11994.220375675553, 11998.98008669238, 12375.69060773488, 12416.255024698547, 11741.530338786353, 11743.76512469763, 11845.407729613313, 12365.567205147776, 12498.315691764237], "value": 7781.351767254685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 106.0, 110.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 146.0, 165.0, 118.0, 151.0, 148.0, 124.0, 178.0, 123.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 164.0, 168.0, 166.0, 163.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 135.0, 77.0, 74.0, 75.0, 77.0, 177.0, 75.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 149.0, 84.0, 85.0, 83.0, 151.0, 84.0, 84.0, 144.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 150.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 53.0, 52.0, 55.0, 56.0, 52.0, 52.0, 51.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 77.0, 76.0, 75.0, 77.0, 79.0, 80.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 121.0, 129.0, 134.0, 132.0, 125.0, 121.0, 158.0, 133.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 163.0, 161.0, 159.0, 160.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 65.0, 66.0, 67.0, 63.0, 65.0, 62.0, 65.0], "value": 65.7, "unit": "score"}]}]} 15:35:40 INFO - Return code: 0 15:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:35:40 ERROR - # TBPL SUCCESS # 15:35:40 INFO - Running post-action listener: _resource_record_post_action 15:35:40 INFO - ##### 15:35:40 INFO - ##### Finished run-tests step (success) 15:35:40 INFO - ##### 15:35:40 INFO - Running post-run listener: _resource_record_post_run 15:35:41 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558243840; Read time: 16; Write time: 407260 15:35:41 INFO - TinderboxPrint: CPU usage
13.3% 15:35:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:35:41 INFO - TinderboxPrint: I/O write bytes / time
558,243,840 / 407,260 15:35:41 INFO - TinderboxPrint: CPU idle
8,223.4 (86.7%) 15:35:41 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 15:35:41 INFO - TinderboxPrint: Swap in / out
0 / 0 15:35:41 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256987136; Read time: 0; Write time: 226108 15:35:41 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 300642304; Read time: 0; Write time: 181152 15:35:41 INFO - Running post-run listener: _upload_blobber_files 15:35:41 INFO - Blob upload gear active. 15:35:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:41 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 15:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:42 INFO - (blobuploader) - INFO - Done attempting. 15:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:49 INFO - (blobuploader) - INFO - Done attempting. 15:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:50 INFO - (blobuploader) - INFO - Done attempting. 15:35:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:50 INFO - Return code: 0 15:35:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f86b20ff705355310180c8918b623cb4dc9ab009b16398e167d59fd75d776447b35bcf4a8b1ad2ed224b5421b0d9fd8f5ccbd36491103746d6a44344788ede77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa76a624ee0ae7cd936ae460df5598aa69310e9ce4149be7f8cb541aa66dd90aee62027a663ae54625496244916c396a60aec879d9d952b710c497ea2257f64b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7e6b5b0fff9a36445878ccdd385d05cac8d255736ae76e284b69bad633b69f8a4bfbd99cdf029f015c0765d857b496e187f0d9c561559cc1c591e500f96f8538"} 15:35:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:50 INFO - Contents: 15:35:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f86b20ff705355310180c8918b623cb4dc9ab009b16398e167d59fd75d776447b35bcf4a8b1ad2ed224b5421b0d9fd8f5ccbd36491103746d6a44344788ede77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa76a624ee0ae7cd936ae460df5598aa69310e9ce4149be7f8cb541aa66dd90aee62027a663ae54625496244916c396a60aec879d9d952b710c497ea2257f64b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7e6b5b0fff9a36445878ccdd385d05cac8d255736ae76e284b69bad633b69f8a4bfbd99cdf029f015c0765d857b496e187f0d9c561559cc1c591e500f96f8538"} 15:35:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:50 INFO - Copying logs to upload dir... 15:35:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.164789 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-18 15:35:50.079770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 15:35:50.083710) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f86b20ff705355310180c8918b623cb4dc9ab009b16398e167d59fd75d776447b35bcf4a8b1ad2ed224b5421b0d9fd8f5ccbd36491103746d6a44344788ede77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa76a624ee0ae7cd936ae460df5598aa69310e9ce4149be7f8cb541aa66dd90aee62027a663ae54625496244916c396a60aec879d9d952b710c497ea2257f64b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7e6b5b0fff9a36445878ccdd385d05cac8d255736ae76e284b69bad633b69f8a4bfbd99cdf029f015c0765d857b496e187f0d9c561559cc1c591e500f96f8538"} build_url:https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/dHtqAl6kQvaD74dyISGAhg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f86b20ff705355310180c8918b623cb4dc9ab009b16398e167d59fd75d776447b35bcf4a8b1ad2ed224b5421b0d9fd8f5ccbd36491103746d6a44344788ede77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa76a624ee0ae7cd936ae460df5598aa69310e9ce4149be7f8cb541aa66dd90aee62027a663ae54625496244916c396a60aec879d9d952b710c497ea2257f64b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7e6b5b0fff9a36445878ccdd385d05cac8d255736ae76e284b69bad633b69f8a4bfbd99cdf029f015c0765d857b496e187f0d9c561559cc1c591e500f96f8538"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 15:35:50.108772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:35:50.109066) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468875922.916857-2055574499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 15:35:50.191390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 15:35:50.191709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 15:35:50.191991) ========= ========= Total master_lag: 0.15 =========