builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1452739050.72 results: success (0) buildid: 20160113172632 builduid: 22bf167a9a794d08bff7ef6bbcf89bc7 revision: 3c473ad89a25a48b7aeb7e48633355c965ac45df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.717412) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.717990) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.718276) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.744451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.744753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.767029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.767278) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.816139) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.816405) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.816772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.817042) ========= 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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 18:37:31-- 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% 43.5M=0s 2016-01-13 18:37:31 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.990381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:30.990666) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.042942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.043244) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c473ad89a25a48b7aeb7e48633355c965ac45df --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 3c473ad89a25a48b7aeb7e48633355c965ac45df --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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 18:37:31,699 truncating revision to first 12 chars 2016-01-13 18:37:31,699 Setting DEBUG logging. 2016-01-13 18:37:31,699 attempt 1/10 2016-01-13 18:37:31,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c473ad89a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 18:37:31,978 unpacking tar archive at: mozilla-central-3c473ad89a25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.634920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.635198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.648273) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.648565) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:37:31.648960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-13 18:37:31.649237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:32 INFO - MultiFileLogger online at 20160113 18:37:32 in /builds/slave/test 18:37:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:37:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:37:32 INFO - {'append_to_log': False, 18:37:32 INFO - 'base_work_dir': '/builds/slave/test', 18:37:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:37:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:37:32 INFO - 'branch': 'Firefox-Non-PGO', 18:37:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:32 INFO - 'config_files': ('talos/linux_config.py',), 18:37:32 INFO - 'default_actions': ('clobber', 18:37:32 INFO - 'read-buildbot-config', 18:37:32 INFO - 'download-and-extract', 18:37:32 INFO - 'populate-webroot', 18:37:32 INFO - 'create-virtualenv', 18:37:32 INFO - 'install', 18:37:32 INFO - 'run-tests'), 18:37:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:32 INFO - 'download_minidump_stackwalk': True, 18:37:32 INFO - 'download_symbols': 'ondemand', 18:37:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:37:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:37:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:37:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:37:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:32 INFO - 'installer_path': 'installer.exe', 18:37:32 INFO - 'log_level': 'info', 18:37:32 INFO - 'log_name': 'talos', 18:37:32 INFO - 'log_to_console': True, 18:37:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:32 INFO - 'opt_config_files': (), 18:37:32 INFO - 'pip_index': False, 18:37:32 INFO - 'sps_profile': False, 18:37:32 INFO - 'sps_profile_interval': 0, 18:37:32 INFO - 'suite': 'dromaeojs-e10s', 18:37:32 INFO - 'system_bits': '32', 18:37:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:32 INFO - 'title': 'talos-linux64-ix-056', 18:37:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:32 INFO - 'use_talos_json': True, 18:37:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:37:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:32 INFO - 'work_dir': 'build'} 18:37:32 INFO - ##### 18:37:32 INFO - ##### Running clobber step. 18:37:32 INFO - ##### 18:37:32 INFO - Running pre-action listener: _resource_record_pre_action 18:37:32 INFO - Running main action method: clobber 18:37:32 INFO - rmtree: /builds/slave/test/build 18:37:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:37:33 INFO - Running post-action listener: _resource_record_post_action 18:37:33 INFO - ##### 18:37:33 INFO - ##### Running read-buildbot-config step. 18:37:33 INFO - ##### 18:37:33 INFO - Running pre-action listener: _resource_record_pre_action 18:37:33 INFO - Running main action method: read_buildbot_config 18:37:33 INFO - Using buildbot properties: 18:37:33 INFO - { 18:37:33 INFO - "project": "", 18:37:33 INFO - "product": "firefox", 18:37:33 INFO - "script_repo_revision": "production", 18:37:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:37:33 INFO - "repository": "", 18:37:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:37:33 INFO - "buildid": "20160113172632", 18:37:33 INFO - "pgo_build": "False", 18:37:33 INFO - "basedir": "/builds/slave/test", 18:37:33 INFO - "buildnumber": 153, 18:37:33 INFO - "slavename": "talos-linux64-ix-056", 18:37:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:37:33 INFO - "platform": "ubuntu64_hw", 18:37:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:37:33 INFO - "branch": "mozilla-central", 18:37:33 INFO - "repo_path": "mozilla-central", 18:37:33 INFO - "revision": "3c473ad89a25a48b7aeb7e48633355c965ac45df", 18:37:33 INFO - "stage_platform": "linux64", 18:37:33 INFO - "builduid": "22bf167a9a794d08bff7ef6bbcf89bc7", 18:37:33 INFO - "slavebuilddir": "test" 18:37:33 INFO - } 18:37:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:37:33 INFO - Running post-action listener: _resource_record_post_action 18:37:33 INFO - ##### 18:37:33 INFO - ##### Running download-and-extract step. 18:37:33 INFO - ##### 18:37:33 INFO - Running pre-action listener: _resource_record_pre_action 18:37:33 INFO - Running main action method: download_and_extract 18:37:33 INFO - mkdir: /builds/slave/test/build/tests 18:37: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')]} 18:37:33 INFO - https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:37:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/test_packages.json 18:37:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/test_packages.json 18:37:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:37:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:37:36 INFO - Downloaded 1448 bytes. 18:37:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:37:36 INFO - Using the following test package requirements: 18:37:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:37:36 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:37:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'jsshell-linux-x86_64.zip'], 18:37:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:37:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:37:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:37:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:37:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:37:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:36 INFO - https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:37:42 INFO - Downloaded 22762442 bytes. 18:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:37:43 INFO - Return code: 0 18:37:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:43 INFO - https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:37:48 INFO - Downloaded 22762442 bytes. 18:37:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:37:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:37:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:37:49 INFO - Return code: 0 18:37:49 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')]} 18:37:49 INFO - https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:37:52 INFO - Downloaded 11132279 bytes. 18:37:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:37:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:37:52 INFO - Return code: 0 18:37: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')]} 18:37:52 INFO - https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:37:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:37:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:37:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:37:56 INFO - Downloaded 53892768 bytes. 18:37:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:37:56 INFO - mkdir: /builds/slave/test/properties 18:37:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:37:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:37:56 INFO - Contents: 18:37:56 INFO - build_url:https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:37:56 INFO - Running post-action listener: _resource_record_post_action 18:37:56 INFO - Running post-action listener: set_extra_try_arguments 18:37:56 INFO - ##### 18:37:56 INFO - ##### Running populate-webroot step. 18:37:56 INFO - ##### 18:37:56 INFO - Running pre-action listener: _resource_record_pre_action 18:37:56 INFO - Running main action method: populate_webroot 18:37:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:37:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:37:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:37:56 INFO - '--tppagecycles', 18:37:56 INFO - '7'], 18:37:56 INFO - 'tests': ['tsvgm']}}, 18:37:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:37:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:37:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:37:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:37:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'tests': ['damp', 'tps']}, 18:37:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['damp', 'tps']}, 18:37:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:37:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:37:56 INFO - 'other': {'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'other_l64': {'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'other_nol64': {'tests': ['a11yr', 18:37:56 INFO - 'ts_paint', 18:37:56 INFO - 'tpaint', 18:37:56 INFO - 'sessionrestore', 18:37:56 INFO - 'sessionrestore_no_auto_restore']}, 18:37:56 INFO - 'svgr': {'tests': ['tsvgx', 18:37:56 INFO - 'tsvgr_opacity', 18:37:56 INFO - 'tart', 18:37:56 INFO - 'tscrollx', 18:37:56 INFO - 'cart']}, 18:37:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['tsvgx', 18:37:56 INFO - 'tsvgr_opacity', 18:37:56 INFO - 'tart', 18:37:56 INFO - 'tscrollx', 18:37:56 INFO - 'cart']}, 18:37:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'tests': ['tp5o']}, 18:37:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'talos_options': ['--e10s'], 18:37:56 INFO - 'tests': ['tp5o']}, 18:37:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'talos_options': ['--xperf_path', 18:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:56 INFO - 'tests': ['tp5n']}, 18:37:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:56 INFO - 'talos_options': ['--e10s', 18:37:56 INFO - '--xperf_path', 18:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:56 INFO - 'tests': ['tp5n']}}, 18:37:56 INFO - 'talos.zip': {'path': '', 18:37:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:37:56 INFO - Running post-action listener: _resource_record_post_action 18:37:56 INFO - ##### 18:37:56 INFO - ##### Running create-virtualenv step. 18:37:56 INFO - ##### 18:37:56 INFO - Running pre-action listener: _resource_record_pre_action 18:37:56 INFO - Running main action method: create_virtualenv 18:37:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:37:56 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 18:37:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:37:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:37:56 INFO - Using real prefix '/usr' 18:37:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:37:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:37:58 INFO - Installing pip.................done. 18:37:58 INFO - Return code: 0 18:37:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:37:58 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')]} 18:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:58 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')]} 18:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:37:58 INFO - Using env: {'DISPLAY': ':0', 18:37:58 INFO - 'HOME': '/home/cltbld', 18:37:58 INFO - 'LANG': 'en_US.UTF-8', 18:37:58 INFO - 'LANGUAGE': 'en_US:en', 18:37:58 INFO - 'LOGNAME': 'cltbld', 18:37:58 INFO - 'MAIL': '/var/mail/cltbld', 18:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:58 INFO - 'MOZ_NO_REMOTE': '1', 18:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:58 INFO - 'NO_EM_RESTART': '1', 18:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:58 INFO - 'PWD': '/builds/slave/test', 18:37:58 INFO - 'SHELL': '/bin/bash', 18:37:58 INFO - 'SHLVL': '1', 18:37:58 INFO - 'TERM': 'linux', 18:37:58 INFO - 'TMOUT': '86400', 18:37:58 INFO - 'USER': 'cltbld', 18:37:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:58 INFO - '_': '/tools/buildbot/bin/python'} 18:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:59 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 18:37:59 INFO - Cleaning up... 18:37:59 INFO - Return code: 0 18:37:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37: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')]} 18:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 18:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 18:37:59 INFO - Using env: {'DISPLAY': ':0', 18:37:59 INFO - 'HOME': '/home/cltbld', 18:37:59 INFO - 'LANG': 'en_US.UTF-8', 18:37:59 INFO - 'LANGUAGE': 'en_US:en', 18:37:59 INFO - 'LOGNAME': 'cltbld', 18:37:59 INFO - 'MAIL': '/var/mail/cltbld', 18:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:59 INFO - 'MOZ_NO_REMOTE': '1', 18:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:59 INFO - 'NO_EM_RESTART': '1', 18:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:59 INFO - 'PWD': '/builds/slave/test', 18:37:59 INFO - 'SHELL': '/bin/bash', 18:37:59 INFO - 'SHLVL': '1', 18:37:59 INFO - 'TERM': 'linux', 18:37:59 INFO - 'TMOUT': '86400', 18:37:59 INFO - 'USER': 'cltbld', 18:37:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:59 INFO - '_': '/tools/buildbot/bin/python'} 18:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:59 INFO - Downloading/unpacking psutil>=0.7.1 18:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:38:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:01 INFO - Installing collected packages: psutil 18:38:01 INFO - Running setup.py install for psutil 18:38:01 INFO - building 'psutil._psutil_linux' extension 18:38:01 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 18:38:01 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 18:38:01 INFO - building 'psutil._psutil_posix' extension 18:38:01 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 18:38:01 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 18:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:01 INFO - Successfully installed psutil 18:38:01 INFO - Cleaning up... 18:38:01 INFO - Return code: 0 18:38:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 18:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 18:38:01 INFO - Using env: {'DISPLAY': ':0', 18:38:01 INFO - 'HOME': '/home/cltbld', 18:38:01 INFO - 'LANG': 'en_US.UTF-8', 18:38:01 INFO - 'LANGUAGE': 'en_US:en', 18:38:01 INFO - 'LOGNAME': 'cltbld', 18:38:01 INFO - 'MAIL': '/var/mail/cltbld', 18:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:01 INFO - 'MOZ_NO_REMOTE': '1', 18:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:01 INFO - 'NO_EM_RESTART': '1', 18:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:01 INFO - 'PWD': '/builds/slave/test', 18:38:01 INFO - 'SHELL': '/bin/bash', 18:38:01 INFO - 'SHLVL': '1', 18:38:01 INFO - 'TERM': 'linux', 18:38:01 INFO - 'TMOUT': '86400', 18:38:01 INFO - 'USER': 'cltbld', 18:38:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:01 INFO - '_': '/tools/buildbot/bin/python'} 18:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:38:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:38:03 INFO - Installing collected packages: mozsystemmonitor 18:38:03 INFO - Running setup.py install for mozsystemmonitor 18:38:04 INFO - Successfully installed mozsystemmonitor 18:38:04 INFO - Cleaning up... 18:38:04 INFO - Return code: 0 18:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38: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')]} 18:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38: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')]} 18:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:04 INFO - Using env: {'DISPLAY': ':0', 18:38:04 INFO - 'HOME': '/home/cltbld', 18:38:04 INFO - 'LANG': 'en_US.UTF-8', 18:38:04 INFO - 'LANGUAGE': 'en_US:en', 18:38:04 INFO - 'LOGNAME': 'cltbld', 18:38:04 INFO - 'MAIL': '/var/mail/cltbld', 18:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:04 INFO - 'MOZ_NO_REMOTE': '1', 18:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:04 INFO - 'NO_EM_RESTART': '1', 18:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:04 INFO - 'PWD': '/builds/slave/test', 18:38:04 INFO - 'SHELL': '/bin/bash', 18:38:04 INFO - 'SHLVL': '1', 18:38:04 INFO - 'TERM': 'linux', 18:38:04 INFO - 'TMOUT': '86400', 18:38:04 INFO - 'USER': 'cltbld', 18:38:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:04 INFO - '_': '/tools/buildbot/bin/python'} 18:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:06 INFO - Downloading docopt-0.6.1.tar.gz 18:38:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:06 INFO - Running setup.py install for blobuploader 18:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:06 INFO - Running setup.py install for requests 18:38:07 INFO - Running setup.py install for docopt 18:38:07 INFO - Successfully installed blobuploader requests docopt 18:38:07 INFO - Cleaning up... 18:38:07 INFO - Return code: 0 18:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 18:38:07 INFO - Using env: {'DISPLAY': ':0', 18:38:07 INFO - 'HOME': '/home/cltbld', 18:38:07 INFO - 'LANG': 'en_US.UTF-8', 18:38:07 INFO - 'LANGUAGE': 'en_US:en', 18:38:07 INFO - 'LOGNAME': 'cltbld', 18:38:07 INFO - 'MAIL': '/var/mail/cltbld', 18:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:07 INFO - 'MOZ_NO_REMOTE': '1', 18:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:07 INFO - 'NO_EM_RESTART': '1', 18:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:07 INFO - 'PWD': '/builds/slave/test', 18:38:07 INFO - 'SHELL': '/bin/bash', 18:38:07 INFO - 'SHLVL': '1', 18:38:07 INFO - 'TERM': 'linux', 18:38:07 INFO - 'TMOUT': '86400', 18:38:07 INFO - 'USER': 'cltbld', 18:38:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:07 INFO - '_': '/tools/buildbot/bin/python'} 18:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:07 INFO - Running setup.py (path:/tmp/pip-BVw7VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:07 INFO - Running setup.py (path:/tmp/pip-RtOo5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:07 INFO - Running setup.py (path:/tmp/pip-JD0zEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:07 INFO - Running setup.py (path:/tmp/pip-2yptZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:07 INFO - Running setup.py (path:/tmp/pip-kD0Ngg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:07 INFO - Running setup.py (path:/tmp/pip-SSBLmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:07 INFO - Running setup.py (path:/tmp/pip-sS90ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:08 INFO - Running setup.py (path:/tmp/pip-oLryxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:08 INFO - Running setup.py (path:/tmp/pip-c1GEWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:08 INFO - Running setup.py (path:/tmp/pip-hAKK2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:08 INFO - Running setup.py (path:/tmp/pip-KaeKJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:08 INFO - Running setup.py (path:/tmp/pip-wV_Cxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:08 INFO - Running setup.py (path:/tmp/pip-8W4doP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:08 INFO - Running setup.py (path:/tmp/pip-9VE_N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:08 INFO - Running setup.py (path:/tmp/pip-cBcRSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:08 INFO - Running setup.py (path:/tmp/pip-sQxrtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:08 INFO - Running setup.py (path:/tmp/pip-lkqEKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:08 INFO - Running setup.py install for manifestparser 18:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:08 INFO - Running setup.py install for mozcrash 18:38:08 INFO - Running setup.py install for mozdebug 18:38:09 INFO - Running setup.py install for mozdevice 18:38:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for mozfile 18:38:09 INFO - Running setup.py install for mozhttpd 18:38:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for mozinfo 18:38:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for mozInstall 18:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for mozleak 18:38:09 INFO - Running setup.py install for mozlog 18:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for moznetwork 18:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:09 INFO - Running setup.py install for mozprocess 18:38:10 INFO - Running setup.py install for mozprofile 18:38:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:10 INFO - Running setup.py install for mozrunner 18:38:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:10 INFO - Running setup.py install for mozscreenshot 18:38:10 INFO - Running setup.py install for moztest 18:38:10 INFO - Running setup.py install for mozversion 18:38:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:10 INFO - Cleaning up... 18:38:10 INFO - Return code: 0 18:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:10 INFO - Using env: {'DISPLAY': ':0', 18:38:10 INFO - 'HOME': '/home/cltbld', 18:38:10 INFO - 'LANG': 'en_US.UTF-8', 18:38:10 INFO - 'LANGUAGE': 'en_US:en', 18:38:10 INFO - 'LOGNAME': 'cltbld', 18:38:10 INFO - 'MAIL': '/var/mail/cltbld', 18:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:10 INFO - 'MOZ_NO_REMOTE': '1', 18:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:10 INFO - 'NO_EM_RESTART': '1', 18:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:10 INFO - 'PWD': '/builds/slave/test', 18:38:10 INFO - 'SHELL': '/bin/bash', 18:38:10 INFO - 'SHLVL': '1', 18:38:10 INFO - 'TERM': 'linux', 18:38:10 INFO - 'TMOUT': '86400', 18:38:10 INFO - 'USER': 'cltbld', 18:38:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:10 INFO - '_': '/tools/buildbot/bin/python'} 18:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:10 INFO - Running setup.py (path:/tmp/pip-u6m48h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:10 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)) 18:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:10 INFO - Running setup.py (path:/tmp/pip-XOa42A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:10 INFO - Running setup.py (path:/tmp/pip-m26lFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38: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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:11 INFO - Running setup.py (path:/tmp/pip-gF55Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:11 INFO - Running setup.py (path:/tmp/pip-ehhKS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:11 INFO - Running setup.py (path:/tmp/pip-2mDSGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:11 INFO - Running setup.py (path:/tmp/pip-VAoF14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:11 INFO - Running setup.py (path:/tmp/pip-Hju5Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:11 INFO - Running setup.py (path:/tmp/pip-QlH4T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:11 INFO - Running setup.py (path:/tmp/pip-62Shar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:11 INFO - Running setup.py (path:/tmp/pip-sqAbf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:11 INFO - Running setup.py (path:/tmp/pip-cQvg7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:11 INFO - Running setup.py (path:/tmp/pip-Ngyeit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:11 INFO - Running setup.py (path:/tmp/pip-cYhoRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:11 INFO - Running setup.py (path:/tmp/pip-bZ5aV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:11 INFO - Running setup.py (path:/tmp/pip-L05Vct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:11 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)) 18:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:11 INFO - Running setup.py (path:/tmp/pip-dUyvhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38: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)) 18:38: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38: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)) 18:38: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)) 18:38: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)) 18:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:13 INFO - Downloading blessings-1.5.1.tar.gz 18:38:13 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:13 INFO - Installing collected packages: blessings 18:38:13 INFO - Running setup.py install for blessings 18:38:13 INFO - Successfully installed blessings 18:38:13 INFO - Cleaning up... 18:38:14 INFO - Return code: 0 18:38:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:14 INFO - Reading from file tmpfile_stdout 18:38:14 INFO - Current package versions: 18:38:14 INFO - argparse == 1.2.1 18:38:14 INFO - blessings == 1.5.1 18:38:14 INFO - blobuploader == 1.2.4 18:38:14 INFO - docopt == 0.6.1 18:38:14 INFO - manifestparser == 1.1 18:38:14 INFO - mozInstall == 1.12 18:38:14 INFO - mozcrash == 0.16 18:38:14 INFO - mozdebug == 0.1 18:38:14 INFO - mozdevice == 0.48 18:38:14 INFO - mozfile == 1.2 18:38:14 INFO - mozhttpd == 0.7 18:38:14 INFO - mozinfo == 0.9 18:38:14 INFO - mozleak == 0.1 18:38:14 INFO - mozlog == 3.1 18:38:14 INFO - moznetwork == 0.27 18:38:14 INFO - mozprocess == 0.22 18:38:14 INFO - mozprofile == 0.28 18:38:14 INFO - mozrunner == 6.11 18:38:14 INFO - mozscreenshot == 0.1 18:38:14 INFO - mozsystemmonitor == 0.0 18:38:14 INFO - moztest == 0.7 18:38:14 INFO - mozversion == 1.4 18:38:14 INFO - psutil == 3.1.1 18:38:14 INFO - requests == 1.2.3 18:38:14 INFO - wsgiref == 0.1.2 18:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:14 INFO - Using env: {'DISPLAY': ':0', 18:38:14 INFO - 'HOME': '/home/cltbld', 18:38:14 INFO - 'LANG': 'en_US.UTF-8', 18:38:14 INFO - 'LANGUAGE': 'en_US:en', 18:38:14 INFO - 'LOGNAME': 'cltbld', 18:38:14 INFO - 'MAIL': '/var/mail/cltbld', 18:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:14 INFO - 'MOZ_NO_REMOTE': '1', 18:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:14 INFO - 'NO_EM_RESTART': '1', 18:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:14 INFO - 'PWD': '/builds/slave/test', 18:38:14 INFO - 'SHELL': '/bin/bash', 18:38:14 INFO - 'SHLVL': '1', 18:38:14 INFO - 'TERM': 'linux', 18:38:14 INFO - 'TMOUT': '86400', 18:38:14 INFO - 'USER': 'cltbld', 18:38:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:14 INFO - '_': '/tools/buildbot/bin/python'} 18:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 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)) 18:38:14 INFO - Cleaning up... 18:38:14 INFO - Return code: 0 18:38:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:38:14 INFO - Using env: {'DISPLAY': ':0', 18:38:14 INFO - 'HOME': '/home/cltbld', 18:38:14 INFO - 'LANG': 'en_US.UTF-8', 18:38:14 INFO - 'LANGUAGE': 'en_US:en', 18:38:14 INFO - 'LOGNAME': 'cltbld', 18:38:14 INFO - 'MAIL': '/var/mail/cltbld', 18:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:14 INFO - 'MOZ_NO_REMOTE': '1', 18:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:14 INFO - 'NO_EM_RESTART': '1', 18:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:14 INFO - 'PWD': '/builds/slave/test', 18:38:14 INFO - 'SHELL': '/bin/bash', 18:38:14 INFO - 'SHLVL': '1', 18:38:14 INFO - 'TERM': 'linux', 18:38:14 INFO - 'TMOUT': '86400', 18:38:14 INFO - 'USER': 'cltbld', 18:38:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:14 INFO - '_': '/tools/buildbot/bin/python'} 18:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:14 INFO - Downloading/unpacking jsonschema 18:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:38:16 INFO - Downloading/unpacking functools32 (from jsonschema) 18:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:16 INFO - warning: no files found matching '*.txt' 18:38:16 INFO - no previously-included directories found matching 'build' 18:38:16 INFO - no previously-included directories found matching 'dist' 18:38:16 INFO - no previously-included directories found matching '.git*' 18:38:16 INFO - Installing collected packages: jsonschema, functools32 18:38:16 INFO - Running setup.py install for functools32 18:38:16 INFO - warning: no files found matching '*.txt' 18:38:16 INFO - no previously-included directories found matching 'build' 18:38:16 INFO - no previously-included directories found matching 'dist' 18:38:16 INFO - no previously-included directories found matching '.git*' 18:38:16 INFO - Successfully installed jsonschema functools32 18:38:16 INFO - Cleaning up... 18:38:16 INFO - Return code: 0 18:38:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:38:16 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')]} 18:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:16 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')]} 18:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f051c8f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', '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 18:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 18:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 18:38:16 INFO - Using env: {'DISPLAY': ':0', 18:38:16 INFO - 'HOME': '/home/cltbld', 18:38:16 INFO - 'LANG': 'en_US.UTF-8', 18:38:16 INFO - 'LANGUAGE': 'en_US:en', 18:38:16 INFO - 'LOGNAME': 'cltbld', 18:38:16 INFO - 'MAIL': '/var/mail/cltbld', 18:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:16 INFO - 'MOZ_NO_REMOTE': '1', 18:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:16 INFO - 'NO_EM_RESTART': '1', 18:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:16 INFO - 'PWD': '/builds/slave/test', 18:38:16 INFO - 'SHELL': '/bin/bash', 18:38:16 INFO - 'SHLVL': '1', 18:38:16 INFO - 'TERM': 'linux', 18:38:16 INFO - 'TMOUT': '86400', 18:38:16 INFO - 'USER': 'cltbld', 18:38:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:16 INFO - '_': '/tools/buildbot/bin/python'} 18:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:17 INFO - Downloading/unpacking flake8 18:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:38:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:38:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:38:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:38:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:38:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:38:19 INFO - no previously-included directories found matching 'docs/_build' 18:38:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:38:19 INFO - Running setup.py install for pep8 18:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:38:19 INFO - no previously-included directories found matching 'docs/_build' 18:38:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:38:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:38:19 INFO - Cleaning up... 18:38:19 INFO - Return code: 0 18:38:19 INFO - Running post-action listener: _resource_record_post_action 18:38:19 INFO - Running post-action listener: _start_resource_monitoring 18:38:19 INFO - Starting resource monitoring. 18:38:19 INFO - ##### 18:38:19 INFO - ##### Running install step. 18:38:19 INFO - ##### 18:38:19 INFO - Running pre-action listener: _resource_record_pre_action 18:38:19 INFO - Running main action method: install 18:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:19 INFO - Reading from file tmpfile_stdout 18:38:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:19 INFO - Reading from file tmpfile_stdout 18:38:19 INFO - Output received: 18:38:19 INFO - Usage: mozinstall [options] installer 18:38:19 INFO - Options: 18:38:19 INFO - -h, --help show this help message and exit 18:38:19 INFO - -d DEST, --destination=DEST 18:38:19 INFO - Directory to install application into. [default: 18:38:19 INFO - "/builds/slave/test"] 18:38:19 INFO - --app=APP Application being installed. [default: firefox] 18:38:19 INFO - mkdir: /builds/slave/test/build/application 18:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:38:35 INFO - Reading from file tmpfile_stdout 18:38:35 INFO - Output received: 18:38:35 INFO - /builds/slave/test/build/application/firefox/firefox 18:38:35 INFO - Running post-action listener: _resource_record_post_action 18:38:35 INFO - ##### 18:38:35 INFO - ##### Running run-tests step. 18:38:35 INFO - ##### 18:38:35 INFO - Running pre-action listener: _resource_record_pre_action 18:38:35 INFO - Running main action method: run_tests 18:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:38:35 INFO - Python 2.7.3 18:38:35 INFO - Return code: 0 18:38:35 INFO - grabbing minidump binary from tooltool 18:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:35 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:38:35 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 18:38:35 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 18:38:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:38:35 INFO - Return code: 0 18:38:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:38:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:38:36 INFO - Return code: 0 18:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 18:38:36 INFO - Using env: {'DISPLAY': ':0', 18:38:36 INFO - 'HOME': '/home/cltbld', 18:38:36 INFO - 'LANG': 'en_US.UTF-8', 18:38:36 INFO - 'LANGUAGE': 'en_US:en', 18:38:36 INFO - 'LOGNAME': 'cltbld', 18:38:36 INFO - 'MAIL': '/var/mail/cltbld', 18:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:36 INFO - 'MOZ_NO_REMOTE': '1', 18:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:36 INFO - 'NO_EM_RESTART': '1', 18:38:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:36 INFO - 'PWD': '/builds/slave/test', 18:38:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:38:36 INFO - 'SHELL': '/bin/bash', 18:38:36 INFO - 'SHLVL': '1', 18:38:36 INFO - 'TERM': 'linux', 18:38:36 INFO - 'TMOUT': '86400', 18:38:36 INFO - 'USER': 'cltbld', 18:38:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452736978.373629-648688326', 18:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:36 INFO - '_': '/tools/buildbot/bin/python'} 18:38:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:38:36 INFO - mozversion application_buildid: 20160113172632 18:38:36 INFO - mozversion application_changeset: 3c473ad89a25a48b7aeb7e48633355c965ac45df 18:38:36 INFO - mozversion application_display_name: Nightly 18:38:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:38:36 INFO - mozversion application_name: Firefox 18:38:36 INFO - mozversion application_remotingname: firefox 18:38:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:38:36 INFO - mozversion application_vendor: Mozilla 18:38:36 INFO - mozversion application_version: 46.0a1 18:38:36 INFO - mozversion platform_buildid: 20160113172632 18:38:36 INFO - mozversion platform_changeset: 3c473ad89a25a48b7aeb7e48633355c965ac45df 18:38:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:38:36 INFO - mozversion platform_version: 46.0a1 18:38:36 INFO - using testdate: 1452739116 18:38:36 INFO - actual date: 1452739116 18:38:36 INFO - starting webserver on 'localhost:38746' 18:38:36 INFO - SUITE-START | Running 3 tests 18:38:36 INFO - TEST-START | dromaeo_css 18:38:36 INFO - operating with platform_type : linux_ 18:38:36 INFO - Initialising browser for dromaeo_css test... 18:38:36 INFO - TEST-INFO | started process 3265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkymn5h/profile http://localhost:38746/getInfo.html) 18:38:41 INFO - PROCESS | 3265 | 18:38:41 INFO - PROCESS | 3265 | (process:3349): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:38:42 INFO - PROCESS | 3265 | __metrics Screen width/height:1600/1200 18:38:42 INFO - PROCESS | 3265 | colorDepth:24 18:38:42 INFO - PROCESS | 3265 | Browser inner width/height: 1024/697 18:38:42 INFO - PROCESS | 3265 | __metrics 18:38:42 INFO - PROCESS | 3265 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:38:43 INFO - TEST-INFO | 3265: exit 0 18:38:43 INFO - Browser initialized. 18:38:43 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:43 INFO - TEST-INFO | started process 3399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkymn5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:45 INFO - PROCESS | 3399 | 18:38:45 INFO - PROCESS | 3399 | (process:3455): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:38:55 INFO - PROCESS | 3399 | RSS: Main: 150622208 18:38:55 INFO - PROCESS | 3399 | 18:39:45 INFO - PROCESS | 3399 | 1452739185236 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] 18:41:55 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38746/tests/dromaeo/cssquery-ext.html) 18:41:56 INFO - PROCESS | 3399 | RSS: Main: 154923008 18:41:56 INFO - PROCESS | 3399 | 18:44:58 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-ext.html (next: http://localhost:38746/tests/dromaeo/cssquery-jquery.html) 18:44:59 INFO - PROCESS | 3399 | RSS: Main: 153083904 18:44:59 INFO - PROCESS | 3399 | 18:48:01 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38746/tests/dromaeo/cssquery-mootools.html) 18:48:01 INFO - PROCESS | 3399 | RSS: Main: 151785472 18:48:01 INFO - PROCESS | 3399 | 18:51:03 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38746/tests/dromaeo/cssquery-prototype.html) 18:51:04 INFO - PROCESS | 3399 | RSS: Main: 150265856 18:51:04 INFO - PROCESS | 3399 | 18:54:06 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38746/tests/dromaeo/cssquery-yui.html) 18:54:07 INFO - PROCESS | 3399 | RSS: Main: 151420928 18:54:07 INFO - PROCESS | 3399 | 18:57:09 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:38746/tests/dromaeo/cssquery-yui.html (next: http://localhost:38746/tests/dromaeo/cssquery-dojo.html) 18:57:10 INFO - PROCESS | 3399 | RSS: Main: 152928256 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | __start_tp_report 18:57:10 INFO - PROCESS | 3399 | _x_x_mozilla_page_load 18:57:10 INFO - PROCESS | 3399 | _x_x_mozilla_page_load_details 18:57:10 INFO - PROCESS | 3399 | |i|pagename|runs| 18:57:10 INFO - PROCESS | 3399 | |0;dojo.html;2505.57405241109;2545.363659085229;2584.3539115221197;2598.5322641924454;2600.1549496413672;4288.57114288571;4336.761478118702;4373.169097871402;4406.272964960777;4406.845760398387;4349.7390156590545;4370.1915145697985;4372.300431930892;4464.464264288282;4483.7085589436665;4048.838046478145;4094.61101195386;4117.505899292089;4124.587541245866;4147.875563733093;231.4502351902371;4046.736962097454;4057.431959525654;4112.753234805921;4139.668826493873;4060.086480541869;4101.589841015904;4103.466549348565;4107.589241075899;4143.067809742814;3883.941740873889;4048.0891799345204;4085.571015043437;4133.958660413387;4145.274576949022;3992.1017771001584;4053.655439287664;4094.2425651254316;4094.8362065517344;4114.7119701620895;4286.957130428687;4299.742015479082;4318.632916202127;4350.021245219832;4370.2789039808395;4567.15507631086;4645.488996210414;4688.390509233778;4689.507601701806;4727.574518293336;4681.180793361148;4723.338732577442;4729.787159577792;4738.099761045391;4782.95217047832;4420.425344705232;4424.623906967911;4427.092446048552;4453.688241823073;4469.240229160985;4736.242201247784;4812.687175333592;4820;4820.421549414093;4855.587275081587;4589.036302376471;4622.537746225351;4630.004549021976;4639.698419602715;4699.553542413465;4700.2244629635725;4712.764361781898;4714.269288260325;4721.244600863845;4769.403824521934;4509.098180363941;4589.747563884019;4686.461056978423;4692.483826779052;4708.741019243975;4569.451665800125;4575.542445755398;4608.193566125981;4616.95383046172;4652.092841895866;3931.9017024574614;3945.6448919597374;3946.427767973628;3949.3878448840474;3970.82131304092;3423.246885685145;3442.638522955104;3502.387082260594;3502.509648649191;3519.7008254298157;4123.9381409278885;4127.545969943304;4145.751254924714;4169.895752606149;4194.433751443577;4717.834875779331;4740.478547359788;4743.193657078305;4756.6432517561325;4761.071591039783;3941.3693808990424;4025.1748391579654;4109.609587089221;4162.708610397303;4194.769287689206;4163.458750362494;4165.250254954138;4171.499420069611;4176.832926682899;4218.704690671685;4465.933011004838;4480.126375356839;4484.035932274576;4485.798139083749;4521.84173553924;4491.505934347285;4573.176828170961;4696.38946936896;4731.361266229015;4762.452317983476;4486.7083639563325;4488.932666010078;4506;4513.413256276663;4549.567791059844;4506.526814684411;4644.907101857876;4649.2793616988065;4660.743659098782;4703.976480117578;4562.224421848227;4640.721556706473;4695.131400690883;4703.365045718784;4710.69380490267;4527.637788976808;4557.4531056272135;4578.954210457853;4606;4617.699849509771;4429.867103986886;4497.280435130494;4566.977165114286;4571.725696458223;4579.06129243511;4449.555044495524;4488.5960263576435;4496.21316269658;4532.864014079583;4554.180247555471;4542.409486766699;4565.977170114128;4596.6322694185055;4608.5621865922685;4652.069586082729;4356.956430435782;4436.3123715824095;4471.195184866755;4497.955020449754;4510.030343476168 18:57:10 INFO - PROCESS | 3399 | |1;ext.html;494.86143879713694;504.1454734225488;527.8944211157769;530.8434011966469;542.2489851555592;31752.68247317526;32665;32667.183320417;32763.836180819122;32777.50833737496;35917.28165436696;36623.81688091563;36664.45003324952;36707;36760.81619591898;7673.309402153805;7813;7838.294553490185;7844.960775196116;7868.685252589889;7627.656755446018;7725.72959946402;7727.536347819121;7731.265529774662;7750.806229844271;7894.250046245597;7902;7913.841723165533;7958.602069896511;7970.282674559288;7817.452778305521;7894.763157105296;7917.604119793988;7927.603619819015;7927.960360198191;7802.648880800378;7905.881411778828;7927.246911543394;7947.046354437447;7965.761027169194;36849.81575092134;36983.075423114366;37389.81305093457;37409.62590374089;37576.436353454446;2431.3678443604613;2890.682024977251;2995.970040299591;3060.9846950765327;3129.5931528901096;23752.88123559371;23881;23917.28248152541;24026.159084432136;24155.396115097086;3293.275479394529;3348.2466445049913;3405.5743032120986;3424.092615456906;3494.2487365216602;143686.28156859253;144553;144827;145112;145791.27104364516;45807;46881.531184687716;54818;55924.72037639867;56047.71976140175;48598;48696.75651621719;48921.51078489241;49236.26145607819;49335;13621.387037583332;14084.859151408355;14144.787828182585;14186.290685465892;14211.715765684836;9788.412695238167;9795.804083918281;9911.008899110175;9938.900610993942;9942.80114397708;17704.55738606545;18879.716804247946;18996.810031899782;19001.334953276844;19066.428007159808;6893.724251030003;7041.436685065182;7061.293870612898;7101.609411482418;7126.750563730245;856.9571521423904;863.3869952333788;880.1770344727701;887.8357503861677;958.2286259561121;25611.87194064055;26249.08128215503;26324.21027369144;26534.336641584116;26538;978.7308490165119;1002.9147522460527;1030.701096681954;1070.314998401024;1113.9443027848574;13514.86485135136;13730.725385492235;13833.654158645913;13911.373988170557;13925.582232533041;253927;255740;258051;259663;260009;46008.769956150674;46220.306695399595;46490.302645460346;46651.06697866024;46687;1199.6940780101017;1209.8850609192114;1223.6757259326287;1225.7732319520917;1228.0543981134656;24840.25479235626;25366.87316563479;25880.482390352463;26027.219183424528;26090.347741306618;40194.99512512211;40418;40640;40928.79535602303;41009.58990410177;245919;247068;247981;248524;249292;29371.7062829369;30336.84831575828;30910.22724431907;30930.381392372477;31074;35771.46342804808;36456.635433646385;36499.27001460009;36898.44652330271;36898.631013690596;31180.53229201609;31417.52873706942;31646.841765791025;32012.67987320097;32583.511247330836;31095.68904310928;31611;31645.36709265848;31665.20836979094;31860.840695796374;32972.34055318928;33030.33939321152;33091.8345408281;33169.336613267114;33921.49117763186;34216.315673686884;34473.827630861684;35206.823965881034;36035;37812.81093594514;25281;25870.741292586834;26574.734252658;27400.72599273982;28002.159935201977 18:57:10 INFO - PROCESS | 3399 | |2;jquery.html;322.52266645364847;327.2505961348512;329.12945259787864;334.9666279527657;342.2043748285237;7923.12845586985;8272.875906861402;9748.122668959792;14561.344739486722;15264.160471174095;14837.554873353789;15181.392744290242;15426.537203883874;15909.363625454997;15986.440474583393;4534.888952206714;5301.655392399492;5514.393416724157;5514.393416724157;5550.47270509301;5451.672899626015;5512.503874651281;5573.749181286852;5576.470235327637;5584.134459158817;5946.375630558794;6184.969075154618;6225.377462253784;6236.220472440945;6257.4368306852375;6017.548683848707;6661.533692641517;6681.398674119304;6681.665916704145;6685.264620891698;6105.603135796159;6224.128621992924;6227.968860155715;6246.187995560548;6375.17122774041;19038.42884713447;19372.903135484372;19913.502162446053;20003.699944500844;20134.395968120978;1857.5077604434834;1922.528980399797;1928.3347245200384;2032.573159636478;2079.521710006707;6215.782447614357;6220.440160385542;10927.743309519428;12960.092793504458;13087.345632718327;1859.2098358197711;1926.8014597885906;1928.2768961639385;1980.2574034736974;2039.2047101630376;54333.45666543363;55032;55504.72247638736;55690.721546392415;56920.43858026399;13877.583672489842;14483.927580362242;14569.562913112624;14573.41706331756;14597.489087881873;9486.19367353769;9902;21907.561848762936;22079.558408832054;22232.666510002364;6200.627962322275;6529.085927970088;6535.738570457223;6543.901841472381;6611.66941652925;6033.42682445167;6103.023516237381;6105.664188469676;6116;6131.601445906002;4177.8328866845595;4192.979035104805;4198.454200953856;4201.558836322142;4211.599898009684;1792.1666425112126;1832.578506943384;1873.8688291819442;1895.1471837673103;1904.8476121910214;358.6861496190833;785.4619585583779;826.4297634632085;900.446225571269;921.4931787516839;8735.868961965576;9221.262299016063;9244.815103697889;9659.855102173473;14049;762.2415696382025;855.07224661242;886.096181894464;902.9187373136449;906.1799071839995;7741.61291935401;8069.6368663410285;8195.180481951757;8743.51910644908;9001.324900632479;432324;440677;447856;448711;451724;62856.685716571126;63155.684221578595;64392;66215.33784662189;66463.66768166225;1086.8913108689069;1101.6529793115144;1103.2442776697826;1110.228391268061;1112.1436493899653;12608.558700445441;13081.345932703136;13284.867151328363;13510.797338040134;13963.720725585228;26730.866345668146;28095.578566321114;28744.13767586976;30108.54837177488;30593;31520.842395787873;32843;33186.5022024665;33247.66752332446;33512.49731253985;6098.207233059674;6158.445739883432;6379.904301435389;6428.903566446414;6600.273969863215;8172.468789528662;9179.403338782959;9214.354995150543;9417.152456278967;9475.857862131936;7814.765557033298;7977.7207797726805;8117.671754580593;8185.0996390398195;8612.827743445221;7774.2614451627005;8027.39794515402;8088.676452941816;8428.957855210685;8482.915170848213;8223.54770487605;8330.958345208235;8377.371697122619;8633.525156116222;8911.955440223017;6688.632125233159;6715.764948226789;6716.899246511209;6751.831204219934;6818.8636227276165;6774.458043356618;8725.345599080221;8817.867731983897;8848.955755221183;8884.644614215618 18:57:10 INFO - PROCESS | 3399 | |3;mootools.html;1319.313956742494;1404.2697797145481;1498.2658497336308;1688.5440930948637;1693.2465053051396;6020.6086604370685;6175.351588083243;7048.471364647653;7171.318724721144;7182.928170718291;6791.219009813873;7016.087908571892;7078.575285482862;7091.326323999225;7098.964505177467;2025.6961455781604;2056.28030189434;2060.927867524637;2067.6898465230183;2074.7925207479207;1953.0625299856079;1970.123295133659;1973.881567105971;2030.167631271179;2043.1929387891773;2083.125087463269;2089.717888085112;2091.6025955068562;2093.832493400532;2103;2047.06858379437;2060.6702927531596;2063.5769667218183;2066.875987440751;2073.1085633177727;2052.568960518293;2060.9896950515304;2072.9378118656464;2083.635363811327;2084.978360603309;7246.673899674527;7271.236520165412;7302.123745150563;7304.598247096407;7337.3029562191505;3931.056546428865;3994.4407782910416;4038.3336749436603;4043.716939814214;4046.089629833293;2533.6199570064637;2565.4227798745133;2594.15689900783;2596.857172855492;2616.5813469844734;764.2548515197693;768.5119948832531;771.0400551313594;778.1595876453416;785.1638005524155;9414.105659962293;9440.10319019692;9476.005019472994;9487.573059212353;9511.714648560484;3618.131648404364;3618.5838628557526;3657.5610926688437;3663.8351274192723;3686.170611612419;8223.753287401387;8277.875831862528;8279;8308.335333173332;8317.625706843206;4053.7162398632404;4067.877963661095;4076.6942479313575;4084.14233011071;4093.242750091183;3216.710496055366;3292.687194716546;3577.8211089445945;3665.6151104134215;3667.9633203668154;3257.9837100814343;3278.918027049343;3293.1437826164893;3300.488424294238;3311.7350611950988;982.8869679986893;1057.735566108473;1061.9150467962545;1074.3178081918038;1082.1613249731522;817.1624085312484;1045.414567842011;1088.7223757941674;1100.5817789240039;1100.7963526747578;6667.899981500282;6760.7633732820095;6773.085633439521;6805.557638753465;6827.283135270725;956.3496822160859;960.1982344742079;1048.4600430778003;1051.0645525482328;1065.6057258814287;5064.088464076502;5070.264811602371;5073.771680274396;5089.033083714083;5106.846794596168;8233.50598964052;8357.456765310235;8460.915390846012;8519.48883067018;8615.698450554326;8505.702300419456;8552;8563.058063612998;8590.78523036929;8605.182507661762;6832.145981752281;6838.111045564145;6907.792766216921;6911.89632155518;6951.756688515878;6428.6785660717715;6643.900341494785;6692.866142677217;6698.698558564779;6708.932910671026;7742.419318551244;7863.646135923783;7988.320992715684;8011.399145064027;8051.35589152878;7428.9628551856895;7739.729109481141;7753.806154846174;7860.724874629361;7999.520028798291;5431.538319242751;5615.101583746581;6243;6393.817143828406;6426.4537514311805;6380.234371875405;6494.1232933553365;6502.089707441057;6527.902081468686;6561.40947314744;5995.730192141277;6136.386361363828;6164.3835616438;6206.472449841814;6227.564070515021;5949.583529152917;6021.729022194099;6041.6375017499095;6042;6133.53998450127;5831.970840145772;5885.852853678693;5960.910586341121;5976.462118409364;6021.578489505868;5683.8010669626365;5711.914321285267;5715.685637289823;5722.799702010409;5734.197212390185;5481.205225242238;5505.779768809202;5545.611807173459;5555.333359996826;5572.442755724395 18:57:10 INFO - PROCESS | 3399 | |4;prototype.html;299.2712744467222;301.5100461749657;309.2207636755378;310.39937720510807;311.7786371676111;5409.188621706741;5474.479924407185;5566.944330556688;5569.359523654781;5669.63147395419;5452.127659574468;5530.198121272413;5540.584456165793;5545.694986775726;5551.472610102044;4094.4267802507675;4219.346001369778;4227.85202517912;4228.915421691564;4236.533981262051;4210.842018444921;4218;4218.219629368561;4226.366045093245;4226.556211597769;4166.270902592049;4170.520390155126;4171.603697648734;4175.749455032693;4180.916381672365;4122.319817230154;4146.336586146217;4155.958440415588;4182.372644103379;4192.643625291823;3522.137076416269;3656.177360093984;3657.7073834093208;3662.377395842713;3665.065408320888;5108.489151084899;5173.508516690908;5208.479152084799;5216.5305122538775;5276.630635855492;4817.012512434978;4828.155072862271;4831.613470922353;4832.299316599108;4833.589144922686;5796.043652797283;5800.129980502916;5803.912941305884;5809.651420914759;5810.157527158581;3903.902402439933;3962.9405558916637;3969.2656858481273;3983.6016398359934;3997.2605068062503;5984.072468767348;6059.757609695607;6065.302490213594;6068.908966365508;6072.36240194782;4063.227986682521;4088.2845502037026;4099.97950010248;4101.89745256365;4107.301758701028;4159.209750147463;4165.645920096826;4168.374743788456;4172.728772629769;4175.832966681299;4616.215243408628;4784.976075119672;4785.617150627942;4787.688800227974;4790.401199850019;5596.496315331639;5744.798932037359;5755.827325180251;5756.683382413924;5761.711914404263;1449.9347529361205;1463.9634009149856;1471.154086400324;1472.146155229964;1476.047949072842;968.3415277611292;986.0287616697548;988.4365911430416;994.9005099490138;999.2206079258191;5037.899242015213;5052.6715763475995;5055.292259083732;5060.468650791688;5065.290859279704;6017.458428741435;6023.427774361428;6028.186194863725;6029.969850150721;6040.214772079602;5013.749312534359;5047.646664733434;5048.671836330626;5051.318072060225;5052.216906379517;3175.5712978748033;3186.060112266887;3252.15443984561;3254.8047117173046;3258.3971965186042;5684.857878553069;5701.885962280731;5707.486326230576;5714.314282286152;5736.311642602915;6145.416185462464;6183.628982261079;6190.133381326618;6190.350013248634;6191.938080619227;5542.196381524737;5689.231953686282;5711.771529138871;5716.114002329646;5719.027765279912;6007.279126504847;6011.489023433057;6022.337542870368;6023.759049637965;6031.185789918481;5831.35855055935;5839.124131380327;5883.55873309512;5885.3820348862755;5897.439743224387;5691.658500489983;5691.8292451226525;5691.971540142273;5696.344920334214;5697.800576979786;3976.3240249158293;4070.5929407059057;4120.052387950728;4126.66986641062;4128.8348466061025;5910.881782364415;5938.61399009063;5971.552133590085;5983.042713165873;6075.939240607714;5814.680192589448;5828.067509198508;5847.707614619167;5855.707214639337;5878.088896221093;5789.189513468202;5813.215215945962;5813.912791308218;5846.824595262149;5852.209951656472;5605.271314729059;5690.402507736793;5697.4587414195585;5709.457601527848;5710.029295019774;5852.502537284378;5871.911921321098;5872.471477567039;5879.235699359056;5902.085176797432;5699.601027928005;5702.173184888251;5713.143028545752;5714.971425142848;5716.056850619601 18:57:10 INFO - PROCESS | 3399 | |5;yui.html;760.4790718357923;767.0909971683556;780.4692808889956;787.885756565298;801.0667572278296;11720.824187637181;11738.295702257848;11837.348945807988;11855.347955862424;11933.701657458569;11116.333020018805;11319;11364.204505684605;11366.488508017139;11370.431478426066;759.4797563668877;770.1105223466876;774.9573773442459;777.1334961517895;777.9260970207849;760.1600231743927;765.3762183820196;767.5471471831618;767.8118860879065;767.93088622024;796.2594786848229;797.0753925446484;799.6641410607559;800.0918956983807;800.2637573432456;790.9723159689383;795.9044914610226;799.1169757418056;799.2167675677811;800.6997375984006;594.1533315026071;594.3402822866615;595.5711887441036;596.1088173181079;596.4900010491054;11105.444727763661;11111.777764444665;11172.162087843362;11214.158938079596;11215.046721028722;9735;9850.931304426007;9944.801103977952;10080.193584513221;10277.948610256975;8865.46807191564;8938.46369217849;9051.185393314567;9214.677486288016;9382.061793820632;3197.680231976807;3220.178854392115;3249.1227368610344;3273.738100951918;3344.9331013379597;34202.82898585491;35209.82395088034;38520.229595408215;39583;39890.60109398898;9394.530273486298;9757.365771224848;9782.266330025277;9856.605735770489;10000.14998725102;16926.83073169277;16937.745933811002;16967;16973.066481343398;17044.829551704574;6715.059891615178;6816.386525212754;6847.144106986627;6960.617166055814;6981.79054628362;3549.3433714762336;3579.856805727794;3593.6509837382614;3639.927201455956;3665.303592317451;2483.1309041835575;2532.607445845897;2535.3408113890523;2535.936601584938;2541.3900663840545;448.7688840247275;449.51003406287305;460.14872485901486;469.4483981321933;469.591455433768;520.1807153732885;535.5983012740445;541.9729013549306;566.815784869919;577.2870504926412;6709.269920156017;6797.2523022467485;6946.6179360134665;7032.718691252395;7162.176349719744;498.5189292332916;567.7019564728467;570.2814453788174;577.4369989260438;579.7333226715758;3620.9275814483562;3630.407534468899;3929.332013557702;4115.300398932189;4207.116505533872;43497.130057398674;43591.78204109023;46452;46734;46988;37275.25449490995;37508.249835003146;37526.24947501034;38220.61779382226;43149.35275970863;36332;38162.038934938835;38880;39014.024649383995;39203.80398098048;7493.325600695964;7910.920890791019;7954.244346787046;7967.960160199394;8145.266925976453;27898.72101278961;30238.848805756712;30386.544201836547;30807.383852323277;31294.530582040832;35276.47085293774;38449.6155038446;38513.614863852126;38586;38661.6133838658;9794.559244833858;9802.9019709802;10155.339902906288;10312.535935883054;10326.793464130526;10660.62687805923;10724.03483686472;10973.3964631946;11385.658430247106;12416.751664966469;10535.894641053492;10767.515461804394;10812.026917577456;11018.669439916815;11229.49467273991;10503.78992420132;10621;10844.403557804397;11217.60738374153;11228;10151;10281.228907832092;10456.738581535523;10712.303700259457;10728.51721672511;9047.140521650434;9239.260859131387;9279.536023198678;9324.95337523308;9404.858927115962;9070.63717451321;9623.5669394876;9626.518674066128;9634;9658.71023869285 18:57:10 INFO - PROCESS | 3399 | __end_tp_report 18:57:10 INFO - PROCESS | 3399 | __start_cc_report 18:57:10 INFO - PROCESS | 3399 | _x_x_mozilla_cycle_collect,333 18:57:10 INFO - PROCESS | 3399 | __end_cc_report 18:57:10 INFO - PROCESS | 3399 | __startTimestamp1452740230072__endTimestamp 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | ------- Summary: start ------- 18:57:10 INFO - PROCESS | 3399 | Number of tests: 6 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#0] dojo.html Cycles:165 Average:4325.87 Median:4484.04 stddev:538.34 (12.0%) stddev-sans-first:520.71 18:57:10 INFO - PROCESS | 3399 | Values: 2505.6 2545.4 2584.4 2598.5 2600.2 4288.6 4336.8 4373.2 4406.3 4406.8 4349.7 4370.2 4372.3 4464.5 4483.7 4048.8 4094.6 4117.5 4124.6 4147.9 231.5 4046.7 4057.4 4112.8 4139.7 4060.1 4101.6 4103.5 4107.6 4143.1 3883.9 4048.1 4085.6 4134.0 4145.3 3992.1 4053.7 4094.2 4094.8 4114.7 4287.0 4299.7 4318.6 4350.0 4370.3 4567.2 4645.5 4688.4 4689.5 4727.6 4681.2 4723.3 4729.8 4738.1 4783.0 4420.4 4424.6 4427.1 4453.7 4469.2 4736.2 4812.7 4820.0 4820.4 4855.6 4589.0 4622.5 4630.0 4639.7 4699.6 4700.2 4712.8 4714.3 4721.2 4769.4 4509.1 4589.7 4686.5 4692.5 4708.7 4569.5 4575.5 4608.2 4617.0 4652.1 3931.9 3945.6 3946.4 3949.4 3970.8 3423.2 3442.6 3502.4 3502.5 3519.7 4123.9 4127.5 4145.8 4169.9 4194.4 4717.8 4740.5 4743.2 4756.6 4761.1 3941.4 4025.2 4109.6 4162.7 4194.8 4163.5 4165.3 4171.5 4176.8 4218.7 4465.9 4480.1 4484.0 4485.8 4521.8 4491.5 4573.2 4696.4 4731.4 4762.5 4486.7 4488.9 4506.0 4513.4 4549.6 4506.5 4644.9 4649.3 4660.7 4704.0 4562.2 4640.7 4695.1 4703.4 4710.7 4527.6 4557.5 4579.0 4606.0 4617.7 4429.9 4497.3 4567.0 4571.7 4579.1 4449.6 4488.6 4496.2 4532.9 4554.2 4542.4 4566.0 4596.6 4608.6 4652.1 4357.0 4436.3 4471.2 4498.0 4510.0 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#1] ext.html Cycles:180 Average:37737.68 Median:18663.53 stddev:58032.99 (310.9%) stddev-sans-first:58128.41 18:57:10 INFO - PROCESS | 3399 | Values: 494.9 504.1 527.9 530.8 542.2 31752.7 32665.0 32667.2 32763.8 32777.5 35917.3 36623.8 36664.5 36707.0 36760.8 7673.3 7813.0 7838.3 7845.0 7868.7 7627.7 7725.7 7727.5 7731.3 7750.8 7894.3 7902.0 7913.8 7958.6 7970.3 7817.5 7894.8 7917.6 7927.6 7928.0 7802.6 7905.9 7927.2 7947.0 7965.8 36849.8 36983.1 37389.8 37409.6 37576.4 2431.4 2890.7 2996.0 3061.0 3129.6 23752.9 23881.0 23917.3 24026.2 24155.4 3293.3 3348.2 3405.6 3424.1 3494.2 143686.3 144553.0 144827.0 145112.0 145791.3 45807.0 46881.5 54818.0 55924.7 56047.7 48598.0 48696.8 48921.5 49236.3 49335.0 13621.4 14084.9 14144.8 14186.3 14211.7 9788.4 9795.8 9911.0 9938.9 9942.8 17704.6 18879.7 18996.8 19001.3 19066.4 6893.7 7041.4 7061.3 7101.6 7126.8 857.0 863.4 880.2 887.8 958.2 25611.9 26249.1 26324.2 26534.3 26538.0 978.7 1002.9 1030.7 1070.3 1113.9 13514.9 13730.7 13833.7 13911.4 13925.6 253927.0 255740.0 258051.0 259663.0 260009.0 46008.8 46220.3 46490.3 46651.1 46687.0 1199.7 1209.9 1223.7 1225.8 1228.1 24840.3 25366.9 25880.5 26027.2 26090.3 40195.0 40418.0 40640.0 40928.8 41009.6 245919.0 247068.0 247981.0 248524.0 249292.0 29371.7 30336.8 30910.2 30930.4 31074.0 35771.5 36456.6 36499.3 36898.4 36898.6 31180.5 31417.5 31646.8 32012.7 32583.5 31095.7 31611.0 31645.4 31665.2 31860.8 32972.3 33030.3 33091.8 33169.3 33921.5 34216.3 34473.8 35206.8 36035.0 37812.8 25281.0 25870.7 26574.7 27400.7 28002.2 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#2] jquery.html Cycles:180 Average:23788.86 Median:5981.96 stddev:72603.25 (1213.7%) stddev-sans-first:72785.54 18:57:10 INFO - PROCESS | 3399 | Values: 322.5 327.3 329.1 335.0 342.2 7923.1 8272.9 9748.1 14561.3 15264.2 14837.6 15181.4 15426.5 15909.4 15986.4 4534.9 5301.7 5514.4 5514.4 5550.5 5451.7 5512.5 5573.7 5576.5 5584.1 5946.4 6185.0 6225.4 6236.2 6257.4 6017.5 6661.5 6681.4 6681.7 6685.3 6105.6 6224.1 6228.0 6246.2 6375.2 19038.4 19372.9 19913.5 20003.7 20134.4 1857.5 1922.5 1928.3 2032.6 2079.5 6215.8 6220.4 10927.7 12960.1 13087.3 1859.2 1926.8 1928.3 1980.3 2039.2 54333.5 55032.0 55504.7 55690.7 56920.4 13877.6 14483.9 14569.6 14573.4 14597.5 9486.2 9902.0 21907.6 22079.6 22232.7 6200.6 6529.1 6535.7 6543.9 6611.7 6033.4 6103.0 6105.7 6116.0 6131.6 4177.8 4193.0 4198.5 4201.6 4211.6 1792.2 1832.6 1873.9 1895.1 1904.8 358.7 785.5 826.4 900.4 921.5 8735.9 9221.3 9244.8 9659.9 14049.0 762.2 855.1 886.1 902.9 906.2 7741.6 8069.6 8195.2 8743.5 9001.3 432324.0 440677.0 447856.0 448711.0 451724.0 62856.7 63155.7 64392.0 66215.3 66463.7 1086.9 1101.7 1103.2 1110.2 1112.1 12608.6 13081.3 13284.9 13510.8 13963.7 26730.9 28095.6 28744.1 30108.5 30593.0 31520.8 32843.0 33186.5 33247.7 33512.5 6098.2 6158.4 6379.9 6428.9 6600.3 8172.5 9179.4 9214.4 9417.2 9475.9 7814.8 7977.7 8117.7 8185.1 8612.8 7774.3 8027.4 8088.7 8429.0 8482.9 8223.5 8331.0 8377.4 8633.5 8912.0 6688.6 6715.8 6716.9 6751.8 6818.9 6774.5 8725.3 8817.9 8849.0 8884.6 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#3] mootools.html Cycles:180 Average:4874.23 Median:5955.25 stddev:2566.08 (43.1%) stddev-sans-first:2559.37 18:57:10 INFO - PROCESS | 3399 | Values: 1319.3 1404.3 1498.3 1688.5 1693.2 6020.6 6175.4 7048.5 7171.3 7182.9 6791.2 7016.1 7078.6 7091.3 7099.0 2025.7 2056.3 2060.9 2067.7 2074.8 1953.1 1970.1 1973.9 2030.2 2043.2 2083.1 2089.7 2091.6 2093.8 2103.0 2047.1 2060.7 2063.6 2066.9 2073.1 2052.6 2061.0 2072.9 2083.6 2085.0 7246.7 7271.2 7302.1 7304.6 7337.3 3931.1 3994.4 4038.3 4043.7 4046.1 2533.6 2565.4 2594.2 2596.9 2616.6 764.3 768.5 771.0 778.2 785.2 9414.1 9440.1 9476.0 9487.6 9511.7 3618.1 3618.6 3657.6 3663.8 3686.2 8223.8 8277.9 8279.0 8308.3 8317.6 4053.7 4067.9 4076.7 4084.1 4093.2 3216.7 3292.7 3577.8 3665.6 3668.0 3258.0 3278.9 3293.1 3300.5 3311.7 982.9 1057.7 1061.9 1074.3 1082.2 817.2 1045.4 1088.7 1100.6 1100.8 6667.9 6760.8 6773.1 6805.6 6827.3 956.3 960.2 1048.5 1051.1 1065.6 5064.1 5070.3 5073.8 5089.0 5106.8 8233.5 8357.5 8460.9 8519.5 8615.7 8505.7 8552.0 8563.1 8590.8 8605.2 6832.1 6838.1 6907.8 6911.9 6951.8 6428.7 6643.9 6692.9 6698.7 6708.9 7742.4 7863.6 7988.3 8011.4 8051.4 7429.0 7739.7 7753.8 7860.7 7999.5 5431.5 5615.1 6243.0 6393.8 6426.5 6380.2 6494.1 6502.1 6527.9 6561.4 5995.7 6136.4 6164.4 6206.5 6227.6 5949.6 6021.7 6041.6 6042.0 6133.5 5832.0 5885.9 5960.9 5976.5 6021.6 5683.8 5711.9 5715.7 5722.8 5734.2 5481.2 5505.8 5545.6 5555.3 5572.4 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#4] prototype.html Cycles:180 Average:4785.56 Median:5543.95 stddev:1426.22 (25.7%) stddev-sans-first:1389.90 18:57:10 INFO - PROCESS | 3399 | Values: 299.3 301.5 309.2 310.4 311.8 5409.2 5474.5 5566.9 5569.4 5669.6 5452.1 5530.2 5540.6 5545.7 5551.5 4094.4 4219.3 4227.9 4228.9 4236.5 4210.8 4218.0 4218.2 4226.4 4226.6 4166.3 4170.5 4171.6 4175.7 4180.9 4122.3 4146.3 4156.0 4182.4 4192.6 3522.1 3656.2 3657.7 3662.4 3665.1 5108.5 5173.5 5208.5 5216.5 5276.6 4817.0 4828.2 4831.6 4832.3 4833.6 5796.0 5800.1 5803.9 5809.7 5810.2 3903.9 3962.9 3969.3 3983.6 3997.3 5984.1 6059.8 6065.3 6068.9 6072.4 4063.2 4088.3 4100.0 4101.9 4107.3 4159.2 4165.6 4168.4 4172.7 4175.8 4616.2 4785.0 4785.6 4787.7 4790.4 5596.5 5744.8 5755.8 5756.7 5761.7 1449.9 1464.0 1471.2 1472.1 1476.0 968.3 986.0 988.4 994.9 999.2 5037.9 5052.7 5055.3 5060.5 5065.3 6017.5 6023.4 6028.2 6030.0 6040.2 5013.7 5047.6 5048.7 5051.3 5052.2 3175.6 3186.1 3252.2 3254.8 3258.4 5684.9 5701.9 5707.5 5714.3 5736.3 6145.4 6183.6 6190.1 6190.4 6191.9 5542.2 5689.2 5711.8 5716.1 5719.0 6007.3 6011.5 6022.3 6023.8 6031.2 5831.4 5839.1 5883.6 5885.4 5897.4 5691.7 5691.8 5692.0 5696.3 5697.8 3976.3 4070.6 4120.1 4126.7 4128.8 5910.9 5938.6 5971.6 5983.0 6075.9 5814.7 5828.1 5847.7 5855.7 5878.1 5789.2 5813.2 5813.9 5846.8 5852.2 5605.3 5690.4 5697.5 5709.5 5710.0 5852.5 5871.9 5872.5 5879.2 5902.1 5699.6 5702.2 5713.1 5715.0 5716.1 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - PROCESS | 3399 | [#5] yui.html Cycles:180 Average:11707.26 Median:43323.24 stddev:12708.59 (29.3%) stddev-sans-first:12717.65 18:57:10 INFO - PROCESS | 3399 | Values: 760.5 767.1 780.5 787.9 801.1 11720.8 11738.3 11837.3 11855.3 11933.7 11116.3 11319.0 11364.2 11366.5 11370.4 759.5 770.1 775.0 777.1 777.9 760.2 765.4 767.5 767.8 767.9 796.3 797.1 799.7 800.1 800.3 791.0 795.9 799.1 799.2 800.7 594.2 594.3 595.6 596.1 596.5 11105.4 11111.8 11172.2 11214.2 11215.0 9735.0 9850.9 9944.8 10080.2 10277.9 8865.5 8938.5 9051.2 9214.7 9382.1 3197.7 3220.2 3249.1 3273.7 3344.9 34202.8 35209.8 38520.2 39583.0 39890.6 9394.5 9757.4 9782.3 9856.6 10000.1 16926.8 16937.7 16967.0 16973.1 17044.8 6715.1 6816.4 6847.1 6960.6 6981.8 3549.3 3579.9 3593.7 3639.9 3665.3 2483.1 2532.6 2535.3 2535.9 2541.4 448.8 449.5 460.1 469.4 469.6 520.2 535.6 542.0 566.8 577.3 6709.3 6797.3 6946.6 7032.7 7162.2 498.5 567.7 570.3 577.4 579.7 3620.9 3630.4 3929.3 4115.3 4207.1 43497.1 43591.8 46452.0 46734.0 46988.0 37275.3 37508.2 37526.2 38220.6 43149.4 36332.0 38162.0 38880.0 39014.0 39203.8 7493.3 7910.9 7954.2 7968.0 8145.3 27898.7 30238.8 30386.5 30807.4 31294.5 35276.5 38449.6 38513.6 38586.0 38661.6 9794.6 9802.9 10155.3 10312.5 10326.8 10660.6 10724.0 10973.4 11385.7 12416.8 10535.9 10767.5 10812.0 11018.7 11229.5 10503.8 10621.0 10844.4 11217.6 11228.0 10151.0 10281.2 10456.7 10712.3 10728.5 9047.1 9239.3 9279.5 9325.0 9404.9 9070.6 9623.6 9626.5 9634.0 9658.7 18:57:10 INFO - PROCESS | 3399 | -------- Summary: end -------- 18:57:10 INFO - PROCESS | 3399 | 18:57:10 INFO - TEST-INFO | 3399: exit 0 18:57:10 INFO - TEST-OK | dromaeo_css | took 1113959ms 18:57:10 INFO - TEST-START | kraken 18:57:10 INFO - operating with platform_type : linux_ 18:57:10 INFO - Initialising browser for kraken test... 18:57:10 INFO - TEST-INFO | started process 3637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDtqhB/profile http://localhost:38746/getInfo.html) 18:57:14 INFO - PROCESS | 3637 | 18:57:14 INFO - PROCESS | 3637 | (process:3712): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:57:15 INFO - PROCESS | 3637 | __metrics Screen width/height:1600/1200 18:57:15 INFO - PROCESS | 3637 | colorDepth:24 18:57:15 INFO - PROCESS | 3637 | Browser inner width/height: 1024/697 18:57:15 INFO - PROCESS | 3637 | __metrics 18:57:15 INFO - PROCESS | 3637 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:57:16 INFO - TEST-INFO | 3637: exit 0 18:57:16 INFO - Browser initialized. 18:57:16 INFO - Running cycle 1/1 for kraken test... 18:57:16 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDtqhB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:18 INFO - PROCESS | 3761 | 18:57:18 INFO - PROCESS | 3761 | (process:3820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:57:28 INFO - PROCESS | 3761 | RSS: Main: 150888448 18:57:28 INFO - PROCESS | 3761 | 18:57:31 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38746/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:32 INFO - PROCESS | 3761 | RSS: Main: 152317952 18:57:32 INFO - PROCESS | 3761 | 18:57:34 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38746/tests/kraken/driver.html?testName=audio-dft) 18:57:35 INFO - PROCESS | 3761 | RSS: Main: 155365376 18:57:35 INFO - PROCESS | 3761 | 18:57:38 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38746/tests/kraken/driver.html?testName=audio-fft) 18:57:38 INFO - PROCESS | 3761 | RSS: Main: 148127744 18:57:38 INFO - PROCESS | 3761 | 18:57:41 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38746/tests/kraken/driver.html?testName=audio-oscillator) 18:57:41 INFO - PROCESS | 3761 | RSS: Main: 147296256 18:57:41 INFO - PROCESS | 3761 | 18:57:43 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:44 INFO - PROCESS | 3761 | RSS: Main: 148152320 18:57:44 INFO - PROCESS | 3761 | 18:57:47 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38746/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:48 INFO - PROCESS | 3761 | RSS: Main: 148119552 18:57:48 INFO - PROCESS | 3761 | 18:57:51 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38746/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:52 INFO - PROCESS | 3761 | RSS: Main: 147202048 18:57:52 INFO - PROCESS | 3761 | 18:57:55 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38746/tests/kraken/driver.html?testName=json-parse-financial) 18:57:55 INFO - PROCESS | 3761 | RSS: Main: 147611648 18:57:55 INFO - PROCESS | 3761 | 18:57:57 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:57:58 INFO - PROCESS | 3761 | RSS: Main: 148905984 18:57:58 INFO - PROCESS | 3761 | 18:58:00 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:00 INFO - PROCESS | 3761 | RSS: Main: 148430848 18:58:00 INFO - PROCESS | 3761 | 18:58:02 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:03 INFO - PROCESS | 3761 | RSS: Main: 148168704 18:58:03 INFO - PROCESS | 3761 | 18:58:06 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:06 INFO - PROCESS | 3761 | RSS: Main: 149221376 18:58:06 INFO - PROCESS | 3761 | 18:58:09 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:09 INFO - PROCESS | 3761 | RSS: Main: 149610496 18:58:09 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:38746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38746/tests/kraken/driver.html?testName=ai-astar) 18:58:11 INFO - PROCESS | 3761 | RSS: Main: 150298624 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | __start_tp_report 18:58:11 INFO - PROCESS | 3761 | _x_x_mozilla_page_load 18:58:11 INFO - PROCESS | 3761 | _x_x_mozilla_page_load_details 18:58:11 INFO - PROCESS | 3761 | |i|pagename|runs| 18:58:11 INFO - PROCESS | 3761 | |0;ai-astar;114;110;115;116;118;125;114;116;115;115 18:58:11 INFO - PROCESS | 3761 | |1;audio-beat-detection;169;142;162;164;136;159;155;136;169;135 18:58:11 INFO - PROCESS | 3761 | |2;audio-dft;166;163;166;162;164;173;163;162;165;164 18:58:11 INFO - PROCESS | 3761 | |3;audio-fft;77;74;77;74;141;75;77;74;76;153 18:58:11 INFO - PROCESS | 3761 | |4;audio-oscillator;98;98;132;98;98;98;139;97;97;128 18:58:11 INFO - PROCESS | 3761 | |5;imaging-gaussian-blur;110;110;110;111;109;110;109;110;110;111 18:58:11 INFO - PROCESS | 3761 | |6;imaging-darkroom;148;150;149;149;149;149;148;148;148;148 18:58:11 INFO - PROCESS | 3761 | |7;imaging-desaturate;96;98;96;96;96;96;96;96;96;97 18:58:11 INFO - PROCESS | 3761 | |8;json-parse-financial;69;79;70;71;71;71;71;78;72;69 18:58:11 INFO - PROCESS | 3761 | |9;json-stringify-tinderbox;68;68;67;66;67;68;67;67;67;69 18:58:11 INFO - PROCESS | 3761 | |10;stanford-crypto-aes;85;86;87;83;86;92;85;87;86;88 18:58:11 INFO - PROCESS | 3761 | |11;stanford-crypto-ccm;147;125;123;127;124;129;122;127;126;131 18:58:11 INFO - PROCESS | 3761 | |12;stanford-crypto-pbkdf2;139;153;147;148;148;134;147;151;150;142 18:58:11 INFO - PROCESS | 3761 | |13;stanford-crypto-sha256-iterative;74;73;72;71;74;71;72;71;72;71 18:58:11 INFO - PROCESS | 3761 | __end_tp_report 18:58:11 INFO - PROCESS | 3761 | __start_cc_report 18:58:11 INFO - PROCESS | 3761 | _x_x_mozilla_cycle_collect,812 18:58:11 INFO - PROCESS | 3761 | __end_cc_report 18:58:11 INFO - PROCESS | 3761 | __startTimestamp1452740291930__endTimestamp 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | ------- Summary: start ------- 18:58:11 INFO - PROCESS | 3761 | Number of tests: 14 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.50 stddev:3.82 (3.3%) stddev-sans-first:4.00 18:58:11 INFO - PROCESS | 3761 | Values: 114.0 110.0 115.0 116.0 118.0 125.0 114.0 116.0 115.0 115.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:160.50 stddev:14.05 (8.8%) stddev-sans-first:13.61 18:58:11 INFO - PROCESS | 3761 | Values: 169.0 142.0 162.0 164.0 136.0 159.0 155.0 136.0 169.0 135.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.22 (2.0%) stddev-sans-first:3.39 18:58:11 INFO - PROCESS | 3761 | Values: 166.0 163.0 166.0 162.0 164.0 173.0 163.0 162.0 165.0 164.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#3] audio-fft Cycles:10 Average:89.80 Median:75.50 stddev:30.31 (40.1%) stddev-sans-first:31.79 18:58:11 INFO - PROCESS | 3761 | Values: 77.0 74.0 77.0 74.0 141.0 75.0 77.0 74.0 76.0 153.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:98.00 stddev:17.25 (17.6%) stddev-sans-first:17.89 18:58:11 INFO - PROCESS | 3761 | Values: 98.0 98.0 132.0 98.0 98.0 98.0 139.0 97.0 97.0 128.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:58:11 INFO - PROCESS | 3761 | Values: 110.0 110.0 110.0 111.0 109.0 110.0 109.0 110.0 110.0 111.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:58:11 INFO - PROCESS | 3761 | Values: 148.0 150.0 149.0 149.0 149.0 149.0 148.0 148.0 148.0 148.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:58:11 INFO - PROCESS | 3761 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#8] json-parse-financial Cycles:10 Average:72.10 Median:71.00 stddev:3.51 (4.9%) stddev-sans-first:3.54 18:58:11 INFO - PROCESS | 3761 | Values: 69.0 79.0 70.0 71.0 71.0 71.0 71.0 78.0 72.0 69.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 18:58:11 INFO - PROCESS | 3761 | Values: 68.0 68.0 67.0 66.0 67.0 68.0 67.0 67.0 67.0 69.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:2.37 (2.7%) stddev-sans-first:2.45 18:58:11 INFO - PROCESS | 3761 | Values: 85.0 86.0 87.0 83.0 86.0 92.0 85.0 87.0 86.0 88.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:127.00 stddev:7.17 (5.6%) stddev-sans-first:2.87 18:58:11 INFO - PROCESS | 3761 | Values: 147.0 125.0 123.0 127.0 124.0 129.0 122.0 127.0 126.0 131.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:148.00 stddev:5.86 (4.0%) stddev-sans-first:5.66 18:58:11 INFO - PROCESS | 3761 | Values: 139.0 153.0 147.0 148.0 148.0 134.0 147.0 151.0 150.0 142.0 18:58:11 INFO - PROCESS | 3761 | 18:58:11 INFO - PROCESS | 3761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.20 (1.7%) stddev-sans-first:1.05 18:58:11 INFO - PROCESS | 3761 | Values: 74.0 73.0 72.0 71.0 74.0 71.0 72.0 71.0 72.0 71.0 18:58:11 INFO - PROCESS | 3761 | -------- Summary: end -------- 18:58:11 INFO - PROCESS | 3761 | 18:58:12 INFO - TEST-INFO | 3761: exit 0 18:58:12 INFO - TEST-OK | kraken | took 62143ms 18:58:12 INFO - TEST-START | v8_7 18:58:12 INFO - operating with platform_type : linux_ 18:58:12 INFO - Initialising browser for v8_7 test... 18:58:12 INFO - TEST-INFO | started process 4048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMB6uF/profile http://localhost:38746/getInfo.html) 18:58:16 INFO - PROCESS | 4048 | 18:58:16 INFO - PROCESS | 4048 | (process:4118): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:58:17 INFO - PROCESS | 4048 | __metrics Screen width/height:1600/1200 18:58:17 INFO - PROCESS | 4048 | colorDepth:24 18:58:17 INFO - PROCESS | 4048 | Browser inner width/height: 1024/697 18:58:17 INFO - PROCESS | 4048 | __metrics 18:58:18 INFO - PROCESS | 4048 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:58:19 INFO - TEST-INFO | 4048: exit 0 18:58:19 INFO - Browser initialized. 18:58:19 INFO - Running cycle 1/1 for v8_7 test... 18:58:19 INFO - TEST-INFO | started process 4167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMB6uF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:20 INFO - PROCESS | 4167 | 18:58:20 INFO - PROCESS | 4167 | (process:4226): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:58:31 INFO - PROCESS | 4167 | RSS: Main: 150138880 18:58:31 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | Cycle 1(1): loaded http://localhost:38746/tests/v8_7/run.html (next: http://localhost:38746/tests/v8_7/run.html) 18:58:53 INFO - PROCESS | 4167 | RSS: Main: 145403904 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | __start_tp_report 18:58:53 INFO - PROCESS | 4167 | _x_x_mozilla_page_load 18:58:53 INFO - PROCESS | 4167 | _x_x_mozilla_page_load_details 18:58:53 INFO - PROCESS | 4167 | |i|pagename|runs| 18:58:53 INFO - PROCESS | 4167 | |0;Richards;169.83695652173913 18:58:53 INFO - PROCESS | 4167 | |1;DeltaBlue;187.0907390084191 18:58:53 INFO - PROCESS | 4167 | |2;Encrypt;281.45229383619477 18:58:53 INFO - PROCESS | 4167 | |3;Decrypt;5251.308900523561 18:58:53 INFO - PROCESS | 4167 | |4;RayTrace;1068.3760683760684 18:58:53 INFO - PROCESS | 4167 | |5;Earley;730.9941520467836 18:58:53 INFO - PROCESS | 4167 | |6;Boyer;12696.20253164557 18:58:53 INFO - PROCESS | 4167 | |7;RegExp;42416.666666666664 18:58:53 INFO - PROCESS | 4167 | |8;Splay;589.2751915144372 18:58:53 INFO - PROCESS | 4167 | |9;NavierStokes;4822.115384615385 18:58:53 INFO - PROCESS | 4167 | __end_tp_report 18:58:53 INFO - PROCESS | 4167 | __startTimestamp1452740333760__endTimestamp 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | ------- Summary: start ------- 18:58:53 INFO - PROCESS | 4167 | Number of tests: 10 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#0] Richards Cycles:1 Average:169.84 Median:169.84 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 169.8 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#1] DeltaBlue Cycles:1 Average:187.09 Median:187.09 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 187.1 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 281.5 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 5251.3 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 1068.4 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#5] Earley Cycles:1 Average:730.99 Median:730.99 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 731.0 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#6] Boyer Cycles:1 Average:12696.20 Median:12696.20 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 12696.2 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#7] RegExp Cycles:1 Average:42416.67 Median:42416.67 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 42416.7 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#8] Splay Cycles:1 Average:589.28 Median:589.28 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 589.3 18:58:53 INFO - PROCESS | 4167 | 18:58:53 INFO - PROCESS | 4167 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 18:58:53 INFO - PROCESS | 4167 | Values: 4822.1 18:58:53 INFO - PROCESS | 4167 | -------- Summary: end -------- 18:58:53 INFO - PROCESS | 4167 | 18:58:54 INFO - TEST-INFO | 4167: exit 0 18:58:54 INFO - TEST-OK | v8_7 | took 41736ms 18:58:54 INFO - SUITE-END | took 1217s 18:58:54 INFO - Completed test suite (00:20:17) 18:58:54 INFO - Working with test: dromaeo_css 18:58:54 INFO - Generating results file: dromaeo_css 18:58:54 INFO - Working with test: kraken 18:58:54 INFO - Generating results file: kraken 18:58:54 INFO - javascript benchmark 18:58:54 INFO - Working with test: v8_7 18:58:54 INFO - Generating results file: v8_7 18:58:54 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 18:58:54 INFO - process_Request line: dromaeo_css 6102.88 graph.html#tests=[[72,94,43]] 18:58:54 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:54 INFO - process_Request line: kraken 1558.40 graph.html#tests=[[232,94,43]] 18:58:54 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:54 INFO - process_Request line: v8_7 20195.51 graph.html#tests=[[230,94,43]] 18:58:54 INFO - RETURN: dromaeo_css: 6102.88 18:58:54 INFO - RETURN: kraken: 1558.40 18:58:54 INFO - RETURN: v8_7: 20195.51 18:58:54 INFO - javascript benchmark 18:58:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2505.57405241109, 2545.363659085229, 2584.3539115221197, 2598.5322641924454, 2600.1549496413672, 4288.57114288571, 4336.761478118702, 4373.169097871402, 4406.272964960777, 4406.845760398387, 4349.7390156590545, 4370.1915145697985, 4372.300431930892, 4464.464264288282, 4483.7085589436665, 4048.838046478145, 4094.61101195386, 4117.505899292089, 4124.587541245866, 4147.875563733093, 231.4502351902371, 4046.736962097454, 4057.431959525654, 4112.753234805921, 4139.668826493873, 4060.086480541869, 4101.589841015904, 4103.466549348565, 4107.589241075899, 4143.067809742814, 3883.941740873889, 4048.0891799345204, 4085.571015043437, 4133.958660413387, 4145.274576949022, 3992.1017771001584, 4053.655439287664, 4094.2425651254316, 4094.8362065517344, 4114.7119701620895, 4286.957130428687, 4299.742015479082, 4318.632916202127, 4350.021245219832, 4370.2789039808395, 4567.15507631086, 4645.488996210414, 4688.390509233778, 4689.507601701806, 4727.574518293336, 4681.180793361148, 4723.338732577442, 4729.787159577792, 4738.099761045391, 4782.95217047832, 4420.425344705232, 4424.623906967911, 4427.092446048552, 4453.688241823073, 4469.240229160985, 4736.242201247784, 4812.687175333592, 4820.0, 4820.421549414093, 4855.587275081587, 4589.036302376471, 4622.537746225351, 4630.004549021976, 4639.698419602715, 4699.553542413465, 4700.2244629635725, 4712.764361781898, 4714.269288260325, 4721.244600863845, 4769.403824521934, 4509.098180363941, 4589.747563884019, 4686.461056978423, 4692.483826779052, 4708.741019243975, 4569.451665800125, 4575.542445755398, 4608.193566125981, 4616.95383046172, 4652.092841895866, 3931.9017024574614, 3945.6448919597374, 3946.427767973628, 3949.3878448840474, 3970.82131304092, 3423.246885685145, 3442.638522955104, 3502.387082260594, 3502.509648649191, 3519.7008254298157, 4123.9381409278885, 4127.545969943304, 4145.751254924714, 4169.895752606149, 4194.433751443577, 4717.834875779331, 4740.478547359788, 4743.193657078305, 4756.6432517561325, 4761.071591039783, 3941.3693808990424, 4025.1748391579654, 4109.609587089221, 4162.708610397303, 4194.769287689206, 4163.458750362494, 4165.250254954138, 4171.499420069611, 4176.832926682899, 4218.704690671685, 4465.933011004838, 4480.126375356839, 4484.035932274576, 4485.798139083749, 4521.84173553924, 4491.505934347285, 4573.176828170961, 4696.38946936896, 4731.361266229015, 4762.452317983476, 4486.7083639563325, 4488.932666010078, 4506.0, 4513.413256276663, 4549.567791059844, 4506.526814684411, 4644.907101857876, 4649.2793616988065, 4660.743659098782, 4703.976480117578, 4562.224421848227, 4640.721556706473, 4695.131400690883, 4703.365045718784, 4710.69380490267, 4527.637788976808, 4557.4531056272135, 4578.954210457853, 4606.0, 4617.699849509771, 4429.867103986886, 4497.280435130494, 4566.977165114286, 4571.725696458223, 4579.06129243511, 4449.555044495524, 4488.5960263576435, 4496.21316269658, 4532.864014079583, 4554.180247555471, 4542.409486766699, 4565.977170114128, 4596.6322694185055, 4608.5621865922685, 4652.069586082729, 4356.956430435782, 4436.3123715824095, 4471.195184866755, 4497.955020449754, 4510.030343476168], "unit": "score", "name": "dojo.html", "value": 4296.1825515195815}, {"lowerIsBetter": false, "replicates": [494.86143879713694, 504.1454734225488, 527.8944211157769, 530.8434011966469, 542.2489851555592, 31752.68247317526, 32665.0, 32667.183320417, 32763.836180819122, 32777.50833737496, 35917.28165436696, 36623.81688091563, 36664.45003324952, 36707.0, 36760.81619591898, 7673.309402153805, 7813.0, 7838.294553490185, 7844.960775196116, 7868.685252589889, 7627.656755446018, 7725.72959946402, 7727.536347819121, 7731.265529774662, 7750.806229844271, 7894.250046245597, 7902.0, 7913.841723165533, 7958.602069896511, 7970.282674559288, 7817.452778305521, 7894.763157105296, 7917.604119793988, 7927.603619819015, 7927.960360198191, 7802.648880800378, 7905.881411778828, 7927.246911543394, 7947.046354437447, 7965.761027169194, 36849.81575092134, 36983.075423114366, 37389.81305093457, 37409.62590374089, 37576.436353454446, 2431.3678443604613, 2890.682024977251, 2995.970040299591, 3060.9846950765327, 3129.5931528901096, 23752.88123559371, 23881.0, 23917.28248152541, 24026.159084432136, 24155.396115097086, 3293.275479394529, 3348.2466445049913, 3405.5743032120986, 3424.092615456906, 3494.2487365216602, 143686.28156859253, 144553.0, 144827.0, 145112.0, 145791.27104364516, 45807.0, 46881.531184687716, 54818.0, 55924.72037639867, 56047.71976140175, 48598.0, 48696.75651621719, 48921.51078489241, 49236.26145607819, 49335.0, 13621.387037583332, 14084.859151408355, 14144.787828182585, 14186.290685465892, 14211.715765684836, 9788.412695238167, 9795.804083918281, 9911.008899110175, 9938.900610993942, 9942.80114397708, 17704.55738606545, 18879.716804247946, 18996.810031899782, 19001.334953276844, 19066.428007159808, 6893.724251030003, 7041.436685065182, 7061.293870612898, 7101.609411482418, 7126.750563730245, 856.9571521423904, 863.3869952333788, 880.1770344727701, 887.8357503861677, 958.2286259561121, 25611.87194064055, 26249.08128215503, 26324.21027369144, 26534.336641584116, 26538.0, 978.7308490165119, 1002.9147522460527, 1030.701096681954, 1070.314998401024, 1113.9443027848574, 13514.86485135136, 13730.725385492235, 13833.654158645913, 13911.373988170557, 13925.582232533041, 253927.0, 255740.0, 258051.0, 259663.0, 260009.0, 46008.769956150674, 46220.306695399595, 46490.302645460346, 46651.06697866024, 46687.0, 1199.6940780101017, 1209.8850609192114, 1223.6757259326287, 1225.7732319520917, 1228.0543981134656, 24840.25479235626, 25366.87316563479, 25880.482390352463, 26027.219183424528, 26090.347741306618, 40194.99512512211, 40418.0, 40640.0, 40928.79535602303, 41009.58990410177, 245919.0, 247068.0, 247981.0, 248524.0, 249292.0, 29371.7062829369, 30336.84831575828, 30910.22724431907, 30930.381392372477, 31074.0, 35771.46342804808, 36456.635433646385, 36499.27001460009, 36898.44652330271, 36898.631013690596, 31180.53229201609, 31417.52873706942, 31646.841765791025, 32012.67987320097, 32583.511247330836, 31095.68904310928, 31611.0, 31645.36709265848, 31665.20836979094, 31860.840695796374, 32972.34055318928, 33030.33939321152, 33091.8345408281, 33169.336613267114, 33921.49117763186, 34216.315673686884, 34473.827630861684, 35206.823965881034, 36035.0, 37812.81093594514, 25281.0, 25870.741292586834, 26574.734252658, 27400.72599273982, 28002.159935201977], "unit": "score", "name": "ext.html", "value": 16347.779338448288}, {"lowerIsBetter": false, "replicates": [322.52266645364847, 327.2505961348512, 329.12945259787864, 334.9666279527657, 342.2043748285237, 7923.12845586985, 8272.875906861402, 9748.122668959792, 14561.344739486722, 15264.160471174095, 14837.554873353789, 15181.392744290242, 15426.537203883874, 15909.363625454997, 15986.440474583393, 4534.888952206714, 5301.655392399492, 5514.393416724157, 5514.393416724157, 5550.47270509301, 5451.672899626015, 5512.503874651281, 5573.749181286852, 5576.470235327637, 5584.134459158817, 5946.375630558794, 6184.969075154618, 6225.377462253784, 6236.220472440945, 6257.4368306852375, 6017.548683848707, 6661.533692641517, 6681.398674119304, 6681.665916704145, 6685.264620891698, 6105.603135796159, 6224.128621992924, 6227.968860155715, 6246.187995560548, 6375.17122774041, 19038.42884713447, 19372.903135484372, 19913.502162446053, 20003.699944500844, 20134.395968120978, 1857.5077604434834, 1922.528980399797, 1928.3347245200384, 2032.573159636478, 2079.521710006707, 6215.782447614357, 6220.440160385542, 10927.743309519428, 12960.092793504458, 13087.345632718327, 1859.2098358197711, 1926.8014597885906, 1928.2768961639385, 1980.2574034736974, 2039.2047101630376, 54333.45666543363, 55032.0, 55504.72247638736, 55690.721546392415, 56920.43858026399, 13877.583672489842, 14483.927580362242, 14569.562913112624, 14573.41706331756, 14597.489087881873, 9486.19367353769, 9902.0, 21907.561848762936, 22079.558408832054, 22232.666510002364, 6200.627962322275, 6529.085927970088, 6535.738570457223, 6543.901841472381, 6611.66941652925, 6033.42682445167, 6103.023516237381, 6105.664188469676, 6116.0, 6131.601445906002, 4177.8328866845595, 4192.979035104805, 4198.454200953856, 4201.558836322142, 4211.599898009684, 1792.1666425112126, 1832.578506943384, 1873.8688291819442, 1895.1471837673103, 1904.8476121910214, 358.6861496190833, 785.4619585583779, 826.4297634632085, 900.446225571269, 921.4931787516839, 8735.868961965576, 9221.262299016063, 9244.815103697889, 9659.855102173473, 14049.0, 762.2415696382025, 855.07224661242, 886.096181894464, 902.9187373136449, 906.1799071839995, 7741.61291935401, 8069.6368663410285, 8195.180481951757, 8743.51910644908, 9001.324900632479, 432324.0, 440677.0, 447856.0, 448711.0, 451724.0, 62856.685716571126, 63155.684221578595, 64392.0, 66215.33784662189, 66463.66768166225, 1086.8913108689069, 1101.6529793115144, 1103.2442776697826, 1110.228391268061, 1112.1436493899653, 12608.558700445441, 13081.345932703136, 13284.867151328363, 13510.797338040134, 13963.720725585228, 26730.866345668146, 28095.578566321114, 28744.13767586976, 30108.54837177488, 30593.0, 31520.842395787873, 32843.0, 33186.5022024665, 33247.66752332446, 33512.49731253985, 6098.207233059674, 6158.445739883432, 6379.904301435389, 6428.903566446414, 6600.273969863215, 8172.468789528662, 9179.403338782959, 9214.354995150543, 9417.152456278967, 9475.857862131936, 7814.765557033298, 7977.7207797726805, 8117.671754580593, 8185.0996390398195, 8612.827743445221, 7774.2614451627005, 8027.39794515402, 8088.676452941816, 8428.957855210685, 8482.915170848213, 8223.54770487605, 8330.958345208235, 8377.371697122619, 8633.525156116222, 8911.955440223017, 6688.632125233159, 6715.764948226789, 6716.899246511209, 6751.831204219934, 6818.8636227276165, 6774.458043356618, 8725.345599080221, 8817.867731983897, 8848.955755221183, 8884.644614215618], "unit": "score", "name": "jquery.html", "value": 7613.219564357253}, {"lowerIsBetter": false, "replicates": [1319.313956742494, 1404.2697797145481, 1498.2658497336308, 1688.5440930948637, 1693.2465053051396, 6020.6086604370685, 6175.351588083243, 7048.471364647653, 7171.318724721144, 7182.928170718291, 6791.219009813873, 7016.087908571892, 7078.575285482862, 7091.326323999225, 7098.964505177467, 2025.6961455781604, 2056.28030189434, 2060.927867524637, 2067.6898465230183, 2074.7925207479207, 1953.0625299856079, 1970.123295133659, 1973.881567105971, 2030.167631271179, 2043.1929387891773, 2083.125087463269, 2089.717888085112, 2091.6025955068562, 2093.832493400532, 2103.0, 2047.06858379437, 2060.6702927531596, 2063.5769667218183, 2066.875987440751, 2073.1085633177727, 2052.568960518293, 2060.9896950515304, 2072.9378118656464, 2083.635363811327, 2084.978360603309, 7246.673899674527, 7271.236520165412, 7302.123745150563, 7304.598247096407, 7337.3029562191505, 3931.056546428865, 3994.4407782910416, 4038.3336749436603, 4043.716939814214, 4046.089629833293, 2533.6199570064637, 2565.4227798745133, 2594.15689900783, 2596.857172855492, 2616.5813469844734, 764.2548515197693, 768.5119948832531, 771.0400551313594, 778.1595876453416, 785.1638005524155, 9414.105659962293, 9440.10319019692, 9476.005019472994, 9487.573059212353, 9511.714648560484, 3618.131648404364, 3618.5838628557526, 3657.5610926688437, 3663.8351274192723, 3686.170611612419, 8223.753287401387, 8277.875831862528, 8279.0, 8308.335333173332, 8317.625706843206, 4053.7162398632404, 4067.877963661095, 4076.6942479313575, 4084.14233011071, 4093.242750091183, 3216.710496055366, 3292.687194716546, 3577.8211089445945, 3665.6151104134215, 3667.9633203668154, 3257.9837100814343, 3278.918027049343, 3293.1437826164893, 3300.488424294238, 3311.7350611950988, 982.8869679986893, 1057.735566108473, 1061.9150467962545, 1074.3178081918038, 1082.1613249731522, 817.1624085312484, 1045.414567842011, 1088.7223757941674, 1100.5817789240039, 1100.7963526747578, 6667.899981500282, 6760.7633732820095, 6773.085633439521, 6805.557638753465, 6827.283135270725, 956.3496822160859, 960.1982344742079, 1048.4600430778003, 1051.0645525482328, 1065.6057258814287, 5064.088464076502, 5070.264811602371, 5073.771680274396, 5089.033083714083, 5106.846794596168, 8233.50598964052, 8357.456765310235, 8460.915390846012, 8519.48883067018, 8615.698450554326, 8505.702300419456, 8552.0, 8563.058063612998, 8590.78523036929, 8605.182507661762, 6832.145981752281, 6838.111045564145, 6907.792766216921, 6911.89632155518, 6951.756688515878, 6428.6785660717715, 6643.900341494785, 6692.866142677217, 6698.698558564779, 6708.932910671026, 7742.419318551244, 7863.646135923783, 7988.320992715684, 8011.399145064027, 8051.35589152878, 7428.9628551856895, 7739.729109481141, 7753.806154846174, 7860.724874629361, 7999.520028798291, 5431.538319242751, 5615.101583746581, 6243.0, 6393.817143828406, 6426.4537514311805, 6380.234371875405, 6494.1232933553365, 6502.089707441057, 6527.902081468686, 6561.40947314744, 5995.730192141277, 6136.386361363828, 6164.3835616438, 6206.472449841814, 6227.564070515021, 5949.583529152917, 6021.729022194099, 6041.6375017499095, 6042.0, 6133.53998450127, 5831.970840145772, 5885.852853678693, 5960.910586341121, 5976.462118409364, 6021.578489505868, 5683.8010669626365, 5711.914321285267, 5715.685637289823, 5722.799702010409, 5734.197212390185, 5481.205225242238, 5505.779768809202, 5545.611807173459, 5555.333359996826, 5572.442755724395], "unit": "score", "name": "mootools.html", "value": 3989.727218623013}, {"lowerIsBetter": false, "replicates": [299.2712744467222, 301.5100461749657, 309.2207636755378, 310.39937720510807, 311.7786371676111, 5409.188621706741, 5474.479924407185, 5566.944330556688, 5569.359523654781, 5669.63147395419, 5452.127659574468, 5530.198121272413, 5540.584456165793, 5545.694986775726, 5551.472610102044, 4094.4267802507675, 4219.346001369778, 4227.85202517912, 4228.915421691564, 4236.533981262051, 4210.842018444921, 4218.0, 4218.219629368561, 4226.366045093245, 4226.556211597769, 4166.270902592049, 4170.520390155126, 4171.603697648734, 4175.749455032693, 4180.916381672365, 4122.319817230154, 4146.336586146217, 4155.958440415588, 4182.372644103379, 4192.643625291823, 3522.137076416269, 3656.177360093984, 3657.7073834093208, 3662.377395842713, 3665.065408320888, 5108.489151084899, 5173.508516690908, 5208.479152084799, 5216.5305122538775, 5276.630635855492, 4817.012512434978, 4828.155072862271, 4831.613470922353, 4832.299316599108, 4833.589144922686, 5796.043652797283, 5800.129980502916, 5803.912941305884, 5809.651420914759, 5810.157527158581, 3903.902402439933, 3962.9405558916637, 3969.2656858481273, 3983.6016398359934, 3997.2605068062503, 5984.072468767348, 6059.757609695607, 6065.302490213594, 6068.908966365508, 6072.36240194782, 4063.227986682521, 4088.2845502037026, 4099.97950010248, 4101.89745256365, 4107.301758701028, 4159.209750147463, 4165.645920096826, 4168.374743788456, 4172.728772629769, 4175.832966681299, 4616.215243408628, 4784.976075119672, 4785.617150627942, 4787.688800227974, 4790.401199850019, 5596.496315331639, 5744.798932037359, 5755.827325180251, 5756.683382413924, 5761.711914404263, 1449.9347529361205, 1463.9634009149856, 1471.154086400324, 1472.146155229964, 1476.047949072842, 968.3415277611292, 986.0287616697548, 988.4365911430416, 994.9005099490138, 999.2206079258191, 5037.899242015213, 5052.6715763475995, 5055.292259083732, 5060.468650791688, 5065.290859279704, 6017.458428741435, 6023.427774361428, 6028.186194863725, 6029.969850150721, 6040.214772079602, 5013.749312534359, 5047.646664733434, 5048.671836330626, 5051.318072060225, 5052.216906379517, 3175.5712978748033, 3186.060112266887, 3252.15443984561, 3254.8047117173046, 3258.3971965186042, 5684.857878553069, 5701.885962280731, 5707.486326230576, 5714.314282286152, 5736.311642602915, 6145.416185462464, 6183.628982261079, 6190.133381326618, 6190.350013248634, 6191.938080619227, 5542.196381524737, 5689.231953686282, 5711.771529138871, 5716.114002329646, 5719.027765279912, 6007.279126504847, 6011.489023433057, 6022.337542870368, 6023.759049637965, 6031.185789918481, 5831.35855055935, 5839.124131380327, 5883.55873309512, 5885.3820348862755, 5897.439743224387, 5691.658500489983, 5691.8292451226525, 5691.971540142273, 5696.344920334214, 5697.800576979786, 3976.3240249158293, 4070.5929407059057, 4120.052387950728, 4126.66986641062, 4128.8348466061025, 5910.881782364415, 5938.61399009063, 5971.552133590085, 5983.042713165873, 6075.939240607714, 5814.680192589448, 5828.067509198508, 5847.707614619167, 5855.707214639337, 5878.088896221093, 5789.189513468202, 5813.215215945962, 5813.912791308218, 5846.824595262149, 5852.209951656472, 5605.271314729059, 5690.402507736793, 5697.4587414195585, 5709.457601527848, 5710.029295019774, 5852.502537284378, 5871.911921321098, 5872.471477567039, 5879.235699359056, 5902.085176797432, 5699.601027928005, 5702.173184888251, 5713.143028545752, 5714.971425142848, 5716.056850619601], "unit": "score", "name": "prototype.html", "value": 4324.0176933959165}, {"lowerIsBetter": false, "replicates": [760.4790718357923, 767.0909971683556, 780.4692808889956, 787.885756565298, 801.0667572278296, 11720.824187637181, 11738.295702257848, 11837.348945807988, 11855.347955862424, 11933.701657458569, 11116.333020018805, 11319.0, 11364.204505684605, 11366.488508017139, 11370.431478426066, 759.4797563668877, 770.1105223466876, 774.9573773442459, 777.1334961517895, 777.9260970207849, 760.1600231743927, 765.3762183820196, 767.5471471831618, 767.8118860879065, 767.93088622024, 796.2594786848229, 797.0753925446484, 799.6641410607559, 800.0918956983807, 800.2637573432456, 790.9723159689383, 795.9044914610226, 799.1169757418056, 799.2167675677811, 800.6997375984006, 594.1533315026071, 594.3402822866615, 595.5711887441036, 596.1088173181079, 596.4900010491054, 11105.444727763661, 11111.777764444665, 11172.162087843362, 11214.158938079596, 11215.046721028722, 9735.0, 9850.931304426007, 9944.801103977952, 10080.193584513221, 10277.948610256975, 8865.46807191564, 8938.46369217849, 9051.185393314567, 9214.677486288016, 9382.061793820632, 3197.680231976807, 3220.178854392115, 3249.1227368610344, 3273.738100951918, 3344.9331013379597, 34202.82898585491, 35209.82395088034, 38520.229595408215, 39583.0, 39890.60109398898, 9394.530273486298, 9757.365771224848, 9782.266330025277, 9856.605735770489, 10000.14998725102, 16926.83073169277, 16937.745933811002, 16967.0, 16973.066481343398, 17044.829551704574, 6715.059891615178, 6816.386525212754, 6847.144106986627, 6960.617166055814, 6981.79054628362, 3549.3433714762336, 3579.856805727794, 3593.6509837382614, 3639.927201455956, 3665.303592317451, 2483.1309041835575, 2532.607445845897, 2535.3408113890523, 2535.936601584938, 2541.3900663840545, 448.7688840247275, 449.51003406287305, 460.14872485901486, 469.4483981321933, 469.591455433768, 520.1807153732885, 535.5983012740445, 541.9729013549306, 566.815784869919, 577.2870504926412, 6709.269920156017, 6797.2523022467485, 6946.6179360134665, 7032.718691252395, 7162.176349719744, 498.5189292332916, 567.7019564728467, 570.2814453788174, 577.4369989260438, 579.7333226715758, 3620.9275814483562, 3630.407534468899, 3929.332013557702, 4115.300398932189, 4207.116505533872, 43497.130057398674, 43591.78204109023, 46452.0, 46734.0, 46988.0, 37275.25449490995, 37508.249835003146, 37526.24947501034, 38220.61779382226, 43149.35275970863, 36332.0, 38162.038934938835, 38880.0, 39014.024649383995, 39203.80398098048, 7493.325600695964, 7910.920890791019, 7954.244346787046, 7967.960160199394, 8145.266925976453, 27898.72101278961, 30238.848805756712, 30386.544201836547, 30807.383852323277, 31294.530582040832, 35276.47085293774, 38449.6155038446, 38513.614863852126, 38586.0, 38661.6133838658, 9794.559244833858, 9802.9019709802, 10155.339902906288, 10312.535935883054, 10326.793464130526, 10660.62687805923, 10724.03483686472, 10973.3964631946, 11385.658430247106, 12416.751664966469, 10535.894641053492, 10767.515461804394, 10812.026917577456, 11018.669439916815, 11229.49467273991, 10503.78992420132, 10621.0, 10844.403557804397, 11217.60738374153, 11228.0, 10151.0, 10281.228907832092, 10456.738581535523, 10712.303700259457, 10728.51721672511, 9047.140521650434, 9239.260859131387, 9279.536023198678, 9324.95337523308, 9404.858927115962, 9070.63717451321, 9623.5669394876, 9626.518674066128, 9634.0, 9658.71023869285], "unit": "score", "name": "yui.html", "value": 5600.448207036493}], "name": "dromaeo_css", "value": 6102.87734435267}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 115.0, 116.0, 118.0, 125.0, 114.0, 116.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [169.0, 142.0, 162.0, 164.0, 136.0, 159.0, 155.0, 136.0, 169.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [166.0, 163.0, 166.0, 162.0, 164.0, 173.0, 163.0, 162.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 77.0, 74.0, 141.0, 75.0, 77.0, 74.0, 76.0, 153.0], "unit": "score", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 132.0, 98.0, 98.0, 98.0, 139.0, 97.0, 97.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [69.0, 79.0, 70.0, 71.0, 71.0, 71.0, 71.0, 78.0, 72.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 83.0, 86.0, 92.0, 85.0, 87.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 123.0, 127.0, 124.0, 129.0, 122.0, 127.0, 126.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.1}, {"lowerIsBetter": true, "replicates": [139.0, 153.0, 147.0, 148.0, 148.0, 134.0, 147.0, 151.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 71.0, 74.0, 71.0, 72.0, 71.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1558.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.83695652173913], "unit": "score", "name": "Richards", "value": 207.85817599999996}, {"lowerIsBetter": false, "replicates": [187.0907390084191], "unit": "score", "name": "DeltaBlue", "value": 353.40070999999995}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [730.9941520467836], "unit": "score", "name": "Earley", "value": 911.7213840000002}, {"lowerIsBetter": false, "replicates": [12696.20253164557], "unit": "score", "name": "Boyer", "value": 52.49309770687939}, {"lowerIsBetter": false, "replicates": [42416.666666666664], "unit": "score", "name": "RegExp", "value": 21.47705304518664}, {"lowerIsBetter": false, "replicates": [589.2751915144372], "unit": "score", "name": "Splay", "value": 138.29022699999996}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20195.512165814216}]} 18:58:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20195.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1558.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6102.88"}}} 18:58:54 INFO - Return code: 0 18:58:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:58:54 INFO - # TBPL SUCCESS # 18:58:54 INFO - Running post-action listener: _resource_record_post_action 18:58:54 INFO - Running post-run listener: _resource_record_post_run 18:58:56 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 539557888; Read time: 0; Write time: 746688 18:58:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231776256; Read time: 0; Write time: 348656 18:58:56 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 307781632; Read time: 0; Write time: 398032 18:58:56 INFO - Running post-run listener: _upload_blobber_files 18:58:56 INFO - Blob upload gear active. 18:58:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:58:56 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 18:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:58:56 INFO - (blobuploader) - INFO - Open directory for files ... 18:58:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:58:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:58:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:57 INFO - (blobuploader) - INFO - Done attempting. 18:58:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:58:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:58 INFO - (blobuploader) - INFO - Done attempting. 18:58:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:58:58 INFO - Return code: 0 18:58:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:58:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:58:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a851cda45be115b573f983101c769f5171f75566167913b7f9a9a45b6a51d218bf7ce987bdca46be168ea878bd7bef9cecfc8acd962452aea9727ed75f6b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/180805fa92d1e55d6830624443443375e0ca7e95a607d309b1f3a0137e3fb4a9c1ed21c6635b9e8a3a174fb23842d148029694b9ee1a56dacdccc6e807710124"} 18:58:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:58:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:58:58 INFO - Contents: 18:58:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a851cda45be115b573f983101c769f5171f75566167913b7f9a9a45b6a51d218bf7ce987bdca46be168ea878bd7bef9cecfc8acd962452aea9727ed75f6b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/180805fa92d1e55d6830624443443375e0ca7e95a607d309b1f3a0137e3fb4a9c1ed21c6635b9e8a3a174fb23842d148029694b9ee1a56dacdccc6e807710124"} 18:58:58 INFO - Copying logs to upload dir... 18:58:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.151706 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-13 18:58:57.802417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.806073) ========= 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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a851cda45be115b573f983101c769f5171f75566167913b7f9a9a45b6a51d218bf7ce987bdca46be168ea878bd7bef9cecfc8acd962452aea9727ed75f6b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/180805fa92d1e55d6830624443443375e0ca7e95a607d309b1f3a0137e3fb4a9c1ed21c6635b9e8a3a174fb23842d148029694b9ee1a56dacdccc6e807710124"} build_url:https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/NGPlBN9EQ8qyyLl39-oo0g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a851cda45be115b573f983101c769f5171f75566167913b7f9a9a45b6a51d218bf7ce987bdca46be168ea878bd7bef9cecfc8acd962452aea9727ed75f6b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/180805fa92d1e55d6830624443443375e0ca7e95a607d309b1f3a0137e3fb4a9c1ed21c6635b9e8a3a174fb23842d148029694b9ee1a56dacdccc6e807710124"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.831641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.832189) ========= 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=52faae308a556c440401f8e5000001e8-1452736978.373629-648688326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.916728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 18:58:57.917083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 18:58:57.917453) ========= ========= Total master_lag: 0.22 =========