builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1469045203.19 results: success (0) buildid: 20160720103050 builduid: bddf671bfede4fc9bac362d820079d5f revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.186681) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.187199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.187535) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.202025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.202327) ========= 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=4300f881736b422476174874000001bc-1469045202.460223-830156693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 13:06:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-07-20 13:06:43 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.323078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.323792) ========= 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=4300f881736b422476174874000001bc-1469045202.460223-830156693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014341 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.375112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:43.375519) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d224fc999cb6accb208af0a105f14433375e2e77 --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 d224fc999cb6accb208af0a105f14433375e2e77 --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=4300f881736b422476174874000001bc-1469045202.460223-830156693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 13:06:43,575 truncating revision to first 12 chars 2016-07-20 13:06:43,575 Setting DEBUG logging. 2016-07-20 13:06:43,575 attempt 1/10 2016-07-20 13:06:43,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d224fc999cb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 13:06:43,974 unpacking tar archive at: mozilla-central-d224fc999cb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:44.147029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:44.147394) ========= script_repo_revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:44.147847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:44.148167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 13:06:44.159243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-20 13:06:44.159859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=4300f881736b422476174874000001bc-1469045202.460223-830156693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:44 INFO - MultiFileLogger online at 20160720 13:06:44 in /builds/slave/test 13:06:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:06:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:06:44 INFO - {'append_to_log': False, 13:06:44 INFO - 'base_work_dir': '/builds/slave/test', 13:06:44 INFO - 'blob_upload_branch': 'Firefox', 13:06:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:06:44 INFO - 'branch': 'Firefox', 13:06:44 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:44 INFO - 'config_files': ('talos/linux_config.py',), 13:06:44 INFO - 'default_actions': ('clobber', 13:06:44 INFO - 'read-buildbot-config', 13:06:44 INFO - 'download-and-extract', 13:06:44 INFO - 'populate-webroot', 13:06:44 INFO - 'create-virtualenv', 13:06:44 INFO - 'install', 13:06:44 INFO - 'run-tests'), 13:06:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:44 INFO - 'download_minidump_stackwalk': True, 13:06:44 INFO - 'download_symbols': 'ondemand', 13:06:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:44 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:44 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:44 INFO - 'installer_path': 'installer.exe', 13:06:44 INFO - 'log_level': 'info', 13:06:44 INFO - 'log_name': 'talos', 13:06:44 INFO - 'log_to_console': True, 13:06:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:44 INFO - 'opt_config_files': (), 13:06:44 INFO - 'pip_index': False, 13:06:44 INFO - 'sps_profile': False, 13:06:44 INFO - 'sps_profile_interval': 0, 13:06:44 INFO - 'suite': 'dromaeojs-e10s', 13:06:44 INFO - 'system_bits': '32', 13:06:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:44 INFO - 'title': 'talos-linux64-ix-045', 13:06:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:44 INFO - 'use_talos_json': True, 13:06:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:06:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:44 INFO - 'work_dir': 'build'} 13:06:44 INFO - [mozharness: 2016-07-20 20:06:44.446664Z] Running clobber step. 13:06:44 INFO - Running pre-action listener: _resource_record_pre_action 13:06:44 INFO - Running main action method: clobber 13:06:44 INFO - rmtree: /builds/slave/test/build 13:06:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:06:44 INFO - Running post-action listener: _resource_record_post_action 13:06:44 INFO - [mozharness: 2016-07-20 20:06:44.918622Z] Finished clobber step (success) 13:06:44 INFO - [mozharness: 2016-07-20 20:06:44.918723Z] Running read-buildbot-config step. 13:06:44 INFO - Running pre-action listener: _resource_record_pre_action 13:06:44 INFO - Running main action method: read_buildbot_config 13:06:44 INFO - Using buildbot properties: 13:06:44 INFO - { 13:06:44 INFO - "project": "", 13:06:44 INFO - "product": "firefox", 13:06:44 INFO - "script_repo_revision": "production", 13:06:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:06:44 INFO - "repository": "", 13:06:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:06:44 INFO - "buildid": "20160720103050", 13:06:44 INFO - "pgo_build": "True", 13:06:44 INFO - "basedir": "/builds/slave/test", 13:06:44 INFO - "buildnumber": 100, 13:06:44 INFO - "slavename": "talos-linux64-ix-045", 13:06:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:06:44 INFO - "platform": "ubuntu64_hw", 13:06:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:06:44 INFO - "branch": "mozilla-central", 13:06:44 INFO - "repo_path": "mozilla-central", 13:06:44 INFO - "revision": "d224fc999cb6accb208af0a105f14433375e2e77", 13:06:44 INFO - "stage_platform": "linux64-pgo", 13:06:44 INFO - "builduid": "bddf671bfede4fc9bac362d820079d5f", 13:06:44 INFO - "slavebuilddir": "test" 13:06:44 INFO - } 13:06:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:06:44 INFO - Running post-action listener: _resource_record_post_action 13:06:44 INFO - [mozharness: 2016-07-20 20:06:44.921149Z] Finished read-buildbot-config step (success) 13:06:44 INFO - [mozharness: 2016-07-20 20:06:44.921248Z] Running download-and-extract step. 13:06:44 INFO - Running pre-action listener: _resource_record_pre_action 13:06:44 INFO - Running main action method: download_and_extract 13:06:44 INFO - mkdir: /builds/slave/test/build/tests 13:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:44 INFO - https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:45 INFO - Downloaded 1361 bytes. 13:06:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:45 INFO - Using the following test package requirements: 13:06:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:06:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:06:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'jsshell-linux-x86_64.zip'], 13:06:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:06:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:06:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:06:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:06:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:06:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:45 INFO - https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:46 INFO - Downloaded 24342889 bytes. 13:06:46 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'] 13:06:46 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 13:06:47 INFO - Return code: 0 13:06:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:47 INFO - https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:49 INFO - Downloaded 24342889 bytes. 13:06:49 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'] 13:06:49 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 13:06:50 INFO - Return code: 0 13:06: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')]} 13:06:50 INFO - https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:51 INFO - Downloaded 14403317 bytes. 13:06:51 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'] 13:06:51 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 13:06:52 INFO - Return code: 0 13:06:52 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')]} 13:06:52 INFO - https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:06:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:06:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:06:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eS-3YTpnQTGWxRN_xymbwg/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 13:06:53 INFO - Downloaded 60885998 bytes. 13:06:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:06:53 INFO - mkdir: /builds/slave/test/properties 13:06:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:06:53 INFO - Writing to file /builds/slave/test/properties/build_url 13:06:53 INFO - Contents: 13:06:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:06:54 INFO - Running post-action listener: _resource_record_post_action 13:06:54 INFO - Running post-action listener: set_extra_try_arguments 13:06:54 INFO - [mozharness: 2016-07-20 20:06:54.167733Z] Finished download-and-extract step (success) 13:06:54 INFO - [mozharness: 2016-07-20 20:06:54.167964Z] Running populate-webroot step. 13:06:54 INFO - Running pre-action listener: _resource_record_pre_action 13:06:54 INFO - Running main action method: populate_webroot 13:06:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:06:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:06:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:06:54 INFO - '--tppagecycles', 13:06:54 INFO - '7'], 13:06:54 INFO - 'tests': ['tsvgm']}}, 13:06:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:06:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:06:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:06:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:06:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['damp', 'tps']}, 13:06:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'tests': ['damp', 'tps']}, 13:06:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['dromaeo_dom']}, 13:06:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:06:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['basic_compositor_video']}, 13:06:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:06:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['a11yr', 13:06:54 INFO - 'ts_paint', 13:06:54 INFO - 'tpaint', 13:06:54 INFO - 'sessionrestore', 13:06:54 INFO - 'sessionrestore_no_auto_restore', 13:06:54 INFO - 'tabpaint']}, 13:06:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['tsvgx', 13:06:54 INFO - 'tsvgr_opacity', 13:06:54 INFO - 'tart', 13:06:54 INFO - 'tscrollx', 13:06:54 INFO - 'cart']}, 13:06:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:06:54 INFO - 'tsvgr_opacity', 13:06:54 INFO - 'tart', 13:06:54 INFO - 'tscrollx', 13:06:54 INFO - 'cart']}, 13:06:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'talos_options': ['--disable-e10s'], 13:06:54 INFO - 'tests': ['tp5o']}, 13:06:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'tests': ['tp5o']}, 13:06:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'talos_options': ['--disable-e10s', 13:06:54 INFO - '--xperf_path', 13:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:54 INFO - 'tests': ['tp5n']}, 13:06:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:54 INFO - 'talos_options': ['--xperf_path', 13:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:54 INFO - 'tests': ['tp5n']}}, 13:06:54 INFO - 'talos.zip': {'path': '', 13:06:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:06:54 INFO - Running post-action listener: _resource_record_post_action 13:06:54 INFO - [mozharness: 2016-07-20 20:06:54.187217Z] Finished populate-webroot step (success) 13:06:54 INFO - [mozharness: 2016-07-20 20:06:54.187306Z] Running create-virtualenv step. 13:06:54 INFO - Running pre-action listener: _resource_record_pre_action 13:06:54 INFO - Running main action method: create_virtualenv 13:06:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:06:54 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 13:06:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:06:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:06:54 INFO - Using real prefix '/usr' 13:06:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:06:54 INFO - Installing distribute.............................................................................................................................................................................................done. 13:06:56 INFO - Installing pip.................done. 13:06:56 INFO - Return code: 0 13:06:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:06:56 INFO - Using env: {'DISPLAY': ':0', 13:06:56 INFO - 'HOME': '/home/cltbld', 13:06:56 INFO - 'LANG': 'en_US.UTF-8', 13:06:56 INFO - 'LANGUAGE': 'en_US:en', 13:06:56 INFO - 'LOGNAME': 'cltbld', 13:06:56 INFO - 'MAIL': '/var/mail/cltbld', 13:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:56 INFO - 'MOZ_NO_REMOTE': '1', 13:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:56 INFO - 'NO_EM_RESTART': '1', 13:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:56 INFO - 'PWD': '/builds/slave/test', 13:06:56 INFO - 'SHELL': '/bin/bash', 13:06:56 INFO - 'SHLVL': '1', 13:06:56 INFO - 'TERM': 'linux', 13:06:56 INFO - 'TMOUT': '86400', 13:06:56 INFO - 'USER': 'cltbld', 13:06:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:56 INFO - '_': '/tools/buildbot/bin/python'} 13:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:57 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 13:06:57 INFO - Cleaning up... 13:06:57 INFO - Return code: 0 13:06:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:06:57 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')]} 13:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:57 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')]} 13:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:57 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:06:57 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 13:06:57 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 13:06:57 INFO - Using env: {'DISPLAY': ':0', 13:06:57 INFO - 'HOME': '/home/cltbld', 13:06:57 INFO - 'LANG': 'en_US.UTF-8', 13:06:57 INFO - 'LANGUAGE': 'en_US:en', 13:06:57 INFO - 'LOGNAME': 'cltbld', 13:06:57 INFO - 'MAIL': '/var/mail/cltbld', 13:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:57 INFO - 'MOZ_NO_REMOTE': '1', 13:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:57 INFO - 'NO_EM_RESTART': '1', 13:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:57 INFO - 'PWD': '/builds/slave/test', 13:06:57 INFO - 'SHELL': '/bin/bash', 13:06:57 INFO - 'SHLVL': '1', 13:06:57 INFO - 'TERM': 'linux', 13:06:57 INFO - 'TMOUT': '86400', 13:06:57 INFO - 'USER': 'cltbld', 13:06:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:57 INFO - '_': '/tools/buildbot/bin/python'} 13:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:57 INFO - Downloading/unpacking psutil>=3.1.1 13:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:59 INFO - Installing collected packages: psutil 13:06:59 INFO - Running setup.py install for psutil 13:06:59 INFO - building 'psutil._psutil_linux' extension 13:06:59 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 13:06:59 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 13:06:59 INFO - building 'psutil._psutil_posix' extension 13:06:59 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 13:06:59 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 13:06:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:59 INFO - Successfully installed psutil 13:06:59 INFO - Cleaning up... 13:06:59 INFO - Return code: 0 13:06:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:06:59 INFO - Using env: {'DISPLAY': ':0', 13:06:59 INFO - 'HOME': '/home/cltbld', 13:06:59 INFO - 'LANG': 'en_US.UTF-8', 13:06:59 INFO - 'LANGUAGE': 'en_US:en', 13:06:59 INFO - 'LOGNAME': 'cltbld', 13:06:59 INFO - 'MAIL': '/var/mail/cltbld', 13:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:59 INFO - 'MOZ_NO_REMOTE': '1', 13:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:59 INFO - 'NO_EM_RESTART': '1', 13:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:59 INFO - 'PWD': '/builds/slave/test', 13:06:59 INFO - 'SHELL': '/bin/bash', 13:06:59 INFO - 'SHLVL': '1', 13:06:59 INFO - 'TERM': 'linux', 13:06:59 INFO - 'TMOUT': '86400', 13:06:59 INFO - 'USER': 'cltbld', 13:06:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:59 INFO - '_': '/tools/buildbot/bin/python'} 13:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:00 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 13:07:00 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 13:07:00 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 13:07:00 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 13:07:00 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 13:07:00 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 13:07:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:02 INFO - Installing collected packages: mozsystemmonitor 13:07:02 INFO - Running setup.py install for mozsystemmonitor 13:07:02 INFO - Successfully installed mozsystemmonitor 13:07:02 INFO - Cleaning up... 13:07:02 INFO - Return code: 0 13:07:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:02 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:02 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 13:07:02 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 13:07:02 INFO - Using env: {'DISPLAY': ':0', 13:07:02 INFO - 'HOME': '/home/cltbld', 13:07:02 INFO - 'LANG': 'en_US.UTF-8', 13:07:02 INFO - 'LANGUAGE': 'en_US:en', 13:07:02 INFO - 'LOGNAME': 'cltbld', 13:07:02 INFO - 'MAIL': '/var/mail/cltbld', 13:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:02 INFO - 'MOZ_NO_REMOTE': '1', 13:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:02 INFO - 'NO_EM_RESTART': '1', 13:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:02 INFO - 'PWD': '/builds/slave/test', 13:07:02 INFO - 'SHELL': '/bin/bash', 13:07:02 INFO - 'SHLVL': '1', 13:07:02 INFO - 'TERM': 'linux', 13:07:02 INFO - 'TMOUT': '86400', 13:07:02 INFO - 'USER': 'cltbld', 13:07:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:02 INFO - '_': '/tools/buildbot/bin/python'} 13:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:02 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:04 INFO - warning: no files found matching '*.txt' 13:07:04 INFO - no previously-included directories found matching 'build' 13:07:04 INFO - no previously-included directories found matching 'dist' 13:07:04 INFO - no previously-included directories found matching '.git*' 13:07:04 INFO - Installing collected packages: jsonschema, functools32 13:07:04 INFO - Running setup.py install for functools32 13:07:04 INFO - warning: no files found matching '*.txt' 13:07:04 INFO - no previously-included directories found matching 'build' 13:07:04 INFO - no previously-included directories found matching 'dist' 13:07:04 INFO - no previously-included directories found matching '.git*' 13:07:04 INFO - Successfully installed jsonschema functools32 13:07:04 INFO - Cleaning up... 13:07:04 INFO - Return code: 0 13:07:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:04 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')]} 13:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:04 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')]} 13:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:04 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:04 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 13:07:04 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 13:07:04 INFO - Using env: {'DISPLAY': ':0', 13:07:04 INFO - 'HOME': '/home/cltbld', 13:07:04 INFO - 'LANG': 'en_US.UTF-8', 13:07:04 INFO - 'LANGUAGE': 'en_US:en', 13:07:04 INFO - 'LOGNAME': 'cltbld', 13:07:04 INFO - 'MAIL': '/var/mail/cltbld', 13:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:04 INFO - 'MOZ_NO_REMOTE': '1', 13:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:04 INFO - 'NO_EM_RESTART': '1', 13:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:04 INFO - 'PWD': '/builds/slave/test', 13:07:04 INFO - 'SHELL': '/bin/bash', 13:07:04 INFO - 'SHLVL': '1', 13:07:04 INFO - 'TERM': 'linux', 13:07:04 INFO - 'TMOUT': '86400', 13:07:04 INFO - 'USER': 'cltbld', 13:07:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:04 INFO - '_': '/tools/buildbot/bin/python'} 13:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:04 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 13:07:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:06 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 13:07:06 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 13:07:06 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 13:07:06 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 13:07:06 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 13:07:06 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 13:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:07 INFO - Downloading docopt-0.6.1.tar.gz 13:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:07 INFO - Running setup.py install for blobuploader 13:07:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:07 INFO - Running setup.py install for requests 13:07:08 INFO - Running setup.py install for docopt 13:07:08 INFO - Successfully installed blobuploader requests docopt 13:07:08 INFO - Cleaning up... 13:07:08 INFO - Return code: 0 13:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:08 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:08 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 13:07:08 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 13:07:08 INFO - Using env: {'DISPLAY': ':0', 13:07:08 INFO - 'HOME': '/home/cltbld', 13:07:08 INFO - 'LANG': 'en_US.UTF-8', 13:07:08 INFO - 'LANGUAGE': 'en_US:en', 13:07:08 INFO - 'LOGNAME': 'cltbld', 13:07:08 INFO - 'MAIL': '/var/mail/cltbld', 13:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:08 INFO - 'MOZ_NO_REMOTE': '1', 13:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:08 INFO - 'NO_EM_RESTART': '1', 13:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:08 INFO - 'PWD': '/builds/slave/test', 13:07:08 INFO - 'SHELL': '/bin/bash', 13:07:08 INFO - 'SHLVL': '1', 13:07:08 INFO - 'TERM': 'linux', 13:07:08 INFO - 'TMOUT': '86400', 13:07:08 INFO - 'USER': 'cltbld', 13:07:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:08 INFO - '_': '/tools/buildbot/bin/python'} 13:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:08 INFO - Running setup.py (path:/tmp/pip-xMOENu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:08 INFO - Running setup.py (path:/tmp/pip-TiVbkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:08 INFO - Running setup.py (path:/tmp/pip-C4jEjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:08 INFO - Running setup.py (path:/tmp/pip-eUKz9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:08 INFO - Running setup.py (path:/tmp/pip-X69b_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:08 INFO - Running setup.py (path:/tmp/pip-9L89mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:08 INFO - Running setup.py (path:/tmp/pip-cIwwbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:09 INFO - Running setup.py (path:/tmp/pip-6gEYA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:09 INFO - Running setup.py (path:/tmp/pip-N61gF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:09 INFO - Running setup.py (path:/tmp/pip-S8s7MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:09 INFO - Running setup.py (path:/tmp/pip-osHnGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:09 INFO - Running setup.py (path:/tmp/pip-FV5e2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:09 INFO - Running setup.py (path:/tmp/pip-vy8jSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:09 INFO - Running setup.py (path:/tmp/pip-WKS8XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:09 INFO - Running setup.py (path:/tmp/pip-2wtH8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:09 INFO - Running setup.py (path:/tmp/pip-sOOawj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:09 INFO - Running setup.py (path:/tmp/pip-EUoCYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:09 INFO - Running setup.py install for manifestparser 13:07:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:09 INFO - Running setup.py install for mozcrash 13:07:09 INFO - Running setup.py install for mozdebug 13:07:10 INFO - Running setup.py install for mozdevice 13:07:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for mozfile 13:07:10 INFO - Running setup.py install for mozhttpd 13:07:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for mozinfo 13:07:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for mozInstall 13:07:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for mozleak 13:07:10 INFO - Running setup.py install for mozlog 13:07:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for moznetwork 13:07:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:10 INFO - Running setup.py install for mozprocess 13:07:10 INFO - Running setup.py install for mozprofile 13:07:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:11 INFO - Running setup.py install for mozrunner 13:07:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:11 INFO - Running setup.py install for mozscreenshot 13:07:11 INFO - Running setup.py install for moztest 13:07:11 INFO - Running setup.py install for mozversion 13:07:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:11 INFO - Cleaning up... 13:07:11 INFO - Return code: 0 13:07:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:11 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:11 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 13:07:11 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 13:07:11 INFO - Using env: {'DISPLAY': ':0', 13:07:11 INFO - 'HOME': '/home/cltbld', 13:07:11 INFO - 'LANG': 'en_US.UTF-8', 13:07:11 INFO - 'LANGUAGE': 'en_US:en', 13:07:11 INFO - 'LOGNAME': 'cltbld', 13:07:11 INFO - 'MAIL': '/var/mail/cltbld', 13:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:11 INFO - 'MOZ_NO_REMOTE': '1', 13:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:11 INFO - 'NO_EM_RESTART': '1', 13:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:11 INFO - 'PWD': '/builds/slave/test', 13:07:11 INFO - 'SHELL': '/bin/bash', 13:07:11 INFO - 'SHLVL': '1', 13:07:11 INFO - 'TERM': 'linux', 13:07:11 INFO - 'TMOUT': '86400', 13:07:11 INFO - 'USER': 'cltbld', 13:07:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:11 INFO - '_': '/tools/buildbot/bin/python'} 13:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:11 INFO - Running setup.py (path:/tmp/pip-_tWeI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:11 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)) 13:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:11 INFO - Running setup.py (path:/tmp/pip-o8AiIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:11 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)) 13:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:11 INFO - Running setup.py (path:/tmp/pip-rUeEsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:11 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)) 13:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:11 INFO - Running setup.py (path:/tmp/pip-F4XOG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:12 INFO - Running setup.py (path:/tmp/pip-SvMG7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:12 INFO - Running setup.py (path:/tmp/pip-b5pq4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:12 INFO - Running setup.py (path:/tmp/pip-PL3Vvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:12 INFO - Running setup.py (path:/tmp/pip-VRTtBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:12 INFO - Running setup.py (path:/tmp/pip-v2S4d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:12 INFO - Running setup.py (path:/tmp/pip-q3FSfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:12 INFO - Running setup.py (path:/tmp/pip-yv7lsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:12 INFO - Running setup.py (path:/tmp/pip-0Jd1B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:12 INFO - Running setup.py (path:/tmp/pip-ZN9zUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:12 INFO - Running setup.py (path:/tmp/pip-HuQtJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:12 INFO - Running setup.py (path:/tmp/pip-yDP_MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:12 INFO - Running setup.py (path:/tmp/pip-LAUKi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:12 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)) 13:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:12 INFO - Running setup.py (path:/tmp/pip-d2YV08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:12 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)) 13:07:12 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)) 13:07:12 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)) 13:07:12 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)) 13:07:12 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)) 13:07:12 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)) 13:07:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:15 INFO - Downloading blessings-1.6.tar.gz 13:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:15 INFO - Installing collected packages: blessings 13:07:15 INFO - Running setup.py install for blessings 13:07:15 INFO - Successfully installed blessings 13:07:15 INFO - Cleaning up... 13:07:15 INFO - Return code: 0 13:07:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:15 INFO - Reading from file tmpfile_stdout 13:07:15 INFO - Current package versions: 13:07:15 INFO - argparse == 1.2.1 13:07:15 INFO - blessings == 1.6 13:07:15 INFO - blobuploader == 1.2.4 13:07:15 INFO - docopt == 0.6.1 13:07:15 INFO - functools32 == 3.2.3-2 13:07:15 INFO - jsonschema == 2.5.1 13:07:15 INFO - manifestparser == 1.1 13:07:15 INFO - mozInstall == 1.12 13:07:15 INFO - mozcrash == 0.17 13:07:15 INFO - mozdebug == 0.1 13:07:15 INFO - mozdevice == 0.48 13:07:15 INFO - mozfile == 1.2 13:07:15 INFO - mozhttpd == 0.7 13:07:15 INFO - mozinfo == 0.9 13:07:15 INFO - mozleak == 0.1 13:07:15 INFO - mozlog == 3.3 13:07:15 INFO - moznetwork == 0.27 13:07:15 INFO - mozprocess == 0.23 13:07:15 INFO - mozprofile == 0.28 13:07:15 INFO - mozrunner == 6.12 13:07:15 INFO - mozscreenshot == 0.1 13:07:15 INFO - mozsystemmonitor == 0.3 13:07:15 INFO - moztest == 0.7 13:07:15 INFO - mozversion == 1.4 13:07:15 INFO - psutil == 3.1.1 13:07:15 INFO - requests == 1.2.3 13:07:15 INFO - wsgiref == 0.1.2 13:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:15 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')]} 13:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:15 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')]} 13:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:15 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:15 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 13:07:15 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 13:07:15 INFO - Using env: {'DISPLAY': ':0', 13:07:15 INFO - 'HOME': '/home/cltbld', 13:07:15 INFO - 'LANG': 'en_US.UTF-8', 13:07:15 INFO - 'LANGUAGE': 'en_US:en', 13:07:15 INFO - 'LOGNAME': 'cltbld', 13:07:15 INFO - 'MAIL': '/var/mail/cltbld', 13:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:15 INFO - 'MOZ_NO_REMOTE': '1', 13:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:15 INFO - 'NO_EM_RESTART': '1', 13:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:15 INFO - 'PWD': '/builds/slave/test', 13:07:15 INFO - 'SHELL': '/bin/bash', 13:07:15 INFO - 'SHLVL': '1', 13:07:15 INFO - 'TERM': 'linux', 13:07:15 INFO - 'TMOUT': '86400', 13:07:15 INFO - 'USER': 'cltbld', 13:07:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:15 INFO - '_': '/tools/buildbot/bin/python'} 13:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 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)) 13:07:15 INFO - Cleaning up... 13:07:15 INFO - Return code: 0 13:07:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07:15 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')]} 13:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:15 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')]} 13:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:15 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 0xd8b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, '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': '4300f881736b422476174874000001bc-1469045202.460223-830156693', '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 13:07:15 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 13:07:15 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 13:07:15 INFO - Using env: {'DISPLAY': ':0', 13:07:15 INFO - 'HOME': '/home/cltbld', 13:07:15 INFO - 'LANG': 'en_US.UTF-8', 13:07:15 INFO - 'LANGUAGE': 'en_US:en', 13:07:15 INFO - 'LOGNAME': 'cltbld', 13:07:15 INFO - 'MAIL': '/var/mail/cltbld', 13:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:15 INFO - 'MOZ_NO_REMOTE': '1', 13:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:15 INFO - 'NO_EM_RESTART': '1', 13:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:15 INFO - 'PWD': '/builds/slave/test', 13:07:15 INFO - 'SHELL': '/bin/bash', 13:07:15 INFO - 'SHLVL': '1', 13:07:15 INFO - 'TERM': 'linux', 13:07:15 INFO - 'TMOUT': '86400', 13:07:15 INFO - 'USER': 'cltbld', 13:07:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:15 INFO - '_': '/tools/buildbot/bin/python'} 13:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:07:15 INFO - Cleaning up... 13:07:15 INFO - Return code: 0 13:07:15 INFO - Running post-action listener: _resource_record_post_action 13:07:15 INFO - Running post-action listener: _start_resource_monitoring 13:07:15 INFO - Starting resource monitoring. 13:07:15 INFO - [mozharness: 2016-07-20 20:07:15.973673Z] Finished create-virtualenv step (success) 13:07:15 INFO - [mozharness: 2016-07-20 20:07:15.974156Z] Running install step. 13:07:15 INFO - Running pre-action listener: _resource_record_pre_action 13:07:15 INFO - Running main action method: install 13:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:16 INFO - Reading from file tmpfile_stdout 13:07:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:07:16 INFO - Reading from file tmpfile_stdout 13:07:16 INFO - Output received: 13:07:16 INFO - Usage: mozinstall [options] installer 13:07:16 INFO - Options: 13:07:16 INFO - -h, --help show this help message and exit 13:07:16 INFO - -d DEST, --destination=DEST 13:07:16 INFO - Directory to install application into. [default: 13:07:16 INFO - "/builds/slave/test"] 13:07:16 INFO - --app=APP Application being installed. [default: firefox] 13:07:16 INFO - mkdir: /builds/slave/test/build/application 13:07:16 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'] 13:07:16 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 13:07:33 INFO - Reading from file tmpfile_stdout 13:07:33 INFO - Output received: 13:07:33 INFO - /builds/slave/test/build/application/firefox/firefox 13:07:33 INFO - Running post-action listener: _resource_record_post_action 13:07:33 INFO - [mozharness: 2016-07-20 20:07:33.494360Z] Finished install step (success) 13:07:33 INFO - [mozharness: 2016-07-20 20:07:33.494632Z] Running run-tests step. 13:07:33 INFO - Running pre-action listener: _resource_record_pre_action 13:07:33 INFO - Running main action method: run_tests 13:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:33 INFO - Python 2.7.3 13:07:33 INFO - Return code: 0 13:07:33 INFO - grabbing minidump binary from tooltool 13:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:33 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 0x104a3b0>, '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 0x104b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:33 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 13:07:33 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 13:07:33 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 13:07:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:33 INFO - Return code: 0 13:07:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:07:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:07:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 13:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 13:07:33 INFO - Using env: {'DISPLAY': ':0', 13:07:33 INFO - 'HOME': '/home/cltbld', 13:07:33 INFO - 'LANG': 'en_US.UTF-8', 13:07:33 INFO - 'LANGUAGE': 'en_US:en', 13:07:33 INFO - 'LOGNAME': 'cltbld', 13:07:33 INFO - 'MAIL': '/var/mail/cltbld', 13:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:33 INFO - 'MOZ_NO_REMOTE': '1', 13:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:33 INFO - 'NO_EM_RESTART': '1', 13:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:33 INFO - 'PWD': '/builds/slave/test', 13:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:33 INFO - 'SHELL': '/bin/bash', 13:07:33 INFO - 'SHLVL': '1', 13:07:33 INFO - 'TERM': 'linux', 13:07:33 INFO - 'TMOUT': '86400', 13:07:33 INFO - 'USER': 'cltbld', 13:07:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469045202.460223-830156693', 13:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:33 INFO - '_': '/tools/buildbot/bin/python'} 13:07:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 13:07:33 INFO - mozversion application_buildid: 20160720103050 13:07:33 INFO - mozversion application_changeset: d224fc999cb6accb208af0a105f14433375e2e77 13:07:33 INFO - mozversion application_display_name: Nightly 13:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:33 INFO - mozversion application_name: Firefox 13:07:33 INFO - mozversion application_remotingname: firefox 13:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:07:33 INFO - mozversion application_vendor: Mozilla 13:07:33 INFO - mozversion application_version: 50.0a1 13:07:33 INFO - mozversion platform_buildid: 20160720103050 13:07:33 INFO - mozversion platform_changeset: d224fc999cb6accb208af0a105f14433375e2e77 13:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:07:33 INFO - mozversion platform_version: 50.0a1 13:07:33 INFO - using testdate: 1469045253 13:07:33 INFO - actual date: 1469045253 13:07:33 INFO - starting webserver on 'localhost:46255' 13:07:33 INFO - SUITE-START | Running 2 tests 13:07:33 INFO - TEST-START | dromaeo_css 13:07:33 INFO - operating with platform_type : linux_ 13:07:33 INFO - Initialising browser for dromaeo_css test... 13:07:33 INFO - TEST-INFO | started process 20021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOxJY1/profile http://localhost:46255/getInfo.html) 13:07:38 INFO - PROCESS | 20021 | __metrics Screen width/height:1600/1200 13:07:38 INFO - PROCESS | 20021 | colorDepth:24 13:07:38 INFO - PROCESS | 20021 | Browser inner width/height: 1024/697 13:07:38 INFO - PROCESS | 20021 | __metrics 13:07:39 ERROR - PROCESS | 20021 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:07:40 INFO - TEST-INFO | 20021: exit 0 13:07:40 INFO - Browser initialized. 13:07:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:07:40 INFO - TEST-INFO | started process 20144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOxJY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:51 INFO - PROCESS | 20144 | RSS: Main: 167759872 13:07:51 INFO - PROCESS | 20144 | 13:08:41 INFO - PROCESS | 20144 | 1469045321412 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] 13:10:49 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46255/tests/dromaeo/cssquery-ext.html) 13:10:51 INFO - PROCESS | 20144 | RSS: Main: 173547520 13:10:51 INFO - PROCESS | 20144 | 13:13:53 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-ext.html (next: http://localhost:46255/tests/dromaeo/cssquery-jquery.html) 13:13:53 INFO - PROCESS | 20144 | RSS: Main: 170082304 13:13:53 INFO - PROCESS | 20144 | 13:16:55 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46255/tests/dromaeo/cssquery-mootools.html) 13:16:56 INFO - PROCESS | 20144 | RSS: Main: 173297664 13:16:56 INFO - PROCESS | 20144 | 13:19:58 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46255/tests/dromaeo/cssquery-prototype.html) 13:19:58 INFO - PROCESS | 20144 | RSS: Main: 168071168 13:19:58 INFO - PROCESS | 20144 | 13:23:01 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46255/tests/dromaeo/cssquery-yui.html) 13:23:01 INFO - PROCESS | 20144 | RSS: Main: 170217472 13:23:01 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | Cycle 1(1): loaded http://localhost:46255/tests/dromaeo/cssquery-yui.html (next: http://localhost:46255/tests/dromaeo/cssquery-dojo.html) 13:26:04 INFO - PROCESS | 20144 | RSS: Main: 170819584 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | __start_tp_report 13:26:04 INFO - PROCESS | 20144 | _x_x_mozilla_page_load 13:26:04 INFO - PROCESS | 20144 | _x_x_mozilla_page_load_details 13:26:04 INFO - PROCESS | 20144 | |i|pagename|runs| 13:26:04 INFO - PROCESS | 20144 | |0;dojo.html;3088.4903990841512;3099.287163952291;3130.593022907022;3144.71697547221;3147.1817327494846;5448.019356515825;5530.170474428838;5540.806071787489;5545.805896793613;5553.5834812389085;5314.627976041678;5374.220737992989;5380.811671591495;5433.239346491494;5487.945120548793;4981.178105612587;5004.749762511878;5022.296878437012;5052.444231134572;5052.444231134572;4993.251012348141;5046.041252162077;5101.464346243647;5109.233614957768;5144.588432925357;5079.4412614612365;5089.287499750019;5118.6416950813455;5121.923171152435;5166.095933211692;4894.412670479565;4916.311716359713;4919.581835543983;4979.228219625964;5010.774515146791;4930.728809915453;4933.876653083666;4936.185529387682;4952.430470495903;5017.673851199696;5390.6226564140525;5423.213634023084;5424.105022671294;5476.315460567429;5492.0663487206875;5698.914516282259;5734.853029394138;5761.88476230473;5800.651960882361;5825.38833422493;5849.38581448946;5884.323302820188;5884.6469211847425;5896.292444906639;5901.321348044987;5470;5472.5621950243885;5473.042217611902;5473.06957817172;5477.863053423656;5837;5944.5838791284195;5985.042393217152;5999.970000150059;6016.42843929826;5757.8560535986935;5794.21778059965;5825.854353641108;5837.941620583825;5839.9124013139835;5845.532357411397;5885.234919460443;5894.17481552583;5897.233359663216;5922.3485416604135;5637.774489020475;5815.127730840408;5833.533317334603;5844.094165404369;5867;5639.971800140973;5799.82600521985;5833.125031245262;5840.591158618856;5978.1929439525975;4464.553544645574;4466.196084704719;4476.216662084187;4485.372047913294;4513.480949690827;3890.922181556353;3990.5610382857863;3998.140399814054;4000.4599379084034;4042.130941847458;5529.612927095065;5547.140193270049;5588.050031494656;5606.971965140148;5628.60599758013;5880.852978675567;5898.203742494708;5916.083007133901;5919.55603329752;5927.318358388754;5593.916091258634;5595.272614560081;5599.552035837123;5602.4957753802355;5613.382527921925;4954.801807927714;5015.097282489114;5048.469910659402;5056.696598204119;5110.207917772751;6034.366391528914;6043.697815109315;6052.54605904559;6058.636481811105;6060.33336333003;5836.620619659709;5874.177615133799;5879;5896.616719913192;5903.822885313448;5868.853278668067;5987.491063259672;6048.4858787003595;6088.4215999479975;6117.583823141572;5813.3895940925595;5820.30156381237;5848.53211743051;5851.093080572518;5851.561132914963;5962.612430192024;5967.9701601491715;5974.850628734316;5978.581499295007;5981.9401805983125;5621.831345059655;5671.432856714296;5721.828345149652;5748.080307150836;5749.9712501437225;5710.000749868674;5741.598088133957;5748.137779333133;5755.280589926259;5756.65460072397;5578.274824272981;5626.971865140648;5630.549556035589;5642.492175704207;5658.179563963285;5598.664080155041;5663.886722265449;5785.161151633074;5812.593118481665;5848.093545500455;5695.686737229492;5702.885942281214;5707.828765137053;5721.199032135588;5723.255976723 13:26:04 INFO - PROCESS | 20144 | |1;ext.html;549.2578096152428;575.9971200143999;598.4912824099516;601.1613798750745;631.3087169549342;39926.60073399265;44413.77793111038;44416.33375499366;44433.555664443345;44546.33180502295;43131.3530297045;44000.11999760003;44282;44309.11381772363;44425.77787111068;8847.469151850877;8983;8996.775080623003;9015.594298256594;9016.729498115033;8787.912120878806;8896.644134234622;8918.643254269853;8948.463092214488;8949.77625559363;8978.551072446384;9022.86465703015;9034.819303613924;9036.954815225914;9048.230900373443;8909.1536304051;8932.999999999967;8972.057933916974;9001.594928228245;9002.639894404216;8918.241949434307;8927;8946.329025323063;8992.820143597157;9000.909990900072;41885;42132.57867421348;42262.36606450906;42268.36597451041;42367.15265694699;3571.821408929543;3658.5243918290716;3677.595464498903;3851.1615841643497;4216.2832318505925;33241.6675833241;33404.498932516035;33535.16162095943;33613.83193084019;35305.64694353049;4377.409049778303;4394.6923715339935;4429.15845989261;4444.177827101964;4446.421965144543;375039;375519;375806;378348;378829;60176.09735853966;60235.69882150649;60405.697971509864;60589.394106058375;60664.39335606676;61811.381886181465;62185;62509.68745156245;62592;62715.6864215676;15299;15364.692706145814;15369.923150384177;15436.45972390961;15480;11823.704407389712;11909.285442873455;11916.582919597773;11916.808319168014;11926.1651684383;15814.76277855833;17121.571960701083;17156.142192890307;17185;17284.481465556055;6393.9360606394275;6520.217573891068;6572.061241933641;6579.374959378852;6608.768693095719;968.2931460034215;1039.1167507618463;1055.6991257491577;1109.6615532262738;1156.5720683347047;32769.50845737316;33853.32293354168;33935.32129357448;34106;34351;1040.661784919904;1155.67063386936;1181.6218809980896;1213.5691829400612;1235.5659351078361;17307;17424.825751742574;17431.65136697259;17503.212355444037;17572.384966526366;535415;536896;539009;539822;539868;60038.39961600416;60084.39915600788;60177.69911150416;60317;60341.396586034454;1314.901382396305;1320.5444121778164;1333.5465941579716;1384.2248340929111;1399.0766094377661;31332;33942.66057339395;34553;34873.30253394969;34978.30043399169;50990.490095098576;51232.74383628058;51280.743596281776;51354.48645513497;51487.48512514827;414944;416474;419146;419544;420138;28090.2977425566;28349.14952551427;28391.716082838906;28445.288867778472;28494.85752571224;47629.761851190524;47782.76108619435;48293.27560086672;48575.51424485851;49671;40766.38850417187;41202.79398602988;41915.37126943159;42108.789456052524;43237.567624323354;41366.58633413627;41786;41831.163376732904;42338.36492452677;42764.35853462138;35832.820835895654;40962.385564217155;41193.38209926793;41822.16355672809;42663.7866810664;35374.46938295876;37577.81211093927;38018.239635206584;38107.42838857364;38453.615463845;28514.57228141538;28786.568201476577;29161;29381.412371752016;29448.705512944598 13:26:04 INFO - PROCESS | 20144 | |2;jquery.html;373.6805031697898;381.8243607940348;388.3921662598034;395.9841606335747;406.17546380846875;17574;19679.212831486722;19811.20755169793;19986.30047948322;20057.699134512994;18101.094945252717;18288.542786430346;18911.148998295077;19265.229390824385;19369.709454358162;5856.824295271138;5948.345681975001;5996.820095397145;6056.545759068065;6075.513958883301;5736.627119237257;5890.734916928748;5891.941080589182;5925.822225333247;5925.911111333312;5525;5719.628224165416;5793.652380857141;5833.241678581779;5870.119482077701;5680.233168522238;5721.427857214246;5809.186713860063;5814.447627475383;5849.03490923997;5653.971730141364;5787.13193021046;5815.098659707752;5830.212921255618;5843.9707801461145;14416.062955907832;14421.351039203157;14434.566962991126;14474.42102315906;19796.505087372785;2247.1236217875044;2256.2328808205125;2475.6905386826647;2953.719396657314;2981.0311648714255;9526;9592.328537002413;9973.35173213746;10286.9485652572;14252.501162459368;1774.6184570317314;1783.7502749615064;1802.0989505247376;1837.9473261458586;1891.5743957609566;83483.58258208731;83589.16410835875;84092;85081.57459212726;85648;10234.795304094025;10289.536970836181;10702.73243168927;10954.507047182897;11144.60993865211;14504.274786260645;14539.636509087357;14566.563003109924;14586.854131458762;14631.341589628491;7399;7721.305082542598;7750.224977502205;7830.765077047584;7889.368850491946;7505.474616776883;7576.052993375828;7764.301212890754;7776.494527855672;7813.960930195312;4389.473263208435;4412.382266482695;4509.6843220974215;4546.61353784932;4659.114768194032;1793.2647614478;1855.9142901402831;1859.4235786906102;1879.3422302194122;1928.633559623667;830.7549272964369;990.6087095597343;1012.2610494339026;1049.0768124050787;1083.2254937719567;18623.720644190347;19711.80288197128;19882.70175947362;20046.699299510517;20256.89871550633;913.9908600914039;957.167264479907;996.4519514267269;1002.754325190333;1040.7033995311451;9567.473788941676;10867.578540502473;10973.68788525602;11040;11045;516576;517535;522946;524532;526919;88932.5553372229;90072.54963725139;90255.54872225598;90716;91813.54093229491;1016.5425558498705;1018.8267994440963;1022.0648106982028;1027.547878933267;1049.8320268756963;16937.32250709958;17388.91305543464;17861.374851880122;18022.729659055385;18023.2790688371;40610.79694601508;42220;42281.365779513944;42634.78682606567;43213.525185583116;59006;59149;59194;60208.39791602028;60231;7714;8726.214640682369;8767.824643507221;8784.385093043426;8846.601902914255;12116.75766484683;13376.130551514121;13403.865961340261;13417.664558385728;13591.388387522784;11937.701557461132;11940.164188506722;12062;12140.878591213976;12231.816522751988;11314.434278285888;11370.260933039326;11429.142814289127;11507.136964727511;11540.365279909685;10819.729506762395;11233.32600044;11480.483378248166;11500.597479088192;12136.271823690253;7459.254074592497;7667.233276672288;8636;8679.479231246145;8752.256058234867;6444.709988050643;10362;10916.672499825017;11510.251833630788;12294.692632684255 13:26:04 INFO - PROCESS | 20144 | |3;mootools.html;1519.1948267418268;1552.417843308759;1716.0990479998006;1824;1843.2995461724533;8124.837503249932;8735.563221838907;8808.823823523526;9312.068793120685;9317.5807088681;8798.252148567364;9057;9079.18287354138;9110.362274640778;9131.178193962542;2346.5189636124596;2348.365941195876;2383.7616238376195;2384.2847145856263;2386.9880650596724;2362.0669835415;2381.1903952656094;2391.964120538193;2433.5862903306393;2438.6829712137487;2350.1421980976993;2353.646952957053;2362.574736547421;2374.2877136858874;2386.260259319608;2329.6039673255586;2351.1300818697105;2365.562370961378;2366.5740166769974;2368.798652114572;2299.310206937929;2302.090674183705;2306.2274138163734;2310.6418505131733;2314.6990891184205;9136.954315228448;9233.445993240428;9250.907490925072;9269.536523173882;9278.072192780735;5408.729563521808;5419.295491586108;5423.566114710814;5489.6980666063355;5517.834464966058;3483.773554718935;3514.0863375522295;3524.753267271292;3555;3589.6948759355487;1217.424009976936;1219.7499512599895;1223.804191329383;1242.1243023668292;1259.0494176896384;12625.05312101596;12735.172213806165;12754.426050827735;12755.553555625509;12815.487380504768;4666.2207876549755;4762.166620841339;4803.327534145223;4904.117258893362;4925.039617274669;10669.78660426787;10690;10714.357138571711;10718.785624287471;10738.731531711614;5503.532199763065;5510.228568000483;5536.2249285100115;5544.22380866679;5557.805476808292;4342.174986752507;4908.975455122773;5023.648344615842;5059.8988020239385;5085.567726743268;3940.862069827542;4008.3586626139677;4065.2276067547073;4136.8138433770555;4198.874033778991;1241.6150993192139;1265.0638527489775;1266.892314153289;1270.783966725659;1274.4583551990368;884.2616415293302;1011.8077565262577;1014.4319181258519;1032.550840384435;1035.4667346316653;6015.796840631891;6238.688065596702;6308.179936608211;6409.615423074631;6438.259600146043;449.1174841436593;456.5936316678093;458.209588459904;464.21779301875773;474.5515487864004;4112.691548133902;4169.728967617095;4187.497500299984;4220.915581688349;4231.915361692811;11064.17018723599;11273.661790146309;11394.316341019565;11422.428878556038;11495.597654082067;11263.718407039889;11332.943335283271;11343.659690209306;11346.773064538664;11401.372924489067;8084.312833409109;8407.243348098822;8503.74488765338;8559.614817333235;8605.526696031653;6166.722497487534;6275.435210831047;6364.459020983083;6373.74505019794;6477.190351206099;10095.44475053879;10162.593496260066;10225.181985441295;10231.488425578542;10296.639617613348;10393.584256629953;10435.269531133052;10464.162866970471;10481.266311358131;10501.422421766876;7430.368418684472;7953.403494737802;8008.559529225949;8058.274755272054;8186.181381861767;9110.453372797654;9207.953960230156;9229.630814767603;9234.861477077715;9240.353175277934;7692.0384951881015;7842.607869606611;7954.920450795418;8222.958885205535;8268.09051004377;7874.842503150019;7879.0939042010905;8014.879776803236;8025.398095142771;8064;7235.674394652358;7365.116186057708;7395.297446742551;7423.331900129015;7435.293647103516;5538.944610554004;5584.581156413366;5634.211210430461;5657.60396772222;5710.114932185518;5530.5022547970875;5552.750126244248;5645.604807663424;5741.45456181662;5797.652140871562 13:26:04 INFO - PROCESS | 20144 | |4;prototype.html;302.6353244340568;319.340561740007;322.8692379586267;326.61948829613493;328.2745133255506;5555.472230138141;5571.5513966368735;5691.772329106836;5778.5377169826415;5826.067829147342;5636.633618814774;5638.633488823224;5660.575456840733;5668.121441176624;5725.4847063764255;4390.956090439103;4419.469663640368;4429.446319210098;4434.733915965036;4450.821967121327;4136.193442278757;4273.722208056482;4291.935620965688;4427.77861106945;4443.800028998687;4283.400323954634;4284.828606855722;4285.785710714467;4297.656187504992;4317.330813723878;4319.935200971988;4337.783110844445;4338.414314067592;4349.521552629209;4351.521332653406;3693.8522459101605;3736.8692095776787;3794.260119276742;3823.1589050408866;3827.8133778528745;5423.2949716537;5452.482014208644;5485.369182543979;5486.204500347428;5518.862028449281;4860.343853579792;4926.3595732554895;4927.581155601778;4967.726775027372;4975.253711943201;5593.105103183471;5855.531557475391;5867;5870.943230218559;5874.50066744323;4066.4916885389325;4070.5115386153557;4073.5722749111214;4091.85678501254;4104.4664193654935;6146.784862529835;6161.860055889675;6181.6600086995195;6208.4722798561725;6229.968850155766;4116.217918595457;4167.5207351154395;4206.663466922639;4234.703570750018;4245.596668316505;4241.300185469425;4242.681798865097;4246.40550322955;4264.381664658607;4264.744115353089;4945.332380128637;4947.282644016669;4983.25251212321;4989.55094041538;5004.299398084271;5805.403514033675;5911.881762364728;5943.692387674705;5960.672163031075;5974.4622983930785;1460.2552698124034;1477.5150973272007;1479.2677624575904;1479.371267211431;1479.7558402863408;896.780288829241;925.7454200094893;931.9254459643212;939.4691999020531;944.2351695126969;4997.425296090923;5014.921791814777;5020.397552293675;5038.773255203525;5097.8725531861255;5304.904562697713;5413.9729301353245;5432.375276843213;5461.726913654302;5469.906018796177;4935.259711043373;5090.567301779391;5097.796088156507;5130.434348128015;5133.845984620392;2893.4791737487453;2896.2904088498453;2901.433226057947;2907.680155182928;2933.8093023953375;5451.018816613047;5531.778728850801;5534;5547.667139971534;5598.768270980378;5308.522232999048;5352;5423.918641220384;5461.890762184734;5496.532794712414;5387.8653033675255;5456.645318054314;5460.890782184334;5534.7860855658055;5571.554275657938;5316.494932981361;5370.9731451342495;5413.431589683184;5421.5391691706645;5697.743601537858;6036.92117020314;6057.606255593549;6060.6969651516365;6079.966405711129;6094.329623741296;6306.400891915261;6312.747490100344;6343.636118234602;6364.64994425311;6383.648899310582;3854.20988697322;4174.77038762871;4176.791160442027;4182.64447521964;4208.831646734219;6115.785947491817;6126.663033533198;6162.691865406622;6198.473129783839;6199.039148931923;5805.709714514342;5895.64626122434;6019.277686677627;6029.306629737636;6056.515478761777;5850.356460789395;5864.67744274069;5907.9704601476715;5919.312995796177;5966.343702192842;5812.18629391877;5846.064629659234;5851.795187168429;5866;5866.442687944638;5865.354810970875;5936.554758393224;5961.4898269867435;5963.970180149072;5982.970085149546;5818.8254352369495;5887.470127688529;5894.322152952465;5904.704764761831;5931.08068249422 13:26:04 INFO - PROCESS | 20144 | |5;yui.html;657.8684263147371;738.6749830074764;785.5522352259211;791.9168487308832;798.8641930871751;15657.921710391447;17011.14944252787;17051.57371065724;17108.657826843457;17196.91401542992;15366.615834604141;15496.767548486754;15508.767368489454;15512.612184695388;15532.301046452909;655.8884989551788;787.122358570193;806.7942674617964;811.4319976016783;822.5023860564362;815.6655771133836;815.9592020398957;816.4121832280748;817.8037271054964;817.9591020448984;857.9184977427135;860;860.0711231869598;861.8491763941316;862.0517430826072;843.5023336231592;846.6782622603403;848.5121055393174;849.8215374771244;854.1842540373959;617.8424501752024;623.0902881792588;623.2147494157349;624.2446639566131;625.1591609285549;15711.92144039284;15729.292181851844;15730.606734831606;15749.527514174593;15755.212239387985;14953.551393458214;15607;15644.92177539105;15733.134677592841;15761.290741916526;11718.648440546796;11763.2942023478;11776.764464710657;12043.458044387937;12087.153899227058;3946.6842652587725;3959.8614048508166;3972.523297204354;4016.7790771507557;4139.172165566899;75333.24666753317;77045;78142;79488.20511794866;79861;11440.141989350832;11858.288502689693;11888.405579720978;11942.880571194351;12028.63914082579;22780.4304892379;23037.193698220482;23086.884565577064;23107.88446057759;23209.3037208884;8446.704365347307;8614.574536784039;8705.768395404466;8708.738737837875;8711.433756805787;4601.493835678073;4807.678022255593;4854.490278520775;4881.731504767272;5018.996200759862;3532.1699400640828;3628.3650361186687;3646.854125834937;3647.471116688065;3670.963290367062;690.9689063992132;734.1850545894054;735.290444720847;739.2976672161361;747.637395863006;700.5271342478312;708.7696498637861;746.1568427676799;755.4787196834167;759.5480688990042;9820.852687209697;10017.14854237398;10081.647142349982;10127.442990635585;10562.524686388977;645.9471062168728;677.395414630744;734.5702763883188;749.3555542233674;752.3567349915853;4788.186008378584;4845.345878306454;4923.409190897044;4949;4975.203967365204;114436;127158.36420818022;127442;128612.35693821471;130253.34873325573;100728;102538.48730756299;108787;112723.4363828192;113139.4343028296;56910;76272;88004.11995880216;88567.55716221378;89732.5513372429;9857.605695772088;10382.221333399873;10636.202284828823;10649.733756656145;10925.781484370109;50624.49375506198;50837.491625083276;51146;52158.47841521536;52605.7369713149;60692.69653651703;78181;78628.60685696534;79298.20701792907;80030;12665.493380265054;13538;13567.86432135666;13593;13792.724145517233;15392.461263855712;15420.055007794355;15551.300191491637;15566.066036037873;15609.453669121527;14213.573592792232;14314.284285785461;14923.701525969636;14958.32687529042;15265.465708700141;14251;14473.493427729978;14892.40430382816;15122.773158402853;15412.383504660136;13621.455141794217;14347.856521434653;14355.779758720626;14924.955253132177;15115.31981060833;11082.279651822606;11285.37930413835;11475.48360323804;11519.835957058283;11613.883861161281;10706.62526811589;10826.76285156436;11025.338479691245;11791.941040294743;12644.30456324911 13:26:04 INFO - PROCESS | 20144 | __end_tp_report 13:26:04 INFO - PROCESS | 20144 | __start_cc_report 13:26:04 INFO - PROCESS | 20144 | _x_x_mozilla_cycle_collect,362 13:26:04 INFO - PROCESS | 20144 | __end_cc_report 13:26:04 INFO - PROCESS | 20144 | __startTimestamp1469046364833__endTimestamp 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | ------- Summary: start ------- 13:26:04 INFO - PROCESS | 20144 | Number of tests: 6 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#0] dojo.html Cycles:165 Average:5450.66 Median:5642.49 stddev:622.01 (11.0%) stddev-sans-first:595.67 13:26:04 INFO - PROCESS | 20144 | Values: 3088.5 3099.3 3130.6 3144.7 3147.2 5448.0 5530.2 5540.8 5545.8 5553.6 5314.6 5374.2 5380.8 5433.2 5487.9 4981.2 5004.7 5022.3 5052.4 5052.4 4993.3 5046.0 5101.5 5109.2 5144.6 5079.4 5089.3 5118.6 5121.9 5166.1 4894.4 4916.3 4919.6 4979.2 5010.8 4930.7 4933.9 4936.2 4952.4 5017.7 5390.6 5423.2 5424.1 5476.3 5492.1 5698.9 5734.9 5761.9 5800.7 5825.4 5849.4 5884.3 5884.6 5896.3 5901.3 5470.0 5472.6 5473.0 5473.1 5477.9 5837.0 5944.6 5985.0 6000.0 6016.4 5757.9 5794.2 5825.9 5837.9 5839.9 5845.5 5885.2 5894.2 5897.2 5922.3 5637.8 5815.1 5833.5 5844.1 5867.0 5640.0 5799.8 5833.1 5840.6 5978.2 4464.6 4466.2 4476.2 4485.4 4513.5 3890.9 3990.6 3998.1 4000.5 4042.1 5529.6 5547.1 5588.1 5607.0 5628.6 5880.9 5898.2 5916.1 5919.6 5927.3 5593.9 5595.3 5599.6 5602.5 5613.4 4954.8 5015.1 5048.5 5056.7 5110.2 6034.4 6043.7 6052.5 6058.6 6060.3 5836.6 5874.2 5879.0 5896.6 5903.8 5868.9 5987.5 6048.5 6088.4 6117.6 5813.4 5820.3 5848.5 5851.1 5851.6 5962.6 5968.0 5974.9 5978.6 5981.9 5621.8 5671.4 5721.8 5748.1 5750.0 5710.0 5741.6 5748.1 5755.3 5756.7 5578.3 5627.0 5630.5 5642.5 5658.2 5598.7 5663.9 5785.2 5812.6 5848.1 5695.7 5702.9 5707.8 5721.2 5723.3 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#1] ext.html Cycles:180 Average:60876.99 Median:42120.68 stddev:119097.20 (282.8%) stddev-sans-first:119345.17 13:26:04 INFO - PROCESS | 20144 | Values: 549.3 576.0 598.5 601.2 631.3 39926.6 44413.8 44416.3 44433.6 44546.3 43131.4 44000.1 44282.0 44309.1 44425.8 8847.5 8983.0 8996.8 9015.6 9016.7 8787.9 8896.6 8918.6 8948.5 8949.8 8978.6 9022.9 9034.8 9037.0 9048.2 8909.2 8933.0 8972.1 9001.6 9002.6 8918.2 8927.0 8946.3 8992.8 9000.9 41885.0 42132.6 42262.4 42268.4 42367.2 3571.8 3658.5 3677.6 3851.2 4216.3 33241.7 33404.5 33535.2 33613.8 35305.6 4377.4 4394.7 4429.2 4444.2 4446.4 375039.0 375519.0 375806.0 378348.0 378829.0 60176.1 60235.7 60405.7 60589.4 60664.4 61811.4 62185.0 62509.7 62592.0 62715.7 15299.0 15364.7 15369.9 15436.5 15480.0 11823.7 11909.3 11916.6 11916.8 11926.2 15814.8 17121.6 17156.1 17185.0 17284.5 6393.9 6520.2 6572.1 6579.4 6608.8 968.3 1039.1 1055.7 1109.7 1156.6 32769.5 33853.3 33935.3 34106.0 34351.0 1040.7 1155.7 1181.6 1213.6 1235.6 17307.0 17424.8 17431.7 17503.2 17572.4 535415.0 536896.0 539009.0 539822.0 539868.0 60038.4 60084.4 60177.7 60317.0 60341.4 1314.9 1320.5 1333.5 1384.2 1399.1 31332.0 33942.7 34553.0 34873.3 34978.3 50990.5 51232.7 51280.7 51354.5 51487.5 414944.0 416474.0 419146.0 419544.0 420138.0 28090.3 28349.1 28391.7 28445.3 28494.9 47629.8 47782.8 48293.3 48575.5 49671.0 40766.4 41202.8 41915.4 42108.8 43237.6 41366.6 41786.0 41831.2 42338.4 42764.4 35832.8 40962.4 41193.4 41822.2 42663.8 35374.5 37577.8 38018.2 38107.4 38453.6 28514.6 28786.6 29161.0 29381.4 29448.7 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#2] jquery.html Cycles:180 Average:29718.61 Median:377.75 stddev:85939.24 (22750.1%) stddev-sans-first:86152.08 13:26:04 INFO - PROCESS | 20144 | Values: 373.7 381.8 388.4 396.0 406.2 17574.0 19679.2 19811.2 19986.3 20057.7 18101.1 18288.5 18911.1 19265.2 19369.7 5856.8 5948.3 5996.8 6056.5 6075.5 5736.6 5890.7 5891.9 5925.8 5925.9 5525.0 5719.6 5793.7 5833.2 5870.1 5680.2 5721.4 5809.2 5814.4 5849.0 5654.0 5787.1 5815.1 5830.2 5844.0 14416.1 14421.4 14434.6 14474.4 19796.5 2247.1 2256.2 2475.7 2953.7 2981.0 9526.0 9592.3 9973.4 10286.9 14252.5 1774.6 1783.8 1802.1 1837.9 1891.6 83483.6 83589.2 84092.0 85081.6 85648.0 10234.8 10289.5 10702.7 10954.5 11144.6 14504.3 14539.6 14566.6 14586.9 14631.3 7399.0 7721.3 7750.2 7830.8 7889.4 7505.5 7576.1 7764.3 7776.5 7814.0 4389.5 4412.4 4509.7 4546.6 4659.1 1793.3 1855.9 1859.4 1879.3 1928.6 830.8 990.6 1012.3 1049.1 1083.2 18623.7 19711.8 19882.7 20046.7 20256.9 914.0 957.2 996.5 1002.8 1040.7 9567.5 10867.6 10973.7 11040.0 11045.0 516576.0 517535.0 522946.0 524532.0 526919.0 88932.6 90072.5 90255.5 90716.0 91813.5 1016.5 1018.8 1022.1 1027.5 1049.8 16937.3 17388.9 17861.4 18022.7 18023.3 40610.8 42220.0 42281.4 42634.8 43213.5 59006.0 59149.0 59194.0 60208.4 60231.0 7714.0 8726.2 8767.8 8784.4 8846.6 12116.8 13376.1 13403.9 13417.7 13591.4 11937.7 11940.2 12062.0 12140.9 12231.8 11314.4 11370.3 11429.1 11507.1 11540.4 10819.7 11233.3 11480.5 11500.6 12136.3 7459.3 7667.2 8636.0 8679.5 8752.3 6444.7 10362.0 10916.7 11510.3 12294.7 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#3] mootools.html Cycles:180 Average:6016.73 Median:452.86 stddev:3435.20 (758.6%) stddev-sans-first:3428.21 13:26:04 INFO - PROCESS | 20144 | Values: 1519.2 1552.4 1716.1 1824.0 1843.3 8124.8 8735.6 8808.8 9312.1 9317.6 8798.3 9057.0 9079.2 9110.4 9131.2 2346.5 2348.4 2383.8 2384.3 2387.0 2362.1 2381.2 2392.0 2433.6 2438.7 2350.1 2353.6 2362.6 2374.3 2386.3 2329.6 2351.1 2365.6 2366.6 2368.8 2299.3 2302.1 2306.2 2310.6 2314.7 9137.0 9233.4 9250.9 9269.5 9278.1 5408.7 5419.3 5423.6 5489.7 5517.8 3483.8 3514.1 3524.8 3555.0 3589.7 1217.4 1219.7 1223.8 1242.1 1259.0 12625.1 12735.2 12754.4 12755.6 12815.5 4666.2 4762.2 4803.3 4904.1 4925.0 10669.8 10690.0 10714.4 10718.8 10738.7 5503.5 5510.2 5536.2 5544.2 5557.8 4342.2 4909.0 5023.6 5059.9 5085.6 3940.9 4008.4 4065.2 4136.8 4198.9 1241.6 1265.1 1266.9 1270.8 1274.5 884.3 1011.8 1014.4 1032.6 1035.5 6015.8 6238.7 6308.2 6409.6 6438.3 449.1 456.6 458.2 464.2 474.6 4112.7 4169.7 4187.5 4220.9 4231.9 11064.2 11273.7 11394.3 11422.4 11495.6 11263.7 11332.9 11343.7 11346.8 11401.4 8084.3 8407.2 8503.7 8559.6 8605.5 6166.7 6275.4 6364.5 6373.7 6477.2 10095.4 10162.6 10225.2 10231.5 10296.6 10393.6 10435.3 10464.2 10481.3 10501.4 7430.4 7953.4 8008.6 8058.3 8186.2 9110.5 9208.0 9229.6 9234.9 9240.4 7692.0 7842.6 7954.9 8223.0 8268.1 7874.8 7879.1 8014.9 8025.4 8064.0 7235.7 7365.1 7395.3 7423.3 7435.3 5538.9 5584.6 5634.2 5657.6 5710.1 5530.5 5552.8 5645.6 5741.5 5797.7 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#4] prototype.html Cycles:180 Average:4821.55 Median:5428.15 stddev:1436.42 (26.5%) stddev-sans-first:1399.83 13:26:04 INFO - PROCESS | 20144 | Values: 302.6 319.3 322.9 326.6 328.3 5555.5 5571.6 5691.8 5778.5 5826.1 5636.6 5638.6 5660.6 5668.1 5725.5 4391.0 4419.5 4429.4 4434.7 4450.8 4136.2 4273.7 4291.9 4427.8 4443.8 4283.4 4284.8 4285.8 4297.7 4317.3 4319.9 4337.8 4338.4 4349.5 4351.5 3693.9 3736.9 3794.3 3823.2 3827.8 5423.3 5452.5 5485.4 5486.2 5518.9 4860.3 4926.4 4927.6 4967.7 4975.3 5593.1 5855.5 5867.0 5870.9 5874.5 4066.5 4070.5 4073.6 4091.9 4104.5 6146.8 6161.9 6181.7 6208.5 6230.0 4116.2 4167.5 4206.7 4234.7 4245.6 4241.3 4242.7 4246.4 4264.4 4264.7 4945.3 4947.3 4983.3 4989.6 5004.3 5805.4 5911.9 5943.7 5960.7 5974.5 1460.3 1477.5 1479.3 1479.4 1479.8 896.8 925.7 931.9 939.5 944.2 4997.4 5014.9 5020.4 5038.8 5097.9 5304.9 5414.0 5432.4 5461.7 5469.9 4935.3 5090.6 5097.8 5130.4 5133.8 2893.5 2896.3 2901.4 2907.7 2933.8 5451.0 5531.8 5534.0 5547.7 5598.8 5308.5 5352.0 5423.9 5461.9 5496.5 5387.9 5456.6 5460.9 5534.8 5571.6 5316.5 5371.0 5413.4 5421.5 5697.7 6036.9 6057.6 6060.7 6080.0 6094.3 6306.4 6312.7 6343.6 6364.6 6383.6 3854.2 4174.8 4176.8 4182.6 4208.8 6115.8 6126.7 6162.7 6198.5 6199.0 5805.7 5895.6 6019.3 6029.3 6056.5 5850.4 5864.7 5908.0 5919.3 5966.3 5812.2 5846.1 5851.8 5866.0 5866.4 5865.4 5936.6 5961.5 5964.0 5983.0 5818.8 5887.5 5894.3 5904.7 5931.1 13:26:04 INFO - PROCESS | 20144 | 13:26:04 INFO - PROCESS | 20144 | [#5] yui.html Cycles:180 Average:21595.32 Median:3647.16 stddev:31330.96 (859.1%) stddev-sans-first:31379.41 13:26:04 INFO - PROCESS | 20144 | Values: 657.9 738.7 785.6 791.9 798.9 15657.9 17011.1 17051.6 17108.7 17196.9 15366.6 15496.8 15508.8 15512.6 15532.3 655.9 787.1 806.8 811.4 822.5 815.7 816.0 816.4 817.8 818.0 857.9 860.0 860.1 861.8 862.1 843.5 846.7 848.5 849.8 854.2 617.8 623.1 623.2 624.2 625.2 15711.9 15729.3 15730.6 15749.5 15755.2 14953.6 15607.0 15644.9 15733.1 15761.3 11718.6 11763.3 11776.8 12043.5 12087.2 3946.7 3959.9 3972.5 4016.8 4139.2 75333.2 77045.0 78142.0 79488.2 79861.0 11440.1 11858.3 11888.4 11942.9 12028.6 22780.4 23037.2 23086.9 23107.9 23209.3 8446.7 8614.6 8705.8 8708.7 8711.4 4601.5 4807.7 4854.5 4881.7 5019.0 3532.2 3628.4 3646.9 3647.5 3671.0 691.0 734.2 735.3 739.3 747.6 700.5 708.8 746.2 755.5 759.5 9820.9 10017.1 10081.6 10127.4 10562.5 645.9 677.4 734.6 749.4 752.4 4788.2 4845.3 4923.4 4949.0 4975.2 114436.0 127158.4 127442.0 128612.4 130253.3 100728.0 102538.5 108787.0 112723.4 113139.4 56910.0 76272.0 88004.1 88567.6 89732.6 9857.6 10382.2 10636.2 10649.7 10925.8 50624.5 50837.5 51146.0 52158.5 52605.7 60692.7 78181.0 78628.6 79298.2 80030.0 12665.5 13538.0 13567.9 13593.0 13792.7 15392.5 15420.1 15551.3 15566.1 15609.5 14213.6 14314.3 14923.7 14958.3 15265.5 14251.0 14473.5 14892.4 15122.8 15412.4 13621.5 14347.9 14355.8 14925.0 15115.3 11082.3 11285.4 11475.5 11519.8 11613.9 10706.6 10826.8 11025.3 11791.9 12644.3 13:26:04 INFO - PROCESS | 20144 | -------- Summary: end -------- 13:26:04 INFO - PROCESS | 20144 | 13:26:05 INFO - TEST-INFO | 20144: exit 0 13:26:05 INFO - TEST-OK | dromaeo_css | took 1111802ms 13:26:05 INFO - TEST-START | kraken 13:26:05 INFO - operating with platform_type : linux_ 13:26:05 INFO - Initialising browser for kraken test... 13:26:05 INFO - TEST-INFO | started process 20390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96LOXA/profile http://localhost:46255/getInfo.html) 13:26:10 INFO - PROCESS | 20390 | __metrics Screen width/height:1600/1200 13:26:10 INFO - PROCESS | 20390 | colorDepth:24 13:26:10 INFO - PROCESS | 20390 | Browser inner width/height: 1024/697 13:26:10 INFO - PROCESS | 20390 | __metrics 13:26:10 ERROR - PROCESS | 20390 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:26:11 INFO - TEST-INFO | 20390: exit 0 13:26:11 INFO - Browser initialized. 13:26:11 INFO - Running cycle 1/1 for kraken test... 13:26:11 INFO - TEST-INFO | started process 20509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96LOXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:23 INFO - PROCESS | 20509 | RSS: Main: 167251968 13:26:23 INFO - PROCESS | 20509 | 13:26:25 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46255/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:26 INFO - PROCESS | 20509 | RSS: Main: 172916736 13:26:26 INFO - PROCESS | 20509 | 13:26:29 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46255/tests/kraken/driver.html?testName=audio-dft) 13:26:30 INFO - PROCESS | 20509 | RSS: Main: 171851776 13:26:30 INFO - PROCESS | 20509 | 13:26:32 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46255/tests/kraken/driver.html?testName=audio-fft) 13:26:33 INFO - PROCESS | 20509 | RSS: Main: 168095744 13:26:33 INFO - PROCESS | 20509 | 13:26:35 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46255/tests/kraken/driver.html?testName=audio-oscillator) 13:26:36 INFO - PROCESS | 20509 | RSS: Main: 169361408 13:26:36 INFO - PROCESS | 20509 | 13:26:38 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:39 INFO - PROCESS | 20509 | RSS: Main: 170274816 13:26:39 INFO - PROCESS | 20509 | 13:26:42 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46255/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:42 INFO - PROCESS | 20509 | RSS: Main: 169410560 13:26:42 INFO - PROCESS | 20509 | 13:26:46 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46255/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:46 INFO - PROCESS | 20509 | RSS: Main: 167501824 13:26:46 INFO - PROCESS | 20509 | 13:26:49 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46255/tests/kraken/driver.html?testName=json-parse-financial) 13:26:50 INFO - PROCESS | 20509 | RSS: Main: 169091072 13:26:50 INFO - PROCESS | 20509 | 13:26:51 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:52 INFO - PROCESS | 20509 | RSS: Main: 169013248 13:26:52 INFO - PROCESS | 20509 | 13:26:54 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:55 INFO - PROCESS | 20509 | RSS: Main: 169590784 13:26:55 INFO - PROCESS | 20509 | 13:26:57 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:57 INFO - PROCESS | 20509 | RSS: Main: 170049536 13:26:57 INFO - PROCESS | 20509 | 13:27:00 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:01 INFO - PROCESS | 20509 | RSS: Main: 169955328 13:27:01 INFO - PROCESS | 20509 | 13:27:03 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:04 INFO - PROCESS | 20509 | RSS: Main: 170139648 13:27:04 INFO - PROCESS | 20509 | 13:27:05 INFO - PROCESS | 20509 | Cycle 1(1): loaded http://localhost:46255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46255/tests/kraken/driver.html?testName=ai-astar) 13:27:06 INFO - PROCESS | 20509 | RSS: Main: 170844160 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | __start_tp_report 13:27:06 INFO - PROCESS | 20509 | _x_x_mozilla_page_load 13:27:06 INFO - PROCESS | 20509 | _x_x_mozilla_page_load_details 13:27:06 INFO - PROCESS | 20509 | |i|pagename|runs| 13:27:06 INFO - PROCESS | 20509 | |0;ai-astar;102;112;104;111;111;112;113;113;111;120 13:27:06 INFO - PROCESS | 20509 | |1;audio-beat-detection;146;118;147;184;125;144;146;121;182;118 13:27:06 INFO - PROCESS | 20509 | |2;audio-dft;161;162;161;161;162;167;171;165;162;164 13:27:06 INFO - PROCESS | 20509 | |3;audio-fft;77;74;74;157;75;75;76;76;158;76 13:27:06 INFO - PROCESS | 20509 | |4;audio-oscillator;86;83;152;94;85;83;148;83;83;152 13:27:06 INFO - PROCESS | 20509 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;117;117;117 13:27:06 INFO - PROCESS | 20509 | |6;imaging-darkroom;147;148;148;151;149;146;147;147;150;147 13:27:06 INFO - PROCESS | 20509 | |7;imaging-desaturate;95;95;95;96;95;95;96;96;95;95 13:27:06 INFO - PROCESS | 20509 | |8;json-parse-financial;52;55;55;52;52;52;56;55;52;52 13:27:06 INFO - PROCESS | 20509 | |9;json-stringify-tinderbox;63;63;63;64;64;64;64;64;64;65 13:27:06 INFO - PROCESS | 20509 | |10;stanford-crypto-aes;77;76;84;75;75;76;76;77;77;76 13:27:06 INFO - PROCESS | 20509 | |11;stanford-crypto-ccm;129;121;134;132;123;131;128;141;165;133 13:27:06 INFO - PROCESS | 20509 | |12;stanford-crypto-pbkdf2;156;165;156;153;160;154;155;153;155;154 13:27:06 INFO - PROCESS | 20509 | |13;stanford-crypto-sha256-iterative;63;64;64;63;63;62;66;67;62;62 13:27:06 INFO - PROCESS | 20509 | __end_tp_report 13:27:06 INFO - PROCESS | 20509 | __start_cc_report 13:27:06 INFO - PROCESS | 20509 | _x_x_mozilla_cycle_collect,944 13:27:06 INFO - PROCESS | 20509 | __end_cc_report 13:27:06 INFO - PROCESS | 20509 | __startTimestamp1469046426218__endTimestamp 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | ------- Summary: start ------- 13:27:06 INFO - PROCESS | 20509 | Number of tests: 14 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:4.95 (4.4%) stddev-sans-first:4.08 13:27:06 INFO - PROCESS | 20509 | Values: 102.0 112.0 104.0 111.0 111.0 112.0 113.0 113.0 111.0 120.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:146.00 stddev:24.26 (16.6%) stddev-sans-first:25.70 13:27:06 INFO - PROCESS | 20509 | Values: 146.0 118.0 147.0 184.0 125.0 144.0 146.0 121.0 182.0 118.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.27 (2.0%) stddev-sans-first:3.33 13:27:06 INFO - PROCESS | 20509 | Values: 161.0 162.0 161.0 161.0 162.0 167.0 171.0 165.0 162.0 164.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.50 stddev:34.64 (45.9%) stddev-sans-first:36.33 13:27:06 INFO - PROCESS | 20509 | Values: 77.0 74.0 74.0 157.0 75.0 75.0 76.0 76.0 158.0 76.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:83.00 stddev:31.77 (38.3%) stddev-sans-first:32.95 13:27:06 INFO - PROCESS | 20509 | Values: 86.0 83.0 152.0 94.0 85.0 83.0 148.0 83.0 83.0 152.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:27:06 INFO - PROCESS | 20509 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.56 (1.1%) stddev-sans-first:1.62 13:27:06 INFO - PROCESS | 20509 | Values: 147.0 148.0 148.0 151.0 149.0 146.0 147.0 147.0 150.0 147.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:27:06 INFO - PROCESS | 20509 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.70 (3.2%) stddev-sans-first:1.74 13:27:06 INFO - PROCESS | 20509 | Values: 52.0 55.0 55.0 52.0 52.0 52.0 56.0 55.0 52.0 52.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 13:27:06 INFO - PROCESS | 20509 | Values: 63.0 63.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:2.60 (3.4%) stddev-sans-first:2.76 13:27:06 INFO - PROCESS | 20509 | Values: 77.0 76.0 84.0 75.0 75.0 76.0 76.0 77.0 77.0 76.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:132.50 stddev:12.36 (9.3%) stddev-sans-first:12.99 13:27:06 INFO - PROCESS | 20509 | Values: 129.0 121.0 134.0 132.0 123.0 131.0 128.0 141.0 165.0 133.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.50 stddev:3.73 (2.4%) stddev-sans-first:3.95 13:27:06 INFO - PROCESS | 20509 | Values: 156.0 165.0 156.0 153.0 160.0 154.0 155.0 153.0 155.0 154.0 13:27:06 INFO - PROCESS | 20509 | 13:27:06 INFO - PROCESS | 20509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.71 (2.7%) stddev-sans-first:1.80 13:27:06 INFO - PROCESS | 20509 | Values: 63.0 64.0 64.0 63.0 63.0 62.0 66.0 67.0 62.0 62.0 13:27:06 INFO - PROCESS | 20509 | -------- Summary: end -------- 13:27:06 INFO - PROCESS | 20509 | 13:27:07 INFO - TEST-INFO | 20509: exit 0 13:27:07 INFO - TEST-OK | kraken | took 61655ms 13:27:07 INFO - SUITE-END | took 1173s 13:27:07 INFO - Completed test suite (00:19:33) 13:27:07 INFO - javascript benchmark 13:27:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7373.661950728876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.4903990841512, 3099.287163952291, 3130.593022907022, 3144.71697547221, 3147.1817327494846, 5448.019356515825, 5530.170474428838, 5540.806071787489, 5545.805896793613, 5553.5834812389085, 5314.627976041678, 5374.220737992989, 5380.811671591495, 5433.239346491494, 5487.945120548793, 4981.178105612587, 5004.749762511878, 5022.296878437012, 5052.444231134572, 5052.444231134572, 4993.251012348141, 5046.041252162077, 5101.464346243647, 5109.233614957768, 5144.588432925357, 5079.4412614612365, 5089.287499750019, 5118.6416950813455, 5121.923171152435, 5166.095933211692, 4894.412670479565, 4916.311716359713, 4919.581835543983, 4979.228219625964, 5010.774515146791, 4930.728809915453, 4933.876653083666, 4936.185529387682, 4952.430470495903, 5017.673851199696, 5390.6226564140525, 5423.213634023084, 5424.105022671294, 5476.315460567429, 5492.0663487206875, 5698.914516282259, 5734.853029394138, 5761.88476230473, 5800.651960882361, 5825.38833422493, 5849.38581448946, 5884.323302820188, 5884.6469211847425, 5896.292444906639, 5901.321348044987, 5470.0, 5472.5621950243885, 5473.042217611902, 5473.06957817172, 5477.863053423656, 5837.0, 5944.5838791284195, 5985.042393217152, 5999.970000150059, 6016.42843929826, 5757.8560535986935, 5794.21778059965, 5825.854353641108, 5837.941620583825, 5839.9124013139835, 5845.532357411397, 5885.234919460443, 5894.17481552583, 5897.233359663216, 5922.3485416604135, 5637.774489020475, 5815.127730840408, 5833.533317334603, 5844.094165404369, 5867.0, 5639.971800140973, 5799.82600521985, 5833.125031245262, 5840.591158618856, 5978.1929439525975, 4464.553544645574, 4466.196084704719, 4476.216662084187, 4485.372047913294, 4513.480949690827, 3890.922181556353, 3990.5610382857863, 3998.140399814054, 4000.4599379084034, 4042.130941847458, 5529.612927095065, 5547.140193270049, 5588.050031494656, 5606.971965140148, 5628.60599758013, 5880.852978675567, 5898.203742494708, 5916.083007133901, 5919.55603329752, 5927.318358388754, 5593.916091258634, 5595.272614560081, 5599.552035837123, 5602.4957753802355, 5613.382527921925, 4954.801807927714, 5015.097282489114, 5048.469910659402, 5056.696598204119, 5110.207917772751, 6034.366391528914, 6043.697815109315, 6052.54605904559, 6058.636481811105, 6060.33336333003, 5836.620619659709, 5874.177615133799, 5879.0, 5896.616719913192, 5903.822885313448, 5868.853278668067, 5987.491063259672, 6048.4858787003595, 6088.4215999479975, 6117.583823141572, 5813.3895940925595, 5820.30156381237, 5848.53211743051, 5851.093080572518, 5851.561132914963, 5962.612430192024, 5967.9701601491715, 5974.850628734316, 5978.581499295007, 5981.9401805983125, 5621.831345059655, 5671.432856714296, 5721.828345149652, 5748.080307150836, 5749.9712501437225, 5710.000749868674, 5741.598088133957, 5748.137779333133, 5755.280589926259, 5756.65460072397, 5578.274824272981, 5626.971865140648, 5630.549556035589, 5642.492175704207, 5658.179563963285, 5598.664080155041, 5663.886722265449, 5785.161151633074, 5812.593118481665, 5848.093545500455, 5695.686737229492, 5702.885942281214, 5707.828765137053, 5721.199032135588, 5723.255976723], "value": 5407.896011282825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.2578096152428, 575.9971200143999, 598.4912824099516, 601.1613798750745, 631.3087169549342, 39926.60073399265, 44413.77793111038, 44416.33375499366, 44433.555664443345, 44546.33180502295, 43131.3530297045, 44000.11999760003, 44282.0, 44309.11381772363, 44425.77787111068, 8847.469151850877, 8983.0, 8996.775080623003, 9015.594298256594, 9016.729498115033, 8787.912120878806, 8896.644134234622, 8918.643254269853, 8948.463092214488, 8949.77625559363, 8978.551072446384, 9022.86465703015, 9034.819303613924, 9036.954815225914, 9048.230900373443, 8909.1536304051, 8932.999999999967, 8972.057933916974, 9001.594928228245, 9002.639894404216, 8918.241949434307, 8927.0, 8946.329025323063, 8992.820143597157, 9000.909990900072, 41885.0, 42132.57867421348, 42262.36606450906, 42268.36597451041, 42367.15265694699, 3571.821408929543, 3658.5243918290716, 3677.595464498903, 3851.1615841643497, 4216.2832318505925, 33241.6675833241, 33404.498932516035, 33535.16162095943, 33613.83193084019, 35305.64694353049, 4377.409049778303, 4394.6923715339935, 4429.15845989261, 4444.177827101964, 4446.421965144543, 375039.0, 375519.0, 375806.0, 378348.0, 378829.0, 60176.09735853966, 60235.69882150649, 60405.697971509864, 60589.394106058375, 60664.39335606676, 61811.381886181465, 62185.0, 62509.68745156245, 62592.0, 62715.6864215676, 15299.0, 15364.692706145814, 15369.923150384177, 15436.45972390961, 15480.0, 11823.704407389712, 11909.285442873455, 11916.582919597773, 11916.808319168014, 11926.1651684383, 15814.76277855833, 17121.571960701083, 17156.142192890307, 17185.0, 17284.481465556055, 6393.9360606394275, 6520.217573891068, 6572.061241933641, 6579.374959378852, 6608.768693095719, 968.2931460034215, 1039.1167507618463, 1055.6991257491577, 1109.6615532262738, 1156.5720683347047, 32769.50845737316, 33853.32293354168, 33935.32129357448, 34106.0, 34351.0, 1040.661784919904, 1155.67063386936, 1181.6218809980896, 1213.5691829400612, 1235.5659351078361, 17307.0, 17424.825751742574, 17431.65136697259, 17503.212355444037, 17572.384966526366, 535415.0, 536896.0, 539009.0, 539822.0, 539868.0, 60038.39961600416, 60084.39915600788, 60177.69911150416, 60317.0, 60341.396586034454, 1314.901382396305, 1320.5444121778164, 1333.5465941579716, 1384.2248340929111, 1399.0766094377661, 31332.0, 33942.66057339395, 34553.0, 34873.30253394969, 34978.30043399169, 50990.490095098576, 51232.74383628058, 51280.743596281776, 51354.48645513497, 51487.48512514827, 414944.0, 416474.0, 419146.0, 419544.0, 420138.0, 28090.2977425566, 28349.14952551427, 28391.716082838906, 28445.288867778472, 28494.85752571224, 47629.761851190524, 47782.76108619435, 48293.27560086672, 48575.51424485851, 49671.0, 40766.38850417187, 41202.79398602988, 41915.37126943159, 42108.789456052524, 43237.567624323354, 41366.58633413627, 41786.0, 41831.163376732904, 42338.36492452677, 42764.35853462138, 35832.820835895654, 40962.385564217155, 41193.38209926793, 41822.16355672809, 42663.7866810664, 35374.46938295876, 37577.81211093927, 38018.239635206584, 38107.42838857364, 38453.615463845, 28514.57228141538, 28786.568201476577, 29161.0, 29381.412371752016, 29448.705512944598], "value": 20274.98553017267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.6805031697898, 381.8243607940348, 388.3921662598034, 395.9841606335747, 406.17546380846875, 17574.0, 19679.212831486722, 19811.20755169793, 19986.30047948322, 20057.699134512994, 18101.094945252717, 18288.542786430346, 18911.148998295077, 19265.229390824385, 19369.709454358162, 5856.824295271138, 5948.345681975001, 5996.820095397145, 6056.545759068065, 6075.513958883301, 5736.627119237257, 5890.734916928748, 5891.941080589182, 5925.822225333247, 5925.911111333312, 5525.0, 5719.628224165416, 5793.652380857141, 5833.241678581779, 5870.119482077701, 5680.233168522238, 5721.427857214246, 5809.186713860063, 5814.447627475383, 5849.03490923997, 5653.971730141364, 5787.13193021046, 5815.098659707752, 5830.212921255618, 5843.9707801461145, 14416.062955907832, 14421.351039203157, 14434.566962991126, 14474.42102315906, 19796.505087372785, 2247.1236217875044, 2256.2328808205125, 2475.6905386826647, 2953.719396657314, 2981.0311648714255, 9526.0, 9592.328537002413, 9973.35173213746, 10286.9485652572, 14252.501162459368, 1774.6184570317314, 1783.7502749615064, 1802.0989505247376, 1837.9473261458586, 1891.5743957609566, 83483.58258208731, 83589.16410835875, 84092.0, 85081.57459212726, 85648.0, 10234.795304094025, 10289.536970836181, 10702.73243168927, 10954.507047182897, 11144.60993865211, 14504.274786260645, 14539.636509087357, 14566.563003109924, 14586.854131458762, 14631.341589628491, 7399.0, 7721.305082542598, 7750.224977502205, 7830.765077047584, 7889.368850491946, 7505.474616776883, 7576.052993375828, 7764.301212890754, 7776.494527855672, 7813.960930195312, 4389.473263208435, 4412.382266482695, 4509.6843220974215, 4546.61353784932, 4659.114768194032, 1793.2647614478, 1855.9142901402831, 1859.4235786906102, 1879.3422302194122, 1928.633559623667, 830.7549272964369, 990.6087095597343, 1012.2610494339026, 1049.0768124050787, 1083.2254937719567, 18623.720644190347, 19711.80288197128, 19882.70175947362, 20046.699299510517, 20256.89871550633, 913.9908600914039, 957.167264479907, 996.4519514267269, 1002.754325190333, 1040.7033995311451, 9567.473788941676, 10867.578540502473, 10973.68788525602, 11040.0, 11045.0, 516576.0, 517535.0, 522946.0, 524532.0, 526919.0, 88932.5553372229, 90072.54963725139, 90255.54872225598, 90716.0, 91813.54093229491, 1016.5425558498705, 1018.8267994440963, 1022.0648106982028, 1027.547878933267, 1049.8320268756963, 16937.32250709958, 17388.91305543464, 17861.374851880122, 18022.729659055385, 18023.2790688371, 40610.79694601508, 42220.0, 42281.365779513944, 42634.78682606567, 43213.525185583116, 59006.0, 59149.0, 59194.0, 60208.39791602028, 60231.0, 7714.0, 8726.214640682369, 8767.824643507221, 8784.385093043426, 8846.601902914255, 12116.75766484683, 13376.130551514121, 13403.865961340261, 13417.664558385728, 13591.388387522784, 11937.701557461132, 11940.164188506722, 12062.0, 12140.878591213976, 12231.816522751988, 11314.434278285888, 11370.260933039326, 11429.142814289127, 11507.136964727511, 11540.365279909685, 10819.729506762395, 11233.32600044, 11480.483378248166, 11500.597479088192, 12136.271823690253, 7459.254074592497, 7667.233276672288, 8636.0, 8679.479231246145, 8752.256058234867, 6444.709988050643, 10362.0, 10916.672499825017, 11510.251833630788, 12294.692632684255], "value": 9094.622648820789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.1948267418268, 1552.417843308759, 1716.0990479998006, 1824.0, 1843.2995461724533, 8124.837503249932, 8735.563221838907, 8808.823823523526, 9312.068793120685, 9317.5807088681, 8798.252148567364, 9057.0, 9079.18287354138, 9110.362274640778, 9131.178193962542, 2346.5189636124596, 2348.365941195876, 2383.7616238376195, 2384.2847145856263, 2386.9880650596724, 2362.0669835415, 2381.1903952656094, 2391.964120538193, 2433.5862903306393, 2438.6829712137487, 2350.1421980976993, 2353.646952957053, 2362.574736547421, 2374.2877136858874, 2386.260259319608, 2329.6039673255586, 2351.1300818697105, 2365.562370961378, 2366.5740166769974, 2368.798652114572, 2299.310206937929, 2302.090674183705, 2306.2274138163734, 2310.6418505131733, 2314.6990891184205, 9136.954315228448, 9233.445993240428, 9250.907490925072, 9269.536523173882, 9278.072192780735, 5408.729563521808, 5419.295491586108, 5423.566114710814, 5489.6980666063355, 5517.834464966058, 3483.773554718935, 3514.0863375522295, 3524.753267271292, 3555.0, 3589.6948759355487, 1217.424009976936, 1219.7499512599895, 1223.804191329383, 1242.1243023668292, 1259.0494176896384, 12625.05312101596, 12735.172213806165, 12754.426050827735, 12755.553555625509, 12815.487380504768, 4666.2207876549755, 4762.166620841339, 4803.327534145223, 4904.117258893362, 4925.039617274669, 10669.78660426787, 10690.0, 10714.357138571711, 10718.785624287471, 10738.731531711614, 5503.532199763065, 5510.228568000483, 5536.2249285100115, 5544.22380866679, 5557.805476808292, 4342.174986752507, 4908.975455122773, 5023.648344615842, 5059.8988020239385, 5085.567726743268, 3940.862069827542, 4008.3586626139677, 4065.2276067547073, 4136.8138433770555, 4198.874033778991, 1241.6150993192139, 1265.0638527489775, 1266.892314153289, 1270.783966725659, 1274.4583551990368, 884.2616415293302, 1011.8077565262577, 1014.4319181258519, 1032.550840384435, 1035.4667346316653, 6015.796840631891, 6238.688065596702, 6308.179936608211, 6409.615423074631, 6438.259600146043, 449.1174841436593, 456.5936316678093, 458.209588459904, 464.21779301875773, 474.5515487864004, 4112.691548133902, 4169.728967617095, 4187.497500299984, 4220.915581688349, 4231.915361692811, 11064.17018723599, 11273.661790146309, 11394.316341019565, 11422.428878556038, 11495.597654082067, 11263.718407039889, 11332.943335283271, 11343.659690209306, 11346.773064538664, 11401.372924489067, 8084.312833409109, 8407.243348098822, 8503.74488765338, 8559.614817333235, 8605.526696031653, 6166.722497487534, 6275.435210831047, 6364.459020983083, 6373.74505019794, 6477.190351206099, 10095.44475053879, 10162.593496260066, 10225.181985441295, 10231.488425578542, 10296.639617613348, 10393.584256629953, 10435.269531133052, 10464.162866970471, 10481.266311358131, 10501.422421766876, 7430.368418684472, 7953.403494737802, 8008.559529225949, 8058.274755272054, 8186.181381861767, 9110.453372797654, 9207.953960230156, 9229.630814767603, 9234.861477077715, 9240.353175277934, 7692.0384951881015, 7842.607869606611, 7954.920450795418, 8222.958885205535, 8268.09051004377, 7874.842503150019, 7879.0939042010905, 8014.879776803236, 8025.398095142771, 8064.0, 7235.674394652358, 7365.116186057708, 7395.297446742551, 7423.331900129015, 7435.293647103516, 5538.944610554004, 5584.581156413366, 5634.211210430461, 5657.60396772222, 5710.114932185518, 5530.5022547970875, 5552.750126244248, 5645.604807663424, 5741.45456181662, 5797.652140871562], "value": 4725.796430162606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6353244340568, 319.340561740007, 322.8692379586267, 326.61948829613493, 328.2745133255506, 5555.472230138141, 5571.5513966368735, 5691.772329106836, 5778.5377169826415, 5826.067829147342, 5636.633618814774, 5638.633488823224, 5660.575456840733, 5668.121441176624, 5725.4847063764255, 4390.956090439103, 4419.469663640368, 4429.446319210098, 4434.733915965036, 4450.821967121327, 4136.193442278757, 4273.722208056482, 4291.935620965688, 4427.77861106945, 4443.800028998687, 4283.400323954634, 4284.828606855722, 4285.785710714467, 4297.656187504992, 4317.330813723878, 4319.935200971988, 4337.783110844445, 4338.414314067592, 4349.521552629209, 4351.521332653406, 3693.8522459101605, 3736.8692095776787, 3794.260119276742, 3823.1589050408866, 3827.8133778528745, 5423.2949716537, 5452.482014208644, 5485.369182543979, 5486.204500347428, 5518.862028449281, 4860.343853579792, 4926.3595732554895, 4927.581155601778, 4967.726775027372, 4975.253711943201, 5593.105103183471, 5855.531557475391, 5867.0, 5870.943230218559, 5874.50066744323, 4066.4916885389325, 4070.5115386153557, 4073.5722749111214, 4091.85678501254, 4104.4664193654935, 6146.784862529835, 6161.860055889675, 6181.6600086995195, 6208.4722798561725, 6229.968850155766, 4116.217918595457, 4167.5207351154395, 4206.663466922639, 4234.703570750018, 4245.596668316505, 4241.300185469425, 4242.681798865097, 4246.40550322955, 4264.381664658607, 4264.744115353089, 4945.332380128637, 4947.282644016669, 4983.25251212321, 4989.55094041538, 5004.299398084271, 5805.403514033675, 5911.881762364728, 5943.692387674705, 5960.672163031075, 5974.4622983930785, 1460.2552698124034, 1477.5150973272007, 1479.2677624575904, 1479.371267211431, 1479.7558402863408, 896.780288829241, 925.7454200094893, 931.9254459643212, 939.4691999020531, 944.2351695126969, 4997.425296090923, 5014.921791814777, 5020.397552293675, 5038.773255203525, 5097.8725531861255, 5304.904562697713, 5413.9729301353245, 5432.375276843213, 5461.726913654302, 5469.906018796177, 4935.259711043373, 5090.567301779391, 5097.796088156507, 5130.434348128015, 5133.845984620392, 2893.4791737487453, 2896.2904088498453, 2901.433226057947, 2907.680155182928, 2933.8093023953375, 5451.018816613047, 5531.778728850801, 5534.0, 5547.667139971534, 5598.768270980378, 5308.522232999048, 5352.0, 5423.918641220384, 5461.890762184734, 5496.532794712414, 5387.8653033675255, 5456.645318054314, 5460.890782184334, 5534.7860855658055, 5571.554275657938, 5316.494932981361, 5370.9731451342495, 5413.431589683184, 5421.5391691706645, 5697.743601537858, 6036.92117020314, 6057.606255593549, 6060.6969651516365, 6079.966405711129, 6094.329623741296, 6306.400891915261, 6312.747490100344, 6343.636118234602, 6364.64994425311, 6383.648899310582, 3854.20988697322, 4174.77038762871, 4176.791160442027, 4182.64447521964, 4208.831646734219, 6115.785947491817, 6126.663033533198, 6162.691865406622, 6198.473129783839, 6199.039148931923, 5805.709714514342, 5895.64626122434, 6019.277686677627, 6029.306629737636, 6056.515478761777, 5850.356460789395, 5864.67744274069, 5907.9704601476715, 5919.312995796177, 5966.343702192842, 5812.18629391877, 5846.064629659234, 5851.795187168429, 5866.0, 5866.442687944638, 5865.354810970875, 5936.554758393224, 5961.4898269867435, 5963.970180149072, 5982.970085149546, 5818.8254352369495, 5887.470127688529, 5894.322152952465, 5904.704764761831, 5931.08068249422], "value": 4353.749370011182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.8684263147371, 738.6749830074764, 785.5522352259211, 791.9168487308832, 798.8641930871751, 15657.921710391447, 17011.14944252787, 17051.57371065724, 17108.657826843457, 17196.91401542992, 15366.615834604141, 15496.767548486754, 15508.767368489454, 15512.612184695388, 15532.301046452909, 655.8884989551788, 787.122358570193, 806.7942674617964, 811.4319976016783, 822.5023860564362, 815.6655771133836, 815.9592020398957, 816.4121832280748, 817.8037271054964, 817.9591020448984, 857.9184977427135, 860.0, 860.0711231869598, 861.8491763941316, 862.0517430826072, 843.5023336231592, 846.6782622603403, 848.5121055393174, 849.8215374771244, 854.1842540373959, 617.8424501752024, 623.0902881792588, 623.2147494157349, 624.2446639566131, 625.1591609285549, 15711.92144039284, 15729.292181851844, 15730.606734831606, 15749.527514174593, 15755.212239387985, 14953.551393458214, 15607.0, 15644.92177539105, 15733.134677592841, 15761.290741916526, 11718.648440546796, 11763.2942023478, 11776.764464710657, 12043.458044387937, 12087.153899227058, 3946.6842652587725, 3959.8614048508166, 3972.523297204354, 4016.7790771507557, 4139.172165566899, 75333.24666753317, 77045.0, 78142.0, 79488.20511794866, 79861.0, 11440.141989350832, 11858.288502689693, 11888.405579720978, 11942.880571194351, 12028.63914082579, 22780.4304892379, 23037.193698220482, 23086.884565577064, 23107.88446057759, 23209.3037208884, 8446.704365347307, 8614.574536784039, 8705.768395404466, 8708.738737837875, 8711.433756805787, 4601.493835678073, 4807.678022255593, 4854.490278520775, 4881.731504767272, 5018.996200759862, 3532.1699400640828, 3628.3650361186687, 3646.854125834937, 3647.471116688065, 3670.963290367062, 690.9689063992132, 734.1850545894054, 735.290444720847, 739.2976672161361, 747.637395863006, 700.5271342478312, 708.7696498637861, 746.1568427676799, 755.4787196834167, 759.5480688990042, 9820.852687209697, 10017.14854237398, 10081.647142349982, 10127.442990635585, 10562.524686388977, 645.9471062168728, 677.395414630744, 734.5702763883188, 749.3555542233674, 752.3567349915853, 4788.186008378584, 4845.345878306454, 4923.409190897044, 4949.0, 4975.203967365204, 114436.0, 127158.36420818022, 127442.0, 128612.35693821471, 130253.34873325573, 100728.0, 102538.48730756299, 108787.0, 112723.4363828192, 113139.4343028296, 56910.0, 76272.0, 88004.11995880216, 88567.55716221378, 89732.5513372429, 9857.605695772088, 10382.221333399873, 10636.202284828823, 10649.733756656145, 10925.781484370109, 50624.49375506198, 50837.491625083276, 51146.0, 52158.47841521536, 52605.7369713149, 60692.69653651703, 78181.0, 78628.60685696534, 79298.20701792907, 80030.0, 12665.493380265054, 13538.0, 13567.86432135666, 13593.0, 13792.724145517233, 15392.461263855712, 15420.055007794355, 15551.300191491637, 15566.066036037873, 15609.453669121527, 14213.573592792232, 14314.284285785461, 14923.701525969636, 14958.32687529042, 15265.465708700141, 14251.0, 14473.493427729978, 14892.40430382816, 15122.773158402853, 15412.383504660136, 13621.455141794217, 14347.856521434653, 14355.779758720626, 14924.955253132177, 15115.31981060833, 11082.279651822606, 11285.37930413835, 11475.48360323804, 11519.835957058283, 11613.883861161281, 10706.62526811589, 10826.76285156436, 11025.338479691245, 11791.941040294743, 12644.30456324911], "value": 7833.289234128254, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 104.0, 111.0, 111.0, 112.0, 113.0, 113.0, 111.0, 120.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 147.0, 184.0, 125.0, 144.0, 146.0, 121.0, 182.0, 118.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 167.0, 171.0, 165.0, 162.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 157.0, 75.0, 75.0, 76.0, 76.0, 158.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 152.0, 94.0, 85.0, 83.0, 148.0, 83.0, 83.0, 152.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 151.0, 149.0, 146.0, 147.0, 147.0, 150.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 55.0, 52.0, 52.0, 52.0, 56.0, 55.0, 52.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 84.0, 75.0, 75.0, 76.0, 76.0, 77.0, 77.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 134.0, 132.0, 123.0, 131.0, 128.0, 141.0, 165.0, 133.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 156.0, 153.0, 160.0, 154.0, 155.0, 153.0, 155.0, 154.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 62.0, 66.0, 67.0, 62.0, 62.0], "value": 63.6, "unit": "score"}]}]} 13:27:07 INFO - Return code: 0 13:27:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:27:07 ERROR - # TBPL SUCCESS # 13:27:07 INFO - Running post-action listener: _resource_record_post_action 13:27:07 INFO - [mozharness: 2016-07-20 20:27:07.537650Z] Finished run-tests step (success) 13:27:07 INFO - Running post-run listener: _resource_record_post_run 13:27:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559267840; Read time: 12; Write time: 425340 13:27:07 INFO - TinderboxPrint: CPU usage
13.4% 13:27:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:27:07 INFO - TinderboxPrint: I/O write bytes / time
559,267,840 / 425,340 13:27:07 INFO - TinderboxPrint: CPU idle
8,229.8 (86.6%) 13:27:07 INFO - TinderboxPrint: CPU user
1,216.4 (12.8%) 13:27:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:27:07 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 264032256; Read time: 0; Write time: 239248 13:27:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291282944; Read time: 0; Write time: 185560 13:27:08 INFO - Running post-run listener: _upload_blobber_files 13:27:08 INFO - Blob upload gear active. 13:27:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:27:08 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 13:27:08 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:27:08 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:27:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:09 INFO - (blobuploader) - INFO - Done attempting. 13:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:15 INFO - (blobuploader) - INFO - Done attempting. 13:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:16 INFO - (blobuploader) - INFO - Done attempting. 13:27:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:16 INFO - Return code: 0 13:27:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6487d725a23780705ee4786a031837a8f08e4c8dc80873ab382b83ad205c5a03a1025174563632a979e9392942213249bdfbcfe5a39b68932dfe7f3064245700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97d40f9b79aaa1c343e916f3687c311f8f9afa8c06932697f99a7923080ca4a0ba0fec538d691aa81f87ac15a5d7eb77251c246585fe152b38df2199d6bdcab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a31a434c33b538587cc295507712c99f725bdcda515a2d43d464122d18241295d8cf629dccc924fbbb7002cf5d6ba0bee8d83e4d6e3c76ba29fe8d7f4157e"} 13:27:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:16 INFO - Contents: 13:27:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6487d725a23780705ee4786a031837a8f08e4c8dc80873ab382b83ad205c5a03a1025174563632a979e9392942213249bdfbcfe5a39b68932dfe7f3064245700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97d40f9b79aaa1c343e916f3687c311f8f9afa8c06932697f99a7923080ca4a0ba0fec538d691aa81f87ac15a5d7eb77251c246585fe152b38df2199d6bdcab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a31a434c33b538587cc295507712c99f725bdcda515a2d43d464122d18241295d8cf629dccc924fbbb7002cf5d6ba0bee8d83e4d6e3c76ba29fe8d7f4157e"} 13:27:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:16 INFO - Copying logs to upload dir... 13:27:16 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.778023 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-20 13:27:15.959380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:27:15.963323) ========= 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=4300f881736b422476174874000001bc-1469045202.460223-830156693 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/sha512/6487d725a23780705ee4786a031837a8f08e4c8dc80873ab382b83ad205c5a03a1025174563632a979e9392942213249bdfbcfe5a39b68932dfe7f3064245700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97d40f9b79aaa1c343e916f3687c311f8f9afa8c06932697f99a7923080ca4a0ba0fec538d691aa81f87ac15a5d7eb77251c246585fe152b38df2199d6bdcab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a31a434c33b538587cc295507712c99f725bdcda515a2d43d464122d18241295d8cf629dccc924fbbb7002cf5d6ba0bee8d83e4d6e3c76ba29fe8d7f4157e"} build_url:https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/eS-3YTpnQTGWxRN_xymbwg/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/sha512/6487d725a23780705ee4786a031837a8f08e4c8dc80873ab382b83ad205c5a03a1025174563632a979e9392942213249bdfbcfe5a39b68932dfe7f3064245700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97d40f9b79aaa1c343e916f3687c311f8f9afa8c06932697f99a7923080ca4a0ba0fec538d691aa81f87ac15a5d7eb77251c246585fe152b38df2199d6bdcab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a31a434c33b538587cc295507712c99f725bdcda515a2d43d464122d18241295d8cf629dccc924fbbb7002cf5d6ba0bee8d83e4d6e3c76ba29fe8d7f4157e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:27:15.992521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:27:15.993235) ========= 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=4300f881736b422476174874000001bc-1469045202.460223-830156693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:27:16.075241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:27:16.075958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:27:16.076571) ========= ========= Total master_lag: 0.19 =========