builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1469119509.53 results: success (0) buildid: 20160721072521 builduid: 0bf7303198af461aba5565ba2dd022dc revision: e28e856b987380f55d699092f11f6997378f79a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.527261) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.528020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.528329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.562810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.563091) ========= 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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 09:45:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-07-21 09:45:10 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.895939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.896492) ========= 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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016635 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.948828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:09.949443) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e28e856b987380f55d699092f11f6997378f79a6 --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 e28e856b987380f55d699092f11f6997378f79a6 --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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 09:45:10,344 truncating revision to first 12 chars 2016-07-21 09:45:10,344 Setting DEBUG logging. 2016-07-21 09:45:10,344 attempt 1/10 2016-07-21 09:45:10,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e28e856b9873?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 09:45:10,668 unpacking tar archive at: mozilla-central-e28e856b9873/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:10.664555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:10.664921) ========= script_repo_revision: e28e856b987380f55d699092f11f6997378f79a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:10.665428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:10.665702) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 09:45:10.677644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-21 09:45:10.678074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:11 INFO - MultiFileLogger online at 20160721 09:45:11 in /builds/slave/test 09:45:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:45:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:11 INFO - {'append_to_log': False, 09:45:11 INFO - 'base_work_dir': '/builds/slave/test', 09:45:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:45:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:11 INFO - 'branch': 'Firefox-Non-PGO', 09:45:11 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:11 INFO - 'config_files': ('talos/linux_config.py',), 09:45:11 INFO - 'default_actions': ('clobber', 09:45:11 INFO - 'read-buildbot-config', 09:45:11 INFO - 'download-and-extract', 09:45:11 INFO - 'populate-webroot', 09:45:11 INFO - 'create-virtualenv', 09:45:11 INFO - 'install', 09:45:11 INFO - 'run-tests'), 09:45:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:11 INFO - 'download_minidump_stackwalk': True, 09:45:11 INFO - 'download_symbols': 'ondemand', 09:45:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:11 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:11 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:11 INFO - 'installer_path': 'installer.exe', 09:45:11 INFO - 'log_level': 'info', 09:45:11 INFO - 'log_name': 'talos', 09:45:11 INFO - 'log_to_console': True, 09:45:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:11 INFO - 'opt_config_files': (), 09:45:11 INFO - 'pip_index': False, 09:45:11 INFO - 'sps_profile': False, 09:45:11 INFO - 'sps_profile_interval': 0, 09:45:11 INFO - 'suite': 'dromaeojs-e10s', 09:45:11 INFO - 'system_bits': '32', 09:45:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:11 INFO - 'title': 'talos-linux64-ix-021', 09:45:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:11 INFO - 'use_talos_json': True, 09:45:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:11 INFO - 'work_dir': 'build'} 09:45:11 INFO - [mozharness: 2016-07-21 16:45:11.162396Z] Running clobber step. 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: clobber 09:45:11 INFO - rmtree: /builds/slave/test/build 09:45:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - [mozharness: 2016-07-21 16:45:11.637821Z] Finished clobber step (success) 09:45:11 INFO - [mozharness: 2016-07-21 16:45:11.637923Z] Running read-buildbot-config step. 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: read_buildbot_config 09:45:11 INFO - Using buildbot properties: 09:45:11 INFO - { 09:45:11 INFO - "project": "", 09:45:11 INFO - "product": "firefox", 09:45:11 INFO - "script_repo_revision": "production", 09:45:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:45:11 INFO - "repository": "", 09:45:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:45:11 INFO - "buildid": "20160721072521", 09:45:11 INFO - "pgo_build": "False", 09:45:11 INFO - "basedir": "/builds/slave/test", 09:45:11 INFO - "buildnumber": 389, 09:45:11 INFO - "slavename": "talos-linux64-ix-021", 09:45:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:45:11 INFO - "platform": "ubuntu64_hw", 09:45:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:45:11 INFO - "branch": "mozilla-central", 09:45:11 INFO - "repo_path": "mozilla-central", 09:45:11 INFO - "revision": "e28e856b987380f55d699092f11f6997378f79a6", 09:45:11 INFO - "stage_platform": "linux64", 09:45:11 INFO - "builduid": "0bf7303198af461aba5565ba2dd022dc", 09:45:11 INFO - "slavebuilddir": "test" 09:45:11 INFO - } 09:45:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - [mozharness: 2016-07-21 16:45:11.640387Z] Finished read-buildbot-config step (success) 09:45:11 INFO - [mozharness: 2016-07-21 16:45:11.640477Z] Running download-and-extract step. 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: download_and_extract 09:45:11 INFO - mkdir: /builds/slave/test/build/tests 09:45:11 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')]} 09:45:11 INFO - https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:45:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:17 INFO - Downloaded 1361 bytes. 09:45:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:17 INFO - Using the following test package requirements: 09:45:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'jsshell-linux-x86_64.zip'], 09:45:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:17 INFO - https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:25 INFO - Downloaded 22729933 bytes. 09:45:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:45:26 INFO - Return code: 0 09:45:26 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 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:26 INFO - https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:27 INFO - Downloaded 22729933 bytes. 09:45:27 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'] 09:45:27 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 09:45:29 INFO - Return code: 0 09:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:29 INFO - https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:30 INFO - Downloaded 14403317 bytes. 09:45:30 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'] 09:45:30 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 09:45:30 INFO - Return code: 0 09:45: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')]} 09:45:30 INFO - https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/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 09:45:31 INFO - Downloaded 57149487 bytes. 09:45:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:31 INFO - mkdir: /builds/slave/test/properties 09:45:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:31 INFO - Contents: 09:45:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:32 INFO - Running post-action listener: _resource_record_post_action 09:45:32 INFO - Running post-action listener: set_extra_try_arguments 09:45:32 INFO - [mozharness: 2016-07-21 16:45:32.712538Z] Finished download-and-extract step (success) 09:45:32 INFO - [mozharness: 2016-07-21 16:45:32.712772Z] Running populate-webroot step. 09:45:32 INFO - Running pre-action listener: _resource_record_pre_action 09:45:32 INFO - Running main action method: populate_webroot 09:45:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:32 INFO - '--tppagecycles', 09:45:32 INFO - '7'], 09:45:32 INFO - 'tests': ['tsvgm']}}, 09:45:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['damp', 'tps']}, 09:45:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'tests': ['damp', 'tps']}, 09:45:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['dromaeo_dom']}, 09:45:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['basic_compositor_video']}, 09:45:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['a11yr', 09:45:32 INFO - 'ts_paint', 09:45:32 INFO - 'tpaint', 09:45:32 INFO - 'sessionrestore', 09:45:32 INFO - 'sessionrestore_no_auto_restore', 09:45:32 INFO - 'tabpaint']}, 09:45:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['tsvgx', 09:45:32 INFO - 'tsvgr_opacity', 09:45:32 INFO - 'tart', 09:45:32 INFO - 'tscrollx', 09:45:32 INFO - 'cart']}, 09:45:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:32 INFO - 'tsvgr_opacity', 09:45:32 INFO - 'tart', 09:45:32 INFO - 'tscrollx', 09:45:32 INFO - 'cart']}, 09:45:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'talos_options': ['--disable-e10s'], 09:45:32 INFO - 'tests': ['tp5o']}, 09:45:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'tests': ['tp5o']}, 09:45:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'talos_options': ['--disable-e10s', 09:45:32 INFO - '--xperf_path', 09:45:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:32 INFO - 'tests': ['tp5n']}, 09:45:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:32 INFO - 'talos_options': ['--xperf_path', 09:45:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:32 INFO - 'tests': ['tp5n']}}, 09:45:32 INFO - 'talos.zip': {'path': '', 09:45:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:32 INFO - Running post-action listener: _resource_record_post_action 09:45:32 INFO - [mozharness: 2016-07-21 16:45:32.734078Z] Finished populate-webroot step (success) 09:45:32 INFO - [mozharness: 2016-07-21 16:45:32.734168Z] Running create-virtualenv step. 09:45:32 INFO - Running pre-action listener: _resource_record_pre_action 09:45:32 INFO - Running main action method: create_virtualenv 09:45:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:32 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 09:45:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:32 INFO - Using real prefix '/usr' 09:45:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:35 INFO - Installing pip.................done. 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:35 INFO - Using env: {'DISPLAY': ':0', 09:45:35 INFO - 'HOME': '/home/cltbld', 09:45:35 INFO - 'LANG': 'en_US.UTF-8', 09:45:35 INFO - 'LANGUAGE': 'en_US:en', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MAIL': '/var/mail/cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SHLVL': '1', 09:45:35 INFO - 'TERM': 'linux', 09:45:35 INFO - 'TMOUT': '86400', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - '_': '/tools/buildbot/bin/python'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 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 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:35 INFO - Using env: {'DISPLAY': ':0', 09:45:35 INFO - 'HOME': '/home/cltbld', 09:45:35 INFO - 'LANG': 'en_US.UTF-8', 09:45:35 INFO - 'LANGUAGE': 'en_US:en', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MAIL': '/var/mail/cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SHLVL': '1', 09:45:35 INFO - 'TERM': 'linux', 09:45:35 INFO - 'TMOUT': '86400', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - '_': '/tools/buildbot/bin/python'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 INFO - Downloading/unpacking psutil>=3.1.1 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:37 INFO - Installing collected packages: psutil 09:45:37 INFO - Running setup.py install for psutil 09:45:37 INFO - building 'psutil._psutil_linux' extension 09:45:37 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 09:45:38 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 09:45:38 INFO - building 'psutil._psutil_posix' extension 09:45:38 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 09:45:38 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 09:45:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:38 INFO - Successfully installed psutil 09:45:38 INFO - Cleaning up... 09:45:38 INFO - Return code: 0 09:45:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:45:38 INFO - Using env: {'DISPLAY': ':0', 09:45:38 INFO - 'HOME': '/home/cltbld', 09:45:38 INFO - 'LANG': 'en_US.UTF-8', 09:45:38 INFO - 'LANGUAGE': 'en_US:en', 09:45:38 INFO - 'LOGNAME': 'cltbld', 09:45:38 INFO - 'MAIL': '/var/mail/cltbld', 09:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:38 INFO - 'MOZ_NO_REMOTE': '1', 09:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:38 INFO - 'NO_EM_RESTART': '1', 09:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:38 INFO - 'PWD': '/builds/slave/test', 09:45:38 INFO - 'SHELL': '/bin/bash', 09:45:38 INFO - 'SHLVL': '1', 09:45:38 INFO - 'TERM': 'linux', 09:45:38 INFO - 'TMOUT': '86400', 09:45:38 INFO - 'USER': 'cltbld', 09:45:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:38 INFO - '_': '/tools/buildbot/bin/python'} 09:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:40 INFO - Installing collected packages: mozsystemmonitor 09:45:40 INFO - Running setup.py install for mozsystemmonitor 09:45:40 INFO - Successfully installed mozsystemmonitor 09:45:40 INFO - Cleaning up... 09:45:40 INFO - Return code: 0 09:45:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:45:40 INFO - Using env: {'DISPLAY': ':0', 09:45:40 INFO - 'HOME': '/home/cltbld', 09:45:40 INFO - 'LANG': 'en_US.UTF-8', 09:45:40 INFO - 'LANGUAGE': 'en_US:en', 09:45:40 INFO - 'LOGNAME': 'cltbld', 09:45:40 INFO - 'MAIL': '/var/mail/cltbld', 09:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:40 INFO - 'MOZ_NO_REMOTE': '1', 09:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:40 INFO - 'NO_EM_RESTART': '1', 09:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:40 INFO - 'PWD': '/builds/slave/test', 09:45:40 INFO - 'SHELL': '/bin/bash', 09:45:40 INFO - 'SHLVL': '1', 09:45:40 INFO - 'TERM': 'linux', 09:45:40 INFO - 'TMOUT': '86400', 09:45:40 INFO - 'USER': 'cltbld', 09:45:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:40 INFO - '_': '/tools/buildbot/bin/python'} 09:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:43 INFO - warning: no files found matching '*.txt' 09:45:43 INFO - no previously-included directories found matching 'build' 09:45:43 INFO - no previously-included directories found matching 'dist' 09:45:43 INFO - no previously-included directories found matching '.git*' 09:45:43 INFO - Installing collected packages: jsonschema, functools32 09:45:43 INFO - Running setup.py install for functools32 09:45:43 INFO - warning: no files found matching '*.txt' 09:45:43 INFO - no previously-included directories found matching 'build' 09:45:43 INFO - no previously-included directories found matching 'dist' 09:45:43 INFO - no previously-included directories found matching '.git*' 09:45:43 INFO - Successfully installed jsonschema functools32 09:45:43 INFO - Cleaning up... 09:45:43 INFO - Return code: 0 09:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:43 INFO - Using env: {'DISPLAY': ':0', 09:45:43 INFO - 'HOME': '/home/cltbld', 09:45:43 INFO - 'LANG': 'en_US.UTF-8', 09:45:43 INFO - 'LANGUAGE': 'en_US:en', 09:45:43 INFO - 'LOGNAME': 'cltbld', 09:45:43 INFO - 'MAIL': '/var/mail/cltbld', 09:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:43 INFO - 'MOZ_NO_REMOTE': '1', 09:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:43 INFO - 'NO_EM_RESTART': '1', 09:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:43 INFO - 'PWD': '/builds/slave/test', 09:45:43 INFO - 'SHELL': '/bin/bash', 09:45:43 INFO - 'SHLVL': '1', 09:45:43 INFO - 'TERM': 'linux', 09:45:43 INFO - 'TMOUT': '86400', 09:45:43 INFO - 'USER': 'cltbld', 09:45:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:43 INFO - '_': '/tools/buildbot/bin/python'} 09:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:46 INFO - Downloading docopt-0.6.1.tar.gz 09:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:46 INFO - Running setup.py install for blobuploader 09:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:46 INFO - Running setup.py install for requests 09:45:46 INFO - Running setup.py install for docopt 09:45:46 INFO - Successfully installed blobuploader requests docopt 09:45:46 INFO - Cleaning up... 09:45:46 INFO - Return code: 0 09:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:46 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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:46 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 09:45:46 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 09:45:46 INFO - Using env: {'DISPLAY': ':0', 09:45:46 INFO - 'HOME': '/home/cltbld', 09:45:46 INFO - 'LANG': 'en_US.UTF-8', 09:45:46 INFO - 'LANGUAGE': 'en_US:en', 09:45:46 INFO - 'LOGNAME': 'cltbld', 09:45:46 INFO - 'MAIL': '/var/mail/cltbld', 09:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:46 INFO - 'MOZ_NO_REMOTE': '1', 09:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:46 INFO - 'NO_EM_RESTART': '1', 09:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:46 INFO - 'PWD': '/builds/slave/test', 09:45:46 INFO - 'SHELL': '/bin/bash', 09:45:46 INFO - 'SHLVL': '1', 09:45:46 INFO - 'TERM': 'linux', 09:45:46 INFO - 'TMOUT': '86400', 09:45:46 INFO - 'USER': 'cltbld', 09:45:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:46 INFO - '_': '/tools/buildbot/bin/python'} 09:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:47 INFO - Running setup.py (path:/tmp/pip-Q4M_kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:47 INFO - Running setup.py (path:/tmp/pip-wWbipK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:47 INFO - Running setup.py (path:/tmp/pip-BgoSve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:47 INFO - Running setup.py (path:/tmp/pip-4lOEeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:47 INFO - Running setup.py (path:/tmp/pip-hEBIvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:47 INFO - Running setup.py (path:/tmp/pip-hKeULf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:47 INFO - Running setup.py (path:/tmp/pip-0e4zbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:47 INFO - Running setup.py (path:/tmp/pip-392FiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:47 INFO - Running setup.py (path:/tmp/pip-S7Zl0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:47 INFO - Running setup.py (path:/tmp/pip-FNcUTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:47 INFO - Running setup.py (path:/tmp/pip-mbAK8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:47 INFO - Running setup.py (path:/tmp/pip-EVQ9Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:47 INFO - Running setup.py (path:/tmp/pip-8GYt44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:48 INFO - Running setup.py (path:/tmp/pip-PwcvwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:48 INFO - Running setup.py (path:/tmp/pip-f0nelq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:48 INFO - Running setup.py (path:/tmp/pip-2xcNL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:48 INFO - Running setup.py (path:/tmp/pip-GnESYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:48 INFO - Running setup.py install for manifestparser 09:45:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:48 INFO - Running setup.py install for mozcrash 09:45:48 INFO - Running setup.py install for mozdebug 09:45:48 INFO - Running setup.py install for mozdevice 09:45:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:48 INFO - Running setup.py install for mozfile 09:45:48 INFO - Running setup.py install for mozhttpd 09:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:48 INFO - Running setup.py install for mozinfo 09:45:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for mozInstall 09:45:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for mozleak 09:45:49 INFO - Running setup.py install for mozlog 09:45:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for moznetwork 09:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for mozprocess 09:45:49 INFO - Running setup.py install for mozprofile 09:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for mozrunner 09:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:49 INFO - Running setup.py install for mozscreenshot 09:45:49 INFO - Running setup.py install for moztest 09:45:50 INFO - Running setup.py install for mozversion 09:45:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:50 INFO - Cleaning up... 09:45:50 INFO - Return code: 0 09:45:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:50 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')]} 09:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 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')]} 09:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:50 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 09:45:50 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 09:45:50 INFO - Using env: {'DISPLAY': ':0', 09:45:50 INFO - 'HOME': '/home/cltbld', 09:45:50 INFO - 'LANG': 'en_US.UTF-8', 09:45:50 INFO - 'LANGUAGE': 'en_US:en', 09:45:50 INFO - 'LOGNAME': 'cltbld', 09:45:50 INFO - 'MAIL': '/var/mail/cltbld', 09:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:50 INFO - 'MOZ_NO_REMOTE': '1', 09:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:50 INFO - 'NO_EM_RESTART': '1', 09:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:50 INFO - 'PWD': '/builds/slave/test', 09:45:50 INFO - 'SHELL': '/bin/bash', 09:45:50 INFO - 'SHLVL': '1', 09:45:50 INFO - 'TERM': 'linux', 09:45:50 INFO - 'TMOUT': '86400', 09:45:50 INFO - 'USER': 'cltbld', 09:45:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:50 INFO - '_': '/tools/buildbot/bin/python'} 09:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:50 INFO - Running setup.py (path:/tmp/pip-JQi6Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:50 INFO - Running setup.py (path:/tmp/pip-RuMSx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:50 INFO - Running setup.py (path:/tmp/pip-d14IgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:50 INFO - Running setup.py (path:/tmp/pip-Q7HMj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:50 INFO - Running setup.py (path:/tmp/pip-JMLbBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:50 INFO - Running setup.py (path:/tmp/pip-P0q7VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:50 INFO - Running setup.py (path:/tmp/pip-6CCBaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:50 INFO - Running setup.py (path:/tmp/pip-BZo2lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:50 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)) 09:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:50 INFO - Running setup.py (path:/tmp/pip-hHyGoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:51 INFO - Running setup.py (path:/tmp/pip-rQgLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:51 INFO - Running setup.py (path:/tmp/pip-byo1av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:51 INFO - Running setup.py (path:/tmp/pip-EPKSxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:51 INFO - Running setup.py (path:/tmp/pip-OzvVfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:51 INFO - Running setup.py (path:/tmp/pip-3Ie9Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:51 INFO - Running setup.py (path:/tmp/pip-e5awhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:51 INFO - Running setup.py (path:/tmp/pip-xgZQ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:51 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)) 09:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:51 INFO - Running setup.py (path:/tmp/pip-riNnaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:51 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)) 09:45:51 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)) 09:45:51 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)) 09:45:51 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)) 09:45:51 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)) 09:45:51 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)) 09:45:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:53 INFO - Downloading blessings-1.6.tar.gz 09:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:53 INFO - Installing collected packages: blessings 09:45:53 INFO - Running setup.py install for blessings 09:45:53 INFO - Successfully installed blessings 09:45:53 INFO - Cleaning up... 09:45:53 INFO - Return code: 0 09:45:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:53 INFO - Reading from file tmpfile_stdout 09:45:53 INFO - Current package versions: 09:45:53 INFO - argparse == 1.2.1 09:45:53 INFO - blessings == 1.6 09:45:53 INFO - blobuploader == 1.2.4 09:45:53 INFO - docopt == 0.6.1 09:45:53 INFO - functools32 == 3.2.3-2 09:45:53 INFO - jsonschema == 2.5.1 09:45:53 INFO - manifestparser == 1.1 09:45:53 INFO - mozInstall == 1.12 09:45:53 INFO - mozcrash == 0.17 09:45:53 INFO - mozdebug == 0.1 09:45:53 INFO - mozdevice == 0.48 09:45:53 INFO - mozfile == 1.2 09:45:53 INFO - mozhttpd == 0.7 09:45:53 INFO - mozinfo == 0.9 09:45:53 INFO - mozleak == 0.1 09:45:53 INFO - mozlog == 3.3 09:45:53 INFO - moznetwork == 0.27 09:45:53 INFO - mozprocess == 0.23 09:45:53 INFO - mozprofile == 0.28 09:45:53 INFO - mozrunner == 6.12 09:45:53 INFO - mozscreenshot == 0.1 09:45:53 INFO - mozsystemmonitor == 0.3 09:45:53 INFO - moztest == 0.7 09:45:53 INFO - mozversion == 1.4 09:45:53 INFO - psutil == 3.1.1 09:45:53 INFO - requests == 1.2.3 09:45:53 INFO - wsgiref == 0.1.2 09:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:53 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')]} 09:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:53 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')]} 09:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:53 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 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45:53 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 09:45:53 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 09:45:53 INFO - Using env: {'DISPLAY': ':0', 09:45:53 INFO - 'HOME': '/home/cltbld', 09:45:53 INFO - 'LANG': 'en_US.UTF-8', 09:45:53 INFO - 'LANGUAGE': 'en_US:en', 09:45:53 INFO - 'LOGNAME': 'cltbld', 09:45:53 INFO - 'MAIL': '/var/mail/cltbld', 09:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:53 INFO - 'MOZ_NO_REMOTE': '1', 09:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:53 INFO - 'NO_EM_RESTART': '1', 09:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:53 INFO - 'PWD': '/builds/slave/test', 09:45:53 INFO - 'SHELL': '/bin/bash', 09:45:53 INFO - 'SHLVL': '1', 09:45:53 INFO - 'TERM': 'linux', 09:45:53 INFO - 'TMOUT': '86400', 09:45:53 INFO - 'USER': 'cltbld', 09:45:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:53 INFO - '_': '/tools/buildbot/bin/python'} 09:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 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)) 09:45:54 INFO - Cleaning up... 09:45:54 INFO - Return code: 0 09:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, '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': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', '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 09:45: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', 'jsonschema'] in /builds/slave/test/build 09:45: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 jsonschema 09:45:54 INFO - Using env: {'DISPLAY': ':0', 09:45:54 INFO - 'HOME': '/home/cltbld', 09:45:54 INFO - 'LANG': 'en_US.UTF-8', 09:45:54 INFO - 'LANGUAGE': 'en_US:en', 09:45:54 INFO - 'LOGNAME': 'cltbld', 09:45:54 INFO - 'MAIL': '/var/mail/cltbld', 09:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:54 INFO - 'MOZ_NO_REMOTE': '1', 09:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:54 INFO - 'NO_EM_RESTART': '1', 09:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:54 INFO - 'PWD': '/builds/slave/test', 09:45:54 INFO - 'SHELL': '/bin/bash', 09:45:54 INFO - 'SHLVL': '1', 09:45:54 INFO - 'TERM': 'linux', 09:45:54 INFO - 'TMOUT': '86400', 09:45:54 INFO - 'USER': 'cltbld', 09:45:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:54 INFO - '_': '/tools/buildbot/bin/python'} 09:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:54 INFO - Cleaning up... 09:45:54 INFO - Return code: 0 09:45:54 INFO - Running post-action listener: _resource_record_post_action 09:45:54 INFO - Running post-action listener: _start_resource_monitoring 09:45:54 INFO - Starting resource monitoring. 09:45:54 INFO - [mozharness: 2016-07-21 16:45:54.447868Z] Finished create-virtualenv step (success) 09:45:54 INFO - [mozharness: 2016-07-21 16:45:54.448297Z] Running install step. 09:45:54 INFO - Running pre-action listener: _resource_record_pre_action 09:45:54 INFO - Running main action method: install 09:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:54 INFO - Reading from file tmpfile_stdout 09:45:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:54 INFO - Reading from file tmpfile_stdout 09:45:54 INFO - Output received: 09:45:54 INFO - Usage: mozinstall [options] installer 09:45:54 INFO - Options: 09:45:54 INFO - -h, --help show this help message and exit 09:45:54 INFO - -d DEST, --destination=DEST 09:45:54 INFO - Directory to install application into. [default: 09:45:54 INFO - "/builds/slave/test"] 09:45:54 INFO - --app=APP Application being installed. [default: firefox] 09:45:54 INFO - mkdir: /builds/slave/test/build/application 09:45:54 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'] 09:45:54 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 09:46:11 INFO - Reading from file tmpfile_stdout 09:46:11 INFO - Output received: 09:46:11 INFO - /builds/slave/test/build/application/firefox/firefox 09:46:11 INFO - Running post-action listener: _resource_record_post_action 09:46:11 INFO - [mozharness: 2016-07-21 16:46:11.269466Z] Finished install step (success) 09:46:11 INFO - [mozharness: 2016-07-21 16:46:11.269751Z] Running run-tests step. 09:46:11 INFO - Running pre-action listener: _resource_record_pre_action 09:46:11 INFO - Running main action method: run_tests 09:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:11 INFO - Python 2.7.3 09:46:11 INFO - Return code: 0 09:46:11 INFO - grabbing minidump binary from tooltool 09:46:11 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')]} 09:46:11 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 0x19ca570>, '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 0x19cb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:11 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 09:46:11 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 09:46:11 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 09:46:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:11 INFO - Return code: 0 09:46:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:46:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:46:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:46:11 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:46:11 INFO - Using env: {'DISPLAY': ':0', 09:46:11 INFO - 'HOME': '/home/cltbld', 09:46:11 INFO - 'LANG': 'en_US.UTF-8', 09:46:11 INFO - 'LANGUAGE': 'en_US:en', 09:46:11 INFO - 'LOGNAME': 'cltbld', 09:46:11 INFO - 'MAIL': '/var/mail/cltbld', 09:46:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:11 INFO - 'MOZ_NO_REMOTE': '1', 09:46:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:11 INFO - 'NO_EM_RESTART': '1', 09:46:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:11 INFO - 'PWD': '/builds/slave/test', 09:46:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:11 INFO - 'SHELL': '/bin/bash', 09:46:11 INFO - 'SHLVL': '1', 09:46:11 INFO - 'TERM': 'linux', 09:46:11 INFO - 'TMOUT': '86400', 09:46:11 INFO - 'USER': 'cltbld', 09:46:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469115307.427345-354849880', 09:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:11 INFO - '_': '/tools/buildbot/bin/python'} 09:46:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:46:11 INFO - mozversion application_buildid: 20160721072521 09:46:11 INFO - mozversion application_changeset: e28e856b987380f55d699092f11f6997378f79a6 09:46:11 INFO - mozversion application_display_name: Nightly 09:46:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:11 INFO - mozversion application_name: Firefox 09:46:11 INFO - mozversion application_remotingname: firefox 09:46:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:46:11 INFO - mozversion application_vendor: Mozilla 09:46:11 INFO - mozversion application_version: 50.0a1 09:46:11 INFO - mozversion platform_buildid: 20160721072521 09:46:11 INFO - mozversion platform_changeset: e28e856b987380f55d699092f11f6997378f79a6 09:46:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:46:11 INFO - mozversion platform_version: 50.0a1 09:46:11 INFO - using testdate: 1469119571 09:46:11 INFO - actual date: 1469119571 09:46:11 INFO - starting webserver on 'localhost:49967' 09:46:11 INFO - SUITE-START | Running 2 tests 09:46:11 INFO - TEST-START | dromaeo_css 09:46:11 INFO - operating with platform_type : linux_ 09:46:11 INFO - Initialising browser for dromaeo_css test... 09:46:11 INFO - TEST-INFO | started process 26166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3xR8QP/profile http://localhost:49967/getInfo.html) 09:46:16 INFO - PROCESS | 26166 | __metrics Screen width/height:1600/1200 09:46:16 INFO - PROCESS | 26166 | colorDepth:24 09:46:16 INFO - PROCESS | 26166 | Browser inner width/height: 1024/697 09:46:16 INFO - PROCESS | 26166 | __metrics 09:46:17 ERROR - PROCESS | 26166 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:46:18 INFO - TEST-INFO | 26166: exit 0 09:46:18 INFO - Browser initialized. 09:46:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:18 INFO - TEST-INFO | started process 26286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3xR8QP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:30 INFO - PROCESS | 26286 | RSS: Main: 168595456 09:46:30 INFO - PROCESS | 26286 | 09:47:19 INFO - PROCESS | 26286 | 1469119639934 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] 09:49:32 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49967/tests/dromaeo/cssquery-ext.html) 09:49:33 INFO - PROCESS | 26286 | RSS: Main: 170405888 09:49:33 INFO - PROCESS | 26286 | 09:52:35 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-ext.html (next: http://localhost:49967/tests/dromaeo/cssquery-jquery.html) 09:52:36 INFO - PROCESS | 26286 | RSS: Main: 170295296 09:52:36 INFO - PROCESS | 26286 | 09:55:38 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49967/tests/dromaeo/cssquery-mootools.html) 09:55:39 INFO - PROCESS | 26286 | RSS: Main: 173854720 09:55:39 INFO - PROCESS | 26286 | 09:58:40 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49967/tests/dromaeo/cssquery-prototype.html) 09:58:41 INFO - PROCESS | 26286 | RSS: Main: 168038400 09:58:41 INFO - PROCESS | 26286 | 10:01:44 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49967/tests/dromaeo/cssquery-yui.html) 10:01:45 INFO - PROCESS | 26286 | RSS: Main: 170475520 10:01:45 INFO - PROCESS | 26286 | 10:04:47 INFO - PROCESS | 26286 | Cycle 1(1): loaded http://localhost:49967/tests/dromaeo/cssquery-yui.html (next: http://localhost:49967/tests/dromaeo/cssquery-dojo.html) 10:04:48 INFO - PROCESS | 26286 | RSS: Main: 171208704 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | __start_tp_report 10:04:48 INFO - PROCESS | 26286 | _x_x_mozilla_page_load 10:04:48 INFO - PROCESS | 26286 | _x_x_mozilla_page_load_details 10:04:48 INFO - PROCESS | 26286 | |i|pagename|runs| 10:04:48 INFO - PROCESS | 26286 | |0;dojo.html;2653.7478939500747;2693.340131667741;2725.4549090181954;2727.8636068196583;2730.6586676665406;4878.75606219689;4887.584555312803;4907.877303067425;4946.851594452172;5018.824341148061;4788.401449818773;4870.196417591093;4889.682170658904;4893.947801222736;4910.288008238803;4475.977620111911;4484.753338566377;4521.570450807168;4607.032523170122;4616.699914505546;4495.100979804036;4611.584957353837;4668.043051174518;4669.463011753641;4672.486026537078;4365.716228445141;4485.618722408599;4527.253003254459;4555.339475776011;4559.954400456019;4447.132809102226;4461.933071003938;4463.397441345442;4477.417935668343;4488.932666010012;4426.889327766831;4456.420665313521;4461.620762235214;4486.416765820422;4512.684112112153;4793.113274044313;4877.561019508261;4899.55903968641;4902.28916807061;4927.77824997876;5166.302549155891;5211.687298762086;5227.8170264040955;5230.973845130788;5278.762455689503;5246.37043554772;5265.894682106375;5270.6574072685535;5281.9207711884355;5314.229436731653;4805.8558243252755;4831.275308703723;4832.226843704991;4923.064617722621;4929.827456039057;5308.734563271898;5339.41266460689;5342.866428339323;5381.0852155133725;5391.838244852661;5080.822171223989;5084.9745751271;5086.135356989321;5086.72023038729;5131.307273518028;5154.484551544815;5180.248863914711;5207.869803254873;5220.791168353299;5230.137027390514;5234.555062819627;5234.92147617786;5247.763850626731;5277.050130976461;5288.81489147878;5217.191335343028;5223.634345595772;5229.189475631283;5241.371035475768;5265.552428043583;4382.627476664456;4468;4489.506154323022;4489.842855500042;4497.370368148397;3905.453236546886;3913.5890731473355;3944.6449819516383;3965.940510892339;3982.980085099556;4437.179121862466;4516.525764794649;4529.954700452953;4533.320001999727;4591.288350305708;5193;5220.7128607926925;5236.1098613235845;5295.761690723926;5374.54316383104;4482.686211965131;4521.299198624219;4525.841595544141;4535.433070866142;4548.545145485425;4762.9523704763205;4764.2615394613895;4783.617310615143;4786.593139583105;4806.8798280043275;4786.880327991828;4922.556969872729;4937.185364414831;4952.777125029383;4978.8755281118265;5323.414424413234;5346.465353464622;5347.518723314764;5397.8380648580605;5420.9186862197885;4976.850694479172;4999.47505511916;5019.698818070928;5027.095122877917;5049.31834202378;5067.569256613229;5198.610104242272;5238.0833354162105;5285.709285989154;5288.259643649815;5330.600204984564;5344.919826202688;5356.223347614497;5363.973180134074;5389.083855744611;5178.844634660966;5191.039657663345;5192.506711862367;5195.064888320138;5212.765425555935;4993.675411098267;5067;5107.361579802525;5196.454372290855;5207.062728708869;5004.924926126038;5031.547160755549;5038.672486288379;5081.77132029067;5102.846914592568;5092.414372347227;5110.131277682877;5174.663646862942;5197.24639927216;5219.582433405394;4859.902801943871;5017.824376146963;5036.521530454601;5054.4187418447345;5073.898522029613 10:04:48 INFO - PROCESS | 26286 | |1;ext.html;551.5890661457215;553.2420583800193;560.6860158311346;561.4890449690782;576.3285772075532;35443.645563544356;39708.2058358833;39709;39751;39853.80073099631;40461.797691011576;41030.17939641205;41033.17933641325;41068.58931410685;41076.79461602688;7792.610369481517;7949.483283586577;7949.562774047425;7975.521468711867;8000.919990800105;7938.960305198466;7971.840563188733;8000.719974800854;8018.478798878084;8045;7983.401244906655;8026.317762990153;8031.156728543507;8050.51696898185;8064.27421532062;7999.36005119589;8027.839443211162;8029.357651387875;8046.517208967452;8051.51690898548;7912.367010639193;7919.208079192093;7959.840803183962;7972.3622110231045;7987.8402431951035;38299.23401531982;38564.421533677014;39055.414168787494;39106;39254.803725981474;2259.762724913893;2827.6465441819773;2840.7869409794143;2849.316164120596;2899.608552845381;26495.47009059808;28750.424991500262;29180.562291565642;30112.247193820112;30152.19480138005;3251.398491279121;3268.8855890043974;3307.7684562080663;3317.4526203176447;3368.8315584220936;263866;265251;266558;267037;267117;56300;56747;56785;56889.14666280009;56893.71553142291;33299.667003329654;34538.309233815184;34739;59663.70168149218;59810.401895981355;13619.18284902909;13974.231417272147;13979.580612581638;14000.719985600232;14035.438582456587;9705.417674939526;9819.410835349901;9828.262880284008;9856.605735770489;9920.206383489303;18706.906465467586;18716.81283187178;18742.906285468485;18758.718619220723;18851.81148188528;6636.601803891782;6851.897221541681;6914.135733033371;6964.895526567106;7014.298570142945;753.393518217829;766.8159641686067;836.6026137584598;874.6384761144934;958.4536814015944;26901.461970760476;28447.28881777972;28451.71548284532;28866;29065.7093429063;862.3704695572142;979.8530220466845;999.1257649556638;1038.2109596706407;1096.7477480179602;14680.265986700835;15273.923630381776;15284.541463756104;15350.616234594001;15654.295556699975;408167;411288;412349;415227;415479;51357;51372.22941655878;51556.22665660018;51885.481145188816;52027.219591706154;1153.5270539078938;1165.5221359242669;1184.650528094197;1184.9526018959318;1198.5146015863588;27230.72769272282;27730;28311.858440707663;28698.713012869604;29052.418951621272;43679.78160109179;44225;44501.33248001218;44583.33125003063;44660.55339446564;362922;364173;364902;365065;365745;26126.73873261243;26199.607005894544;26233.737662623895;26267.60598591061;26415.735842641327;42591.7870410646;43712;43909.341359878985;44193.55806441895;44504.33243501415;36460;36888.26223475569;37082.814585927976;37222.44166337453;37825.432618510196;36879.9107696121;37186.07034824151;37416.62583374132;37512.2497550042;38224.617753823215;36043.639563604025;36490.452643210905;37060.44409333916;37260.44109338308;37614.811925940194;31866.522002170448;33392.49911251382;33815.154621134665;34114.31771364609;34309.31381372408;25798.87100564485;26039.73960260373;26055.869720651277;26109.73890261149;26150.607740884283 10:04:48 INFO - PROCESS | 26286 | |2;jquery.html;361.5137639874368;363.17015619309876;367.6268587383806;373.76452834714127;379.22637818849546;16044.598885027866;16735.16324183789;17105.657886842288;17236.052017139053;17267.39564115256;14893.702125957501;17141.74287385687;17613.647727045452;17802.19890104945;17837.554061148447;5110.948890511085;5299.49654782795;5339.038972984861;5340.412554618989;5358.410574836765;3818.77087374757;5274.103402421579;5963.701814909259;6207.255129384457;6265.5614107012525;6286.7170977305905;6299.77950771723;6329.019002054666;6337.936620633804;6355.078513615523;6242.594231374969;6253.062040693887;6256.468200202989;6286.779962701284;6306.653134077624;5418.91871621926;5459.317585301837;5510.283663123809;5533.253010843525;5539.944600554023;20292.695609565722;20341.898290508452;20763.273285435087;20882.895585521976;20896.686549701768;1772.831580999803;1900.4203717866046;1925.5763731979082;2150.40863762465;2336.8130549555995;12980.805287920688;12997.350132493431;13311.467541298336;13347.532836350681;13511.932440337736;1730.7230843065174;1753.6142048749255;1758.8768786184971;1795.4882858385429;1802.4142153800067;68886.65556672185;68895.65552172207;69180.30819691789;69906.1551614661;70312.648436758;9267.860982085274;9323.766905827408;9338.533073346305;9408.059194080673;9555.331126821056;13093.018023648265;13106.80339794904;13121.147125436815;13153.802692959613;13158.407871645799;6728.764493242713;6947.930520694728;7034.859302813915;7050.541714788523;7072.611006394698;6478.449331806755;6484.1894763154605;6501.1548498694865;6673.733050677918;6678.33216678338;5840.386759390288;5936.554758393051;6020.488258498077;6027;6032.819015429544;1624.1716724470368;1692.1454665393896;1758.5955230297104;1779.359430604981;1804.4857215693464;818.5620692929255;924.2421214604094;933.6498812945146;951.6811868024151;985.3989066669326;16762.91618541924;17609.29562817473;17637.7354339685;17923.551911202325;17932.282708691768;806.3186607316808;851.2721623012235;892.9687460938966;897.8922529296526;912.1243606138049;9866.605335786488;10092.587037814712;10199.54102065409;10250.794984100425;10276.743081423025;394057;399559;400702;400804;401551;42765;48606.75696621494;68946.65526672335;69785.65107174533;72293;905.0090151284202;911.1935936696071;927.4110939553298;936.8688383626297;941.1529623338913;15368.308426121075;15494.5351639451;16079;16234.594135146715;16288.348466061225;34756.79424428812;34948;35099.473507897914;35284.661621103216;36149.457758133125;46093.53906460892;46656;46763.766181170235;48090.27864581964;49287.50712492829;7442.96278518604;7482.551046937201;7802.102758182881;7872.291493765589;8106.47307924983;10586.576536938435;11944.64166075019;12198.512059517874;12473.750524989267;12604.30676312775;10193.796124077626;10469.633562825264;10730.624428144978;10742.24804263694;10906.236563440483;10671.626493072705;10675.94662026716;10733.14134869193;10821.621243256448;10993.353156382063;10093;10156.949215253877;10718.410487423267;10840.132789376674;10896.291741036806;6508.511861610304;7040.683169257498;7648.388128949782;7720.498167619086;8120.512769233865;9446.38598491096;9990.150837178631;10580.100691441314;10722.249442538947;10986.725331866768 10:04:48 INFO - PROCESS | 26286 | |3;mootools.html;1366.200772548059;1407.9859201407985;1492.3881208704427;1694.881358304919;1724.6981778188813;6945.652717364124;7620.65707043183;7714.6142692865415;8036.116027236999;8186.386021048423;7823.647935842887;7911.8417631647335;7918.722844700436;7939.682412703485;7987.041555013407;2172.565486902618;2190.9452263693374;2205.900734466945;2209.1053123485012;2209.414505156127;2133.232036466871;2152.9031193596325;2171.7502487214015;2174.510735084609;2179.0521123311332;2077.3871707846147;2110.873347599149;2117.9682304765442;2119.8304135669187;2149.7097891784642;2101.3800928726064;2106.199644135234;2111.6199084164846;2113.123053932616;2120.6182887080395;2078.314156328408;2130.797574230461;2136.9572608547896;2139.1816955587783;2152.655575107991;8002.599870006535;8028.317593004602;8028.678852845879;8052.396070294692;8059.758207253733;4478.93281600773;4514.548545145492;4591.081783643252;4609.608183304423;4626.306054091913;2811.1988083396336;2865.9713402866123;2901.434220327037;2909.345397285615;2912.9126126216247;870.5647176411794;907.9591418386123;919.8482250428672;921.5484412637826;923.6397804856111;10764.515596798163;10778.838317425245;10881.12950963921;10982.06652434544;10990.780184396348;3827.732058755916;3980.840766369313;4080.326746086922;4106.91786164281;4140.006398464347;8593.355498337525;8631.56842157902;8647.697330593399;8650.697225597074;8664.220220180214;4632.606228470618;4637;4639.652026098056;4645.86062418128;4652.95347046532;3553.6979356754964;4056.776877271778;4131.50421949368;4309.719868208619;4318.157959197989;3459.39460594395;3468.3063387322636;3567.6075631680496;3572.517710109102;3644.562652481666;1011.7318910488726;1014.5688082565028;1015.9644412445676;1036.4662198967537;1044.2481413382352;627.6234259444388;758.8178837079062;785.8664027115404;790.7667238164755;795.3954994204446;5163.4062082860955;5259;5279.868003299948;5339.893202135935;5502.834914952477;403.3063131414022;414.53364964415033;421.9261629214875;424.90227247732577;425.16455165599746;3457.619661837196;3584.3368976738866;3594.101474631342;3595.1371670799344;3662.6520480554304;9252.028537003518;9676;9763.316567840326;9802.117809397188;9806.803863922823;9619;9657.806843863083;9688.224942004623;9736.367136136128;9747.56135973883;7376.409887209011;7382.892566115126;7430.4798664093;7459.142198647225;7487.812804679927;5103.974480127576;5204.245384419162;5264.894372181885;5339.065663508948;5355.169948657965;8932.955335223282;8961.462312261025;9018.143276388733;9026.593803278736;9073.364864459689;8997;9000.009998899985;9047.411918225294;9101.089891010846;9209.125133112344;5615.522680572034;6244.625322480666;6314.368563143649;6364.64994425311;6378.266499352449;7772.922270777446;7799.5320280783335;7815.29662330393;7843.058832939855;7858.764237072897;6805.625690587065;6986.825329366807;6987.965060174666;7000.264972177848;7118.857622847618;6838.863222735418;6858.4856135791015;6918.342757438036;6932.757353492603;6950.826229344307;6254.8123556293385;6338.683065846597;6356.841078972878;6547.181602299713;6626.966865165643;4367.126574685012;4369.825206991684;4390.23170945077;4451.08752705701;4512.729236245836;4386.166628340605;4460.531644177315;4506.977465112785;4522.547745225451;4559.316102584638 10:04:48 INFO - PROCESS | 26286 | |4;prototype.html;298.3719270934681;302.1389041232488;310.9160526657802;311.3042350346973;311.33374578402226;4915.852524424273;5035.571976382012;5152.536271735547;5216.4611439625305;5246.868828279295;5036.294918711384;5059.494050594939;5081.1108056090225;5085.694858308504;5088.2622019807195;4028.5367182773916;4035.3745169498775;4050.7974601269966;4051.392291156321;4072.5927407259333;3985.9003524911964;4051.392291156321;4074.8981275468204;4085.9795701021603;4088.36630322299;3979.582143874895;3982.064214909494;3989.700772442064;3997.2605068062503;4026.5570787213383;3990.6009399059863;3991.1618560102415;3996.7002474814503;4001.819918103707;4035.4955630546183;3565.5008298838184;3571.1250743567994;3572.8570857165682;3576.3204991051616;3581.4985901973746;4844.733539655353;4958.859462323686;5004.649674522785;5064.772085256172;5073.7209453480045;4582.1064892346;4591.357209990604;4611.423572053493;4617.099665565216;4641.86074417768;5377.650452720561;5386.195624465809;5416.295881535375;5435.157550579666;5441.483059109379;3611.3319035978166;3778.5087938568086;3782.8865134046023;3791.4502397152532;3922.372420412749;5608.270924779793;5660.122680984454;5674.773009079632;5703.230063941398;5704.4865962063195;3912.9608703912595;3913.354296541039;3919.6668283195677;3925.9607403926166;3926.1755031443145;3843.615638436134;3906.257811015898;3947.605239476087;3965.345717956505;3966.2464131814863;4490.238503320435;4503.594676479132;4517.977410112929;4518.322251662277;4533.5013148553635;5376;5455.290812194389;5463.644863083887;5470.2375300473;5471.288732464834;1286.9704236610862;1355.335885416139;1365.0581099041628;1374.6632075141654;1391.8329800423812;878.4114643189079;880.5465185429509;901.2249465459699;912.183595681861;919.3886065766325;4056.1887622475624;4112.321466957978;4114.300568903293;4117.402976568381;4174.603412675791;4814;4844.975775121173;4894.290327902506;4916.72957987307;4922.843131864009;4154.356074808409;4165.250254954077;4170.020045289354;4182.456280683492;4187.178577318815;2626.7898568114506;2740.945181096367;2966.8516574171204;2977.35986762847;2982.64208295006;5224.007438586732;5226.137687281632;5226.686398816083;5240.423553409122;5260.71066091361;5449.6730196188355;5715.228444160069;5725.341585717612;5753.453421924911;5768.423157684198;5217.921731174036;5230.660007099526;5233.4243233244315;5248.9737551312;5277.815276465305;5643.746031428677;5647.830565083054;5682.66457382523;5684.186327767781;5695.487406133468;5294.470552944675;5487;5548.029094908295;5553.278073850373;5555.722213889208;5260.500252476008;5270.973645131749;5293.867653308698;5317.627766056339;5350;3952.6442620163175;3960.6237407446247;3961.3859851723028;3966.6826653868197;3971.046948732341;5281.207818827206;5560.777568897199;5608.158776183605;5634.32388113429;5714.828555143353;5256.500632439912;5354.143337066051;5366;5408.810691625774;5410.59420543453;5418.83743487696;5430.42980487059;5439.37447193562;5439.728013599225;5506.284183056177;5152.742362881916;5258.421573626822;5292.867678308073;5353.946460535345;5364.8122315718765;5394.433584473731;5402.432744561765;5447.291852059207;5448.882978989219;5500.22996780443;5287.89424211506;5358.517733404013;5359.437259087739;5359.732013399393;5385.784568617211 10:04:48 INFO - PROCESS | 26286 | |5;yui.html;624.7938180400469;707.6102791790137;732.2933369298628;742.7363286033461;750.1635676221015;12972.870271297284;13837.100588461743;14271.714565708693;14282.714345713093;14524.854751452482;13269.601911942633;13500.864991350083;13517.932410337935;13536.661583460418;13559.186448813054;614.5820841827556;769.054063501893;781.7029528779084;784.0826233307045;785.6189747972229;765.4756491803132;791.2245998921061;794.5987276425398;796.6494742313364;797.3063434811722;844.3540691371106;847.2544161138189;848.0840692052599;848.5757121439281;848.8641817309232;838.1283465196188;838.4424357802054;839.345310657688;841.2092632925031;841.7474757572704;611.1535523300261;614.3549273263101;614.7264467312048;616.4759954039076;617.1421723803916;12865.67835804103;12890.291033993126;12908.35458227085;12935.353232338439;13013.154144980641;12982.545610903668;13029.413676384585;13488.662783430394;13501.527446539421;13661.658458538517;9931.453770042644;9983.151432128278;10037;10175.287729858914;10495.370277783357;3198.7441004719567;3237;3253.137918451612;3267.39553182662;3292.341531693647;62189.68905155445;64531.35468645301;64540;64691.35308646948;66130.33869661338;10422.114120299708;10612.946935265429;10693.83959240612;10801.351918884891;10892;19699.21203151858;19852.205911763656;19896.70154947677;19964.201431942558;20054.59890802176;6741.325867413219;6873.243943166248;6931.272216417204;6940.757073502504;7096.680649370791;3630.274214287865;3671.30245253401;3746.587875333711;3809.7714137151306;3861.0540417597867;2799.6640403151346;2869.038871977869;2876.180288617734;2888.7111288870947;2895.1169893182782;462.4335189392967;535.7803300646716;543.5868739757813;553.1205383440349;564.1509528160093;502.1513641945101;560.7588736843196;570.1817891325878;586.9661622478134;603.0441749826487;7105.857882842314;7273.199948005715;7447.329740323397;7521.210272921265;7527.623618819037;507.88559208767356;568.2499101186394;580.6022874331097;591.5326891755465;599.4784537452445;3344;3512.7541072124704;3554.306910152547;3566.32239874423;3607.2424790793702;102655.48672256591;104867.47566262273;105467.47266263772;105849;109624;54503;78554;93294;95912;96087;76665.61667191629;77427;78428.60785696149;78580;78770.6061469689;6688.5747190342545;7014.929850701427;7141.321574450419;7151.106111736033;7348.853022939405;48035.75982120067;48833;49617.255741164634;49658.751706242685;50195.247071293226;64339.356606433335;68920.31079689138;71876.64061679658;72870;73615;9316.581664386118;10000.44997525114;10049.346792458467;10107.39355638664;10149.289549731448;10742.570297188338;11028.44857757125;11029.558817647205;11095.778084438105;11176.969510592258;9893.406395615999;9929.702108936743;10326.845097323396;10471.3193642413;10483.47582620881;10087.193024558164;10100.141487973604;10200.132988695746;10564.630237941636;10846.891531084588;10198.33710808795;10397;10592.841107383549;10695.732606684895;10842.891571084188;8408.990921089508;8502.404831661725;8670.653173872974;8755.693550725695;8948.86576701363;8465.534395608302;8639.352048596505;8646.178613031752;8726.607302671522;9053 10:04:48 INFO - PROCESS | 26286 | __end_tp_report 10:04:48 INFO - PROCESS | 26286 | __start_cc_report 10:04:48 INFO - PROCESS | 26286 | _x_x_mozilla_cycle_collect,398 10:04:48 INFO - PROCESS | 26286 | __end_cc_report 10:04:48 INFO - PROCESS | 26286 | __startTimestamp1469120688023__endTimestamp 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | ------- Summary: start ------- 10:04:48 INFO - PROCESS | 26286 | Number of tests: 6 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#0] dojo.html Cycles:165 Average:4860.01 Median:4999.48 stddev:515.02 (10.3%) stddev-sans-first:486.66 10:04:48 INFO - PROCESS | 26286 | Values: 2653.7 2693.3 2725.5 2727.9 2730.7 4878.8 4887.6 4907.9 4946.9 5018.8 4788.4 4870.2 4889.7 4893.9 4910.3 4476.0 4484.8 4521.6 4607.0 4616.7 4495.1 4611.6 4668.0 4669.5 4672.5 4365.7 4485.6 4527.3 4555.3 4560.0 4447.1 4461.9 4463.4 4477.4 4488.9 4426.9 4456.4 4461.6 4486.4 4512.7 4793.1 4877.6 4899.6 4902.3 4927.8 5166.3 5211.7 5227.8 5231.0 5278.8 5246.4 5265.9 5270.7 5281.9 5314.2 4805.9 4831.3 4832.2 4923.1 4929.8 5308.7 5339.4 5342.9 5381.1 5391.8 5080.8 5085.0 5086.1 5086.7 5131.3 5154.5 5180.2 5207.9 5220.8 5230.1 5234.6 5234.9 5247.8 5277.1 5288.8 5217.2 5223.6 5229.2 5241.4 5265.6 4382.6 4468.0 4489.5 4489.8 4497.4 3905.5 3913.6 3944.6 3965.9 3983.0 4437.2 4516.5 4530.0 4533.3 4591.3 5193.0 5220.7 5236.1 5295.8 5374.5 4482.7 4521.3 4525.8 4535.4 4548.5 4763.0 4764.3 4783.6 4786.6 4806.9 4786.9 4922.6 4937.2 4952.8 4978.9 5323.4 5346.5 5347.5 5397.8 5420.9 4976.9 4999.5 5019.7 5027.1 5049.3 5067.6 5198.6 5238.1 5285.7 5288.3 5330.6 5344.9 5356.2 5364.0 5389.1 5178.8 5191.0 5192.5 5195.1 5212.8 4993.7 5067.0 5107.4 5196.5 5207.1 5004.9 5031.5 5038.7 5081.8 5102.8 5092.4 5110.1 5174.7 5197.2 5219.6 4859.9 5017.8 5036.5 5054.4 5073.9 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#1] ext.html Cycles:180 Average:49985.52 Median:38261.93 stddev:93173.67 (243.5%) stddev-sans-first:93361.12 10:04:48 INFO - PROCESS | 26286 | Values: 551.6 553.2 560.7 561.5 576.3 35443.6 39708.2 39709.0 39751.0 39853.8 40461.8 41030.2 41033.2 41068.6 41076.8 7792.6 7949.5 7949.6 7975.5 8000.9 7939.0 7971.8 8000.7 8018.5 8045.0 7983.4 8026.3 8031.2 8050.5 8064.3 7999.4 8027.8 8029.4 8046.5 8051.5 7912.4 7919.2 7959.8 7972.4 7987.8 38299.2 38564.4 39055.4 39106.0 39254.8 2259.8 2827.6 2840.8 2849.3 2899.6 26495.5 28750.4 29180.6 30112.2 30152.2 3251.4 3268.9 3307.8 3317.5 3368.8 263866.0 265251.0 266558.0 267037.0 267117.0 56300.0 56747.0 56785.0 56889.1 56893.7 33299.7 34538.3 34739.0 59663.7 59810.4 13619.2 13974.2 13979.6 14000.7 14035.4 9705.4 9819.4 9828.3 9856.6 9920.2 18706.9 18716.8 18742.9 18758.7 18851.8 6636.6 6851.9 6914.1 6964.9 7014.3 753.4 766.8 836.6 874.6 958.5 26901.5 28447.3 28451.7 28866.0 29065.7 862.4 979.9 999.1 1038.2 1096.7 14680.3 15273.9 15284.5 15350.6 15654.3 408167.0 411288.0 412349.0 415227.0 415479.0 51357.0 51372.2 51556.2 51885.5 52027.2 1153.5 1165.5 1184.7 1185.0 1198.5 27230.7 27730.0 28311.9 28698.7 29052.4 43679.8 44225.0 44501.3 44583.3 44660.6 362922.0 364173.0 364902.0 365065.0 365745.0 26126.7 26199.6 26233.7 26267.6 26415.7 42591.8 43712.0 43909.3 44193.6 44504.3 36460.0 36888.3 37082.8 37222.4 37825.4 36879.9 37186.1 37416.6 37512.2 38224.6 36043.6 36490.5 37060.4 37260.4 37614.8 31866.5 33392.5 33815.2 34114.3 34309.3 25798.9 26039.7 26055.9 26109.7 26150.6 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#2] jquery.html Cycles:180 Average:24226.55 Median:400753.00 stddev:65498.25 (16.3%) stddev-sans-first:65657.48 10:04:48 INFO - PROCESS | 26286 | Values: 361.5 363.2 367.6 373.8 379.2 16044.6 16735.2 17105.7 17236.1 17267.4 14893.7 17141.7 17613.6 17802.2 17837.6 5110.9 5299.5 5339.0 5340.4 5358.4 3818.8 5274.1 5963.7 6207.3 6265.6 6286.7 6299.8 6329.0 6337.9 6355.1 6242.6 6253.1 6256.5 6286.8 6306.7 5418.9 5459.3 5510.3 5533.3 5539.9 20292.7 20341.9 20763.3 20882.9 20896.7 1772.8 1900.4 1925.6 2150.4 2336.8 12980.8 12997.4 13311.5 13347.5 13511.9 1730.7 1753.6 1758.9 1795.5 1802.4 68886.7 68895.7 69180.3 69906.2 70312.6 9267.9 9323.8 9338.5 9408.1 9555.3 13093.0 13106.8 13121.1 13153.8 13158.4 6728.8 6947.9 7034.9 7050.5 7072.6 6478.4 6484.2 6501.2 6673.7 6678.3 5840.4 5936.6 6020.5 6027.0 6032.8 1624.2 1692.1 1758.6 1779.4 1804.5 818.6 924.2 933.6 951.7 985.4 16762.9 17609.3 17637.7 17923.6 17932.3 806.3 851.3 893.0 897.9 912.1 9866.6 10092.6 10199.5 10250.8 10276.7 394057.0 399559.0 400702.0 400804.0 401551.0 42765.0 48606.8 68946.7 69785.7 72293.0 905.0 911.2 927.4 936.9 941.2 15368.3 15494.5 16079.0 16234.6 16288.3 34756.8 34948.0 35099.5 35284.7 36149.5 46093.5 46656.0 46763.8 48090.3 49287.5 7443.0 7482.6 7802.1 7872.3 8106.5 10586.6 11944.6 12198.5 12473.8 12604.3 10193.8 10469.6 10730.6 10742.2 10906.2 10671.6 10675.9 10733.1 10821.6 10993.4 10093.0 10156.9 10718.4 10840.1 10896.3 6508.5 7040.7 7648.4 7720.5 8120.5 9446.4 9990.2 10580.1 10722.2 10986.7 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#3] mootools.html Cycles:180 Average:5123.73 Median:5133.69 stddev:2941.73 (57.3%) stddev-sans-first:2936.43 10:04:48 INFO - PROCESS | 26286 | Values: 1366.2 1408.0 1492.4 1694.9 1724.7 6945.7 7620.7 7714.6 8036.1 8186.4 7823.6 7911.8 7918.7 7939.7 7987.0 2172.6 2190.9 2205.9 2209.1 2209.4 2133.2 2152.9 2171.8 2174.5 2179.1 2077.4 2110.9 2118.0 2119.8 2149.7 2101.4 2106.2 2111.6 2113.1 2120.6 2078.3 2130.8 2137.0 2139.2 2152.7 8002.6 8028.3 8028.7 8052.4 8059.8 4478.9 4514.5 4591.1 4609.6 4626.3 2811.2 2866.0 2901.4 2909.3 2912.9 870.6 908.0 919.8 921.5 923.6 10764.5 10778.8 10881.1 10982.1 10990.8 3827.7 3980.8 4080.3 4106.9 4140.0 8593.4 8631.6 8647.7 8650.7 8664.2 4632.6 4637.0 4639.7 4645.9 4653.0 3553.7 4056.8 4131.5 4309.7 4318.2 3459.4 3468.3 3567.6 3572.5 3644.6 1011.7 1014.6 1016.0 1036.5 1044.2 627.6 758.8 785.9 790.8 795.4 5163.4 5259.0 5279.9 5339.9 5502.8 403.3 414.5 421.9 424.9 425.2 3457.6 3584.3 3594.1 3595.1 3662.7 9252.0 9676.0 9763.3 9802.1 9806.8 9619.0 9657.8 9688.2 9736.4 9747.6 7376.4 7382.9 7430.5 7459.1 7487.8 5104.0 5204.2 5264.9 5339.1 5355.2 8933.0 8961.5 9018.1 9026.6 9073.4 8997.0 9000.0 9047.4 9101.1 9209.1 5615.5 6244.6 6314.4 6364.6 6378.3 7772.9 7799.5 7815.3 7843.1 7858.8 6805.6 6986.8 6988.0 7000.3 7118.9 6838.9 6858.5 6918.3 6932.8 6950.8 6254.8 6338.7 6356.8 6547.2 6627.0 4367.1 4369.8 4390.2 4451.1 4512.7 4386.2 4460.5 4507.0 4522.5 4559.3 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#4] prototype.html Cycles:180 Average:4436.83 Median:5047.89 stddev:1308.15 (25.9%) stddev-sans-first:1274.41 10:04:48 INFO - PROCESS | 26286 | Values: 298.4 302.1 310.9 311.3 311.3 4915.9 5035.6 5152.5 5216.5 5246.9 5036.3 5059.5 5081.1 5085.7 5088.3 4028.5 4035.4 4050.8 4051.4 4072.6 3985.9 4051.4 4074.9 4086.0 4088.4 3979.6 3982.1 3989.7 3997.3 4026.6 3990.6 3991.2 3996.7 4001.8 4035.5 3565.5 3571.1 3572.9 3576.3 3581.5 4844.7 4958.9 5004.6 5064.8 5073.7 4582.1 4591.4 4611.4 4617.1 4641.9 5377.7 5386.2 5416.3 5435.2 5441.5 3611.3 3778.5 3782.9 3791.5 3922.4 5608.3 5660.1 5674.8 5703.2 5704.5 3913.0 3913.4 3919.7 3926.0 3926.2 3843.6 3906.3 3947.6 3965.3 3966.2 4490.2 4503.6 4518.0 4518.3 4533.5 5376.0 5455.3 5463.6 5470.2 5471.3 1287.0 1355.3 1365.1 1374.7 1391.8 878.4 880.5 901.2 912.2 919.4 4056.2 4112.3 4114.3 4117.4 4174.6 4814.0 4845.0 4894.3 4916.7 4922.8 4154.4 4165.3 4170.0 4182.5 4187.2 2626.8 2740.9 2966.9 2977.4 2982.6 5224.0 5226.1 5226.7 5240.4 5260.7 5449.7 5715.2 5725.3 5753.5 5768.4 5217.9 5230.7 5233.4 5249.0 5277.8 5643.7 5647.8 5682.7 5684.2 5695.5 5294.5 5487.0 5548.0 5553.3 5555.7 5260.5 5271.0 5293.9 5317.6 5350.0 3952.6 3960.6 3961.4 3966.7 3971.0 5281.2 5560.8 5608.2 5634.3 5714.8 5256.5 5354.1 5366.0 5408.8 5410.6 5418.8 5430.4 5439.4 5439.7 5506.3 5152.7 5258.4 5292.9 5353.9 5364.8 5394.4 5402.4 5447.3 5448.9 5500.2 5287.9 5358.5 5359.4 5359.7 5385.8 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - PROCESS | 26286 | [#5] yui.html Cycles:180 Average:18226.09 Median:27528.06 stddev:27114.33 (98.5%) stddev-sans-first:27158.18 10:04:48 INFO - PROCESS | 26286 | Values: 624.8 707.6 732.3 742.7 750.2 12972.9 13837.1 14271.7 14282.7 14524.9 13269.6 13500.9 13517.9 13536.7 13559.2 614.6 769.1 781.7 784.1 785.6 765.5 791.2 794.6 796.6 797.3 844.4 847.3 848.1 848.6 848.9 838.1 838.4 839.3 841.2 841.7 611.2 614.4 614.7 616.5 617.1 12865.7 12890.3 12908.4 12935.4 13013.2 12982.5 13029.4 13488.7 13501.5 13661.7 9931.5 9983.2 10037.0 10175.3 10495.4 3198.7 3237.0 3253.1 3267.4 3292.3 62189.7 64531.4 64540.0 64691.4 66130.3 10422.1 10612.9 10693.8 10801.4 10892.0 19699.2 19852.2 19896.7 19964.2 20054.6 6741.3 6873.2 6931.3 6940.8 7096.7 3630.3 3671.3 3746.6 3809.8 3861.1 2799.7 2869.0 2876.2 2888.7 2895.1 462.4 535.8 543.6 553.1 564.2 502.2 560.8 570.2 587.0 603.0 7105.9 7273.2 7447.3 7521.2 7527.6 507.9 568.2 580.6 591.5 599.5 3344.0 3512.8 3554.3 3566.3 3607.2 102655.5 104867.5 105467.5 105849.0 109624.0 54503.0 78554.0 93294.0 95912.0 96087.0 76665.6 77427.0 78428.6 78580.0 78770.6 6688.6 7014.9 7141.3 7151.1 7348.9 48035.8 48833.0 49617.3 49658.8 50195.2 64339.4 68920.3 71876.6 72870.0 73615.0 9316.6 10000.4 10049.3 10107.4 10149.3 10742.6 11028.4 11029.6 11095.8 11177.0 9893.4 9929.7 10326.8 10471.3 10483.5 10087.2 10100.1 10200.1 10564.6 10846.9 10198.3 10397.0 10592.8 10695.7 10842.9 8409.0 8502.4 8670.7 8755.7 8948.9 8465.5 8639.4 8646.2 8726.6 9053.0 10:04:48 INFO - PROCESS | 26286 | -------- Summary: end -------- 10:04:48 INFO - PROCESS | 26286 | 10:04:48 INFO - TEST-INFO | 26286: exit 0 10:04:48 INFO - TEST-OK | dromaeo_css | took 1117230ms 10:04:48 INFO - TEST-START | kraken 10:04:48 INFO - operating with platform_type : linux_ 10:04:48 INFO - Initialising browser for kraken test... 10:04:48 INFO - TEST-INFO | started process 26532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8pQmk/profile http://localhost:49967/getInfo.html) 10:04:53 INFO - PROCESS | 26532 | __metrics Screen width/height:1600/1200 10:04:53 INFO - PROCESS | 26532 | colorDepth:24 10:04:53 INFO - PROCESS | 26532 | Browser inner width/height: 1024/697 10:04:53 INFO - PROCESS | 26532 | __metrics 10:04:54 ERROR - PROCESS | 26532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:04:55 INFO - TEST-INFO | 26532: exit 0 10:04:55 INFO - Browser initialized. 10:04:55 INFO - Running cycle 1/1 for kraken test... 10:04:55 INFO - TEST-INFO | started process 26653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8pQmk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:07 INFO - PROCESS | 26653 | RSS: Main: 168849408 10:05:07 INFO - PROCESS | 26653 | 10:05:10 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49967/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:11 INFO - PROCESS | 26653 | RSS: Main: 174260224 10:05:11 INFO - PROCESS | 26653 | 10:05:13 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49967/tests/kraken/driver.html?testName=audio-dft) 10:05:14 INFO - PROCESS | 26653 | RSS: Main: 172929024 10:05:14 INFO - PROCESS | 26653 | 10:05:17 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49967/tests/kraken/driver.html?testName=audio-fft) 10:05:18 INFO - PROCESS | 26653 | RSS: Main: 169439232 10:05:18 INFO - PROCESS | 26653 | 10:05:20 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49967/tests/kraken/driver.html?testName=audio-oscillator) 10:05:20 INFO - PROCESS | 26653 | RSS: Main: 169906176 10:05:20 INFO - PROCESS | 26653 | 10:05:23 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:23 INFO - PROCESS | 26653 | RSS: Main: 169779200 10:05:23 INFO - PROCESS | 26653 | 10:05:27 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49967/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:27 INFO - PROCESS | 26653 | RSS: Main: 170209280 10:05:27 INFO - PROCESS | 26653 | 10:05:31 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49967/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:31 INFO - PROCESS | 26653 | RSS: Main: 167706624 10:05:31 INFO - PROCESS | 26653 | 10:05:34 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49967/tests/kraken/driver.html?testName=json-parse-financial) 10:05:35 INFO - PROCESS | 26653 | RSS: Main: 169144320 10:05:35 INFO - PROCESS | 26653 | 10:05:37 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:37 INFO - PROCESS | 26653 | RSS: Main: 169357312 10:05:37 INFO - PROCESS | 26653 | 10:05:39 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:40 INFO - PROCESS | 26653 | RSS: Main: 170369024 10:05:40 INFO - PROCESS | 26653 | 10:05:42 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:43 INFO - PROCESS | 26653 | RSS: Main: 170516480 10:05:43 INFO - PROCESS | 26653 | 10:05:46 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:46 INFO - PROCESS | 26653 | RSS: Main: 170680320 10:05:46 INFO - PROCESS | 26653 | 10:05:49 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:50 INFO - PROCESS | 26653 | RSS: Main: 170110976 10:05:50 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | Cycle 1(1): loaded http://localhost:49967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49967/tests/kraken/driver.html?testName=ai-astar) 10:05:52 INFO - PROCESS | 26653 | RSS: Main: 171175936 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | __start_tp_report 10:05:52 INFO - PROCESS | 26653 | _x_x_mozilla_page_load 10:05:52 INFO - PROCESS | 26653 | _x_x_mozilla_page_load_details 10:05:52 INFO - PROCESS | 26653 | |i|pagename|runs| 10:05:52 INFO - PROCESS | 26653 | |0;ai-astar;108;117;108;115;117;117;116;118;114;115 10:05:52 INFO - PROCESS | 26653 | |1;audio-beat-detection;156;128;147;186;124;161;153;126;198;132 10:05:52 INFO - PROCESS | 26653 | |2;audio-dft;164;163;164;177;165;164;164;163;163;164 10:05:52 INFO - PROCESS | 26653 | |3;audio-fft;75;76;77;147;78;76;78;77;161;77 10:05:52 INFO - PROCESS | 26653 | |4;audio-oscillator;86;86;147;93;87;86;141;87;89;137 10:05:52 INFO - PROCESS | 26653 | |5;imaging-gaussian-blur;118;117;118;118;118;118;119;117;119;118 10:05:52 INFO - PROCESS | 26653 | |6;imaging-darkroom;148;148;147;148;148;149;150;148;149;148 10:05:52 INFO - PROCESS | 26653 | |7;imaging-desaturate;96;96;96;96;96;95;101;96;95;95 10:05:52 INFO - PROCESS | 26653 | |8;json-parse-financial;75;66;65;65;67;63;65;64;64;65 10:05:52 INFO - PROCESS | 26653 | |9;json-stringify-tinderbox;66;65;66;65;65;66;66;66;68;67 10:05:52 INFO - PROCESS | 26653 | |10;stanford-crypto-aes;83;87;80;81;80;80;83;81;84;80 10:05:52 INFO - PROCESS | 26653 | |11;stanford-crypto-ccm;142;132;145;135;132;132;134;134;174;146 10:05:52 INFO - PROCESS | 26653 | |12;stanford-crypto-pbkdf2;167;169;174;176;167;164;169;167;163;171 10:05:52 INFO - PROCESS | 26653 | |13;stanford-crypto-sha256-iterative;69;71;70;67;68;72;69;67;73;66 10:05:52 INFO - PROCESS | 26653 | __end_tp_report 10:05:52 INFO - PROCESS | 26653 | __start_cc_report 10:05:52 INFO - PROCESS | 26653 | _x_x_mozilla_cycle_collect,1015 10:05:52 INFO - PROCESS | 26653 | __end_cc_report 10:05:52 INFO - PROCESS | 26653 | __startTimestamp1469120752287__endTimestamp 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | ------- Summary: start ------- 10:05:52 INFO - PROCESS | 26653 | Number of tests: 14 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.50 stddev:3.63 (3.1%) stddev-sans-first:2.99 10:05:52 INFO - PROCESS | 26653 | Values: 108.0 117.0 108.0 115.0 117.0 117.0 116.0 118.0 114.0 115.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:154.50 stddev:25.44 (16.5%) stddev-sans-first:26.92 10:05:52 INFO - PROCESS | 26653 | Values: 156.0 128.0 147.0 186.0 124.0 161.0 153.0 126.0 198.0 132.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.23 (2.6%) stddev-sans-first:4.47 10:05:52 INFO - PROCESS | 26653 | Values: 164.0 163.0 164.0 177.0 165.0 164.0 164.0 163.0 163.0 164.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#3] audio-fft Cycles:10 Average:92.20 Median:77.00 stddev:32.75 (42.5%) stddev-sans-first:34.14 10:05:52 INFO - PROCESS | 26653 | Values: 75.0 76.0 77.0 147.0 78.0 76.0 78.0 77.0 161.0 77.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:86.50 stddev:26.25 (30.4%) stddev-sans-first:27.03 10:05:52 INFO - PROCESS | 26653 | Values: 86.0 86.0 147.0 93.0 87.0 86.0 141.0 87.0 89.0 137.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:05:52 INFO - PROCESS | 26653 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 119.0 117.0 119.0 118.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:05:52 INFO - PROCESS | 26653 | Values: 148.0 148.0 147.0 148.0 148.0 149.0 150.0 148.0 149.0 148.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 10:05:52 INFO - PROCESS | 26653 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 101.0 96.0 95.0 95.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:3.38 (5.2%) stddev-sans-first:1.17 10:05:52 INFO - PROCESS | 26653 | Values: 75.0 66.0 65.0 65.0 67.0 63.0 65.0 64.0 64.0 65.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 10:05:52 INFO - PROCESS | 26653 | Values: 66.0 65.0 66.0 65.0 65.0 66.0 66.0 66.0 68.0 67.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:2.33 (2.8%) stddev-sans-first:2.44 10:05:52 INFO - PROCESS | 26653 | Values: 83.0 87.0 80.0 81.0 80.0 80.0 83.0 81.0 84.0 80.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:138.50 stddev:12.94 (9.3%) stddev-sans-first:13.71 10:05:52 INFO - PROCESS | 26653 | Values: 142.0 132.0 145.0 135.0 132.0 132.0 134.0 134.0 174.0 146.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:4.08 (2.4%) stddev-sans-first:4.28 10:05:52 INFO - PROCESS | 26653 | Values: 167.0 169.0 174.0 176.0 167.0 164.0 169.0 167.0 163.0 171.0 10:05:52 INFO - PROCESS | 26653 | 10:05:52 INFO - PROCESS | 26653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.30 (3.3%) stddev-sans-first:2.44 10:05:52 INFO - PROCESS | 26653 | Values: 69.0 71.0 70.0 67.0 68.0 72.0 69.0 67.0 73.0 66.0 10:05:52 INFO - PROCESS | 26653 | -------- Summary: end -------- 10:05:52 INFO - PROCESS | 26653 | 10:05:53 INFO - TEST-INFO | 26653: exit 0 10:05:53 INFO - TEST-OK | kraken | took 64646ms 10:05:53 INFO - SUITE-END | took 1181s 10:05:53 INFO - Completed test suite (00:19:41) 10:05:53 INFO - javascript benchmark 10:05:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6487.415293874737, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.7478939500747, 2693.340131667741, 2725.4549090181954, 2727.8636068196583, 2730.6586676665406, 4878.75606219689, 4887.584555312803, 4907.877303067425, 4946.851594452172, 5018.824341148061, 4788.401449818773, 4870.196417591093, 4889.682170658904, 4893.947801222736, 4910.288008238803, 4475.977620111911, 4484.753338566377, 4521.570450807168, 4607.032523170122, 4616.699914505546, 4495.100979804036, 4611.584957353837, 4668.043051174518, 4669.463011753641, 4672.486026537078, 4365.716228445141, 4485.618722408599, 4527.253003254459, 4555.339475776011, 4559.954400456019, 4447.132809102226, 4461.933071003938, 4463.397441345442, 4477.417935668343, 4488.932666010012, 4426.889327766831, 4456.420665313521, 4461.620762235214, 4486.416765820422, 4512.684112112153, 4793.113274044313, 4877.561019508261, 4899.55903968641, 4902.28916807061, 4927.77824997876, 5166.302549155891, 5211.687298762086, 5227.8170264040955, 5230.973845130788, 5278.762455689503, 5246.37043554772, 5265.894682106375, 5270.6574072685535, 5281.9207711884355, 5314.229436731653, 4805.8558243252755, 4831.275308703723, 4832.226843704991, 4923.064617722621, 4929.827456039057, 5308.734563271898, 5339.41266460689, 5342.866428339323, 5381.0852155133725, 5391.838244852661, 5080.822171223989, 5084.9745751271, 5086.135356989321, 5086.72023038729, 5131.307273518028, 5154.484551544815, 5180.248863914711, 5207.869803254873, 5220.791168353299, 5230.137027390514, 5234.555062819627, 5234.92147617786, 5247.763850626731, 5277.050130976461, 5288.81489147878, 5217.191335343028, 5223.634345595772, 5229.189475631283, 5241.371035475768, 5265.552428043583, 4382.627476664456, 4468.0, 4489.506154323022, 4489.842855500042, 4497.370368148397, 3905.453236546886, 3913.5890731473355, 3944.6449819516383, 3965.940510892339, 3982.980085099556, 4437.179121862466, 4516.525764794649, 4529.954700452953, 4533.320001999727, 4591.288350305708, 5193.0, 5220.7128607926925, 5236.1098613235845, 5295.761690723926, 5374.54316383104, 4482.686211965131, 4521.299198624219, 4525.841595544141, 4535.433070866142, 4548.545145485425, 4762.9523704763205, 4764.2615394613895, 4783.617310615143, 4786.593139583105, 4806.8798280043275, 4786.880327991828, 4922.556969872729, 4937.185364414831, 4952.777125029383, 4978.8755281118265, 5323.414424413234, 5346.465353464622, 5347.518723314764, 5397.8380648580605, 5420.9186862197885, 4976.850694479172, 4999.47505511916, 5019.698818070928, 5027.095122877917, 5049.31834202378, 5067.569256613229, 5198.610104242272, 5238.0833354162105, 5285.709285989154, 5288.259643649815, 5330.600204984564, 5344.919826202688, 5356.223347614497, 5363.973180134074, 5389.083855744611, 5178.844634660966, 5191.039657663345, 5192.506711862367, 5195.064888320138, 5212.765425555935, 4993.675411098267, 5067.0, 5107.361579802525, 5196.454372290855, 5207.062728708869, 5004.924926126038, 5031.547160755549, 5038.672486288379, 5081.77132029067, 5102.846914592568, 5092.414372347227, 5110.131277682877, 5174.663646862942, 5197.24639927216, 5219.582433405394, 4859.902801943871, 5017.824376146963, 5036.521530454601, 5054.4187418447345, 5073.898522029613], "value": 4826.532145764519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5890661457215, 553.2420583800193, 560.6860158311346, 561.4890449690782, 576.3285772075532, 35443.645563544356, 39708.2058358833, 39709.0, 39751.0, 39853.80073099631, 40461.797691011576, 41030.17939641205, 41033.17933641325, 41068.58931410685, 41076.79461602688, 7792.610369481517, 7949.483283586577, 7949.562774047425, 7975.521468711867, 8000.919990800105, 7938.960305198466, 7971.840563188733, 8000.719974800854, 8018.478798878084, 8045.0, 7983.401244906655, 8026.317762990153, 8031.156728543507, 8050.51696898185, 8064.27421532062, 7999.36005119589, 8027.839443211162, 8029.357651387875, 8046.517208967452, 8051.51690898548, 7912.367010639193, 7919.208079192093, 7959.840803183962, 7972.3622110231045, 7987.8402431951035, 38299.23401531982, 38564.421533677014, 39055.414168787494, 39106.0, 39254.803725981474, 2259.762724913893, 2827.6465441819773, 2840.7869409794143, 2849.316164120596, 2899.608552845381, 26495.47009059808, 28750.424991500262, 29180.562291565642, 30112.247193820112, 30152.19480138005, 3251.398491279121, 3268.8855890043974, 3307.7684562080663, 3317.4526203176447, 3368.8315584220936, 263866.0, 265251.0, 266558.0, 267037.0, 267117.0, 56300.0, 56747.0, 56785.0, 56889.14666280009, 56893.71553142291, 33299.667003329654, 34538.309233815184, 34739.0, 59663.70168149218, 59810.401895981355, 13619.18284902909, 13974.231417272147, 13979.580612581638, 14000.719985600232, 14035.438582456587, 9705.417674939526, 9819.410835349901, 9828.262880284008, 9856.605735770489, 9920.206383489303, 18706.906465467586, 18716.81283187178, 18742.906285468485, 18758.718619220723, 18851.81148188528, 6636.601803891782, 6851.897221541681, 6914.135733033371, 6964.895526567106, 7014.298570142945, 753.393518217829, 766.8159641686067, 836.6026137584598, 874.6384761144934, 958.4536814015944, 26901.461970760476, 28447.28881777972, 28451.71548284532, 28866.0, 29065.7093429063, 862.3704695572142, 979.8530220466845, 999.1257649556638, 1038.2109596706407, 1096.7477480179602, 14680.265986700835, 15273.923630381776, 15284.541463756104, 15350.616234594001, 15654.295556699975, 408167.0, 411288.0, 412349.0, 415227.0, 415479.0, 51357.0, 51372.22941655878, 51556.22665660018, 51885.481145188816, 52027.219591706154, 1153.5270539078938, 1165.5221359242669, 1184.650528094197, 1184.9526018959318, 1198.5146015863588, 27230.72769272282, 27730.0, 28311.858440707663, 28698.713012869604, 29052.418951621272, 43679.78160109179, 44225.0, 44501.33248001218, 44583.33125003063, 44660.55339446564, 362922.0, 364173.0, 364902.0, 365065.0, 365745.0, 26126.73873261243, 26199.607005894544, 26233.737662623895, 26267.60598591061, 26415.735842641327, 42591.7870410646, 43712.0, 43909.341359878985, 44193.55806441895, 44504.33243501415, 36460.0, 36888.26223475569, 37082.814585927976, 37222.44166337453, 37825.432618510196, 36879.9107696121, 37186.07034824151, 37416.62583374132, 37512.2497550042, 38224.617753823215, 36043.639563604025, 36490.452643210905, 37060.44409333916, 37260.44109338308, 37614.811925940194, 31866.522002170448, 33392.49911251382, 33815.154621134665, 34114.31771364609, 34309.31381372408, 25798.87100564485, 26039.73960260373, 26055.869720651277, 26109.73890261149, 26150.607740884283], "value": 17635.722721511465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5137639874368, 363.17015619309876, 367.6268587383806, 373.76452834714127, 379.22637818849546, 16044.598885027866, 16735.16324183789, 17105.657886842288, 17236.052017139053, 17267.39564115256, 14893.702125957501, 17141.74287385687, 17613.647727045452, 17802.19890104945, 17837.554061148447, 5110.948890511085, 5299.49654782795, 5339.038972984861, 5340.412554618989, 5358.410574836765, 3818.77087374757, 5274.103402421579, 5963.701814909259, 6207.255129384457, 6265.5614107012525, 6286.7170977305905, 6299.77950771723, 6329.019002054666, 6337.936620633804, 6355.078513615523, 6242.594231374969, 6253.062040693887, 6256.468200202989, 6286.779962701284, 6306.653134077624, 5418.91871621926, 5459.317585301837, 5510.283663123809, 5533.253010843525, 5539.944600554023, 20292.695609565722, 20341.898290508452, 20763.273285435087, 20882.895585521976, 20896.686549701768, 1772.831580999803, 1900.4203717866046, 1925.5763731979082, 2150.40863762465, 2336.8130549555995, 12980.805287920688, 12997.350132493431, 13311.467541298336, 13347.532836350681, 13511.932440337736, 1730.7230843065174, 1753.6142048749255, 1758.8768786184971, 1795.4882858385429, 1802.4142153800067, 68886.65556672185, 68895.65552172207, 69180.30819691789, 69906.1551614661, 70312.648436758, 9267.860982085274, 9323.766905827408, 9338.533073346305, 9408.059194080673, 9555.331126821056, 13093.018023648265, 13106.80339794904, 13121.147125436815, 13153.802692959613, 13158.407871645799, 6728.764493242713, 6947.930520694728, 7034.859302813915, 7050.541714788523, 7072.611006394698, 6478.449331806755, 6484.1894763154605, 6501.1548498694865, 6673.733050677918, 6678.33216678338, 5840.386759390288, 5936.554758393051, 6020.488258498077, 6027.0, 6032.819015429544, 1624.1716724470368, 1692.1454665393896, 1758.5955230297104, 1779.359430604981, 1804.4857215693464, 818.5620692929255, 924.2421214604094, 933.6498812945146, 951.6811868024151, 985.3989066669326, 16762.91618541924, 17609.29562817473, 17637.7354339685, 17923.551911202325, 17932.282708691768, 806.3186607316808, 851.2721623012235, 892.9687460938966, 897.8922529296526, 912.1243606138049, 9866.605335786488, 10092.587037814712, 10199.54102065409, 10250.794984100425, 10276.743081423025, 394057.0, 399559.0, 400702.0, 400804.0, 401551.0, 42765.0, 48606.75696621494, 68946.65526672335, 69785.65107174533, 72293.0, 905.0090151284202, 911.1935936696071, 927.4110939553298, 936.8688383626297, 941.1529623338913, 15368.308426121075, 15494.5351639451, 16079.0, 16234.594135146715, 16288.348466061225, 34756.79424428812, 34948.0, 35099.473507897914, 35284.661621103216, 36149.457758133125, 46093.53906460892, 46656.0, 46763.766181170235, 48090.27864581964, 49287.50712492829, 7442.96278518604, 7482.551046937201, 7802.102758182881, 7872.291493765589, 8106.47307924983, 10586.576536938435, 11944.64166075019, 12198.512059517874, 12473.750524989267, 12604.30676312775, 10193.796124077626, 10469.633562825264, 10730.624428144978, 10742.24804263694, 10906.236563440483, 10671.626493072705, 10675.94662026716, 10733.14134869193, 10821.621243256448, 10993.353156382063, 10093.0, 10156.949215253877, 10718.410487423267, 10840.132789376674, 10896.291741036806, 6508.511861610304, 7040.683169257498, 7648.388128949782, 7720.498167619086, 8120.512769233865, 9446.38598491096, 9990.150837178631, 10580.100691441314, 10722.249442538947, 10986.725331866768], "value": 8407.148505811037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.200772548059, 1407.9859201407985, 1492.3881208704427, 1694.881358304919, 1724.6981778188813, 6945.652717364124, 7620.65707043183, 7714.6142692865415, 8036.116027236999, 8186.386021048423, 7823.647935842887, 7911.8417631647335, 7918.722844700436, 7939.682412703485, 7987.041555013407, 2172.565486902618, 2190.9452263693374, 2205.900734466945, 2209.1053123485012, 2209.414505156127, 2133.232036466871, 2152.9031193596325, 2171.7502487214015, 2174.510735084609, 2179.0521123311332, 2077.3871707846147, 2110.873347599149, 2117.9682304765442, 2119.8304135669187, 2149.7097891784642, 2101.3800928726064, 2106.199644135234, 2111.6199084164846, 2113.123053932616, 2120.6182887080395, 2078.314156328408, 2130.797574230461, 2136.9572608547896, 2139.1816955587783, 2152.655575107991, 8002.599870006535, 8028.317593004602, 8028.678852845879, 8052.396070294692, 8059.758207253733, 4478.93281600773, 4514.548545145492, 4591.081783643252, 4609.608183304423, 4626.306054091913, 2811.1988083396336, 2865.9713402866123, 2901.434220327037, 2909.345397285615, 2912.9126126216247, 870.5647176411794, 907.9591418386123, 919.8482250428672, 921.5484412637826, 923.6397804856111, 10764.515596798163, 10778.838317425245, 10881.12950963921, 10982.06652434544, 10990.780184396348, 3827.732058755916, 3980.840766369313, 4080.326746086922, 4106.91786164281, 4140.006398464347, 8593.355498337525, 8631.56842157902, 8647.697330593399, 8650.697225597074, 8664.220220180214, 4632.606228470618, 4637.0, 4639.652026098056, 4645.86062418128, 4652.95347046532, 3553.6979356754964, 4056.776877271778, 4131.50421949368, 4309.719868208619, 4318.157959197989, 3459.39460594395, 3468.3063387322636, 3567.6075631680496, 3572.517710109102, 3644.562652481666, 1011.7318910488726, 1014.5688082565028, 1015.9644412445676, 1036.4662198967537, 1044.2481413382352, 627.6234259444388, 758.8178837079062, 785.8664027115404, 790.7667238164755, 795.3954994204446, 5163.4062082860955, 5259.0, 5279.868003299948, 5339.893202135935, 5502.834914952477, 403.3063131414022, 414.53364964415033, 421.9261629214875, 424.90227247732577, 425.16455165599746, 3457.619661837196, 3584.3368976738866, 3594.101474631342, 3595.1371670799344, 3662.6520480554304, 9252.028537003518, 9676.0, 9763.316567840326, 9802.117809397188, 9806.803863922823, 9619.0, 9657.806843863083, 9688.224942004623, 9736.367136136128, 9747.56135973883, 7376.409887209011, 7382.892566115126, 7430.4798664093, 7459.142198647225, 7487.812804679927, 5103.974480127576, 5204.245384419162, 5264.894372181885, 5339.065663508948, 5355.169948657965, 8932.955335223282, 8961.462312261025, 9018.143276388733, 9026.593803278736, 9073.364864459689, 8997.0, 9000.009998899985, 9047.411918225294, 9101.089891010846, 9209.125133112344, 5615.522680572034, 6244.625322480666, 6314.368563143649, 6364.64994425311, 6378.266499352449, 7772.922270777446, 7799.5320280783335, 7815.29662330393, 7843.058832939855, 7858.764237072897, 6805.625690587065, 6986.825329366807, 6987.965060174666, 7000.264972177848, 7118.857622847618, 6838.863222735418, 6858.4856135791015, 6918.342757438036, 6932.757353492603, 6950.826229344307, 6254.8123556293385, 6338.683065846597, 6356.841078972878, 6547.181602299713, 6626.966865165643, 4367.126574685012, 4369.825206991684, 4390.23170945077, 4451.08752705701, 4512.729236245836, 4386.166628340605, 4460.531644177315, 4506.977465112785, 4522.547745225451, 4559.316102584638], "value": 4018.801704773369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.3719270934681, 302.1389041232488, 310.9160526657802, 311.3042350346973, 311.33374578402226, 4915.852524424273, 5035.571976382012, 5152.536271735547, 5216.4611439625305, 5246.868828279295, 5036.294918711384, 5059.494050594939, 5081.1108056090225, 5085.694858308504, 5088.2622019807195, 4028.5367182773916, 4035.3745169498775, 4050.7974601269966, 4051.392291156321, 4072.5927407259333, 3985.9003524911964, 4051.392291156321, 4074.8981275468204, 4085.9795701021603, 4088.36630322299, 3979.582143874895, 3982.064214909494, 3989.700772442064, 3997.2605068062503, 4026.5570787213383, 3990.6009399059863, 3991.1618560102415, 3996.7002474814503, 4001.819918103707, 4035.4955630546183, 3565.5008298838184, 3571.1250743567994, 3572.8570857165682, 3576.3204991051616, 3581.4985901973746, 4844.733539655353, 4958.859462323686, 5004.649674522785, 5064.772085256172, 5073.7209453480045, 4582.1064892346, 4591.357209990604, 4611.423572053493, 4617.099665565216, 4641.86074417768, 5377.650452720561, 5386.195624465809, 5416.295881535375, 5435.157550579666, 5441.483059109379, 3611.3319035978166, 3778.5087938568086, 3782.8865134046023, 3791.4502397152532, 3922.372420412749, 5608.270924779793, 5660.122680984454, 5674.773009079632, 5703.230063941398, 5704.4865962063195, 3912.9608703912595, 3913.354296541039, 3919.6668283195677, 3925.9607403926166, 3926.1755031443145, 3843.615638436134, 3906.257811015898, 3947.605239476087, 3965.345717956505, 3966.2464131814863, 4490.238503320435, 4503.594676479132, 4517.977410112929, 4518.322251662277, 4533.5013148553635, 5376.0, 5455.290812194389, 5463.644863083887, 5470.2375300473, 5471.288732464834, 1286.9704236610862, 1355.335885416139, 1365.0581099041628, 1374.6632075141654, 1391.8329800423812, 878.4114643189079, 880.5465185429509, 901.2249465459699, 912.183595681861, 919.3886065766325, 4056.1887622475624, 4112.321466957978, 4114.300568903293, 4117.402976568381, 4174.603412675791, 4814.0, 4844.975775121173, 4894.290327902506, 4916.72957987307, 4922.843131864009, 4154.356074808409, 4165.250254954077, 4170.020045289354, 4182.456280683492, 4187.178577318815, 2626.7898568114506, 2740.945181096367, 2966.8516574171204, 2977.35986762847, 2982.64208295006, 5224.007438586732, 5226.137687281632, 5226.686398816083, 5240.423553409122, 5260.71066091361, 5449.6730196188355, 5715.228444160069, 5725.341585717612, 5753.453421924911, 5768.423157684198, 5217.921731174036, 5230.660007099526, 5233.4243233244315, 5248.9737551312, 5277.815276465305, 5643.746031428677, 5647.830565083054, 5682.66457382523, 5684.186327767781, 5695.487406133468, 5294.470552944675, 5487.0, 5548.029094908295, 5553.278073850373, 5555.722213889208, 5260.500252476008, 5270.973645131749, 5293.867653308698, 5317.627766056339, 5350.0, 3952.6442620163175, 3960.6237407446247, 3961.3859851723028, 3966.6826653868197, 3971.046948732341, 5281.207818827206, 5560.777568897199, 5608.158776183605, 5634.32388113429, 5714.828555143353, 5256.500632439912, 5354.143337066051, 5366.0, 5408.810691625774, 5410.59420543453, 5418.83743487696, 5430.42980487059, 5439.37447193562, 5439.728013599225, 5506.284183056177, 5152.742362881916, 5258.421573626822, 5292.867678308073, 5353.946460535345, 5364.8122315718765, 5394.433584473731, 5402.432744561765, 5447.291852059207, 5448.882978989219, 5500.22996780443, 5287.89424211506, 5358.517733404013, 5359.437259087739, 5359.732013399393, 5385.784568617211], "value": 4018.8938329255448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.7938180400469, 707.6102791790137, 732.2933369298628, 742.7363286033461, 750.1635676221015, 12972.870271297284, 13837.100588461743, 14271.714565708693, 14282.714345713093, 14524.854751452482, 13269.601911942633, 13500.864991350083, 13517.932410337935, 13536.661583460418, 13559.186448813054, 614.5820841827556, 769.054063501893, 781.7029528779084, 784.0826233307045, 785.6189747972229, 765.4756491803132, 791.2245998921061, 794.5987276425398, 796.6494742313364, 797.3063434811722, 844.3540691371106, 847.2544161138189, 848.0840692052599, 848.5757121439281, 848.8641817309232, 838.1283465196188, 838.4424357802054, 839.345310657688, 841.2092632925031, 841.7474757572704, 611.1535523300261, 614.3549273263101, 614.7264467312048, 616.4759954039076, 617.1421723803916, 12865.67835804103, 12890.291033993126, 12908.35458227085, 12935.353232338439, 13013.154144980641, 12982.545610903668, 13029.413676384585, 13488.662783430394, 13501.527446539421, 13661.658458538517, 9931.453770042644, 9983.151432128278, 10037.0, 10175.287729858914, 10495.370277783357, 3198.7441004719567, 3237.0, 3253.137918451612, 3267.39553182662, 3292.341531693647, 62189.68905155445, 64531.35468645301, 64540.0, 64691.35308646948, 66130.33869661338, 10422.114120299708, 10612.946935265429, 10693.83959240612, 10801.351918884891, 10892.0, 19699.21203151858, 19852.205911763656, 19896.70154947677, 19964.201431942558, 20054.59890802176, 6741.325867413219, 6873.243943166248, 6931.272216417204, 6940.757073502504, 7096.680649370791, 3630.274214287865, 3671.30245253401, 3746.587875333711, 3809.7714137151306, 3861.0540417597867, 2799.6640403151346, 2869.038871977869, 2876.180288617734, 2888.7111288870947, 2895.1169893182782, 462.4335189392967, 535.7803300646716, 543.5868739757813, 553.1205383440349, 564.1509528160093, 502.1513641945101, 560.7588736843196, 570.1817891325878, 586.9661622478134, 603.0441749826487, 7105.857882842314, 7273.199948005715, 7447.329740323397, 7521.210272921265, 7527.623618819037, 507.88559208767356, 568.2499101186394, 580.6022874331097, 591.5326891755465, 599.4784537452445, 3344.0, 3512.7541072124704, 3554.306910152547, 3566.32239874423, 3607.2424790793702, 102655.48672256591, 104867.47566262273, 105467.47266263772, 105849.0, 109624.0, 54503.0, 78554.0, 93294.0, 95912.0, 96087.0, 76665.61667191629, 77427.0, 78428.60785696149, 78580.0, 78770.6061469689, 6688.5747190342545, 7014.929850701427, 7141.321574450419, 7151.106111736033, 7348.853022939405, 48035.75982120067, 48833.0, 49617.255741164634, 49658.751706242685, 50195.247071293226, 64339.356606433335, 68920.31079689138, 71876.64061679658, 72870.0, 73615.0, 9316.581664386118, 10000.44997525114, 10049.346792458467, 10107.39355638664, 10149.289549731448, 10742.570297188338, 11028.44857757125, 11029.558817647205, 11095.778084438105, 11176.969510592258, 9893.406395615999, 9929.702108936743, 10326.845097323396, 10471.3193642413, 10483.47582620881, 10087.193024558164, 10100.141487973604, 10200.132988695746, 10564.630237941636, 10846.891531084588, 10198.33710808795, 10397.0, 10592.841107383549, 10695.732606684895, 10842.891571084188, 8408.990921089508, 8502.404831661725, 8670.653173872974, 8755.693550725695, 8948.86576701363, 8465.534395608302, 8639.352048596505, 8646.178613031752, 8726.607302671522, 9053.0], "value": 6449.140686327888, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 108.0, 115.0, 117.0, 117.0, 116.0, 118.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 147.0, 186.0, 124.0, 161.0, 153.0, 126.0, 198.0, 132.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 177.0, 165.0, 164.0, 164.0, 163.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 147.0, 78.0, 76.0, 78.0, 77.0, 161.0, 77.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 147.0, 93.0, 87.0, 86.0, 141.0, 87.0, 89.0, 137.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 150.0, 148.0, 149.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 101.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 66.0, 65.0, 65.0, 67.0, 63.0, 65.0, 64.0, 64.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 68.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 80.0, 81.0, 80.0, 80.0, 83.0, 81.0, 84.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 145.0, 135.0, 132.0, 132.0, 134.0, 134.0, 174.0, 146.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 174.0, 176.0, 167.0, 164.0, 169.0, 167.0, 163.0, 171.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 67.0, 68.0, 72.0, 69.0, 67.0, 73.0, 66.0], "value": 69.2, "unit": "score"}]}]} 10:05:53 INFO - Return code: 0 10:05:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:53 ERROR - # TBPL SUCCESS # 10:05:53 INFO - Running post-action listener: _resource_record_post_action 10:05:53 INFO - [mozharness: 2016-07-21 17:05:53.593846Z] Finished run-tests step (success) 10:05:53 INFO - Running post-run listener: _resource_record_post_run 10:05:53 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 550219776; Read time: 464; Write time: 1287964 10:05:53 INFO - TinderboxPrint: CPU usage
13.4% 10:05:53 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 464 10:05:53 INFO - TinderboxPrint: I/O write bytes / time
550,219,776 / 1,287,964 10:05:53 INFO - TinderboxPrint: CPU idle
8,283.2 (86.6%) 10:05:53 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 10:05:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:53 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 4096; Write bytes: 247500800; Read time: 288; Write time: 905312 10:05:53 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 302104576; Read time: 176; Write time: 382652 10:05:54 INFO - Running post-run listener: _upload_blobber_files 10:05:54 INFO - Blob upload gear active. 10:05:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:54 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 10:05:54 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'] 10:05:54 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 10:05:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:07 INFO - (blobuploader) - INFO - Done attempting. 10:06:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:06:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:06:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:08 INFO - (blobuploader) - INFO - Done attempting. 10:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:06:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:08 INFO - (blobuploader) - INFO - Done attempting. 10:06:08 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:09 INFO - Return code: 0 10:06:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddb0003c3b8e95af430985e30d85b4f99178864a96d3d4dfca60cba26b686b3b73f230b0a7ea6bda448983bba86362ed12fa826df92e493dbc4a097cf633d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3719db06fa22d593be83ad36498921405d481a3959b5910839755aaa7d9d5e5b40dff57ef5715aad1db29b7a0300340d8a2cf75d0c940d88ab845e076894f2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccb77c7b125b8e9724067d46a8cf822c5a04a7c579d3c9829e6907cbdf84c8772cce53c88fdc26bb6d1bea0b93319a3e87ca4077f032c044c32368f9dff0fc0f"} 10:06:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:09 INFO - Contents: 10:06:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddb0003c3b8e95af430985e30d85b4f99178864a96d3d4dfca60cba26b686b3b73f230b0a7ea6bda448983bba86362ed12fa826df92e493dbc4a097cf633d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3719db06fa22d593be83ad36498921405d481a3959b5910839755aaa7d9d5e5b40dff57ef5715aad1db29b7a0300340d8a2cf75d0c940d88ab845e076894f2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccb77c7b125b8e9724067d46a8cf822c5a04a7c579d3c9829e6907cbdf84c8772cce53c88fdc26bb6d1bea0b93319a3e87ca4077f032c044c32368f9dff0fc0f"} 10:06:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:09 INFO - Copying logs to upload dir... 10:06:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.009306 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-21 10:06:08.701330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 10:06:08.704642) ========= 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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddb0003c3b8e95af430985e30d85b4f99178864a96d3d4dfca60cba26b686b3b73f230b0a7ea6bda448983bba86362ed12fa826df92e493dbc4a097cf633d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3719db06fa22d593be83ad36498921405d481a3959b5910839755aaa7d9d5e5b40dff57ef5715aad1db29b7a0300340d8a2cf75d0c940d88ab845e076894f2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccb77c7b125b8e9724067d46a8cf822c5a04a7c579d3c9829e6907cbdf84c8772cce53c88fdc26bb6d1bea0b93319a3e87ca4077f032c044c32368f9dff0fc0f"} build_url:https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/Zzf4cPkmQsSzzYWmZMm1Cg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dddb0003c3b8e95af430985e30d85b4f99178864a96d3d4dfca60cba26b686b3b73f230b0a7ea6bda448983bba86362ed12fa826df92e493dbc4a097cf633d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3719db06fa22d593be83ad36498921405d481a3959b5910839755aaa7d9d5e5b40dff57ef5715aad1db29b7a0300340d8a2cf75d0c940d88ab845e076894f2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccb77c7b125b8e9724067d46a8cf822c5a04a7c579d3c9829e6907cbdf84c8772cce53c88fdc26bb6d1bea0b93319a3e87ca4077f032c044c32368f9dff0fc0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 10:06:08.731102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:06:08.731445) ========= 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=df17445c3590ff7897617a0e00000225-1469115307.427345-354849880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:06:08.816904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 10:06:08.817263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 10:06:08.817597) ========= ========= Total master_lag: 0.18 =========