builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1453282838.63 results: success (0) buildid: 20160120004518 builduid: a8095b9a41c54a6b92fbe99b2830b566 revision: c6c9487c4236fa5a323be109922892dc5398d543 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.635228) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.635680) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.635986) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.676975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.677280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.702289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.702645) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.752181) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.752578) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.752963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.753248) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 01:40:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-20 01:40:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.861118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.861449) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022368 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.911452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:38.911918) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c6c9487c4236fa5a323be109922892dc5398d543 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c6c9487c4236fa5a323be109922892dc5398d543 --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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 01:40:39,515 truncating revision to first 12 chars 2016-01-20 01:40:39,515 Setting DEBUG logging. 2016-01-20 01:40:39,516 attempt 1/10 2016-01-20 01:40:39,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c6c9487c4236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 01:40:39,774 unpacking tar archive at: fx-team-c6c9487c4236/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.489150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.489481) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004171 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.539143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.539465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.549588) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.549968) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 01:40:39.550451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-20 01:40:39.550800) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:40:40 INFO - MultiFileLogger online at 20160120 01:40:40 in /builds/slave/test 01:40:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:40:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:40:40 INFO - {'append_to_log': False, 01:40:40 INFO - 'base_work_dir': '/builds/slave/test', 01:40:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:40:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:40:40 INFO - 'branch': 'Fx-Team-Non-PGO', 01:40:40 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:40 INFO - 'config_files': ('talos/linux_config.py',), 01:40:40 INFO - 'default_actions': ('clobber', 01:40:40 INFO - 'read-buildbot-config', 01:40:40 INFO - 'download-and-extract', 01:40:40 INFO - 'populate-webroot', 01:40:40 INFO - 'create-virtualenv', 01:40:40 INFO - 'install', 01:40:40 INFO - 'run-tests'), 01:40:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:40 INFO - 'download_minidump_stackwalk': True, 01:40:40 INFO - 'download_symbols': 'ondemand', 01:40:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:40 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:40 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:40 INFO - 'installer_path': 'installer.exe', 01:40:40 INFO - 'log_level': 'info', 01:40:40 INFO - 'log_name': 'talos', 01:40:40 INFO - 'log_to_console': True, 01:40:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:40:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:40:40 INFO - 'opt_config_files': (), 01:40:40 INFO - 'pip_index': False, 01:40:40 INFO - 'sps_profile': False, 01:40:40 INFO - 'sps_profile_interval': 0, 01:40:40 INFO - 'suite': 'dromaeojs-e10s', 01:40:40 INFO - 'system_bits': '32', 01:40:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:40 INFO - 'title': 'talos-linux64-ix-049', 01:40:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:40 INFO - 'use_talos_json': True, 01:40:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:40:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:40 INFO - 'work_dir': 'build'} 01:40:40 INFO - ##### 01:40:40 INFO - ##### Running clobber step. 01:40:40 INFO - ##### 01:40:40 INFO - Running pre-action listener: _resource_record_pre_action 01:40:40 INFO - Running main action method: clobber 01:40:40 INFO - rmtree: /builds/slave/test/build 01:40:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:40:40 INFO - Running post-action listener: _resource_record_post_action 01:40:40 INFO - ##### 01:40:40 INFO - ##### Running read-buildbot-config step. 01:40:40 INFO - ##### 01:40:40 INFO - Running pre-action listener: _resource_record_pre_action 01:40:40 INFO - Running main action method: read_buildbot_config 01:40:40 INFO - Using buildbot properties: 01:40:40 INFO - { 01:40:40 INFO - "project": "", 01:40:40 INFO - "product": "firefox", 01:40:40 INFO - "script_repo_revision": "production", 01:40:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:40:40 INFO - "repository": "", 01:40:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:40:40 INFO - "buildid": "20160120004518", 01:40:40 INFO - "pgo_build": "False", 01:40:40 INFO - "basedir": "/builds/slave/test", 01:40:40 INFO - "buildnumber": 975, 01:40:40 INFO - "slavename": "talos-linux64-ix-049", 01:40:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:40:40 INFO - "platform": "ubuntu64_hw", 01:40:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:40:40 INFO - "branch": "fx-team", 01:40:40 INFO - "repo_path": "integration/fx-team", 01:40:40 INFO - "revision": "c6c9487c4236fa5a323be109922892dc5398d543", 01:40:40 INFO - "stage_platform": "linux64", 01:40:40 INFO - "builduid": "a8095b9a41c54a6b92fbe99b2830b566", 01:40:40 INFO - "slavebuilddir": "test" 01:40:40 INFO - } 01:40:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:40:40 INFO - Running post-action listener: _resource_record_post_action 01:40:40 INFO - ##### 01:40:40 INFO - ##### Running download-and-extract step. 01:40:40 INFO - ##### 01:40:40 INFO - Running pre-action listener: _resource_record_pre_action 01:40:40 INFO - Running main action method: download_and_extract 01:40:40 INFO - mkdir: /builds/slave/test/build/tests 01:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:40 INFO - https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/test_packages.json 01:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/test_packages.json 01:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:40:41 INFO - Downloaded 1448 bytes. 01:40:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:40:41 INFO - Using the following test package requirements: 01:40:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:40:41 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:40:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'jsshell-linux-x86_64.zip'], 01:40:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:40:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:40:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:40:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:40:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:40:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:41 INFO - https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:40:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:42 INFO - Downloaded 21217439 bytes. 01:40:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:40:43 INFO - Return code: 0 01:40:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:43 INFO - https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:44 INFO - Downloaded 21217439 bytes. 01:40:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:40:46 INFO - Return code: 0 01:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:46 INFO - https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:47 INFO - Downloaded 11132144 bytes. 01:40:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:40:47 INFO - Return code: 0 01:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:47 INFO - https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/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 01:40:48 INFO - Downloaded 54196132 bytes. 01:40:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:48 INFO - mkdir: /builds/slave/test/properties 01:40:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:40:48 INFO - Writing to file /builds/slave/test/properties/build_url 01:40:48 INFO - Contents: 01:40:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:48 INFO - Running post-action listener: _resource_record_post_action 01:40:48 INFO - Running post-action listener: set_extra_try_arguments 01:40:48 INFO - ##### 01:40:48 INFO - ##### Running populate-webroot step. 01:40:48 INFO - ##### 01:40:48 INFO - Running pre-action listener: _resource_record_pre_action 01:40:48 INFO - Running main action method: populate_webroot 01:40:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:48 INFO - '--tppagecycles', 01:40:48 INFO - '7'], 01:40:48 INFO - 'tests': ['tsvgm']}}, 01:40:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:40:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:40:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:40:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'tests': ['damp', 'tps']}, 01:40:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['damp', 'tps']}, 01:40:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:48 INFO - 'other': {'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'other_l64': {'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'other_nol64': {'tests': ['a11yr', 01:40:48 INFO - 'ts_paint', 01:40:48 INFO - 'tpaint', 01:40:48 INFO - 'sessionrestore', 01:40:48 INFO - 'sessionrestore_no_auto_restore']}, 01:40:48 INFO - 'svgr': {'tests': ['tsvgx', 01:40:48 INFO - 'tsvgr_opacity', 01:40:48 INFO - 'tart', 01:40:48 INFO - 'tscrollx', 01:40:48 INFO - 'cart']}, 01:40:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['tsvgx', 01:40:48 INFO - 'tsvgr_opacity', 01:40:48 INFO - 'tart', 01:40:48 INFO - 'tscrollx', 01:40:48 INFO - 'cart']}, 01:40:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'tests': ['tp5o']}, 01:40:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'talos_options': ['--e10s'], 01:40:48 INFO - 'tests': ['tp5o']}, 01:40:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'talos_options': ['--xperf_path', 01:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:48 INFO - 'tests': ['tp5n']}, 01:40:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:48 INFO - 'talos_options': ['--e10s', 01:40:48 INFO - '--xperf_path', 01:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:48 INFO - 'tests': ['tp5n']}}, 01:40:48 INFO - 'talos.zip': {'path': '', 01:40:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:48 INFO - Running post-action listener: _resource_record_post_action 01:40:48 INFO - ##### 01:40:48 INFO - ##### Running create-virtualenv step. 01:40:48 INFO - ##### 01:40:48 INFO - Running pre-action listener: _resource_record_pre_action 01:40:48 INFO - Running main action method: create_virtualenv 01:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 01:40:48 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 01:40:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:48 INFO - Using real prefix '/usr' 01:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:51 INFO - Installing pip.................done. 01:40:51 INFO - Return code: 0 01:40:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:40:51 INFO - Using env: {'DISPLAY': ':0', 01:40:51 INFO - 'HOME': '/home/cltbld', 01:40:51 INFO - 'LANG': 'en_US.UTF-8', 01:40:51 INFO - 'LANGUAGE': 'en_US:en', 01:40:51 INFO - 'LOGNAME': 'cltbld', 01:40:51 INFO - 'MAIL': '/var/mail/cltbld', 01:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:51 INFO - 'MOZ_NO_REMOTE': '1', 01:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:51 INFO - 'NO_EM_RESTART': '1', 01:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:51 INFO - 'PWD': '/builds/slave/test', 01:40:51 INFO - 'SHELL': '/bin/bash', 01:40:51 INFO - 'SHLVL': '1', 01:40:51 INFO - 'TERM': 'linux', 01:40:51 INFO - 'TMOUT': '86400', 01:40:51 INFO - 'USER': 'cltbld', 01:40:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:51 INFO - '_': '/tools/buildbot/bin/python'} 01:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:51 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 01:40:51 INFO - Cleaning up... 01:40:51 INFO - Return code: 0 01:40:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:40:51 INFO - Using env: {'DISPLAY': ':0', 01:40:51 INFO - 'HOME': '/home/cltbld', 01:40:51 INFO - 'LANG': 'en_US.UTF-8', 01:40:51 INFO - 'LANGUAGE': 'en_US:en', 01:40:51 INFO - 'LOGNAME': 'cltbld', 01:40:51 INFO - 'MAIL': '/var/mail/cltbld', 01:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:51 INFO - 'MOZ_NO_REMOTE': '1', 01:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:51 INFO - 'NO_EM_RESTART': '1', 01:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:51 INFO - 'PWD': '/builds/slave/test', 01:40:51 INFO - 'SHELL': '/bin/bash', 01:40:51 INFO - 'SHLVL': '1', 01:40:51 INFO - 'TERM': 'linux', 01:40:51 INFO - 'TMOUT': '86400', 01:40:51 INFO - 'USER': 'cltbld', 01:40:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:51 INFO - '_': '/tools/buildbot/bin/python'} 01:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:51 INFO - Downloading/unpacking psutil>=0.7.1 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:53 INFO - Installing collected packages: psutil 01:40:53 INFO - Running setup.py install for psutil 01:40:53 INFO - building 'psutil._psutil_linux' extension 01:40:53 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 01:40:54 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 01:40:54 INFO - building 'psutil._psutil_posix' extension 01:40:54 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 01:40:54 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 01:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:54 INFO - Successfully installed psutil 01:40:54 INFO - Cleaning up... 01:40:54 INFO - Return code: 0 01:40:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:40:54 INFO - Using env: {'DISPLAY': ':0', 01:40:54 INFO - 'HOME': '/home/cltbld', 01:40:54 INFO - 'LANG': 'en_US.UTF-8', 01:40:54 INFO - 'LANGUAGE': 'en_US:en', 01:40:54 INFO - 'LOGNAME': 'cltbld', 01:40:54 INFO - 'MAIL': '/var/mail/cltbld', 01:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:54 INFO - 'MOZ_NO_REMOTE': '1', 01:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:54 INFO - 'NO_EM_RESTART': '1', 01:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:54 INFO - 'PWD': '/builds/slave/test', 01:40:54 INFO - 'SHELL': '/bin/bash', 01:40:54 INFO - 'SHLVL': '1', 01:40:54 INFO - 'TERM': 'linux', 01:40:54 INFO - 'TMOUT': '86400', 01:40:54 INFO - 'USER': 'cltbld', 01:40:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:54 INFO - '_': '/tools/buildbot/bin/python'} 01:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:40:54 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 01:40:54 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 01:40:54 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 01:40:54 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 01:40:54 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 01:40:54 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 01:40:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:40:56 INFO - Installing collected packages: mozsystemmonitor 01:40:56 INFO - Running setup.py install for mozsystemmonitor 01:40:56 INFO - Successfully installed mozsystemmonitor 01:40:56 INFO - Cleaning up... 01:40:56 INFO - Return code: 0 01:40:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:40:56 INFO - Using env: {'DISPLAY': ':0', 01:40:56 INFO - 'HOME': '/home/cltbld', 01:40:56 INFO - 'LANG': 'en_US.UTF-8', 01:40:56 INFO - 'LANGUAGE': 'en_US:en', 01:40:56 INFO - 'LOGNAME': 'cltbld', 01:40:56 INFO - 'MAIL': '/var/mail/cltbld', 01:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:56 INFO - 'MOZ_NO_REMOTE': '1', 01:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:56 INFO - 'NO_EM_RESTART': '1', 01:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:56 INFO - 'PWD': '/builds/slave/test', 01:40:56 INFO - 'SHELL': '/bin/bash', 01:40:56 INFO - 'SHLVL': '1', 01:40:56 INFO - 'TERM': 'linux', 01:40:56 INFO - 'TMOUT': '86400', 01:40:56 INFO - 'USER': 'cltbld', 01:40:56 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:56 INFO - '_': '/tools/buildbot/bin/python'} 01:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:40:56 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 01:40:56 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 01:40:56 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 01:40:56 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 01:40:56 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 01:40:56 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 01:40:58 INFO - Downloading blobuploader-1.2.4.tar.gz 01:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:40:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:40:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:58 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 01:40:59 INFO - Downloading docopt-0.6.1.tar.gz 01:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:40:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:40:59 INFO - Running setup.py install for blobuploader 01:40:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:40:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:40:59 INFO - Running setup.py install for requests 01:40:59 INFO - Running setup.py install for docopt 01:40:59 INFO - Successfully installed blobuploader requests docopt 01:40:59 INFO - Cleaning up... 01:40:59 INFO - Return code: 0 01:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:40:59 INFO - Using env: {'DISPLAY': ':0', 01:40:59 INFO - 'HOME': '/home/cltbld', 01:40:59 INFO - 'LANG': 'en_US.UTF-8', 01:40:59 INFO - 'LANGUAGE': 'en_US:en', 01:40:59 INFO - 'LOGNAME': 'cltbld', 01:40:59 INFO - 'MAIL': '/var/mail/cltbld', 01:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:59 INFO - 'MOZ_NO_REMOTE': '1', 01:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:59 INFO - 'NO_EM_RESTART': '1', 01:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:59 INFO - 'PWD': '/builds/slave/test', 01:40:59 INFO - 'SHELL': '/bin/bash', 01:40:59 INFO - 'SHLVL': '1', 01:40:59 INFO - 'TERM': 'linux', 01:40:59 INFO - 'TMOUT': '86400', 01:40:59 INFO - 'USER': 'cltbld', 01:40:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:59 INFO - '_': '/tools/buildbot/bin/python'} 01:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:59 INFO - Running setup.py (path:/tmp/pip-fa6Xx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:00 INFO - Running setup.py (path:/tmp/pip-zyAFyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:00 INFO - Running setup.py (path:/tmp/pip-khfbC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:00 INFO - Running setup.py (path:/tmp/pip-R7uEdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:00 INFO - Running setup.py (path:/tmp/pip-vk7Khc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:00 INFO - Running setup.py (path:/tmp/pip-cAQUON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:00 INFO - Running setup.py (path:/tmp/pip-PxCibt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:00 INFO - Running setup.py (path:/tmp/pip-I5ghLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:00 INFO - Running setup.py (path:/tmp/pip-gFl181-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:00 INFO - Running setup.py (path:/tmp/pip-BoNpf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:00 INFO - Running setup.py (path:/tmp/pip-tKRdOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:00 INFO - Running setup.py (path:/tmp/pip-5NqZ6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:00 INFO - Running setup.py (path:/tmp/pip-Oj4ae2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:00 INFO - Running setup.py (path:/tmp/pip-SYTHxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:00 INFO - Running setup.py (path:/tmp/pip-uIAITU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:01 INFO - Running setup.py (path:/tmp/pip-_KuHbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:01 INFO - Running setup.py (path:/tmp/pip-VVQ_oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:01 INFO - Running setup.py install for manifestparser 01:41:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Running setup.py install for mozcrash 01:41:01 INFO - Running setup.py install for mozdebug 01:41:01 INFO - Running setup.py install for mozdevice 01:41:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Running setup.py install for mozfile 01:41:01 INFO - Running setup.py install for mozhttpd 01:41:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Running setup.py install for mozinfo 01:41:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Running setup.py install for mozInstall 01:41:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:01 INFO - Running setup.py install for mozleak 01:41:02 INFO - Running setup.py install for mozlog 01:41:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Running setup.py install for moznetwork 01:41:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Running setup.py install for mozprocess 01:41:02 INFO - Running setup.py install for mozprofile 01:41:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Running setup.py install for mozrunner 01:41:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Running setup.py install for mozscreenshot 01:41:02 INFO - Running setup.py install for moztest 01:41:02 INFO - Running setup.py install for mozversion 01:41:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:02 INFO - Cleaning up... 01:41:02 INFO - Return code: 0 01:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:41:02 INFO - Using env: {'DISPLAY': ':0', 01:41:02 INFO - 'HOME': '/home/cltbld', 01:41:02 INFO - 'LANG': 'en_US.UTF-8', 01:41:02 INFO - 'LANGUAGE': 'en_US:en', 01:41:02 INFO - 'LOGNAME': 'cltbld', 01:41:02 INFO - 'MAIL': '/var/mail/cltbld', 01:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:02 INFO - 'MOZ_NO_REMOTE': '1', 01:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:02 INFO - 'NO_EM_RESTART': '1', 01:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:02 INFO - 'PWD': '/builds/slave/test', 01:41:02 INFO - 'SHELL': '/bin/bash', 01:41:02 INFO - 'SHLVL': '1', 01:41:02 INFO - 'TERM': 'linux', 01:41:02 INFO - 'TMOUT': '86400', 01:41:02 INFO - 'USER': 'cltbld', 01:41:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:02 INFO - '_': '/tools/buildbot/bin/python'} 01:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:03 INFO - Running setup.py (path:/tmp/pip-s9y1jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:03 INFO - Running setup.py (path:/tmp/pip-xsQlov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:03 INFO - Running setup.py (path:/tmp/pip-StPQaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:03 INFO - Running setup.py (path:/tmp/pip-u0cw2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:03 INFO - Running setup.py (path:/tmp/pip-ryQD4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:03 INFO - Running setup.py (path:/tmp/pip-JbhP6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:03 INFO - Running setup.py (path:/tmp/pip-P6817u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:03 INFO - Running setup.py (path:/tmp/pip-BvqDsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:03 INFO - Running setup.py (path:/tmp/pip-aoY8ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:03 INFO - Running setup.py (path:/tmp/pip-wTLuzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:03 INFO - Running setup.py (path:/tmp/pip-0EM4yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:04 INFO - Running setup.py (path:/tmp/pip-bkQNlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:04 INFO - Running setup.py (path:/tmp/pip-VbA72y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:04 INFO - Running setup.py (path:/tmp/pip-ZTvyS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:04 INFO - Running setup.py (path:/tmp/pip-dNkBu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:04 INFO - Running setup.py (path:/tmp/pip-M0fucY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:04 INFO - Running setup.py (path:/tmp/pip-Uo4R1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:04 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)) 01:41:04 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)) 01:41:04 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)) 01:41:04 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)) 01:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:06 INFO - Downloading blessings-1.5.1.tar.gz 01:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:06 INFO - Installing collected packages: blessings 01:41:06 INFO - Running setup.py install for blessings 01:41:06 INFO - Successfully installed blessings 01:41:06 INFO - Cleaning up... 01:41:06 INFO - Return code: 0 01:41:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:06 INFO - Reading from file tmpfile_stdout 01:41:06 INFO - Current package versions: 01:41:06 INFO - argparse == 1.2.1 01:41:06 INFO - blessings == 1.5.1 01:41:06 INFO - blobuploader == 1.2.4 01:41:06 INFO - docopt == 0.6.1 01:41:06 INFO - manifestparser == 1.1 01:41:06 INFO - mozInstall == 1.12 01:41:06 INFO - mozcrash == 0.16 01:41:06 INFO - mozdebug == 0.1 01:41:06 INFO - mozdevice == 0.48 01:41:06 INFO - mozfile == 1.2 01:41:06 INFO - mozhttpd == 0.7 01:41:06 INFO - mozinfo == 0.9 01:41:06 INFO - mozleak == 0.1 01:41:06 INFO - mozlog == 3.1 01:41:06 INFO - moznetwork == 0.27 01:41:06 INFO - mozprocess == 0.22 01:41:06 INFO - mozprofile == 0.28 01:41:06 INFO - mozrunner == 6.11 01:41:06 INFO - mozscreenshot == 0.1 01:41:06 INFO - mozsystemmonitor == 0.0 01:41:06 INFO - moztest == 0.7 01:41:06 INFO - mozversion == 1.4 01:41:06 INFO - psutil == 3.1.1 01:41:06 INFO - requests == 1.2.3 01:41:06 INFO - wsgiref == 0.1.2 01:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:06 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')]} 01:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 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')]} 01:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:41:06 INFO - Using env: {'DISPLAY': ':0', 01:41:06 INFO - 'HOME': '/home/cltbld', 01:41:06 INFO - 'LANG': 'en_US.UTF-8', 01:41:06 INFO - 'LANGUAGE': 'en_US:en', 01:41:06 INFO - 'LOGNAME': 'cltbld', 01:41:06 INFO - 'MAIL': '/var/mail/cltbld', 01:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:06 INFO - 'MOZ_NO_REMOTE': '1', 01:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:06 INFO - 'NO_EM_RESTART': '1', 01:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:06 INFO - 'PWD': '/builds/slave/test', 01:41:06 INFO - 'SHELL': '/bin/bash', 01:41:06 INFO - 'SHLVL': '1', 01:41:06 INFO - 'TERM': 'linux', 01:41:06 INFO - 'TMOUT': '86400', 01:41:06 INFO - 'USER': 'cltbld', 01:41:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:06 INFO - '_': '/tools/buildbot/bin/python'} 01:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 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)) 01:41:06 INFO - Cleaning up... 01:41:06 INFO - Return code: 0 01:41:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41:06 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')]} 01:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 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')]} 01:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:41:06 INFO - Using env: {'DISPLAY': ':0', 01:41:06 INFO - 'HOME': '/home/cltbld', 01:41:06 INFO - 'LANG': 'en_US.UTF-8', 01:41:06 INFO - 'LANGUAGE': 'en_US:en', 01:41:06 INFO - 'LOGNAME': 'cltbld', 01:41:06 INFO - 'MAIL': '/var/mail/cltbld', 01:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:06 INFO - 'MOZ_NO_REMOTE': '1', 01:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:06 INFO - 'NO_EM_RESTART': '1', 01:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:06 INFO - 'PWD': '/builds/slave/test', 01:41:06 INFO - 'SHELL': '/bin/bash', 01:41:06 INFO - 'SHLVL': '1', 01:41:06 INFO - 'TERM': 'linux', 01:41:06 INFO - 'TMOUT': '86400', 01:41:06 INFO - 'USER': 'cltbld', 01:41:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:06 INFO - '_': '/tools/buildbot/bin/python'} 01:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:07 INFO - Downloading/unpacking jsonschema 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:09 INFO - warning: no files found matching '*.txt' 01:41:09 INFO - no previously-included directories found matching 'build' 01:41:09 INFO - no previously-included directories found matching 'dist' 01:41:09 INFO - no previously-included directories found matching '.git*' 01:41:09 INFO - Installing collected packages: jsonschema, functools32 01:41:09 INFO - Running setup.py install for functools32 01:41:09 INFO - warning: no files found matching '*.txt' 01:41:09 INFO - no previously-included directories found matching 'build' 01:41:09 INFO - no previously-included directories found matching 'dist' 01:41:09 INFO - no previously-included directories found matching '.git*' 01:41:09 INFO - Successfully installed jsonschema functools32 01:41:09 INFO - Cleaning up... 01:41:09 INFO - Return code: 0 01:41:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3da5aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', '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 01:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:41:09 INFO - Using env: {'DISPLAY': ':0', 01:41:09 INFO - 'HOME': '/home/cltbld', 01:41:09 INFO - 'LANG': 'en_US.UTF-8', 01:41:09 INFO - 'LANGUAGE': 'en_US:en', 01:41:09 INFO - 'LOGNAME': 'cltbld', 01:41:09 INFO - 'MAIL': '/var/mail/cltbld', 01:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:09 INFO - 'MOZ_NO_REMOTE': '1', 01:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:09 INFO - 'NO_EM_RESTART': '1', 01:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:09 INFO - 'PWD': '/builds/slave/test', 01:41:09 INFO - 'SHELL': '/bin/bash', 01:41:09 INFO - 'SHLVL': '1', 01:41:09 INFO - 'TERM': 'linux', 01:41:09 INFO - 'TMOUT': '86400', 01:41:09 INFO - 'USER': 'cltbld', 01:41:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:09 INFO - '_': '/tools/buildbot/bin/python'} 01:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:09 INFO - Downloading/unpacking flake8 01:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:41:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:41:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:11 INFO - no previously-included directories found matching 'docs/_build' 01:41:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:41:11 INFO - Running setup.py install for pep8 01:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:11 INFO - no previously-included directories found matching 'docs/_build' 01:41:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:41:12 INFO - Cleaning up... 01:41:12 INFO - Return code: 0 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - Running post-action listener: _start_resource_monitoring 01:41:12 INFO - Starting resource monitoring. 01:41:12 INFO - ##### 01:41:12 INFO - ##### Running install step. 01:41:12 INFO - ##### 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: install 01:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:12 INFO - Reading from file tmpfile_stdout 01:41:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:12 INFO - Reading from file tmpfile_stdout 01:41:12 INFO - Output received: 01:41:12 INFO - Usage: mozinstall [options] installer 01:41:12 INFO - Options: 01:41:12 INFO - -h, --help show this help message and exit 01:41:12 INFO - -d DEST, --destination=DEST 01:41:12 INFO - Directory to install application into. [default: 01:41:12 INFO - "/builds/slave/test"] 01:41:12 INFO - --app=APP Application being installed. [default: firefox] 01:41:12 INFO - mkdir: /builds/slave/test/build/application 01:41:12 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'] 01:41:12 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 01:41:28 INFO - Reading from file tmpfile_stdout 01:41:28 INFO - Output received: 01:41:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:41:28 INFO - Running post-action listener: _resource_record_post_action 01:41:28 INFO - ##### 01:41:28 INFO - ##### Running run-tests step. 01:41:28 INFO - ##### 01:41:28 INFO - Running pre-action listener: _resource_record_pre_action 01:41:28 INFO - Running main action method: run_tests 01:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:41:28 INFO - Python 2.7.3 01:41:28 INFO - Return code: 0 01:41:28 INFO - grabbing minidump binary from tooltool 01:41:28 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')]} 01:41:28 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 0x122e3d0>, '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 0x1199ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:41:28 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 01:41:28 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 01:41:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:28 INFO - Return code: 0 01:41:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:41:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:41:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:41:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:41:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:41:29 INFO - Return code: 0 01:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 01:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 01:41:29 INFO - Using env: {'DISPLAY': ':0', 01:41:29 INFO - 'HOME': '/home/cltbld', 01:41:29 INFO - 'LANG': 'en_US.UTF-8', 01:41:29 INFO - 'LANGUAGE': 'en_US:en', 01:41:29 INFO - 'LOGNAME': 'cltbld', 01:41:29 INFO - 'MAIL': '/var/mail/cltbld', 01:41:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:41:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:29 INFO - 'MOZ_NO_REMOTE': '1', 01:41:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:29 INFO - 'NO_EM_RESTART': '1', 01:41:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:29 INFO - 'PWD': '/builds/slave/test', 01:41:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:41:29 INFO - 'SHELL': '/bin/bash', 01:41:29 INFO - 'SHLVL': '1', 01:41:29 INFO - 'TERM': 'linux', 01:41:29 INFO - 'TMOUT': '86400', 01:41:29 INFO - 'USER': 'cltbld', 01:41:29 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691', 01:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:29 INFO - '_': '/tools/buildbot/bin/python'} 01:41:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 01:41:29 INFO - mozversion application_buildid: 20160120004518 01:41:29 INFO - mozversion application_changeset: c6c9487c4236fa5a323be109922892dc5398d543 01:41:29 INFO - mozversion application_display_name: Nightly 01:41:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:29 INFO - mozversion application_name: Firefox 01:41:29 INFO - mozversion application_remotingname: firefox 01:41:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:41:29 INFO - mozversion application_vendor: Mozilla 01:41:29 INFO - mozversion application_version: 46.0a1 01:41:29 INFO - mozversion platform_buildid: 20160120004518 01:41:29 INFO - mozversion platform_changeset: c6c9487c4236fa5a323be109922892dc5398d543 01:41:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:41:29 INFO - mozversion platform_version: 46.0a1 01:41:29 INFO - using testdate: 1453282889 01:41:29 INFO - actual date: 1453282889 01:41:29 INFO - starting webserver on 'localhost:56747' 01:41:29 INFO - SUITE-START | Running 3 tests 01:41:29 INFO - TEST-START | dromaeo_css 01:41:29 INFO - operating with platform_type : linux_ 01:41:29 INFO - Initialising browser for dromaeo_css test... 01:41:29 INFO - TEST-INFO | started process 8145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC80uJ3/profile http://localhost:56747/getInfo.html) 01:41:33 INFO - PROCESS | 8145 | 01:41:33 INFO - PROCESS | 8145 | (process:8227): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:41:34 INFO - PROCESS | 8145 | __metrics Screen width/height:1600/1200 01:41:34 INFO - PROCESS | 8145 | colorDepth:24 01:41:34 INFO - PROCESS | 8145 | Browser inner width/height: 1024/697 01:41:34 INFO - PROCESS | 8145 | __metrics 01:41:34 INFO - PROCESS | 8145 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:41:35 INFO - TEST-INFO | 8145: exit 0 01:41:35 INFO - Browser initialized. 01:41:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:41:35 INFO - TEST-INFO | started process 8276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC80uJ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:36 INFO - PROCESS | 8276 | -- checkerboarding starts below -- 01:41:36 INFO - PROCESS | 8276 | RENDERTRACE 0.036443 rect red 0 0 10 10 // viewport 01:41:36 INFO - PROCESS | 8276 | RENDERTRACE 50.1707 rect brown 0 0 10 10 // page 01:41:36 INFO - PROCESS | 8276 | RENDERTRACE 50.1929 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 01:41:36 INFO - PROCESS | 8276 | Checkerboarded for 1 frames (52.3289 ms), 100 peak, 1 severity. 01:41:36 INFO - PROCESS | 8276 | 01:41:36 INFO - PROCESS | 8276 | (process:8333): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:41:47 INFO - PROCESS | 8276 | RSS: Main: 150192128 01:41:47 INFO - PROCESS | 8276 | 01:42:36 INFO - PROCESS | 8276 | 1453282956949 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] 01:44:48 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56747/tests/dromaeo/cssquery-ext.html) 01:44:49 INFO - PROCESS | 8276 | RSS: Main: 156053504 01:44:49 INFO - PROCESS | 8276 | 01:47:51 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-ext.html (next: http://localhost:56747/tests/dromaeo/cssquery-jquery.html) 01:47:51 INFO - PROCESS | 8276 | RSS: Main: 150532096 01:47:51 INFO - PROCESS | 8276 | 01:50:53 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56747/tests/dromaeo/cssquery-mootools.html) 01:50:54 INFO - PROCESS | 8276 | RSS: Main: 151154688 01:50:54 INFO - PROCESS | 8276 | 01:53:56 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56747/tests/dromaeo/cssquery-prototype.html) 01:53:56 INFO - PROCESS | 8276 | RSS: Main: 150609920 01:53:56 INFO - PROCESS | 8276 | 01:56:59 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56747/tests/dromaeo/cssquery-yui.html) 01:57:00 INFO - PROCESS | 8276 | RSS: Main: 151158784 01:57:00 INFO - PROCESS | 8276 | 02:00:02 INFO - PROCESS | 8276 | Cycle 1(1): loaded http://localhost:56747/tests/dromaeo/cssquery-yui.html (next: http://localhost:56747/tests/dromaeo/cssquery-dojo.html) 02:00:02 INFO - PROCESS | 8276 | RSS: Main: 154230784 02:00:02 INFO - PROCESS | 8276 | 02:00:02 INFO - PROCESS | 8276 | __start_tp_report 02:00:02 INFO - PROCESS | 8276 | _x_x_mozilla_page_load 02:00:02 INFO - PROCESS | 8276 | _x_x_mozilla_page_load_details 02:00:02 INFO - PROCESS | 8276 | |i|pagename|runs| 02:00:03 INFO - PROCESS | 8276 | |0;dojo.html;2575.4462790500043;2610.164747280871;2637.9999999999986;2652.3634327761333;2661.8669066546668;4394.165108629358;4520.231560634696;4544.454665440147;4548.067646132543;4570.154521413537;4432.955670443303;4466.263066594008;4491.079328737609;4520.254158063915;4530.097359109174;4191.538930717618;4215.873523794291;4259.467566554181;4264.040590867061;4279.935800962988;4173.436586060889;4189.350650649154;4213.367994800789;4225.028243503996;4272.700910936236;4113.691473139526;4192.832286708558;4195.202911446815;4198.3282674772045;4285.635720963722;4203.348480985452;4213.367994800774;4214.978925105385;4228.217779710763;4253.532111467736;4190.979045104786;4196.223698615766;4219.767912764797;4231.936520952188;4247.362895565659;4312.82748690052;4388.802503887333;4397.560243975577;4413.492448368414;4413.889652758675;4836.927446088312;4846.224604063333;4850.6362022848425;4856.3201151838775;4891.682040667345;4909.435414927293;4910.508949105097;4910.8281210157475;4929.2359684248995;4933.975330123327;4296.0548679290505;4356.956430435718;4358.847440339573;4560.1335746208115;4564.863054108382;4890.413150421972;4906.435759887588;4927.334809800703;4965.478624744422;4978;4738.099761045391;4746.477887432379;4749.145153872336;4759.571638552547;4795.160846851787;4763.428388593391;4812.205986012269;4830.830920917751;4849.054434385261;4861.246506791453;4846.345743324606;4885.389326334208;4891.364122664031;4894.535019173173;4922.581580565692;4870.95129048705;4879.097366987119;4880.902381952412;4884.169691152512;4903.754812259373;3992.740471869319;4055.330870406409;4136.627703506639;4199.958000420018;4231.217224813419;3527.5766907970697;3528.9236782780986;3578.499010138583;3582.820858957094;3605.0626837022564;4189.685773566934;4202.537720850704;4224.704270701083;4231.597998190167;4253.8723838284905;4753.35829662998;4849.806007759721;4849.830255941025;4865.513448655177;4956.975215123901;4222.387753775685;4239.27932251518;4246.44796176495;4253.8723838284905;4267.658587313008;4387.648988080946;4390.934135987963;4394.582514661102;4408.272635015251;4442.378067070613;4533;4546.477155127137;4566.589006989387;4576.656750743641;4631.560001799824;4848.5636292733825;4867.80528778859;4881.487443818348;4901.485344038967;4915.26271059344;4476.888077798081;4626.514216007271;4640.303954406866;4641.443026836801;4680.836170734145;4697.459792123949;4701.318308845267;4826.396700412449;4875.68308059975;4910.779014944407;4727.479977202436;4791.880202994814;4818.590419814355;4824.49342819013;4865.829695960624;4597.885052873705;4668.323093151406;4672.672912896064;4681.836135735233;4724.527547245248;4635.23518619424;4763;4785.234362501983;4802.567768900815;4842.443119041355;4559.110973360163;4577.656675749398;4580.083983203306;4614.100250451264;4657.115148121846;4546.88632784183;4639.396878405786;4674.906501869876;4733.479317275028;4789.425268967746;4609.838655647036;4623.791929363119;4638.257878739386;4655.790489427916;4674.555917187861 02:00:03 INFO - PROCESS | 8276 | |1;ext.html;490.7816021870267;527.0670912484904;561.668615516845;563.2846285217773;566.6147020026382;31456.213594660116;32253.35493290133;32284.838575807116;32344.353112937726;32380;35401.645983540155;35883.641163588356;35959;36023.279534409296;36121.819390903074;7614.276643718852;7790.104138024143;7819.882701759479;7827.373810095179;7838.216178382173;7608.923910760905;7726.266004729542;7733.690652373898;7821.8826717598995;7873.527588344689;7812.921870781304;7814.218578142169;7897.881531777028;7917.049954005499;7927.722529711461;7620.352270057052;7698.191689872567;7712.074551053854;7722.382209423233;7781.727639532617;6498.902516462257;6586.440152587036;6615.867682646368;6616.933830661728;6645.534812563123;35487.64512354869;35584;35851;36001.09997250063;36024.81987590045;2640.696319923195;2746.4232511172677;2797.202797202787;2967.525195968656;3192.5690031845634;26876.328091797666;27020.59469107965;27163.864180679167;27187.728122718716;27343.906243750425;3513.5959364673135;3516.349475347069;3519.2433626770367;3598.748087633867;3611.20553478237;202975;203147;203354;203567;204310;45158.54841451609;51022.48977510251;51165.74417127965;51387.48612513827;51414;40873.386899196536;55467.44532554623;56693.14960275599;56723;56867.431325687045;12516.561920332744;12785.488580456864;12812.231266124063;12873.356332183354;12886.484540618458;9388.34281600295;9430.339876208736;9466.148046675833;9474.05259474061;9494.572744226527;17997.460076197734;18204.726929096076;18228.635427291647;18359;18384.26462941494;7086.539374940612;7156.745625128068;7251.637418129072;7283.817904552323;7383.2247614000835;880.8414485392562;892.9508877011697;917.7934964633038;921.2169655792522;964.4647220792527;22042.559148816934;22085.779142208372;22309.665355019686;22455.55088898213;22609.208677696202;944.8157609266265;955.0822238062647;959.5298303831072;961.4471678784587;992.2012779712256;11967.281963082243;12043.518259269531;12076.335801530824;12105.394730263628;12131.696707582205;250006;251835;252051;252167;253639;44043.55956440394;44134;44273.33589996152;44280.557194428286;44539.77730111329;1169.4211365374194;1179.6991767099335;1180.6635108994067;1191.7616476704693;1218.1290377380217;23040.539189215786;23254;23357.532849342577;23395.362324637113;23482.882585587646;30382;30665.386692265583;30677.386452271276;36674.8166259167;36841.631583684895;229904;231686;232285;232503;232613;27457.17628471149;27738.583921240795;28339.574906376834;28454.715452846034;28457.857710711312;32610;32759.344813104082;33384.49923251202;33573.16067098244;33666.15834604057;27431.451370972867;27939.44121117607;28115.57826632643;28706.856465717538;29337.413251735274;27926.3018424541;28217.576736349383;28234.43531129407;28867.711322887342;29202.707972919998;30446.543301850048;30757.384852303276;30807.2298192538;31157.88421157866;31201.531977020815;27037.459250815267;27327.642154660592;28430;28472;31554;22252.88873555622;22716.659250111592;22850.42873928165;22955.311340659806;22982.885085574464 02:00:03 INFO - PROCESS | 8276 | |2;jquery.html;334.68539572801575;336.77604393078605;340.2497493027874;341.0892915914508;342.68644190565635;14075.648108797284;14446.347827819049;14582.41670333188;15204.923975380108;15363;9353.298502612315;9619.278554108452;10819.945900270508;14918.850811491882;14974.700505989873;4381.518033016366;4550.567696068868;4610.031893302411;4620.5148459411785;5040.697558146505;4917.950820491803;4970.105381031413;4978.153713868633;4985.052839960414;4986.35177426934;3247.480403135499;3414.7951122932577;4855.5872750816225;4942.258661200813;4957.454679985199;5090.694558326512;5105.310783044279;5121.539061484447;5129.9230511542355;5143.331366922295;4752.120857641313;4976.2038073908;4976.950230497685;4977.855093328555;4989.800407983676;10545.78908421835;10791.29856559329;12579.811302830465;17027.48917532476;17083.487495375157;1741.2251548061117;1783.1975610974982;1826.8355847973614;1845.2342277954633;1863.5806943437753;7753.728619498347;8208.548529830858;9144.40561363516;9354;12206.694832629166;1582.6280824006349;1586.7699183618427;1604.879634027441;1608.404890190637;1615.6122530592572;48017.51982480165;48749;49025.264621030714;49484.257736133986;50585.74707126478;9334.346595738232;9337.579808908615;9408.153266206074;9449.905500944902;9466.242700584075;11989.760204795855;12039.337836419081;12048.457819398149;12054.095942804324;12073.939630301968;6547.770828021092;6722.092517510074;6725.226598941086;6731.730730770714;6753.088333074972;6200.0699895015205;6267.71795269214;6281.528885333618;6347.079673447324;6406.487481001509;3994.940075898864;4067.7966101694797;4072.959270407258;4093.5497095319492;4096.73371230869;1596.0503500417233;1609.4769200010044;1623.3019801485475;1649.2413489794828;1687.8480936715755;360.38734151941804;366.8055930356915;371.6376532880474;379.6583075232313;826.3141592478229;9149.413121514546;9385.06149385056;9402.576884040234;9472.857907131398;9918.80162396748;369.7393337696971;387.521411057344;405.5093337062129;409.3307442331809;815.2092470303796;4819.879503012453;5002.249662550574;5003.424606170264;5051.797928082909;5071.264666623319;411879;412068;414534;418028;424165;63471.36528634747;63725.681371592844;64373;64922.67538662277;64959;425.23457776003073;430.3866989539893;430.71572761976944;432.19180133151207;432.85283003778864;8885;9078.773030674285;9137.766401535708;9218.677346292847;9238.214751745909;29595.556066658588;30287.848560757055;30663.540046898866;30921.072367829;31736.841315793274;37233;37267.62732372642;37377;37854.43218351672;38557.807210963765;6017.849553761191;6194.752209911553;6211.378862113753;6332.145160403471;6467.708953097028;3037.0433313506173;3040.650325212629;6631.038499417654;7327.890081648886;9636.71089867305;7830.2169783021245;8074.757757267292;8339.708110216114;8644.78388040304;9423.19902808269;7356.337929586363;8772.29821614282;9248.815023699623;9326.207272381924;9375.01562335945;2717.062613398374;3550.7159427246274;3698.8150592470806;8928.687495937611;9093.590788414405;6432.131662225727;6610.140681711347;6610.305917878553;6665.866682666417;6687.866242675022;7318.853622927405;8273.503589784632;8741;8753.431026983226;8784.78038049054 02:00:03 INFO - PROCESS | 8276 | |3;mootools.html;1341.6779972806526;1353.5059703208328;1437.1520802726388;1628.3486605357848;1657.9245499598253;6003.0695242237525;6130.203073600425;6581.407673309402;6754.121964144654;6769.120014398128;6462.159919210508;6602.339766023408;6638.369354911276;6641.4686825054005;6680.198376194851;1981.782003979561;2001.8098280663314;2016.949576260598;2018.5054661607926;2019.2831544801604;1994.5611965367596;1995.2019192323114;2002.4092892596718;2039.0416504242983;2042.132093860111;1977.6835706286997;2001.8198362147405;2004.2383894120287;2015.3953813855858;2018.3944816555047;1996.5208349996042;2009.457446489447;2011.5474018345901;2012.5270561418056;2013.5872146210138;1990;2002.1290738528787;2030.8883011434366;2040.1329434990218;2047.2732180076007;6434.903476447857;6504.414602685781;6530.44491218247;6533.248676402227;6554.475641948633;3921.29416704993;4009.759414435114;4022.054817117975;4030.717849750519;4033.253848038122;2554.118829003991;2570.9228723138335;2611.138324352959;2706.418120104187;2716.6468359113187;839.5382539603194;857.5540718826238;867.1025488619312;868.1448772958631;1763.5150333658346;8443.788905277355;8490.278326342268;8503.82992340156;8534.445261058012;8556.229939305493;3364.343952929204;3414.402479566066;3427.811470369104;3467.9826600866836;3492.2666240089357;7158.06945097134;7190.640467976685;7221.602811845294;7221.96389018062;7232.349088582053;3860.1700634363183;3884.8057597120032;3885.3977633466857;3885.436611691289;3920.666743326792;3551.1654761131113;3610.8736194233074;3617.2403795202777;3619.438986956973;3626.1841085756023;3333.71663408613;3345.7825241359233;3376;3382.255903701182;3434.639362866863;1034.0848349211003;1093.2565855218527;1093.3057508482011;1096.3038470571244;1104.6575561575937;1124.3703526025452;1145.3585991844593;1147.9483423245974;1151.3264740126951;1182.3851597169423;6111.755529778848;6179;6203.4416902479;6222.284437289679;6233.34549872266;392.1529496288004;392.3741632096801;394.7335548504748;395.4661207370085;403.7375705791201;5126.307948426989;5196.350456192976;5215.374155101412;5225.399079105951;5226.059309324358;7377;7494.812629684301;7871.173526779606;7989.8402031960195;8064;7333.559986400833;7448.068991376078;7517.586532740752;7530.623468826537;7544.132424771112;6307.590006649553;6423.389777971085;6424.550281480345;6434.549581529342;6444.033394990695;6037;6180.6600636965395;6209.937900621117;6218.689065546795;6243.313235543996;7070.222275549582;7213.567185968858;7301.306375894282;7427.071616047994;7453.440991925736;7419.591922444318;7477.476576639583;7532.698692052257;7595.506292090997;7661.693532258647;5369.624126311121;5506.724663766876;5667.064934285797;5992.43071908168;6098.542609304409;6340.270868850142;6343.9682801585695;6362.618242905255;6371.49028077762;6391.904121438275;5922.940770592239;5987.910181347196;6030.5778595497895;6126.693665316806;6159.784407545714;5921.733521991435;5985.132155837292;6008.579399441997;6067.939320606914;6094.908576371269;6054.545909056927;6182.598131121463;6197.938020619917;6202.782902598387;6209.5963762357105;5611.38274789781;5686.43135686428;5692.3169219692245;5704.600677952503;5706.514946229451;5651.237082993744;5674.602777805679;5741.1388291756575;5745.770169193185;5757.65454072757 02:00:03 INFO - PROCESS | 8276 | |4;prototype.html;286.769150833579;294.62876775263175;297.62647876914474;302.6549733304034;304.99237519062007;5417.295751552293;5519.641223320481;5561.47166019228;5577.916331255029;5585.581081418894;5362.865928351793;5508.173773933912;5537.667739935607;5546.500814926656;5575.2473416088815;4241.872743817675;4286.828526858938;4298.204832106055;4300.1829652366105;4303.548127446612;4248.596383343577;4258.552851950547;4286.7568405162465;4300.591443812833;4305.741655500664;4046.858359957402;4165.312723400635;4263.232618128735;4270.12462445198;4278.4438023056955;4184.372344148372;4210.410542524049;4215.199112168709;4215.683823713233;4221.261279276115;3589.8743543976097;3625.854965801365;3632.891013269606;3642.5811031731423;3653.1232504199065;5315.309009828737;5393.164059570773;5408.35099788024;5411.107167317388;5415.0523658360025;4761.095391875532;4830.178869592142;4851.296561998526;4854;4871.732054736988;5818.5345172386105;5852.122181672783;5867.413258674141;5868.23712917318;5884.146798714162;3951.288768021755;3952.7628342299554;3958.188571342868;3964.623360780721;3969.3450580654157;6153.907691384633;6199.659018753967;6215.751369945152;6244.469220116295;6254.8123556293385;3928.705347098979;4046.5751096135073;4051.473308469939;4057.188562287495;4059.878203653895;4121.91756164875;4134.813933373005;4154.4183814266025;4158.688098392633;4165.146145040259;4804.759762011886;4808.783604737795;4816.735079570657;4819.1566475867285;4822.734749588806;5848.736806843703;5861.648301101947;5868.911966320508;5886.823395298148;5887.793927212527;1425.095064633965;1448.8116544849313;1449.9855001450062;1452.5134080083078;1463.604826696786;950.097407462913;966.5698764050071;966.7293157915794;970.3256236915418;981.5190556627344;5022.970291090391;5062.341895553554;5099.107656160157;5109.029284435946;5113.9744301279;6024.548158888101;6040.365761595057;6095;6096.902557539685;6108.205933228652;5089.389273287229;5095.210242412432;5104.821331253463;5112.130937740519;5124.9743751281;3234.6280177779386;3261.575995120619;3299.653536378694;3311.288073064303;3311.569495965557;5728.971355143198;5733.88532229353;5734.2258795062135;5735.713214339266;5741.052726300197;6187.504999600022;6210.875782484325;6222.502199824004;6230.408111229426;6248.156498872685;5566.749496272597;5708.514776243983;5724.914126288192;5730.684812335278;5731.627444216196;6036.6679832609625;6053.4551890330085;6068.21113255274;6069.089636554376;6073.48375388097;5905.379935106752;5909.468147866713;5912.142739302863;5913.85215369602;5915;5691.516221121251;5710.743016564347;5719.428057194247;5720.570957178312;5725.427457254241;3964.5044369453817;4093.9795301024496;4096.897577560585;4099.569545197712;4115.835366585423;5983.850403739942;5996.1005849122985;6067.150598916067;6072.240969878765;6074.757009719562;5949.8215053548465;5953.583249172516;5957.49361304294;5959.225300711053;5985.700714964321;5951.791687290924;5958.791442299499;5960.374160713062;5970.492508136857;5973.283206015132;5673.234113394639;5779.2775903012125;5800.1589769484035;5831.4168583141345;5841.269841269841;5968.104784282219;5984.042553191469;5997.880042399215;5998.610090344114;6008.128821320972;5849.151872978479;5849.912251316318;5853.1805547222575;5867.589268751147;5868.2664666916635 02:00:03 INFO - PROCESS | 8276 | |5;yui.html;643.9710213040413;661.7286912365931;662.1061566884704;673.8854394752891;760.9429292803039;10821.945890270548;10829.729256768585;10975.61585344512;11125.388103654306;11226.101911847052;10365.844512332302;10393.376397416161;10482;10491.213159013067;10540.262181647287;592.7303077099909;598.8622616798139;728.1989811207669;734.4014628078099;740.8407192453622;725.9382952449048;734.5299008634478;745.3440971944681;746.7461063238497;746.9589172595505;764.6864785437972;765.674588299973;770.6493545436841;772.8531579;774.0363247756551;776.6854423958277;777.2305417636527;777.8327659553166;778.1284960843834;779.95710235937;566.3232437237502;569.0184431855058;569.313976658126;570.4381184533273;571.622728998863;10949.397783121925;10961.12311015117;11004.504797284062;11006.559737610485;11035.83446248307;11585.18903676743;11612;11811.763764724743;11953.342566158857;12258;9192.54782279141;9280.953595232048;9352.812943741086;9382.95308523453;9425.76435589109;3185.7769956103084;3258.853351599184;3281.786683865541;3295.1103202135528;3295.3903527847187;36580.63419365772;37014;37188.326525306424;37236.57962232446;37542.43686344707;8521.10528394522;8667;8710.085441028601;8780;8808;13158.21050736959;13227.735445291233;13563.864361356458;13607;13672.52146174879;6203.503719702413;6225.719842607094;6293.559450838489;6441.935580644134;6528.400541867273;3551.1122219445137;3592.1199306170156;3626.7279954003557;3635.9636403636155;3658.6707196352454;2607.113581382339;2644.087789712546;2645.708972013077;2651.8939242430474;2667.5065112954167;436.6245029274821;448.46184578505273;453.7368326370697;455.6992385025867;456.3724878292348;480.73319307783817;516.9483051694875;539.134688824439;552.1607157121233;556.3824155187739;7038.718451261994;7164.856702865914;7173.318534739192;7209.89185162223;7308.6345682715655;479.54443278885196;535.6009772719349;536.3885170905171;536.7906516458585;556.1241045353504;3437.1750779812664;3658.2683463307444;3690.944635830465;3722.3299806034634;3809.8666546670734;43258.567414326084;43434.131317373474;43736;43797.12405751867;43971;42433;42654.78672606617;42702.57297427048;42936.785316073845;43233.35149972753;35415.82292088523;37767.43348849769;38964.22071558553;39052;39644.60355396467;7462.552246865205;7656.157822639394;7702.191269916802;7754.961225193838;8029.799255018671;29392;29452.705472945854;29606.851965740894;30073.248168795955;30087.247818804706;35569.1107722309;36465;36632.45051324285;36999;37089.25821483609;8881.378303518692;9003.369764116449;9234.353595248536;9288.58201380953;9345.392549484262;9785.80428391414;10039.899601003897;10122.392656440637;10225.642102526375;10665.680029599125;9577.281703872099;9592.808143836945;9768.804623907625;10023.348482348623;10108.54511546997;9559.713208603753;9568.473733944422;9582.904170958202;9696.70909872705;10016.799664006825;8536.658533658585;9381.530923453663;9416.576254068446;10087.646932357333;10110.09009189147;7802.33680137172;7820.765377038698;7965.402594805297;8041.758747237593;8322.54226017575;8018.478798878287;8047.407052098735;8343.707970221014;8365.62354694028;8381.958090209753 02:00:03 INFO - PROCESS | 8276 | __end_tp_report 02:00:03 INFO - PROCESS | 8276 | __start_cc_report 02:00:03 INFO - PROCESS | 8276 | _x_x_mozilla_cycle_collect,339 02:00:03 INFO - PROCESS | 8276 | __end_cc_report 02:00:03 INFO - PROCESS | 8276 | __startTimestamp1453284002998__endTimestamp 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | ------- Summary: start ------- 02:00:03 INFO - PROCESS | 8276 | Number of tests: 6 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#0] dojo.html Cycles:165 Average:4486.00 Median:4577.66 stddev:453.77 (9.9%) stddev-sans-first:429.70 02:00:03 INFO - PROCESS | 8276 | Values: 2575.4 2610.2 2638.0 2652.4 2661.9 4394.2 4520.2 4544.5 4548.1 4570.2 4433.0 4466.3 4491.1 4520.3 4530.1 4191.5 4215.9 4259.5 4264.0 4279.9 4173.4 4189.4 4213.4 4225.0 4272.7 4113.7 4192.8 4195.2 4198.3 4285.6 4203.3 4213.4 4215.0 4228.2 4253.5 4191.0 4196.2 4219.8 4231.9 4247.4 4312.8 4388.8 4397.6 4413.5 4413.9 4836.9 4846.2 4850.6 4856.3 4891.7 4909.4 4910.5 4910.8 4929.2 4934.0 4296.1 4357.0 4358.8 4560.1 4564.9 4890.4 4906.4 4927.3 4965.5 4978.0 4738.1 4746.5 4749.1 4759.6 4795.2 4763.4 4812.2 4830.8 4849.1 4861.2 4846.3 4885.4 4891.4 4894.5 4922.6 4871.0 4879.1 4880.9 4884.2 4903.8 3992.7 4055.3 4136.6 4200.0 4231.2 3527.6 3528.9 3578.5 3582.8 3605.1 4189.7 4202.5 4224.7 4231.6 4253.9 4753.4 4849.8 4849.8 4865.5 4957.0 4222.4 4239.3 4246.4 4253.9 4267.7 4387.6 4390.9 4394.6 4408.3 4442.4 4533.0 4546.5 4566.6 4576.7 4631.6 4848.6 4867.8 4881.5 4901.5 4915.3 4476.9 4626.5 4640.3 4641.4 4680.8 4697.5 4701.3 4826.4 4875.7 4910.8 4727.5 4791.9 4818.6 4824.5 4865.8 4597.9 4668.3 4672.7 4681.8 4724.5 4635.2 4763.0 4785.2 4802.6 4842.4 4559.1 4577.7 4580.1 4614.1 4657.1 4546.9 4639.4 4674.9 4733.5 4789.4 4609.8 4623.8 4638.3 4655.8 4674.6 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#1] ext.html Cycles:180 Average:37560.18 Median:32314.60 stddev:59919.74 (185.4%) stddev-sans-first:60023.18 02:00:03 INFO - PROCESS | 8276 | Values: 490.8 527.1 561.7 563.3 566.6 31456.2 32253.4 32284.8 32344.4 32380.0 35401.6 35883.6 35959.0 36023.3 36121.8 7614.3 7790.1 7819.9 7827.4 7838.2 7608.9 7726.3 7733.7 7821.9 7873.5 7812.9 7814.2 7897.9 7917.0 7927.7 7620.4 7698.2 7712.1 7722.4 7781.7 6498.9 6586.4 6615.9 6616.9 6645.5 35487.6 35584.0 35851.0 36001.1 36024.8 2640.7 2746.4 2797.2 2967.5 3192.6 26876.3 27020.6 27163.9 27187.7 27343.9 3513.6 3516.3 3519.2 3598.7 3611.2 202975.0 203147.0 203354.0 203567.0 204310.0 45158.5 51022.5 51165.7 51387.5 51414.0 40873.4 55467.4 56693.1 56723.0 56867.4 12516.6 12785.5 12812.2 12873.4 12886.5 9388.3 9430.3 9466.1 9474.1 9494.6 17997.5 18204.7 18228.6 18359.0 18384.3 7086.5 7156.7 7251.6 7283.8 7383.2 880.8 893.0 917.8 921.2 964.5 22042.6 22085.8 22309.7 22455.6 22609.2 944.8 955.1 959.5 961.4 992.2 11967.3 12043.5 12076.3 12105.4 12131.7 250006.0 251835.0 252051.0 252167.0 253639.0 44043.6 44134.0 44273.3 44280.6 44539.8 1169.4 1179.7 1180.7 1191.8 1218.1 23040.5 23254.0 23357.5 23395.4 23482.9 30382.0 30665.4 30677.4 36674.8 36841.6 229904.0 231686.0 232285.0 232503.0 232613.0 27457.2 27738.6 28339.6 28454.7 28457.9 32610.0 32759.3 33384.5 33573.2 33666.2 27431.5 27939.4 28115.6 28706.9 29337.4 27926.3 28217.6 28234.4 28867.7 29202.7 30446.5 30757.4 30807.2 31157.9 31201.5 27037.5 27327.6 28430.0 28472.0 31554.0 22252.9 22716.7 22850.4 22955.3 22982.9 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#2] jquery.html Cycles:180 Average:21952.91 Median:27213.26 stddev:68184.83 (250.6%) stddev-sans-first:68356.78 02:00:03 INFO - PROCESS | 8276 | Values: 334.7 336.8 340.2 341.1 342.7 14075.6 14446.3 14582.4 15204.9 15363.0 9353.3 9619.3 10819.9 14918.9 14974.7 4381.5 4550.6 4610.0 4620.5 5040.7 4918.0 4970.1 4978.2 4985.1 4986.4 3247.5 3414.8 4855.6 4942.3 4957.5 5090.7 5105.3 5121.5 5129.9 5143.3 4752.1 4976.2 4977.0 4977.9 4989.8 10545.8 10791.3 12579.8 17027.5 17083.5 1741.2 1783.2 1826.8 1845.2 1863.6 7753.7 8208.5 9144.4 9354.0 12206.7 1582.6 1586.8 1604.9 1608.4 1615.6 48017.5 48749.0 49025.3 49484.3 50585.7 9334.3 9337.6 9408.2 9449.9 9466.2 11989.8 12039.3 12048.5 12054.1 12073.9 6547.8 6722.1 6725.2 6731.7 6753.1 6200.1 6267.7 6281.5 6347.1 6406.5 3994.9 4067.8 4073.0 4093.5 4096.7 1596.1 1609.5 1623.3 1649.2 1687.8 360.4 366.8 371.6 379.7 826.3 9149.4 9385.1 9402.6 9472.9 9918.8 369.7 387.5 405.5 409.3 815.2 4819.9 5002.2 5003.4 5051.8 5071.3 411879.0 412068.0 414534.0 418028.0 424165.0 63471.4 63725.7 64373.0 64922.7 64959.0 425.2 430.4 430.7 432.2 432.9 8885.0 9078.8 9137.8 9218.7 9238.2 29595.6 30287.8 30663.5 30921.1 31736.8 37233.0 37267.6 37377.0 37854.4 38557.8 6017.8 6194.8 6211.4 6332.1 6467.7 3037.0 3040.7 6631.0 7327.9 9636.7 7830.2 8074.8 8339.7 8644.8 9423.2 7356.3 8772.3 9248.8 9326.2 9375.0 2717.1 3550.7 3698.8 8928.7 9093.6 6432.1 6610.1 6610.3 6665.9 6687.9 7318.9 8273.5 8741.0 8753.4 8784.8 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#3] mootools.html Cycles:180 Average:4643.64 Median:5723.83 stddev:2340.32 (40.9%) stddev-sans-first:2333.72 02:00:03 INFO - PROCESS | 8276 | Values: 1341.7 1353.5 1437.2 1628.3 1657.9 6003.1 6130.2 6581.4 6754.1 6769.1 6462.2 6602.3 6638.4 6641.5 6680.2 1981.8 2001.8 2016.9 2018.5 2019.3 1994.6 1995.2 2002.4 2039.0 2042.1 1977.7 2001.8 2004.2 2015.4 2018.4 1996.5 2009.5 2011.5 2012.5 2013.6 1990.0 2002.1 2030.9 2040.1 2047.3 6434.9 6504.4 6530.4 6533.2 6554.5 3921.3 4009.8 4022.1 4030.7 4033.3 2554.1 2570.9 2611.1 2706.4 2716.6 839.5 857.6 867.1 868.1 1763.5 8443.8 8490.3 8503.8 8534.4 8556.2 3364.3 3414.4 3427.8 3468.0 3492.3 7158.1 7190.6 7221.6 7222.0 7232.3 3860.2 3884.8 3885.4 3885.4 3920.7 3551.2 3610.9 3617.2 3619.4 3626.2 3333.7 3345.8 3376.0 3382.3 3434.6 1034.1 1093.3 1093.3 1096.3 1104.7 1124.4 1145.4 1147.9 1151.3 1182.4 6111.8 6179.0 6203.4 6222.3 6233.3 392.2 392.4 394.7 395.5 403.7 5126.3 5196.4 5215.4 5225.4 5226.1 7377.0 7494.8 7871.2 7989.8 8064.0 7333.6 7448.1 7517.6 7530.6 7544.1 6307.6 6423.4 6424.6 6434.5 6444.0 6037.0 6180.7 6209.9 6218.7 6243.3 7070.2 7213.6 7301.3 7427.1 7453.4 7419.6 7477.5 7532.7 7595.5 7661.7 5369.6 5506.7 5667.1 5992.4 6098.5 6340.3 6344.0 6362.6 6371.5 6391.9 5922.9 5987.9 6030.6 6126.7 6159.8 5921.7 5985.1 6008.6 6067.9 6094.9 6054.5 6182.6 6197.9 6202.8 6209.6 5611.4 5686.4 5692.3 5704.6 5706.5 5651.2 5674.6 5741.1 5745.8 5757.7 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#4] prototype.html Cycles:180 Average:4833.92 Median:5553.99 stddev:1456.01 (26.2%) stddev-sans-first:1419.53 02:00:03 INFO - PROCESS | 8276 | Values: 286.8 294.6 297.6 302.7 305.0 5417.3 5519.6 5561.5 5577.9 5585.6 5362.9 5508.2 5537.7 5546.5 5575.2 4241.9 4286.8 4298.2 4300.2 4303.5 4248.6 4258.6 4286.8 4300.6 4305.7 4046.9 4165.3 4263.2 4270.1 4278.4 4184.4 4210.4 4215.2 4215.7 4221.3 3589.9 3625.9 3632.9 3642.6 3653.1 5315.3 5393.2 5408.4 5411.1 5415.1 4761.1 4830.2 4851.3 4854.0 4871.7 5818.5 5852.1 5867.4 5868.2 5884.1 3951.3 3952.8 3958.2 3964.6 3969.3 6153.9 6199.7 6215.8 6244.5 6254.8 3928.7 4046.6 4051.5 4057.2 4059.9 4121.9 4134.8 4154.4 4158.7 4165.1 4804.8 4808.8 4816.7 4819.2 4822.7 5848.7 5861.6 5868.9 5886.8 5887.8 1425.1 1448.8 1450.0 1452.5 1463.6 950.1 966.6 966.7 970.3 981.5 5023.0 5062.3 5099.1 5109.0 5114.0 6024.5 6040.4 6095.0 6096.9 6108.2 5089.4 5095.2 5104.8 5112.1 5125.0 3234.6 3261.6 3299.7 3311.3 3311.6 5729.0 5733.9 5734.2 5735.7 5741.1 6187.5 6210.9 6222.5 6230.4 6248.2 5566.7 5708.5 5724.9 5730.7 5731.6 6036.7 6053.5 6068.2 6069.1 6073.5 5905.4 5909.5 5912.1 5913.9 5915.0 5691.5 5710.7 5719.4 5720.6 5725.4 3964.5 4094.0 4096.9 4099.6 4115.8 5983.9 5996.1 6067.2 6072.2 6074.8 5949.8 5953.6 5957.5 5959.2 5985.7 5951.8 5958.8 5960.4 5970.5 5973.3 5673.2 5779.3 5800.2 5831.4 5841.3 5968.1 5984.0 5997.9 5998.6 6008.1 5849.2 5849.9 5853.2 5867.6 5868.3 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - PROCESS | 8276 | [#5] yui.html Cycles:180 Average:11345.41 Median:498.84 stddev:12719.73 (2549.9%) stddev-sans-first:12730.03 02:00:03 INFO - PROCESS | 8276 | Values: 644.0 661.7 662.1 673.9 760.9 10821.9 10829.7 10975.6 11125.4 11226.1 10365.8 10393.4 10482.0 10491.2 10540.3 592.7 598.9 728.2 734.4 740.8 725.9 734.5 745.3 746.7 747.0 764.7 765.7 770.6 772.9 774.0 776.7 777.2 777.8 778.1 780.0 566.3 569.0 569.3 570.4 571.6 10949.4 10961.1 11004.5 11006.6 11035.8 11585.2 11612.0 11811.8 11953.3 12258.0 9192.5 9281.0 9352.8 9383.0 9425.8 3185.8 3258.9 3281.8 3295.1 3295.4 36580.6 37014.0 37188.3 37236.6 37542.4 8521.1 8667.0 8710.1 8780.0 8808.0 13158.2 13227.7 13563.9 13607.0 13672.5 6203.5 6225.7 6293.6 6441.9 6528.4 3551.1 3592.1 3626.7 3636.0 3658.7 2607.1 2644.1 2645.7 2651.9 2667.5 436.6 448.5 453.7 455.7 456.4 480.7 516.9 539.1 552.2 556.4 7038.7 7164.9 7173.3 7209.9 7308.6 479.5 535.6 536.4 536.8 556.1 3437.2 3658.3 3690.9 3722.3 3809.9 43258.6 43434.1 43736.0 43797.1 43971.0 42433.0 42654.8 42702.6 42936.8 43233.4 35415.8 37767.4 38964.2 39052.0 39644.6 7462.6 7656.2 7702.2 7755.0 8029.8 29392.0 29452.7 29606.9 30073.2 30087.2 35569.1 36465.0 36632.5 36999.0 37089.3 8881.4 9003.4 9234.4 9288.6 9345.4 9785.8 10039.9 10122.4 10225.6 10665.7 9577.3 9592.8 9768.8 10023.3 10108.5 9559.7 9568.5 9582.9 9696.7 10016.8 8536.7 9381.5 9416.6 10087.6 10110.1 7802.3 7820.8 7965.4 8041.8 8322.5 8018.5 8047.4 8343.7 8365.6 8382.0 02:00:03 INFO - PROCESS | 8276 | -------- Summary: end -------- 02:00:03 INFO - PROCESS | 8276 | 02:00:03 INFO - TEST-INFO | 8276: exit 0 02:00:03 INFO - TEST-OK | dromaeo_css | took 1113909ms 02:00:03 INFO - TEST-START | kraken 02:00:03 INFO - operating with platform_type : linux_ 02:00:03 INFO - Initialising browser for kraken test... 02:00:03 INFO - TEST-INFO | started process 8516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8OQAtF/profile http://localhost:56747/getInfo.html) 02:00:07 INFO - PROCESS | 8516 | -- checkerboarding starts below -- 02:00:07 INFO - PROCESS | 8516 | RENDERTRACE 0.038459 rect red 0 0 1024 768 // viewport 02:00:07 INFO - PROCESS | 8516 | RENDERTRACE 300.878 rect brown 0 0 1024 768 // page 02:00:07 INFO - PROCESS | 8516 | RENDERTRACE 300.91 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 02:00:07 INFO - PROCESS | 8516 | Checkerboarded for 1 frames (316.748 ms), 786432 peak, 12129 severity. 02:00:07 INFO - PROCESS | 8516 | 02:00:07 INFO - PROCESS | 8516 | (process:8585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:00:08 INFO - PROCESS | 8516 | __metrics Screen width/height:1600/1200 02:00:08 INFO - PROCESS | 8516 | colorDepth:24 02:00:08 INFO - PROCESS | 8516 | Browser inner width/height: 1024/697 02:00:08 INFO - PROCESS | 8516 | __metrics 02:00:08 INFO - PROCESS | 8516 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:00:09 INFO - TEST-INFO | 8516: exit 0 02:00:09 INFO - Browser initialized. 02:00:09 INFO - Running cycle 1/1 for kraken test... 02:00:09 INFO - TEST-INFO | started process 8634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8OQAtF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:10 INFO - PROCESS | 8634 | -- checkerboarding starts below -- 02:00:10 INFO - PROCESS | 8634 | RENDERTRACE 0.031881 rect red 0 0 10 10 // viewport 02:00:10 INFO - PROCESS | 8634 | RENDERTRACE 26.0213 rect brown 0 0 10 10 // page 02:00:10 INFO - PROCESS | 8634 | RENDERTRACE 26.0406 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:00:10 INFO - PROCESS | 8634 | Checkerboarded for 1 frames (26.0897 ms), 100 peak, 1 severity. 02:00:10 INFO - PROCESS | 8634 | 02:00:10 INFO - PROCESS | 8634 | (process:8689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:00:21 INFO - PROCESS | 8634 | RSS: Main: 149262336 02:00:21 INFO - PROCESS | 8634 | 02:00:23 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56747/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:24 INFO - PROCESS | 8634 | RSS: Main: 150368256 02:00:24 INFO - PROCESS | 8634 | 02:00:27 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56747/tests/kraken/driver.html?testName=audio-dft) 02:00:27 INFO - PROCESS | 8634 | RSS: Main: 154329088 02:00:27 INFO - PROCESS | 8634 | 02:00:30 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56747/tests/kraken/driver.html?testName=audio-fft) 02:00:31 INFO - PROCESS | 8634 | RSS: Main: 147972096 02:00:31 INFO - PROCESS | 8634 | 02:00:33 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56747/tests/kraken/driver.html?testName=audio-oscillator) 02:00:34 INFO - PROCESS | 8634 | RSS: Main: 147226624 02:00:34 INFO - PROCESS | 8634 | 02:00:36 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:36 INFO - PROCESS | 8634 | RSS: Main: 148168704 02:00:36 INFO - PROCESS | 8634 | 02:00:39 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56747/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:40 INFO - PROCESS | 8634 | RSS: Main: 148406272 02:00:40 INFO - PROCESS | 8634 | 02:00:44 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56747/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:44 INFO - PROCESS | 8634 | RSS: Main: 148185088 02:00:44 INFO - PROCESS | 8634 | 02:00:47 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56747/tests/kraken/driver.html?testName=json-parse-financial) 02:00:48 INFO - PROCESS | 8634 | RSS: Main: 148545536 02:00:48 INFO - PROCESS | 8634 | 02:00:49 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:50 INFO - PROCESS | 8634 | RSS: Main: 148881408 02:00:50 INFO - PROCESS | 8634 | 02:00:52 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:53 INFO - PROCESS | 8634 | RSS: Main: 149065728 02:00:53 INFO - PROCESS | 8634 | 02:00:55 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:55 INFO - PROCESS | 8634 | RSS: Main: 149868544 02:00:55 INFO - PROCESS | 8634 | 02:00:58 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:00:58 INFO - PROCESS | 8634 | RSS: Main: 150450176 02:00:58 INFO - PROCESS | 8634 | 02:01:01 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:02 INFO - PROCESS | 8634 | RSS: Main: 149127168 02:01:02 INFO - PROCESS | 8634 | 02:01:03 INFO - PROCESS | 8634 | Cycle 1(1): loaded http://localhost:56747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56747/tests/kraken/driver.html?testName=ai-astar) 02:01:04 INFO - PROCESS | 8634 | RSS: Main: 149041152 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | __start_tp_report 02:01:04 INFO - PROCESS | 8634 | _x_x_mozilla_page_load 02:01:04 INFO - PROCESS | 8634 | _x_x_mozilla_page_load_details 02:01:04 INFO - PROCESS | 8634 | |i|pagename|runs| 02:01:04 INFO - PROCESS | 8634 | |0;ai-astar;118;111;117;115;115;127;116;115;117;115 02:01:04 INFO - PROCESS | 8634 | |1;audio-beat-detection;161;135;155;173;147;154;152;134;166;135 02:01:04 INFO - PROCESS | 8634 | |2;audio-dft;167;164;165;162;164;165;169;165;161;162 02:01:04 INFO - PROCESS | 8634 | |3;audio-fft;75;74;74;149;76;75;74;76;162;74 02:01:04 INFO - PROCESS | 8634 | |4;audio-oscillator;98;98;140;97;99;98;141;98;99;130 02:01:04 INFO - PROCESS | 8634 | |5;imaging-gaussian-blur;109;110;110;110;110;111;110;110;109;110 02:01:04 INFO - PROCESS | 8634 | |6;imaging-darkroom;147;147;149;147;148;147;148;148;148;149 02:01:04 INFO - PROCESS | 8634 | |7;imaging-desaturate;97;98;96;96;96;96;96;97;97;96 02:01:04 INFO - PROCESS | 8634 | |8;json-parse-financial;72;72;75;71;72;73;71;71;72;70 02:01:04 INFO - PROCESS | 8634 | |9;json-stringify-tinderbox;67;68;68;68;68;68;70;69;68;68 02:01:04 INFO - PROCESS | 8634 | |10;stanford-crypto-aes;82;85;85;85;85;91;84;83;83;85 02:01:04 INFO - PROCESS | 8634 | |11;stanford-crypto-ccm;123;121;121;121;124;124;127;126;126;129 02:01:04 INFO - PROCESS | 8634 | |12;stanford-crypto-pbkdf2;144;151;149;149;148;150;148;148;152;142 02:01:04 INFO - PROCESS | 8634 | |13;stanford-crypto-sha256-iterative;72;75;78;71;71;70;73;70;72;71 02:01:04 INFO - PROCESS | 8634 | __end_tp_report 02:01:04 INFO - PROCESS | 8634 | __start_cc_report 02:01:04 INFO - PROCESS | 8634 | _x_x_mozilla_cycle_collect,799 02:01:04 INFO - PROCESS | 8634 | __end_cc_report 02:01:04 INFO - PROCESS | 8634 | __startTimestamp1453284064201__endTimestamp 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | ------- Summary: start ------- 02:01:04 INFO - PROCESS | 8634 | Number of tests: 14 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.50 stddev:4.12 (3.5%) stddev-sans-first:4.33 02:01:04 INFO - PROCESS | 8634 | Values: 118.0 111.0 117.0 115.0 115.0 127.0 116.0 115.0 117.0 115.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.50 stddev:13.55 (8.8%) stddev-sans-first:13.90 02:01:04 INFO - PROCESS | 8634 | Values: 161.0 135.0 155.0 173.0 147.0 154.0 152.0 134.0 166.0 135.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.37 02:01:04 INFO - PROCESS | 8634 | Values: 167.0 164.0 165.0 162.0 164.0 165.0 169.0 165.0 161.0 162.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.50 stddev:34.19 (45.9%) stddev-sans-first:35.78 02:01:04 INFO - PROCESS | 8634 | Values: 75.0 74.0 74.0 149.0 76.0 75.0 74.0 76.0 162.0 74.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:98.00 stddev:19.00 (19.4%) stddev-sans-first:19.66 02:01:04 INFO - PROCESS | 8634 | Values: 98.0 98.0 140.0 97.0 99.0 98.0 141.0 98.0 99.0 130.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:01:04 INFO - PROCESS | 8634 | Values: 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 02:01:04 INFO - PROCESS | 8634 | Values: 147.0 147.0 149.0 147.0 148.0 147.0 148.0 148.0 148.0 149.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 02:01:04 INFO - PROCESS | 8634 | Values: 97.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:1.37 (1.9%) stddev-sans-first:1.45 02:01:04 INFO - PROCESS | 8634 | Values: 72.0 72.0 75.0 71.0 72.0 73.0 71.0 71.0 72.0 70.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 02:01:04 INFO - PROCESS | 8634 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 70.0 69.0 68.0 68.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:2.44 (2.9%) stddev-sans-first:2.37 02:01:04 INFO - PROCESS | 8634 | Values: 82.0 85.0 85.0 85.0 85.0 91.0 84.0 83.0 83.0 85.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.00 stddev:2.78 (2.2%) stddev-sans-first:2.92 02:01:04 INFO - PROCESS | 8634 | Values: 123.0 121.0 121.0 121.0 124.0 124.0 127.0 126.0 126.0 129.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.00 stddev:3.03 (2.0%) stddev-sans-first:2.83 02:01:04 INFO - PROCESS | 8634 | Values: 144.0 151.0 149.0 149.0 148.0 150.0 148.0 148.0 152.0 142.0 02:01:04 INFO - PROCESS | 8634 | 02:01:04 INFO - PROCESS | 8634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:2.50 (3.5%) stddev-sans-first:2.65 02:01:04 INFO - PROCESS | 8634 | Values: 72.0 75.0 78.0 71.0 71.0 70.0 73.0 70.0 72.0 71.0 02:01:04 INFO - PROCESS | 8634 | -------- Summary: end -------- 02:01:04 INFO - PROCESS | 8634 | 02:01:05 INFO - TEST-INFO | 8634: exit 0 02:01:05 INFO - TEST-OK | kraken | took 61510ms 02:01:05 INFO - TEST-START | v8_7 02:01:05 INFO - operating with platform_type : linux_ 02:01:05 INFO - Initialising browser for v8_7 test... 02:01:05 INFO - TEST-INFO | started process 8917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYuMiIA/profile http://localhost:56747/getInfo.html) 02:01:08 INFO - PROCESS | 8917 | 02:01:08 INFO - PROCESS | 8917 | (process:8988): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:01:09 INFO - PROCESS | 8917 | __metrics Screen width/height:1600/1200 02:01:09 INFO - PROCESS | 8917 | colorDepth:24 02:01:09 INFO - PROCESS | 8917 | Browser inner width/height: 1024/697 02:01:09 INFO - PROCESS | 8917 | __metrics 02:01:09 INFO - PROCESS | 8917 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:01:10 INFO - TEST-INFO | 8917: exit 0 02:01:10 INFO - Browser initialized. 02:01:10 INFO - Running cycle 1/1 for v8_7 test... 02:01:10 INFO - TEST-INFO | started process 9037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYuMiIA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:11 INFO - PROCESS | 9037 | -- checkerboarding starts below -- 02:01:11 INFO - PROCESS | 9037 | RENDERTRACE 0.03379 rect red 0 0 10 10 // viewport 02:01:11 INFO - PROCESS | 9037 | RENDERTRACE 88.7409 rect brown 0 0 10 10 // page 02:01:11 INFO - PROCESS | 9037 | RENDERTRACE 88.7648 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:01:11 INFO - PROCESS | 9037 | Checkerboarded for 1 frames (90.4822 ms), 100 peak, 1 severity. 02:01:12 INFO - PROCESS | 9037 | 02:01:12 INFO - PROCESS | 9037 | (process:9092): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:01:22 INFO - PROCESS | 9037 | RSS: Main: 150151168 02:01:22 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | Cycle 1(1): loaded http://localhost:56747/tests/v8_7/run.html (next: http://localhost:56747/tests/v8_7/run.html) 02:01:45 INFO - PROCESS | 9037 | RSS: Main: 145940480 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | __start_tp_report 02:01:45 INFO - PROCESS | 9037 | _x_x_mozilla_page_load 02:01:45 INFO - PROCESS | 9037 | _x_x_mozilla_page_load_details 02:01:45 INFO - PROCESS | 9037 | |i|pagename|runs| 02:01:45 INFO - PROCESS | 9037 | |0;Richards;167.64459346186086 02:01:45 INFO - PROCESS | 9037 | |1;DeltaBlue;186.98578908002992 02:01:45 INFO - PROCESS | 9037 | |2;Encrypt;280.50490883590464 02:01:45 INFO - PROCESS | 9037 | |3;Decrypt;5261.780104712042 02:01:45 INFO - PROCESS | 9037 | |4;RayTrace;1075.268817204301 02:01:45 INFO - PROCESS | 9037 | |5;Earley;742.0311341734619 02:01:45 INFO - PROCESS | 9037 | |6;Boyer;12587.5 02:01:45 INFO - PROCESS | 9037 | |7;RegExp;42408.163265306124 02:01:45 INFO - PROCESS | 9037 | |8;Splay;595.2380952380952 02:01:45 INFO - PROCESS | 9037 | |9;NavierStokes;4835.748792270531 02:01:45 INFO - PROCESS | 9037 | __end_tp_report 02:01:45 INFO - PROCESS | 9037 | __startTimestamp1453284105591__endTimestamp 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | ------- Summary: start ------- 02:01:45 INFO - PROCESS | 9037 | Number of tests: 10 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 167.6 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#1] DeltaBlue Cycles:1 Average:186.99 Median:186.99 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 187.0 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 280.5 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 5261.8 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 1075.3 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#5] Earley Cycles:1 Average:742.03 Median:742.03 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 742.0 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 12587.5 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#7] RegExp Cycles:1 Average:42408.16 Median:42408.16 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 42408.2 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#8] Splay Cycles:1 Average:595.24 Median:595.24 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 595.2 02:01:45 INFO - PROCESS | 9037 | 02:01:45 INFO - PROCESS | 9037 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 02:01:45 INFO - PROCESS | 9037 | Values: 4835.7 02:01:45 INFO - PROCESS | 9037 | -------- Summary: end -------- 02:01:45 INFO - PROCESS | 9037 | 02:01:46 INFO - TEST-INFO | 9037: exit 0 02:01:46 INFO - TEST-OK | v8_7 | took 41265ms 02:01:46 INFO - SUITE-END | took 1216s 02:01:46 INFO - Completed test suite (00:20:16) 02:01:46 INFO - Working with test: dromaeo_css 02:01:46 INFO - Generating results file: dromaeo_css 02:01:46 INFO - Working with test: kraken 02:01:46 INFO - Generating results file: kraken 02:01:46 INFO - javascript benchmark 02:01:46 INFO - Working with test: v8_7 02:01:46 INFO - Generating results file: v8_7 02:01:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 02:01:46 INFO - process_Request line: dromaeo_css 5835.37 graph.html#tests=[[72,132,43]] 02:01:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:46 INFO - process_Request line: kraken 1556.60 graph.html#tests=[[232,132,43]] 02:01:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:46 INFO - process_Request line: v8_7 20173.88 graph.html#tests=[[230,132,43]] 02:01:46 INFO - RETURN: dromaeo_css: 5835.37 02:01:46 INFO - RETURN: kraken: 1556.60 02:01:46 INFO - RETURN: v8_7: 20173.88 02:01:46 INFO - javascript benchmark 02:01:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2575.4462790500043, 2610.164747280871, 2637.9999999999986, 2652.3634327761333, 2661.8669066546668, 4394.165108629358, 4520.231560634696, 4544.454665440147, 4548.067646132543, 4570.154521413537, 4432.955670443303, 4466.263066594008, 4491.079328737609, 4520.254158063915, 4530.097359109174, 4191.538930717618, 4215.873523794291, 4259.467566554181, 4264.040590867061, 4279.935800962988, 4173.436586060889, 4189.350650649154, 4213.367994800789, 4225.028243503996, 4272.700910936236, 4113.691473139526, 4192.832286708558, 4195.202911446815, 4198.3282674772045, 4285.635720963722, 4203.348480985452, 4213.367994800774, 4214.978925105385, 4228.217779710763, 4253.532111467736, 4190.979045104786, 4196.223698615766, 4219.767912764797, 4231.936520952188, 4247.362895565659, 4312.82748690052, 4388.802503887333, 4397.560243975577, 4413.492448368414, 4413.889652758675, 4836.927446088312, 4846.224604063333, 4850.6362022848425, 4856.3201151838775, 4891.682040667345, 4909.435414927293, 4910.508949105097, 4910.8281210157475, 4929.2359684248995, 4933.975330123327, 4296.0548679290505, 4356.956430435718, 4358.847440339573, 4560.1335746208115, 4564.863054108382, 4890.413150421972, 4906.435759887588, 4927.334809800703, 4965.478624744422, 4978.0, 4738.099761045391, 4746.477887432379, 4749.145153872336, 4759.571638552547, 4795.160846851787, 4763.428388593391, 4812.205986012269, 4830.830920917751, 4849.054434385261, 4861.246506791453, 4846.345743324606, 4885.389326334208, 4891.364122664031, 4894.535019173173, 4922.581580565692, 4870.95129048705, 4879.097366987119, 4880.902381952412, 4884.169691152512, 4903.754812259373, 3992.740471869319, 4055.330870406409, 4136.627703506639, 4199.958000420018, 4231.217224813419, 3527.5766907970697, 3528.9236782780986, 3578.499010138583, 3582.820858957094, 3605.0626837022564, 4189.685773566934, 4202.537720850704, 4224.704270701083, 4231.597998190167, 4253.8723838284905, 4753.35829662998, 4849.806007759721, 4849.830255941025, 4865.513448655177, 4956.975215123901, 4222.387753775685, 4239.27932251518, 4246.44796176495, 4253.8723838284905, 4267.658587313008, 4387.648988080946, 4390.934135987963, 4394.582514661102, 4408.272635015251, 4442.378067070613, 4533.0, 4546.477155127137, 4566.589006989387, 4576.656750743641, 4631.560001799824, 4848.5636292733825, 4867.80528778859, 4881.487443818348, 4901.485344038967, 4915.26271059344, 4476.888077798081, 4626.514216007271, 4640.303954406866, 4641.443026836801, 4680.836170734145, 4697.459792123949, 4701.318308845267, 4826.396700412449, 4875.68308059975, 4910.779014944407, 4727.479977202436, 4791.880202994814, 4818.590419814355, 4824.49342819013, 4865.829695960624, 4597.885052873705, 4668.323093151406, 4672.672912896064, 4681.836135735233, 4724.527547245248, 4635.23518619424, 4763.0, 4785.234362501983, 4802.567768900815, 4842.443119041355, 4559.110973360163, 4577.656675749398, 4580.083983203306, 4614.100250451264, 4657.115148121846, 4546.88632784183, 4639.396878405786, 4674.906501869876, 4733.479317275028, 4789.425268967746, 4609.838655647036, 4623.791929363119, 4638.257878739386, 4655.790489427916, 4674.555917187861], "unit": "score", "name": "dojo.html", "value": 4458.541537102296}, {"lowerIsBetter": false, "replicates": [490.7816021870267, 527.0670912484904, 561.668615516845, 563.2846285217773, 566.6147020026382, 31456.213594660116, 32253.35493290133, 32284.838575807116, 32344.353112937726, 32380.0, 35401.645983540155, 35883.641163588356, 35959.0, 36023.279534409296, 36121.819390903074, 7614.276643718852, 7790.104138024143, 7819.882701759479, 7827.373810095179, 7838.216178382173, 7608.923910760905, 7726.266004729542, 7733.690652373898, 7821.8826717598995, 7873.527588344689, 7812.921870781304, 7814.218578142169, 7897.881531777028, 7917.049954005499, 7927.722529711461, 7620.352270057052, 7698.191689872567, 7712.074551053854, 7722.382209423233, 7781.727639532617, 6498.902516462257, 6586.440152587036, 6615.867682646368, 6616.933830661728, 6645.534812563123, 35487.64512354869, 35584.0, 35851.0, 36001.09997250063, 36024.81987590045, 2640.696319923195, 2746.4232511172677, 2797.202797202787, 2967.525195968656, 3192.5690031845634, 26876.328091797666, 27020.59469107965, 27163.864180679167, 27187.728122718716, 27343.906243750425, 3513.5959364673135, 3516.349475347069, 3519.2433626770367, 3598.748087633867, 3611.20553478237, 202975.0, 203147.0, 203354.0, 203567.0, 204310.0, 45158.54841451609, 51022.48977510251, 51165.74417127965, 51387.48612513827, 51414.0, 40873.386899196536, 55467.44532554623, 56693.14960275599, 56723.0, 56867.431325687045, 12516.561920332744, 12785.488580456864, 12812.231266124063, 12873.356332183354, 12886.484540618458, 9388.34281600295, 9430.339876208736, 9466.148046675833, 9474.05259474061, 9494.572744226527, 17997.460076197734, 18204.726929096076, 18228.635427291647, 18359.0, 18384.26462941494, 7086.539374940612, 7156.745625128068, 7251.637418129072, 7283.817904552323, 7383.2247614000835, 880.8414485392562, 892.9508877011697, 917.7934964633038, 921.2169655792522, 964.4647220792527, 22042.559148816934, 22085.779142208372, 22309.665355019686, 22455.55088898213, 22609.208677696202, 944.8157609266265, 955.0822238062647, 959.5298303831072, 961.4471678784587, 992.2012779712256, 11967.281963082243, 12043.518259269531, 12076.335801530824, 12105.394730263628, 12131.696707582205, 250006.0, 251835.0, 252051.0, 252167.0, 253639.0, 44043.55956440394, 44134.0, 44273.33589996152, 44280.557194428286, 44539.77730111329, 1169.4211365374194, 1179.6991767099335, 1180.6635108994067, 1191.7616476704693, 1218.1290377380217, 23040.539189215786, 23254.0, 23357.532849342577, 23395.362324637113, 23482.882585587646, 30382.0, 30665.386692265583, 30677.386452271276, 36674.8166259167, 36841.631583684895, 229904.0, 231686.0, 232285.0, 232503.0, 232613.0, 27457.17628471149, 27738.583921240795, 28339.574906376834, 28454.715452846034, 28457.857710711312, 32610.0, 32759.344813104082, 33384.49923251202, 33573.16067098244, 33666.15834604057, 27431.451370972867, 27939.44121117607, 28115.57826632643, 28706.856465717538, 29337.413251735274, 27926.3018424541, 28217.576736349383, 28234.43531129407, 28867.711322887342, 29202.707972919998, 30446.543301850048, 30757.384852303276, 30807.2298192538, 31157.88421157866, 31201.531977020815, 27037.459250815267, 27327.642154660592, 28430.0, 28472.0, 31554.0, 22252.88873555622, 22716.659250111592, 22850.42873928165, 22955.311340659806, 22982.885085574464], "unit": "score", "name": "ext.html", "value": 15687.17643257475}, {"lowerIsBetter": false, "replicates": [334.68539572801575, 336.77604393078605, 340.2497493027874, 341.0892915914508, 342.68644190565635, 14075.648108797284, 14446.347827819049, 14582.41670333188, 15204.923975380108, 15363.0, 9353.298502612315, 9619.278554108452, 10819.945900270508, 14918.850811491882, 14974.700505989873, 4381.518033016366, 4550.567696068868, 4610.031893302411, 4620.5148459411785, 5040.697558146505, 4917.950820491803, 4970.105381031413, 4978.153713868633, 4985.052839960414, 4986.35177426934, 3247.480403135499, 3414.7951122932577, 4855.5872750816225, 4942.258661200813, 4957.454679985199, 5090.694558326512, 5105.310783044279, 5121.539061484447, 5129.9230511542355, 5143.331366922295, 4752.120857641313, 4976.2038073908, 4976.950230497685, 4977.855093328555, 4989.800407983676, 10545.78908421835, 10791.29856559329, 12579.811302830465, 17027.48917532476, 17083.487495375157, 1741.2251548061117, 1783.1975610974982, 1826.8355847973614, 1845.2342277954633, 1863.5806943437753, 7753.728619498347, 8208.548529830858, 9144.40561363516, 9354.0, 12206.694832629166, 1582.6280824006349, 1586.7699183618427, 1604.879634027441, 1608.404890190637, 1615.6122530592572, 48017.51982480165, 48749.0, 49025.264621030714, 49484.257736133986, 50585.74707126478, 9334.346595738232, 9337.579808908615, 9408.153266206074, 9449.905500944902, 9466.242700584075, 11989.760204795855, 12039.337836419081, 12048.457819398149, 12054.095942804324, 12073.939630301968, 6547.770828021092, 6722.092517510074, 6725.226598941086, 6731.730730770714, 6753.088333074972, 6200.0699895015205, 6267.71795269214, 6281.528885333618, 6347.079673447324, 6406.487481001509, 3994.940075898864, 4067.7966101694797, 4072.959270407258, 4093.5497095319492, 4096.73371230869, 1596.0503500417233, 1609.4769200010044, 1623.3019801485475, 1649.2413489794828, 1687.8480936715755, 360.38734151941804, 366.8055930356915, 371.6376532880474, 379.6583075232313, 826.3141592478229, 9149.413121514546, 9385.06149385056, 9402.576884040234, 9472.857907131398, 9918.80162396748, 369.7393337696971, 387.521411057344, 405.5093337062129, 409.3307442331809, 815.2092470303796, 4819.879503012453, 5002.249662550574, 5003.424606170264, 5051.797928082909, 5071.264666623319, 411879.0, 412068.0, 414534.0, 418028.0, 424165.0, 63471.36528634747, 63725.681371592844, 64373.0, 64922.67538662277, 64959.0, 425.23457776003073, 430.3866989539893, 430.71572761976944, 432.19180133151207, 432.85283003778864, 8885.0, 9078.773030674285, 9137.766401535708, 9218.677346292847, 9238.214751745909, 29595.556066658588, 30287.848560757055, 30663.540046898866, 30921.072367829, 31736.841315793274, 37233.0, 37267.62732372642, 37377.0, 37854.43218351672, 38557.807210963765, 6017.849553761191, 6194.752209911553, 6211.378862113753, 6332.145160403471, 6467.708953097028, 3037.0433313506173, 3040.650325212629, 6631.038499417654, 7327.890081648886, 9636.71089867305, 7830.2169783021245, 8074.757757267292, 8339.708110216114, 8644.78388040304, 9423.19902808269, 7356.337929586363, 8772.29821614282, 9248.815023699623, 9326.207272381924, 9375.01562335945, 2717.062613398374, 3550.7159427246274, 3698.8150592470806, 8928.687495937611, 9093.590788414405, 6432.131662225727, 6610.140681711347, 6610.305917878553, 6665.866682666417, 6687.866242675022, 7318.853622927405, 8273.503589784632, 8741.0, 8753.431026983226, 8784.78038049054], "unit": "score", "name": "jquery.html", "value": 6377.418372697115}, {"lowerIsBetter": false, "replicates": [1341.6779972806526, 1353.5059703208328, 1437.1520802726388, 1628.3486605357848, 1657.9245499598253, 6003.0695242237525, 6130.203073600425, 6581.407673309402, 6754.121964144654, 6769.120014398128, 6462.159919210508, 6602.339766023408, 6638.369354911276, 6641.4686825054005, 6680.198376194851, 1981.782003979561, 2001.8098280663314, 2016.949576260598, 2018.5054661607926, 2019.2831544801604, 1994.5611965367596, 1995.2019192323114, 2002.4092892596718, 2039.0416504242983, 2042.132093860111, 1977.6835706286997, 2001.8198362147405, 2004.2383894120287, 2015.3953813855858, 2018.3944816555047, 1996.5208349996042, 2009.457446489447, 2011.5474018345901, 2012.5270561418056, 2013.5872146210138, 1990.0, 2002.1290738528787, 2030.8883011434366, 2040.1329434990218, 2047.2732180076007, 6434.903476447857, 6504.414602685781, 6530.44491218247, 6533.248676402227, 6554.475641948633, 3921.29416704993, 4009.759414435114, 4022.054817117975, 4030.717849750519, 4033.253848038122, 2554.118829003991, 2570.9228723138335, 2611.138324352959, 2706.418120104187, 2716.6468359113187, 839.5382539603194, 857.5540718826238, 867.1025488619312, 868.1448772958631, 1763.5150333658346, 8443.788905277355, 8490.278326342268, 8503.82992340156, 8534.445261058012, 8556.229939305493, 3364.343952929204, 3414.402479566066, 3427.811470369104, 3467.9826600866836, 3492.2666240089357, 7158.06945097134, 7190.640467976685, 7221.602811845294, 7221.96389018062, 7232.349088582053, 3860.1700634363183, 3884.8057597120032, 3885.3977633466857, 3885.436611691289, 3920.666743326792, 3551.1654761131113, 3610.8736194233074, 3617.2403795202777, 3619.438986956973, 3626.1841085756023, 3333.71663408613, 3345.7825241359233, 3376.0, 3382.255903701182, 3434.639362866863, 1034.0848349211003, 1093.2565855218527, 1093.3057508482011, 1096.3038470571244, 1104.6575561575937, 1124.3703526025452, 1145.3585991844593, 1147.9483423245974, 1151.3264740126951, 1182.3851597169423, 6111.755529778848, 6179.0, 6203.4416902479, 6222.284437289679, 6233.34549872266, 392.1529496288004, 392.3741632096801, 394.7335548504748, 395.4661207370085, 403.7375705791201, 5126.307948426989, 5196.350456192976, 5215.374155101412, 5225.399079105951, 5226.059309324358, 7377.0, 7494.812629684301, 7871.173526779606, 7989.8402031960195, 8064.0, 7333.559986400833, 7448.068991376078, 7517.586532740752, 7530.623468826537, 7544.132424771112, 6307.590006649553, 6423.389777971085, 6424.550281480345, 6434.549581529342, 6444.033394990695, 6037.0, 6180.6600636965395, 6209.937900621117, 6218.689065546795, 6243.313235543996, 7070.222275549582, 7213.567185968858, 7301.306375894282, 7427.071616047994, 7453.440991925736, 7419.591922444318, 7477.476576639583, 7532.698692052257, 7595.506292090997, 7661.693532258647, 5369.624126311121, 5506.724663766876, 5667.064934285797, 5992.43071908168, 6098.542609304409, 6340.270868850142, 6343.9682801585695, 6362.618242905255, 6371.49028077762, 6391.904121438275, 5922.940770592239, 5987.910181347196, 6030.5778595497895, 6126.693665316806, 6159.784407545714, 5921.733521991435, 5985.132155837292, 6008.579399441997, 6067.939320606914, 6094.908576371269, 6054.545909056927, 6182.598131121463, 6197.938020619917, 6202.782902598387, 6209.5963762357105, 5611.38274789781, 5686.43135686428, 5692.3169219692245, 5704.600677952503, 5706.514946229451, 5651.237082993744, 5674.602777805679, 5741.1388291756575, 5745.770169193185, 5757.65454072757], "unit": "score", "name": "mootools.html", "value": 3805.8453016610174}, {"lowerIsBetter": false, "replicates": [286.769150833579, 294.62876775263175, 297.62647876914474, 302.6549733304034, 304.99237519062007, 5417.295751552293, 5519.641223320481, 5561.47166019228, 5577.916331255029, 5585.581081418894, 5362.865928351793, 5508.173773933912, 5537.667739935607, 5546.500814926656, 5575.2473416088815, 4241.872743817675, 4286.828526858938, 4298.204832106055, 4300.1829652366105, 4303.548127446612, 4248.596383343577, 4258.552851950547, 4286.7568405162465, 4300.591443812833, 4305.741655500664, 4046.858359957402, 4165.312723400635, 4263.232618128735, 4270.12462445198, 4278.4438023056955, 4184.372344148372, 4210.410542524049, 4215.199112168709, 4215.683823713233, 4221.261279276115, 3589.8743543976097, 3625.854965801365, 3632.891013269606, 3642.5811031731423, 3653.1232504199065, 5315.309009828737, 5393.164059570773, 5408.35099788024, 5411.107167317388, 5415.0523658360025, 4761.095391875532, 4830.178869592142, 4851.296561998526, 4854.0, 4871.732054736988, 5818.5345172386105, 5852.122181672783, 5867.413258674141, 5868.23712917318, 5884.146798714162, 3951.288768021755, 3952.7628342299554, 3958.188571342868, 3964.623360780721, 3969.3450580654157, 6153.907691384633, 6199.659018753967, 6215.751369945152, 6244.469220116295, 6254.8123556293385, 3928.705347098979, 4046.5751096135073, 4051.473308469939, 4057.188562287495, 4059.878203653895, 4121.91756164875, 4134.813933373005, 4154.4183814266025, 4158.688098392633, 4165.146145040259, 4804.759762011886, 4808.783604737795, 4816.735079570657, 4819.1566475867285, 4822.734749588806, 5848.736806843703, 5861.648301101947, 5868.911966320508, 5886.823395298148, 5887.793927212527, 1425.095064633965, 1448.8116544849313, 1449.9855001450062, 1452.5134080083078, 1463.604826696786, 950.097407462913, 966.5698764050071, 966.7293157915794, 970.3256236915418, 981.5190556627344, 5022.970291090391, 5062.341895553554, 5099.107656160157, 5109.029284435946, 5113.9744301279, 6024.548158888101, 6040.365761595057, 6095.0, 6096.902557539685, 6108.205933228652, 5089.389273287229, 5095.210242412432, 5104.821331253463, 5112.130937740519, 5124.9743751281, 3234.6280177779386, 3261.575995120619, 3299.653536378694, 3311.288073064303, 3311.569495965557, 5728.971355143198, 5733.88532229353, 5734.2258795062135, 5735.713214339266, 5741.052726300197, 6187.504999600022, 6210.875782484325, 6222.502199824004, 6230.408111229426, 6248.156498872685, 5566.749496272597, 5708.514776243983, 5724.914126288192, 5730.684812335278, 5731.627444216196, 6036.6679832609625, 6053.4551890330085, 6068.21113255274, 6069.089636554376, 6073.48375388097, 5905.379935106752, 5909.468147866713, 5912.142739302863, 5913.85215369602, 5915.0, 5691.516221121251, 5710.743016564347, 5719.428057194247, 5720.570957178312, 5725.427457254241, 3964.5044369453817, 4093.9795301024496, 4096.897577560585, 4099.569545197712, 4115.835366585423, 5983.850403739942, 5996.1005849122985, 6067.150598916067, 6072.240969878765, 6074.757009719562, 5949.8215053548465, 5953.583249172516, 5957.49361304294, 5959.225300711053, 5985.700714964321, 5951.791687290924, 5958.791442299499, 5960.374160713062, 5970.492508136857, 5973.283206015132, 5673.234113394639, 5779.2775903012125, 5800.1589769484035, 5831.4168583141345, 5841.269841269841, 5968.104784282219, 5984.042553191469, 5997.880042399215, 5998.610090344114, 6008.128821320972, 5849.151872978479, 5849.912251316318, 5853.1805547222575, 5867.589268751147, 5868.2664666916635], "unit": "score", "name": "prototype.html", "value": 4355.770526627294}, {"lowerIsBetter": false, "replicates": [643.9710213040413, 661.7286912365931, 662.1061566884704, 673.8854394752891, 760.9429292803039, 10821.945890270548, 10829.729256768585, 10975.61585344512, 11125.388103654306, 11226.101911847052, 10365.844512332302, 10393.376397416161, 10482.0, 10491.213159013067, 10540.262181647287, 592.7303077099909, 598.8622616798139, 728.1989811207669, 734.4014628078099, 740.8407192453622, 725.9382952449048, 734.5299008634478, 745.3440971944681, 746.7461063238497, 746.9589172595505, 764.6864785437972, 765.674588299973, 770.6493545436841, 772.8531579, 774.0363247756551, 776.6854423958277, 777.2305417636527, 777.8327659553166, 778.1284960843834, 779.95710235937, 566.3232437237502, 569.0184431855058, 569.313976658126, 570.4381184533273, 571.622728998863, 10949.397783121925, 10961.12311015117, 11004.504797284062, 11006.559737610485, 11035.83446248307, 11585.18903676743, 11612.0, 11811.763764724743, 11953.342566158857, 12258.0, 9192.54782279141, 9280.953595232048, 9352.812943741086, 9382.95308523453, 9425.76435589109, 3185.7769956103084, 3258.853351599184, 3281.786683865541, 3295.1103202135528, 3295.3903527847187, 36580.63419365772, 37014.0, 37188.326525306424, 37236.57962232446, 37542.43686344707, 8521.10528394522, 8667.0, 8710.085441028601, 8780.0, 8808.0, 13158.21050736959, 13227.735445291233, 13563.864361356458, 13607.0, 13672.52146174879, 6203.503719702413, 6225.719842607094, 6293.559450838489, 6441.935580644134, 6528.400541867273, 3551.1122219445137, 3592.1199306170156, 3626.7279954003557, 3635.9636403636155, 3658.6707196352454, 2607.113581382339, 2644.087789712546, 2645.708972013077, 2651.8939242430474, 2667.5065112954167, 436.6245029274821, 448.46184578505273, 453.7368326370697, 455.6992385025867, 456.3724878292348, 480.73319307783817, 516.9483051694875, 539.134688824439, 552.1607157121233, 556.3824155187739, 7038.718451261994, 7164.856702865914, 7173.318534739192, 7209.89185162223, 7308.6345682715655, 479.54443278885196, 535.6009772719349, 536.3885170905171, 536.7906516458585, 556.1241045353504, 3437.1750779812664, 3658.2683463307444, 3690.944635830465, 3722.3299806034634, 3809.8666546670734, 43258.567414326084, 43434.131317373474, 43736.0, 43797.12405751867, 43971.0, 42433.0, 42654.78672606617, 42702.57297427048, 42936.785316073845, 43233.35149972753, 35415.82292088523, 37767.43348849769, 38964.22071558553, 39052.0, 39644.60355396467, 7462.552246865205, 7656.157822639394, 7702.191269916802, 7754.961225193838, 8029.799255018671, 29392.0, 29452.705472945854, 29606.851965740894, 30073.248168795955, 30087.247818804706, 35569.1107722309, 36465.0, 36632.45051324285, 36999.0, 37089.25821483609, 8881.378303518692, 9003.369764116449, 9234.353595248536, 9288.58201380953, 9345.392549484262, 9785.80428391414, 10039.899601003897, 10122.392656440637, 10225.642102526375, 10665.680029599125, 9577.281703872099, 9592.808143836945, 9768.804623907625, 10023.348482348623, 10108.54511546997, 9559.713208603753, 9568.473733944422, 9582.904170958202, 9696.70909872705, 10016.799664006825, 8536.658533658585, 9381.530923453663, 9416.576254068446, 10087.646932357333, 10110.09009189147, 7802.33680137172, 7820.765377038698, 7965.402594805297, 8041.758747237593, 8322.54226017575, 8018.478798878287, 8047.407052098735, 8343.707970221014, 8365.62354694028, 8381.958090209753], "unit": "score", "name": "yui.html", "value": 5339.10675615344}], "name": "dromaeo_css", "value": 5835.366944339475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 111.0, 117.0, 115.0, 115.0, 127.0, 116.0, 115.0, 117.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.6}, {"lowerIsBetter": true, "replicates": [161.0, 135.0, 155.0, 173.0, 147.0, 154.0, 152.0, 134.0, 166.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [167.0, 164.0, 165.0, 162.0, 164.0, 165.0, 169.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 149.0, 76.0, 75.0, 74.0, 76.0, 162.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.9}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 140.0, 97.0, 99.0, 98.0, 141.0, 98.0, 99.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 71.0, 72.0, 73.0, 71.0, 71.0, 72.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 85.0, 85.0, 85.0, 91.0, 84.0, 83.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 121.0, 121.0, 124.0, 124.0, 127.0, 126.0, 126.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [144.0, 151.0, 149.0, 149.0, 148.0, 150.0, 148.0, 148.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 78.0, 71.0, 71.0, 70.0, 73.0, 70.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1556.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [186.98578908002992], "unit": "score", "name": "DeltaBlue", "value": 353.5990640000001}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [742.0311341734619], "unit": "score", "name": "Earley", "value": 898.1604265734265}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [42408.163265306124], "unit": "score", "name": "RegExp", "value": 21.481359480269475}, {"lowerIsBetter": false, "replicates": [595.2380952380952], "unit": "score", "name": "Splay", "value": 136.90488}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20173.87823667274}]} 02:01:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20173.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5835.37"}}} 02:01:46 INFO - Return code: 0 02:01:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:01:46 INFO - # TBPL SUCCESS # 02:01:46 INFO - Running post-action listener: _resource_record_post_action 02:01:46 INFO - Running post-run listener: _resource_record_post_run 02:01:47 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551960576; Read time: 8; Write time: 657648 02:01:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243265536; Read time: 0; Write time: 428260 02:01:47 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308695040; Read time: 8; Write time: 229388 02:01:47 INFO - Running post-run listener: _upload_blobber_files 02:01:47 INFO - Blob upload gear active. 02:01:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:47 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 02:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:01:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:49 INFO - (blobuploader) - INFO - Done attempting. 02:01:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:50 INFO - (blobuploader) - INFO - Done attempting. 02:01:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:50 INFO - Return code: 0 02:01:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76422795070bad5655e1e3d22d4a7b66f874cecef67cea265bbe11631337974d2790b4110da60e3091f5594df5a846968ff24ff8507240232830e5f04120892b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2265523e9458a24b01ee31398966bf773135a56abef47d296737cda799154dcae1ceb4d68acd0298a2a1adf53bfec95a4faebdd6f97a26c6f46f3034363a695f"} 02:01:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:50 INFO - Contents: 02:01:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76422795070bad5655e1e3d22d4a7b66f874cecef67cea265bbe11631337974d2790b4110da60e3091f5594df5a846968ff24ff8507240232830e5f04120892b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2265523e9458a24b01ee31398966bf773135a56abef47d296737cda799154dcae1ceb4d68acd0298a2a1adf53bfec95a4faebdd6f97a26c6f46f3034363a695f"} 02:01:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:50 INFO - Copying logs to upload dir... 02:01:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.134619 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-20 02:01:49.696668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 02:01:49.699988) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76422795070bad5655e1e3d22d4a7b66f874cecef67cea265bbe11631337974d2790b4110da60e3091f5594df5a846968ff24ff8507240232830e5f04120892b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2265523e9458a24b01ee31398966bf773135a56abef47d296737cda799154dcae1ceb4d68acd0298a2a1adf53bfec95a4faebdd6f97a26c6f46f3034363a695f"} build_url:https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/Xwf0R_pnRe-oHcoB1CxB8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76422795070bad5655e1e3d22d4a7b66f874cecef67cea265bbe11631337974d2790b4110da60e3091f5594df5a846968ff24ff8507240232830e5f04120892b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2265523e9458a24b01ee31398966bf773135a56abef47d296737cda799154dcae1ceb4d68acd0298a2a1adf53bfec95a4faebdd6f97a26c6f46f3034363a695f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 02:01:49.725707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 02:01:49.726315) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453273681.235537-480311691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 02:01:49.807350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 02:01:49.807684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 02:01:49.807972) ========= ========= Total master_lag: 0.28 =========