builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1452473989.83 results: success (0) buildid: 20160110153832 builduid: 695d28dbf46d402296ab72dd0e06cd47 revision: 359f86fecbc2a6531d9018fb81a74fd26502f5a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.833347) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.833818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.834139) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.867001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.867324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.947589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:49.947885) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004696 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.012493) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.012804) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.013213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.013549) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 16:59:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-01-10 16:59:50 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.314741 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.343881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.344200) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014483 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.396395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:50.397166) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 359f86fecbc2a6531d9018fb81a74fd26502f5a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 359f86fecbc2a6531d9018fb81a74fd26502f5a1 --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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 16:59:50,573 truncating revision to first 12 chars 2016-01-10 16:59:50,573 Setting DEBUG logging. 2016-01-10 16:59:50,573 attempt 1/10 2016-01-10 16:59:50,573 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/359f86fecbc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 16:59:50,883 unpacking tar archive at: mozilla-central-359f86fecbc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:51.017574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:51.018314) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:51.030550) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:51.030858) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 16:59:51.031288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-10 16:59:51.031641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:51 INFO - MultiFileLogger online at 20160110 16:59:51 in /builds/slave/test 16:59:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:59:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:51 INFO - {'append_to_log': False, 16:59:51 INFO - 'base_work_dir': '/builds/slave/test', 16:59:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:59:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:51 INFO - 'branch': 'Firefox-Non-PGO', 16:59:51 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:51 INFO - 'config_files': ('talos/linux_config.py',), 16:59:51 INFO - 'default_actions': ('clobber', 16:59:51 INFO - 'read-buildbot-config', 16:59:51 INFO - 'download-and-extract', 16:59:51 INFO - 'populate-webroot', 16:59:51 INFO - 'create-virtualenv', 16:59:51 INFO - 'install', 16:59:51 INFO - 'run-tests'), 16:59:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:51 INFO - 'download_minidump_stackwalk': True, 16:59:51 INFO - 'download_symbols': 'ondemand', 16:59:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:51 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:51 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:51 INFO - 'installer_path': 'installer.exe', 16:59:51 INFO - 'log_level': 'info', 16:59:51 INFO - 'log_name': 'talos', 16:59:51 INFO - 'log_to_console': True, 16:59:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:51 INFO - 'opt_config_files': (), 16:59:51 INFO - 'pip_index': False, 16:59:51 INFO - 'sps_profile': False, 16:59:51 INFO - 'sps_profile_interval': 0, 16:59:51 INFO - 'suite': 'dromaeojs-e10s', 16:59:51 INFO - 'system_bits': '32', 16:59:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:51 INFO - 'title': 'talos-linux64-ix-058', 16:59:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:51 INFO - 'use_talos_json': True, 16:59:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:51 INFO - 'work_dir': 'build'} 16:59:51 INFO - ##### 16:59:51 INFO - ##### Running clobber step. 16:59:51 INFO - ##### 16:59:51 INFO - Running pre-action listener: _resource_record_pre_action 16:59:51 INFO - Running main action method: clobber 16:59:51 INFO - rmtree: /builds/slave/test/build 16:59:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:51 INFO - Running post-action listener: _resource_record_post_action 16:59:51 INFO - ##### 16:59:51 INFO - ##### Running read-buildbot-config step. 16:59:51 INFO - ##### 16:59:51 INFO - Running pre-action listener: _resource_record_pre_action 16:59:51 INFO - Running main action method: read_buildbot_config 16:59:51 INFO - Using buildbot properties: 16:59:51 INFO - { 16:59:51 INFO - "project": "", 16:59:51 INFO - "product": "firefox", 16:59:51 INFO - "script_repo_revision": "production", 16:59:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:59:51 INFO - "repository": "", 16:59:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:59:51 INFO - "buildid": "20160110153832", 16:59:51 INFO - "pgo_build": "False", 16:59:51 INFO - "basedir": "/builds/slave/test", 16:59:51 INFO - "buildnumber": 167, 16:59:51 INFO - "slavename": "talos-linux64-ix-058", 16:59:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:59:51 INFO - "platform": "ubuntu64_hw", 16:59:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:59:51 INFO - "branch": "mozilla-central", 16:59:51 INFO - "repo_path": "mozilla-central", 16:59:51 INFO - "revision": "359f86fecbc2a6531d9018fb81a74fd26502f5a1", 16:59:51 INFO - "stage_platform": "linux64", 16:59:51 INFO - "builduid": "695d28dbf46d402296ab72dd0e06cd47", 16:59:51 INFO - "slavebuilddir": "test" 16:59:51 INFO - } 16:59:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:59:51 INFO - Running post-action listener: _resource_record_post_action 16:59:51 INFO - ##### 16:59:51 INFO - ##### Running download-and-extract step. 16:59:51 INFO - ##### 16:59:51 INFO - Running pre-action listener: _resource_record_pre_action 16:59:51 INFO - Running main action method: download_and_extract 16:59:51 INFO - mkdir: /builds/slave/test/build/tests 16:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:51 INFO - https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/test_packages.json 16:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/test_packages.json 16:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:59:56 INFO - Downloaded 1302 bytes. 16:59:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:59:56 INFO - Using the following test package requirements: 16:59:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'jsshell-linux-x86_64.zip'], 16:59:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16: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')]} 16:59:56 INFO - https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 16:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:01 INFO - Downloaded 22761285 bytes. 17:00:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:00:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:00:02 INFO - Return code: 0 17:00:02 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 17:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:02 INFO - https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:09 INFO - Downloaded 22761285 bytes. 17:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:00:10 INFO - Return code: 0 17:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:10 INFO - https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:13 INFO - Downloaded 11132285 bytes. 17:00:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:00:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:00:13 INFO - Return code: 0 17: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')]} 17:00:13 INFO - https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQIF773eRR26GLswc3STpw/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 17:00:16 INFO - Downloaded 54045665 bytes. 17:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:16 INFO - mkdir: /builds/slave/test/properties 17:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:16 INFO - Contents: 17:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:16 INFO - Running post-action listener: _resource_record_post_action 17:00:16 INFO - Running post-action listener: set_extra_try_arguments 17:00:16 INFO - ##### 17:00:16 INFO - ##### Running populate-webroot step. 17:00:16 INFO - ##### 17:00:16 INFO - Running pre-action listener: _resource_record_pre_action 17:00:16 INFO - Running main action method: populate_webroot 17:00:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:16 INFO - '--tppagecycles', 17:00:16 INFO - '7'], 17:00:16 INFO - 'tests': ['tsvgm']}}, 17:00:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:00:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['damp', 'tps']}, 17:00:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['damp', 'tps']}, 17:00:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:00:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:16 INFO - 'other': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'other_l64': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'other_nol64': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore']}, 17:00:16 INFO - 'svgr': {'tests': ['tsvgx', 17:00:16 INFO - 'tsvgr_opacity', 17:00:16 INFO - 'tart', 17:00:16 INFO - 'tscrollx', 17:00:16 INFO - 'cart']}, 17:00:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['tsvgx', 17:00:16 INFO - 'tsvgr_opacity', 17:00:16 INFO - 'tart', 17:00:16 INFO - 'tscrollx', 17:00:16 INFO - 'cart']}, 17:00:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['tp5o']}, 17:00:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--e10s'], 17:00:16 INFO - 'tests': ['tp5o']}, 17:00:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--xperf_path', 17:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:16 INFO - 'tests': ['tp5n']}, 17:00:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--e10s', 17:00:16 INFO - '--xperf_path', 17:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:16 INFO - 'tests': ['tp5n']}}, 17:00:16 INFO - 'talos.zip': {'path': '', 17:00:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:16 INFO - Running post-action listener: _resource_record_post_action 17:00:16 INFO - ##### 17:00:16 INFO - ##### Running create-virtualenv step. 17:00:16 INFO - ##### 17:00:16 INFO - Running pre-action listener: _resource_record_pre_action 17:00:16 INFO - Running main action method: create_virtualenv 17:00:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00:16 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 17:00:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:16 INFO - Using real prefix '/usr' 17:00:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:19 INFO - Installing pip.................done. 17:00:19 INFO - Return code: 0 17:00:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', '--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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:19 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 17:00:19 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 17:00:19 INFO - Using env: {'DISPLAY': ':0', 17:00:19 INFO - 'HOME': '/home/cltbld', 17:00:19 INFO - 'LANG': 'en_US.UTF-8', 17:00:19 INFO - 'LANGUAGE': 'en_US:en', 17:00:19 INFO - 'LOGNAME': 'cltbld', 17:00:19 INFO - 'MAIL': '/var/mail/cltbld', 17:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:19 INFO - 'MOZ_NO_REMOTE': '1', 17:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:19 INFO - 'NO_EM_RESTART': '1', 17:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:19 INFO - 'PWD': '/builds/slave/test', 17:00:19 INFO - 'SHELL': '/bin/bash', 17:00:19 INFO - 'SHLVL': '1', 17:00:19 INFO - 'TERM': 'linux', 17:00:19 INFO - 'TMOUT': '86400', 17:00:19 INFO - 'USER': 'cltbld', 17:00:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:19 INFO - '_': '/tools/buildbot/bin/python'} 17:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:19 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 17:00:19 INFO - Cleaning up... 17:00:19 INFO - Return code: 0 17:00:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', '--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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:19 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 17:00:19 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 17:00:19 INFO - Using env: {'DISPLAY': ':0', 17:00:19 INFO - 'HOME': '/home/cltbld', 17:00:19 INFO - 'LANG': 'en_US.UTF-8', 17:00:19 INFO - 'LANGUAGE': 'en_US:en', 17:00:19 INFO - 'LOGNAME': 'cltbld', 17:00:19 INFO - 'MAIL': '/var/mail/cltbld', 17:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:19 INFO - 'MOZ_NO_REMOTE': '1', 17:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:19 INFO - 'NO_EM_RESTART': '1', 17:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:19 INFO - 'PWD': '/builds/slave/test', 17:00:19 INFO - 'SHELL': '/bin/bash', 17:00:19 INFO - 'SHLVL': '1', 17:00:19 INFO - 'TERM': 'linux', 17:00:19 INFO - 'TMOUT': '86400', 17:00:19 INFO - 'USER': 'cltbld', 17:00:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:19 INFO - '_': '/tools/buildbot/bin/python'} 17:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:19 INFO - Downloading/unpacking psutil>=0.7.1 17:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:00:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:21 INFO - Installing collected packages: psutil 17:00:21 INFO - Running setup.py install for psutil 17:00:21 INFO - building 'psutil._psutil_linux' extension 17:00:21 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 17:00:21 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 17:00:21 INFO - building 'psutil._psutil_posix' extension 17:00:21 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 17:00:21 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 17:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:21 INFO - Successfully installed psutil 17:00:21 INFO - Cleaning up... 17:00:21 INFO - Return code: 0 17:00:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:21 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 17:00:21 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 17:00:21 INFO - Using env: {'DISPLAY': ':0', 17:00:21 INFO - 'HOME': '/home/cltbld', 17:00:21 INFO - 'LANG': 'en_US.UTF-8', 17:00:21 INFO - 'LANGUAGE': 'en_US:en', 17:00:21 INFO - 'LOGNAME': 'cltbld', 17:00:21 INFO - 'MAIL': '/var/mail/cltbld', 17:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:21 INFO - 'MOZ_NO_REMOTE': '1', 17:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:21 INFO - 'NO_EM_RESTART': '1', 17:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:21 INFO - 'PWD': '/builds/slave/test', 17:00:21 INFO - 'SHELL': '/bin/bash', 17:00:21 INFO - 'SHLVL': '1', 17:00:21 INFO - 'TERM': 'linux', 17:00:21 INFO - 'TMOUT': '86400', 17:00:21 INFO - 'USER': 'cltbld', 17:00:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:21 INFO - '_': '/tools/buildbot/bin/python'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17: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 17: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 17: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 17: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 17: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 17: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 17:00:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:00:23 INFO - Installing collected packages: mozsystemmonitor 17:00:23 INFO - Running setup.py install for mozsystemmonitor 17:00:24 INFO - Successfully installed mozsystemmonitor 17:00:24 INFO - Cleaning up... 17:00:24 INFO - Return code: 0 17:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00:24 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')]} 17:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:24 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')]} 17:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:24 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:24 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 17:00:24 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 17:00:24 INFO - Using env: {'DISPLAY': ':0', 17:00:24 INFO - 'HOME': '/home/cltbld', 17:00:24 INFO - 'LANG': 'en_US.UTF-8', 17:00:24 INFO - 'LANGUAGE': 'en_US:en', 17:00:24 INFO - 'LOGNAME': 'cltbld', 17:00:24 INFO - 'MAIL': '/var/mail/cltbld', 17:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:24 INFO - 'MOZ_NO_REMOTE': '1', 17:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:24 INFO - 'NO_EM_RESTART': '1', 17:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:24 INFO - 'PWD': '/builds/slave/test', 17:00:24 INFO - 'SHELL': '/bin/bash', 17:00:24 INFO - 'SHLVL': '1', 17:00:24 INFO - 'TERM': 'linux', 17:00:24 INFO - 'TMOUT': '86400', 17:00:24 INFO - 'USER': 'cltbld', 17:00:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:24 INFO - '_': '/tools/buildbot/bin/python'} 17:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 17: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 17: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 17: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 17: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 17: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 17: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 17:00:25 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 INFO - Downloading docopt-0.6.1.tar.gz 17:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:26 INFO - Running setup.py install for blobuploader 17:00:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:26 INFO - Running setup.py install for requests 17:00:27 INFO - Running setup.py install for docopt 17:00:27 INFO - Successfully installed blobuploader requests docopt 17:00:27 INFO - Cleaning up... 17:00:27 INFO - Return code: 0 17:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:27 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 17:00:27 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 17:00:27 INFO - Using env: {'DISPLAY': ':0', 17:00:27 INFO - 'HOME': '/home/cltbld', 17:00:27 INFO - 'LANG': 'en_US.UTF-8', 17:00:27 INFO - 'LANGUAGE': 'en_US:en', 17:00:27 INFO - 'LOGNAME': 'cltbld', 17:00:27 INFO - 'MAIL': '/var/mail/cltbld', 17:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:27 INFO - 'MOZ_NO_REMOTE': '1', 17:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:27 INFO - 'NO_EM_RESTART': '1', 17:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:27 INFO - 'PWD': '/builds/slave/test', 17:00:27 INFO - 'SHELL': '/bin/bash', 17:00:27 INFO - 'SHLVL': '1', 17:00:27 INFO - 'TERM': 'linux', 17:00:27 INFO - 'TMOUT': '86400', 17:00:27 INFO - 'USER': 'cltbld', 17:00:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:27 INFO - '_': '/tools/buildbot/bin/python'} 17:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:27 INFO - Running setup.py (path:/tmp/pip-uD8B5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:27 INFO - Running setup.py (path:/tmp/pip-BzGCMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:27 INFO - Running setup.py (path:/tmp/pip-EuSZKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:27 INFO - Running setup.py (path:/tmp/pip-cnWkmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:27 INFO - Running setup.py (path:/tmp/pip-HoEGgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:27 INFO - Running setup.py (path:/tmp/pip-e7eDgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:28 INFO - Running setup.py (path:/tmp/pip-fzEEKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:28 INFO - Running setup.py (path:/tmp/pip-zyKPSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:28 INFO - Running setup.py (path:/tmp/pip-8klaZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:28 INFO - Running setup.py (path:/tmp/pip-gl18af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:28 INFO - Running setup.py (path:/tmp/pip-Agmn6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:28 INFO - Running setup.py (path:/tmp/pip-F3_y1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:28 INFO - Running setup.py (path:/tmp/pip-eYbTiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:28 INFO - Running setup.py (path:/tmp/pip-odhDmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:28 INFO - Running setup.py (path:/tmp/pip-MAJC3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:28 INFO - Running setup.py (path:/tmp/pip-Vq8j9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:28 INFO - Running setup.py (path:/tmp/pip-DVbx7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:28 INFO - Running setup.py install for manifestparser 17:00:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:28 INFO - Running setup.py install for mozcrash 17:00:29 INFO - Running setup.py install for mozdebug 17:00:29 INFO - Running setup.py install for mozdevice 17:00:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for mozfile 17:00:29 INFO - Running setup.py install for mozhttpd 17:00:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for mozinfo 17:00:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for mozInstall 17:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for mozleak 17:00:29 INFO - Running setup.py install for mozlog 17:00:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for moznetwork 17:00:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:29 INFO - Running setup.py install for mozprocess 17:00:30 INFO - Running setup.py install for mozprofile 17:00:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:30 INFO - Running setup.py install for mozrunner 17:00:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:30 INFO - Running setup.py install for mozscreenshot 17:00:30 INFO - Running setup.py install for moztest 17:00:30 INFO - Running setup.py install for mozversion 17:00:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:30 INFO - Cleaning up... 17:00:30 INFO - Return code: 0 17:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:30 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 17:00:30 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 17:00:30 INFO - Using env: {'DISPLAY': ':0', 17:00:30 INFO - 'HOME': '/home/cltbld', 17:00:30 INFO - 'LANG': 'en_US.UTF-8', 17:00:30 INFO - 'LANGUAGE': 'en_US:en', 17:00:30 INFO - 'LOGNAME': 'cltbld', 17:00:30 INFO - 'MAIL': '/var/mail/cltbld', 17:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:30 INFO - 'MOZ_NO_REMOTE': '1', 17:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:30 INFO - 'NO_EM_RESTART': '1', 17:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:30 INFO - 'PWD': '/builds/slave/test', 17:00:30 INFO - 'SHELL': '/bin/bash', 17:00:30 INFO - 'SHLVL': '1', 17:00:30 INFO - 'TERM': 'linux', 17:00:30 INFO - 'TMOUT': '86400', 17:00:30 INFO - 'USER': 'cltbld', 17:00:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:30 INFO - '_': '/tools/buildbot/bin/python'} 17:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:30 INFO - Running setup.py (path:/tmp/pip-CQW22d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:30 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)) 17:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:30 INFO - Running setup.py (path:/tmp/pip-99iX9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:30 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)) 17:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:30 INFO - Running setup.py (path:/tmp/pip-7511dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:31 INFO - Running setup.py (path:/tmp/pip-0of4S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:31 INFO - Running setup.py (path:/tmp/pip-qPfRC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:31 INFO - Running setup.py (path:/tmp/pip-2YezfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:31 INFO - Running setup.py (path:/tmp/pip-r7Ol4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:31 INFO - Running setup.py (path:/tmp/pip-Aswi2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:31 INFO - Running setup.py (path:/tmp/pip-XprxKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:31 INFO - Running setup.py (path:/tmp/pip-HzaV3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:31 INFO - Running setup.py (path:/tmp/pip-Nj6_hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:31 INFO - Running setup.py (path:/tmp/pip-ItgkGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:31 INFO - Running setup.py (path:/tmp/pip-9UCP13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:31 INFO - Running setup.py (path:/tmp/pip-7wsOM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:31 INFO - Running setup.py (path:/tmp/pip-XPzlCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:31 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)) 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:31 INFO - Running setup.py (path:/tmp/pip-bfEUQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:32 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)) 17:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:32 INFO - Running setup.py (path:/tmp/pip-Utf5Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:32 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)) 17:00:32 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)) 17:00:32 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)) 17:00:32 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)) 17:00:32 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:00:32 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:00:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:33 INFO - Downloading blessings-1.5.1.tar.gz 17:00:33 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 17:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:33 INFO - Installing collected packages: blessings 17:00:33 INFO - Running setup.py install for blessings 17:00:33 INFO - Successfully installed blessings 17:00:33 INFO - Cleaning up... 17:00:34 INFO - Return code: 0 17:00:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:34 INFO - Reading from file tmpfile_stdout 17:00:34 INFO - Current package versions: 17:00:34 INFO - argparse == 1.2.1 17:00:34 INFO - blessings == 1.5.1 17:00:34 INFO - blobuploader == 1.2.4 17:00:34 INFO - docopt == 0.6.1 17:00:34 INFO - manifestparser == 1.1 17:00:34 INFO - mozInstall == 1.12 17:00:34 INFO - mozcrash == 0.16 17:00:34 INFO - mozdebug == 0.1 17:00:34 INFO - mozdevice == 0.47 17:00:34 INFO - mozfile == 1.2 17:00:34 INFO - mozhttpd == 0.7 17:00:34 INFO - mozinfo == 0.9 17:00:34 INFO - mozleak == 0.1 17:00:34 INFO - mozlog == 3.1 17:00:34 INFO - moznetwork == 0.27 17:00:34 INFO - mozprocess == 0.22 17:00:34 INFO - mozprofile == 0.28 17:00:34 INFO - mozrunner == 6.11 17:00:34 INFO - mozscreenshot == 0.1 17:00:34 INFO - mozsystemmonitor == 0.0 17:00:34 INFO - moztest == 0.7 17:00:34 INFO - mozversion == 1.4 17:00:34 INFO - psutil == 3.1.1 17:00:34 INFO - requests == 1.2.3 17:00:34 INFO - wsgiref == 0.1.2 17:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:34 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')]} 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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')]} 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:34 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 17:00:34 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 17:00:34 INFO - Using env: {'DISPLAY': ':0', 17:00:34 INFO - 'HOME': '/home/cltbld', 17:00:34 INFO - 'LANG': 'en_US.UTF-8', 17:00:34 INFO - 'LANGUAGE': 'en_US:en', 17:00:34 INFO - 'LOGNAME': 'cltbld', 17:00:34 INFO - 'MAIL': '/var/mail/cltbld', 17:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:34 INFO - 'MOZ_NO_REMOTE': '1', 17:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:34 INFO - 'NO_EM_RESTART': '1', 17:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:34 INFO - 'PWD': '/builds/slave/test', 17:00:34 INFO - 'SHELL': '/bin/bash', 17:00:34 INFO - 'SHLVL': '1', 17:00:34 INFO - 'TERM': 'linux', 17:00:34 INFO - 'TMOUT': '86400', 17:00:34 INFO - 'USER': 'cltbld', 17:00:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:34 INFO - '_': '/tools/buildbot/bin/python'} 17:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 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)) 17:00:34 INFO - Cleaning up... 17:00:34 INFO - Return code: 0 17:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00:34 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')]} 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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')]} 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:34 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 17:00:34 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 17:00:34 INFO - Using env: {'DISPLAY': ':0', 17:00:34 INFO - 'HOME': '/home/cltbld', 17:00:34 INFO - 'LANG': 'en_US.UTF-8', 17:00:34 INFO - 'LANGUAGE': 'en_US:en', 17:00:34 INFO - 'LOGNAME': 'cltbld', 17:00:34 INFO - 'MAIL': '/var/mail/cltbld', 17:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:34 INFO - 'MOZ_NO_REMOTE': '1', 17:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:34 INFO - 'NO_EM_RESTART': '1', 17:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:34 INFO - 'PWD': '/builds/slave/test', 17:00:34 INFO - 'SHELL': '/bin/bash', 17:00:34 INFO - 'SHLVL': '1', 17:00:34 INFO - 'TERM': 'linux', 17:00:34 INFO - 'TMOUT': '86400', 17:00:34 INFO - 'USER': 'cltbld', 17:00:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:34 INFO - '_': '/tools/buildbot/bin/python'} 17:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 INFO - Downloading/unpacking jsonschema 17:00:34 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 17:00:34 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 17:00:34 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 17:00:34 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 17:00:34 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 17:00:34 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 17:00:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:36 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 17:00:36 INFO - Downloading/unpacking functools32 (from jsonschema) 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:36 INFO - warning: no files found matching '*.txt' 17:00:36 INFO - no previously-included directories found matching 'build' 17:00:36 INFO - no previously-included directories found matching 'dist' 17:00:36 INFO - no previously-included directories found matching '.git*' 17:00:36 INFO - Installing collected packages: jsonschema, functools32 17:00:36 INFO - Running setup.py install for functools32 17:00:36 INFO - warning: no files found matching '*.txt' 17:00:36 INFO - no previously-included directories found matching 'build' 17:00:36 INFO - no previously-included directories found matching 'dist' 17:00:36 INFO - no previously-included directories found matching '.git*' 17:00:36 INFO - Successfully installed jsonschema functools32 17:00:36 INFO - Cleaning up... 17:00:36 INFO - Return code: 0 17:00:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:36 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 0x7f9d2b29df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, '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': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', '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 17:00:36 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 17:00:36 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 17:00:36 INFO - Using env: {'DISPLAY': ':0', 17:00:36 INFO - 'HOME': '/home/cltbld', 17:00:36 INFO - 'LANG': 'en_US.UTF-8', 17:00:36 INFO - 'LANGUAGE': 'en_US:en', 17:00:36 INFO - 'LOGNAME': 'cltbld', 17:00:36 INFO - 'MAIL': '/var/mail/cltbld', 17:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:36 INFO - 'MOZ_NO_REMOTE': '1', 17:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:36 INFO - 'NO_EM_RESTART': '1', 17:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:36 INFO - 'PWD': '/builds/slave/test', 17:00:36 INFO - 'SHELL': '/bin/bash', 17:00:36 INFO - 'SHLVL': '1', 17:00:36 INFO - 'TERM': 'linux', 17:00:36 INFO - 'TMOUT': '86400', 17:00:36 INFO - 'USER': 'cltbld', 17:00:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:36 INFO - '_': '/tools/buildbot/bin/python'} 17:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:37 INFO - Downloading/unpacking flake8 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:38 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 17:00:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:38 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 17:00:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:39 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 17:00:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:39 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 17:00:39 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 17:00:39 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 17:00:39 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 17:00:39 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 17:00:39 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 17:00:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:39 INFO - no previously-included directories found matching 'docs/_build' 17:00:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:39 INFO - Running setup.py install for pep8 17:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:39 INFO - no previously-included directories found matching 'docs/_build' 17:00:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:00:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:39 INFO - Cleaning up... 17:00:39 INFO - Return code: 0 17:00:39 INFO - Running post-action listener: _resource_record_post_action 17:00:39 INFO - Running post-action listener: _start_resource_monitoring 17:00:39 INFO - Starting resource monitoring. 17:00:39 INFO - ##### 17:00:39 INFO - ##### Running install step. 17:00:39 INFO - ##### 17:00:39 INFO - Running pre-action listener: _resource_record_pre_action 17:00:39 INFO - Running main action method: install 17:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:39 INFO - Reading from file tmpfile_stdout 17:00:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:39 INFO - Reading from file tmpfile_stdout 17:00:39 INFO - Output received: 17:00:39 INFO - Usage: mozinstall [options] installer 17:00:39 INFO - Options: 17:00:39 INFO - -h, --help show this help message and exit 17:00:39 INFO - -d DEST, --destination=DEST 17:00:39 INFO - Directory to install application into. [default: 17:00:39 INFO - "/builds/slave/test"] 17:00:39 INFO - --app=APP Application being installed. [default: firefox] 17:00:39 INFO - mkdir: /builds/slave/test/build/application 17:00:39 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'] 17:00:39 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 17:00:55 INFO - Reading from file tmpfile_stdout 17:00:55 INFO - Output received: 17:00:55 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:55 INFO - Running post-action listener: _resource_record_post_action 17:00:55 INFO - ##### 17:00:55 INFO - ##### Running run-tests step. 17:00:55 INFO - ##### 17:00:55 INFO - Running pre-action listener: _resource_record_pre_action 17:00:55 INFO - Running main action method: run_tests 17:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:55 INFO - Python 2.7.3 17:00:55 INFO - Return code: 0 17:00:55 INFO - grabbing minidump binary from tooltool 17:00:55 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')]} 17:00:55 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 0x2a433d0>, '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 0x29aeed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:55 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 17:00:55 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 17:00:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:55 INFO - Return code: 0 17:00:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:00:56 INFO - Return code: 0 17:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 17:00:56 INFO - Using env: {'DISPLAY': ':0', 17:00:56 INFO - 'HOME': '/home/cltbld', 17:00:56 INFO - 'LANG': 'en_US.UTF-8', 17:00:56 INFO - 'LANGUAGE': 'en_US:en', 17:00:56 INFO - 'LOGNAME': 'cltbld', 17:00:56 INFO - 'MAIL': '/var/mail/cltbld', 17:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:56 INFO - 'MOZ_NO_REMOTE': '1', 17:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:56 INFO - 'NO_EM_RESTART': '1', 17:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:56 INFO - 'PWD': '/builds/slave/test', 17:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:56 INFO - 'SHELL': '/bin/bash', 17:00:56 INFO - 'SHLVL': '1', 17:00:56 INFO - 'TERM': 'linux', 17:00:56 INFO - 'TMOUT': '86400', 17:00:56 INFO - 'USER': 'cltbld', 17:00:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848', 17:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:56 INFO - '_': '/tools/buildbot/bin/python'} 17:00:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:00:56 INFO - mozversion application_buildid: 20160110153832 17:00:56 INFO - mozversion application_changeset: 359f86fecbc2a6531d9018fb81a74fd26502f5a1 17:00:56 INFO - mozversion application_display_name: Nightly 17:00:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:56 INFO - mozversion application_name: Firefox 17:00:56 INFO - mozversion application_remotingname: firefox 17:00:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:56 INFO - mozversion application_vendor: Mozilla 17:00:56 INFO - mozversion application_version: 46.0a1 17:00:56 INFO - mozversion platform_buildid: 20160110153832 17:00:56 INFO - mozversion platform_changeset: 359f86fecbc2a6531d9018fb81a74fd26502f5a1 17:00:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:56 INFO - mozversion platform_version: 46.0a1 17:00:56 INFO - using testdate: 1452474056 17:00:56 INFO - actual date: 1452474056 17:00:56 INFO - starting webserver on 'localhost:38861' 17:00:56 INFO - SUITE-START | Running 3 tests 17:00:56 INFO - TEST-START | dromaeo_css 17:00:56 INFO - operating with platform_type : linux_ 17:00:56 INFO - Initialising browser for dromaeo_css test... 17:00:56 INFO - TEST-INFO | started process 6598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp358h14/profile http://localhost:38861/getInfo.html) 17:01:00 INFO - PROCESS | 6598 | 17:01:00 INFO - PROCESS | 6598 | (process:6682): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:00 INFO - PROCESS | 6598 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:01:01 INFO - PROCESS | 6598 | __metrics Screen width/height:1600/1200 17:01:01 INFO - PROCESS | 6598 | colorDepth:24 17:01:01 INFO - PROCESS | 6598 | Browser inner width/height: 1024/697 17:01:01 INFO - PROCESS | 6598 | __metrics 17:01:02 INFO - PROCESS | 6598 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:01:03 INFO - TEST-INFO | 6598: exit 0 17:01:03 INFO - Browser initialized. 17:01:03 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:03 INFO - TEST-INFO | started process 6731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp358h14/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:04 INFO - PROCESS | 6731 | 17:01:04 INFO - PROCESS | 6731 | (process:6788): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:15 INFO - PROCESS | 6731 | RSS: Main: 150982656 17:01:15 INFO - PROCESS | 6731 | 17:02:04 INFO - PROCESS | 6731 | 1452474124694 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] 17:04:16 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38861/tests/dromaeo/cssquery-ext.html) 17:04:17 INFO - PROCESS | 6731 | RSS: Main: 154800128 17:04:17 INFO - PROCESS | 6731 | 17:07:19 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-ext.html (next: http://localhost:38861/tests/dromaeo/cssquery-jquery.html) 17:07:20 INFO - PROCESS | 6731 | RSS: Main: 153640960 17:07:20 INFO - PROCESS | 6731 | 17:10:21 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38861/tests/dromaeo/cssquery-mootools.html) 17:10:22 INFO - PROCESS | 6731 | RSS: Main: 153616384 17:10:22 INFO - PROCESS | 6731 | 17:13:24 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38861/tests/dromaeo/cssquery-prototype.html) 17:13:24 INFO - PROCESS | 6731 | RSS: Main: 153399296 17:13:24 INFO - PROCESS | 6731 | 17:16:27 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38861/tests/dromaeo/cssquery-yui.html) 17:16:28 INFO - PROCESS | 6731 | RSS: Main: 153096192 17:16:28 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | Cycle 1(1): loaded http://localhost:38861/tests/dromaeo/cssquery-yui.html (next: http://localhost:38861/tests/dromaeo/cssquery-dojo.html) 17:19:30 INFO - PROCESS | 6731 | RSS: Main: 156246016 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | __start_tp_report 17:19:30 INFO - PROCESS | 6731 | _x_x_mozilla_page_load 17:19:30 INFO - PROCESS | 6731 | _x_x_mozilla_page_load_details 17:19:30 INFO - PROCESS | 6731 | |i|pagename|runs| 17:19:30 INFO - PROCESS | 6731 | |0;dojo.html;2611.6213149093383;2661.188337557047;2685.5703087506004;2694.151342327168;2704.6889607695116;4429.114177164572;4527.796249168791;4578.313253012046;4597.333386658933;4618.237990731525;4521.796519156637;4531.954680453195;4560.680752347337;4616.699914505563;4667.509911459299;4191.601797829201;4274.935875961863;4318.611324980751;4329.480462344523;4360.89097772555;4015.3248154140824;4303.0963497665525;4309.159713855799;4328.761918094504;4370.781460926957;4122.299209134424;4228.133232687292;4288.592583704543;4353.238183317907;4363.847265345714;4205.264078786231;4212.957870421287;4241.27898257297;4287.421198138242;4306.181825453185;4152.211079894841;4178.770167640779;4188.895277618084;4192.664586833076;4227.8097485613225;4320.589543993316;4391.538888416702;4407.955920440819;4418.536053714378;4439.711418757803;4830.73430961297;4890.095332363524;4918.950810491885;4957.851264462072;4996.800127994876;4955.231939049453;4971.925421118686;4974.90050198994;5000.249962505617;5030.84907452777;4430.601245887821;4529.886752831139;4601.585857272861;4620.5379462053525;4674.205385084544;5001.974595208047;5008.373953255843;5043.218301163325;5047.873803154877;5088.084144853962;4792.616590672807;4798;4811.927821082687;4828.517148285144;4861.124997500413;4752.52474752522;4846.442659094178;4869.391326084239;4907.901841963141;4952.158133117378;4774.259989701602;4779.617630589544;4875.853724388274;4964.528369804862;4983.252512123138;4878.0975519529;4896.926546101811;4913.631477639191;4915.410150781858;4946.9010619787405;4066.755994640331;4174.3112386456505;4178.937315940263;4185.686073544496;4228.556001619847;3634.47300141478;3642.453631955228;3694.538182727159;3720.776753394805;3734.5705243896755;4264.296391095497;4265.850695225652;4275.1022285319805;4300.290452075373;4301.526832048472;4716.29255611661;4823.541763532529;4949.282354058641;4984.501549844987;5007.39911210657;4257.978710106429;4318.935215971763;4322.7190232634775;4365.781710914505;4379.1022840317655;4296.4414626098405;4364.498082720528;4366.956330436718;4389.604935555815;4390.824367025347;4481.641468682497;4617.561331673485;4641.628669706348;4666.580007799314;4709.788059537329;4899.877503062452;4900.68145570551;4909.140900342354;4917.754112294442;4930.531599498042;4645.2103142465185;4657.254839225708;4669.929951050805;4675.205215113371;4709.764511774466;4629.93055104167;4772.689775164603;4819.156647586588;4828.2998965150555;4956.454789973028;4921.532454416824;4928.112939670894;4933.186024305949;4939.456659767351;4954.628402869727;4759.9286010709175;4760.3811504505575;4762.571368576845;4763.118823017753;4800.879978000578;4644.674872758875;4752.025834703946;4764.571188593043;4781.330613714153;4889.90220195587;4626.1441633297945;4632.420947381577;4632.559906808848;4637.585536411427;4679.27471241958;4634.397528321297;4781.665283430127;4787.808487660454;4788.401449818773;4788.808447662054;4635.675502714777;4661.440627124631;4678.298255261738;4766.356541866804;4780.784864681028 17:19:30 INFO - PROCESS | 6731 | |1;ext.html;449.4135153624521;489.4738156481782;493.7605261448197;498.9625778066641;526.0714838310383;24998;25487.617685734705;33163.33673326532;33557.66442335576;33803.83098084512;37471.25057498848;37814.8109259454;38042.61957380425;38052.80973595135;38171.23657526848;7615.390768738502;7787.7663670089705;7806.453548251625;7810.687572497121;7817.921820781777;7438.330550250476;7525.849483010336;7544.849103017937;7552.848943021137;7570.242975702441;7551.546907185587;7618.885716714254;7775.611219439033;7792.103908050562;7792.76621701347;7657.655405506765;7682.846343073164;7705.15243323234;7709.0749110107145;7751.922480775176;7712.614369281569;7779.649915753805;7863.174366691473;7865.567393793339;7882.132965373804;35693.82153089218;35989;36008.45987310192;36165.63834361675;36196.45705314422;2990.7756918231003;3107.5027995520836;3307.9834600827085;3376.7805092668896;3747.194353214072;27494;27518.174454766387;28105.15684529447;28434.573481397794;28437.715622843712;3349.363620912043;3358.865645374182;3361.3277344531193;3386.6444023377685;3438.862445502177;163829;164079;164412;164743;165086;52294.73852630713;52529.474705253226;52935.20597191045;52951.73524132355;53113.2033019505;53717;54648;55762;63735;64957.35042649607;12624.81062784059;12654.936725316498;12700.682482938;12727.427265773062;12785.744285114246;9992.000799920095;10014.048665376778;10038.498075096217;10040;10048.54781534818;18479.722804157947;18670.43988680342;18715;18762.812371876105;18810.717839232424;7246.347828695337;7369.22623124575;7509.399248060142;7618.352440042548;7623.542587444771;835.4486039214089;868.934829887761;917.655879045358;946.8863736351682;1066.6799960011965;21679.566408671737;21847.563048738935;21875;22001.679899206098;22055.450907110448;934.1172591900724;946.1437399153776;948.6489998700525;971.4171497101682;1056.9048785609177;13841.377138028813;13946.794418493488;14291.57125286243;14635.85364146345;14707.191104489142;258999;261114;262567;265177;266503;45008;45139.32291015638;45891.54108458939;46255;46368;1244.1291096232674;1250.349818094604;1263.5261776833688;1267.3029833591672;1280.4558062823448;25522;26228.60657090107;26250;26327.288726232735;26384.472310554065;39373.409398859614;39758.60241397549;39771.2045759089;39832;39865.601343986185;245798;246070;246554;247727;248043;26620.866895665396;27350.452990940466;27643.72356276492;27653.723462765116;27692.584611230446;37029.25941481209;37307.440388393654;38078.23843523059;38351.42472862853;38359;31378.372432551678;31904.68095319017;32140.67859321377;32243.677563225006;32550.51174232341;31333.686663133078;32513;32854.83572582122;33214.833925830215;33215.335693286484;32429;32525;32533.34933301368;32652.183695407806;32668.83665581657;25192.118275860255;25450.109246176296;29430.26424339323;29841;30152.396952061274;21146.788532114482;21204.893975530023;21274.574508510053;21422.89288553547;21491.677624835953 17:19:30 INFO - PROCESS | 6731 | |2;jquery.html;326.5346880695009;329.4711987260447;330.349212052257;333.8063922924704;336.6150821430167;14405.279736013197;14852.925735371322;15175.392984280616;15326.15706136162;15786.526404207863;14801.925990370033;14954.626134346647;15335.76996345053;15361.30874110665;15386.923065384657;4431.6233120184825;5022.924656130161;5032.949670503303;5041.798328066891;5046.369203849519;3953.446517487554;5017.824376146836;5033.496650334974;5063.518965698253;5069.645124841262;3476.8609255629744;3629.201575653365;5029.698218106907;5194.71429071401;5226.05930932432;5163.122269214243;5184.7815763295785;5189.66267192635;5216.26972223889;5248.5276325130735;4854.101991131652;5056.823011194628;5065.290859279704;5068.873278168038;5089.185730283174;16908.915455422644;16996;17539.47381578542;18382.632347352977;18394.816051839443;1811.9275228990957;1843.2074208090517;1890.432870138953;1982.8017198280202;2073.3572592496375;8840.690575829814;8929.910700893039;11079.778404431947;11141.777164456666;12257.448414821354;1585.3341596529485;1755.4294854172445;1771.3091894161287;1778.3597904754408;1786.3747688308988;47780.28329575059;48318.27522587164;48600;48751;48751;9339.953300233592;9644.083812037845;9679.806403872024;9697.321187516805;9785.755356116155;12151.331676757687;12236.938815305866;12267;12271.631851044483;12272.570460033856;6629.502787290972;6656.2345330287635;6713.462922966151;6719.966400167968;6763.289854565298;6126.172966649535;6174.197354343996;6216.533759968021;6221.720022598994;6245.28179259391;4084.591540845892;4100.405441211008;4102.159057393227;4122.670186385082;4125.23683118624;1703.1143805221463;1715.8198389169206;1728.0927513055494;1776.5025792778042;1793.9103044847704;749.868772964729;801.1227705662291;864.3906046237513;881.7090360181253;910.6402970826487;14624.780628290584;14731.26343682833;15219.239038048274;15261.160636165117;15336.693266134615;825.5542007315983;844.4046946902419;897.9264531905135;907.3013779389964;927.1146055516965;8521.44610600309;8565.828683426296;8790.95604521986;8908.331875109392;9180.036096209935;417466;423390;425988;430515;430993;62770.37229627737;64563.67718161473;64856.351436485034;65526.67236663786;65757;1002.3534820041033;1005.9295849290626;1010.5957616953277;1014.7158795537262;1023.3961962442046;13879.861201387857;13956.2324072177;14036.29818509091;14063.859361406256;14077.014608977273;27790.86104569464;27904.32574045564;28157.577636335063;28476;28686;33365.83317083399;33470;33516;34498.82750586231;34983.82508087545;6341.8097457076365;6418.358164183544;6508.8047358579315;6632.403083722488;6850.657467126524;8147.75556733299;9729.173020293354;9773.462459564793;9964.601415943282;10001.399916005063;7942.44402891792;8010.3992200584025;8157.306628936607;8382.455140415854;8387.203215694499;8379.329653627574;8525.275351595184;8742.650293988423;8826.470411775314;9372.859407109036;8292.419530632798;8417.410781245255;8430.536320502431;8794.736157915273;8864.335174861782;6837.863242735217;6902.930970690229;6935.7225710971;6936.930630693629;6984.755533556301;6875.862482750417;8187.099419064018;8241.217084377215;8335.49987000782;8367.121452247426 17:19:30 INFO - PROCESS | 6731 | |3;mootools.html;1375.7523645743765;1398.2169984808509;1519.3618680154334;1712.6489069740705;1736.4530172995505;6296.370362963701;6429;7268.200497945222;7387.298206670364;7389.076365454318;7222.855542889139;7362.8527429451515;7384.335409813116;7457.769468037767;7475.514091584043;2123.6495978163584;2161.3623980925663;2161.4056134563043;2167.6315026445463;2170.1102547955343;2109.325015994882;2136.2523116909033;2156.094440335063;2165.6426689596196;2172.73927128744;2125.6067627488887;2133.349328454821;2134.3170185540635;2143.614149453098;2174.8912554372296;2104.71586335845;2125;2128.7764784697615;2129.957400851982;2132.1471411435396;2090.95818083639;2126.223928266187;2129.6805479178092;2133.5092928626505;2135.263334149716;7689.884651730228;7786.1435242123325;7789.649465774054;7831.569263690495;7834;4259.382389553497;4333.848315308981;4335.263005289077;4349.064951035542;4356.302991521341;2913.533834586477;2934.090431966076;2987.4473222453917;2995.3260516383857;2996;919.0992827029548;952.2001518724305;956.206348730552;966.7341481092756;992.7915137821067;10499.212559058102;10574.841377379345;10606.363618182857;10626.946865265625;10685.946570267177;4004.4994375703036;4009.8396064157105;4089.7137200395687;4133.91732165361;4136.945079004835;8861.91138088611;8952.14954579314;8958.776030599156;8978.595963181673;8978.82042359149;4483.14820184164;4487.506374298824;4498.370228168059;4505.36924830524;4510.233260345749;3233.3856567252146;3318.9170270742943;3855.614438556178;4011.13760541485;4089.5092588889524;3409.880654177092;3415.846286917095;3447.052060683332;3452.9813704956596;3483.581970163546;1071.185898716965;1089.8528698625742;1100.0484580837517;1101.5263436722287;1103.8399432082304;977.2816979520047;991.8710567626163;995.6515219673056;1081.853949716794;1229.6802831263758;6957.65211739411;6970.860582788316;6979.755708550177;6988.755393561201;7091.609961452066;453.215936429978;457.4190777712287;463.81215607678945;464.6422254863736;465.74849581226437;5031.949680503149;5111.233315002705;5133.024725302181;5145.331106956071;5170.276161337416;8846.248068914085;8973.102689731106;9051.864222036675;9295.256379489625;9353.438793672402;8778.429402088845;8805;8815.426997245288;8823.735287941372;8860.822783544292;6700.83247918806;6757.189137303555;6880.58716477013;6899.241083480813;6906.861862762717;6943.583384996714;6977.372036516738;7007.894881576678;7023.754168604074;7029.9648501757165;8011.75964721036;8071.152528984372;8279.54462504568;8330.291925186184;8399.664013439395;8398.244158025807;8482.533460659723;8531.957340213508;8560.571971401281;8609.569521523774;5463.125899856004;5729.570282228766;6352.460040896575;6679.265280819009;6733.293004234485;6639;6655.267920528641;6660.333966603301;6664.3335666434905;6702.262751097473;6107.725152368243;6245.843853903689;6420.036994450869;6430.5177111715875;6484.5460817742305;6203.751849925952;6348.809535713936;6367.90448143269;6415.935840641534;6445.806625801233;6694.631795251308;6746.797596072126;6755.695993680394;6757.189137303555;6764.661766911733;5735;5751.884962300815;5768.913466297925;5789.1605717171615;6059.484943779652;6207.255129384503;6208.906866397098;6228.28374736893;6246.3753624637175;6255.061740738925 17:19:30 INFO - PROCESS | 6731 | |4;prototype.html;301.64406000918905;304.99237519062035;308.2647884794764;308.79002278450645;316.2031680165981;5440.619156659035;5460.481254280847;5521.227028216048;5626.859328516784;5631.18347839563;5477.096279113942;5529.861753456165;5558.471945165213;5565.053940830058;5567.053600887849;4139.958600413987;4237.533871274158;4282.29342158545;4283.828646854122;4289.378040184171;4263.680223983198;4266.509351424579;4271.743695378287;4276.550962148961;4280.72175308604;4214.936775948363;4220.198162349144;4233.703640745149;4236.301010333292;4247.745135291892;4232.174725928445;4233.872983810491;4240.469941257343;4245.066085461193;4246.108317253381;3684.705223582107;3700;3701.1117331840433;3704.129529560551;3708.0915175782106;5133.897322053575;5305.549028332596;5344.278522399504;5368.892622147574;5378.865528361783;4876.171050921316;4879.804807807684;4881.975590122062;4883.926741098886;4883.975580122112;5847.941520584783;5852.76588936442;5858.2677165354335;5865;5869.4717475427415;4030.3349947258666;4033.9394909076386;4036.6770658347555;4037.596240375968;4042.403250715951;5875.059990401515;6028.608140470856;6058.454739073461;6117.265928088614;6121.296050954153;4116.958830411718;4129.463169787909;4135.110951145458;4146.460960075171;4152;4197.559256278047;4200.768957707355;4200.894977625523;4203.201391735561;4211.894702632459;4810.95189048112;4815.7351345676325;4816.927746083811;4820.301056346881;4820.927686084711;5685.943140568624;5692.288463942007;5780.1907732917425;5801.071828507418;5806.825795226066;1471.220253265771;1490.8434614365553;1492.6939977304626;1493.9028963117362;1494.7309484292714;979.7942432089199;1005.5776573839005;1006.5219020964983;1009.7936009818424;1019.5004447820514;5053.343065401475;5065.088284108896;5070.416902056237;5076.162433198481;5077.086124497552;5906.173135760997;5993.970030149909;6057.18228039209;6058.636481811105;6082.939170608326;5004.599632029429;5048.798048078036;5076.7207803571155;5085.949140508622;5090.821821236239;3247.220667039893;3282.2778988622463;3285.392202442508;3288.4245257079915;3293.440115180425;5599.496045355938;5669.092945128842;5671.404502527258;5716.771329146787;5726.226959360516;6211.3478084800445;6212.316645169028;6219.346968568235;6224.844378890473;6232.439080482688;5670.914936275959;5695.088785794253;5727.226824378822;5729.5702822288495;5744.3394009687745;6078.696065196634;6085.269767627736;6087.634741915499;6089.634621922699;6096.237970253718;5735.225744524602;5884.676342801015;5959.135925290722;5972.492338151305;5979.730912108878;5731.283589551306;5740.397258287987;5747.252857128547;5751.051076572486;5751.079827227623;4240.4275422818755;4295.269804133367;4311.417958575677;4312.353147027846;4315.676324275629;5886.293644762656;5999.730012149551;6011.909821352596;6016;6021.969890150521;5768.192453056659;5788.652680839163;5789.2763404574425;5796.507296879812;5803.535717142703;5766.798162064308;5781.653100813965;5791.420857914175;5801.1878337033695;5821.214136091743;5525.944740552543;5665.943340566541;5671.461211184931;5673.092305231144;5677.659340439587;5808.680522571299;5811.244538210175;5819.970900145472;5824.5631577631;5846;5467.07059799827;5628.74670639814;5652.265205523256;5680.9147862781265;5692.260006199168 17:19:30 INFO - PROCESS | 6731 | |5;yui.html;707.1832034000728;760.4524742185631;768.8001119708875;789.9684012639494;800.6037011679218;11148.331100133997;11324.490397932092;11339.716507087327;11353.943230283858;11362.318260904342;10924.508397122128;11002.669919902415;11011.174161937866;11040.723981900457;12411.193272437307;778.5873487051857;779.6374685771116;784.8822676598527;785.603270348476;786.5398741736092;782.8199514111758;785.1951749456824;785.7446329942763;785.9371250299962;788.1645455816824;810.84999275134;816.0166998766501;817.1093508076195;818.1613845808065;819.7090033038274;804.4248362420897;806.4757907360233;807.7213361390311;809.2595275323073;812.0336799208923;597.1699337920294;599.4964230046738;600.1208229943111;600.534585696089;602.6323942395136;11906.107041971887;11967.341796201206;11970.760584788342;12025.639230823002;12097.2136811107;11316.3210207387;11417.257878237888;11430.885691143065;11468.369239691814;11577.53689852405;9339.486328251944;9414.435133891988;9505.477198754066;9521.571529281198;9567.091126342986;3194.7763656544053;3203.9679603204136;3225.145336485833;3258.951115733266;3259.282957749291;38407.42388864169;38873.61126388728;38939.610603894165;38957.415638765444;39008.804955975036;9006.774830629287;9035.864462033074;9147.63409463614;9216.953915230515;9236.353455258202;15698.68602627941;15707.136107513968;15719.764203536955;15722.685546289238;15726.21368931549;6067.908981365283;6115.724792384353;6292.874142517216;6473.06140609609;6473.805785826433;3632.164602141522;3651.3245049665898;3662.2675464907124;3683.686886614614;3751.981240093782;2616.5682662360496;2625.7242989486213;2630.9605355919675;2632.1445530202377;2639.3533584271977;477.43424042509736;517.3791450259628;524.9842504724865;538.3190264315643;540.3084052412918;423.72669628090324;448.9685721999494;465.9510751371125;468.6250999200694;588.8498432899669;7477.1775104738435;7817.648205830751;7980.201979801974;7993.644258346922;8106.108328083906;484.30260424987904;492.9457759646436;599.2150283129115;623.5884316351187;624.3506752976944;3706.925861482809;3783.5838057813617;3818.4153576266094;3844.3488072533332;3856.7107466940092;48684.26973595399;49288;49370.259446108335;49547;49561;42810;43006.56993430088;43082.35376469355;43131.35302970458;43392.56607433885;40227;40733.79633101816;42070.78964605158;42915;42937.570624293985;7850.450468467153;8163.387745919199;8312.168783121639;8339.749807505785;8442.15578442151;30331.786728531493;30393;30663.693363066082;30840.691593083782;30972.845135774176;35652.46521302131;35790.64209357977;37077.44383834299;38988.415173772984;39215.411768822916;9266.583003764712;9959.950200248952;10074.597016119273;10094.19246460296;10252.487375631039;10743.194260430342;10836.891631083588;10998.12015038779;11046.779064418506;11489.310641361211;10266.127379172854;10327.32872363294;10468.371897686164;10823.729406764895;11079.723006924569;10297.845532316871;10474.21443391764;10571;10633.255672102878;10904.454777261264;10490.790184196121;10619.256652034283;10866.67399978002;11055.060319872578;11108.055815255793;8596.742097737078;8666.436681615674;8667.263282620796;8816.162464565856;8917;8767.956160219159;9112.681056163003;9147.725568232963;9242.353035287466;9287 17:19:30 INFO - PROCESS | 6731 | __end_tp_report 17:19:30 INFO - PROCESS | 6731 | __start_cc_report 17:19:30 INFO - PROCESS | 6731 | _x_x_mozilla_cycle_collect,328 17:19:30 INFO - PROCESS | 6731 | __end_cc_report 17:19:30 INFO - PROCESS | 6731 | __startTimestamp1452475170803__endTimestamp 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | ------- Summary: start ------- 17:19:30 INFO - PROCESS | 6731 | Number of tests: 6 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#0] dojo.html Cycles:165 Average:4538.00 Median:4641.63 stddev:454.85 (9.8%) stddev-sans-first:430.41 17:19:30 INFO - PROCESS | 6731 | Values: 2611.6 2661.2 2685.6 2694.2 2704.7 4429.1 4527.8 4578.3 4597.3 4618.2 4521.8 4532.0 4560.7 4616.7 4667.5 4191.6 4274.9 4318.6 4329.5 4360.9 4015.3 4303.1 4309.2 4328.8 4370.8 4122.3 4228.1 4288.6 4353.2 4363.8 4205.3 4213.0 4241.3 4287.4 4306.2 4152.2 4178.8 4188.9 4192.7 4227.8 4320.6 4391.5 4408.0 4418.5 4439.7 4830.7 4890.1 4919.0 4957.9 4996.8 4955.2 4971.9 4974.9 5000.2 5030.8 4430.6 4529.9 4601.6 4620.5 4674.2 5002.0 5008.4 5043.2 5047.9 5088.1 4792.6 4798.0 4811.9 4828.5 4861.1 4752.5 4846.4 4869.4 4907.9 4952.2 4774.3 4779.6 4875.9 4964.5 4983.3 4878.1 4896.9 4913.6 4915.4 4946.9 4066.8 4174.3 4178.9 4185.7 4228.6 3634.5 3642.5 3694.5 3720.8 3734.6 4264.3 4265.9 4275.1 4300.3 4301.5 4716.3 4823.5 4949.3 4984.5 5007.4 4258.0 4318.9 4322.7 4365.8 4379.1 4296.4 4364.5 4367.0 4389.6 4390.8 4481.6 4617.6 4641.6 4666.6 4709.8 4899.9 4900.7 4909.1 4917.8 4930.5 4645.2 4657.3 4669.9 4675.2 4709.8 4629.9 4772.7 4819.2 4828.3 4956.5 4921.5 4928.1 4933.2 4939.5 4954.6 4759.9 4760.4 4762.6 4763.1 4800.9 4644.7 4752.0 4764.6 4781.3 4889.9 4626.1 4632.4 4632.6 4637.6 4679.3 4634.4 4781.7 4787.8 4788.4 4788.8 4635.7 4661.4 4678.3 4766.4 4780.8 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#1] ext.html Cycles:180 Average:38191.02 Median:33215.08 stddev:59761.09 (179.9%) stddev-sans-first:59861.55 17:19:30 INFO - PROCESS | 6731 | Values: 449.4 489.5 493.8 499.0 526.1 24998.0 25487.6 33163.3 33557.7 33803.8 37471.3 37814.8 38042.6 38052.8 38171.2 7615.4 7787.8 7806.5 7810.7 7817.9 7438.3 7525.8 7544.8 7552.8 7570.2 7551.5 7618.9 7775.6 7792.1 7792.8 7657.7 7682.8 7705.2 7709.1 7751.9 7712.6 7779.6 7863.2 7865.6 7882.1 35693.8 35989.0 36008.5 36165.6 36196.5 2990.8 3107.5 3308.0 3376.8 3747.2 27494.0 27518.2 28105.2 28434.6 28437.7 3349.4 3358.9 3361.3 3386.6 3438.9 163829.0 164079.0 164412.0 164743.0 165086.0 52294.7 52529.5 52935.2 52951.7 53113.2 53717.0 54648.0 55762.0 63735.0 64957.4 12624.8 12654.9 12700.7 12727.4 12785.7 9992.0 10014.0 10038.5 10040.0 10048.5 18479.7 18670.4 18715.0 18762.8 18810.7 7246.3 7369.2 7509.4 7618.4 7623.5 835.4 868.9 917.7 946.9 1066.7 21679.6 21847.6 21875.0 22001.7 22055.5 934.1 946.1 948.6 971.4 1056.9 13841.4 13946.8 14291.6 14635.9 14707.2 258999.0 261114.0 262567.0 265177.0 266503.0 45008.0 45139.3 45891.5 46255.0 46368.0 1244.1 1250.3 1263.5 1267.3 1280.5 25522.0 26228.6 26250.0 26327.3 26384.5 39373.4 39758.6 39771.2 39832.0 39865.6 245798.0 246070.0 246554.0 247727.0 248043.0 26620.9 27350.5 27643.7 27653.7 27692.6 37029.3 37307.4 38078.2 38351.4 38359.0 31378.4 31904.7 32140.7 32243.7 32550.5 31333.7 32513.0 32854.8 33214.8 33215.3 32429.0 32525.0 32533.3 32652.2 32668.8 25192.1 25450.1 29430.3 29841.0 30152.4 21146.8 21204.9 21274.6 21422.9 21491.7 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#2] jquery.html Cycles:180 Average:22930.34 Median:5026.31 stddev:69534.52 (1383.4%) stddev-sans-first:69708.87 17:19:30 INFO - PROCESS | 6731 | Values: 326.5 329.5 330.3 333.8 336.6 14405.3 14852.9 15175.4 15326.2 15786.5 14801.9 14954.6 15335.8 15361.3 15386.9 4431.6 5022.9 5032.9 5041.8 5046.4 3953.4 5017.8 5033.5 5063.5 5069.6 3476.9 3629.2 5029.7 5194.7 5226.1 5163.1 5184.8 5189.7 5216.3 5248.5 4854.1 5056.8 5065.3 5068.9 5089.2 16908.9 16996.0 17539.5 18382.6 18394.8 1811.9 1843.2 1890.4 1982.8 2073.4 8840.7 8929.9 11079.8 11141.8 12257.4 1585.3 1755.4 1771.3 1778.4 1786.4 47780.3 48318.3 48600.0 48751.0 48751.0 9340.0 9644.1 9679.8 9697.3 9785.8 12151.3 12236.9 12267.0 12271.6 12272.6 6629.5 6656.2 6713.5 6720.0 6763.3 6126.2 6174.2 6216.5 6221.7 6245.3 4084.6 4100.4 4102.2 4122.7 4125.2 1703.1 1715.8 1728.1 1776.5 1793.9 749.9 801.1 864.4 881.7 910.6 14624.8 14731.3 15219.2 15261.2 15336.7 825.6 844.4 897.9 907.3 927.1 8521.4 8565.8 8791.0 8908.3 9180.0 417466.0 423390.0 425988.0 430515.0 430993.0 62770.4 64563.7 64856.4 65526.7 65757.0 1002.4 1005.9 1010.6 1014.7 1023.4 13879.9 13956.2 14036.3 14063.9 14077.0 27790.9 27904.3 28157.6 28476.0 28686.0 33365.8 33470.0 33516.0 34498.8 34983.8 6341.8 6418.4 6508.8 6632.4 6850.7 8147.8 9729.2 9773.5 9964.6 10001.4 7942.4 8010.4 8157.3 8382.5 8387.2 8379.3 8525.3 8742.7 8826.5 9372.9 8292.4 8417.4 8430.5 8794.7 8864.3 6837.9 6902.9 6935.7 6936.9 6984.8 6875.9 8187.1 8241.2 8335.5 8367.1 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#3] mootools.html Cycles:180 Average:5150.67 Median:6205.50 stddev:2761.94 (44.5%) stddev-sans-first:2755.11 17:19:30 INFO - PROCESS | 6731 | Values: 1375.8 1398.2 1519.4 1712.6 1736.5 6296.4 6429.0 7268.2 7387.3 7389.1 7222.9 7362.9 7384.3 7457.8 7475.5 2123.6 2161.4 2161.4 2167.6 2170.1 2109.3 2136.3 2156.1 2165.6 2172.7 2125.6 2133.3 2134.3 2143.6 2174.9 2104.7 2125.0 2128.8 2130.0 2132.1 2091.0 2126.2 2129.7 2133.5 2135.3 7689.9 7786.1 7789.6 7831.6 7834.0 4259.4 4333.8 4335.3 4349.1 4356.3 2913.5 2934.1 2987.4 2995.3 2996.0 919.1 952.2 956.2 966.7 992.8 10499.2 10574.8 10606.4 10626.9 10685.9 4004.5 4009.8 4089.7 4133.9 4136.9 8861.9 8952.1 8958.8 8978.6 8978.8 4483.1 4487.5 4498.4 4505.4 4510.2 3233.4 3318.9 3855.6 4011.1 4089.5 3409.9 3415.8 3447.1 3453.0 3483.6 1071.2 1089.9 1100.0 1101.5 1103.8 977.3 991.9 995.7 1081.9 1229.7 6957.7 6970.9 6979.8 6988.8 7091.6 453.2 457.4 463.8 464.6 465.7 5031.9 5111.2 5133.0 5145.3 5170.3 8846.2 8973.1 9051.9 9295.3 9353.4 8778.4 8805.0 8815.4 8823.7 8860.8 6700.8 6757.2 6880.6 6899.2 6906.9 6943.6 6977.4 7007.9 7023.8 7030.0 8011.8 8071.2 8279.5 8330.3 8399.7 8398.2 8482.5 8532.0 8560.6 8609.6 5463.1 5729.6 6352.5 6679.3 6733.3 6639.0 6655.3 6660.3 6664.3 6702.3 6107.7 6245.8 6420.0 6430.5 6484.5 6203.8 6348.8 6367.9 6415.9 6445.8 6694.6 6746.8 6755.7 6757.2 6764.7 5735.0 5751.9 5768.9 5789.2 6059.5 6207.3 6208.9 6228.3 6246.4 6255.1 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#4] prototype.html Cycles:180 Average:4814.62 Median:5463.78 stddev:1415.54 (25.9%) stddev-sans-first:1378.39 17:19:30 INFO - PROCESS | 6731 | Values: 301.6 305.0 308.3 308.8 316.2 5440.6 5460.5 5521.2 5626.9 5631.2 5477.1 5529.9 5558.5 5565.1 5567.1 4140.0 4237.5 4282.3 4283.8 4289.4 4263.7 4266.5 4271.7 4276.6 4280.7 4214.9 4220.2 4233.7 4236.3 4247.7 4232.2 4233.9 4240.5 4245.1 4246.1 3684.7 3700.0 3701.1 3704.1 3708.1 5133.9 5305.5 5344.3 5368.9 5378.9 4876.2 4879.8 4882.0 4883.9 4884.0 5847.9 5852.8 5858.3 5865.0 5869.5 4030.3 4033.9 4036.7 4037.6 4042.4 5875.1 6028.6 6058.5 6117.3 6121.3 4117.0 4129.5 4135.1 4146.5 4152.0 4197.6 4200.8 4200.9 4203.2 4211.9 4811.0 4815.7 4816.9 4820.3 4820.9 5685.9 5692.3 5780.2 5801.1 5806.8 1471.2 1490.8 1492.7 1493.9 1494.7 979.8 1005.6 1006.5 1009.8 1019.5 5053.3 5065.1 5070.4 5076.2 5077.1 5906.2 5994.0 6057.2 6058.6 6082.9 5004.6 5048.8 5076.7 5085.9 5090.8 3247.2 3282.3 3285.4 3288.4 3293.4 5599.5 5669.1 5671.4 5716.8 5726.2 6211.3 6212.3 6219.3 6224.8 6232.4 5670.9 5695.1 5727.2 5729.6 5744.3 6078.7 6085.3 6087.6 6089.6 6096.2 5735.2 5884.7 5959.1 5972.5 5979.7 5731.3 5740.4 5747.3 5751.1 5751.1 4240.4 4295.3 4311.4 4312.4 4315.7 5886.3 5999.7 6011.9 6016.0 6022.0 5768.2 5788.7 5789.3 5796.5 5803.5 5766.8 5781.7 5791.4 5801.2 5821.2 5525.9 5665.9 5671.5 5673.1 5677.7 5808.7 5811.2 5820.0 5824.6 5846.0 5467.1 5628.7 5652.3 5680.9 5692.3 17:19:30 INFO - PROCESS | 6731 | 17:19:30 INFO - PROCESS | 6731 | [#5] yui.html Cycles:180 Average:12053.88 Median:43044.46 stddev:13511.98 (31.4%) stddev-sans-first:13523.02 17:19:30 INFO - PROCESS | 6731 | Values: 707.2 760.5 768.8 790.0 800.6 11148.3 11324.5 11339.7 11353.9 11362.3 10924.5 11002.7 11011.2 11040.7 12411.2 778.6 779.6 784.9 785.6 786.5 782.8 785.2 785.7 785.9 788.2 810.8 816.0 817.1 818.2 819.7 804.4 806.5 807.7 809.3 812.0 597.2 599.5 600.1 600.5 602.6 11906.1 11967.3 11970.8 12025.6 12097.2 11316.3 11417.3 11430.9 11468.4 11577.5 9339.5 9414.4 9505.5 9521.6 9567.1 3194.8 3204.0 3225.1 3259.0 3259.3 38407.4 38873.6 38939.6 38957.4 39008.8 9006.8 9035.9 9147.6 9217.0 9236.4 15698.7 15707.1 15719.8 15722.7 15726.2 6067.9 6115.7 6292.9 6473.1 6473.8 3632.2 3651.3 3662.3 3683.7 3752.0 2616.6 2625.7 2631.0 2632.1 2639.4 477.4 517.4 525.0 538.3 540.3 423.7 449.0 466.0 468.6 588.8 7477.2 7817.6 7980.2 7993.6 8106.1 484.3 492.9 599.2 623.6 624.4 3706.9 3783.6 3818.4 3844.3 3856.7 48684.3 49288.0 49370.3 49547.0 49561.0 42810.0 43006.6 43082.4 43131.4 43392.6 40227.0 40733.8 42070.8 42915.0 42937.6 7850.5 8163.4 8312.2 8339.7 8442.2 30331.8 30393.0 30663.7 30840.7 30972.8 35652.5 35790.6 37077.4 38988.4 39215.4 9266.6 9960.0 10074.6 10094.2 10252.5 10743.2 10836.9 10998.1 11046.8 11489.3 10266.1 10327.3 10468.4 10823.7 11079.7 10297.8 10474.2 10571.0 10633.3 10904.5 10490.8 10619.3 10866.7 11055.1 11108.1 8596.7 8666.4 8667.3 8816.2 8917.0 8768.0 9112.7 9147.7 9242.4 9287.0 17:19:30 INFO - PROCESS | 6731 | -------- Summary: end -------- 17:19:30 INFO - PROCESS | 6731 | 17:19:31 INFO - TEST-INFO | 6731: exit 0 17:19:31 INFO - TEST-OK | dromaeo_css | took 1114587ms 17:19:31 INFO - TEST-START | kraken 17:19:31 INFO - operating with platform_type : linux_ 17:19:31 INFO - Initialising browser for kraken test... 17:19:31 INFO - TEST-INFO | started process 6977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp11L1hM/profile http://localhost:38861/getInfo.html) 17:19:35 INFO - PROCESS | 6977 | 17:19:35 INFO - PROCESS | 6977 | (process:7049): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:35 INFO - PROCESS | 6977 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:19:36 INFO - PROCESS | 6977 | __metrics Screen width/height:1600/1200 17:19:36 INFO - PROCESS | 6977 | colorDepth:24 17:19:36 INFO - PROCESS | 6977 | Browser inner width/height: 1024/697 17:19:36 INFO - PROCESS | 6977 | __metrics 17:19:36 INFO - PROCESS | 6977 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:19:37 INFO - TEST-INFO | 6977: exit 0 17:19:37 INFO - Browser initialized. 17:19:37 INFO - Running cycle 1/1 for kraken test... 17:19:37 INFO - TEST-INFO | started process 7098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp11L1hM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:38 INFO - PROCESS | 7098 | 17:19:38 INFO - PROCESS | 7098 | (process:7156): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:49 INFO - PROCESS | 7098 | RSS: Main: 150786048 17:19:49 INFO - PROCESS | 7098 | 17:19:51 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38861/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:52 INFO - PROCESS | 7098 | RSS: Main: 150122496 17:19:52 INFO - PROCESS | 7098 | 17:19:55 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38861/tests/kraken/driver.html?testName=audio-dft) 17:19:55 INFO - PROCESS | 7098 | RSS: Main: 150224896 17:19:55 INFO - PROCESS | 7098 | 17:19:58 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38861/tests/kraken/driver.html?testName=audio-fft) 17:19:59 INFO - PROCESS | 7098 | RSS: Main: 145440768 17:19:59 INFO - PROCESS | 7098 | 17:20:01 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38861/tests/kraken/driver.html?testName=audio-oscillator) 17:20:01 INFO - PROCESS | 7098 | RSS: Main: 146386944 17:20:01 INFO - PROCESS | 7098 | 17:20:04 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38861/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:04 INFO - PROCESS | 7098 | RSS: Main: 147288064 17:20:04 INFO - PROCESS | 7098 | 17:20:07 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38861/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:08 INFO - PROCESS | 7098 | RSS: Main: 148119552 17:20:08 INFO - PROCESS | 7098 | 17:20:11 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38861/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:12 INFO - PROCESS | 7098 | RSS: Main: 147148800 17:20:12 INFO - PROCESS | 7098 | 17:20:15 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38861/tests/kraken/driver.html?testName=json-parse-financial) 17:20:15 INFO - PROCESS | 7098 | RSS: Main: 145821696 17:20:15 INFO - PROCESS | 7098 | 17:20:17 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38861/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:18 INFO - PROCESS | 7098 | RSS: Main: 147247104 17:20:18 INFO - PROCESS | 7098 | 17:20:20 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:20 INFO - PROCESS | 7098 | RSS: Main: 147628032 17:20:20 INFO - PROCESS | 7098 | 17:20:22 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:23 INFO - PROCESS | 7098 | RSS: Main: 148529152 17:20:23 INFO - PROCESS | 7098 | 17:20:26 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:26 INFO - PROCESS | 7098 | RSS: Main: 148393984 17:20:26 INFO - PROCESS | 7098 | 17:20:29 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:29 INFO - PROCESS | 7098 | RSS: Main: 147779584 17:20:29 INFO - PROCESS | 7098 | 17:20:31 INFO - PROCESS | 7098 | Cycle 1(1): loaded http://localhost:38861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38861/tests/kraken/driver.html?testName=ai-astar) 17:20:32 INFO - PROCESS | 7098 | RSS: Main: 148418560 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | __start_tp_report 17:20:32 INFO - PROCESS | 7098 | _x_x_mozilla_page_load 17:20:32 INFO - PROCESS | 7098 | _x_x_mozilla_page_load_details 17:20:32 INFO - PROCESS | 7098 | |i|pagename|runs| 17:20:32 INFO - PROCESS | 7098 | |0;ai-astar;115;109;114;114;115;123;113;113;114;113 17:20:32 INFO - PROCESS | 7098 | |1;audio-beat-detection;156;141;164;168;134;155;160;135;167;142 17:20:32 INFO - PROCESS | 7098 | |2;audio-dft;164;164;164;161;162;165;168;164;165;163 17:20:32 INFO - PROCESS | 7098 | |3;audio-fft;79;73;71;74;72;73;131;72;74;73 17:20:32 INFO - PROCESS | 7098 | |4;audio-oscillator;97;98;143;106;98;97;138;98;98;132 17:20:32 INFO - PROCESS | 7098 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;111;110;110 17:20:32 INFO - PROCESS | 7098 | |6;imaging-darkroom;147;148;148;148;150;147;148;148;150;148 17:20:32 INFO - PROCESS | 7098 | |7;imaging-desaturate;96;98;97;96;96;95;96;98;96;97 17:20:32 INFO - PROCESS | 7098 | |8;json-parse-financial;74;71;71;71;73;71;72;73;72;70 17:20:32 INFO - PROCESS | 7098 | |9;json-stringify-tinderbox;68;69;68;69;71;69;68;69;68;70 17:20:32 INFO - PROCESS | 7098 | |10;stanford-crypto-aes;85;85;85;86;86;84;85;86;87;88 17:20:32 INFO - PROCESS | 7098 | |11;stanford-crypto-ccm;121;125;125;122;125;131;125;122;126;128 17:20:32 INFO - PROCESS | 7098 | |12;stanford-crypto-pbkdf2;139;148;149;141;147;150;148;148;146;136 17:20:32 INFO - PROCESS | 7098 | |13;stanford-crypto-sha256-iterative;71;72;71;72;71;78;71;70;73;71 17:20:32 INFO - PROCESS | 7098 | __end_tp_report 17:20:32 INFO - PROCESS | 7098 | __start_cc_report 17:20:32 INFO - PROCESS | 7098 | _x_x_mozilla_cycle_collect,817 17:20:32 INFO - PROCESS | 7098 | __end_cc_report 17:20:32 INFO - PROCESS | 7098 | __startTimestamp1452475232015__endTimestamp 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | ------- Summary: start ------- 17:20:32 INFO - PROCESS | 7098 | Number of tests: 14 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:3.70 17:20:32 INFO - PROCESS | 7098 | Values: 115.0 109.0 114.0 114.0 115.0 123.0 113.0 113.0 114.0 113.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:158.00 stddev:13.11 (8.3%) stddev-sans-first:13.84 17:20:32 INFO - PROCESS | 7098 | Values: 156.0 141.0 164.0 168.0 134.0 155.0 160.0 135.0 167.0 142.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.89 (1.1%) stddev-sans-first:2.00 17:20:32 INFO - PROCESS | 7098 | Values: 164.0 164.0 164.0 161.0 162.0 165.0 168.0 164.0 165.0 163.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:18.33 (25.1%) stddev-sans-first:19.44 17:20:32 INFO - PROCESS | 7098 | Values: 79.0 73.0 71.0 74.0 72.0 73.0 131.0 72.0 74.0 73.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:97.50 stddev:19.10 (19.6%) stddev-sans-first:19.63 17:20:32 INFO - PROCESS | 7098 | Values: 97.0 98.0 143.0 106.0 98.0 97.0 138.0 98.0 98.0 132.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:20:32 INFO - PROCESS | 7098 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 17:20:32 INFO - PROCESS | 7098 | Values: 147.0 148.0 148.0 148.0 150.0 147.0 148.0 148.0 150.0 148.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 17:20:32 INFO - PROCESS | 7098 | Values: 96.0 98.0 97.0 96.0 96.0 95.0 96.0 98.0 96.0 97.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#8] json-parse-financial Cycles:10 Average:71.80 Median:72.00 stddev:1.23 (1.7%) stddev-sans-first:1.01 17:20:32 INFO - PROCESS | 7098 | Values: 74.0 71.0 71.0 71.0 73.0 71.0 72.0 73.0 72.0 70.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 17:20:32 INFO - PROCESS | 7098 | Values: 68.0 69.0 68.0 69.0 71.0 69.0 68.0 69.0 68.0 70.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 17:20:32 INFO - PROCESS | 7098 | Values: 85.0 85.0 85.0 86.0 86.0 84.0 85.0 86.0 87.0 88.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:125.00 stddev:2.98 (2.4%) stddev-sans-first:2.79 17:20:32 INFO - PROCESS | 7098 | Values: 121.0 125.0 125.0 122.0 125.0 131.0 125.0 122.0 126.0 128.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:148.00 stddev:4.78 (3.2%) stddev-sans-first:4.51 17:20:32 INFO - PROCESS | 7098 | Values: 139.0 148.0 149.0 141.0 147.0 150.0 148.0 148.0 146.0 136.0 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - PROCESS | 7098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.50 stddev:2.26 (3.2%) stddev-sans-first:2.37 17:20:32 INFO - PROCESS | 7098 | Values: 71.0 72.0 71.0 72.0 71.0 78.0 71.0 70.0 73.0 71.0 17:20:32 INFO - PROCESS | 7098 | -------- Summary: end -------- 17:20:32 INFO - PROCESS | 7098 | 17:20:32 INFO - TEST-INFO | 7098: exit 0 17:20:32 INFO - TEST-OK | kraken | took 61450ms 17:20:32 INFO - TEST-START | v8_7 17:20:32 INFO - operating with platform_type : linux_ 17:20:32 INFO - Initialising browser for v8_7 test... 17:20:32 INFO - TEST-INFO | started process 7384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMj4ELy/profile http://localhost:38861/getInfo.html) 17:20:36 INFO - PROCESS | 7384 | 17:20:36 INFO - PROCESS | 7384 | (process:7455): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:20:36 INFO - PROCESS | 7384 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:20:37 INFO - PROCESS | 7384 | __metrics Screen width/height:1600/1200 17:20:37 INFO - PROCESS | 7384 | colorDepth:24 17:20:37 INFO - PROCESS | 7384 | Browser inner width/height: 1024/697 17:20:37 INFO - PROCESS | 7384 | __metrics 17:20:37 INFO - PROCESS | 7384 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:20:38 INFO - TEST-INFO | 7384: exit 0 17:20:38 INFO - Browser initialized. 17:20:38 INFO - Running cycle 1/1 for v8_7 test... 17:20:38 INFO - TEST-INFO | started process 7504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMj4ELy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:40 INFO - PROCESS | 7504 | 17:20:40 INFO - PROCESS | 7504 | (process:7562): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:20:50 INFO - PROCESS | 7504 | RSS: Main: 150798336 17:20:50 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | Cycle 1(1): loaded http://localhost:38861/tests/v8_7/run.html (next: http://localhost:38861/tests/v8_7/run.html) 17:21:13 INFO - PROCESS | 7504 | RSS: Main: 146575360 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | __start_tp_report 17:21:13 INFO - PROCESS | 7504 | _x_x_mozilla_page_load 17:21:13 INFO - PROCESS | 7504 | _x_x_mozilla_page_load_details 17:21:13 INFO - PROCESS | 7504 | |i|pagename|runs| 17:21:13 INFO - PROCESS | 7504 | |0;Richards;166.91704223001167 17:21:13 INFO - PROCESS | 7504 | |1;DeltaBlue;186.28912071535024 17:21:13 INFO - PROCESS | 7504 | |2;Encrypt;278.31895352073474 17:21:13 INFO - PROCESS | 7504 | |3;Decrypt;5170.103092783505 17:21:13 INFO - PROCESS | 7504 | |4;RayTrace;1090.5125408942204 17:21:13 INFO - PROCESS | 7504 | |5;Earley;757.002271006813 17:21:13 INFO - PROCESS | 7504 | |6;Boyer;12456.79012345679 17:21:13 INFO - PROCESS | 7504 | |7;RegExp;43000 17:21:13 INFO - PROCESS | 7504 | |8;Splay;616.9031462060457 17:21:13 INFO - PROCESS | 7504 | |9;NavierStokes;4830.917874396136 17:21:13 INFO - PROCESS | 7504 | __end_tp_report 17:21:13 INFO - PROCESS | 7504 | __startTimestamp1452475273371__endTimestamp 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | ------- Summary: start ------- 17:21:13 INFO - PROCESS | 7504 | Number of tests: 10 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 166.9 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 186.3 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 278.3 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 5170.1 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#4] RayTrace Cycles:1 Average:1090.51 Median:1090.51 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 1090.5 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#5] Earley Cycles:1 Average:757.00 Median:757.00 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 757.0 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 12456.8 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#7] RegExp Cycles:1 Average:43000.00 Median:43000.00 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 43000.0 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#8] Splay Cycles:1 Average:616.90 Median:616.90 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 616.9 17:21:13 INFO - PROCESS | 7504 | 17:21:13 INFO - PROCESS | 7504 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:21:13 INFO - PROCESS | 7504 | Values: 4830.9 17:21:13 INFO - PROCESS | 7504 | -------- Summary: end -------- 17:21:13 INFO - PROCESS | 7504 | 17:21:14 INFO - TEST-INFO | 7504: exit 0 17:21:14 INFO - TEST-OK | v8_7 | took 41348ms 17:21:14 INFO - SUITE-END | took 1217s 17:21:14 INFO - Completed test suite (00:20:17) 17:21:14 INFO - Working with test: dromaeo_css 17:21:14 INFO - Generating results file: dromaeo_css 17:21:14 INFO - Working with test: kraken 17:21:14 INFO - Generating results file: kraken 17:21:14 INFO - javascript benchmark 17:21:14 INFO - Working with test: v8_7 17:21:14 INFO - Generating results file: v8_7 17:21:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 17:21:14 INFO - process_Request line: dromaeo_css 6167.09 graph.html#tests=[[72,94,43]] 17:21:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:14 INFO - process_Request line: kraken 1543.60 graph.html#tests=[[232,94,43]] 17:21:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:14 INFO - process_Request line: v8_7 20096.20 graph.html#tests=[[230,94,43]] 17:21:14 INFO - RETURN: dromaeo_css: 6167.09 17:21:14 INFO - RETURN: kraken: 1543.60 17:21:14 INFO - RETURN: v8_7: 20096.20 17:21:14 INFO - javascript benchmark 17:21:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.6213149093383, 2661.188337557047, 2685.5703087506004, 2694.151342327168, 2704.6889607695116, 4429.114177164572, 4527.796249168791, 4578.313253012046, 4597.333386658933, 4618.237990731525, 4521.796519156637, 4531.954680453195, 4560.680752347337, 4616.699914505563, 4667.509911459299, 4191.601797829201, 4274.935875961863, 4318.611324980751, 4329.480462344523, 4360.89097772555, 4015.3248154140824, 4303.0963497665525, 4309.159713855799, 4328.761918094504, 4370.781460926957, 4122.299209134424, 4228.133232687292, 4288.592583704543, 4353.238183317907, 4363.847265345714, 4205.264078786231, 4212.957870421287, 4241.27898257297, 4287.421198138242, 4306.181825453185, 4152.211079894841, 4178.770167640779, 4188.895277618084, 4192.664586833076, 4227.8097485613225, 4320.589543993316, 4391.538888416702, 4407.955920440819, 4418.536053714378, 4439.711418757803, 4830.73430961297, 4890.095332363524, 4918.950810491885, 4957.851264462072, 4996.800127994876, 4955.231939049453, 4971.925421118686, 4974.90050198994, 5000.249962505617, 5030.84907452777, 4430.601245887821, 4529.886752831139, 4601.585857272861, 4620.5379462053525, 4674.205385084544, 5001.974595208047, 5008.373953255843, 5043.218301163325, 5047.873803154877, 5088.084144853962, 4792.616590672807, 4798.0, 4811.927821082687, 4828.517148285144, 4861.124997500413, 4752.52474752522, 4846.442659094178, 4869.391326084239, 4907.901841963141, 4952.158133117378, 4774.259989701602, 4779.617630589544, 4875.853724388274, 4964.528369804862, 4983.252512123138, 4878.0975519529, 4896.926546101811, 4913.631477639191, 4915.410150781858, 4946.9010619787405, 4066.755994640331, 4174.3112386456505, 4178.937315940263, 4185.686073544496, 4228.556001619847, 3634.47300141478, 3642.453631955228, 3694.538182727159, 3720.776753394805, 3734.5705243896755, 4264.296391095497, 4265.850695225652, 4275.1022285319805, 4300.290452075373, 4301.526832048472, 4716.29255611661, 4823.541763532529, 4949.282354058641, 4984.501549844987, 5007.39911210657, 4257.978710106429, 4318.935215971763, 4322.7190232634775, 4365.781710914505, 4379.1022840317655, 4296.4414626098405, 4364.498082720528, 4366.956330436718, 4389.604935555815, 4390.824367025347, 4481.641468682497, 4617.561331673485, 4641.628669706348, 4666.580007799314, 4709.788059537329, 4899.877503062452, 4900.68145570551, 4909.140900342354, 4917.754112294442, 4930.531599498042, 4645.2103142465185, 4657.254839225708, 4669.929951050805, 4675.205215113371, 4709.764511774466, 4629.93055104167, 4772.689775164603, 4819.156647586588, 4828.2998965150555, 4956.454789973028, 4921.532454416824, 4928.112939670894, 4933.186024305949, 4939.456659767351, 4954.628402869727, 4759.9286010709175, 4760.3811504505575, 4762.571368576845, 4763.118823017753, 4800.879978000578, 4644.674872758875, 4752.025834703946, 4764.571188593043, 4781.330613714153, 4889.90220195587, 4626.1441633297945, 4632.420947381577, 4632.559906808848, 4637.585536411427, 4679.27471241958, 4634.397528321297, 4781.665283430127, 4787.808487660454, 4788.401449818773, 4788.808447662054, 4635.675502714777, 4661.440627124631, 4678.298255261738, 4766.356541866804, 4780.784864681028], "unit": "score", "name": "dojo.html", "value": 4510.981607511662}, {"lowerIsBetter": false, "replicates": [449.4135153624521, 489.4738156481782, 493.7605261448197, 498.9625778066641, 526.0714838310383, 24998.0, 25487.617685734705, 33163.33673326532, 33557.66442335576, 33803.83098084512, 37471.25057498848, 37814.8109259454, 38042.61957380425, 38052.80973595135, 38171.23657526848, 7615.390768738502, 7787.7663670089705, 7806.453548251625, 7810.687572497121, 7817.921820781777, 7438.330550250476, 7525.849483010336, 7544.849103017937, 7552.848943021137, 7570.242975702441, 7551.546907185587, 7618.885716714254, 7775.611219439033, 7792.103908050562, 7792.76621701347, 7657.655405506765, 7682.846343073164, 7705.15243323234, 7709.0749110107145, 7751.922480775176, 7712.614369281569, 7779.649915753805, 7863.174366691473, 7865.567393793339, 7882.132965373804, 35693.82153089218, 35989.0, 36008.45987310192, 36165.63834361675, 36196.45705314422, 2990.7756918231003, 3107.5027995520836, 3307.9834600827085, 3376.7805092668896, 3747.194353214072, 27494.0, 27518.174454766387, 28105.15684529447, 28434.573481397794, 28437.715622843712, 3349.363620912043, 3358.865645374182, 3361.3277344531193, 3386.6444023377685, 3438.862445502177, 163829.0, 164079.0, 164412.0, 164743.0, 165086.0, 52294.73852630713, 52529.474705253226, 52935.20597191045, 52951.73524132355, 53113.2033019505, 53717.0, 54648.0, 55762.0, 63735.0, 64957.35042649607, 12624.81062784059, 12654.936725316498, 12700.682482938, 12727.427265773062, 12785.744285114246, 9992.000799920095, 10014.048665376778, 10038.498075096217, 10040.0, 10048.54781534818, 18479.722804157947, 18670.43988680342, 18715.0, 18762.812371876105, 18810.717839232424, 7246.347828695337, 7369.22623124575, 7509.399248060142, 7618.352440042548, 7623.542587444771, 835.4486039214089, 868.934829887761, 917.655879045358, 946.8863736351682, 1066.6799960011965, 21679.566408671737, 21847.563048738935, 21875.0, 22001.679899206098, 22055.450907110448, 934.1172591900724, 946.1437399153776, 948.6489998700525, 971.4171497101682, 1056.9048785609177, 13841.377138028813, 13946.794418493488, 14291.57125286243, 14635.85364146345, 14707.191104489142, 258999.0, 261114.0, 262567.0, 265177.0, 266503.0, 45008.0, 45139.32291015638, 45891.54108458939, 46255.0, 46368.0, 1244.1291096232674, 1250.349818094604, 1263.5261776833688, 1267.3029833591672, 1280.4558062823448, 25522.0, 26228.60657090107, 26250.0, 26327.288726232735, 26384.472310554065, 39373.409398859614, 39758.60241397549, 39771.2045759089, 39832.0, 39865.601343986185, 245798.0, 246070.0, 246554.0, 247727.0, 248043.0, 26620.866895665396, 27350.452990940466, 27643.72356276492, 27653.723462765116, 27692.584611230446, 37029.25941481209, 37307.440388393654, 38078.23843523059, 38351.42472862853, 38359.0, 31378.372432551678, 31904.68095319017, 32140.67859321377, 32243.677563225006, 32550.51174232341, 31333.686663133078, 32513.0, 32854.83572582122, 33214.833925830215, 33215.335693286484, 32429.0, 32525.0, 32533.34933301368, 32652.183695407806, 32668.83665581657, 25192.118275860255, 25450.109246176296, 29430.26424339323, 29841.0, 30152.396952061274, 21146.788532114482, 21204.893975530023, 21274.574508510053, 21422.89288553547, 21491.677624835953], "unit": "score", "name": "ext.html", "value": 16214.122027592575}, {"lowerIsBetter": false, "replicates": [326.5346880695009, 329.4711987260447, 330.349212052257, 333.8063922924704, 336.6150821430167, 14405.279736013197, 14852.925735371322, 15175.392984280616, 15326.15706136162, 15786.526404207863, 14801.925990370033, 14954.626134346647, 15335.76996345053, 15361.30874110665, 15386.923065384657, 4431.6233120184825, 5022.924656130161, 5032.949670503303, 5041.798328066891, 5046.369203849519, 3953.446517487554, 5017.824376146836, 5033.496650334974, 5063.518965698253, 5069.645124841262, 3476.8609255629744, 3629.201575653365, 5029.698218106907, 5194.71429071401, 5226.05930932432, 5163.122269214243, 5184.7815763295785, 5189.66267192635, 5216.26972223889, 5248.5276325130735, 4854.101991131652, 5056.823011194628, 5065.290859279704, 5068.873278168038, 5089.185730283174, 16908.915455422644, 16996.0, 17539.47381578542, 18382.632347352977, 18394.816051839443, 1811.9275228990957, 1843.2074208090517, 1890.432870138953, 1982.8017198280202, 2073.3572592496375, 8840.690575829814, 8929.910700893039, 11079.778404431947, 11141.777164456666, 12257.448414821354, 1585.3341596529485, 1755.4294854172445, 1771.3091894161287, 1778.3597904754408, 1786.3747688308988, 47780.28329575059, 48318.27522587164, 48600.0, 48751.0, 48751.0, 9339.953300233592, 9644.083812037845, 9679.806403872024, 9697.321187516805, 9785.755356116155, 12151.331676757687, 12236.938815305866, 12267.0, 12271.631851044483, 12272.570460033856, 6629.502787290972, 6656.2345330287635, 6713.462922966151, 6719.966400167968, 6763.289854565298, 6126.172966649535, 6174.197354343996, 6216.533759968021, 6221.720022598994, 6245.28179259391, 4084.591540845892, 4100.405441211008, 4102.159057393227, 4122.670186385082, 4125.23683118624, 1703.1143805221463, 1715.8198389169206, 1728.0927513055494, 1776.5025792778042, 1793.9103044847704, 749.868772964729, 801.1227705662291, 864.3906046237513, 881.7090360181253, 910.6402970826487, 14624.780628290584, 14731.26343682833, 15219.239038048274, 15261.160636165117, 15336.693266134615, 825.5542007315983, 844.4046946902419, 897.9264531905135, 907.3013779389964, 927.1146055516965, 8521.44610600309, 8565.828683426296, 8790.95604521986, 8908.331875109392, 9180.036096209935, 417466.0, 423390.0, 425988.0, 430515.0, 430993.0, 62770.37229627737, 64563.67718161473, 64856.351436485034, 65526.67236663786, 65757.0, 1002.3534820041033, 1005.9295849290626, 1010.5957616953277, 1014.7158795537262, 1023.3961962442046, 13879.861201387857, 13956.2324072177, 14036.29818509091, 14063.859361406256, 14077.014608977273, 27790.86104569464, 27904.32574045564, 28157.577636335063, 28476.0, 28686.0, 33365.83317083399, 33470.0, 33516.0, 34498.82750586231, 34983.82508087545, 6341.8097457076365, 6418.358164183544, 6508.8047358579315, 6632.403083722488, 6850.657467126524, 8147.75556733299, 9729.173020293354, 9773.462459564793, 9964.601415943282, 10001.399916005063, 7942.44402891792, 8010.3992200584025, 8157.306628936607, 8382.455140415854, 8387.203215694499, 8379.329653627574, 8525.275351595184, 8742.650293988423, 8826.470411775314, 9372.859407109036, 8292.419530632798, 8417.410781245255, 8430.536320502431, 8794.736157915273, 8864.335174861782, 6837.863242735217, 6902.930970690229, 6935.7225710971, 6936.930630693629, 6984.755533556301, 6875.862482750417, 8187.099419064018, 8241.217084377215, 8335.49987000782, 8367.121452247426], "unit": "score", "name": "jquery.html", "value": 7374.284107083193}, {"lowerIsBetter": false, "replicates": [1375.7523645743765, 1398.2169984808509, 1519.3618680154334, 1712.6489069740705, 1736.4530172995505, 6296.370362963701, 6429.0, 7268.200497945222, 7387.298206670364, 7389.076365454318, 7222.855542889139, 7362.8527429451515, 7384.335409813116, 7457.769468037767, 7475.514091584043, 2123.6495978163584, 2161.3623980925663, 2161.4056134563043, 2167.6315026445463, 2170.1102547955343, 2109.325015994882, 2136.2523116909033, 2156.094440335063, 2165.6426689596196, 2172.73927128744, 2125.6067627488887, 2133.349328454821, 2134.3170185540635, 2143.614149453098, 2174.8912554372296, 2104.71586335845, 2125.0, 2128.7764784697615, 2129.957400851982, 2132.1471411435396, 2090.95818083639, 2126.223928266187, 2129.6805479178092, 2133.5092928626505, 2135.263334149716, 7689.884651730228, 7786.1435242123325, 7789.649465774054, 7831.569263690495, 7834.0, 4259.382389553497, 4333.848315308981, 4335.263005289077, 4349.064951035542, 4356.302991521341, 2913.533834586477, 2934.090431966076, 2987.4473222453917, 2995.3260516383857, 2996.0, 919.0992827029548, 952.2001518724305, 956.206348730552, 966.7341481092756, 992.7915137821067, 10499.212559058102, 10574.841377379345, 10606.363618182857, 10626.946865265625, 10685.946570267177, 4004.4994375703036, 4009.8396064157105, 4089.7137200395687, 4133.91732165361, 4136.945079004835, 8861.91138088611, 8952.14954579314, 8958.776030599156, 8978.595963181673, 8978.82042359149, 4483.14820184164, 4487.506374298824, 4498.370228168059, 4505.36924830524, 4510.233260345749, 3233.3856567252146, 3318.9170270742943, 3855.614438556178, 4011.13760541485, 4089.5092588889524, 3409.880654177092, 3415.846286917095, 3447.052060683332, 3452.9813704956596, 3483.581970163546, 1071.185898716965, 1089.8528698625742, 1100.0484580837517, 1101.5263436722287, 1103.8399432082304, 977.2816979520047, 991.8710567626163, 995.6515219673056, 1081.853949716794, 1229.6802831263758, 6957.65211739411, 6970.860582788316, 6979.755708550177, 6988.755393561201, 7091.609961452066, 453.215936429978, 457.4190777712287, 463.81215607678945, 464.6422254863736, 465.74849581226437, 5031.949680503149, 5111.233315002705, 5133.024725302181, 5145.331106956071, 5170.276161337416, 8846.248068914085, 8973.102689731106, 9051.864222036675, 9295.256379489625, 9353.438793672402, 8778.429402088845, 8805.0, 8815.426997245288, 8823.735287941372, 8860.822783544292, 6700.83247918806, 6757.189137303555, 6880.58716477013, 6899.241083480813, 6906.861862762717, 6943.583384996714, 6977.372036516738, 7007.894881576678, 7023.754168604074, 7029.9648501757165, 8011.75964721036, 8071.152528984372, 8279.54462504568, 8330.291925186184, 8399.664013439395, 8398.244158025807, 8482.533460659723, 8531.957340213508, 8560.571971401281, 8609.569521523774, 5463.125899856004, 5729.570282228766, 6352.460040896575, 6679.265280819009, 6733.293004234485, 6639.0, 6655.267920528641, 6660.333966603301, 6664.3335666434905, 6702.262751097473, 6107.725152368243, 6245.843853903689, 6420.036994450869, 6430.5177111715875, 6484.5460817742305, 6203.751849925952, 6348.809535713936, 6367.90448143269, 6415.935840641534, 6445.806625801233, 6694.631795251308, 6746.797596072126, 6755.695993680394, 6757.189137303555, 6764.661766911733, 5735.0, 5751.884962300815, 5768.913466297925, 5789.1605717171615, 6059.484943779652, 6207.255129384503, 6208.906866397098, 6228.28374736893, 6246.3753624637175, 6255.061740738925], "unit": "score", "name": "mootools.html", "value": 4135.828568703752}, {"lowerIsBetter": false, "replicates": [301.64406000918905, 304.99237519062035, 308.2647884794764, 308.79002278450645, 316.2031680165981, 5440.619156659035, 5460.481254280847, 5521.227028216048, 5626.859328516784, 5631.18347839563, 5477.096279113942, 5529.861753456165, 5558.471945165213, 5565.053940830058, 5567.053600887849, 4139.958600413987, 4237.533871274158, 4282.29342158545, 4283.828646854122, 4289.378040184171, 4263.680223983198, 4266.509351424579, 4271.743695378287, 4276.550962148961, 4280.72175308604, 4214.936775948363, 4220.198162349144, 4233.703640745149, 4236.301010333292, 4247.745135291892, 4232.174725928445, 4233.872983810491, 4240.469941257343, 4245.066085461193, 4246.108317253381, 3684.705223582107, 3700.0, 3701.1117331840433, 3704.129529560551, 3708.0915175782106, 5133.897322053575, 5305.549028332596, 5344.278522399504, 5368.892622147574, 5378.865528361783, 4876.171050921316, 4879.804807807684, 4881.975590122062, 4883.926741098886, 4883.975580122112, 5847.941520584783, 5852.76588936442, 5858.2677165354335, 5865.0, 5869.4717475427415, 4030.3349947258666, 4033.9394909076386, 4036.6770658347555, 4037.596240375968, 4042.403250715951, 5875.059990401515, 6028.608140470856, 6058.454739073461, 6117.265928088614, 6121.296050954153, 4116.958830411718, 4129.463169787909, 4135.110951145458, 4146.460960075171, 4152.0, 4197.559256278047, 4200.768957707355, 4200.894977625523, 4203.201391735561, 4211.894702632459, 4810.95189048112, 4815.7351345676325, 4816.927746083811, 4820.301056346881, 4820.927686084711, 5685.943140568624, 5692.288463942007, 5780.1907732917425, 5801.071828507418, 5806.825795226066, 1471.220253265771, 1490.8434614365553, 1492.6939977304626, 1493.9028963117362, 1494.7309484292714, 979.7942432089199, 1005.5776573839005, 1006.5219020964983, 1009.7936009818424, 1019.5004447820514, 5053.343065401475, 5065.088284108896, 5070.416902056237, 5076.162433198481, 5077.086124497552, 5906.173135760997, 5993.970030149909, 6057.18228039209, 6058.636481811105, 6082.939170608326, 5004.599632029429, 5048.798048078036, 5076.7207803571155, 5085.949140508622, 5090.821821236239, 3247.220667039893, 3282.2778988622463, 3285.392202442508, 3288.4245257079915, 3293.440115180425, 5599.496045355938, 5669.092945128842, 5671.404502527258, 5716.771329146787, 5726.226959360516, 6211.3478084800445, 6212.316645169028, 6219.346968568235, 6224.844378890473, 6232.439080482688, 5670.914936275959, 5695.088785794253, 5727.226824378822, 5729.5702822288495, 5744.3394009687745, 6078.696065196634, 6085.269767627736, 6087.634741915499, 6089.634621922699, 6096.237970253718, 5735.225744524602, 5884.676342801015, 5959.135925290722, 5972.492338151305, 5979.730912108878, 5731.283589551306, 5740.397258287987, 5747.252857128547, 5751.051076572486, 5751.079827227623, 4240.4275422818755, 4295.269804133367, 4311.417958575677, 4312.353147027846, 4315.676324275629, 5886.293644762656, 5999.730012149551, 6011.909821352596, 6016.0, 6021.969890150521, 5768.192453056659, 5788.652680839163, 5789.2763404574425, 5796.507296879812, 5803.535717142703, 5766.798162064308, 5781.653100813965, 5791.420857914175, 5801.1878337033695, 5821.214136091743, 5525.944740552543, 5665.943340566541, 5671.461211184931, 5673.092305231144, 5677.659340439587, 5808.680522571299, 5811.244538210175, 5819.970900145472, 5824.5631577631, 5846.0, 5467.07059799827, 5628.74670639814, 5652.265205523256, 5680.9147862781265, 5692.260006199168], "unit": "score", "name": "prototype.html", "value": 4356.592097951705}, {"lowerIsBetter": false, "replicates": [707.1832034000728, 760.4524742185631, 768.8001119708875, 789.9684012639494, 800.6037011679218, 11148.331100133997, 11324.490397932092, 11339.716507087327, 11353.943230283858, 11362.318260904342, 10924.508397122128, 11002.669919902415, 11011.174161937866, 11040.723981900457, 12411.193272437307, 778.5873487051857, 779.6374685771116, 784.8822676598527, 785.603270348476, 786.5398741736092, 782.8199514111758, 785.1951749456824, 785.7446329942763, 785.9371250299962, 788.1645455816824, 810.84999275134, 816.0166998766501, 817.1093508076195, 818.1613845808065, 819.7090033038274, 804.4248362420897, 806.4757907360233, 807.7213361390311, 809.2595275323073, 812.0336799208923, 597.1699337920294, 599.4964230046738, 600.1208229943111, 600.534585696089, 602.6323942395136, 11906.107041971887, 11967.341796201206, 11970.760584788342, 12025.639230823002, 12097.2136811107, 11316.3210207387, 11417.257878237888, 11430.885691143065, 11468.369239691814, 11577.53689852405, 9339.486328251944, 9414.435133891988, 9505.477198754066, 9521.571529281198, 9567.091126342986, 3194.7763656544053, 3203.9679603204136, 3225.145336485833, 3258.951115733266, 3259.282957749291, 38407.42388864169, 38873.61126388728, 38939.610603894165, 38957.415638765444, 39008.804955975036, 9006.774830629287, 9035.864462033074, 9147.63409463614, 9216.953915230515, 9236.353455258202, 15698.68602627941, 15707.136107513968, 15719.764203536955, 15722.685546289238, 15726.21368931549, 6067.908981365283, 6115.724792384353, 6292.874142517216, 6473.06140609609, 6473.805785826433, 3632.164602141522, 3651.3245049665898, 3662.2675464907124, 3683.686886614614, 3751.981240093782, 2616.5682662360496, 2625.7242989486213, 2630.9605355919675, 2632.1445530202377, 2639.3533584271977, 477.43424042509736, 517.3791450259628, 524.9842504724865, 538.3190264315643, 540.3084052412918, 423.72669628090324, 448.9685721999494, 465.9510751371125, 468.6250999200694, 588.8498432899669, 7477.1775104738435, 7817.648205830751, 7980.201979801974, 7993.644258346922, 8106.108328083906, 484.30260424987904, 492.9457759646436, 599.2150283129115, 623.5884316351187, 624.3506752976944, 3706.925861482809, 3783.5838057813617, 3818.4153576266094, 3844.3488072533332, 3856.7107466940092, 48684.26973595399, 49288.0, 49370.259446108335, 49547.0, 49561.0, 42810.0, 43006.56993430088, 43082.35376469355, 43131.35302970458, 43392.56607433885, 40227.0, 40733.79633101816, 42070.78964605158, 42915.0, 42937.570624293985, 7850.450468467153, 8163.387745919199, 8312.168783121639, 8339.749807505785, 8442.15578442151, 30331.786728531493, 30393.0, 30663.693363066082, 30840.691593083782, 30972.845135774176, 35652.46521302131, 35790.64209357977, 37077.44383834299, 38988.415173772984, 39215.411768822916, 9266.583003764712, 9959.950200248952, 10074.597016119273, 10094.19246460296, 10252.487375631039, 10743.194260430342, 10836.891631083588, 10998.12015038779, 11046.779064418506, 11489.310641361211, 10266.127379172854, 10327.32872363294, 10468.371897686164, 10823.729406764895, 11079.723006924569, 10297.845532316871, 10474.21443391764, 10571.0, 10633.255672102878, 10904.454777261264, 10490.790184196121, 10619.256652034283, 10866.67399978002, 11055.060319872578, 11108.055815255793, 8596.742097737078, 8666.436681615674, 8667.263282620796, 8816.162464565856, 8917.0, 8767.956160219159, 9112.681056163003, 9147.725568232963, 9242.353035287466, 9287.0], "unit": "score", "name": "yui.html", "value": 5660.389001178973}], "name": "dromaeo_css", "value": 6167.088059638127}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 114.0, 115.0, 123.0, 113.0, 113.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.3}, {"lowerIsBetter": true, "replicates": [156.0, 141.0, 164.0, 168.0, 134.0, 155.0, 160.0, 135.0, 167.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 161.0, 162.0, 165.0, 168.0, 164.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 71.0, 74.0, 72.0, 73.0, 131.0, 72.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 143.0, 106.0, 98.0, 97.0, 138.0, 98.0, 98.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 150.0, 147.0, 148.0, 148.0, 150.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 96.0, 96.0, 95.0, 96.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 71.0, 71.0, 73.0, 71.0, 72.0, 73.0, 72.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 71.0, 69.0, 68.0, 69.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 86.0, 84.0, 85.0, 86.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 125.0, 122.0, 125.0, 131.0, 125.0, 122.0, 126.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 149.0, 141.0, 147.0, 150.0, 148.0, 148.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 71.0, 78.0, 71.0, 70.0, 73.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1543.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1090.5125408942204], "unit": "score", "name": "RayTrace", "value": 678.5699129999998}, {"lowerIsBetter": false, "replicates": [757.002271006813], "unit": "score", "name": "Earley", "value": 880.3976229999998}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [43000.0], "unit": "score", "name": "RegExp", "value": 21.185697674418595}, {"lowerIsBetter": false, "replicates": [616.9031462060457], "unit": "score", "name": "Splay", "value": 132.096911}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20096.20185757368}]} 17:21:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20096.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1543.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6167.09"}}} 17:21:14 INFO - Return code: 0 17:21:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:21:14 INFO - # TBPL SUCCESS # 17:21:14 INFO - Running post-action listener: _resource_record_post_action 17:21:14 INFO - Running post-run listener: _resource_record_post_run 17:21:15 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 274432; Write bytes: 318390272; Read time: 80; Write time: 239444 17:21:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 864256; Read time: 0; Write time: 44 17:21:15 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 274432; Write bytes: 317526016; Read time: 80; Write time: 239400 17:21:15 INFO - Running post-run listener: _upload_blobber_files 17:21:15 INFO - Blob upload gear active. 17:21:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:21:15 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 17:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:21:16 INFO - (blobuploader) - INFO - Open directory for files ... 17:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:17 INFO - (blobuploader) - INFO - Done attempting. 17:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:17 INFO - (blobuploader) - INFO - Done attempting. 17:21:17 INFO - (blobuploader) - INFO - Iteration through files over. 17:21:17 INFO - Return code: 0 17:21:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:21:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:21:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4dd67c274b223c0155c594367064b1985be45d2cf1b6951b84ec32b57bda17b9b6c6d41c165e41b03d7c82f7f5cf00534e8cd3f5646b6d92dfccfd37ce0c0d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a73e86068af143c43f0227bc24147f1c2e22cef190c4b72412a7964d5d905b661642c86c9abe5c2300b93d3b1c2013ec0d4c39b42a2345a565736dcfe880abb"} 17:21:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:21:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:21:17 INFO - Contents: 17:21:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4dd67c274b223c0155c594367064b1985be45d2cf1b6951b84ec32b57bda17b9b6c6d41c165e41b03d7c82f7f5cf00534e8cd3f5646b6d92dfccfd37ce0c0d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a73e86068af143c43f0227bc24147f1c2e22cef190c4b72412a7964d5d905b661642c86c9abe5c2300b93d3b1c2013ec0d4c39b42a2345a565736dcfe880abb"} 17:21:17 INFO - Copying logs to upload dir... 17:21:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.646208 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-10 17:21:17.692039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:21:17.695969) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4dd67c274b223c0155c594367064b1985be45d2cf1b6951b84ec32b57bda17b9b6c6d41c165e41b03d7c82f7f5cf00534e8cd3f5646b6d92dfccfd37ce0c0d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a73e86068af143c43f0227bc24147f1c2e22cef190c4b72412a7964d5d905b661642c86c9abe5c2300b93d3b1c2013ec0d4c39b42a2345a565736dcfe880abb"} build_url:https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/DQIF773eRR26GLswc3STpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4dd67c274b223c0155c594367064b1985be45d2cf1b6951b84ec32b57bda17b9b6c6d41c165e41b03d7c82f7f5cf00534e8cd3f5646b6d92dfccfd37ce0c0d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a73e86068af143c43f0227bc24147f1c2e22cef190c4b72412a7964d5d905b661642c86c9abe5c2300b93d3b1c2013ec0d4c39b42a2345a565736dcfe880abb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:21:17.720894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:21:17.721228) ========= 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=0e2a256762fed810e2f0f810000001b3-1452469413.676396-646801848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:21:17.805711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:21:17.806024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:21:17.806329) ========= ========= Total master_lag: 0.27 =========