builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1452794369.61 results: success (0) buildid: 20160114092258 builduid: 0b4712a3511b4d68b12a9746affcdffa revision: 03215fabd7fb1932e8fa402598092f8b2a7c4131 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.610413) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.610936) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.611265) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006400 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.647819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.648154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.663811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.664089) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004706 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.716791) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.717088) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.717425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.717739) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 09:59:29-- 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% 221M=0s 2016-01-14 09:59:30 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.879276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.879618) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.930146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:29.930516) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03215fabd7fb1932e8fa402598092f8b2a7c4131 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03215fabd7fb1932e8fa402598092f8b2a7c4131 --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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 09:59:30,116 truncating revision to first 12 chars 2016-01-14 09:59:30,117 Setting DEBUG logging. 2016-01-14 09:59:30,117 attempt 1/10 2016-01-14 09:59:30,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03215fabd7fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 09:59:30,391 unpacking tar archive at: fx-team-03215fabd7fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:30.557279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:30.557590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:30.567696) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:30.568056) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 09:59:30.568505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-14 09:59:30.568807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:30 INFO - MultiFileLogger online at 20160114 09:59:30 in /builds/slave/test 09:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:59:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:30 INFO - {'append_to_log': False, 09:59:30 INFO - 'base_work_dir': '/builds/slave/test', 09:59:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:30 INFO - 'branch': 'Fx-Team-Non-PGO', 09:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:30 INFO - 'config_files': ('talos/linux_config.py',), 09:59:30 INFO - 'default_actions': ('clobber', 09:59:30 INFO - 'read-buildbot-config', 09:59:30 INFO - 'download-and-extract', 09:59:30 INFO - 'populate-webroot', 09:59:30 INFO - 'create-virtualenv', 09:59:30 INFO - 'install', 09:59:30 INFO - 'run-tests'), 09:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:30 INFO - 'download_minidump_stackwalk': True, 09:59:30 INFO - 'download_symbols': 'ondemand', 09:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:30 INFO - 'installer_path': 'installer.exe', 09:59:30 INFO - 'log_level': 'info', 09:59:30 INFO - 'log_name': 'talos', 09:59:30 INFO - 'log_to_console': True, 09:59:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:30 INFO - 'opt_config_files': (), 09:59:30 INFO - 'pip_index': False, 09:59:30 INFO - 'sps_profile': False, 09:59:30 INFO - 'sps_profile_interval': 0, 09:59:30 INFO - 'suite': 'dromaeojs-e10s', 09:59:30 INFO - 'system_bits': '32', 09:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:30 INFO - 'title': 'talos-linux64-ix-037', 09:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:30 INFO - 'use_talos_json': True, 09:59:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:30 INFO - 'work_dir': 'build'} 09:59:30 INFO - ##### 09:59:30 INFO - ##### Running clobber step. 09:59:30 INFO - ##### 09:59:30 INFO - Running pre-action listener: _resource_record_pre_action 09:59:30 INFO - Running main action method: clobber 09:59:30 INFO - rmtree: /builds/slave/test/build 09:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:31 INFO - Running post-action listener: _resource_record_post_action 09:59:31 INFO - ##### 09:59:31 INFO - ##### Running read-buildbot-config step. 09:59:31 INFO - ##### 09:59:31 INFO - Running pre-action listener: _resource_record_pre_action 09:59:31 INFO - Running main action method: read_buildbot_config 09:59:31 INFO - Using buildbot properties: 09:59:31 INFO - { 09:59:31 INFO - "project": "", 09:59:31 INFO - "product": "firefox", 09:59:31 INFO - "script_repo_revision": "production", 09:59:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:59:31 INFO - "repository": "", 09:59:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:59:31 INFO - "buildid": "20160114092258", 09:59:31 INFO - "pgo_build": "False", 09:59:31 INFO - "basedir": "/builds/slave/test", 09:59:31 INFO - "buildnumber": 695, 09:59:31 INFO - "slavename": "talos-linux64-ix-037", 09:59:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:59:31 INFO - "platform": "ubuntu64_hw", 09:59:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:59:31 INFO - "branch": "fx-team", 09:59:31 INFO - "repo_path": "integration/fx-team", 09:59:31 INFO - "revision": "03215fabd7fb1932e8fa402598092f8b2a7c4131", 09:59:31 INFO - "stage_platform": "linux64", 09:59:31 INFO - "builduid": "0b4712a3511b4d68b12a9746affcdffa", 09:59:31 INFO - "slavebuilddir": "test" 09:59:31 INFO - } 09:59:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:59:31 INFO - Running post-action listener: _resource_record_post_action 09:59:31 INFO - ##### 09:59:31 INFO - ##### Running download-and-extract step. 09:59:31 INFO - ##### 09:59:31 INFO - Running pre-action listener: _resource_record_pre_action 09:59:31 INFO - Running main action method: download_and_extract 09:59:31 INFO - mkdir: /builds/slave/test/build/tests 09:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:31 INFO - https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/test_packages.json 09:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/test_packages.json 09:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:59:38 INFO - Downloaded 1448 bytes. 09:59:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:59:38 INFO - Using the following test package requirements: 09:59:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:38 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:59:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'jsshell-linux-x86_64.zip'], 09:59:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:59:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:59:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:38 INFO - https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:44 INFO - Downloaded 22762528 bytes. 09:59:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:59:45 INFO - Return code: 0 09:59:45 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 09:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:45 INFO - https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:59:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:59:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:52 INFO - Downloaded 22762528 bytes. 09:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:59:53 INFO - Return code: 0 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:53 INFO - https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:56 INFO - Downloaded 11132144 bytes. 09:59:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:59:56 INFO - Return code: 0 09:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:56 INFO - https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 09:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmDUWfzOT8iNauZg6XoUEg/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 10:00:02 INFO - Downloaded 53998104 bytes. 10:00:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:02 INFO - mkdir: /builds/slave/test/properties 10:00:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:02 INFO - Contents: 10:00:02 INFO - build_url:https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:00:02 INFO - Running post-action listener: _resource_record_post_action 10:00:02 INFO - Running post-action listener: set_extra_try_arguments 10:00:02 INFO - ##### 10:00:02 INFO - ##### Running populate-webroot step. 10:00:02 INFO - ##### 10:00:02 INFO - Running pre-action listener: _resource_record_pre_action 10:00:02 INFO - Running main action method: populate_webroot 10:00:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:02 INFO - '--tppagecycles', 10:00:02 INFO - '7'], 10:00:02 INFO - 'tests': ['tsvgm']}}, 10:00:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:00:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'tests': ['damp', 'tps']}, 10:00:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['damp', 'tps']}, 10:00:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:00:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:02 INFO - 'other': {'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'other_l64': {'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'other_nol64': {'tests': ['a11yr', 10:00:02 INFO - 'ts_paint', 10:00:02 INFO - 'tpaint', 10:00:02 INFO - 'sessionrestore', 10:00:02 INFO - 'sessionrestore_no_auto_restore']}, 10:00:02 INFO - 'svgr': {'tests': ['tsvgx', 10:00:02 INFO - 'tsvgr_opacity', 10:00:02 INFO - 'tart', 10:00:02 INFO - 'tscrollx', 10:00:02 INFO - 'cart']}, 10:00:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['tsvgx', 10:00:02 INFO - 'tsvgr_opacity', 10:00:02 INFO - 'tart', 10:00:02 INFO - 'tscrollx', 10:00:02 INFO - 'cart']}, 10:00:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'tests': ['tp5o']}, 10:00:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'talos_options': ['--e10s'], 10:00:02 INFO - 'tests': ['tp5o']}, 10:00:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'talos_options': ['--xperf_path', 10:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:02 INFO - 'tests': ['tp5n']}, 10:00:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:02 INFO - 'talos_options': ['--e10s', 10:00:02 INFO - '--xperf_path', 10:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:02 INFO - 'tests': ['tp5n']}}, 10:00:02 INFO - 'talos.zip': {'path': '', 10:00:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:02 INFO - Running post-action listener: _resource_record_post_action 10:00:02 INFO - ##### 10:00:02 INFO - ##### Running create-virtualenv step. 10:00:02 INFO - ##### 10:00:02 INFO - Running pre-action listener: _resource_record_pre_action 10:00:02 INFO - Running main action method: create_virtualenv 10:00:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:02 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 10:00:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:02 INFO - Using real prefix '/usr' 10:00:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:04 INFO - Installing pip.................done. 10:00:04 INFO - Return code: 0 10:00:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00: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', 'pip>=1.5'] in /builds/slave/test/build 10:00: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 pip>=1.5 10:00:04 INFO - Using env: {'DISPLAY': ':0', 10:00:04 INFO - 'HOME': '/home/cltbld', 10:00:04 INFO - 'LANG': 'en_US.UTF-8', 10:00:04 INFO - 'LANGUAGE': 'en_US:en', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MAIL': '/var/mail/cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SHLVL': '1', 10:00:04 INFO - 'TERM': 'linux', 10:00:04 INFO - 'TMOUT': '86400', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - '_': '/tools/buildbot/bin/python'} 10:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:04 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 10:00:04 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', '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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:00: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 psutil>=0.7.1 10:00:04 INFO - Using env: {'DISPLAY': ':0', 10:00:04 INFO - 'HOME': '/home/cltbld', 10:00:04 INFO - 'LANG': 'en_US.UTF-8', 10:00:04 INFO - 'LANGUAGE': 'en_US:en', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MAIL': '/var/mail/cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SHLVL': '1', 10:00:04 INFO - 'TERM': 'linux', 10:00:04 INFO - 'TMOUT': '86400', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - '_': '/tools/buildbot/bin/python'} 10:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:05 INFO - Downloading/unpacking psutil>=0.7.1 10:00:05 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 10:00:05 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 10:00:05 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 10:00:05 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 10:00:05 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 10:00:05 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 10:00:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:07 INFO - Installing collected packages: psutil 10:00:07 INFO - Running setup.py install for psutil 10:00:07 INFO - building 'psutil._psutil_linux' extension 10:00:07 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 10:00:07 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 10:00:07 INFO - building 'psutil._psutil_posix' extension 10:00:07 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 10:00:07 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 10:00:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:07 INFO - Successfully installed psutil 10:00:07 INFO - Cleaning up... 10:00:07 INFO - Return code: 0 10:00:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:07 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:07 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 10:00:07 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 10:00:07 INFO - Using env: {'DISPLAY': ':0', 10:00:07 INFO - 'HOME': '/home/cltbld', 10:00:07 INFO - 'LANG': 'en_US.UTF-8', 10:00:07 INFO - 'LANGUAGE': 'en_US:en', 10:00:07 INFO - 'LOGNAME': 'cltbld', 10:00:07 INFO - 'MAIL': '/var/mail/cltbld', 10:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:07 INFO - 'MOZ_NO_REMOTE': '1', 10:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:07 INFO - 'NO_EM_RESTART': '1', 10:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:07 INFO - 'PWD': '/builds/slave/test', 10:00:07 INFO - 'SHELL': '/bin/bash', 10:00:07 INFO - 'SHLVL': '1', 10:00:07 INFO - 'TERM': 'linux', 10:00:07 INFO - 'TMOUT': '86400', 10:00:07 INFO - 'USER': 'cltbld', 10:00:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:07 INFO - '_': '/tools/buildbot/bin/python'} 10:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:00:09 INFO - Installing collected packages: mozsystemmonitor 10:00:09 INFO - Running setup.py install for mozsystemmonitor 10:00:09 INFO - Successfully installed mozsystemmonitor 10:00:09 INFO - Cleaning up... 10:00:09 INFO - Return code: 0 10:00:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:09 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:09 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 10:00:09 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 10:00:09 INFO - Using env: {'DISPLAY': ':0', 10:00:09 INFO - 'HOME': '/home/cltbld', 10:00:09 INFO - 'LANG': 'en_US.UTF-8', 10:00:09 INFO - 'LANGUAGE': 'en_US:en', 10:00:09 INFO - 'LOGNAME': 'cltbld', 10:00:09 INFO - 'MAIL': '/var/mail/cltbld', 10:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:09 INFO - 'MOZ_NO_REMOTE': '1', 10:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:09 INFO - 'NO_EM_RESTART': '1', 10:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:09 INFO - 'PWD': '/builds/slave/test', 10:00:09 INFO - 'SHELL': '/bin/bash', 10:00:09 INFO - 'SHLVL': '1', 10:00:09 INFO - 'TERM': 'linux', 10:00:09 INFO - 'TMOUT': '86400', 10:00:09 INFO - 'USER': 'cltbld', 10:00:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:09 INFO - '_': '/tools/buildbot/bin/python'} 10:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:09 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 10:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:11 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 10:00:11 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 10:00:11 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 10:00:11 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 10:00:11 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 10:00:11 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 10:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:12 INFO - Downloading docopt-0.6.1.tar.gz 10:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:12 INFO - Running setup.py install for blobuploader 10:00:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:12 INFO - Running setup.py install for requests 10:00:12 INFO - Running setup.py install for docopt 10:00:12 INFO - Successfully installed blobuploader requests docopt 10:00:12 INFO - Cleaning up... 10:00:13 INFO - Return code: 0 10:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:13 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')]} 10:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:13 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')]} 10:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:13 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:13 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 10:00:13 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 10:00:13 INFO - Using env: {'DISPLAY': ':0', 10:00:13 INFO - 'HOME': '/home/cltbld', 10:00:13 INFO - 'LANG': 'en_US.UTF-8', 10:00:13 INFO - 'LANGUAGE': 'en_US:en', 10:00:13 INFO - 'LOGNAME': 'cltbld', 10:00:13 INFO - 'MAIL': '/var/mail/cltbld', 10:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:13 INFO - 'MOZ_NO_REMOTE': '1', 10:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:13 INFO - 'NO_EM_RESTART': '1', 10:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:13 INFO - 'PWD': '/builds/slave/test', 10:00:13 INFO - 'SHELL': '/bin/bash', 10:00:13 INFO - 'SHLVL': '1', 10:00:13 INFO - 'TERM': 'linux', 10:00:13 INFO - 'TMOUT': '86400', 10:00:13 INFO - 'USER': 'cltbld', 10:00:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:13 INFO - '_': '/tools/buildbot/bin/python'} 10:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:13 INFO - Running setup.py (path:/tmp/pip-msdMRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:13 INFO - Running setup.py (path:/tmp/pip-dVWJrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:13 INFO - Running setup.py (path:/tmp/pip-hxo7_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:13 INFO - Running setup.py (path:/tmp/pip-hg2i24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:13 INFO - Running setup.py (path:/tmp/pip-JZOnGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:13 INFO - Running setup.py (path:/tmp/pip-B90XK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:13 INFO - Running setup.py (path:/tmp/pip-HzvKHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:13 INFO - Running setup.py (path:/tmp/pip-GuO5so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:13 INFO - Running setup.py (path:/tmp/pip-7j3EW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:13 INFO - Running setup.py (path:/tmp/pip-3ifiTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:13 INFO - Running setup.py (path:/tmp/pip-tayR50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:14 INFO - Running setup.py (path:/tmp/pip-M25krp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:14 INFO - Running setup.py (path:/tmp/pip-w0a6pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:14 INFO - Running setup.py (path:/tmp/pip-hQBP5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:14 INFO - Running setup.py (path:/tmp/pip-EP0ftY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:14 INFO - Running setup.py (path:/tmp/pip-_2nrd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:14 INFO - Running setup.py (path:/tmp/pip-QAC41N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:14 INFO - Running setup.py install for manifestparser 10:00:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:14 INFO - Running setup.py install for mozcrash 10:00:14 INFO - Running setup.py install for mozdebug 10:00:14 INFO - Running setup.py install for mozdevice 10:00:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:14 INFO - Running setup.py install for mozfile 10:00:14 INFO - Running setup.py install for mozhttpd 10:00:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozinfo 10:00:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozInstall 10:00:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozleak 10:00:15 INFO - Running setup.py install for mozlog 10:00:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for moznetwork 10:00:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozprocess 10:00:15 INFO - Running setup.py install for mozprofile 10:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozrunner 10:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:15 INFO - Running setup.py install for mozscreenshot 10:00:16 INFO - Running setup.py install for moztest 10:00:16 INFO - Running setup.py install for mozversion 10:00:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:16 INFO - Cleaning up... 10:00:16 INFO - Return code: 0 10:00:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', '-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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:16 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 10:00:16 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 10:00:16 INFO - Using env: {'DISPLAY': ':0', 10:00:16 INFO - 'HOME': '/home/cltbld', 10:00:16 INFO - 'LANG': 'en_US.UTF-8', 10:00:16 INFO - 'LANGUAGE': 'en_US:en', 10:00:16 INFO - 'LOGNAME': 'cltbld', 10:00:16 INFO - 'MAIL': '/var/mail/cltbld', 10:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:16 INFO - 'MOZ_NO_REMOTE': '1', 10:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:16 INFO - 'NO_EM_RESTART': '1', 10:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:16 INFO - 'PWD': '/builds/slave/test', 10:00:16 INFO - 'SHELL': '/bin/bash', 10:00:16 INFO - 'SHLVL': '1', 10:00:16 INFO - 'TERM': 'linux', 10:00:16 INFO - 'TMOUT': '86400', 10:00:16 INFO - 'USER': 'cltbld', 10:00:16 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:16 INFO - '_': '/tools/buildbot/bin/python'} 10:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:16 INFO - Running setup.py (path:/tmp/pip-tAdJ1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:16 INFO - Running setup.py (path:/tmp/pip-GQ9jj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:16 INFO - Running setup.py (path:/tmp/pip-oZ3ofl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:16 INFO - Running setup.py (path:/tmp/pip-v6uZIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:16 INFO - Running setup.py (path:/tmp/pip-vfnSqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:16 INFO - Running setup.py (path:/tmp/pip-e4Nzj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:16 INFO - Running setup.py (path:/tmp/pip-7S0NWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:16 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)) 10:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:16 INFO - Running setup.py (path:/tmp/pip-p6hRfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:17 INFO - Running setup.py (path:/tmp/pip-LERSd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:17 INFO - Running setup.py (path:/tmp/pip-Qucirq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:17 INFO - Running setup.py (path:/tmp/pip-aU67mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:17 INFO - Running setup.py (path:/tmp/pip-aP0YiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:17 INFO - Running setup.py (path:/tmp/pip-CvnamM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:17 INFO - Running setup.py (path:/tmp/pip-jCOqI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:17 INFO - Running setup.py (path:/tmp/pip-ehFKjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:17 INFO - Running setup.py (path:/tmp/pip-aEuSuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:17 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)) 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:17 INFO - Running setup.py (path:/tmp/pip-Ak1RTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:17 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)) 10:00:17 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)) 10:00:17 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)) 10:00:17 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)) 10:00:17 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)) 10:00:17 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)) 10:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:19 INFO - Downloading blessings-1.5.1.tar.gz 10:00:19 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 10:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:19 INFO - Installing collected packages: blessings 10:00:19 INFO - Running setup.py install for blessings 10:00:19 INFO - Successfully installed blessings 10:00:19 INFO - Cleaning up... 10:00:19 INFO - Return code: 0 10:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:19 INFO - Reading from file tmpfile_stdout 10:00:19 INFO - Current package versions: 10:00:19 INFO - argparse == 1.2.1 10:00:19 INFO - blessings == 1.5.1 10:00:19 INFO - blobuploader == 1.2.4 10:00:19 INFO - docopt == 0.6.1 10:00:19 INFO - manifestparser == 1.1 10:00:19 INFO - mozInstall == 1.12 10:00:19 INFO - mozcrash == 0.16 10:00:19 INFO - mozdebug == 0.1 10:00:19 INFO - mozdevice == 0.48 10:00:19 INFO - mozfile == 1.2 10:00:19 INFO - mozhttpd == 0.7 10:00:19 INFO - mozinfo == 0.9 10:00:19 INFO - mozleak == 0.1 10:00:19 INFO - mozlog == 3.1 10:00:19 INFO - moznetwork == 0.27 10:00:19 INFO - mozprocess == 0.22 10:00:19 INFO - mozprofile == 0.28 10:00:19 INFO - mozrunner == 6.11 10:00:19 INFO - mozscreenshot == 0.1 10:00:19 INFO - mozsystemmonitor == 0.0 10:00:19 INFO - moztest == 0.7 10:00:19 INFO - mozversion == 1.4 10:00:19 INFO - psutil == 3.1.1 10:00:19 INFO - requests == 1.2.3 10:00:19 INFO - wsgiref == 0.1.2 10:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:19 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')]} 10:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:19 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')]} 10:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:19 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:19 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 10:00:19 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 10:00:19 INFO - Using env: {'DISPLAY': ':0', 10:00:19 INFO - 'HOME': '/home/cltbld', 10:00:19 INFO - 'LANG': 'en_US.UTF-8', 10:00:19 INFO - 'LANGUAGE': 'en_US:en', 10:00:19 INFO - 'LOGNAME': 'cltbld', 10:00:19 INFO - 'MAIL': '/var/mail/cltbld', 10:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:19 INFO - 'MOZ_NO_REMOTE': '1', 10:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:19 INFO - 'NO_EM_RESTART': '1', 10:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:19 INFO - 'PWD': '/builds/slave/test', 10:00:19 INFO - 'SHELL': '/bin/bash', 10:00:19 INFO - 'SHLVL': '1', 10:00:19 INFO - 'TERM': 'linux', 10:00:19 INFO - 'TMOUT': '86400', 10:00:19 INFO - 'USER': 'cltbld', 10:00:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:19 INFO - '_': '/tools/buildbot/bin/python'} 10:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 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)) 10:00:20 INFO - Cleaning up... 10:00:20 INFO - Return code: 0 10:00:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:20 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')]} 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 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')]} 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:20 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 10:00:20 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 10:00:20 INFO - Using env: {'DISPLAY': ':0', 10:00:20 INFO - 'HOME': '/home/cltbld', 10:00:20 INFO - 'LANG': 'en_US.UTF-8', 10:00:20 INFO - 'LANGUAGE': 'en_US:en', 10:00:20 INFO - 'LOGNAME': 'cltbld', 10:00:20 INFO - 'MAIL': '/var/mail/cltbld', 10:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:20 INFO - 'MOZ_NO_REMOTE': '1', 10:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:20 INFO - 'NO_EM_RESTART': '1', 10:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:20 INFO - 'PWD': '/builds/slave/test', 10:00:20 INFO - 'SHELL': '/bin/bash', 10:00:20 INFO - 'SHLVL': '1', 10:00:20 INFO - 'TERM': 'linux', 10:00:20 INFO - 'TMOUT': '86400', 10:00:20 INFO - 'USER': 'cltbld', 10:00:20 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:20 INFO - '_': '/tools/buildbot/bin/python'} 10:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:20 INFO - Downloading/unpacking jsonschema 10:00:20 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 10:00:20 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 10:00:20 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 10:00:20 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 10:00:20 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 10:00:20 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 10:00:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:22 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 10:00:22 INFO - Downloading/unpacking functools32 (from jsonschema) 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:22 INFO - warning: no files found matching '*.txt' 10:00:22 INFO - no previously-included directories found matching 'build' 10:00:22 INFO - no previously-included directories found matching 'dist' 10:00:22 INFO - no previously-included directories found matching '.git*' 10:00:22 INFO - Installing collected packages: jsonschema, functools32 10:00:22 INFO - Running setup.py install for functools32 10:00:22 INFO - warning: no files found matching '*.txt' 10:00:22 INFO - no previously-included directories found matching 'build' 10:00:22 INFO - no previously-included directories found matching 'dist' 10:00:22 INFO - no previously-included directories found matching '.git*' 10:00:22 INFO - Successfully installed jsonschema functools32 10:00:22 INFO - Cleaning up... 10:00:22 INFO - Return code: 0 10:00:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:00:22 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')]} 10:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:22 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')]} 10:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:22 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 0x7fcf9bc9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12addd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', '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 10:00:22 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 10:00:22 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 10:00:22 INFO - Using env: {'DISPLAY': ':0', 10:00:22 INFO - 'HOME': '/home/cltbld', 10:00:22 INFO - 'LANG': 'en_US.UTF-8', 10:00:22 INFO - 'LANGUAGE': 'en_US:en', 10:00:22 INFO - 'LOGNAME': 'cltbld', 10:00:22 INFO - 'MAIL': '/var/mail/cltbld', 10:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:22 INFO - 'MOZ_NO_REMOTE': '1', 10:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:22 INFO - 'NO_EM_RESTART': '1', 10:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:22 INFO - 'PWD': '/builds/slave/test', 10:00:22 INFO - 'SHELL': '/bin/bash', 10:00:22 INFO - 'SHLVL': '1', 10:00:22 INFO - 'TERM': 'linux', 10:00:22 INFO - 'TMOUT': '86400', 10:00:22 INFO - 'USER': 'cltbld', 10:00:22 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:22 INFO - '_': '/tools/buildbot/bin/python'} 10:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:22 INFO - Downloading/unpacking flake8 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:00:24 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 10:00:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:00:24 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 10:00:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:25 INFO - no previously-included directories found matching 'docs/_build' 10:00:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:00:25 INFO - Running setup.py install for pep8 10:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:25 INFO - no previously-included directories found matching 'docs/_build' 10:00:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:00:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:00:25 INFO - Cleaning up... 10:00:25 INFO - Return code: 0 10:00:25 INFO - Running post-action listener: _resource_record_post_action 10:00:25 INFO - Running post-action listener: _start_resource_monitoring 10:00:25 INFO - Starting resource monitoring. 10:00:25 INFO - ##### 10:00:25 INFO - ##### Running install step. 10:00:25 INFO - ##### 10:00:25 INFO - Running pre-action listener: _resource_record_pre_action 10:00:25 INFO - Running main action method: install 10:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:25 INFO - Reading from file tmpfile_stdout 10:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:25 INFO - Reading from file tmpfile_stdout 10:00:25 INFO - Output received: 10:00:25 INFO - Usage: mozinstall [options] installer 10:00:25 INFO - Options: 10:00:25 INFO - -h, --help show this help message and exit 10:00:25 INFO - -d DEST, --destination=DEST 10:00:25 INFO - Directory to install application into. [default: 10:00:25 INFO - "/builds/slave/test"] 10:00:25 INFO - --app=APP Application being installed. [default: firefox] 10:00:25 INFO - mkdir: /builds/slave/test/build/application 10:00:25 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'] 10:00:25 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 10:00:41 INFO - Reading from file tmpfile_stdout 10:00:41 INFO - Output received: 10:00:41 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:41 INFO - Running post-action listener: _resource_record_post_action 10:00:41 INFO - ##### 10:00:41 INFO - ##### Running run-tests step. 10:00:41 INFO - ##### 10:00:41 INFO - Running pre-action listener: _resource_record_pre_action 10:00:41 INFO - Running main action method: run_tests 10:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:41 INFO - Python 2.7.3 10:00:41 INFO - Return code: 0 10:00:41 INFO - grabbing minidump binary from tooltool 10:00:41 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')]} 10:00:41 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 0x13403d0>, '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 0x12abed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:41 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 10:00:41 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 10:00:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:41 INFO - Return code: 0 10:00:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:00:42 INFO - Return code: 0 10:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 10:00:42 INFO - Using env: {'DISPLAY': ':0', 10:00:42 INFO - 'HOME': '/home/cltbld', 10:00:42 INFO - 'LANG': 'en_US.UTF-8', 10:00:42 INFO - 'LANGUAGE': 'en_US:en', 10:00:42 INFO - 'LOGNAME': 'cltbld', 10:00:42 INFO - 'MAIL': '/var/mail/cltbld', 10:00:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:42 INFO - 'MOZ_NO_REMOTE': '1', 10:00:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:42 INFO - 'NO_EM_RESTART': '1', 10:00:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:42 INFO - 'PWD': '/builds/slave/test', 10:00:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:42 INFO - 'SHELL': '/bin/bash', 10:00:42 INFO - 'SHLVL': '1', 10:00:42 INFO - 'TERM': 'linux', 10:00:42 INFO - 'TMOUT': '86400', 10:00:42 INFO - 'USER': 'cltbld', 10:00:42 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132', 10:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:42 INFO - '_': '/tools/buildbot/bin/python'} 10:00:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:00:42 INFO - mozversion application_buildid: 20160114092258 10:00:42 INFO - mozversion application_changeset: 03215fabd7fb1932e8fa402598092f8b2a7c4131 10:00:42 INFO - mozversion application_display_name: Nightly 10:00:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:42 INFO - mozversion application_name: Firefox 10:00:42 INFO - mozversion application_remotingname: firefox 10:00:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:00:42 INFO - mozversion application_vendor: Mozilla 10:00:42 INFO - mozversion application_version: 46.0a1 10:00:42 INFO - mozversion platform_buildid: 20160114092258 10:00:42 INFO - mozversion platform_changeset: 03215fabd7fb1932e8fa402598092f8b2a7c4131 10:00:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:00:42 INFO - mozversion platform_version: 46.0a1 10:00:42 INFO - using testdate: 1452794442 10:00:42 INFO - actual date: 1452794442 10:00:42 INFO - starting webserver on 'localhost:37397' 10:00:42 INFO - SUITE-START | Running 3 tests 10:00:42 INFO - TEST-START | dromaeo_css 10:00:42 INFO - operating with platform_type : linux_ 10:00:42 INFO - Initialising browser for dromaeo_css test... 10:00:42 INFO - TEST-INFO | started process 25530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0TjKu/profile http://localhost:37397/getInfo.html) 10:00:47 INFO - PROCESS | 25530 | 10:00:47 INFO - PROCESS | 25530 | (process:25616): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:00:48 INFO - PROCESS | 25530 | __metrics Screen width/height:1600/1200 10:00:48 INFO - PROCESS | 25530 | colorDepth:24 10:00:48 INFO - PROCESS | 25530 | Browser inner width/height: 1024/697 10:00:48 INFO - PROCESS | 25530 | __metrics 10:00:48 INFO - PROCESS | 25530 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:00:49 INFO - TEST-INFO | 25530: exit 0 10:00:49 INFO - Browser initialized. 10:00:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:49 INFO - TEST-INFO | started process 25665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0TjKu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:50 INFO - PROCESS | 25665 | 10:00:50 INFO - PROCESS | 25665 | (process:25720): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:01:01 INFO - PROCESS | 25665 | RSS: Main: 150208512 10:01:01 INFO - PROCESS | 25665 | 10:01:50 INFO - PROCESS | 25665 | 1452794510686 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] 10:04:01 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37397/tests/dromaeo/cssquery-ext.html) 10:04:02 INFO - PROCESS | 25665 | RSS: Main: 153296896 10:04:02 INFO - PROCESS | 25665 | 10:07:05 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-ext.html (next: http://localhost:37397/tests/dromaeo/cssquery-jquery.html) 10:07:05 INFO - PROCESS | 25665 | RSS: Main: 153223168 10:07:05 INFO - PROCESS | 25665 | 10:10:07 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37397/tests/dromaeo/cssquery-mootools.html) 10:10:08 INFO - PROCESS | 25665 | RSS: Main: 153223168 10:10:08 INFO - PROCESS | 25665 | 10:13:09 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37397/tests/dromaeo/cssquery-prototype.html) 10:13:10 INFO - PROCESS | 25665 | RSS: Main: 151011328 10:13:10 INFO - PROCESS | 25665 | 10:16:13 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37397/tests/dromaeo/cssquery-yui.html) 10:16:13 INFO - PROCESS | 25665 | RSS: Main: 151560192 10:16:13 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | Cycle 1(1): loaded http://localhost:37397/tests/dromaeo/cssquery-yui.html (next: http://localhost:37397/tests/dromaeo/cssquery-dojo.html) 10:19:16 INFO - PROCESS | 25665 | RSS: Main: 153214976 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | __start_tp_report 10:19:16 INFO - PROCESS | 25665 | _x_x_mozilla_page_load 10:19:16 INFO - PROCESS | 25665 | _x_x_mozilla_page_load_details 10:19:16 INFO - PROCESS | 25665 | |i|pagename|runs| 10:19:16 INFO - PROCESS | 25665 | |0;dojo.html;2635.1699214747355;2670.5994100884855;2700.4059106996465;2721.659792525933;2725.4140359822636;4455.554444555542;4611.100835337111;4631.282151266555;4648.62810975122;4649.674522783406;4461.06317673289;4552.408186935702;4552.704074235173;4594.104149690812;4628.861134165981;4211.380424403455;4213.094184750278;4236.301010333292;4276.25165596021;4293.29160688486;3998.280309544281;4243.893902652428;4263.445752052229;4287.056847493546;4325.956740432587;4166.375043743447;4209.052963083282;4245.532991370947;4245.745255284693;4258.020655249279;4272.316429371285;4275.123599662062;4284.871453856389;4290.871273861758;4305.182015417092;4219.556946520602;4244.3209086546;4248.022954720432;4290.356446533045;4300.311950088002;4392.956070439287;4458;4496.640268778523;4500.842470513517;4617.145828021827;4799.544043315879;4822.493638168012;4824.565789079;4825.445073816521;4855.174620314555;4850.345203397566;4853.951460485385;4857;4860.854174374775;4894.045661096087;4508.188526065307;4570.840020599263;4587.3577699121815;4608.331791890224;4655.930161047587;4982.252662100714;4994.40067191932;4996.375453068366;5008.273800299009;5047.293378926953;4746.288056791509;4787.234042553175;4790.0180463005;4797.160496913096;4856.344393506832;4777.259524773665;4930.827421040246;4945.431275403303;4983.950160498349;4991.775370108354;4745.715257084586;4830.541098595628;4833.275008748716;4842.418909730784;4860.902781944341;4710.646701497401;4773.76131193439;4801.207800712913;4801.639877009238;4848.5636292733825;3996.540397854226;4006.5192176938954;4055.1281474483126;4063.7358571692744;4073.5315438724924;3546.095745584911;3578.821058947094;3590.6409359063887;3593.3352329819068;3623.202895363016;4175.436316097349;4222.556631553643;4259.7231179973205;4307.289297265916;4309.310510318334;4824.710517368969;4846.176150054499;4855.95144048555;4860.80556777732;4902.730349830722;4198.874033778991;4224.556421575752;4261.403403523509;4263.893402664959;4294.055307832272;4204.8528301509305;4289.678274129453;4319.827206911751;4333.328334108218;4370.060437006059;4676.228422310417;4684;4684.742339171378;4688.5545873142;4694.342792009122;4949.232868905326;4956.504349565014;4963.404391473046;4964.032013757283;5022.397312322545;4563.794629241625;4580.083983203306;4657.813687452464;4660.231061874752;4674.205385084611;4793.856184314476;4799.568038876518;4802.447718512276;4804.735739534359;4848.151573474557;4879.926801098058;4888.60891128716;4894.559489645949;4900.044491324157;4931.654784165074;4611.976940115278;4708.081924024782;4754.595859351994;4840.6127509798425;4846.17615005457;4671.929921051119;4689.296605509201;4694.647901407477;4702.15361234981;4736.834210802744;4571.040081582905;4571.291449825149;4586.839460618862;4616.076784643018;4657.208274593395;4653.162430762495;4705.811767529397;4752.358431611827;4796.760161991817;4839.903201935871;4645.86062418128;4651.930221046619;4673.182193116259;4673.392458980311;4708.976455117702 10:19:16 INFO - PROCESS | 25665 | |1;ext.html;501.73408093710344;513.4531723714244;514.4135685318737;532.4701921588015;538.1819634156084;33136.66863331366;33652;33794.9861504155;33799.32401351975;33896.66103338966;37065;37488.250234995285;37643.623563764355;37705.81147094261;38005.61994380056;7661.9616901915415;7851.175626559215;7854.3716502679645;7865.370770338388;7870.921290787076;6459.806205813833;7664.501807382502;7677.385809135256;7882.842343153134;7883.58095542802;7859.331956783681;7944;7946.331270433216;7954.204579542057;7964.362850971937;7826.3738900888075;7853.41099417546;7863.37093032556;7894.7236846710375;7894.881576776353;7751.341136003446;7950.1254861965135;7956.124826269106;7975.042994840656;7990.280874721303;37529.43705844414;38000.239995200216;38256.80871595652;38273;38289.425658615146;3088.089013740952;3110.206897241189;3452.067941655764;3773.660370566662;3784.3566593679143;27547.86226068877;27578.083063281487;28415.147545573665;28447.288817779514;29250.414991700047;3415.213946117279;3415.624281329052;3456.740744444177;3491.14466955595;3580.7314451416246;213992;214592;214768;215089.92455037782;215204;47992;54748.45251547434;54902.45097548974;54907;55088.72455637696;42920.356194657106;60053.39946600478;61235;61396;61471.692641537404;13319.800202996963;13517.526886558922;13557.25435101079;13595.388207530685;13620.318984050758;10835.187360947803;10842;10868.130549556017;10897.237193396544;10899.891001089887;18737.90631046836;18816.153273102744;18892.433227003214;18913.7162942556;19769.703454448194;7405;7631.54210747357;7636.389088872988;7764.961175194087;7834.334081603128;861.6424183963585;873.5195642396657;874.1215078845846;952.7570469530225;985.4776968206862;26319.736802632113;26407.471850563266;26612.733872661414;26626.73373266281;26631.733682663315;996.9651062212788;1013.4020927652721;1040.8334666453331;1076.5908954597203;1135.1202817816093;13979.301034948212;14023.85976140246;14161.716765664629;14342.713145737027;14656.926715366355;259661;265330;266256;266831;267554;47354.5264547357;47766.522334776906;47775;47779.28331075037;47856.52143478521;1198.7902117129468;1274.1781550899618;1276.183242724657;1277.0422183362477;1284.4669462173094;26720.34117858102;26776;27183;27259;27275.590866136627;41037.1792564153;41103.38344924769;41243.38134928038;41397.1720565581;41421.378679319234;239360;239476;240911;241600;241660;28760.712392875805;29034.709652903202;29469.263268417602;29479.19947604974;29505.409891802472;33529.83235083907;33762.662373375955;34049.65950340465;34313.65686343204;34373.48439773455;28780.42439151247;28866.27834304159;28881.711182887902;29313;29509.409811803213;28330.716692832808;28463.288417788892;28829.423411532072;29004.7099529002;29352.26619334534;30633.693663063084;31905.202369940936;32247.35505289928;32339;32521.674783251863;28457.43085138327;28813.855930720212;29286.56070158992;29384.559231611114;29537.852310738308;23073.423164420354;23146.305610831703;23228.535429291656;23233.76766232316;23276.65085023692 10:19:16 INFO - PROCESS | 25665 | |2;jquery.html;344.6725610669864;346.88649435312647;349.9982500087499;351.3780608323268;356.1505808646378;11888.286702797837;12295.508179672825;13963.16221026738;14335.713285734291;16220.18899055047;14030.158190508577;14464.5660630181;14771.482998095069;15373.615659608515;15426.3829446822;4950.158473059589;4971.825986090487;5028.220625803006;5044.470330615288;5071.137906555894;4764.928526072112;4962.702237865721;4997.675151115166;5026.572741316974;5038.193888977764;4908.116539022974;4967.428745694256;5011.599072074244;5372.409035006146;5392.757325920324;5402.189671549259;5599.664020158783;5610.158476228557;5614.242077319551;5636.436356364372;5101.897962040775;5104.106781313255;5114.846554603368;5129.358830146231;5134.666246693991;11364.43177841113;11862.940685296518;18035.819641803675;18087.276508939627;18100.818991810043;1780.3234770787149;1792.4353828543967;1823.8449731772814;1862.8044055374125;1925.1529327096032;8045.155258697811;8680.652773889036;8698.434601750929;8730.083341249205;8928.330375221884;1681.7702636489125;1740.8346207110305;1800.2528950485532;1876.774787025552;1958.8922609256485;38866;41787.582124178974;43759.78120109411;44443.333349999775;54025.459745402826;9382.67160649374;9414.29392795543;9482.905170948341;9608.855867161998;9885.950570247247;12297.32364719949;12400.379981000913;12432.937835310946;12438.626841194779;12446.688832779071;6717.798466046026;6733.057371967929;6973.546719463218;7023.051887995158;7186.892196617055;6338.58799178052;6521.217453905467;6540.574862633914;6563.6389998549585;6603.471722262208;3952.5256969163884;4174.415581818548;4197.349410841324;4220.177065472265;4271.444712187395;1721.8622510199154;1759.6128851652616;1802.5313418511018;1804.3323970131135;1819.7543331650322;792.9801754956056;821.2977903892206;834.5910503853069;903.5978989349808;943.3396622364372;15060.021098628555;15075.698486030218;15211.315490802941;15242.695146097016;15337.463188788339;808.2523665609287;821.3059964330131;836.0928392693874;855.5722138930535;860.9410425177067;8701;8716.041235464094;8798.736037918745;8888.244499217639;8968.820623587491;396973;397222;402951;418705;425891;55384.72307638436;59623.70188149031;60721;61212.693936530035;62031;1067.4769363012067;1074.4037059432246;1074.838774183863;1095.2114477576133;1098.6319582939645;12754.936225318814;13623.38694758758;13639.181649101085;13651.38568764388;14063.156210627396;29890.402191956473;30184.698153018187;30959.380812384075;31072.378552429276;31359.686403135678;36627.633723662424;37062;37090;37135.25729485449;37221.813890930374;6504.869902602016;6689.684294195048;6799.286074962256;6807.421369183675;6861.691223894837;7055.788326350218;8578.742637720878;8823.867641985247;9296.95351523238;9767;8634.78413039679;8653.870191947251;8882.689105881263;8951.149640784115;8982.955085224532;8573;8822.64709411642;8853.60158792843;8859.867101993605;9058.864117038118;8496.787580310542;8641.827163456821;8722;9016.18854303116;9194.58624361892;6798.456123510008;6867.484938629523;6874.621895795779;6964.338387853146;7050.682719277747;7485.251474852689;8559.657613695383;8687.218150366498;8839.248663863644;8867.157620026088 10:19:16 INFO - PROCESS | 25665 | |3;mootools.html;1392.7771556550952;1402.340899777105;1530.510236724248;1717.5534361066127;1720.4494561740232;6128.050152226401;6251.874962500748;7222.783316500507;7437.962810185955;7439.293267139627;6963.965180174092;7081.362677359037;7136.85726285474;7138.571685698848;7151.32062454066;2152.5802468518646;2193.846430749848;2194.089452877054;2195.374318319279;2198.670199470076;2116.195845578678;2122.2253877334815;2211.159759291467;2212.5132470856465;2219.1678120704737;2153.9461513462134;2158.686990386393;2168.1544197762887;2194.1662168375997;2264.8414610977156;2190.660447630612;2199.857009294407;2202.9118835246572;2203.7135172427643;2204.6803213534026;2157.5037741319584;2179.259051922338;2192.572448372568;2194.901229444679;2198.0658220256328;7368.557886526772;7368.705251789922;7414.295641914064;7415.666295016737;7422.406207503441;4281.7002809803325;4389.912201755979;4392.494863090754;4395.626371758404;4411.09572537629;2675.3712877473777;2692.098147120717;2699.2172270041665;2734.9589756153673;2746.931326716828;818.1818181818181;838.2958315015355;839.6935118681637;844.0630899701326;849.1169184048582;10159.339642923187;10165.085142337226;10187.54156062979;10203.4388108654;10223.028812262823;3906.1015966327905;3961.3661814109605;4015.4779878616177;4026.416169655384;4029.6299258252334;8765.737027889174;8791.120887911158;8791.648334066693;8801.955990220007;8806.251468625238;4326.221280169537;4341.19687857741;4347.500037495665;4358.760268185217;4363.890902727458;3344.6989770920736;3434.0384692286198;3806.238752249561;3892.6107389260847;3936.7834769087976;3437.9312413752086;3450.464543278217;3451.3442445935193;3453.9827300863835;3487.442009278554;1010.7169992402139;1024.8155332040155;1029.6910926721953;1033.0857191385678;1095.2661716649864;1103.6082190822303;1118.183725880112;1118.7706520163347;1119.4738472917716;1134.5575225661999;6248.812535623939;6291.779787707408;6305.558610897285;6309.337519560472;6318.873622527615;1111.1555218034352;1111.394290111891;1139.2594813371209;1153.3368313219764;1158.009901534193;4859.902801943941;4906.337644418029;4963.70217786934;5032.84901452957;5040.168372218616;8014.879776803353;8105.918940810517;8215.671373145127;8223.506589604644;8252.174782521819;7928.643211055516;8283.461574997606;8330.042045164884;8454.619542120496;8475.83048339042;6647.734090636417;6738.696758645872;6746.0892779475125;6791.456683465311;6797.456203503807;6310.6844657766005;6334.4932405406535;6468.094466774562;6476.31998640136;6540.803775886731;7443.627818608939;7682.846343072995;7885.408594355561;7979.521228726295;8023.59882005909;7785.571793551409;7830.2169783021245;7845.293923546908;7873.724419645285;8123.065847427385;5313.1764576490705;5436.130219164915;6078.057901025348;6296.150019747275;6380.457661098673;6687.264400915798;6692;6718.496112791462;6723.1259936209935;6723.697433615401;6113.694315284307;6250.593711408744;6362.904556431749;6364.236291644847;6377.585456945284;6228.065790131335;6270.874582508415;6316.873662526816;6332.651704156316;6364.236291645032;6360.459360954371;6370.044493325853;6397.6481293529305;6403.7118329676205;6413.583117097373;5903.468687818117;5918.2898052234;5927.377625349449;5928.644281343133;5938.732757025858;5896.823095307148;6108.144859719554;6110.572259941761;6113.908291375544;6127 10:19:16 INFO - PROCESS | 25665 | |4;prototype.html;311.167626598848;315.93229739232055;318.3839271010594;321.44229761364045;331.6385140197185;5356.1697936819755;5451.918221226685;5459.91810122848;5464.453554644539;5499.67001979881;5308.787648494065;5396.676199428027;5417.891642167155;5436.293281873361;5436.3476382834115;4264.89337766556;4271.743695378287;4271.850485233017;4277.4867015958125;4284.635805956482;4269.935950960738;4271.316589345705;4271.658267338621;4276.914461710764;4280.1653677532895;4048.6153815387493;4163.646090082347;4243.490781106271;4253.2769429197115;4261.296886013804;4157.771322577257;4159.355299928501;4163.02168990287;4172.582741725833;4174.060836311805;3622.456631505269;3622.8550857965915;3634.800085995269;3636.327279453283;3651.9817400912825;5171.715555644438;5248;5253.369595648508;5280.128778751539;5294.311739473882;4694.460137084211;4848.975755121237;4851.223804191312;4856.17445034345;4866.416030076378;5587.692676902769;5668.943310566883;5681.318241810968;5691.345495268056;5744.74148663307;3969.908275224336;3971.027098360891;3975.185087057146;3976.8608098716404;3984.7409918355215;5976.432238937294;6048.7882924097885;6054.849578580056;6055.6063855849225;6056.515478761733;4003.739756915791;4104.630583247522;4118.4440100586635;4124.298869192245;4132.421460995463;4166.312558427825;4168.6039826216465;4172.728772629769;4175.603317684815;4175.789021183883;4764.071006153836;4767.046590681877;4767.380240568704;4780.020095880336;4780.737059461693;5710.229119068873;5733.168690539848;5734.741936612779;5736.827895163152;5739.16782066598;1465.948691795782;1487.4050379847931;1493.5370035288877;1496.9027013244104;1496.9625759355886;970.257752819094;1003.1272792670278;1003.9297249192632;1008.6167256442652;1015.1726343030555;4883.413990321184;4952.504749525018;4957.03337849116;4961.355023846877;4962.60299176065;5852.15143804146;5922.8815423691285;5937.2578427696535;5951.642901425842;5953.613015154001;4985.850424487271;4989.725565093882;4992.700437973734;5001.199808030698;5006.574441172541;3158.8262645554714;3193.520971854194;3209.7271731902583;3226.3869864725625;3248.9187770305457;5613.578981576316;5690.032694441955;5710.543156547466;5737.454941780524;5761.48146666802;6213.720382582795;6225.252969643671;6240.254288113216;6240.594361366497;6259.1550140730415;5499.50504454593;5683.2895888014;5687.232223649919;5687.971560142173;5693.17448969897;6010.3088144863905;6054.364291749479;6057.394260573908;6072.180255665428;6082.057281121433;5898.292204935436;5902.763889444546;5905.173275741314;5909.438603332676;5915.260592425947;5533.667979921218;5642.379338272704;5646.153077038477;5668.319801623831;5672.773089076556;4084.8774536763945;4136.110736191733;4139.110091330258;4154.356074808409;4154.979225103855;5999.310079340931;6009.759609615567;6011.458968692838;6063.181470501426;6064.120702498201;5768.509676677361;5796.855078623068;5799.594028417971;5828;5831;5687.232223649754;5771.884562308646;5821.563382746395;5826.883462330815;5831.241938547962;5647.29408823897;5697.6296540724725;5706.087026075808;5707.1724599933605;5711.485966263056;5856.590038697421;5863.20846685692;5868.911966320594;5876.647401155944;5880.764769409176;5495.450454954473;5615.578831587565;5642.85892852682;5688.516476099578;5706.172604972338 10:19:16 INFO - PROCESS | 25665 | |5;yui.html;648.68862945786;650.0736450557954;650.300926504008;738.6048464071723;752.5033477904577;11689.824652630206;11892.702682432944;11923.64229073127;11963.880361196385;11998.580049698263;11429.371384573846;13133.212007279546;13207.471701131943;13347.265900375476;13360.532381366655;761.7219714804085;772.2663469703775;785.5286827903269;785.8467598818232;786.4298383671821;778.9454738168331;779.1468342165319;782.3193821375411;783.9804004899895;786.5555960882083;818.4352796570378;818.7093581778472;819.4059307002435;824.5959479854857;826.3760860550307;809.550699361854;811.5942028985507;812.4962523235573;815.7675062607158;816.1226681317578;603.6016229288648;607.9513638908921;608.0544752909225;608.0757248981567;609.3571282297174;12571.245725256422;12585;12640.55758048473;12676.985841132688;12706.110572259946;11435.656930292105;11527.596534121349;11535.538578456852;11756.54448964625;12030.33833139177;9279.443233406017;9338;9369.063093690576;9372.625094996192;9974.152197063258;3140.7173354398215;3193.297474555594;3214.8231847248394;3221.3879362921202;3289.194147433894;41180.1763964719;41856.37215441771;41869.581304186875;41873.790631046955;41883.371749423786;9166.26669866409;9204.171624553823;9346.532673366304;9363.578638961262;9406.95296523513;15898.920505397631;15984.600384990468;16025;16042.037477751372;16085.67828643444;6196.318404975449;6228.844278893064;6512.772052978123;6539.574927629689;6581.868362632817;3720.9813950930616;3758.285925674113;3776.206996530759;3779.3952967525615;3838.2323535293053;2676.2372723773633;2691.892324307045;2698.581719833429;2700.7569318761407;2704.486147631944;471.43663322329485;481.4222932481037;491.3710450623208;494.19692998876826;494.83670388771617;511.75691546515105;512.3621091740732;537.4732761893288;596.2993482657946;620.404411764711;7685.346745526581;8185.71350002747;8426.199511046441;8646.313968776154;8914.197722205032;505.87353161709575;546.3962321634616;589.3075636127533;610.1884493623559;631.2677294338637;3431.673990970854;3622.076370525499;3634.8727794527063;3706.166112624692;3709.46212799148;44691.776541117084;44940;45300.77349613231;45325.77337113359;45509.7724511382;38923;38992.80503597464;39167.60832391697;41313;41349.1730165395;36987.44518832274;37913.431298530544;38153.23693526114;38246;38253.42619860704;7330.633468326456;7393.778186654409;7415.740449084256;7443.032405787213;7455.105387353552;27990.44019119647;28075.71924280731;28780.712192877803;29166.708332916398;29284.560731588615;36569.817150914074;36856.44715329219;37080.25839483249;38402;39088.21823563569;9162.496062716615;9864.753381165528;9979.750506237111;10082.092611664986;10293.073623373932;10948.406451421171;10973.177011723992;11100.944495277796;11133.610323638633;11149.554017839195;10602.416867072385;10718.464076796285;10742.892571074502;10751.408672522773;10783.568657253621;10907.727306817393;10972.506237219184;10989;11041.33751974884;11095.5561777528;10362.326448780805;10743;10907.78184436291;10915.181361397768;10931.890681093406;8666.480011199348;8715.564221788758;8795.604197811243;8825.293976481738;8883.555822208993;8516.276116530164;8551.401401901807;8718.761842079031;8766.430182038148;8991.23574496149 10:19:16 INFO - PROCESS | 25665 | __end_tp_report 10:19:16 INFO - PROCESS | 25665 | __start_cc_report 10:19:16 INFO - PROCESS | 25665 | _x_x_mozilla_cycle_collect,343 10:19:16 INFO - PROCESS | 25665 | __end_cc_report 10:19:16 INFO - PROCESS | 25665 | __startTimestamp1452795556411__endTimestamp 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | ------- Summary: start ------- 10:19:16 INFO - PROCESS | 25665 | Number of tests: 6 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#0] dojo.html Cycles:165 Average:4513.59 Median:4651.93 stddev:451.93 (9.7%) stddev-sans-first:428.62 10:19:16 INFO - PROCESS | 25665 | Values: 2635.2 2670.6 2700.4 2721.7 2725.4 4455.6 4611.1 4631.3 4648.6 4649.7 4461.1 4552.4 4552.7 4594.1 4628.9 4211.4 4213.1 4236.3 4276.3 4293.3 3998.3 4243.9 4263.4 4287.1 4326.0 4166.4 4209.1 4245.5 4245.7 4258.0 4272.3 4275.1 4284.9 4290.9 4305.2 4219.6 4244.3 4248.0 4290.4 4300.3 4393.0 4458.0 4496.6 4500.8 4617.1 4799.5 4822.5 4824.6 4825.4 4855.2 4850.3 4854.0 4857.0 4860.9 4894.0 4508.2 4570.8 4587.4 4608.3 4655.9 4982.3 4994.4 4996.4 5008.3 5047.3 4746.3 4787.2 4790.0 4797.2 4856.3 4777.3 4930.8 4945.4 4984.0 4991.8 4745.7 4830.5 4833.3 4842.4 4860.9 4710.6 4773.8 4801.2 4801.6 4848.6 3996.5 4006.5 4055.1 4063.7 4073.5 3546.1 3578.8 3590.6 3593.3 3623.2 4175.4 4222.6 4259.7 4307.3 4309.3 4824.7 4846.2 4856.0 4860.8 4902.7 4198.9 4224.6 4261.4 4263.9 4294.1 4204.9 4289.7 4319.8 4333.3 4370.1 4676.2 4684.0 4684.7 4688.6 4694.3 4949.2 4956.5 4963.4 4964.0 5022.4 4563.8 4580.1 4657.8 4660.2 4674.2 4793.9 4799.6 4802.4 4804.7 4848.2 4879.9 4888.6 4894.6 4900.0 4931.7 4612.0 4708.1 4754.6 4840.6 4846.2 4671.9 4689.3 4694.6 4702.2 4736.8 4571.0 4571.3 4586.8 4616.1 4657.2 4653.2 4705.8 4752.4 4796.8 4839.9 4645.9 4651.9 4673.2 4673.4 4709.0 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#1] ext.html Cycles:180 Average:39772.90 Median:32829.17 stddev:62786.01 (191.3%) stddev-sans-first:62892.90 10:19:16 INFO - PROCESS | 25665 | Values: 501.7 513.5 514.4 532.5 538.2 33136.7 33652.0 33795.0 33799.3 33896.7 37065.0 37488.3 37643.6 37705.8 38005.6 7662.0 7851.2 7854.4 7865.4 7870.9 6459.8 7664.5 7677.4 7882.8 7883.6 7859.3 7944.0 7946.3 7954.2 7964.4 7826.4 7853.4 7863.4 7894.7 7894.9 7751.3 7950.1 7956.1 7975.0 7990.3 37529.4 38000.2 38256.8 38273.0 38289.4 3088.1 3110.2 3452.1 3773.7 3784.4 27547.9 27578.1 28415.1 28447.3 29250.4 3415.2 3415.6 3456.7 3491.1 3580.7 213992.0 214592.0 214768.0 215089.9 215204.0 47992.0 54748.5 54902.5 54907.0 55088.7 42920.4 60053.4 61235.0 61396.0 61471.7 13319.8 13517.5 13557.3 13595.4 13620.3 10835.2 10842.0 10868.1 10897.2 10899.9 18737.9 18816.2 18892.4 18913.7 19769.7 7405.0 7631.5 7636.4 7765.0 7834.3 861.6 873.5 874.1 952.8 985.5 26319.7 26407.5 26612.7 26626.7 26631.7 997.0 1013.4 1040.8 1076.6 1135.1 13979.3 14023.9 14161.7 14342.7 14656.9 259661.0 265330.0 266256.0 266831.0 267554.0 47354.5 47766.5 47775.0 47779.3 47856.5 1198.8 1274.2 1276.2 1277.0 1284.5 26720.3 26776.0 27183.0 27259.0 27275.6 41037.2 41103.4 41243.4 41397.2 41421.4 239360.0 239476.0 240911.0 241600.0 241660.0 28760.7 29034.7 29469.3 29479.2 29505.4 33529.8 33762.7 34049.7 34313.7 34373.5 28780.4 28866.3 28881.7 29313.0 29509.4 28330.7 28463.3 28829.4 29004.7 29352.3 30633.7 31905.2 32247.4 32339.0 32521.7 28457.4 28813.9 29286.6 29384.6 29537.9 23073.4 23146.3 23228.5 23233.8 23276.7 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#2] jquery.html Cycles:180 Average:22273.96 Median:5057.80 stddev:66671.99 (1318.2%) stddev-sans-first:66838.68 10:19:16 INFO - PROCESS | 25665 | Values: 344.7 346.9 350.0 351.4 356.2 11888.3 12295.5 13963.2 14335.7 16220.2 14030.2 14464.6 14771.5 15373.6 15426.4 4950.2 4971.8 5028.2 5044.5 5071.1 4764.9 4962.7 4997.7 5026.6 5038.2 4908.1 4967.4 5011.6 5372.4 5392.8 5402.2 5599.7 5610.2 5614.2 5636.4 5101.9 5104.1 5114.8 5129.4 5134.7 11364.4 11862.9 18035.8 18087.3 18100.8 1780.3 1792.4 1823.8 1862.8 1925.2 8045.2 8680.7 8698.4 8730.1 8928.3 1681.8 1740.8 1800.3 1876.8 1958.9 38866.0 41787.6 43759.8 44443.3 54025.5 9382.7 9414.3 9482.9 9608.9 9886.0 12297.3 12400.4 12432.9 12438.6 12446.7 6717.8 6733.1 6973.5 7023.1 7186.9 6338.6 6521.2 6540.6 6563.6 6603.5 3952.5 4174.4 4197.3 4220.2 4271.4 1721.9 1759.6 1802.5 1804.3 1819.8 793.0 821.3 834.6 903.6 943.3 15060.0 15075.7 15211.3 15242.7 15337.5 808.3 821.3 836.1 855.6 860.9 8701.0 8716.0 8798.7 8888.2 8968.8 396973.0 397222.0 402951.0 418705.0 425891.0 55384.7 59623.7 60721.0 61212.7 62031.0 1067.5 1074.4 1074.8 1095.2 1098.6 12754.9 13623.4 13639.2 13651.4 14063.2 29890.4 30184.7 30959.4 31072.4 31359.7 36627.6 37062.0 37090.0 37135.3 37221.8 6504.9 6689.7 6799.3 6807.4 6861.7 7055.8 8578.7 8823.9 9297.0 9767.0 8634.8 8653.9 8882.7 8951.1 8983.0 8573.0 8822.6 8853.6 8859.9 9058.9 8496.8 8641.8 8722.0 9016.2 9194.6 6798.5 6867.5 6874.6 6964.3 7050.7 7485.3 8559.7 8687.2 8839.2 8867.2 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#3] mootools.html Cycles:180 Average:4991.99 Median:5928.01 stddev:2569.27 (43.3%) stddev-sans-first:2562.24 10:19:16 INFO - PROCESS | 25665 | Values: 1392.8 1402.3 1530.5 1717.6 1720.4 6128.1 6251.9 7222.8 7438.0 7439.3 6964.0 7081.4 7136.9 7138.6 7151.3 2152.6 2193.8 2194.1 2195.4 2198.7 2116.2 2122.2 2211.2 2212.5 2219.2 2153.9 2158.7 2168.2 2194.2 2264.8 2190.7 2199.9 2202.9 2203.7 2204.7 2157.5 2179.3 2192.6 2194.9 2198.1 7368.6 7368.7 7414.3 7415.7 7422.4 4281.7 4389.9 4392.5 4395.6 4411.1 2675.4 2692.1 2699.2 2735.0 2746.9 818.2 838.3 839.7 844.1 849.1 10159.3 10165.1 10187.5 10203.4 10223.0 3906.1 3961.4 4015.5 4026.4 4029.6 8765.7 8791.1 8791.6 8802.0 8806.3 4326.2 4341.2 4347.5 4358.8 4363.9 3344.7 3434.0 3806.2 3892.6 3936.8 3437.9 3450.5 3451.3 3454.0 3487.4 1010.7 1024.8 1029.7 1033.1 1095.3 1103.6 1118.2 1118.8 1119.5 1134.6 6248.8 6291.8 6305.6 6309.3 6318.9 1111.2 1111.4 1139.3 1153.3 1158.0 4859.9 4906.3 4963.7 5032.8 5040.2 8014.9 8105.9 8215.7 8223.5 8252.2 7928.6 8283.5 8330.0 8454.6 8475.8 6647.7 6738.7 6746.1 6791.5 6797.5 6310.7 6334.5 6468.1 6476.3 6540.8 7443.6 7682.8 7885.4 7979.5 8023.6 7785.6 7830.2 7845.3 7873.7 8123.1 5313.2 5436.1 6078.1 6296.2 6380.5 6687.3 6692.0 6718.5 6723.1 6723.7 6113.7 6250.6 6362.9 6364.2 6377.6 6228.1 6270.9 6316.9 6332.7 6364.2 6360.5 6370.0 6397.6 6403.7 6413.6 5903.5 5918.3 5927.4 5928.6 5938.7 5896.8 6108.1 6110.6 6113.9 6127.0 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#4] prototype.html Cycles:180 Average:4775.81 Median:5376.42 stddev:1412.50 (26.3%) stddev-sans-first:1376.14 10:19:16 INFO - PROCESS | 25665 | Values: 311.2 315.9 318.4 321.4 331.6 5356.2 5451.9 5459.9 5464.5 5499.7 5308.8 5396.7 5417.9 5436.3 5436.3 4264.9 4271.7 4271.9 4277.5 4284.6 4269.9 4271.3 4271.7 4276.9 4280.2 4048.6 4163.6 4243.5 4253.3 4261.3 4157.8 4159.4 4163.0 4172.6 4174.1 3622.5 3622.9 3634.8 3636.3 3652.0 5171.7 5248.0 5253.4 5280.1 5294.3 4694.5 4849.0 4851.2 4856.2 4866.4 5587.7 5668.9 5681.3 5691.3 5744.7 3969.9 3971.0 3975.2 3976.9 3984.7 5976.4 6048.8 6054.8 6055.6 6056.5 4003.7 4104.6 4118.4 4124.3 4132.4 4166.3 4168.6 4172.7 4175.6 4175.8 4764.1 4767.0 4767.4 4780.0 4780.7 5710.2 5733.2 5734.7 5736.8 5739.2 1465.9 1487.4 1493.5 1496.9 1497.0 970.3 1003.1 1003.9 1008.6 1015.2 4883.4 4952.5 4957.0 4961.4 4962.6 5852.2 5922.9 5937.3 5951.6 5953.6 4985.9 4989.7 4992.7 5001.2 5006.6 3158.8 3193.5 3209.7 3226.4 3248.9 5613.6 5690.0 5710.5 5737.5 5761.5 6213.7 6225.3 6240.3 6240.6 6259.2 5499.5 5683.3 5687.2 5688.0 5693.2 6010.3 6054.4 6057.4 6072.2 6082.1 5898.3 5902.8 5905.2 5909.4 5915.3 5533.7 5642.4 5646.2 5668.3 5672.8 4084.9 4136.1 4139.1 4154.4 4155.0 5999.3 6009.8 6011.5 6063.2 6064.1 5768.5 5796.9 5799.6 5828.0 5831.0 5687.2 5771.9 5821.6 5826.9 5831.2 5647.3 5697.6 5706.1 5707.2 5711.5 5856.6 5863.2 5868.9 5876.6 5880.8 5495.5 5615.6 5642.9 5688.5 5706.2 10:19:16 INFO - PROCESS | 25665 | 10:19:16 INFO - PROCESS | 25665 | [#5] yui.html Cycles:180 Average:11871.61 Median:41878.58 stddev:12897.03 (30.8%) stddev-sans-first:12905.67 10:19:16 INFO - PROCESS | 25665 | Values: 648.7 650.1 650.3 738.6 752.5 11689.8 11892.7 11923.6 11963.9 11998.6 11429.4 13133.2 13207.5 13347.3 13360.5 761.7 772.3 785.5 785.8 786.4 778.9 779.1 782.3 784.0 786.6 818.4 818.7 819.4 824.6 826.4 809.6 811.6 812.5 815.8 816.1 603.6 608.0 608.1 608.1 609.4 12571.2 12585.0 12640.6 12677.0 12706.1 11435.7 11527.6 11535.5 11756.5 12030.3 9279.4 9338.0 9369.1 9372.6 9974.2 3140.7 3193.3 3214.8 3221.4 3289.2 41180.2 41856.4 41869.6 41873.8 41883.4 9166.3 9204.2 9346.5 9363.6 9407.0 15898.9 15984.6 16025.0 16042.0 16085.7 6196.3 6228.8 6512.8 6539.6 6581.9 3721.0 3758.3 3776.2 3779.4 3838.2 2676.2 2691.9 2698.6 2700.8 2704.5 471.4 481.4 491.4 494.2 494.8 511.8 512.4 537.5 596.3 620.4 7685.3 8185.7 8426.2 8646.3 8914.2 505.9 546.4 589.3 610.2 631.3 3431.7 3622.1 3634.9 3706.2 3709.5 44691.8 44940.0 45300.8 45325.8 45509.8 38923.0 38992.8 39167.6 41313.0 41349.2 36987.4 37913.4 38153.2 38246.0 38253.4 7330.6 7393.8 7415.7 7443.0 7455.1 27990.4 28075.7 28780.7 29166.7 29284.6 36569.8 36856.4 37080.3 38402.0 39088.2 9162.5 9864.8 9979.8 10082.1 10293.1 10948.4 10973.2 11100.9 11133.6 11149.6 10602.4 10718.5 10742.9 10751.4 10783.6 10907.7 10972.5 10989.0 11041.3 11095.6 10362.3 10743.0 10907.8 10915.2 10931.9 8666.5 8715.6 8795.6 8825.3 8883.6 8516.3 8551.4 8718.8 8766.4 8991.2 10:19:16 INFO - PROCESS | 25665 | -------- Summary: end -------- 10:19:16 INFO - PROCESS | 25665 | 10:19:17 INFO - TEST-INFO | 25665: exit 0 10:19:17 INFO - TEST-OK | dromaeo_css | took 1114369ms 10:19:17 INFO - TEST-START | kraken 10:19:17 INFO - operating with platform_type : linux_ 10:19:17 INFO - Initialising browser for kraken test... 10:19:17 INFO - TEST-INFO | started process 25900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNq1ai/profile http://localhost:37397/getInfo.html) 10:19:21 INFO - PROCESS | 25900 | 10:19:21 INFO - PROCESS | 25900 | (process:25968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:19:21 INFO - PROCESS | 25900 | __metrics Screen width/height:1600/1200 10:19:21 INFO - PROCESS | 25900 | colorDepth:24 10:19:21 INFO - PROCESS | 25900 | Browser inner width/height: 1024/697 10:19:21 INFO - PROCESS | 25900 | __metrics 10:19:22 INFO - PROCESS | 25900 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:19:22 INFO - TEST-INFO | 25900: exit 0 10:19:22 INFO - Browser initialized. 10:19:22 INFO - Running cycle 1/1 for kraken test... 10:19:23 INFO - TEST-INFO | started process 26017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNq1ai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:24 INFO - PROCESS | 26017 | 10:19:24 INFO - PROCESS | 26017 | (process:26071): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:19:35 INFO - PROCESS | 26017 | RSS: Main: 150364160 10:19:35 INFO - PROCESS | 26017 | 10:19:37 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37397/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:38 INFO - PROCESS | 26017 | RSS: Main: 149757952 10:19:38 INFO - PROCESS | 26017 | 10:19:40 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37397/tests/kraken/driver.html?testName=audio-dft) 10:19:41 INFO - PROCESS | 26017 | RSS: Main: 153444352 10:19:41 INFO - PROCESS | 26017 | 10:19:44 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37397/tests/kraken/driver.html?testName=audio-fft) 10:19:45 INFO - PROCESS | 26017 | RSS: Main: 147144704 10:19:45 INFO - PROCESS | 26017 | 10:19:47 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37397/tests/kraken/driver.html?testName=audio-oscillator) 10:19:47 INFO - PROCESS | 26017 | RSS: Main: 148299776 10:19:47 INFO - PROCESS | 26017 | 10:19:50 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:50 INFO - PROCESS | 26017 | RSS: Main: 147955712 10:19:50 INFO - PROCESS | 26017 | 10:19:53 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37397/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:54 INFO - PROCESS | 26017 | RSS: Main: 147054592 10:19:54 INFO - PROCESS | 26017 | 10:19:57 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37397/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:58 INFO - PROCESS | 26017 | RSS: Main: 147951616 10:19:58 INFO - PROCESS | 26017 | 10:20:01 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37397/tests/kraken/driver.html?testName=json-parse-financial) 10:20:01 INFO - PROCESS | 26017 | RSS: Main: 147460096 10:20:01 INFO - PROCESS | 26017 | 10:20:03 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:04 INFO - PROCESS | 26017 | RSS: Main: 148889600 10:20:04 INFO - PROCESS | 26017 | 10:20:06 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:06 INFO - PROCESS | 26017 | RSS: Main: 147927040 10:20:06 INFO - PROCESS | 26017 | 10:20:08 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:09 INFO - PROCESS | 26017 | RSS: Main: 149655552 10:20:09 INFO - PROCESS | 26017 | 10:20:12 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:12 INFO - PROCESS | 26017 | RSS: Main: 147742720 10:20:12 INFO - PROCESS | 26017 | 10:20:15 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:15 INFO - PROCESS | 26017 | RSS: Main: 149651456 10:20:15 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | Cycle 1(1): loaded http://localhost:37397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37397/tests/kraken/driver.html?testName=ai-astar) 10:20:17 INFO - PROCESS | 26017 | RSS: Main: 148955136 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | __start_tp_report 10:20:17 INFO - PROCESS | 26017 | _x_x_mozilla_page_load 10:20:17 INFO - PROCESS | 26017 | _x_x_mozilla_page_load_details 10:20:17 INFO - PROCESS | 26017 | |i|pagename|runs| 10:20:17 INFO - PROCESS | 26017 | |0;ai-astar;113;108;114;113;116;125;113;113;113;113 10:20:17 INFO - PROCESS | 26017 | |1;audio-beat-detection;155;132;164;164;134;166;163;137;167;133 10:20:17 INFO - PROCESS | 26017 | |2;audio-dft;162;163;162;162;163;163;166;163;163;162 10:20:17 INFO - PROCESS | 26017 | |3;audio-fft;73;74;77;73;124;72;73;72;73;104 10:20:17 INFO - PROCESS | 26017 | |4;audio-oscillator;96;97;144;97;96;97;146;97;96;134 10:20:17 INFO - PROCESS | 26017 | |5;imaging-gaussian-blur;110;110;110;110;111;111;110;110;110;111 10:20:17 INFO - PROCESS | 26017 | |6;imaging-darkroom;148;147;148;148;149;148;148;149;147;149 10:20:17 INFO - PROCESS | 26017 | |7;imaging-desaturate;95;96;98;96;96;96;96;96;96;96 10:20:17 INFO - PROCESS | 26017 | |8;json-parse-financial;73;73;71;72;80;71;72;73;70;74 10:20:17 INFO - PROCESS | 26017 | |9;json-stringify-tinderbox;66;67;69;72;67;66;67;67;67;67 10:20:17 INFO - PROCESS | 26017 | |10;stanford-crypto-aes;84;85;85;85;85;84;86;83;85;95 10:20:17 INFO - PROCESS | 26017 | |11;stanford-crypto-ccm;122;121;132;134;119;123;124;136;129;130 10:20:17 INFO - PROCESS | 26017 | |12;stanford-crypto-pbkdf2;143;150;146;146;139;153;147;145;149;146 10:20:17 INFO - PROCESS | 26017 | |13;stanford-crypto-sha256-iterative;71;71;74;71;72;72;71;69;70;70 10:20:17 INFO - PROCESS | 26017 | __end_tp_report 10:20:17 INFO - PROCESS | 26017 | __start_cc_report 10:20:17 INFO - PROCESS | 26017 | _x_x_mozilla_cycle_collect,793 10:20:17 INFO - PROCESS | 26017 | __end_cc_report 10:20:17 INFO - PROCESS | 26017 | __startTimestamp1452795617870__endTimestamp 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | ------- Summary: start ------- 10:20:17 INFO - PROCESS | 26017 | Number of tests: 14 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:4.31 (3.8%) stddev-sans-first:4.55 10:20:17 INFO - PROCESS | 26017 | Values: 113.0 108.0 114.0 113.0 116.0 125.0 113.0 113.0 113.0 113.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:163.50 stddev:15.44 (9.4%) stddev-sans-first:16.33 10:20:17 INFO - PROCESS | 26017 | Values: 155.0 132.0 164.0 164.0 134.0 166.0 163.0 137.0 167.0 133.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 10:20:17 INFO - PROCESS | 26017 | Values: 162.0 163.0 162.0 162.0 163.0 163.0 166.0 163.0 163.0 162.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#3] audio-fft Cycles:10 Average:81.50 Median:73.00 stddev:17.82 (24.4%) stddev-sans-first:18.64 10:20:17 INFO - PROCESS | 26017 | Values: 73.0 74.0 77.0 73.0 124.0 72.0 73.0 72.0 73.0 104.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.50 stddev:21.84 (22.6%) stddev-sans-first:22.57 10:20:17 INFO - PROCESS | 26017 | Values: 96.0 97.0 144.0 97.0 96.0 97.0 146.0 97.0 96.0 134.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:20:17 INFO - PROCESS | 26017 | Values: 110.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:20:17 INFO - PROCESS | 26017 | Values: 148.0 147.0 148.0 148.0 149.0 148.0 148.0 149.0 147.0 149.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 10:20:17 INFO - PROCESS | 26017 | Values: 95.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:73.00 stddev:2.77 (3.8%) stddev-sans-first:2.93 10:20:17 INFO - PROCESS | 26017 | Values: 73.0 73.0 71.0 72.0 80.0 71.0 72.0 73.0 70.0 74.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.80 10:20:17 INFO - PROCESS | 26017 | Values: 66.0 67.0 69.0 72.0 67.0 66.0 67.0 67.0 67.0 67.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.52 10:20:17 INFO - PROCESS | 26017 | Values: 84.0 85.0 85.0 85.0 85.0 84.0 86.0 83.0 85.0 95.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:129.50 stddev:5.94 (4.6%) stddev-sans-first:6.02 10:20:17 INFO - PROCESS | 26017 | Values: 122.0 121.0 132.0 134.0 119.0 123.0 124.0 136.0 129.0 130.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:146.50 stddev:3.84 (2.6%) stddev-sans-first:3.87 10:20:17 INFO - PROCESS | 26017 | Values: 143.0 150.0 146.0 146.0 139.0 153.0 147.0 145.0 149.0 146.0 10:20:17 INFO - PROCESS | 26017 | 10:20:17 INFO - PROCESS | 26017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.37 (1.9%) stddev-sans-first:1.45 10:20:17 INFO - PROCESS | 26017 | Values: 71.0 71.0 74.0 71.0 72.0 72.0 71.0 69.0 70.0 70.0 10:20:17 INFO - PROCESS | 26017 | -------- Summary: end -------- 10:20:17 INFO - PROCESS | 26017 | 10:20:18 INFO - TEST-INFO | 26017: exit 0 10:20:18 INFO - TEST-OK | kraken | took 61723ms 10:20:18 INFO - TEST-START | v8_7 10:20:18 INFO - operating with platform_type : linux_ 10:20:18 INFO - Initialising browser for v8_7 test... 10:20:18 INFO - TEST-INFO | started process 26299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddAeND/profile http://localhost:37397/getInfo.html) 10:20:22 INFO - PROCESS | 26299 | 10:20:22 INFO - PROCESS | 26299 | (process:26367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:23 INFO - PROCESS | 26299 | __metrics Screen width/height:1600/1200 10:20:23 INFO - PROCESS | 26299 | colorDepth:24 10:20:23 INFO - PROCESS | 26299 | Browser inner width/height: 1024/697 10:20:23 INFO - PROCESS | 26299 | __metrics 10:20:23 INFO - PROCESS | 26299 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:20:24 INFO - TEST-INFO | 26299: exit 0 10:20:24 INFO - Browser initialized. 10:20:24 INFO - Running cycle 1/1 for v8_7 test... 10:20:24 INFO - TEST-INFO | started process 26416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddAeND/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:26 INFO - PROCESS | 26416 | 10:20:26 INFO - PROCESS | 26416 | (process:26471): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:36 INFO - PROCESS | 26416 | RSS: Main: 150331392 10:20:36 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | Cycle 1(1): loaded http://localhost:37397/tests/v8_7/run.html (next: http://localhost:37397/tests/v8_7/run.html) 10:20:59 INFO - PROCESS | 26416 | RSS: Main: 144896000 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | __start_tp_report 10:20:59 INFO - PROCESS | 26416 | _x_x_mozilla_page_load 10:20:59 INFO - PROCESS | 26416 | _x_x_mozilla_page_load_details 10:20:59 INFO - PROCESS | 26416 | |i|pagename|runs| 10:20:59 INFO - PROCESS | 26416 | |0;Richards;167.44809109176154 10:20:59 INFO - PROCESS | 26416 | |1;DeltaBlue;186.70649738610905 10:20:59 INFO - PROCESS | 26416 | |2;Encrypt;277.77777777777777 10:20:59 INFO - PROCESS | 26416 | |3;Decrypt;5196.891191709845 10:20:59 INFO - PROCESS | 26416 | |4;RayTrace;1104.9723756906078 10:20:59 INFO - PROCESS | 26416 | |5;Earley;726.7441860465116 10:20:59 INFO - PROCESS | 26416 | |6;Boyer;12353.658536585366 10:20:59 INFO - PROCESS | 26416 | |7;RegExp;43340.425531914894 10:20:59 INFO - PROCESS | 26416 | |8;Splay;593.0094786729858 10:20:59 INFO - PROCESS | 26416 | |9;NavierStokes;4826.923076923077 10:20:59 INFO - PROCESS | 26416 | __end_tp_report 10:20:59 INFO - PROCESS | 26416 | __startTimestamp1452795659667__endTimestamp 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | ------- Summary: start ------- 10:20:59 INFO - PROCESS | 26416 | Number of tests: 10 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 167.4 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 186.7 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 277.8 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 5196.9 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 1105.0 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 726.7 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 12353.7 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#7] RegExp Cycles:1 Average:43340.43 Median:43340.43 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 43340.4 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#8] Splay Cycles:1 Average:593.01 Median:593.01 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 593.0 10:20:59 INFO - PROCESS | 26416 | 10:20:59 INFO - PROCESS | 26416 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:20:59 INFO - PROCESS | 26416 | Values: 4826.9 10:20:59 INFO - PROCESS | 26416 | -------- Summary: end -------- 10:20:59 INFO - PROCESS | 26416 | 10:21:00 INFO - TEST-INFO | 26416: exit 0 10:21:00 INFO - TEST-OK | v8_7 | took 41769ms 10:21:00 INFO - SUITE-END | took 1217s 10:21:01 INFO - Completed test suite (00:20:18) 10:21:01 INFO - Working with test: dromaeo_css 10:21:01 INFO - Generating results file: dromaeo_css 10:21:01 INFO - Working with test: kraken 10:21:01 INFO - Generating results file: kraken 10:21:01 INFO - javascript benchmark 10:21:01 INFO - Working with test: v8_7 10:21:01 INFO - Generating results file: v8_7 10:21:01 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:21:01 INFO - process_Request line: dromaeo_css 6184.19 graph.html#tests=[[72,132,43]] 10:21:01 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:01 INFO - process_Request line: kraken 1545.10 graph.html#tests=[[232,132,43]] 10:21:01 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:01 INFO - process_Request line: v8_7 20217.22 graph.html#tests=[[230,132,43]] 10:21:01 INFO - RETURN: dromaeo_css: 6184.19 10:21:01 INFO - RETURN: kraken: 1545.10 10:21:01 INFO - RETURN: v8_7: 20217.22 10:21:01 INFO - javascript benchmark 10:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2635.1699214747355, 2670.5994100884855, 2700.4059106996465, 2721.659792525933, 2725.4140359822636, 4455.554444555542, 4611.100835337111, 4631.282151266555, 4648.62810975122, 4649.674522783406, 4461.06317673289, 4552.408186935702, 4552.704074235173, 4594.104149690812, 4628.861134165981, 4211.380424403455, 4213.094184750278, 4236.301010333292, 4276.25165596021, 4293.29160688486, 3998.280309544281, 4243.893902652428, 4263.445752052229, 4287.056847493546, 4325.956740432587, 4166.375043743447, 4209.052963083282, 4245.532991370947, 4245.745255284693, 4258.020655249279, 4272.316429371285, 4275.123599662062, 4284.871453856389, 4290.871273861758, 4305.182015417092, 4219.556946520602, 4244.3209086546, 4248.022954720432, 4290.356446533045, 4300.311950088002, 4392.956070439287, 4458.0, 4496.640268778523, 4500.842470513517, 4617.145828021827, 4799.544043315879, 4822.493638168012, 4824.565789079, 4825.445073816521, 4855.174620314555, 4850.345203397566, 4853.951460485385, 4857.0, 4860.854174374775, 4894.045661096087, 4508.188526065307, 4570.840020599263, 4587.3577699121815, 4608.331791890224, 4655.930161047587, 4982.252662100714, 4994.40067191932, 4996.375453068366, 5008.273800299009, 5047.293378926953, 4746.288056791509, 4787.234042553175, 4790.0180463005, 4797.160496913096, 4856.344393506832, 4777.259524773665, 4930.827421040246, 4945.431275403303, 4983.950160498349, 4991.775370108354, 4745.715257084586, 4830.541098595628, 4833.275008748716, 4842.418909730784, 4860.902781944341, 4710.646701497401, 4773.76131193439, 4801.207800712913, 4801.639877009238, 4848.5636292733825, 3996.540397854226, 4006.5192176938954, 4055.1281474483126, 4063.7358571692744, 4073.5315438724924, 3546.095745584911, 3578.821058947094, 3590.6409359063887, 3593.3352329819068, 3623.202895363016, 4175.436316097349, 4222.556631553643, 4259.7231179973205, 4307.289297265916, 4309.310510318334, 4824.710517368969, 4846.176150054499, 4855.95144048555, 4860.80556777732, 4902.730349830722, 4198.874033778991, 4224.556421575752, 4261.403403523509, 4263.893402664959, 4294.055307832272, 4204.8528301509305, 4289.678274129453, 4319.827206911751, 4333.328334108218, 4370.060437006059, 4676.228422310417, 4684.0, 4684.742339171378, 4688.5545873142, 4694.342792009122, 4949.232868905326, 4956.504349565014, 4963.404391473046, 4964.032013757283, 5022.397312322545, 4563.794629241625, 4580.083983203306, 4657.813687452464, 4660.231061874752, 4674.205385084611, 4793.856184314476, 4799.568038876518, 4802.447718512276, 4804.735739534359, 4848.151573474557, 4879.926801098058, 4888.60891128716, 4894.559489645949, 4900.044491324157, 4931.654784165074, 4611.976940115278, 4708.081924024782, 4754.595859351994, 4840.6127509798425, 4846.17615005457, 4671.929921051119, 4689.296605509201, 4694.647901407477, 4702.15361234981, 4736.834210802744, 4571.040081582905, 4571.291449825149, 4586.839460618862, 4616.076784643018, 4657.208274593395, 4653.162430762495, 4705.811767529397, 4752.358431611827, 4796.760161991817, 4839.903201935871, 4645.86062418128, 4651.930221046619, 4673.182193116259, 4673.392458980311, 4708.976455117702], "unit": "score", "name": "dojo.html", "value": 4486.755537197202}, {"lowerIsBetter": false, "replicates": [501.73408093710344, 513.4531723714244, 514.4135685318737, 532.4701921588015, 538.1819634156084, 33136.66863331366, 33652.0, 33794.9861504155, 33799.32401351975, 33896.66103338966, 37065.0, 37488.250234995285, 37643.623563764355, 37705.81147094261, 38005.61994380056, 7661.9616901915415, 7851.175626559215, 7854.3716502679645, 7865.370770338388, 7870.921290787076, 6459.806205813833, 7664.501807382502, 7677.385809135256, 7882.842343153134, 7883.58095542802, 7859.331956783681, 7944.0, 7946.331270433216, 7954.204579542057, 7964.362850971937, 7826.3738900888075, 7853.41099417546, 7863.37093032556, 7894.7236846710375, 7894.881576776353, 7751.341136003446, 7950.1254861965135, 7956.124826269106, 7975.042994840656, 7990.280874721303, 37529.43705844414, 38000.239995200216, 38256.80871595652, 38273.0, 38289.425658615146, 3088.089013740952, 3110.206897241189, 3452.067941655764, 3773.660370566662, 3784.3566593679143, 27547.86226068877, 27578.083063281487, 28415.147545573665, 28447.288817779514, 29250.414991700047, 3415.213946117279, 3415.624281329052, 3456.740744444177, 3491.14466955595, 3580.7314451416246, 213992.0, 214592.0, 214768.0, 215089.92455037782, 215204.0, 47992.0, 54748.45251547434, 54902.45097548974, 54907.0, 55088.72455637696, 42920.356194657106, 60053.39946600478, 61235.0, 61396.0, 61471.692641537404, 13319.800202996963, 13517.526886558922, 13557.25435101079, 13595.388207530685, 13620.318984050758, 10835.187360947803, 10842.0, 10868.130549556017, 10897.237193396544, 10899.891001089887, 18737.90631046836, 18816.153273102744, 18892.433227003214, 18913.7162942556, 19769.703454448194, 7405.0, 7631.54210747357, 7636.389088872988, 7764.961175194087, 7834.334081603128, 861.6424183963585, 873.5195642396657, 874.1215078845846, 952.7570469530225, 985.4776968206862, 26319.736802632113, 26407.471850563266, 26612.733872661414, 26626.73373266281, 26631.733682663315, 996.9651062212788, 1013.4020927652721, 1040.8334666453331, 1076.5908954597203, 1135.1202817816093, 13979.301034948212, 14023.85976140246, 14161.716765664629, 14342.713145737027, 14656.926715366355, 259661.0, 265330.0, 266256.0, 266831.0, 267554.0, 47354.5264547357, 47766.522334776906, 47775.0, 47779.28331075037, 47856.52143478521, 1198.7902117129468, 1274.1781550899618, 1276.183242724657, 1277.0422183362477, 1284.4669462173094, 26720.34117858102, 26776.0, 27183.0, 27259.0, 27275.590866136627, 41037.1792564153, 41103.38344924769, 41243.38134928038, 41397.1720565581, 41421.378679319234, 239360.0, 239476.0, 240911.0, 241600.0, 241660.0, 28760.712392875805, 29034.709652903202, 29469.263268417602, 29479.19947604974, 29505.409891802472, 33529.83235083907, 33762.662373375955, 34049.65950340465, 34313.65686343204, 34373.48439773455, 28780.42439151247, 28866.27834304159, 28881.711182887902, 29313.0, 29509.409811803213, 28330.716692832808, 28463.288417788892, 28829.423411532072, 29004.7099529002, 29352.26619334534, 30633.693663063084, 31905.202369940936, 32247.35505289928, 32339.0, 32521.674783251863, 28457.43085138327, 28813.855930720212, 29286.56070158992, 29384.559231611114, 29537.852310738308, 23073.423164420354, 23146.305610831703, 23228.535429291656, 23233.76766232316, 23276.65085023692], "unit": "score", "name": "ext.html", "value": 16665.971495975038}, {"lowerIsBetter": false, "replicates": [344.6725610669864, 346.88649435312647, 349.9982500087499, 351.3780608323268, 356.1505808646378, 11888.286702797837, 12295.508179672825, 13963.16221026738, 14335.713285734291, 16220.18899055047, 14030.158190508577, 14464.5660630181, 14771.482998095069, 15373.615659608515, 15426.3829446822, 4950.158473059589, 4971.825986090487, 5028.220625803006, 5044.470330615288, 5071.137906555894, 4764.928526072112, 4962.702237865721, 4997.675151115166, 5026.572741316974, 5038.193888977764, 4908.116539022974, 4967.428745694256, 5011.599072074244, 5372.409035006146, 5392.757325920324, 5402.189671549259, 5599.664020158783, 5610.158476228557, 5614.242077319551, 5636.436356364372, 5101.897962040775, 5104.106781313255, 5114.846554603368, 5129.358830146231, 5134.666246693991, 11364.43177841113, 11862.940685296518, 18035.819641803675, 18087.276508939627, 18100.818991810043, 1780.3234770787149, 1792.4353828543967, 1823.8449731772814, 1862.8044055374125, 1925.1529327096032, 8045.155258697811, 8680.652773889036, 8698.434601750929, 8730.083341249205, 8928.330375221884, 1681.7702636489125, 1740.8346207110305, 1800.2528950485532, 1876.774787025552, 1958.8922609256485, 38866.0, 41787.582124178974, 43759.78120109411, 44443.333349999775, 54025.459745402826, 9382.67160649374, 9414.29392795543, 9482.905170948341, 9608.855867161998, 9885.950570247247, 12297.32364719949, 12400.379981000913, 12432.937835310946, 12438.626841194779, 12446.688832779071, 6717.798466046026, 6733.057371967929, 6973.546719463218, 7023.051887995158, 7186.892196617055, 6338.58799178052, 6521.217453905467, 6540.574862633914, 6563.6389998549585, 6603.471722262208, 3952.5256969163884, 4174.415581818548, 4197.349410841324, 4220.177065472265, 4271.444712187395, 1721.8622510199154, 1759.6128851652616, 1802.5313418511018, 1804.3323970131135, 1819.7543331650322, 792.9801754956056, 821.2977903892206, 834.5910503853069, 903.5978989349808, 943.3396622364372, 15060.021098628555, 15075.698486030218, 15211.315490802941, 15242.695146097016, 15337.463188788339, 808.2523665609287, 821.3059964330131, 836.0928392693874, 855.5722138930535, 860.9410425177067, 8701.0, 8716.041235464094, 8798.736037918745, 8888.244499217639, 8968.820623587491, 396973.0, 397222.0, 402951.0, 418705.0, 425891.0, 55384.72307638436, 59623.70188149031, 60721.0, 61212.693936530035, 62031.0, 1067.4769363012067, 1074.4037059432246, 1074.838774183863, 1095.2114477576133, 1098.6319582939645, 12754.936225318814, 13623.38694758758, 13639.181649101085, 13651.38568764388, 14063.156210627396, 29890.402191956473, 30184.698153018187, 30959.380812384075, 31072.378552429276, 31359.686403135678, 36627.633723662424, 37062.0, 37090.0, 37135.25729485449, 37221.813890930374, 6504.869902602016, 6689.684294195048, 6799.286074962256, 6807.421369183675, 6861.691223894837, 7055.788326350218, 8578.742637720878, 8823.867641985247, 9296.95351523238, 9767.0, 8634.78413039679, 8653.870191947251, 8882.689105881263, 8951.149640784115, 8982.955085224532, 8573.0, 8822.64709411642, 8853.60158792843, 8859.867101993605, 9058.864117038118, 8496.787580310542, 8641.827163456821, 8722.0, 9016.18854303116, 9194.58624361892, 6798.456123510008, 6867.484938629523, 6874.621895795779, 6964.338387853146, 7050.682719277747, 7485.251474852689, 8559.657613695383, 8687.218150366498, 8839.248663863644, 8867.157620026088], "unit": "score", "name": "jquery.html", "value": 7392.47644037897}, {"lowerIsBetter": false, "replicates": [1392.7771556550952, 1402.340899777105, 1530.510236724248, 1717.5534361066127, 1720.4494561740232, 6128.050152226401, 6251.874962500748, 7222.783316500507, 7437.962810185955, 7439.293267139627, 6963.965180174092, 7081.362677359037, 7136.85726285474, 7138.571685698848, 7151.32062454066, 2152.5802468518646, 2193.846430749848, 2194.089452877054, 2195.374318319279, 2198.670199470076, 2116.195845578678, 2122.2253877334815, 2211.159759291467, 2212.5132470856465, 2219.1678120704737, 2153.9461513462134, 2158.686990386393, 2168.1544197762887, 2194.1662168375997, 2264.8414610977156, 2190.660447630612, 2199.857009294407, 2202.9118835246572, 2203.7135172427643, 2204.6803213534026, 2157.5037741319584, 2179.259051922338, 2192.572448372568, 2194.901229444679, 2198.0658220256328, 7368.557886526772, 7368.705251789922, 7414.295641914064, 7415.666295016737, 7422.406207503441, 4281.7002809803325, 4389.912201755979, 4392.494863090754, 4395.626371758404, 4411.09572537629, 2675.3712877473777, 2692.098147120717, 2699.2172270041665, 2734.9589756153673, 2746.931326716828, 818.1818181818181, 838.2958315015355, 839.6935118681637, 844.0630899701326, 849.1169184048582, 10159.339642923187, 10165.085142337226, 10187.54156062979, 10203.4388108654, 10223.028812262823, 3906.1015966327905, 3961.3661814109605, 4015.4779878616177, 4026.416169655384, 4029.6299258252334, 8765.737027889174, 8791.120887911158, 8791.648334066693, 8801.955990220007, 8806.251468625238, 4326.221280169537, 4341.19687857741, 4347.500037495665, 4358.760268185217, 4363.890902727458, 3344.6989770920736, 3434.0384692286198, 3806.238752249561, 3892.6107389260847, 3936.7834769087976, 3437.9312413752086, 3450.464543278217, 3451.3442445935193, 3453.9827300863835, 3487.442009278554, 1010.7169992402139, 1024.8155332040155, 1029.6910926721953, 1033.0857191385678, 1095.2661716649864, 1103.6082190822303, 1118.183725880112, 1118.7706520163347, 1119.4738472917716, 1134.5575225661999, 6248.812535623939, 6291.779787707408, 6305.558610897285, 6309.337519560472, 6318.873622527615, 1111.1555218034352, 1111.394290111891, 1139.2594813371209, 1153.3368313219764, 1158.009901534193, 4859.902801943941, 4906.337644418029, 4963.70217786934, 5032.84901452957, 5040.168372218616, 8014.879776803353, 8105.918940810517, 8215.671373145127, 8223.506589604644, 8252.174782521819, 7928.643211055516, 8283.461574997606, 8330.042045164884, 8454.619542120496, 8475.83048339042, 6647.734090636417, 6738.696758645872, 6746.0892779475125, 6791.456683465311, 6797.456203503807, 6310.6844657766005, 6334.4932405406535, 6468.094466774562, 6476.31998640136, 6540.803775886731, 7443.627818608939, 7682.846343072995, 7885.408594355561, 7979.521228726295, 8023.59882005909, 7785.571793551409, 7830.2169783021245, 7845.293923546908, 7873.724419645285, 8123.065847427385, 5313.1764576490705, 5436.130219164915, 6078.057901025348, 6296.150019747275, 6380.457661098673, 6687.264400915798, 6692.0, 6718.496112791462, 6723.1259936209935, 6723.697433615401, 6113.694315284307, 6250.593711408744, 6362.904556431749, 6364.236291644847, 6377.585456945284, 6228.065790131335, 6270.874582508415, 6316.873662526816, 6332.651704156316, 6364.236291645032, 6360.459360954371, 6370.044493325853, 6397.6481293529305, 6403.7118329676205, 6413.583117097373, 5903.468687818117, 5918.2898052234, 5927.377625349449, 5928.644281343133, 5938.732757025858, 5896.823095307148, 6108.144859719554, 6110.572259941761, 6113.908291375544, 6127.0], "unit": "score", "name": "mootools.html", "value": 4129.435520150573}, {"lowerIsBetter": false, "replicates": [311.167626598848, 315.93229739232055, 318.3839271010594, 321.44229761364045, 331.6385140197185, 5356.1697936819755, 5451.918221226685, 5459.91810122848, 5464.453554644539, 5499.67001979881, 5308.787648494065, 5396.676199428027, 5417.891642167155, 5436.293281873361, 5436.3476382834115, 4264.89337766556, 4271.743695378287, 4271.850485233017, 4277.4867015958125, 4284.635805956482, 4269.935950960738, 4271.316589345705, 4271.658267338621, 4276.914461710764, 4280.1653677532895, 4048.6153815387493, 4163.646090082347, 4243.490781106271, 4253.2769429197115, 4261.296886013804, 4157.771322577257, 4159.355299928501, 4163.02168990287, 4172.582741725833, 4174.060836311805, 3622.456631505269, 3622.8550857965915, 3634.800085995269, 3636.327279453283, 3651.9817400912825, 5171.715555644438, 5248.0, 5253.369595648508, 5280.128778751539, 5294.311739473882, 4694.460137084211, 4848.975755121237, 4851.223804191312, 4856.17445034345, 4866.416030076378, 5587.692676902769, 5668.943310566883, 5681.318241810968, 5691.345495268056, 5744.74148663307, 3969.908275224336, 3971.027098360891, 3975.185087057146, 3976.8608098716404, 3984.7409918355215, 5976.432238937294, 6048.7882924097885, 6054.849578580056, 6055.6063855849225, 6056.515478761733, 4003.739756915791, 4104.630583247522, 4118.4440100586635, 4124.298869192245, 4132.421460995463, 4166.312558427825, 4168.6039826216465, 4172.728772629769, 4175.603317684815, 4175.789021183883, 4764.071006153836, 4767.046590681877, 4767.380240568704, 4780.020095880336, 4780.737059461693, 5710.229119068873, 5733.168690539848, 5734.741936612779, 5736.827895163152, 5739.16782066598, 1465.948691795782, 1487.4050379847931, 1493.5370035288877, 1496.9027013244104, 1496.9625759355886, 970.257752819094, 1003.1272792670278, 1003.9297249192632, 1008.6167256442652, 1015.1726343030555, 4883.413990321184, 4952.504749525018, 4957.03337849116, 4961.355023846877, 4962.60299176065, 5852.15143804146, 5922.8815423691285, 5937.2578427696535, 5951.642901425842, 5953.613015154001, 4985.850424487271, 4989.725565093882, 4992.700437973734, 5001.199808030698, 5006.574441172541, 3158.8262645554714, 3193.520971854194, 3209.7271731902583, 3226.3869864725625, 3248.9187770305457, 5613.578981576316, 5690.032694441955, 5710.543156547466, 5737.454941780524, 5761.48146666802, 6213.720382582795, 6225.252969643671, 6240.254288113216, 6240.594361366497, 6259.1550140730415, 5499.50504454593, 5683.2895888014, 5687.232223649919, 5687.971560142173, 5693.17448969897, 6010.3088144863905, 6054.364291749479, 6057.394260573908, 6072.180255665428, 6082.057281121433, 5898.292204935436, 5902.763889444546, 5905.173275741314, 5909.438603332676, 5915.260592425947, 5533.667979921218, 5642.379338272704, 5646.153077038477, 5668.319801623831, 5672.773089076556, 4084.8774536763945, 4136.110736191733, 4139.110091330258, 4154.356074808409, 4154.979225103855, 5999.310079340931, 6009.759609615567, 6011.458968692838, 6063.181470501426, 6064.120702498201, 5768.509676677361, 5796.855078623068, 5799.594028417971, 5828.0, 5831.0, 5687.232223649754, 5771.884562308646, 5821.563382746395, 5826.883462330815, 5831.241938547962, 5647.29408823897, 5697.6296540724725, 5706.087026075808, 5707.1724599933605, 5711.485966263056, 5856.590038697421, 5863.20846685692, 5868.911966320594, 5876.647401155944, 5880.764769409176, 5495.450454954473, 5615.578831587565, 5642.85892852682, 5688.516476099578, 5706.172604972338], "unit": "score", "name": "prototype.html", "value": 4324.847291081189}, {"lowerIsBetter": false, "replicates": [648.68862945786, 650.0736450557954, 650.300926504008, 738.6048464071723, 752.5033477904577, 11689.824652630206, 11892.702682432944, 11923.64229073127, 11963.880361196385, 11998.580049698263, 11429.371384573846, 13133.212007279546, 13207.471701131943, 13347.265900375476, 13360.532381366655, 761.7219714804085, 772.2663469703775, 785.5286827903269, 785.8467598818232, 786.4298383671821, 778.9454738168331, 779.1468342165319, 782.3193821375411, 783.9804004899895, 786.5555960882083, 818.4352796570378, 818.7093581778472, 819.4059307002435, 824.5959479854857, 826.3760860550307, 809.550699361854, 811.5942028985507, 812.4962523235573, 815.7675062607158, 816.1226681317578, 603.6016229288648, 607.9513638908921, 608.0544752909225, 608.0757248981567, 609.3571282297174, 12571.245725256422, 12585.0, 12640.55758048473, 12676.985841132688, 12706.110572259946, 11435.656930292105, 11527.596534121349, 11535.538578456852, 11756.54448964625, 12030.33833139177, 9279.443233406017, 9338.0, 9369.063093690576, 9372.625094996192, 9974.152197063258, 3140.7173354398215, 3193.297474555594, 3214.8231847248394, 3221.3879362921202, 3289.194147433894, 41180.1763964719, 41856.37215441771, 41869.581304186875, 41873.790631046955, 41883.371749423786, 9166.26669866409, 9204.171624553823, 9346.532673366304, 9363.578638961262, 9406.95296523513, 15898.920505397631, 15984.600384990468, 16025.0, 16042.037477751372, 16085.67828643444, 6196.318404975449, 6228.844278893064, 6512.772052978123, 6539.574927629689, 6581.868362632817, 3720.9813950930616, 3758.285925674113, 3776.206996530759, 3779.3952967525615, 3838.2323535293053, 2676.2372723773633, 2691.892324307045, 2698.581719833429, 2700.7569318761407, 2704.486147631944, 471.43663322329485, 481.4222932481037, 491.3710450623208, 494.19692998876826, 494.83670388771617, 511.75691546515105, 512.3621091740732, 537.4732761893288, 596.2993482657946, 620.404411764711, 7685.346745526581, 8185.71350002747, 8426.199511046441, 8646.313968776154, 8914.197722205032, 505.87353161709575, 546.3962321634616, 589.3075636127533, 610.1884493623559, 631.2677294338637, 3431.673990970854, 3622.076370525499, 3634.8727794527063, 3706.166112624692, 3709.46212799148, 44691.776541117084, 44940.0, 45300.77349613231, 45325.77337113359, 45509.7724511382, 38923.0, 38992.80503597464, 39167.60832391697, 41313.0, 41349.1730165395, 36987.44518832274, 37913.431298530544, 38153.23693526114, 38246.0, 38253.42619860704, 7330.633468326456, 7393.778186654409, 7415.740449084256, 7443.032405787213, 7455.105387353552, 27990.44019119647, 28075.71924280731, 28780.712192877803, 29166.708332916398, 29284.560731588615, 36569.817150914074, 36856.44715329219, 37080.25839483249, 38402.0, 39088.21823563569, 9162.496062716615, 9864.753381165528, 9979.750506237111, 10082.092611664986, 10293.073623373932, 10948.406451421171, 10973.177011723992, 11100.944495277796, 11133.610323638633, 11149.554017839195, 10602.416867072385, 10718.464076796285, 10742.892571074502, 10751.408672522773, 10783.568657253621, 10907.727306817393, 10972.506237219184, 10989.0, 11041.33751974884, 11095.5561777528, 10362.326448780805, 10743.0, 10907.78184436291, 10915.181361397768, 10931.890681093406, 8666.480011199348, 8715.564221788758, 8795.604197811243, 8825.293976481738, 8883.555822208993, 8516.276116530164, 8551.401401901807, 8718.761842079031, 8766.430182038148, 8991.23574496149], "unit": "score", "name": "yui.html", "value": 5665.480456969711}], "name": "dromaeo_css", "value": 6184.182245968978}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 114.0, 113.0, 116.0, 125.0, 113.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 164.0, 164.0, 134.0, 166.0, 163.0, 137.0, 167.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 166.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 73.0, 124.0, 72.0, 73.0, 72.0, 73.0, 104.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 144.0, 97.0, 96.0, 97.0, 146.0, 97.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 80.0, 71.0, 72.0, 73.0, 70.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 72.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 83.0, 85.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 132.0, 134.0, 119.0, 123.0, 124.0, 136.0, 129.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 146.0, 146.0, 139.0, 153.0, 147.0, 145.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 74.0, 71.0, 72.0, 72.0, 71.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1545.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [43340.425531914894], "unit": "score", "name": "RegExp", "value": 21.019290623465874}, {"lowerIsBetter": false, "replicates": [593.0094786729858], "unit": "score", "name": "Splay", "value": 137.41938861138865}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20217.221565952652}]} 10:21:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20217.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6184.19"}}} 10:21:01 INFO - Return code: 0 10:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:21:01 INFO - # TBPL SUCCESS # 10:21:01 INFO - Running post-action listener: _resource_record_post_action 10:21:01 INFO - Running post-run listener: _resource_record_post_run 10:21:02 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 428134400; Read time: 0; Write time: 233776 10:21:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110608384; Read time: 0; Write time: 59652 10:21:02 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 308604928; Read time: 0; Write time: 162848 10:21:02 INFO - Running post-run listener: _upload_blobber_files 10:21:02 INFO - Blob upload gear active. 10:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:21:02 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:02 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:03 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:04 INFO - (blobuploader) - INFO - Done attempting. 10:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:05 INFO - (blobuploader) - INFO - Done attempting. 10:21:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:05 INFO - Return code: 0 10:21:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/834214ba6824e9302b3e8b2950d85d9bc3d44b130a078016bb1338a3c7adcf76bbea34e61dd42c5303c8e8f3c4c90293ccd3b280a99e4108121dc47c24bd7b61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b491a5ad656d0d7bef962e8fd60e6c86d5b3de09a878da9f4e3cd16de60e31f6295cec2b2002bc970f85ad8474425eddce4c8385da4c12e587a9b941715cd160"} 10:21:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:05 INFO - Contents: 10:21:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/834214ba6824e9302b3e8b2950d85d9bc3d44b130a078016bb1338a3c7adcf76bbea34e61dd42c5303c8e8f3c4c90293ccd3b280a99e4108121dc47c24bd7b61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b491a5ad656d0d7bef962e8fd60e6c86d5b3de09a878da9f4e3cd16de60e31f6295cec2b2002bc970f85ad8474425eddce4c8385da4c12e587a9b941715cd160"} 10:21:05 INFO - Copying logs to upload dir... 10:21:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1294.393915 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-14 10:21:04.980613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:21:04.983946) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 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/Fx-Team-Non-PGO/sha512/834214ba6824e9302b3e8b2950d85d9bc3d44b130a078016bb1338a3c7adcf76bbea34e61dd42c5303c8e8f3c4c90293ccd3b280a99e4108121dc47c24bd7b61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b491a5ad656d0d7bef962e8fd60e6c86d5b3de09a878da9f4e3cd16de60e31f6295cec2b2002bc970f85ad8474425eddce4c8385da4c12e587a9b941715cd160"} build_url:https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/CmDUWfzOT8iNauZg6XoUEg/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/Fx-Team-Non-PGO/sha512/834214ba6824e9302b3e8b2950d85d9bc3d44b130a078016bb1338a3c7adcf76bbea34e61dd42c5303c8e8f3c4c90293ccd3b280a99e4108121dc47c24bd7b61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b491a5ad656d0d7bef962e8fd60e6c86d5b3de09a878da9f4e3cd16de60e31f6295cec2b2002bc970f85ad8474425eddce4c8385da4c12e587a9b941715cd160"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:21:05.009684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:21:05.010222) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452794060.249697-804813132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:21:05.093428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:21:05.093742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:21:05.094027) ========= ========= Total master_lag: 0.24 =========