builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1468318038.0 results: success (0) buildid: 20160712015726 builduid: 8e90f4f3119149eb9f2ca735872df949 revision: 278b332af0cdbe52578a2ea6498380f3e806e2be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.003451) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.004119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.004679) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.031056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.031784) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 03:07:18-- 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% 223M=0s 2016-07-12 03:07:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.155756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.156099) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014485 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:18.229020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 03:07:18.229428) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 278b332af0cdbe52578a2ea6498380f3e806e2be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 278b332af0cdbe52578a2ea6498380f3e806e2be --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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 03:07:18,894 truncating revision to first 12 chars 2016-07-12 03:07:18,894 Setting DEBUG logging. 2016-07-12 03:07:18,894 attempt 1/10 2016-07-12 03:07:18,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/278b332af0cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 03:07:19,941 unpacking tar archive at: mozilla-central-278b332af0cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 03:07:19.633577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:19.633972) ========= script_repo_revision: 278b332af0cdbe52578a2ea6498380f3e806e2be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:19.634482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:19.634849) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:07:19.645633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 50 secs) (at 2016-07-12 03:07:19.646121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:20 INFO - MultiFileLogger online at 20160712 03:07:20 in /builds/slave/test 03:07:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:20 INFO - {'append_to_log': False, 03:07:20 INFO - 'base_work_dir': '/builds/slave/test', 03:07:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:20 INFO - 'branch': 'Firefox-Non-PGO', 03:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:20 INFO - 'config_files': ('talos/linux_config.py',), 03:07:20 INFO - 'default_actions': ('clobber', 03:07:20 INFO - 'read-buildbot-config', 03:07:20 INFO - 'download-and-extract', 03:07:20 INFO - 'populate-webroot', 03:07:20 INFO - 'create-virtualenv', 03:07:20 INFO - 'install', 03:07:20 INFO - 'run-tests'), 03:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:20 INFO - 'download_minidump_stackwalk': True, 03:07:20 INFO - 'download_symbols': 'ondemand', 03:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:20 INFO - 'installer_path': 'installer.exe', 03:07:20 INFO - 'log_level': 'info', 03:07:20 INFO - 'log_name': 'talos', 03:07:20 INFO - 'log_to_console': True, 03:07:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:07:20 INFO - 'opt_config_files': (), 03:07:20 INFO - 'pip_index': False, 03:07:20 INFO - 'sps_profile': False, 03:07:20 INFO - 'sps_profile_interval': 0, 03:07:20 INFO - 'suite': 'dromaeojs', 03:07:20 INFO - 'system_bits': '32', 03:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:20 INFO - 'title': 'talos-linux64-ix-034', 03:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:20 INFO - 'use_talos_json': True, 03:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:20 INFO - 'work_dir': 'build'} 03:07:20 INFO - ##### 03:07:20 INFO - ##### Running clobber step. 03:07:20 INFO - ##### 03:07:20 INFO - Running pre-action listener: _resource_record_pre_action 03:07:20 INFO - Running main action method: clobber 03:07:20 INFO - rmtree: /builds/slave/test/build 03:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:21 INFO - Running post-action listener: _resource_record_post_action 03:07:21 INFO - ##### 03:07:21 INFO - ##### Finished clobber step (success) 03:07:21 INFO - ##### 03:07:21 INFO - ##### 03:07:21 INFO - ##### Running read-buildbot-config step. 03:07:21 INFO - ##### 03:07:21 INFO - Running pre-action listener: _resource_record_pre_action 03:07:21 INFO - Running main action method: read_buildbot_config 03:07:21 INFO - Using buildbot properties: 03:07:21 INFO - { 03:07:21 INFO - "project": "", 03:07:21 INFO - "product": "firefox", 03:07:21 INFO - "script_repo_revision": "production", 03:07:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:07:21 INFO - "repository": "", 03:07:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:07:21 INFO - "buildid": "20160712015726", 03:07:21 INFO - "pgo_build": "False", 03:07:21 INFO - "basedir": "/builds/slave/test", 03:07:21 INFO - "buildnumber": 552, 03:07:21 INFO - "slavename": "talos-linux64-ix-034", 03:07:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:07:21 INFO - "platform": "ubuntu64_hw", 03:07:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:07:21 INFO - "branch": "mozilla-central", 03:07:21 INFO - "repo_path": "mozilla-central", 03:07:21 INFO - "revision": "278b332af0cdbe52578a2ea6498380f3e806e2be", 03:07:21 INFO - "stage_platform": "linux64", 03:07:21 INFO - "builduid": "8e90f4f3119149eb9f2ca735872df949", 03:07:21 INFO - "slavebuilddir": "test" 03:07:21 INFO - } 03:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:07:21 INFO - Running post-action listener: _resource_record_post_action 03:07:21 INFO - ##### 03:07:21 INFO - ##### Finished read-buildbot-config step (success) 03:07:21 INFO - ##### 03:07:21 INFO - ##### 03:07:21 INFO - ##### Running download-and-extract step. 03:07:21 INFO - ##### 03:07:21 INFO - Running pre-action listener: _resource_record_pre_action 03:07:21 INFO - Running main action method: download_and_extract 03:07:21 INFO - mkdir: /builds/slave/test/build/tests 03:07:21 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')]} 03:07:21 INFO - https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:30 INFO - Downloaded 1361 bytes. 03:07:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:07:30 INFO - Using the following test package requirements: 03:07:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:07:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:07:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'jsshell-linux-x86_64.zip'], 03:07:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:07:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:07:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:07:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:07:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:07:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:30 INFO - https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:35 INFO - Downloaded 22700289 bytes. 03:07:35 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'] 03:07:35 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 03:07:36 INFO - Return code: 0 03:07:36 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 03:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:36 INFO - https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:43 INFO - Downloaded 22700289 bytes. 03:07:43 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'] 03:07:43 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 03:07:45 INFO - Return code: 0 03:07:45 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')]} 03:07:45 INFO - https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:46 INFO - Downloaded 14403333 bytes. 03:07:46 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'] 03:07:46 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 03:07:46 INFO - Return code: 0 03:07:46 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')]} 03:07:46 INFO - https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FbdZaKBLToCwp8pPleEENg/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 03:07:48 INFO - Downloaded 56651529 bytes. 03:07:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:07:48 INFO - mkdir: /builds/slave/test/properties 03:07:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:48 INFO - Contents: 03:07:48 INFO - build_url:https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:07:48 INFO - Running post-action listener: _resource_record_post_action 03:07:48 INFO - Running post-action listener: set_extra_try_arguments 03:07:48 INFO - ##### 03:07:48 INFO - ##### Finished download-and-extract step (success) 03:07:48 INFO - ##### 03:07:48 INFO - ##### 03:07:48 INFO - ##### Running populate-webroot step. 03:07:48 INFO - ##### 03:07:48 INFO - Running pre-action listener: _resource_record_pre_action 03:07:48 INFO - Running main action method: populate_webroot 03:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:48 INFO - '--tppagecycles', 03:07:48 INFO - '7'], 03:07:48 INFO - 'tests': ['tsvgm']}}, 03:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['damp', 'tps']}, 03:07:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'tests': ['damp', 'tps']}, 03:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['dromaeo_dom']}, 03:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['basic_compositor_video']}, 03:07:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['a11yr', 03:07:48 INFO - 'ts_paint', 03:07:48 INFO - 'tpaint', 03:07:48 INFO - 'sessionrestore', 03:07:48 INFO - 'sessionrestore_no_auto_restore', 03:07:48 INFO - 'tabpaint']}, 03:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['tsvgx', 03:07:48 INFO - 'tsvgr_opacity', 03:07:48 INFO - 'tart', 03:07:48 INFO - 'tscrollx', 03:07:48 INFO - 'cart']}, 03:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:48 INFO - 'tsvgr_opacity', 03:07:48 INFO - 'tart', 03:07:48 INFO - 'tscrollx', 03:07:48 INFO - 'cart']}, 03:07:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'talos_options': ['--disable-e10s'], 03:07:48 INFO - 'tests': ['tp5o']}, 03:07:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'tests': ['tp5o']}, 03:07:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'talos_options': ['--disable-e10s', 03:07:48 INFO - '--xperf_path', 03:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:48 INFO - 'tests': ['tp5n']}, 03:07:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:48 INFO - 'talos_options': ['--xperf_path', 03:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:48 INFO - 'tests': ['tp5n']}}, 03:07:48 INFO - 'talos.zip': {'path': '', 03:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:48 INFO - Running post-action listener: _resource_record_post_action 03:07:48 INFO - ##### 03:07:48 INFO - ##### Finished populate-webroot step (success) 03:07:48 INFO - ##### 03:07:48 INFO - ##### 03:07:48 INFO - ##### Running create-virtualenv step. 03:07:48 INFO - ##### 03:07:48 INFO - Running pre-action listener: _resource_record_pre_action 03:07:48 INFO - Running main action method: create_virtualenv 03:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:48 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 03:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:49 INFO - Using real prefix '/usr' 03:07:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:51 INFO - Installing pip.................done. 03:07:51 INFO - Return code: 0 03:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:07: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', 'pip>=1.5'] in /builds/slave/test/build 03:07: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 pip>=1.5 03:07:51 INFO - Using env: {'DISPLAY': ':0', 03:07:51 INFO - 'HOME': '/home/cltbld', 03:07:51 INFO - 'LANG': 'en_US.UTF-8', 03:07:51 INFO - 'LANGUAGE': 'en_US:en', 03:07:51 INFO - 'LOGNAME': 'cltbld', 03:07:51 INFO - 'MAIL': '/var/mail/cltbld', 03:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:51 INFO - 'MOZ_NO_REMOTE': '1', 03:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:51 INFO - 'NO_EM_RESTART': '1', 03:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:51 INFO - 'PWD': '/builds/slave/test', 03:07:51 INFO - 'SHELL': '/bin/bash', 03:07:51 INFO - 'SHLVL': '1', 03:07:51 INFO - 'TERM': 'linux', 03:07:51 INFO - 'TMOUT': '86400', 03:07:51 INFO - 'USER': 'cltbld', 03:07:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:51 INFO - '_': '/tools/buildbot/bin/python'} 03:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:51 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 03:07:51 INFO - Cleaning up... 03:07:51 INFO - Return code: 0 03:07:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', '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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:07: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 psutil>=3.1.1 03:07:51 INFO - Using env: {'DISPLAY': ':0', 03:07:51 INFO - 'HOME': '/home/cltbld', 03:07:51 INFO - 'LANG': 'en_US.UTF-8', 03:07:51 INFO - 'LANGUAGE': 'en_US:en', 03:07:51 INFO - 'LOGNAME': 'cltbld', 03:07:51 INFO - 'MAIL': '/var/mail/cltbld', 03:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:51 INFO - 'MOZ_NO_REMOTE': '1', 03:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:51 INFO - 'NO_EM_RESTART': '1', 03:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:51 INFO - 'PWD': '/builds/slave/test', 03:07:51 INFO - 'SHELL': '/bin/bash', 03:07:51 INFO - 'SHLVL': '1', 03:07:51 INFO - 'TERM': 'linux', 03:07:51 INFO - 'TMOUT': '86400', 03:07:51 INFO - 'USER': 'cltbld', 03:07:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:51 INFO - '_': '/tools/buildbot/bin/python'} 03:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:51 INFO - Downloading/unpacking psutil>=3.1.1 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:53 INFO - Installing collected packages: psutil 03:07:53 INFO - Running setup.py install for psutil 03:07:54 INFO - building 'psutil._psutil_linux' extension 03:07:54 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 03:07:54 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 03:07:54 INFO - building 'psutil._psutil_posix' extension 03:07:54 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 03:07:54 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 03:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:54 INFO - Successfully installed psutil 03:07:54 INFO - Cleaning up... 03:07:54 INFO - Return code: 0 03:07:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:54 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')]} 03:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:54 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')]} 03:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:54 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:07:54 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 03:07:54 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 03:07:54 INFO - Using env: {'DISPLAY': ':0', 03:07:54 INFO - 'HOME': '/home/cltbld', 03:07:54 INFO - 'LANG': 'en_US.UTF-8', 03:07:54 INFO - 'LANGUAGE': 'en_US:en', 03:07:54 INFO - 'LOGNAME': 'cltbld', 03:07:54 INFO - 'MAIL': '/var/mail/cltbld', 03:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:54 INFO - 'MOZ_NO_REMOTE': '1', 03:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:54 INFO - 'NO_EM_RESTART': '1', 03:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:54 INFO - 'PWD': '/builds/slave/test', 03:07:54 INFO - 'SHELL': '/bin/bash', 03:07:54 INFO - 'SHLVL': '1', 03:07:54 INFO - 'TERM': 'linux', 03:07:54 INFO - 'TMOUT': '86400', 03:07:54 INFO - 'USER': 'cltbld', 03:07:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:54 INFO - '_': '/tools/buildbot/bin/python'} 03:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:54 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 03:07:54 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 03:07:54 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 03:07:54 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 03:07:54 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 03:07:54 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 03:07:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:56 INFO - Installing collected packages: mozsystemmonitor 03:07:56 INFO - Running setup.py install for mozsystemmonitor 03:07:56 INFO - Successfully installed mozsystemmonitor 03:07:56 INFO - Cleaning up... 03:07:56 INFO - Return code: 0 03:07:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:56 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')]} 03:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:56 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')]} 03:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:56 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:07:56 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 03:07:56 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 03:07:56 INFO - Using env: {'DISPLAY': ':0', 03:07:56 INFO - 'HOME': '/home/cltbld', 03:07:56 INFO - 'LANG': 'en_US.UTF-8', 03:07:56 INFO - 'LANGUAGE': 'en_US:en', 03:07:56 INFO - 'LOGNAME': 'cltbld', 03:07:56 INFO - 'MAIL': '/var/mail/cltbld', 03:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:56 INFO - 'MOZ_NO_REMOTE': '1', 03:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:56 INFO - 'NO_EM_RESTART': '1', 03:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:56 INFO - 'PWD': '/builds/slave/test', 03:07:56 INFO - 'SHELL': '/bin/bash', 03:07:56 INFO - 'SHLVL': '1', 03:07:56 INFO - 'TERM': 'linux', 03:07:56 INFO - 'TMOUT': '86400', 03:07:56 INFO - 'USER': 'cltbld', 03:07:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:56 INFO - '_': '/tools/buildbot/bin/python'} 03:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:57 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 03:07:57 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 03:07:57 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 03:07:57 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 03:07:57 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 03:07:57 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 03:07:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:58 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 03:07:58 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 03:07:58 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 03:07:58 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 03:07:58 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 03:07:58 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 03:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:59 INFO - warning: no files found matching '*.txt' 03:07:59 INFO - no previously-included directories found matching 'build' 03:07:59 INFO - no previously-included directories found matching 'dist' 03:07:59 INFO - no previously-included directories found matching '.git*' 03:07:59 INFO - Installing collected packages: jsonschema, functools32 03:07:59 INFO - Running setup.py install for functools32 03:07:59 INFO - warning: no files found matching '*.txt' 03:07:59 INFO - no previously-included directories found matching 'build' 03:07:59 INFO - no previously-included directories found matching 'dist' 03:07:59 INFO - no previously-included directories found matching '.git*' 03:07:59 INFO - Successfully installed jsonschema functools32 03:07:59 INFO - Cleaning up... 03:07:59 INFO - Return code: 0 03:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:59 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:07:59 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 03:07:59 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 03:07:59 INFO - Using env: {'DISPLAY': ':0', 03:07:59 INFO - 'HOME': '/home/cltbld', 03:07:59 INFO - 'LANG': 'en_US.UTF-8', 03:07:59 INFO - 'LANGUAGE': 'en_US:en', 03:07:59 INFO - 'LOGNAME': 'cltbld', 03:07:59 INFO - 'MAIL': '/var/mail/cltbld', 03:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:59 INFO - 'MOZ_NO_REMOTE': '1', 03:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:59 INFO - 'NO_EM_RESTART': '1', 03:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:59 INFO - 'PWD': '/builds/slave/test', 03:07:59 INFO - 'SHELL': '/bin/bash', 03:07:59 INFO - 'SHLVL': '1', 03:07:59 INFO - 'TERM': 'linux', 03:07:59 INFO - 'TMOUT': '86400', 03:07:59 INFO - 'USER': 'cltbld', 03:07:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:59 INFO - '_': '/tools/buildbot/bin/python'} 03:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:08:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:02 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 03:08:02 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 03:08:02 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 03:08:02 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 03:08:02 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 03:08:02 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 03:08:02 INFO - Downloading docopt-0.6.1.tar.gz 03:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:02 INFO - Running setup.py install for blobuploader 03:08:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:08:02 INFO - Running setup.py install for requests 03:08:02 INFO - Running setup.py install for docopt 03:08:02 INFO - Successfully installed blobuploader requests docopt 03:08:02 INFO - Cleaning up... 03:08:02 INFO - Return code: 0 03:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:02 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:08:02 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 03:08:02 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 03:08:02 INFO - Using env: {'DISPLAY': ':0', 03:08:02 INFO - 'HOME': '/home/cltbld', 03:08:02 INFO - 'LANG': 'en_US.UTF-8', 03:08:02 INFO - 'LANGUAGE': 'en_US:en', 03:08:02 INFO - 'LOGNAME': 'cltbld', 03:08:02 INFO - 'MAIL': '/var/mail/cltbld', 03:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:02 INFO - 'MOZ_NO_REMOTE': '1', 03:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:02 INFO - 'NO_EM_RESTART': '1', 03:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:02 INFO - 'PWD': '/builds/slave/test', 03:08:02 INFO - 'SHELL': '/bin/bash', 03:08:02 INFO - 'SHLVL': '1', 03:08:02 INFO - 'TERM': 'linux', 03:08:02 INFO - 'TMOUT': '86400', 03:08:02 INFO - 'USER': 'cltbld', 03:08:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:02 INFO - '_': '/tools/buildbot/bin/python'} 03:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:03 INFO - Running setup.py (path:/tmp/pip-FgVK9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:03 INFO - Running setup.py (path:/tmp/pip-tuv56T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:03 INFO - Running setup.py (path:/tmp/pip-Fj17oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:03 INFO - Running setup.py (path:/tmp/pip-tdBaCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:03 INFO - Running setup.py (path:/tmp/pip-dz_dOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:03 INFO - Running setup.py (path:/tmp/pip-9yqmbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:03 INFO - Running setup.py (path:/tmp/pip-oOIrkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:03 INFO - Running setup.py (path:/tmp/pip-dFDSAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:03 INFO - Running setup.py (path:/tmp/pip-DxIt8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:03 INFO - Running setup.py (path:/tmp/pip-2SpaXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:03 INFO - Running setup.py (path:/tmp/pip-BwftF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:03 INFO - Running setup.py (path:/tmp/pip-hTcwOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:03 INFO - Running setup.py (path:/tmp/pip-kcsDet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:04 INFO - Running setup.py (path:/tmp/pip-ymw80D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:04 INFO - Running setup.py (path:/tmp/pip-35GAg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:04 INFO - Running setup.py (path:/tmp/pip-FwYXKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:04 INFO - Running setup.py (path:/tmp/pip-bVm5xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:04 INFO - Running setup.py install for manifestparser 03:08:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:08:04 INFO - Running setup.py install for mozcrash 03:08:04 INFO - Running setup.py install for mozdebug 03:08:04 INFO - Running setup.py install for mozdevice 03:08:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:08:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:08:04 INFO - Running setup.py install for mozfile 03:08:04 INFO - Running setup.py install for mozhttpd 03:08:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:08:04 INFO - Running setup.py install for mozinfo 03:08:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for mozInstall 03:08:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for mozleak 03:08:05 INFO - Running setup.py install for mozlog 03:08:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for moznetwork 03:08:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for mozprocess 03:08:05 INFO - Running setup.py install for mozprofile 03:08:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for mozrunner 03:08:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:08:05 INFO - Running setup.py install for mozscreenshot 03:08:05 INFO - Running setup.py install for moztest 03:08:06 INFO - Running setup.py install for mozversion 03:08:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:08:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:06 INFO - Cleaning up... 03:08:06 INFO - Return code: 0 03:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:06 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')]} 03:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:06 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')]} 03:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:06 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:08:06 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 03:08:06 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 03:08:06 INFO - Using env: {'DISPLAY': ':0', 03:08:06 INFO - 'HOME': '/home/cltbld', 03:08:06 INFO - 'LANG': 'en_US.UTF-8', 03:08:06 INFO - 'LANGUAGE': 'en_US:en', 03:08:06 INFO - 'LOGNAME': 'cltbld', 03:08:06 INFO - 'MAIL': '/var/mail/cltbld', 03:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:06 INFO - 'MOZ_NO_REMOTE': '1', 03:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:06 INFO - 'NO_EM_RESTART': '1', 03:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:06 INFO - 'PWD': '/builds/slave/test', 03:08:06 INFO - 'SHELL': '/bin/bash', 03:08:06 INFO - 'SHLVL': '1', 03:08:06 INFO - 'TERM': 'linux', 03:08:06 INFO - 'TMOUT': '86400', 03:08:06 INFO - 'USER': 'cltbld', 03:08:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:06 INFO - '_': '/tools/buildbot/bin/python'} 03:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:06 INFO - Running setup.py (path:/tmp/pip-b8eVK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:06 INFO - Running setup.py (path:/tmp/pip-27OY61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:06 INFO - Running setup.py (path:/tmp/pip-Xlq4BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:06 INFO - Running setup.py (path:/tmp/pip-UGAAJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:06 INFO - Running setup.py (path:/tmp/pip-zfo5DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:06 INFO - Running setup.py (path:/tmp/pip-F4abHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:06 INFO - Running setup.py (path:/tmp/pip-Ba76mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:06 INFO - Running setup.py (path:/tmp/pip-mhTkAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:06 INFO - Running setup.py (path:/tmp/pip-SUrfZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:06 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)) 03:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:07 INFO - Running setup.py (path:/tmp/pip-Z8MUYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:07 INFO - Running setup.py (path:/tmp/pip-uaoV3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:07 INFO - Running setup.py (path:/tmp/pip-kcKfXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:07 INFO - Running setup.py (path:/tmp/pip-3ExIqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:07 INFO - Running setup.py (path:/tmp/pip-ndTS5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:07 INFO - Running setup.py (path:/tmp/pip-Zs1gfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:07 INFO - Running setup.py (path:/tmp/pip-niIDKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:07 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)) 03:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:07 INFO - Running setup.py (path:/tmp/pip-fE4MkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:07 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)) 03:08:07 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)) 03:08:07 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)) 03:08:07 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)) 03:08:07 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)) 03:08:07 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)) 03:08:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:09 INFO - Downloading blessings-1.6.tar.gz 03:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:09 INFO - Installing collected packages: blessings 03:08:09 INFO - Running setup.py install for blessings 03:08:09 INFO - Successfully installed blessings 03:08:09 INFO - Cleaning up... 03:08:09 INFO - Return code: 0 03:08:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:09 INFO - Reading from file tmpfile_stdout 03:08:09 INFO - Current package versions: 03:08:09 INFO - argparse == 1.2.1 03:08:09 INFO - blessings == 1.6 03:08:09 INFO - blobuploader == 1.2.4 03:08:09 INFO - docopt == 0.6.1 03:08:09 INFO - functools32 == 3.2.3-2 03:08:09 INFO - jsonschema == 2.5.1 03:08:09 INFO - manifestparser == 1.1 03:08:09 INFO - mozInstall == 1.12 03:08:09 INFO - mozcrash == 0.17 03:08:09 INFO - mozdebug == 0.1 03:08:09 INFO - mozdevice == 0.48 03:08:09 INFO - mozfile == 1.2 03:08:09 INFO - mozhttpd == 0.7 03:08:09 INFO - mozinfo == 0.9 03:08:09 INFO - mozleak == 0.1 03:08:09 INFO - mozlog == 3.2 03:08:09 INFO - moznetwork == 0.27 03:08:09 INFO - mozprocess == 0.23 03:08:09 INFO - mozprofile == 0.28 03:08:09 INFO - mozrunner == 6.12 03:08:09 INFO - mozscreenshot == 0.1 03:08:09 INFO - mozsystemmonitor == 0.3 03:08:09 INFO - moztest == 0.7 03:08:09 INFO - mozversion == 1.4 03:08:09 INFO - psutil == 3.1.1 03:08:09 INFO - requests == 1.2.3 03:08:09 INFO - wsgiref == 0.1.2 03:08:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:09 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:08:09 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 03:08:09 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 03:08:09 INFO - Using env: {'DISPLAY': ':0', 03:08:09 INFO - 'HOME': '/home/cltbld', 03:08:09 INFO - 'LANG': 'en_US.UTF-8', 03:08:09 INFO - 'LANGUAGE': 'en_US:en', 03:08:09 INFO - 'LOGNAME': 'cltbld', 03:08:09 INFO - 'MAIL': '/var/mail/cltbld', 03:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:09 INFO - 'MOZ_NO_REMOTE': '1', 03:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:09 INFO - 'NO_EM_RESTART': '1', 03:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:09 INFO - 'PWD': '/builds/slave/test', 03:08:09 INFO - 'SHELL': '/bin/bash', 03:08:09 INFO - 'SHLVL': '1', 03:08:09 INFO - 'TERM': 'linux', 03:08:09 INFO - 'TMOUT': '86400', 03:08:09 INFO - 'USER': 'cltbld', 03:08:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:09 INFO - '_': '/tools/buildbot/bin/python'} 03:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 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)) 03:08:10 INFO - Cleaning up... 03:08:10 INFO - Return code: 0 03:08:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:10 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')]} 03:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:10 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')]} 03:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:10 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', '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 03:08:10 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 03:08:10 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 03:08:10 INFO - Using env: {'DISPLAY': ':0', 03:08:10 INFO - 'HOME': '/home/cltbld', 03:08:10 INFO - 'LANG': 'en_US.UTF-8', 03:08:10 INFO - 'LANGUAGE': 'en_US:en', 03:08:10 INFO - 'LOGNAME': 'cltbld', 03:08:10 INFO - 'MAIL': '/var/mail/cltbld', 03:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:10 INFO - 'MOZ_NO_REMOTE': '1', 03:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:10 INFO - 'NO_EM_RESTART': '1', 03:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:10 INFO - 'PWD': '/builds/slave/test', 03:08:10 INFO - 'SHELL': '/bin/bash', 03:08:10 INFO - 'SHLVL': '1', 03:08:10 INFO - 'TERM': 'linux', 03:08:10 INFO - 'TMOUT': '86400', 03:08:10 INFO - 'USER': 'cltbld', 03:08:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:10 INFO - '_': '/tools/buildbot/bin/python'} 03:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:08:10 INFO - Cleaning up... 03:08:10 INFO - Return code: 0 03:08:10 INFO - Running post-action listener: _resource_record_post_action 03:08:10 INFO - Running post-action listener: _start_resource_monitoring 03:08:10 INFO - Starting resource monitoring. 03:08:10 INFO - ##### 03:08:10 INFO - ##### Finished create-virtualenv step (success) 03:08:10 INFO - ##### 03:08:10 INFO - ##### 03:08:10 INFO - ##### Running install step. 03:08:10 INFO - ##### 03:08:10 INFO - Running pre-action listener: _resource_record_pre_action 03:08:10 INFO - Running main action method: install 03:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:10 INFO - Reading from file tmpfile_stdout 03:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:10 INFO - Reading from file tmpfile_stdout 03:08:10 INFO - Output received: 03:08:10 INFO - Usage: mozinstall [options] installer 03:08:10 INFO - Options: 03:08:10 INFO - -h, --help show this help message and exit 03:08:10 INFO - -d DEST, --destination=DEST 03:08:10 INFO - Directory to install application into. [default: 03:08:10 INFO - "/builds/slave/test"] 03:08:10 INFO - --app=APP Application being installed. [default: firefox] 03:08:10 INFO - mkdir: /builds/slave/test/build/application 03:08:10 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'] 03:08:10 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 03:08:27 INFO - Reading from file tmpfile_stdout 03:08:27 INFO - Output received: 03:08:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:08:27 INFO - Running post-action listener: _resource_record_post_action 03:08:27 INFO - ##### 03:08:27 INFO - ##### Finished install step (success) 03:08:27 INFO - ##### 03:08:27 INFO - ##### 03:08:27 INFO - ##### Running run-tests step. 03:08:27 INFO - ##### 03:08:27 INFO - Running pre-action listener: _resource_record_pre_action 03:08:27 INFO - Running main action method: run_tests 03:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:27 INFO - Python 2.7.3 03:08:27 INFO - Return code: 0 03:08:27 INFO - grabbing minidump binary from tooltool 03:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:27 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 0x12db3b0>, '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 0x12dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:27 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 03:08:27 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 03:08:27 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 03:08:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:27 INFO - Return code: 0 03:08:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:08:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:08:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:08:27 INFO - Using env: {'DISPLAY': ':0', 03:08:27 INFO - 'HOME': '/home/cltbld', 03:08:27 INFO - 'LANG': 'en_US.UTF-8', 03:08:27 INFO - 'LANGUAGE': 'en_US:en', 03:08:27 INFO - 'LOGNAME': 'cltbld', 03:08:27 INFO - 'MAIL': '/var/mail/cltbld', 03:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:27 INFO - 'MOZ_NO_REMOTE': '1', 03:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:27 INFO - 'NO_EM_RESTART': '1', 03:08:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:27 INFO - 'PWD': '/builds/slave/test', 03:08:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:27 INFO - 'SHELL': '/bin/bash', 03:08:27 INFO - 'SHLVL': '1', 03:08:27 INFO - 'TERM': 'linux', 03:08:27 INFO - 'TMOUT': '86400', 03:08:27 INFO - 'USER': 'cltbld', 03:08:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650', 03:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:27 INFO - '_': '/tools/buildbot/bin/python'} 03:08:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:08:27 INFO - mozversion application_buildid: 20160712015726 03:08:27 INFO - mozversion application_changeset: 278b332af0cdbe52578a2ea6498380f3e806e2be 03:08:27 INFO - mozversion application_display_name: Nightly 03:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:27 INFO - mozversion application_name: Firefox 03:08:27 INFO - mozversion application_remotingname: firefox 03:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:08:27 INFO - mozversion application_vendor: Mozilla 03:08:27 INFO - mozversion application_version: 50.0a1 03:08:27 INFO - mozversion platform_buildid: 20160712015726 03:08:27 INFO - mozversion platform_changeset: 278b332af0cdbe52578a2ea6498380f3e806e2be 03:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:08:27 INFO - mozversion platform_version: 50.0a1 03:08:27 INFO - using testdate: 1468318107 03:08:27 INFO - actual date: 1468318107 03:08:27 INFO - starting webserver on 'localhost:55045' 03:08:27 INFO - SUITE-START | Running 2 tests 03:08:27 INFO - TEST-START | dromaeo_css 03:08:27 INFO - operating with platform_type : linux_ 03:08:27 INFO - Initialising browser for dromaeo_css test... 03:08:27 INFO - TEST-INFO | started process 14389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRwWzz/profile http://localhost:55045/getInfo.html) 03:08:31 INFO - PROCESS | 14389 | __metrics Screen width/height:1600/1200 03:08:31 INFO - PROCESS | 14389 | colorDepth:24 03:08:31 INFO - PROCESS | 14389 | Browser inner width/height: 1024/697 03:08:31 INFO - PROCESS | 14389 | __metrics 03:08:32 INFO - PROCESS | 14389 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:08:32 INFO - PROCESS | 14389 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:33 INFO - TEST-INFO | 14389: exit 0 03:08:33 INFO - Browser initialized. 03:08:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:33 INFO - TEST-INFO | started process 14474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRwWzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:45 INFO - PROCESS | 14474 | RSS: Main: 159330304 03:08:45 INFO - PROCESS | 14474 | 03:09:37 INFO - PROCESS | 14474 | 1468318177313 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] 03:11:49 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55045/tests/dromaeo/cssquery-ext.html) 03:11:50 INFO - PROCESS | 14474 | RSS: Main: 249671680 03:11:50 INFO - PROCESS | 14474 | 03:14:52 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-ext.html (next: http://localhost:55045/tests/dromaeo/cssquery-jquery.html) 03:14:53 INFO - PROCESS | 14474 | RSS: Main: 248832000 03:14:53 INFO - PROCESS | 14474 | 03:17:55 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55045/tests/dromaeo/cssquery-mootools.html) 03:17:56 INFO - PROCESS | 14474 | RSS: Main: 246059008 03:17:56 INFO - PROCESS | 14474 | 03:20:58 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55045/tests/dromaeo/cssquery-prototype.html) 03:20:59 INFO - PROCESS | 14474 | RSS: Main: 245374976 03:20:59 INFO - PROCESS | 14474 | 03:24:02 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55045/tests/dromaeo/cssquery-yui.html) 03:24:02 INFO - PROCESS | 14474 | RSS: Main: 223404032 03:24:02 INFO - PROCESS | 14474 | 03:27:05 INFO - PROCESS | 14474 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-yui.html (next: http://localhost:55045/tests/dromaeo/cssquery-dojo.html) 03:27:05 INFO - PROCESS | 14474 | RSS: Main: 284848128 03:27:05 INFO - PROCESS | 14474 | 03:27:05 INFO - PROCESS | 14474 | __start_tp_report 03:27:05 INFO - PROCESS | 14474 | _x_x_mozilla_page_load 03:27:05 INFO - PROCESS | 14474 | _x_x_mozilla_page_load_details 03:27:05 INFO - PROCESS | 14474 | |i|pagename|runs| 03:27:05 INFO - PROCESS | 14474 | |0;dojo.html;2582.444774373512;2610.6345111684363;2630.565956617157;2631.815772895898;2642.3922497825492;4630.189716799563;4676.181668208059;4711.269753188257;4740.454847692512;4743.928841067383;4714.622830173586;4734.147853386397;4781.235002399617;4786.928196077061;4817.747385679722;4320.049589090395;4360.760158191299;4402.427684401031;4403.141387429452;4436.622887054604;4371.73769573825;4389.626881715058;4428.867133985986;4458.2866741321395;4484.798184081724;4307.1601037797645;4359.171757366122;4362.432883725127;4376.89057773555;4407.691461597689;4232.343986682069;4281.828726850953;4290.570942905716;4311.698181127323;4330.696851220416;4250.213710463574;4323.351497275403;4329.826806927719;4351.782410879475;4363.3454981752675;4655.790489427984;4661.370714953506;4700.247960326331;4720.150372932871;4729.361536192639;4953.380827396575;4997.725125118117;5094.439611642716;5119.078565858144;5144.485551444825;5145;5191.961607678441;5197.324347834758;5204.3234379530795;5221.242919776611;4635.119327327797;4846.248831431134;4867.172580661225;4870.025994801054;4875.829345972874;5066.08810414129;5185.325907631984;5190.896182076337;5246.950609878039;5254.97372513135;5048.5203905628905;5049.949500505021;5051.3433253676785;5051.949480505222;5053.570446512088;5084.491550844886;5094.363204599425;5134.101532231844;5136.306598609214;5140.434552199255;4810.470848206694;4931.457539670633;5019.0463811875625;5025.045241404122;5082.720450375265;5024.62315326352;5032.3961124665275;5034.446210916796;5035.672681275705;5074.391073071181;4323.935140972888;4325.805338759764;4337.587929146726;4368.584984426474;4372.213001659668;3684.1158122050515;3697.371446854041;3707.295613833363;3713.6472035156617;3769.566499852497;4313.223619748413;4318.52496225415;4318.848840290638;4360.585744354281;4363;5114.948850511447;5154.123798954187;5155.793768249303;5164.690118592896;5167.4832516748775;4151.190517849051;4229.640480559187;4363.978180109143;4366.061296821199;4415.094905544356;4548.704334218265;4569.840055598038;4570.520095389937;4614.976925115353;4617.699849509771;4688.132695451352;4709.905801883875;4711.528847115261;4718.787654555554;4762.190427627381;4942.456329803646;4970.204767237225;4994.750262486788;5016.147254966591;5032.0690672225755;4663.1839428099265;4664.533546645444;4680.344751734828;4712.151812673752;4724.314974328772;4922.556969872729;4925.556699897026;4926.064047830901;4930.408350997904;4968.22992436173;4859.416869975626;4989.825356112518;4996.7001979881325;4997.450280469218;5034.798608055637;4913.950860491349;4919;4920.237363208708;4930.630202734881;4966.503349665005;4932.975335123445;4934.481879402611;4936.111499929903;4936.802527898843;4970.850874473772;4713.646476514206;4821.855344339676;4896.143174944442;4907.190313598217;4910.92633610489;5010.5240002199735;5011.874703132305;5035.295058691713;5039.3448851649055;5085.694858308513;4901.068796928572;4904.632152588499;4914.164592019294;4918.065567542156;4968.8757781055765 03:27:05 INFO - PROCESS | 14474 | |1;ext.html;567.6764244380703;570.1988705868257;576.2710171632888;580.9796657116999;582.8921649494844;29365.559516607267;39551.40672889909;41114.97212569683;41151.58848411515;44963.77518112413;41134.58865411345;41365.58634413655;41534.37698434526;41545.792271038605;41748;7802.96098519508;7948.801279967989;7956.880646790303;7967.641456134488;7968.203179682044;7805.5706936118495;7853.685852565919;7854.175311592287;7856.1751016143335;7873.842523149534;7888;7941;7952.522848629072;7952.840943181133;7956.801079973018;7877.133515313311;7915.722949696733;7923.524588524707;7924.445288829785;7933.523988560676;7745.186755390716;7749.883751743729;7810.1408845027;7811.1017233018365;7821.530708157528;39498.40752388717;39817.60182398197;39983;40007.19985600272;40109.79945100256;3024.228821650465;3073.1702440340982;3094.2419107318624;3208.4064448076947;3232.6444091149956;29189.56215656767;29304.41391172186;29535.85232073826;30227.848860755556;30233.697663023308;3490.3891818931584;3545.131442796506;3580.230250496156;3591.28174365128;3595.2449985503076;273499;275328;276558;276609.61695191596;277140;31899.36201276008;54756.452435475134;54818.451815482134;54957.72521137369;54974.45025549693;32463.350732985207;34443;34511;34515.82742086273;34522.30955380928;13374.866251337557;13451.394687239097;13601.727965440834;13613.387397566936;13640.727185456235;11133.944330278458;11244.775104497865;11249.493772780244;11258.099352051817;11266.43667816606;7967.28294453502;7979.9202007979175;7981.521108733495;8038.356931445471;8043.075046369625;3114.159177022191;3117.142785733896;3124.500079987191;3135.623725152996;3182.172635114887;846.4582667093065;896.9908852540891;928.3826255540125;946.4037656276502;981.651513712636;24879.751202488107;25062.74937250604;25124.874375628006;25294.873525632254;25461.490770184864;978.4031740638205;985.2364417576435;986.8371718666483;991.0485933503772;1008.7326858382535;14014.439422423193;14025;14189.716205675828;14389.712205755826;14445.566633001026;397916;398889;401694;402196;402412;50107.24839127416;50738.74630626823;50792.49207507951;50794.23808642873;50848.745756271725;1066.088494337346;1170.8770579089244;1182.0543565147848;1199.0587388899671;1202.116444413338;28031.159065228076;29123.271918202216;29413;29924.70075299219;30001.399972000003;41452.79273603613;41991;42060;42136;42142.57857421387;307286;309247;309617;310157;311717;21636.38901629205;21669.566608668054;24955.50266983987;25300;25389;41294.793526033376;41330.380044298756;41723.37414938718;42417.36373954455;42732.22240554354;36515;36782.44826327661;37091;37092.62907371;37476.62523374731;34936.30127397387;36258.63741362658;36407.271854562234;36686.816565917;36969.44545831761;34986.82506587451;35755.46366804448;35813.10467238236;36149.457758133125;36160.4575931356;32005.839970799996;33214;33228.1692957678;33236.1690957728;33339.83330083334;24472.388190295384;24927.501449971263;24997.625035624118;25106;25366.619500707136 03:27:05 INFO - PROCESS | 14474 | |2;jquery.html;364.0934074155354;366.73595011591647;374.6422166830677;378.84656714030825;388.06863527533915;16502.669946601076;17479.737803932952;18262.817371826277;18262.908685456587;18263.543411414703;16253.106079165642;17087.572810679707;17106.230219640114;17182.914085429555;17771.91114044428;4691.390119284488;4828.275758636198;4861.416630004404;4863.902721945559;4866.51334866514;3505.772124811892;3663;4618.214903466419;5296.417394086648;5532.28080349554;5570.916436253459;5594.608377413582;5603.439656034405;5612.07400778871;5612.438756124376;5501.019632932162;6158.8768224635705;6253.062040693887;6292.685365731695;6314.684265786692;3419.7264218862433;4998.700077995332;5224.764885580158;5233.555147812441;5559.471850174227;12743.93628031854;12754.936225318907;12852.357382130856;15365.692686146327;21336.466588335417;1833.4133077415233;1872.953176170593;1927.0058514330997;1966.5083729067733;2449.4243852694603;9274.21169200612;9439.24486041115;9501.097395747393;9913.65302214419;9922.05740454663;1742.8082910879793;1813.8548916086813;1817.891405696261;1833.193394906237;1901.5531350132708;60000;70347.29652703459;71620.64189679018;71987.64006179987;72487.63756181239;10344.844827327595;10384.792304153874;10394.272400932014;10548.841767373495;10625.256232063835;14177.645558860904;14243.85756142446;14270.215138167292;14281.14313141215;14287.57137285883;7076.398506127037;7233.421326293884;7320.304571065741;7344.522606030591;7406.962965185139;6647.86704265912;6650.268470468244;6721.395074443226;6841.042254084432;6907.689153988083;4432.977835110803;4483.887902802456;4515.661325400608;4539.795709193094;4609.516000819865;1691.805442374118;1766.0728117738033;1792.1487293535467;1830.304484295959;1843.5759775251768;784.3293983643903;853.38129855854;864.8745931839848;889.6708217959267;908.3823000359819;16578.419755308747;17013.404530841362;17172.141392930305;17312.826871731122;17571.648567028587;848.6987119572586;849.2653854415886;862.642003568512;874.5277550122989;877.8156587116777;7272.563646181246;9512.429254244767;9592;9655.565499552396;9665.130138287588;354785;360101;368464;368659;370228;74659.25340746524;76203;76850.23149768542;77336.22663773403;79273.60363198147;879.2876214005414;879.55582430872;900.230303090861;900.4687234531527;911.6809116809196;14896.478623248135;15042.172680502677;15177.924110379377;15221.467248646244;15486.5354039379;36882.864956479;38095.428568572046;38126.237475249785;38644.227115458096;39423.2115357697;50353.49646503635;52706.73646631742;53393;53598.73200633972;53960.46039539712;7115.75094871677;7526.435517336112;7732.226777322223;7866.606669666379;7987.880181797162;11064.944675276573;11790.705232369259;11982.10134239953;11986.280823150639;12112.273263604213;10194.745131371776;10550.314229575053;10620.84068738985;10633.574657013633;10797.946010270212;10088.949555252177;10327.48362581883;10643.627473038407;10793.514291857042;10821.134309255398;10281.331713438603;10417.9479102604;10604.098651614699;10631.734206644896;10849.186311026546;7606.353459955966;7773.354722436657;7826;7856.332211761835;7885.290323870649;10473.9476302618;10495.580176792842;10695.465226738788;10715.624953126604;10873.021428071512 03:27:05 INFO - PROCESS | 14474 | |3;mootools.html;1337.8996575256858;1401.348373006552;1468.6842328899284;1673.1299724143453;1710.1107424139448;7280;7745.419093567991;7805.765827025184;7820.569868657221;7832.647530861111;6474.514411419151;6636.4690824734025;6674.933250667492;6859.862802743942;7645.50304230226;2078.1791192478922;2155.267209148889;2157.4390658428842;2171.2617709978604;2181.4219231903558;2144.345974477784;2174.978250217501;2187.9562408751817;2199.197292988064;2225.521512874732;1829.1220214297146;2053.435305291042;2193.451637090727;2209.7569267380654;2211.9336419907427;2084.843636727244;2112.0284669052253;2115.8730476171327;2116.703661487393;2119.1205649655376;1995.3714579907282;2005.9398218053482;2006.5986802639384;2008.0160721246484;2025.8885761283123;7670.309672129535;7724.382049436032;7736.34241089508;7740.109887362913;7756.379489640815;4540.205464043812;4552.8861778455475;4559.475660299075;4671.696339737906;4675.368825208621;2864.3555200080023;2879.5680647902773;2924.4589750896153;2932.70672932705;2992.0425463851575;878.5168157513342;914.5518695839057;917.7338571814166;920.9033051529627;931.9720408387759;9647.565859536338;9931.80136397268;10097.242706796946;10293.74265643365;10316.329438586468;3973.5827738087664;4024.8188831502653;4042.6967977401223;4133.834646614162;4173.040200753783;7617.314441700163;7622.047244094489;7630.198829122862;7639.503432276995;7651.808704782425;4528.207563676344;4536.548304542514;4541.02367990877;4543.204939135704;4544.704594201433;3553.786772793589;4209.031922657745;4215.78921053946;4219.620234178878;4231.42875711775;3021.7582593392917;3023.727864492162;3444.689977902001;3452.1197094741183;3452.8100954447245;1013.9239557033104;1015.9789411641253;1016.4054028393325;1016.4155610523978;1030.7423144213947;770.8805135204052;779.4271210660161;793.2939683681528;843.3969711656196;850.9404341696146;4882.438519570223;4966.1309270877455;5031.748412579356;5043.87390315245;5132.717700526507;822.1901427094307;850.9319254459629;861.3367706865679;890.8841850559515;900.5857305639479;3367.107716455141;3493.283876805249;3500.072480792592;3543.698785603201;3566.661167189113;9217.539123043822;9548.37935534188;9679.806403871884;9687.854682179774;9697.854532182022;9504.572294246775;9516.95241523788;9520.095590918852;9529.666461673809;9574.952125239468;6998.4751143664425;7093.822654433578;7192.244814294529;7198.604076775723;7200.387967022757;4984.700917944935;5022.723750193774;5055.014272216882;5110.97444512775;5128.640995130305;8622.396432249683;8680.088590698138;8713.172248636369;8719.956400217958;8807.471551706918;8548.786280343042;9017.323700722342;9024.458532488072;9026.593803278736;9048.592813323548;5469.835904922858;6042.909356359746;6227.626342419469;6228.501719862491;6351.3331100235655;7351.77944661661;7382.5570465772225;7403.14863790671;7461;7461.626918654154;6605.768798092044;6686.765963191265;6768.526203165731;6845.931540684529;6878.209005964178;6662.500312476681;6674.132362792806;6674.43267322283;6762.4928130389435;6787.117674702257;5830.154627579062;5906.970465147647;5959.344472108151;5976.641401515923;5993.0710739835395;4558.88602784933;4572.497025327278;4618.284165954283;4662.580367766917;4672.9532704673875;4436.068425630654;4503.887402814956;4539.795709193028;4555.362249285169;4612.584867361819 03:27:05 INFO - PROCESS | 14474 | |4;prototype.html;302.68369553816245;305.1197295801612;311.83005262132133;314.30852125324293;316.6390315040854;4679.906401871969;4856.878578035551;4870.707757534546;4906.803727850882;4925.778339974705;4620.353150558916;4830.83092091776;4837.419509658837;4840.467548569663;4841.7337046462435;3859.9807000964956;3861.362875125601;3864.594217607153;3864.613538646141;3866.381378979364;3669.5963444021136;3691.280200360931;3846.6345697158727;3868.207017561407;3868.613138686123;3820.7134464915102;3830.5020347354803;3831.8467261309515;3833.7508061976023;3844.9807750961204;3820.2168555446206;3840.9039774005596;3844.480995065658;3857.614238576148;3871.851122626941;3420.794752314869;3424.2637832865803;3438.9828050859837;3441.5181874537584;3446.551948246737;4591.242444996572;4730.800177917285;4743.573078422924;4745.6440766942615;4746.240601503743;4395.934060989056;4396.802143903532;4405.647548196137;4408.082484119418;4426.822927082912;4854;5056.317397151374;5058.291839142523;5080.669756465818;5132.769025393866;3564.697000754939;3572.1248294168095;3581.6418358164237;3587.4080776671817;3588.1747198144312;5284.867878303073;5316.3354580677415;5320.148776195829;5321.467853214725;5330.520253177194;3678.3263615055084;3692.058525076142;3706.1475860551686;3706.9073273167846;3712.607772085468;3601;3799.6200379961783;3800.562935262425;3803.8668646597234;3807.352750032446;4305.440292761921;4318.719283246579;4335.414719012956;4346.587074227943;4355.586219309161;4804.399450068741;5074.538848658398;5107.923381149286;5133.076046311625;5159.2003239497935;1272.1603741530546;1300.7593595184921;1303.9608811735663;1304.62165971869;1306.784380577194;823.172711425014;829.991560254294;833.6665333866381;845.6532821543137;853.6670698427619;3969.8809035728973;3998.5601583825755;4000.8199631016673;4005.178938317638;4014.7791871446766;4629.189891768927;4629.985956109103;4630.86107416778;4633.050224703928;4637.721736695809;3961.870866802947;3966.2067586482817;3973.1854969731135;3988.481497405319;4007.719459637856;2373.382920440698;2474.8638824864806;2488.216211893248;2488.4401009772655;2494.8627825469775;4303.569643035671;4357.586029327209;4375.44671641569;4384.539623339503;4388.868333949987;4674.228752255908;4689.179393606105;4694.291509707361;4700.811967521329;4717.174494463524;4081.5918408158946;4358.3244597087505;4378.2119218540965;4435.026413246203;4450.777461126995;4639.6313087638555;4683.672142949961;4684.953150468452;4689.742064186366;4695.389599352199;4557.794899229476;4593.908121837611;4621.498013145674;4623.630109591158;4627.745473998828;4284.978575107105;4352.194843953878;4358.585934336233;4579.496255411836;5033.2701758245585;3699.741018128705;3708.2398108388256;3732.720045996615;3753.7477513491685;3759.5300587426573;5068.21442676371;5251.343582052244;5262.184361423985;5309.495597918191;5343.4389389113585;4954.331165292783;5085.4914508548845;5094.745262736922;5097.592192624656;5101.2910674924315;5087.160618497906;5087.186050231945;5098.79604815818;5100.132977393926;5126.79492820283;4825.895242518287;4977.153883839828;4981.726005069756;5016.197408414636;5017.498250174954;5102.668326558762;5106.66806657566;5112.233165025276;5120.846374608767;5131.589472842089;5008.6744361616375;5023.673461225008;5028.798848046184;5029.245613158056;5035.723035233097 03:27:05 INFO - PROCESS | 14474 | |5;yui.html;610.5268416976845;647.3461803578385;650.4501015397294;756.7464899258748;761.851438969401;11257.380844053574;11329;11335.263207891481;12062.57780977666;12077;13464.192148471098;13647.317634118279;13655.180689158657;13685.3157342133;13728.931355343235;630.3381449478053;644.8871447496692;646.9061986012049;755.2447552447552;780.1379475679378;641.7400952614199;766.0615745711486;782.5695867273006;788.7042359115331;788.8856115863197;824.6083110522513;828.5443006346516;828.8673812190051;829.0341751859077;831.3556993330157;820.6061090676449;820.9671613135467;821.6302663801283;821.9260266576007;822.4284122534841;600.8497875531117;601.2274227617535;601.5969300568586;601.6390165900468;601.7683191971079;13189.340532973312;13314.134581252187;13328.800067998987;13334;13346.26595537245;13421.12762670433;13440.731185376335;13479.865201347959;13637.113587616774;13654;10160.938147987152;10175.643852465128;10423.947880260626;10472.68581942543;10574.471276436225;3124.406362791085;3161.9683803162134;3164.984175079133;3181.618205815317;3203.19920019995;49449.25826112611;52903.20645190325;56994.715026425016;57155.71422142863;62502;10823.83764243537;11003.834942475869;11078;11208.551657933755;11496.54013839437;20077.096530656156;20080.49798755043;20089.899550502447;20116.39650810478;20145.29491467821;6857.691403886837;6964.268751781091;7015.89476157858;7020.543664661781;7311.780646580611;3820.255050265227;3945.2504024235304;3975.920481590352;3983.0241590810438;4080.591940805896;2852.1015879997735;2979.031814660244;2983.030515082607;2983.075246673495;2983.284011837187;522.7020598259032;525.5952916254539;529.1876968852793;530.6630289766026;545.1468451872806;624.3974564545235;624.8354715819106;636.3604577399776;639.0765344077856;655.7540922154192;8315.750527484186;8425.95787021061;8774.210321071007;8917.019127895926;9187.724368268962;549.8350494851528;610.9297430795515;623.1618473153601;625.7027911741977;640.5388120553288;4072.3077076897;4085.754854708727;4120.7321524100835;4298.570142985676;4307.719998200107;72552.27447725456;93420;94095;97360.51319743498;97762.51118744361;47473;57580.71209643925;83168.58415707883;83998;84570.5771471151;41477.58522414797;45887.77056114698;62994;72992;75568.24431755612;9337.71986840396;9754.640919723342;9759.876839411605;9772.694583455352;9827.606895724377;42878.35682464703;42964.35553466638;43178.78410608052;43574.782126089165;43821.34267986046;58991.705041476234;60223.69888150531;60493;61179;62511.37488625055;11527.308361498337;11633.709157270798;11825.46785394642;11866.220066990021;12039.33783641873;12956.222626642431;13061.08572399961;13395.330233488481;13425.462981480632;13731.519396821062;10933.781324373309;11369.772604548029;11516.94241528787;11517.07863370945;11780.469878855643;12155.331456769962;12464;12689.111762176559;12761.425735841724;12824.743505130033;10702.324418895276;10708.785824283626;10796.082333001783;10893.128549716163;10909.290896091728;10612;10628.096611788085;10704.732381690521;10728.303100794315;10735.838962415413;10462.21533384984;10552.103071239031;10717.35695858251;10867.239293249713;10903.890961090605 03:27:05 INFO - PROCESS | 14474 | __end_tp_report 03:27:05 INFO - PROCESS | 14474 | __start_cc_report 03:27:05 INFO - PROCESS | 14474 | _x_x_mozilla_cycle_collect,932 03:27:05 INFO - PROCESS | 14474 | __end_cc_report 03:27:05 INFO - PROCESS | 14474 | __startTimestamp1468319225987__endTimestamp 03:27:05 INFO - PROCESS | 14474 | 03:27:05 INFO - PROCESS | 14474 | ------- Summary: start ------- 03:27:05 INFO - PROCESS | 14474 | Number of tests: 6 03:27:05 INFO - PROCESS | 14474 | 03:27:05 INFO - PROCESS | 14474 | [#0] dojo.html Cycles:165 Average:4679.89 Median:4817.75 stddev:500.46 (10.4%) stddev-sans-first:474.18 03:27:05 INFO - PROCESS | 14474 | Values: 2582.4 2610.6 2630.6 2631.8 2642.4 4630.2 4676.2 4711.3 4740.5 4743.9 4714.6 4734.1 4781.2 4786.9 4817.7 4320.0 4360.8 4402.4 4403.1 4436.6 4371.7 4389.6 4428.9 4458.3 4484.8 4307.2 4359.2 4362.4 4376.9 4407.7 4232.3 4281.8 4290.6 4311.7 4330.7 4250.2 4323.4 4329.8 4351.8 4363.3 4655.8 4661.4 4700.2 4720.2 4729.4 4953.4 4997.7 5094.4 5119.1 5144.5 5145.0 5192.0 5197.3 5204.3 5221.2 4635.1 4846.2 4867.2 4870.0 4875.8 5066.1 5185.3 5190.9 5247.0 5255.0 5048.5 5049.9 5051.3 5051.9 5053.6 5084.5 5094.4 5134.1 5136.3 5140.4 4810.5 4931.5 5019.0 5025.0 5082.7 5024.6 5032.4 5034.4 5035.7 5074.4 4323.9 4325.8 4337.6 4368.6 4372.2 3684.1 3697.4 3707.3 3713.6 3769.6 4313.2 4318.5 4318.8 4360.6 4363.0 5114.9 5154.1 5155.8 5164.7 5167.5 4151.2 4229.6 4364.0 4366.1 4415.1 4548.7 4569.8 4570.5 4615.0 4617.7 4688.1 4709.9 4711.5 4718.8 4762.2 4942.5 4970.2 4994.8 5016.1 5032.1 4663.2 4664.5 4680.3 4712.2 4724.3 4922.6 4925.6 4926.1 4930.4 4968.2 4859.4 4989.8 4996.7 4997.5 5034.8 4914.0 4919.0 4920.2 4930.6 4966.5 4933.0 4934.5 4936.1 4936.8 4970.9 4713.6 4821.9 4896.1 4907.2 4910.9 5010.5 5011.9 5035.3 5039.3 5085.7 4901.1 4904.6 4914.2 4918.1 4968.9 03:27:05 INFO - PROCESS | 14474 | 03:27:06 INFO - PROCESS | 14474 | [#1] ext.html Cycles:180 Average:47231.52 Median:36461.14 stddev:87868.53 (241.0%) stddev-sans-first:88045.17 03:27:06 INFO - PROCESS | 14474 | Values: 567.7 570.2 576.3 581.0 582.9 29365.6 39551.4 41115.0 41151.6 44963.8 41134.6 41365.6 41534.4 41545.8 41748.0 7803.0 7948.8 7956.9 7967.6 7968.2 7805.6 7853.7 7854.2 7856.2 7873.8 7888.0 7941.0 7952.5 7952.8 7956.8 7877.1 7915.7 7923.5 7924.4 7933.5 7745.2 7749.9 7810.1 7811.1 7821.5 39498.4 39817.6 39983.0 40007.2 40109.8 3024.2 3073.2 3094.2 3208.4 3232.6 29189.6 29304.4 29535.9 30227.8 30233.7 3490.4 3545.1 3580.2 3591.3 3595.2 273499.0 275328.0 276558.0 276609.6 277140.0 31899.4 54756.5 54818.5 54957.7 54974.5 32463.4 34443.0 34511.0 34515.8 34522.3 13374.9 13451.4 13601.7 13613.4 13640.7 11133.9 11244.8 11249.5 11258.1 11266.4 7967.3 7979.9 7981.5 8038.4 8043.1 3114.2 3117.1 3124.5 3135.6 3182.2 846.5 897.0 928.4 946.4 981.7 24879.8 25062.7 25124.9 25294.9 25461.5 978.4 985.2 986.8 991.0 1008.7 14014.4 14025.0 14189.7 14389.7 14445.6 397916.0 398889.0 401694.0 402196.0 402412.0 50107.2 50738.7 50792.5 50794.2 50848.7 1066.1 1170.9 1182.1 1199.1 1202.1 28031.2 29123.3 29413.0 29924.7 30001.4 41452.8 41991.0 42060.0 42136.0 42142.6 307286.0 309247.0 309617.0 310157.0 311717.0 21636.4 21669.6 24955.5 25300.0 25389.0 41294.8 41330.4 41723.4 42417.4 42732.2 36515.0 36782.4 37091.0 37092.6 37476.6 34936.3 36258.6 36407.3 36686.8 36969.4 34986.8 35755.5 35813.1 36149.5 36160.5 32005.8 33214.0 33228.2 33236.2 33339.8 24472.4 24927.5 24997.6 25106.0 25366.6 03:27:06 INFO - PROCESS | 14474 | 03:27:06 INFO - PROCESS | 14474 | [#2] jquery.html Cycles:180 Average:23607.02 Median:19516.15 stddev:60402.14 (309.5%) stddev-sans-first:60546.37 03:27:06 INFO - PROCESS | 14474 | Values: 364.1 366.7 374.6 378.8 388.1 16502.7 17479.7 18262.8 18262.9 18263.5 16253.1 17087.6 17106.2 17182.9 17771.9 4691.4 4828.3 4861.4 4863.9 4866.5 3505.8 3663.0 4618.2 5296.4 5532.3 5570.9 5594.6 5603.4 5612.1 5612.4 5501.0 6158.9 6253.1 6292.7 6314.7 3419.7 4998.7 5224.8 5233.6 5559.5 12743.9 12754.9 12852.4 15365.7 21336.5 1833.4 1873.0 1927.0 1966.5 2449.4 9274.2 9439.2 9501.1 9913.7 9922.1 1742.8 1813.9 1817.9 1833.2 1901.6 60000.0 70347.3 71620.6 71987.6 72487.6 10344.8 10384.8 10394.3 10548.8 10625.3 14177.6 14243.9 14270.2 14281.1 14287.6 7076.4 7233.4 7320.3 7344.5 7407.0 6647.9 6650.3 6721.4 6841.0 6907.7 4433.0 4483.9 4515.7 4539.8 4609.5 1691.8 1766.1 1792.1 1830.3 1843.6 784.3 853.4 864.9 889.7 908.4 16578.4 17013.4 17172.1 17312.8 17571.6 848.7 849.3 862.6 874.5 877.8 7272.6 9512.4 9592.0 9655.6 9665.1 354785.0 360101.0 368464.0 368659.0 370228.0 74659.3 76203.0 76850.2 77336.2 79273.6 879.3 879.6 900.2 900.5 911.7 14896.5 15042.2 15177.9 15221.5 15486.5 36882.9 38095.4 38126.2 38644.2 39423.2 50353.5 52706.7 53393.0 53598.7 53960.5 7115.8 7526.4 7732.2 7866.6 7987.9 11064.9 11790.7 11982.1 11986.3 12112.3 10194.7 10550.3 10620.8 10633.6 10797.9 10088.9 10327.5 10643.6 10793.5 10821.1 10281.3 10417.9 10604.1 10631.7 10849.2 7606.4 7773.4 7826.0 7856.3 7885.3 10473.9 10495.6 10695.5 10715.6 10873.0 03:27:06 INFO - PROCESS | 14474 | 03:27:06 INFO - PROCESS | 14474 | [#3] mootools.html Cycles:180 Average:4961.17 Median:5119.81 stddev:2763.43 (54.0%) stddev-sans-first:2757.77 03:27:06 INFO - PROCESS | 14474 | Values: 1337.9 1401.3 1468.7 1673.1 1710.1 7280.0 7745.4 7805.8 7820.6 7832.6 6474.5 6636.5 6674.9 6859.9 7645.5 2078.2 2155.3 2157.4 2171.3 2181.4 2144.3 2175.0 2188.0 2199.2 2225.5 1829.1 2053.4 2193.5 2209.8 2211.9 2084.8 2112.0 2115.9 2116.7 2119.1 1995.4 2005.9 2006.6 2008.0 2025.9 7670.3 7724.4 7736.3 7740.1 7756.4 4540.2 4552.9 4559.5 4671.7 4675.4 2864.4 2879.6 2924.5 2932.7 2992.0 878.5 914.6 917.7 920.9 932.0 9647.6 9931.8 10097.2 10293.7 10316.3 3973.6 4024.8 4042.7 4133.8 4173.0 7617.3 7622.0 7630.2 7639.5 7651.8 4528.2 4536.5 4541.0 4543.2 4544.7 3553.8 4209.0 4215.8 4219.6 4231.4 3021.8 3023.7 3444.7 3452.1 3452.8 1013.9 1016.0 1016.4 1016.4 1030.7 770.9 779.4 793.3 843.4 850.9 4882.4 4966.1 5031.7 5043.9 5132.7 822.2 850.9 861.3 890.9 900.6 3367.1 3493.3 3500.1 3543.7 3566.7 9217.5 9548.4 9679.8 9687.9 9697.9 9504.6 9517.0 9520.1 9529.7 9575.0 6998.5 7093.8 7192.2 7198.6 7200.4 4984.7 5022.7 5055.0 5111.0 5128.6 8622.4 8680.1 8713.2 8720.0 8807.5 8548.8 9017.3 9024.5 9026.6 9048.6 5469.8 6042.9 6227.6 6228.5 6351.3 7351.8 7382.6 7403.1 7461.0 7461.6 6605.8 6686.8 6768.5 6845.9 6878.2 6662.5 6674.1 6674.4 6762.5 6787.1 5830.2 5907.0 5959.3 5976.6 5993.1 4558.9 4572.5 4618.3 4662.6 4673.0 4436.1 4503.9 4539.8 4555.4 4612.6 03:27:06 INFO - PROCESS | 14474 | 03:27:06 INFO - PROCESS | 14474 | [#4] prototype.html Cycles:180 Average:4091.00 Median:4430.92 stddev:1174.62 (26.5%) stddev-sans-first:1142.98 03:27:06 INFO - PROCESS | 14474 | Values: 302.7 305.1 311.8 314.3 316.6 4679.9 4856.9 4870.7 4906.8 4925.8 4620.4 4830.8 4837.4 4840.5 4841.7 3860.0 3861.4 3864.6 3864.6 3866.4 3669.6 3691.3 3846.6 3868.2 3868.6 3820.7 3830.5 3831.8 3833.8 3845.0 3820.2 3840.9 3844.5 3857.6 3871.9 3420.8 3424.3 3439.0 3441.5 3446.6 4591.2 4730.8 4743.6 4745.6 4746.2 4395.9 4396.8 4405.6 4408.1 4426.8 4854.0 5056.3 5058.3 5080.7 5132.8 3564.7 3572.1 3581.6 3587.4 3588.2 5284.9 5316.3 5320.1 5321.5 5330.5 3678.3 3692.1 3706.1 3706.9 3712.6 3601.0 3799.6 3800.6 3803.9 3807.4 4305.4 4318.7 4335.4 4346.6 4355.6 4804.4 5074.5 5107.9 5133.1 5159.2 1272.2 1300.8 1304.0 1304.6 1306.8 823.2 830.0 833.7 845.7 853.7 3969.9 3998.6 4000.8 4005.2 4014.8 4629.2 4630.0 4630.9 4633.1 4637.7 3961.9 3966.2 3973.2 3988.5 4007.7 2373.4 2474.9 2488.2 2488.4 2494.9 4303.6 4357.6 4375.4 4384.5 4388.9 4674.2 4689.2 4694.3 4700.8 4717.2 4081.6 4358.3 4378.2 4435.0 4450.8 4639.6 4683.7 4685.0 4689.7 4695.4 4557.8 4593.9 4621.5 4623.6 4627.7 4285.0 4352.2 4358.6 4579.5 5033.3 3699.7 3708.2 3732.7 3753.7 3759.5 5068.2 5251.3 5262.2 5309.5 5343.4 4954.3 5085.5 5094.7 5097.6 5101.3 5087.2 5087.2 5098.8 5100.1 5126.8 4825.9 4977.2 4981.7 5016.2 5017.5 5102.7 5106.7 5112.2 5120.8 5131.6 5008.7 5023.7 5028.8 5029.2 5035.7 03:27:06 INFO - PROCESS | 14474 | 03:27:06 INFO - PROCESS | 14474 | [#5] yui.html Cycles:180 Average:16743.20 Median:23631.46 stddev:22807.18 (96.5%) stddev-sans-first:22838.99 03:27:06 INFO - PROCESS | 14474 | Values: 610.5 647.3 650.5 756.7 761.9 11257.4 11329.0 11335.3 12062.6 12077.0 13464.2 13647.3 13655.2 13685.3 13728.9 630.3 644.9 646.9 755.2 780.1 641.7 766.1 782.6 788.7 788.9 824.6 828.5 828.9 829.0 831.4 820.6 821.0 821.6 821.9 822.4 600.8 601.2 601.6 601.6 601.8 13189.3 13314.1 13328.8 13334.0 13346.3 13421.1 13440.7 13479.9 13637.1 13654.0 10160.9 10175.6 10423.9 10472.7 10574.5 3124.4 3162.0 3165.0 3181.6 3203.2 49449.3 52903.2 56994.7 57155.7 62502.0 10823.8 11003.8 11078.0 11208.6 11496.5 20077.1 20080.5 20089.9 20116.4 20145.3 6857.7 6964.3 7015.9 7020.5 7311.8 3820.3 3945.3 3975.9 3983.0 4080.6 2852.1 2979.0 2983.0 2983.1 2983.3 522.7 525.6 529.2 530.7 545.1 624.4 624.8 636.4 639.1 655.8 8315.8 8426.0 8774.2 8917.0 9187.7 549.8 610.9 623.2 625.7 640.5 4072.3 4085.8 4120.7 4298.6 4307.7 72552.3 93420.0 94095.0 97360.5 97762.5 47473.0 57580.7 83168.6 83998.0 84570.6 41477.6 45887.8 62994.0 72992.0 75568.2 9337.7 9754.6 9759.9 9772.7 9827.6 42878.4 42964.4 43178.8 43574.8 43821.3 58991.7 60223.7 60493.0 61179.0 62511.4 11527.3 11633.7 11825.5 11866.2 12039.3 12956.2 13061.1 13395.3 13425.5 13731.5 10933.8 11369.8 11516.9 11517.1 11780.5 12155.3 12464.0 12689.1 12761.4 12824.7 10702.3 10708.8 10796.1 10893.1 10909.3 10612.0 10628.1 10704.7 10728.3 10735.8 10462.2 10552.1 10717.4 10867.2 10903.9 03:27:06 INFO - PROCESS | 14474 | -------- Summary: end -------- 03:27:06 INFO - PROCESS | 14474 | 03:27:06 INFO - TEST-INFO | 14474: exit 0 03:27:06 INFO - TEST-OK | dromaeo_css | took 1119523ms 03:27:06 INFO - TEST-START | kraken 03:27:06 INFO - operating with platform_type : linux_ 03:27:06 INFO - Initialising browser for kraken test... 03:27:06 INFO - TEST-INFO | started process 14664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTZTij3/profile http://localhost:55045/getInfo.html) 03:27:11 INFO - PROCESS | 14664 | __metrics Screen width/height:1600/1200 03:27:11 INFO - PROCESS | 14664 | colorDepth:24 03:27:11 INFO - PROCESS | 14664 | Browser inner width/height: 1024/697 03:27:11 INFO - PROCESS | 14664 | __metrics 03:27:11 INFO - PROCESS | 14664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:27:11 INFO - PROCESS | 14664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:27:12 INFO - TEST-INFO | 14664: exit 0 03:27:12 INFO - Browser initialized. 03:27:12 INFO - Running cycle 1/1 for kraken test... 03:27:12 INFO - TEST-INFO | started process 14745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTZTij3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:24 INFO - PROCESS | 14745 | RSS: Main: 159252480 03:27:24 INFO - PROCESS | 14745 | 03:27:27 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:28 INFO - PROCESS | 14745 | RSS: Main: 216883200 03:27:28 INFO - PROCESS | 14745 | 03:27:30 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-dft) 03:27:31 INFO - PROCESS | 14745 | RSS: Main: 203730944 03:27:31 INFO - PROCESS | 14745 | 03:27:34 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-fft) 03:27:35 INFO - PROCESS | 14745 | RSS: Main: 270868480 03:27:35 INFO - PROCESS | 14745 | 03:27:37 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-oscillator) 03:27:38 INFO - PROCESS | 14745 | RSS: Main: 181764096 03:27:38 INFO - PROCESS | 14745 | 03:27:40 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:41 INFO - PROCESS | 14745 | RSS: Main: 186552320 03:27:41 INFO - PROCESS | 14745 | 03:27:44 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:44 INFO - PROCESS | 14745 | RSS: Main: 222027776 03:27:44 INFO - PROCESS | 14745 | 03:27:48 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:48 INFO - PROCESS | 14745 | RSS: Main: 216698880 03:27:48 INFO - PROCESS | 14745 | 03:27:51 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55045/tests/kraken/driver.html?testName=json-parse-financial) 03:27:52 INFO - PROCESS | 14745 | RSS: Main: 220590080 03:27:52 INFO - PROCESS | 14745 | 03:27:54 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:54 INFO - PROCESS | 14745 | RSS: Main: 205643776 03:27:54 INFO - PROCESS | 14745 | 03:27:56 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:57 INFO - PROCESS | 14745 | RSS: Main: 210862080 03:27:57 INFO - PROCESS | 14745 | 03:27:59 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:00 INFO - PROCESS | 14745 | RSS: Main: 211857408 03:28:00 INFO - PROCESS | 14745 | 03:28:02 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:03 INFO - PROCESS | 14745 | RSS: Main: 221757440 03:28:03 INFO - PROCESS | 14745 | 03:28:06 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:06 INFO - PROCESS | 14745 | RSS: Main: 223608832 03:28:06 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55045/tests/kraken/driver.html?testName=ai-astar) 03:28:08 INFO - PROCESS | 14745 | RSS: Main: 266362880 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | __start_tp_report 03:28:08 INFO - PROCESS | 14745 | _x_x_mozilla_page_load 03:28:08 INFO - PROCESS | 14745 | _x_x_mozilla_page_load_details 03:28:08 INFO - PROCESS | 14745 | |i|pagename|runs| 03:28:08 INFO - PROCESS | 14745 | |0;ai-astar;104;113;112;113;113;114;113;114;115;113 03:28:08 INFO - PROCESS | 14745 | |1;audio-beat-detection;149;124;123;188;123;123;149;129;166;122 03:28:08 INFO - PROCESS | 14745 | |2;audio-dft;163;161;161;160;160;162;162;161;162;161 03:28:08 INFO - PROCESS | 14745 | |3;audio-fft;75;77;77;124;75;76;76;75;100;74 03:28:08 INFO - PROCESS | 14745 | |4;audio-oscillator;85;85;115;85;84;84;114;84;86;132 03:28:08 INFO - PROCESS | 14745 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;125 03:28:08 INFO - PROCESS | 14745 | |6;imaging-darkroom;147;148;146;146;146;146;147;146;146;148 03:28:08 INFO - PROCESS | 14745 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;96 03:28:08 INFO - PROCESS | 14745 | |8;json-parse-financial;62;63;63;63;62;62;63;63;64;63 03:28:08 INFO - PROCESS | 14745 | |9;json-stringify-tinderbox;65;65;65;65;65;64;65;65;65;66 03:28:08 INFO - PROCESS | 14745 | |10;stanford-crypto-aes;80;80;78;79;79;79;88;80;80;81 03:28:08 INFO - PROCESS | 14745 | |11;stanford-crypto-ccm;132;127;137;129;127;129;128;134;176;127 03:28:08 INFO - PROCESS | 14745 | |12;stanford-crypto-pbkdf2;169;171;166;169;164;162;167;169;168;162 03:28:08 INFO - PROCESS | 14745 | |13;stanford-crypto-sha256-iterative;67;70;67;67;71;68;68;65;65;66 03:28:08 INFO - PROCESS | 14745 | __end_tp_report 03:28:08 INFO - PROCESS | 14745 | __start_cc_report 03:28:08 INFO - PROCESS | 14745 | _x_x_mozilla_cycle_collect,1901 03:28:08 INFO - PROCESS | 14745 | __end_cc_report 03:28:08 INFO - PROCESS | 14745 | __startTimestamp1468319288875__endTimestamp 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | ------- Summary: start ------- 03:28:08 INFO - PROCESS | 14745 | Number of tests: 14 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 03:28:08 INFO - PROCESS | 14745 | Values: 104.0 113.0 112.0 113.0 113.0 114.0 113.0 114.0 115.0 113.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:139.00 stddev:22.87 (16.5%) stddev-sans-first:24.01 03:28:08 INFO - PROCESS | 14745 | Values: 149.0 124.0 123.0 188.0 123.0 123.0 149.0 129.0 166.0 122.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 03:28:08 INFO - PROCESS | 14745 | Values: 163.0 161.0 161.0 160.0 160.0 162.0 162.0 161.0 162.0 161.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:16.37 (21.7%) stddev-sans-first:17.12 03:28:08 INFO - PROCESS | 14745 | Values: 75.0 77.0 77.0 124.0 75.0 76.0 76.0 75.0 100.0 74.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.50 stddev:17.86 (21.1%) stddev-sans-first:18.55 03:28:08 INFO - PROCESS | 14745 | Values: 85.0 85.0 115.0 85.0 84.0 84.0 114.0 84.0 86.0 132.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:2.63 (2.3%) stddev-sans-first:2.78 03:28:08 INFO - PROCESS | 14745 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 125.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 03:28:08 INFO - PROCESS | 14745 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:28:08 INFO - PROCESS | 14745 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 03:28:08 INFO - PROCESS | 14745 | Values: 62.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 64.0 63.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 03:28:08 INFO - PROCESS | 14745 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.80 (3.5%) stddev-sans-first:2.96 03:28:08 INFO - PROCESS | 14745 | Values: 80.0 80.0 78.0 79.0 79.0 79.0 88.0 80.0 80.0 81.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:130.50 stddev:14.93 (11.4%) stddev-sans-first:15.81 03:28:08 INFO - PROCESS | 14745 | Values: 132.0 127.0 137.0 129.0 127.0 129.0 128.0 134.0 176.0 127.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.50 stddev:3.13 (1.9%) stddev-sans-first:3.21 03:28:08 INFO - PROCESS | 14745 | Values: 169.0 171.0 166.0 169.0 164.0 162.0 167.0 169.0 168.0 162.0 03:28:08 INFO - PROCESS | 14745 | 03:28:08 INFO - PROCESS | 14745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.96 (2.9%) stddev-sans-first:2.07 03:28:08 INFO - PROCESS | 14745 | Values: 67.0 70.0 67.0 67.0 71.0 68.0 68.0 65.0 65.0 66.0 03:28:08 INFO - PROCESS | 14745 | -------- Summary: end -------- 03:28:08 INFO - PROCESS | 14745 | 03:28:09 INFO - TEST-INFO | 14745: exit 0 03:28:10 INFO - TEST-OK | kraken | took 63144ms 03:28:10 INFO - SUITE-END | took 1182s 03:28:10 INFO - Completed test suite (00:19:42) 03:28:10 INFO - javascript benchmark 03:28:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.444774373512, 2610.6345111684363, 2630.565956617157, 2631.815772895898, 2642.3922497825492, 4630.189716799563, 4676.181668208059, 4711.269753188257, 4740.454847692512, 4743.928841067383, 4714.622830173586, 4734.147853386397, 4781.235002399617, 4786.928196077061, 4817.747385679722, 4320.049589090395, 4360.760158191299, 4402.427684401031, 4403.141387429452, 4436.622887054604, 4371.73769573825, 4389.626881715058, 4428.867133985986, 4458.2866741321395, 4484.798184081724, 4307.1601037797645, 4359.171757366122, 4362.432883725127, 4376.89057773555, 4407.691461597689, 4232.343986682069, 4281.828726850953, 4290.570942905716, 4311.698181127323, 4330.696851220416, 4250.213710463574, 4323.351497275403, 4329.826806927719, 4351.782410879475, 4363.3454981752675, 4655.790489427984, 4661.370714953506, 4700.247960326331, 4720.150372932871, 4729.361536192639, 4953.380827396575, 4997.725125118117, 5094.439611642716, 5119.078565858144, 5144.485551444825, 5145.0, 5191.961607678441, 5197.324347834758, 5204.3234379530795, 5221.242919776611, 4635.119327327797, 4846.248831431134, 4867.172580661225, 4870.025994801054, 4875.829345972874, 5066.08810414129, 5185.325907631984, 5190.896182076337, 5246.950609878039, 5254.97372513135, 5048.5203905628905, 5049.949500505021, 5051.3433253676785, 5051.949480505222, 5053.570446512088, 5084.491550844886, 5094.363204599425, 5134.101532231844, 5136.306598609214, 5140.434552199255, 4810.470848206694, 4931.457539670633, 5019.0463811875625, 5025.045241404122, 5082.720450375265, 5024.62315326352, 5032.3961124665275, 5034.446210916796, 5035.672681275705, 5074.391073071181, 4323.935140972888, 4325.805338759764, 4337.587929146726, 4368.584984426474, 4372.213001659668, 3684.1158122050515, 3697.371446854041, 3707.295613833363, 3713.6472035156617, 3769.566499852497, 4313.223619748413, 4318.52496225415, 4318.848840290638, 4360.585744354281, 4363.0, 5114.948850511447, 5154.123798954187, 5155.793768249303, 5164.690118592896, 5167.4832516748775, 4151.190517849051, 4229.640480559187, 4363.978180109143, 4366.061296821199, 4415.094905544356, 4548.704334218265, 4569.840055598038, 4570.520095389937, 4614.976925115353, 4617.699849509771, 4688.132695451352, 4709.905801883875, 4711.528847115261, 4718.787654555554, 4762.190427627381, 4942.456329803646, 4970.204767237225, 4994.750262486788, 5016.147254966591, 5032.0690672225755, 4663.1839428099265, 4664.533546645444, 4680.344751734828, 4712.151812673752, 4724.314974328772, 4922.556969872729, 4925.556699897026, 4926.064047830901, 4930.408350997904, 4968.22992436173, 4859.416869975626, 4989.825356112518, 4996.7001979881325, 4997.450280469218, 5034.798608055637, 4913.950860491349, 4919.0, 4920.237363208708, 4930.630202734881, 4966.503349665005, 4932.975335123445, 4934.481879402611, 4936.111499929903, 4936.802527898843, 4970.850874473772, 4713.646476514206, 4821.855344339676, 4896.143174944442, 4907.190313598217, 4910.92633610489, 5010.5240002199735, 5011.874703132305, 5035.295058691713, 5039.3448851649055, 5085.694858308513, 4901.068796928572, 4904.632152588499, 4914.164592019294, 4918.065567542156, 4968.8757781055765], "value": 4647.222803178725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6764244380703, 570.1988705868257, 576.2710171632888, 580.9796657116999, 582.8921649494844, 29365.559516607267, 39551.40672889909, 41114.97212569683, 41151.58848411515, 44963.77518112413, 41134.58865411345, 41365.58634413655, 41534.37698434526, 41545.792271038605, 41748.0, 7802.96098519508, 7948.801279967989, 7956.880646790303, 7967.641456134488, 7968.203179682044, 7805.5706936118495, 7853.685852565919, 7854.175311592287, 7856.1751016143335, 7873.842523149534, 7888.0, 7941.0, 7952.522848629072, 7952.840943181133, 7956.801079973018, 7877.133515313311, 7915.722949696733, 7923.524588524707, 7924.445288829785, 7933.523988560676, 7745.186755390716, 7749.883751743729, 7810.1408845027, 7811.1017233018365, 7821.530708157528, 39498.40752388717, 39817.60182398197, 39983.0, 40007.19985600272, 40109.79945100256, 3024.228821650465, 3073.1702440340982, 3094.2419107318624, 3208.4064448076947, 3232.6444091149956, 29189.56215656767, 29304.41391172186, 29535.85232073826, 30227.848860755556, 30233.697663023308, 3490.3891818931584, 3545.131442796506, 3580.230250496156, 3591.28174365128, 3595.2449985503076, 273499.0, 275328.0, 276558.0, 276609.61695191596, 277140.0, 31899.36201276008, 54756.452435475134, 54818.451815482134, 54957.72521137369, 54974.45025549693, 32463.350732985207, 34443.0, 34511.0, 34515.82742086273, 34522.30955380928, 13374.866251337557, 13451.394687239097, 13601.727965440834, 13613.387397566936, 13640.727185456235, 11133.944330278458, 11244.775104497865, 11249.493772780244, 11258.099352051817, 11266.43667816606, 7967.28294453502, 7979.9202007979175, 7981.521108733495, 8038.356931445471, 8043.075046369625, 3114.159177022191, 3117.142785733896, 3124.500079987191, 3135.623725152996, 3182.172635114887, 846.4582667093065, 896.9908852540891, 928.3826255540125, 946.4037656276502, 981.651513712636, 24879.751202488107, 25062.74937250604, 25124.874375628006, 25294.873525632254, 25461.490770184864, 978.4031740638205, 985.2364417576435, 986.8371718666483, 991.0485933503772, 1008.7326858382535, 14014.439422423193, 14025.0, 14189.716205675828, 14389.712205755826, 14445.566633001026, 397916.0, 398889.0, 401694.0, 402196.0, 402412.0, 50107.24839127416, 50738.74630626823, 50792.49207507951, 50794.23808642873, 50848.745756271725, 1066.088494337346, 1170.8770579089244, 1182.0543565147848, 1199.0587388899671, 1202.116444413338, 28031.159065228076, 29123.271918202216, 29413.0, 29924.70075299219, 30001.399972000003, 41452.79273603613, 41991.0, 42060.0, 42136.0, 42142.57857421387, 307286.0, 309247.0, 309617.0, 310157.0, 311717.0, 21636.38901629205, 21669.566608668054, 24955.50266983987, 25300.0, 25389.0, 41294.793526033376, 41330.380044298756, 41723.37414938718, 42417.36373954455, 42732.22240554354, 36515.0, 36782.44826327661, 37091.0, 37092.62907371, 37476.62523374731, 34936.30127397387, 36258.63741362658, 36407.271854562234, 36686.816565917, 36969.44545831761, 34986.82506587451, 35755.46366804448, 35813.10467238236, 36149.457758133125, 36160.4575931356, 32005.839970799996, 33214.0, 33228.1692957678, 33236.1690957728, 33339.83330083334, 24472.388190295384, 24927.501449971263, 24997.625035624118, 25106.0, 25366.619500707136], "value": 16569.971893580387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.0934074155354, 366.73595011591647, 374.6422166830677, 378.84656714030825, 388.06863527533915, 16502.669946601076, 17479.737803932952, 18262.817371826277, 18262.908685456587, 18263.543411414703, 16253.106079165642, 17087.572810679707, 17106.230219640114, 17182.914085429555, 17771.91114044428, 4691.390119284488, 4828.275758636198, 4861.416630004404, 4863.902721945559, 4866.51334866514, 3505.772124811892, 3663.0, 4618.214903466419, 5296.417394086648, 5532.28080349554, 5570.916436253459, 5594.608377413582, 5603.439656034405, 5612.07400778871, 5612.438756124376, 5501.019632932162, 6158.8768224635705, 6253.062040693887, 6292.685365731695, 6314.684265786692, 3419.7264218862433, 4998.700077995332, 5224.764885580158, 5233.555147812441, 5559.471850174227, 12743.93628031854, 12754.936225318907, 12852.357382130856, 15365.692686146327, 21336.466588335417, 1833.4133077415233, 1872.953176170593, 1927.0058514330997, 1966.5083729067733, 2449.4243852694603, 9274.21169200612, 9439.24486041115, 9501.097395747393, 9913.65302214419, 9922.05740454663, 1742.8082910879793, 1813.8548916086813, 1817.891405696261, 1833.193394906237, 1901.5531350132708, 60000.0, 70347.29652703459, 71620.64189679018, 71987.64006179987, 72487.63756181239, 10344.844827327595, 10384.792304153874, 10394.272400932014, 10548.841767373495, 10625.256232063835, 14177.645558860904, 14243.85756142446, 14270.215138167292, 14281.14313141215, 14287.57137285883, 7076.398506127037, 7233.421326293884, 7320.304571065741, 7344.522606030591, 7406.962965185139, 6647.86704265912, 6650.268470468244, 6721.395074443226, 6841.042254084432, 6907.689153988083, 4432.977835110803, 4483.887902802456, 4515.661325400608, 4539.795709193094, 4609.516000819865, 1691.805442374118, 1766.0728117738033, 1792.1487293535467, 1830.304484295959, 1843.5759775251768, 784.3293983643903, 853.38129855854, 864.8745931839848, 889.6708217959267, 908.3823000359819, 16578.419755308747, 17013.404530841362, 17172.141392930305, 17312.826871731122, 17571.648567028587, 848.6987119572586, 849.2653854415886, 862.642003568512, 874.5277550122989, 877.8156587116777, 7272.563646181246, 9512.429254244767, 9592.0, 9655.565499552396, 9665.130138287588, 354785.0, 360101.0, 368464.0, 368659.0, 370228.0, 74659.25340746524, 76203.0, 76850.23149768542, 77336.22663773403, 79273.60363198147, 879.2876214005414, 879.55582430872, 900.230303090861, 900.4687234531527, 911.6809116809196, 14896.478623248135, 15042.172680502677, 15177.924110379377, 15221.467248646244, 15486.5354039379, 36882.864956479, 38095.428568572046, 38126.237475249785, 38644.227115458096, 39423.2115357697, 50353.49646503635, 52706.73646631742, 53393.0, 53598.73200633972, 53960.46039539712, 7115.75094871677, 7526.435517336112, 7732.226777322223, 7866.606669666379, 7987.880181797162, 11064.944675276573, 11790.705232369259, 11982.10134239953, 11986.280823150639, 12112.273263604213, 10194.745131371776, 10550.314229575053, 10620.84068738985, 10633.574657013633, 10797.946010270212, 10088.949555252177, 10327.48362581883, 10643.627473038407, 10793.514291857042, 10821.134309255398, 10281.331713438603, 10417.9479102604, 10604.098651614699, 10631.734206644896, 10849.186311026546, 7606.353459955966, 7773.354722436657, 7826.0, 7856.332211761835, 7885.290323870649, 10473.9476302618, 10495.580176792842, 10695.465226738788, 10715.624953126604, 10873.021428071512], "value": 8173.891895021055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.8996575256858, 1401.348373006552, 1468.6842328899284, 1673.1299724143453, 1710.1107424139448, 7280.0, 7745.419093567991, 7805.765827025184, 7820.569868657221, 7832.647530861111, 6474.514411419151, 6636.4690824734025, 6674.933250667492, 6859.862802743942, 7645.50304230226, 2078.1791192478922, 2155.267209148889, 2157.4390658428842, 2171.2617709978604, 2181.4219231903558, 2144.345974477784, 2174.978250217501, 2187.9562408751817, 2199.197292988064, 2225.521512874732, 1829.1220214297146, 2053.435305291042, 2193.451637090727, 2209.7569267380654, 2211.9336419907427, 2084.843636727244, 2112.0284669052253, 2115.8730476171327, 2116.703661487393, 2119.1205649655376, 1995.3714579907282, 2005.9398218053482, 2006.5986802639384, 2008.0160721246484, 2025.8885761283123, 7670.309672129535, 7724.382049436032, 7736.34241089508, 7740.109887362913, 7756.379489640815, 4540.205464043812, 4552.8861778455475, 4559.475660299075, 4671.696339737906, 4675.368825208621, 2864.3555200080023, 2879.5680647902773, 2924.4589750896153, 2932.70672932705, 2992.0425463851575, 878.5168157513342, 914.5518695839057, 917.7338571814166, 920.9033051529627, 931.9720408387759, 9647.565859536338, 9931.80136397268, 10097.242706796946, 10293.74265643365, 10316.329438586468, 3973.5827738087664, 4024.8188831502653, 4042.6967977401223, 4133.834646614162, 4173.040200753783, 7617.314441700163, 7622.047244094489, 7630.198829122862, 7639.503432276995, 7651.808704782425, 4528.207563676344, 4536.548304542514, 4541.02367990877, 4543.204939135704, 4544.704594201433, 3553.786772793589, 4209.031922657745, 4215.78921053946, 4219.620234178878, 4231.42875711775, 3021.7582593392917, 3023.727864492162, 3444.689977902001, 3452.1197094741183, 3452.8100954447245, 1013.9239557033104, 1015.9789411641253, 1016.4054028393325, 1016.4155610523978, 1030.7423144213947, 770.8805135204052, 779.4271210660161, 793.2939683681528, 843.3969711656196, 850.9404341696146, 4882.438519570223, 4966.1309270877455, 5031.748412579356, 5043.87390315245, 5132.717700526507, 822.1901427094307, 850.9319254459629, 861.3367706865679, 890.8841850559515, 900.5857305639479, 3367.107716455141, 3493.283876805249, 3500.072480792592, 3543.698785603201, 3566.661167189113, 9217.539123043822, 9548.37935534188, 9679.806403871884, 9687.854682179774, 9697.854532182022, 9504.572294246775, 9516.95241523788, 9520.095590918852, 9529.666461673809, 9574.952125239468, 6998.4751143664425, 7093.822654433578, 7192.244814294529, 7198.604076775723, 7200.387967022757, 4984.700917944935, 5022.723750193774, 5055.014272216882, 5110.97444512775, 5128.640995130305, 8622.396432249683, 8680.088590698138, 8713.172248636369, 8719.956400217958, 8807.471551706918, 8548.786280343042, 9017.323700722342, 9024.458532488072, 9026.593803278736, 9048.592813323548, 5469.835904922858, 6042.909356359746, 6227.626342419469, 6228.501719862491, 6351.3331100235655, 7351.77944661661, 7382.5570465772225, 7403.14863790671, 7461.0, 7461.626918654154, 6605.768798092044, 6686.765963191265, 6768.526203165731, 6845.931540684529, 6878.209005964178, 6662.500312476681, 6674.132362792806, 6674.43267322283, 6762.4928130389435, 6787.117674702257, 5830.154627579062, 5906.970465147647, 5959.344472108151, 5976.641401515923, 5993.0710739835395, 4558.88602784933, 4572.497025327278, 4618.284165954283, 4662.580367766917, 4672.9532704673875, 4436.068425630654, 4503.887402814956, 4539.795709193028, 4555.362249285169, 4612.584867361819], "value": 4003.6216474412004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.68369553816245, 305.1197295801612, 311.83005262132133, 314.30852125324293, 316.6390315040854, 4679.906401871969, 4856.878578035551, 4870.707757534546, 4906.803727850882, 4925.778339974705, 4620.353150558916, 4830.83092091776, 4837.419509658837, 4840.467548569663, 4841.7337046462435, 3859.9807000964956, 3861.362875125601, 3864.594217607153, 3864.613538646141, 3866.381378979364, 3669.5963444021136, 3691.280200360931, 3846.6345697158727, 3868.207017561407, 3868.613138686123, 3820.7134464915102, 3830.5020347354803, 3831.8467261309515, 3833.7508061976023, 3844.9807750961204, 3820.2168555446206, 3840.9039774005596, 3844.480995065658, 3857.614238576148, 3871.851122626941, 3420.794752314869, 3424.2637832865803, 3438.9828050859837, 3441.5181874537584, 3446.551948246737, 4591.242444996572, 4730.800177917285, 4743.573078422924, 4745.6440766942615, 4746.240601503743, 4395.934060989056, 4396.802143903532, 4405.647548196137, 4408.082484119418, 4426.822927082912, 4854.0, 5056.317397151374, 5058.291839142523, 5080.669756465818, 5132.769025393866, 3564.697000754939, 3572.1248294168095, 3581.6418358164237, 3587.4080776671817, 3588.1747198144312, 5284.867878303073, 5316.3354580677415, 5320.148776195829, 5321.467853214725, 5330.520253177194, 3678.3263615055084, 3692.058525076142, 3706.1475860551686, 3706.9073273167846, 3712.607772085468, 3601.0, 3799.6200379961783, 3800.562935262425, 3803.8668646597234, 3807.352750032446, 4305.440292761921, 4318.719283246579, 4335.414719012956, 4346.587074227943, 4355.586219309161, 4804.399450068741, 5074.538848658398, 5107.923381149286, 5133.076046311625, 5159.2003239497935, 1272.1603741530546, 1300.7593595184921, 1303.9608811735663, 1304.62165971869, 1306.784380577194, 823.172711425014, 829.991560254294, 833.6665333866381, 845.6532821543137, 853.6670698427619, 3969.8809035728973, 3998.5601583825755, 4000.8199631016673, 4005.178938317638, 4014.7791871446766, 4629.189891768927, 4629.985956109103, 4630.86107416778, 4633.050224703928, 4637.721736695809, 3961.870866802947, 3966.2067586482817, 3973.1854969731135, 3988.481497405319, 4007.719459637856, 2373.382920440698, 2474.8638824864806, 2488.216211893248, 2488.4401009772655, 2494.8627825469775, 4303.569643035671, 4357.586029327209, 4375.44671641569, 4384.539623339503, 4388.868333949987, 4674.228752255908, 4689.179393606105, 4694.291509707361, 4700.811967521329, 4717.174494463524, 4081.5918408158946, 4358.3244597087505, 4378.2119218540965, 4435.026413246203, 4450.777461126995, 4639.6313087638555, 4683.672142949961, 4684.953150468452, 4689.742064186366, 4695.389599352199, 4557.794899229476, 4593.908121837611, 4621.498013145674, 4623.630109591158, 4627.745473998828, 4284.978575107105, 4352.194843953878, 4358.585934336233, 4579.496255411836, 5033.2701758245585, 3699.741018128705, 3708.2398108388256, 3732.720045996615, 3753.7477513491685, 3759.5300587426573, 5068.21442676371, 5251.343582052244, 5262.184361423985, 5309.495597918191, 5343.4389389113585, 4954.331165292783, 5085.4914508548845, 5094.745262736922, 5097.592192624656, 5101.2910674924315, 5087.160618497906, 5087.186050231945, 5098.79604815818, 5100.132977393926, 5126.79492820283, 4825.895242518287, 4977.153883839828, 4981.726005069756, 5016.197408414636, 5017.498250174954, 5102.668326558762, 5106.66806657566, 5112.233165025276, 5120.846374608767, 5131.589472842089, 5008.6744361616375, 5023.673461225008, 5028.798848046184, 5029.245613158056, 5035.723035233097], "value": 3723.499004779766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.5268416976845, 647.3461803578385, 650.4501015397294, 756.7464899258748, 761.851438969401, 11257.380844053574, 11329.0, 11335.263207891481, 12062.57780977666, 12077.0, 13464.192148471098, 13647.317634118279, 13655.180689158657, 13685.3157342133, 13728.931355343235, 630.3381449478053, 644.8871447496692, 646.9061986012049, 755.2447552447552, 780.1379475679378, 641.7400952614199, 766.0615745711486, 782.5695867273006, 788.7042359115331, 788.8856115863197, 824.6083110522513, 828.5443006346516, 828.8673812190051, 829.0341751859077, 831.3556993330157, 820.6061090676449, 820.9671613135467, 821.6302663801283, 821.9260266576007, 822.4284122534841, 600.8497875531117, 601.2274227617535, 601.5969300568586, 601.6390165900468, 601.7683191971079, 13189.340532973312, 13314.134581252187, 13328.800067998987, 13334.0, 13346.26595537245, 13421.12762670433, 13440.731185376335, 13479.865201347959, 13637.113587616774, 13654.0, 10160.938147987152, 10175.643852465128, 10423.947880260626, 10472.68581942543, 10574.471276436225, 3124.406362791085, 3161.9683803162134, 3164.984175079133, 3181.618205815317, 3203.19920019995, 49449.25826112611, 52903.20645190325, 56994.715026425016, 57155.71422142863, 62502.0, 10823.83764243537, 11003.834942475869, 11078.0, 11208.551657933755, 11496.54013839437, 20077.096530656156, 20080.49798755043, 20089.899550502447, 20116.39650810478, 20145.29491467821, 6857.691403886837, 6964.268751781091, 7015.89476157858, 7020.543664661781, 7311.780646580611, 3820.255050265227, 3945.2504024235304, 3975.920481590352, 3983.0241590810438, 4080.591940805896, 2852.1015879997735, 2979.031814660244, 2983.030515082607, 2983.075246673495, 2983.284011837187, 522.7020598259032, 525.5952916254539, 529.1876968852793, 530.6630289766026, 545.1468451872806, 624.3974564545235, 624.8354715819106, 636.3604577399776, 639.0765344077856, 655.7540922154192, 8315.750527484186, 8425.95787021061, 8774.210321071007, 8917.019127895926, 9187.724368268962, 549.8350494851528, 610.9297430795515, 623.1618473153601, 625.7027911741977, 640.5388120553288, 4072.3077076897, 4085.754854708727, 4120.7321524100835, 4298.570142985676, 4307.719998200107, 72552.27447725456, 93420.0, 94095.0, 97360.51319743498, 97762.51118744361, 47473.0, 57580.71209643925, 83168.58415707883, 83998.0, 84570.5771471151, 41477.58522414797, 45887.77056114698, 62994.0, 72992.0, 75568.24431755612, 9337.71986840396, 9754.640919723342, 9759.876839411605, 9772.694583455352, 9827.606895724377, 42878.35682464703, 42964.35553466638, 43178.78410608052, 43574.782126089165, 43821.34267986046, 58991.705041476234, 60223.69888150531, 60493.0, 61179.0, 62511.37488625055, 11527.308361498337, 11633.709157270798, 11825.46785394642, 11866.220066990021, 12039.33783641873, 12956.222626642431, 13061.08572399961, 13395.330233488481, 13425.462981480632, 13731.519396821062, 10933.781324373309, 11369.772604548029, 11516.94241528787, 11517.07863370945, 11780.469878855643, 12155.331456769962, 12464.0, 12689.111762176559, 12761.425735841724, 12824.743505130033, 10702.324418895276, 10708.785824283626, 10796.082333001783, 10893.128549716163, 10909.290896091728, 10612.0, 10628.096611788085, 10704.732381690521, 10728.303100794315, 10735.838962415413, 10462.21533384984, 10552.103071239031, 10717.35695858251, 10867.239293249713, 10903.890961090605], "value": 6584.5082129212615, "unit": "score"}], "name": "dromaeo_css", "value": 6287.6283726835545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 113.0, 113.0, 114.0, 113.0, 114.0, 115.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 123.0, 188.0, 123.0, 123.0, 149.0, 129.0, 166.0, 122.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 124.0, 75.0, 76.0, 76.0, 75.0, 100.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 84.0, 84.0, 114.0, 84.0, 86.0, 132.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 125.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 79.0, 79.0, 79.0, 88.0, 80.0, 80.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 137.0, 129.0, 127.0, 129.0, 128.0, 134.0, 176.0, 127.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 166.0, 169.0, 164.0, 162.0, 167.0, 169.0, 168.0, 162.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 67.0, 71.0, 68.0, 68.0, 65.0, 65.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1527.7, "alertThreshold": 2.0}]} 03:28:10 INFO - Return code: 0 03:28:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:28:10 INFO - # TBPL SUCCESS # 03:28:10 INFO - Running post-action listener: _resource_record_post_action 03:28:10 INFO - ##### 03:28:10 INFO - ##### Finished run-tests step (success) 03:28:10 INFO - ##### 03:28:10 INFO - Running post-run listener: _resource_record_post_run 03:28:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 534269952; Read time: 0; Write time: 598456 03:28:10 INFO - TinderboxPrint: CPU usage
13.0% 03:28:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:28:10 INFO - TinderboxPrint: I/O write bytes / time
534,269,952 / 598,456 03:28:10 INFO - TinderboxPrint: CPU idle
8,321.7 (86.9%) 03:28:10 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 03:28:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:28:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246312960; Read time: 0; Write time: 368376 03:28:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 287956992; Read time: 0; Write time: 230080 03:28:10 INFO - Running post-run listener: _upload_blobber_files 03:28:10 INFO - Blob upload gear active. 03:28:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:10 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 03:28:10 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:28:10 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:28:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:13 INFO - (blobuploader) - INFO - Done attempting. 03:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:14 INFO - (blobuploader) - INFO - Done attempting. 03:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:17 INFO - (blobuploader) - INFO - Done attempting. 03:28:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:17 INFO - Return code: 0 03:28:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cb6dc0f0a3c0a5516c507f26bb9c0a94be8b8e2700380bc570405f8575ac6d2e630d674f2f3310ce754f6d9de8a47e52108c28697b12c30ba0989afd21fae36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86ed0faec0e96a41f091328ce51755df4f9e6681f6311e39ef5fdf86f0558be0007db72ebcf2409dc350af870d4c8cbf9cc763aef041c2b1e95c833053ff0270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/133eeab96f22b4dfab77b8585cad82c5b4eafb5231f1b6d5f9430340e89a612d5f9d47a9b9cc2eb42c4638077c4a3da9a0752c0edbd3447cc299d715b1a69d40"} 03:28:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:17 INFO - Contents: 03:28:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cb6dc0f0a3c0a5516c507f26bb9c0a94be8b8e2700380bc570405f8575ac6d2e630d674f2f3310ce754f6d9de8a47e52108c28697b12c30ba0989afd21fae36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86ed0faec0e96a41f091328ce51755df4f9e6681f6311e39ef5fdf86f0558be0007db72ebcf2409dc350af870d4c8cbf9cc763aef041c2b1e95c833053ff0270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/133eeab96f22b4dfab77b8585cad82c5b4eafb5231f1b6d5f9430340e89a612d5f9d47a9b9cc2eb42c4638077c4a3da9a0752c0edbd3447cc299d715b1a69d40"} 03:28:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:17 INFO - Copying logs to upload dir... 03:28:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.458833 ========= master_lag: 352.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 50 secs) (at 2016-07-12 03:34:09.720513) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 mins, 43 secs) (at 2016-07-12 03:34:09.723672) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cb6dc0f0a3c0a5516c507f26bb9c0a94be8b8e2700380bc570405f8575ac6d2e630d674f2f3310ce754f6d9de8a47e52108c28697b12c30ba0989afd21fae36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86ed0faec0e96a41f091328ce51755df4f9e6681f6311e39ef5fdf86f0558be0007db72ebcf2409dc350af870d4c8cbf9cc763aef041c2b1e95c833053ff0270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/133eeab96f22b4dfab77b8585cad82c5b4eafb5231f1b6d5f9430340e89a612d5f9d47a9b9cc2eb42c4638077c4a3da9a0752c0edbd3447cc299d715b1a69d40"} build_url:https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/FbdZaKBLToCwp8pPleEENg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cb6dc0f0a3c0a5516c507f26bb9c0a94be8b8e2700380bc570405f8575ac6d2e630d674f2f3310ce754f6d9de8a47e52108c28697b12c30ba0989afd21fae36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86ed0faec0e96a41f091328ce51755df4f9e6681f6311e39ef5fdf86f0558be0007db72ebcf2409dc350af870d4c8cbf9cc763aef041c2b1e95c833053ff0270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/133eeab96f22b4dfab77b8585cad82c5b4eafb5231f1b6d5f9430340e89a612d5f9d47a9b9cc2eb42c4638077c4a3da9a0752c0edbd3447cc299d715b1a69d40"}' ========= master_lag: 223.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 mins, 43 secs) (at 2016-07-12 03:37:53.042498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 mins, 32 secs) (at 2016-07-12 03:37:53.042835) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468317751.526632-1050538650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004741 ========= master_lag: 212.42 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 mins, 32 secs) (at 2016-07-12 03:41:25.471445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 03:41:25.471787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 03:41:25.699631) ========= ========= Total master_lag: 788.44 =========