builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1451530310.13 results: success (0) buildid: 20151230174339 builduid: e3231f7c488c41ddb20427655b49af3a revision: 6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.128688) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.129208) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.129522) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006420 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.153151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.153480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.248761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.249035) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.268751) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.269049) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.269452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.269744) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 18:51:51-- 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% 226M=0s 2015-12-30 18:51:51 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.459224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.459524) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.508948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:50.509276) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817 --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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 18:51:51,318 truncating revision to first 12 chars 2015-12-30 18:51:51,318 Setting DEBUG logging. 2015-12-30 18:51:51,318 attempt 1/10 2015-12-30 18:51:51,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/6f4ef2a14886?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 18:51:51,661 unpacking tar archive at: b2g-inbound-6f4ef2a14886/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:51.135522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:51.135827) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:51.145618) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:51.145866) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:51:51.146255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2015-12-30 18:51:51.146555) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:51:52 INFO - MultiFileLogger online at 20151230 18:51:52 in /builds/slave/test 18:51:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 18:51:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:51:52 INFO - {'append_to_log': False, 18:51:52 INFO - 'base_work_dir': '/builds/slave/test', 18:51:52 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 18:51:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:51:52 INFO - 'branch': 'B2G-Inbound-Non-PGO', 18:51:52 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:52 INFO - 'config_files': ('talos/linux_config.py',), 18:51:52 INFO - 'default_actions': ('clobber', 18:51:52 INFO - 'read-buildbot-config', 18:51:52 INFO - 'download-and-extract', 18:51:52 INFO - 'populate-webroot', 18:51:52 INFO - 'create-virtualenv', 18:51:52 INFO - 'install', 18:51:52 INFO - 'run-tests'), 18:51:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:52 INFO - 'download_minidump_stackwalk': True, 18:51:52 INFO - 'download_symbols': 'ondemand', 18:51:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:52 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:52 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:52 INFO - 'installer_path': 'installer.exe', 18:51:52 INFO - 'log_level': 'info', 18:51:52 INFO - 'log_name': 'talos', 18:51:52 INFO - 'log_to_console': True, 18:51:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:51:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:51:52 INFO - 'opt_config_files': (), 18:51:52 INFO - 'pip_index': False, 18:51:52 INFO - 'sps_profile': False, 18:51:52 INFO - 'sps_profile_interval': 0, 18:51:52 INFO - 'suite': 'dromaeojs', 18:51:52 INFO - 'system_bits': '32', 18:51:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:52 INFO - 'title': 'talos-linux64-ix-020', 18:51:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:52 INFO - 'use_talos_json': True, 18:51:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:51:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:52 INFO - 'work_dir': 'build'} 18:51:52 INFO - ##### 18:51:52 INFO - ##### Running clobber step. 18:51:52 INFO - ##### 18:51:52 INFO - Running pre-action listener: _resource_record_pre_action 18:51:52 INFO - Running main action method: clobber 18:51:52 INFO - rmtree: /builds/slave/test/build 18:51:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:51:52 INFO - Running post-action listener: _resource_record_post_action 18:51:52 INFO - ##### 18:51:52 INFO - ##### Running read-buildbot-config step. 18:51:52 INFO - ##### 18:51:52 INFO - Running pre-action listener: _resource_record_pre_action 18:51:52 INFO - Running main action method: read_buildbot_config 18:51:52 INFO - Using buildbot properties: 18:51:52 INFO - { 18:51:52 INFO - "project": "", 18:51:52 INFO - "product": "firefox", 18:51:52 INFO - "script_repo_revision": "production", 18:51:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 18:51:52 INFO - "repository": "", 18:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 18:51:52 INFO - "buildid": "20151230174339", 18:51:52 INFO - "pgo_build": "False", 18:51:53 INFO - "basedir": "/builds/slave/test", 18:51:53 INFO - "buildnumber": 0, 18:51:53 INFO - "slavename": "talos-linux64-ix-020", 18:51:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:51:53 INFO - "platform": "ubuntu64_hw", 18:51:53 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 18:51:53 INFO - "branch": "b2g-inbound", 18:51:53 INFO - "repo_path": "integration/b2g-inbound", 18:51:53 INFO - "revision": "6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817", 18:51:53 INFO - "stage_platform": "linux64", 18:51:53 INFO - "builduid": "e3231f7c488c41ddb20427655b49af3a", 18:51:53 INFO - "slavebuilddir": "test" 18:51:53 INFO - } 18:51:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:51:53 INFO - Running post-action listener: _resource_record_post_action 18:51:53 INFO - ##### 18:51:53 INFO - ##### Running download-and-extract step. 18:51:53 INFO - ##### 18:51:53 INFO - Running pre-action listener: _resource_record_pre_action 18:51:53 INFO - Running main action method: download_and_extract 18:51:53 INFO - mkdir: /builds/slave/test/build/tests 18:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:53 INFO - https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:51:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/test_packages.json 18:51:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/test_packages.json 18:51:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:51:53 INFO - Downloaded 1302 bytes. 18:51:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:51:53 INFO - Using the following test package requirements: 18:51:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:51:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'jsshell-linux-x86_64.zip'], 18:51:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:51:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:51:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:51:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:51:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:51:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:53 INFO - https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:51:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:51:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:51:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:52:08 INFO - Downloaded 21946225 bytes. 18:52:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:52:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:52:09 INFO - Return code: 0 18:52:09 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:52: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')]} 18:52:09 INFO - https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:52:11 INFO - Downloaded 21946225 bytes. 18:52:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:52:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:52:12 INFO - Return code: 0 18:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:12 INFO - https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:52:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:52:13 INFO - Downloaded 11132285 bytes. 18:52:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:52:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:52:13 INFO - Return code: 0 18:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:13 INFO - https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:52:27 INFO - Downloaded 53364193 bytes. 18:52:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:27 INFO - mkdir: /builds/slave/test/properties 18:52:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:52:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:52:27 INFO - Contents: 18:52:27 INFO - build_url:https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:27 INFO - Running post-action listener: _resource_record_post_action 18:52:27 INFO - Running post-action listener: set_extra_try_arguments 18:52:27 INFO - ##### 18:52:27 INFO - ##### Running populate-webroot step. 18:52:27 INFO - ##### 18:52:27 INFO - Running pre-action listener: _resource_record_pre_action 18:52:27 INFO - Running main action method: populate_webroot 18:52:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:52:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:52:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:52:27 INFO - '--tppagecycles', 18:52:27 INFO - '7'], 18:52:27 INFO - 'tests': ['tsvgm']}}, 18:52:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:52:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:52:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:52:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:52:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'tests': ['damp', 'tps']}, 18:52:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['damp', 'tps']}, 18:52:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:52:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:52:27 INFO - 'other': {'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'other_l64': {'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'other_nol64': {'tests': ['a11yr', 18:52:27 INFO - 'ts_paint', 18:52:27 INFO - 'tpaint', 18:52:27 INFO - 'sessionrestore', 18:52:27 INFO - 'sessionrestore_no_auto_restore']}, 18:52:27 INFO - 'svgr': {'tests': ['tsvgx', 18:52:27 INFO - 'tsvgr_opacity', 18:52:27 INFO - 'tart', 18:52:27 INFO - 'tscrollx', 18:52:27 INFO - 'cart']}, 18:52:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['tsvgx', 18:52:27 INFO - 'tsvgr_opacity', 18:52:27 INFO - 'tart', 18:52:27 INFO - 'tscrollx', 18:52:27 INFO - 'cart']}, 18:52:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'tests': ['tp5o']}, 18:52:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'talos_options': ['--e10s'], 18:52:27 INFO - 'tests': ['tp5o']}, 18:52:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'talos_options': ['--xperf_path', 18:52:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:27 INFO - 'tests': ['tp5n']}, 18:52:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:27 INFO - 'talos_options': ['--e10s', 18:52:27 INFO - '--xperf_path', 18:52:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:27 INFO - 'tests': ['tp5n']}}, 18:52:27 INFO - 'talos.zip': {'path': '', 18:52:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:52:27 INFO - Running post-action listener: _resource_record_post_action 18:52:27 INFO - ##### 18:52:27 INFO - ##### Running create-virtualenv step. 18:52:27 INFO - ##### 18:52:27 INFO - Running pre-action listener: _resource_record_pre_action 18:52:27 INFO - Running main action method: create_virtualenv 18:52:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:52:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:52:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:52:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:52:27 INFO - Using real prefix '/usr' 18:52:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:52:27 INFO - Installing distribute.............................................................................................................................................................................................done. 18:52:29 INFO - Installing pip.................done. 18:52:29 INFO - Return code: 0 18:52:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:52:29 INFO - Using env: {'DISPLAY': ':0', 18:52:29 INFO - 'HOME': '/home/cltbld', 18:52:29 INFO - 'LANG': 'en_US.UTF-8', 18:52:29 INFO - 'LANGUAGE': 'en_US:en', 18:52:29 INFO - 'LOGNAME': 'cltbld', 18:52:29 INFO - 'MAIL': '/var/mail/cltbld', 18:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:29 INFO - 'MOZ_NO_REMOTE': '1', 18:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:29 INFO - 'NO_EM_RESTART': '1', 18:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:29 INFO - 'PWD': '/builds/slave/test', 18:52:29 INFO - 'SHELL': '/bin/bash', 18:52:29 INFO - 'SHLVL': '1', 18:52:29 INFO - 'TERM': 'linux', 18:52:29 INFO - 'TMOUT': '86400', 18:52:29 INFO - 'USER': 'cltbld', 18:52:29 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:29 INFO - '_': '/tools/buildbot/bin/python'} 18:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:52:29 INFO - Cleaning up... 18:52:29 INFO - Return code: 0 18:52:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:52:29 INFO - Using env: {'DISPLAY': ':0', 18:52:29 INFO - 'HOME': '/home/cltbld', 18:52:29 INFO - 'LANG': 'en_US.UTF-8', 18:52:29 INFO - 'LANGUAGE': 'en_US:en', 18:52:29 INFO - 'LOGNAME': 'cltbld', 18:52:29 INFO - 'MAIL': '/var/mail/cltbld', 18:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:29 INFO - 'MOZ_NO_REMOTE': '1', 18:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:29 INFO - 'NO_EM_RESTART': '1', 18:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:29 INFO - 'PWD': '/builds/slave/test', 18:52:29 INFO - 'SHELL': '/bin/bash', 18:52:29 INFO - 'SHLVL': '1', 18:52:29 INFO - 'TERM': 'linux', 18:52:29 INFO - 'TMOUT': '86400', 18:52:29 INFO - 'USER': 'cltbld', 18:52:29 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:29 INFO - '_': '/tools/buildbot/bin/python'} 18:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:30 INFO - Downloading/unpacking psutil>=0.7.1 18:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:52:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:31 INFO - Installing collected packages: psutil 18:52:31 INFO - Running setup.py install for psutil 18:52:31 INFO - building 'psutil._psutil_linux' extension 18:52:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:52:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:52:32 INFO - building 'psutil._psutil_posix' extension 18:52:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:52:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:52:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:32 INFO - Successfully installed psutil 18:52:32 INFO - Cleaning up... 18:52:32 INFO - Return code: 0 18:52:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:52:32 INFO - Using env: {'DISPLAY': ':0', 18:52:32 INFO - 'HOME': '/home/cltbld', 18:52:32 INFO - 'LANG': 'en_US.UTF-8', 18:52:32 INFO - 'LANGUAGE': 'en_US:en', 18:52:32 INFO - 'LOGNAME': 'cltbld', 18:52:32 INFO - 'MAIL': '/var/mail/cltbld', 18:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:32 INFO - 'MOZ_NO_REMOTE': '1', 18:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:32 INFO - 'NO_EM_RESTART': '1', 18:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:32 INFO - 'PWD': '/builds/slave/test', 18:52:32 INFO - 'SHELL': '/bin/bash', 18:52:32 INFO - 'SHLVL': '1', 18:52:32 INFO - 'TERM': 'linux', 18:52:32 INFO - 'TMOUT': '86400', 18:52:32 INFO - 'USER': 'cltbld', 18:52:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:32 INFO - '_': '/tools/buildbot/bin/python'} 18:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:52:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:52:34 INFO - Installing collected packages: mozsystemmonitor 18:52:34 INFO - Running setup.py install for mozsystemmonitor 18:52:34 INFO - Successfully installed mozsystemmonitor 18:52:34 INFO - Cleaning up... 18:52:34 INFO - Return code: 0 18:52:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:52:34 INFO - Using env: {'DISPLAY': ':0', 18:52:34 INFO - 'HOME': '/home/cltbld', 18:52:34 INFO - 'LANG': 'en_US.UTF-8', 18:52:34 INFO - 'LANGUAGE': 'en_US:en', 18:52:34 INFO - 'LOGNAME': 'cltbld', 18:52:34 INFO - 'MAIL': '/var/mail/cltbld', 18:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:34 INFO - 'MOZ_NO_REMOTE': '1', 18:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:34 INFO - 'NO_EM_RESTART': '1', 18:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:34 INFO - 'PWD': '/builds/slave/test', 18:52:34 INFO - 'SHELL': '/bin/bash', 18:52:34 INFO - 'SHLVL': '1', 18:52:34 INFO - 'TERM': 'linux', 18:52:34 INFO - 'TMOUT': '86400', 18:52:34 INFO - 'USER': 'cltbld', 18:52:34 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:34 INFO - '_': '/tools/buildbot/bin/python'} 18:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:37 INFO - Downloading docopt-0.6.1.tar.gz 18:52:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:37 INFO - Running setup.py install for blobuploader 18:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:52:37 INFO - Running setup.py install for requests 18:52:37 INFO - Running setup.py install for docopt 18:52:37 INFO - Successfully installed blobuploader requests docopt 18:52:37 INFO - Cleaning up... 18:52:37 INFO - Return code: 0 18:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:37 INFO - Using env: {'DISPLAY': ':0', 18:52:37 INFO - 'HOME': '/home/cltbld', 18:52:37 INFO - 'LANG': 'en_US.UTF-8', 18:52:37 INFO - 'LANGUAGE': 'en_US:en', 18:52:37 INFO - 'LOGNAME': 'cltbld', 18:52:37 INFO - 'MAIL': '/var/mail/cltbld', 18:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:37 INFO - 'MOZ_NO_REMOTE': '1', 18:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:37 INFO - 'NO_EM_RESTART': '1', 18:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:37 INFO - 'PWD': '/builds/slave/test', 18:52:37 INFO - 'SHELL': '/bin/bash', 18:52:37 INFO - 'SHLVL': '1', 18:52:37 INFO - 'TERM': 'linux', 18:52:37 INFO - 'TMOUT': '86400', 18:52:37 INFO - 'USER': 'cltbld', 18:52:37 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:37 INFO - '_': '/tools/buildbot/bin/python'} 18:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:37 INFO - Running setup.py (path:/tmp/pip-Oc9Vh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:37 INFO - Running setup.py (path:/tmp/pip-ZUeQnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:38 INFO - Running setup.py (path:/tmp/pip-ICKZPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:38 INFO - Running setup.py (path:/tmp/pip-8AyBFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:38 INFO - Running setup.py (path:/tmp/pip-yAk3Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:38 INFO - Running setup.py (path:/tmp/pip-plFEc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:38 INFO - Running setup.py (path:/tmp/pip-cNJOlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:38 INFO - Running setup.py (path:/tmp/pip-bm0Dgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:38 INFO - Running setup.py (path:/tmp/pip-4l6yBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:38 INFO - Running setup.py (path:/tmp/pip-W6tPdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:38 INFO - Running setup.py (path:/tmp/pip-RxiobP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:38 INFO - Running setup.py (path:/tmp/pip-ivCBTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:38 INFO - Running setup.py (path:/tmp/pip-LdgcT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:38 INFO - Running setup.py (path:/tmp/pip-gML_Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:38 INFO - Running setup.py (path:/tmp/pip-noq_x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:38 INFO - Running setup.py (path:/tmp/pip-wOFKrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:39 INFO - Running setup.py (path:/tmp/pip-enxKH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:39 INFO - Running setup.py install for manifestparser 18:52:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Running setup.py install for mozcrash 18:52:39 INFO - Running setup.py install for mozdebug 18:52:39 INFO - Running setup.py install for mozdevice 18:52:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Running setup.py install for mozfile 18:52:39 INFO - Running setup.py install for mozhttpd 18:52:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Running setup.py install for mozinfo 18:52:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Running setup.py install for mozInstall 18:52:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:52:39 INFO - Running setup.py install for mozleak 18:52:39 INFO - Running setup.py install for mozlog 18:52:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for moznetwork 18:52:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozprocess 18:52:40 INFO - Running setup.py install for mozprofile 18:52:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozrunner 18:52:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Running setup.py install for mozscreenshot 18:52:40 INFO - Running setup.py install for moztest 18:52:40 INFO - Running setup.py install for mozversion 18:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:40 INFO - Cleaning up... 18:52:40 INFO - Return code: 0 18:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52: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')]} 18:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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')]} 18:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:40 INFO - Using env: {'DISPLAY': ':0', 18:52:40 INFO - 'HOME': '/home/cltbld', 18:52:40 INFO - 'LANG': 'en_US.UTF-8', 18:52:40 INFO - 'LANGUAGE': 'en_US:en', 18:52:40 INFO - 'LOGNAME': 'cltbld', 18:52:40 INFO - 'MAIL': '/var/mail/cltbld', 18:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:40 INFO - 'MOZ_NO_REMOTE': '1', 18:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:40 INFO - 'NO_EM_RESTART': '1', 18:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:40 INFO - 'PWD': '/builds/slave/test', 18:52:40 INFO - 'SHELL': '/bin/bash', 18:52:40 INFO - 'SHLVL': '1', 18:52:40 INFO - 'TERM': 'linux', 18:52:40 INFO - 'TMOUT': '86400', 18:52:40 INFO - 'USER': 'cltbld', 18:52:40 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:40 INFO - '_': '/tools/buildbot/bin/python'} 18:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:41 INFO - Running setup.py (path:/tmp/pip-gjOhUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:41 INFO - Running setup.py (path:/tmp/pip-4uStv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:41 INFO - Running setup.py (path:/tmp/pip-pDPP6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:41 INFO - Running setup.py (path:/tmp/pip-e7QGic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:41 INFO - Running setup.py (path:/tmp/pip-BAKGjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:41 INFO - Running setup.py (path:/tmp/pip-qfYq2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:41 INFO - Running setup.py (path:/tmp/pip-BssfUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:41 INFO - Running setup.py (path:/tmp/pip-yZLTMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:41 INFO - Running setup.py (path:/tmp/pip-HtY4kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:41 INFO - Running setup.py (path:/tmp/pip-L77Oc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:41 INFO - Running setup.py (path:/tmp/pip-tC22Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:41 INFO - Running setup.py (path:/tmp/pip-Lbxnlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:41 INFO - Running setup.py (path:/tmp/pip-RJfvwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:42 INFO - Running setup.py (path:/tmp/pip-V4p_p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:42 INFO - Running setup.py (path:/tmp/pip-cw1e68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:42 INFO - Running setup.py (path:/tmp/pip-k1J0dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:42 INFO - Running setup.py (path:/tmp/pip-kbqsTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:44 INFO - Downloading blessings-1.5.1.tar.gz 18:52:44 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:44 INFO - Installing collected packages: blessings 18:52:44 INFO - Running setup.py install for blessings 18:52:44 INFO - Successfully installed blessings 18:52:44 INFO - Cleaning up... 18:52:44 INFO - Return code: 0 18:52:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:44 INFO - Reading from file tmpfile_stdout 18:52:44 INFO - Current package versions: 18:52:44 INFO - argparse == 1.2.1 18:52:44 INFO - blessings == 1.5.1 18:52:44 INFO - blobuploader == 1.2.4 18:52:44 INFO - docopt == 0.6.1 18:52:44 INFO - manifestparser == 1.1 18:52:44 INFO - mozInstall == 1.12 18:52:44 INFO - mozcrash == 0.16 18:52:44 INFO - mozdebug == 0.1 18:52:44 INFO - mozdevice == 0.47 18:52:44 INFO - mozfile == 1.2 18:52:44 INFO - mozhttpd == 0.7 18:52:44 INFO - mozinfo == 0.9 18:52:44 INFO - mozleak == 0.1 18:52:44 INFO - mozlog == 3.1 18:52:44 INFO - moznetwork == 0.27 18:52:44 INFO - mozprocess == 0.22 18:52:44 INFO - mozprofile == 0.28 18:52:44 INFO - mozrunner == 6.11 18:52:44 INFO - mozscreenshot == 0.1 18:52:44 INFO - mozsystemmonitor == 0.0 18:52:44 INFO - moztest == 0.7 18:52:44 INFO - mozversion == 1.4 18:52:44 INFO - psutil == 3.1.1 18:52:44 INFO - requests == 1.2.3 18:52:44 INFO - wsgiref == 0.1.2 18:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:44 INFO - Using env: {'DISPLAY': ':0', 18:52:44 INFO - 'HOME': '/home/cltbld', 18:52:44 INFO - 'LANG': 'en_US.UTF-8', 18:52:44 INFO - 'LANGUAGE': 'en_US:en', 18:52:44 INFO - 'LOGNAME': 'cltbld', 18:52:44 INFO - 'MAIL': '/var/mail/cltbld', 18:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:44 INFO - 'MOZ_NO_REMOTE': '1', 18:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:44 INFO - 'NO_EM_RESTART': '1', 18:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:44 INFO - 'PWD': '/builds/slave/test', 18:52:44 INFO - 'SHELL': '/bin/bash', 18:52:44 INFO - 'SHLVL': '1', 18:52:44 INFO - 'TERM': 'linux', 18:52:44 INFO - 'TMOUT': '86400', 18:52:44 INFO - 'USER': 'cltbld', 18:52:44 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:44 INFO - '_': '/tools/buildbot/bin/python'} 18:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:52:44 INFO - Cleaning up... 18:52:44 INFO - Return code: 0 18:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:52:44 INFO - Using env: {'DISPLAY': ':0', 18:52:44 INFO - 'HOME': '/home/cltbld', 18:52:44 INFO - 'LANG': 'en_US.UTF-8', 18:52:44 INFO - 'LANGUAGE': 'en_US:en', 18:52:44 INFO - 'LOGNAME': 'cltbld', 18:52:44 INFO - 'MAIL': '/var/mail/cltbld', 18:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:44 INFO - 'MOZ_NO_REMOTE': '1', 18:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:44 INFO - 'NO_EM_RESTART': '1', 18:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:44 INFO - 'PWD': '/builds/slave/test', 18:52:44 INFO - 'SHELL': '/bin/bash', 18:52:44 INFO - 'SHLVL': '1', 18:52:44 INFO - 'TERM': 'linux', 18:52:44 INFO - 'TMOUT': '86400', 18:52:44 INFO - 'USER': 'cltbld', 18:52:44 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:44 INFO - '_': '/tools/buildbot/bin/python'} 18:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:44 INFO - Downloading/unpacking jsonschema 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:52:46 INFO - Downloading/unpacking functools32 (from jsonschema) 18:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:46 INFO - warning: no files found matching '*.txt' 18:52:46 INFO - no previously-included directories found matching 'build' 18:52:46 INFO - no previously-included directories found matching 'dist' 18:52:46 INFO - no previously-included directories found matching '.git*' 18:52:46 INFO - Installing collected packages: jsonschema, functools32 18:52:47 INFO - Running setup.py install for functools32 18:52:47 INFO - warning: no files found matching '*.txt' 18:52:47 INFO - no previously-included directories found matching 'build' 18:52:47 INFO - no previously-included directories found matching 'dist' 18:52:47 INFO - no previously-included directories found matching '.git*' 18:52:47 INFO - Successfully installed jsonschema functools32 18:52:47 INFO - Cleaning up... 18:52:47 INFO - Return code: 0 18:52:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:52: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')]} 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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')]} 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f911d164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:52:47 INFO - Using env: {'DISPLAY': ':0', 18:52:47 INFO - 'HOME': '/home/cltbld', 18:52:47 INFO - 'LANG': 'en_US.UTF-8', 18:52:47 INFO - 'LANGUAGE': 'en_US:en', 18:52:47 INFO - 'LOGNAME': 'cltbld', 18:52:47 INFO - 'MAIL': '/var/mail/cltbld', 18:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:47 INFO - 'MOZ_NO_REMOTE': '1', 18:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:47 INFO - 'NO_EM_RESTART': '1', 18:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:47 INFO - 'PWD': '/builds/slave/test', 18:52:47 INFO - 'SHELL': '/bin/bash', 18:52:47 INFO - 'SHLVL': '1', 18:52:47 INFO - 'TERM': 'linux', 18:52:47 INFO - 'TMOUT': '86400', 18:52:47 INFO - 'USER': 'cltbld', 18:52:47 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:47 INFO - '_': '/tools/buildbot/bin/python'} 18:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:47 INFO - Downloading/unpacking flake8 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:52:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:52:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:52:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:52: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 18:52: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 18:52: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 18:52: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 18:52: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 18:52: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 18:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:52:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:52:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:52:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:52:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:52:51 INFO - no previously-included directories found matching 'docs/_build' 18:52:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:52:52 INFO - Running setup.py install for pep8 18:52:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:52:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:52:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:52:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:52:52 INFO - no previously-included directories found matching 'docs/_build' 18:52:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:52:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:52:52 INFO - Cleaning up... 18:52:52 INFO - Return code: 0 18:52:52 INFO - Running post-action listener: _resource_record_post_action 18:52:52 INFO - Running post-action listener: _start_resource_monitoring 18:52:52 INFO - Starting resource monitoring. 18:52:52 INFO - ##### 18:52:52 INFO - ##### Running install step. 18:52:52 INFO - ##### 18:52:52 INFO - Running pre-action listener: _resource_record_pre_action 18:52:52 INFO - Running main action method: install 18:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:53 INFO - Reading from file tmpfile_stdout 18:52:53 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:52:53 INFO - Reading from file tmpfile_stdout 18:52:53 INFO - Output received: 18:52:53 INFO - Usage: mozinstall [options] installer 18:52:53 INFO - Options: 18:52:53 INFO - -h, --help show this help message and exit 18:52:53 INFO - -d DEST, --destination=DEST 18:52:53 INFO - Directory to install application into. [default: 18:52:53 INFO - "/builds/slave/test"] 18:52:53 INFO - --app=APP Application being installed. [default: firefox] 18:52:53 INFO - mkdir: /builds/slave/test/build/application 18:52:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:53:08 INFO - Reading from file tmpfile_stdout 18:53:08 INFO - Output received: 18:53:08 INFO - /builds/slave/test/build/application/firefox/firefox 18:53:08 INFO - Running post-action listener: _resource_record_post_action 18:53:08 INFO - ##### 18:53:08 INFO - ##### Running run-tests step. 18:53:08 INFO - ##### 18:53:08 INFO - Running pre-action listener: _resource_record_pre_action 18:53:08 INFO - Running main action method: run_tests 18:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:53:08 INFO - Python 2.7.3 18:53:08 INFO - Return code: 0 18:53:08 INFO - grabbing minidump binary from tooltool 18:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:08 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 0x24cd3d0>, '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 0x2438ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:53:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:53:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:53:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:53:08 INFO - Return code: 0 18:53:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:53:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:53:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:53:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:53:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:53:09 INFO - Return code: 0 18:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:53:09 INFO - Using env: {'DISPLAY': ':0', 18:53:09 INFO - 'HOME': '/home/cltbld', 18:53:09 INFO - 'LANG': 'en_US.UTF-8', 18:53:09 INFO - 'LANGUAGE': 'en_US:en', 18:53:09 INFO - 'LOGNAME': 'cltbld', 18:53:09 INFO - 'MAIL': '/var/mail/cltbld', 18:53:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:53:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:09 INFO - 'MOZ_NO_REMOTE': '1', 18:53:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:09 INFO - 'NO_EM_RESTART': '1', 18:53:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:09 INFO - 'PWD': '/builds/slave/test', 18:53:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:53:09 INFO - 'SHELL': '/bin/bash', 18:53:09 INFO - 'SHLVL': '1', 18:53:09 INFO - 'TERM': 'linux', 18:53:09 INFO - 'TMOUT': '86400', 18:53:09 INFO - 'USER': 'cltbld', 18:53:09 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588', 18:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:09 INFO - '_': '/tools/buildbot/bin/python'} 18:53:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:53:09 INFO - mozversion application_buildid: 20151230174339 18:53:09 INFO - mozversion application_changeset: 6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817 18:53:09 INFO - mozversion application_display_name: Nightly 18:53:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:53:09 INFO - mozversion application_name: Firefox 18:53:09 INFO - mozversion application_remotingname: firefox 18:53:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 18:53:09 INFO - mozversion application_vendor: Mozilla 18:53:09 INFO - mozversion application_version: 46.0a1 18:53:09 INFO - mozversion platform_buildid: 20151230174339 18:53:09 INFO - mozversion platform_changeset: 6f4ef2a14886bafda5d255b2ddf36bc5e4ee8817 18:53:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 18:53:09 INFO - mozversion platform_version: 46.0a1 18:53:09 INFO - using testdate: 1451530389 18:53:09 INFO - actual date: 1451530389 18:53:09 INFO - starting webserver on 'localhost:45862' 18:53:09 INFO - SUITE-START | Running 3 tests 18:53:09 INFO - TEST-START | dromaeo_css 18:53:09 INFO - operating with platform_type : linux_ 18:53:09 INFO - Initialising browser for dromaeo_css test... 18:53:10 INFO - TEST-INFO | started process 2589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAkljsr/profile http://localhost:45862/getInfo.html) 18:53:15 INFO - PROCESS | 2589 | __metrics Screen width/height:1600/1200 18:53:15 INFO - PROCESS | 2589 | colorDepth:24 18:53:15 INFO - PROCESS | 2589 | Browser inner width/height: 1024/697 18:53:15 INFO - PROCESS | 2589 | __metrics 18:53:15 INFO - PROCESS | 2589 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:53:15 INFO - PROCESS | 2589 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:53:16 INFO - TEST-INFO | 2589: exit 0 18:53:16 INFO - Browser initialized. 18:53:16 INFO - Running cycle 1/1 for dromaeo_css test... 18:53:16 INFO - TEST-INFO | started process 2682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAkljsr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:28 INFO - PROCESS | 2682 | RSS: Main: 149803008 18:53:28 INFO - PROCESS | 2682 | 18:54:19 INFO - PROCESS | 2682 | 1451530459484 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:56:31 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45862/tests/dromaeo/cssquery-ext.html) 18:56:32 INFO - PROCESS | 2682 | RSS: Main: 245850112 18:56:32 INFO - PROCESS | 2682 | 18:59:35 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-ext.html (next: http://localhost:45862/tests/dromaeo/cssquery-jquery.html) 18:59:35 INFO - PROCESS | 2682 | RSS: Main: 232734720 18:59:35 INFO - PROCESS | 2682 | 19:02:37 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45862/tests/dromaeo/cssquery-mootools.html) 19:02:38 INFO - PROCESS | 2682 | RSS: Main: 219262976 19:02:38 INFO - PROCESS | 2682 | 19:05:40 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45862/tests/dromaeo/cssquery-prototype.html) 19:05:41 INFO - PROCESS | 2682 | RSS: Main: 209182720 19:05:41 INFO - PROCESS | 2682 | 19:08:43 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45862/tests/dromaeo/cssquery-yui.html) 19:08:44 INFO - PROCESS | 2682 | RSS: Main: 213295104 19:08:44 INFO - PROCESS | 2682 | 19:11:46 INFO - PROCESS | 2682 | Cycle 1(1): loaded http://localhost:45862/tests/dromaeo/cssquery-yui.html (next: http://localhost:45862/tests/dromaeo/cssquery-dojo.html) 19:11:47 INFO - PROCESS | 2682 | RSS: Main: 226734080 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | __start_tp_report 19:11:47 INFO - PROCESS | 2682 | _x_x_mozilla_page_load 19:11:47 INFO - PROCESS | 2682 | _x_x_mozilla_page_load_details 19:11:47 INFO - PROCESS | 2682 | |i|pagename|runs| 19:11:47 INFO - PROCESS | 2682 | |0;dojo.html;2575.9198824144887;2692.3538350795816;2700.06847637565;2704.6754389473267;2711.471263103694;4419.580139886705;4534.093181363724;4597.839075632353;4606.769661516928;4615.515370886054;4507.076049409871;4529.2526733089;4605.677602567822;4609.746463944482;4638.188317044521;4240.978795106028;4244.045089854789;4255.5957184067465;4304.461942257218;4308.676849236304;4304.203722311367;4315.978420107911;4342.240107981106;4350.15172041452;4390.363397307388;4103.4870641169855;4196.013936724868;4208.179405016023;4299.032717638522;4325;4176.937345939813;4261.31818908973;4263.765492897889;4271.8718438446895;4295.098029413827;4228.492580890313;4252.978735106336;4256.531781504032;4265.594768497019;4286.657067434598;4445.844395446176;4539.251023581105;4544.500104988449;4573.63410927125;4596.287575425815;4806.0628177505405;4833.492483289239;4907.092187945206;4921.557059864629;4956.281339205831;4937.629677774181;4938.185199442088;4962.503749625044;4974.726390048546;5009.0482808266315;4423.270160423558;4525.275955847049;4588.7935042923145;4598.218302888484;4631.652626052992;4933.802647894116;4949.084419382426;5011.323471331323;5017.147084995559;5082.059818933509;4867.853964381075;4882.462929077798;4889.413270407574;4890.779914903838;4922.064807686528;4790.688605240648;4902.7058376497525;4965.627577931669;4988.5260900214425;5021.14640511114;4774.522547745267;4790.856274311776;4859.125357435625;4871.683340582851;4911.950880491149;4833.130036593377;4846.975765121152;4857.951420485821;4860.586850117779;4885.780139893714;3938.369860822255;4034.253663072341;4109.075458021921;4111.527174374985;4169.145325208386;3556.7510274280553;3581.6955558777277;3634.9636503635156;3656.341858465502;3665.138692407282;4201.117765269267;4232.597903199191;4233.661307095425;4236.766977816188;4265.829366825355;4756.048790241965;4880.292357608198;4920.655554111249;4927.187014142626;4983.775730092155;4169.332906734908;4201.873943781691;4262.23279809631;4263.70154089217;4289.077848262638;4402.779861007001;4425.513193548707;4434.778261086933;4439.889002774892;4468.597826195658;4576.427946506687;4686.718796872198;4730.668853180245;4753.786079626494;4759.928601070987;4810.11012962603;4837.2260438329695;4876.21980483121;4905.068037073087;4945.653804233669;4683.437987441529;4688.390509233778;4690.3199036138885;4695.084458530554;4742.525747425368;4655.371524844239;4765.475797662185;4845.103655823684;4862.975685121552;4910.92633610489;4798.2082956311815;4813.542713442217;4916.287138364989;4969.950300496948;5036.84889453317;4740.715557066587;4745.644076694331;4757.262624293102;4794.712317260975;4806.49531799156;4727.267273572602;4733.502982186821;4741.881452963566;4754.405699287589;4786.688865223749;4507.3915021471685;4532.297493888453;4569.36028955953;4589.426321709786;4676.46220684612;4710.740909249887;4758.310045043519;4891.779869905934;4899.04468628614;4900.019996000743;4675.76621168947;4707.411573553306;4715.669903106749;4715.882102947454;4756.19144745401 19:11:47 INFO - PROCESS | 2682 | |1;ext.html;497.3608912547375;533.607798268273;563.3830955104161;571.0035987202331;578.057765841678;24911;35941.82029089854;36928.44607330892;36937.44593831088;37028.62971370285;40315;40778.59221407785;40866;40872.59127408725;40952.38571421431;6742.7640032598865;6818.624975626339;7827.373810095207;8039.236272554127;8050.718224862131;9790.608375665;10035.19718422528;10035.448050357227;10036.799264014751;10038.498075096217;9686.273529485281;9739;9801.754956126082;9808.26438017148;9814.263930205263;6730.865382692367;6933.0293758873295;9806.509674516281;9842.507874606312;10115.696529104138;9578.664746733832;9751.317407781458;9753.707388778348;9755.219582433388;9755.804883902354;32355.838220808746;32792.34415311681;32806;32809;32833;2680.128958088629;2688.8117831751783;2705;3103.8137711737368;3355.4128027595075;26059.21822345333;28612.783118218365;28691.56962645562;28862.42275154485;29161.56257656137;3325.3515564464938;3425.760196786226;3436.862525499002;3507.0881570791776;3533.0284171852945;235319;237055;237812;238024;238237;55119.448805512235;55122.44877551173;55149;55698.72150639221;55817.441825582035;47512.5248747515;48371;56194.438055619736;57535.42464575385;58117.41882581205;12612;12930.870691293156;12986.480540778452;13001.674958125934;13003.024773142051;10195.388276703421;10273.845892311621;10290.331128476626;10396.272260941661;10398.532066056894;17730.91134544319;17857.553561161076;17890.91054544745;17900.194491247927;17919.193636286138;7186.461015423864;7439.85120297591;7538;7566.35685966699;7580.734674286374;867.3971589745066;880.1858281090094;884.1158841158841;909.2180724576858;1011.5801942194054;26676.46647067048;26794.464110717676;26924.192274231806;27115;27207.591886121725;938.7043081429327;956.2159029595665;969.3795970578835;973.9659111931048;991.6464026603634;13755.724885502434;14009;14052.85947140536;14191.574252772434;14220.928895355664;258190;259266;265739;265871;266008;46002.30996535055;46189;46212.7689361551;46303.76848115738;46307.30539041917;1207.4144040140525;1223.2660403757675;1225.5281716539196;1227.9017678585692;1229.7294595189044;25441;26383.736162638128;26581.20256392234;26890.193294201206;26902;35588.822055889555;36322.8183859079;40260.59739402569;40808;40881.79559102185;238542;241370;244551;244984;245175;24083.157089501783;24623.63064553997;24770.50458990846;24989;25029.249122526355;36928.63071369252;37283.44074838825;37588;37736.433953491265;37927.62072379241;28732;29122.854385727936;32476.675233247366;33821.492677610346;34084.31831363408;32202.35595288128;32406.351872961935;32418.83790581032;32526.674733252363;36462;32640.183995400304;32740.67259327376;32775.34449310953;33003.339933200725;33068.503972439954;28669.713302867538;29128.12615621535;29676.40647187001;29806.25484362908;30135.849320753256;21476.78523214748;23382.883085584464;23563.646545302177;23847.403814904766;25474.87262563675 19:11:47 INFO - PROCESS | 2682 | |2;jquery.html;333.90316808125635;334.20459306849693;336.1579243993795;336.19984437039824;336.7121111449712;12280.508779648804;12742.171758835693;14784.260786960649;15175.848241517595;15571.143587102704;8988;9283.025282345357;9286.024967378413;12580.81128783069;14678.486252981147;4429.3798868158565;4545.045540436512;4549.454065512143;4551.886202844938;4552.9089418211615;3278.327942771726;3375.9156021099548;4836.46798852126;4993.800247990076;5024.246363045536;4915.238138088602;4950.603951683875;4967.4287456942375;4972.950270497303;4974.303597496353;4894.467707965088;5047.899042019158;5115.386153661584;5118.744062796845;5119.206522988924;4948.257761335793;4950.603951683856;4952.232403977389;4957.355543779286;4957.652964292501;11236.550537978472;11660.88339116615;11662.59180928672;11677.824832627517;11680.532778688843;1698.7706659601042;1746.956326091845;1757.1214392803597;1762.6122253104297;1870.9625807483774;8620.784480387978;8731.432456890281;8981.101889811032;10699.786004279871;12311.630651080482;1624.2447262023215;1639.3196823318308;1779.6974514332464;1790.1787703412626;1810.5654642885745;55380.72309638426;58490.94206508953;59048.40951590472;59415;59868.700656496876;9392.62429502826;9528.380655257386;9624.75938101539;9628.951855240679;9675.87130831216;12328.938355308166;12347.444365003596;12353.135280530456;12357.691057723629;12375.071869609636;6819.079424277659;6837.931620683829;6856.760013399507;6894.24163342032;6970.302969703091;6615.735370585123;6626.801195964129;6654.4505746210725;6661.40047395727;6689.331066893272;4012.9598704012587;4048.2105989332385;4058.939115913264;4080.10237747695;4086.0397806515443;1535.692861427719;1541.129261966985;1586.2465328968647;1628.6986907422165;1670.8329167083436;850.6087199887997;868.444195714743;905.8278927003848;939.8308304505118;966;13805.24071176095;14168.787468187986;15390;15604.92197539005;15783.447579334668;771.4445599168589;788.9960550197212;837.2116174311169;891.790429249126;915.33638112368;8738.344624153215;9082.772930676785;9333.066693330748;9441.575129119206;9536.475493847765;319422;323767;324799;326009;473787;63045.68477157585;76794.61602692063;77970.3366114966;78429.60785196038;80034.5998270005;1019.4291196929743;1040.2718097331897;1049.7141002272308;1053.5575058475458;1054.520193312041;13990.16059036461;14421.567352979428;14591.227666743285;14732.263386830402;14738.63153421173;29982.550261746528;30144.84927575348;33173.83413083015;33861.153471163416;34227.657723422446;37509.62490375061;38058.809705951295;38418.42372364361;38510.2297954045;39714.60285397109;8164.346852251924;8339.457935234434;8428.283595894418;8637.654493820177;8654.264387526879;16010.119443430724;16104.03375797456;16118.838811611733;16264.51206463808;16281.104539249982;12970.286634235208;13033.283169425393;13205.877500412573;13601.591952241448;14018.088824226392;12983.805242921553;13042.869571304545;13255.403506842022;13304;13352.532661356807;10793.460326983462;12522.87477125217;13814.171149731048;14047.789283160557;14162.362693678602;8328.250457458858;8575.914240857512;8751.387402881737;8757.60590773404;8770.342224333073;8902.821943561223;9022.909770902206;9481.383710058824;13335.599932002055;13352.933235333761 19:11:47 INFO - PROCESS | 2682 | |3;mootools.html;1204.1510734931862;1378.7793952967525;1379.8896088312936;1484.5026915983144;1713.083500327325;5639.68981706006;6464.12734280872;6575.112359831422;6576.441002514792;6586.637734924583;6676.2989886062;6858.177018757756;6862.622555759432;6871.244163142051;6876.277990810968;1689.847913687768;1726.7323564847468;1728.6629107324077;1987.8509111816636;2032.4715573950805;1676.5389517882559;1683.528611988639;2024.2307922989316;2070.027087268981;2087.342487116561;1924.191839427437;2018.959620807583;2024.2004408258729;2026.7466566679166;2028.1380413324353;2034.2473284884613;2044.570640165567;2059.845511586637;2061.443410279224;2062.4431403520966;2015.8084981926693;2029.6549586570318;2076.377086873947;2078.615456140604;2079.6048750737314;6809.319068093151;6956.826079348057;6962.443004559623;6962.825929351756;6973.790786276369;3959.208158368309;4033.556308806029;4051.372037334218;4061.0659548304056;4065.146319272956;2508.3854455658297;2519.3575638212324;2537.2768760903236;2582.9483410331877;2605.4137818990766;763.3549650545281;771.3135309574483;782.5695867272977;801.7274126796917;801.8195905921121;9041.773955651095;9109.498977556232;9111.589978450986;9119.772005699844;9121.315901307362;3631.6368363163474;3658.323210206067;3720.3489389356755;3722.4602432647116;3764.0966168119453;7879.842403151905;7919.841603167904;7921;7923.801904952422;7924.564148971862;3997.8200980955926;4006.8797936061965;4017.959820401817;4037.4751282333696;4042.777647229431;3622.3117607654463;3634.9091272717865;3646.908827279339;3656.2687462507606;3661.5423072115987;2885.3507960709094;3238.5951756030495;3243.6107667079627;3343.36476069546;3344.364570731553;897.3763234551924;907.1608761895352;911.5168960450972;1026.5431882812077;1051.3271506235862;895.861141523052;902.4765635931276;911.5260064766285;953.5280036382036;1111.0833562311125;6080.543959203077;6129.325774164839;6158.414950579688;6159.6612186330185;6167.907481387782;1026.5329275179774;1034.4930983817876;1035.3942943378058;1041.5000799616228;1063.0751246415514;4862.367892173995;4955.132851750929;4963.57809586182;4973.079980203674;4973.701577905337;7659.808504787425;7888.526688398714;7904.446688731734;7925.484843485155;7937.444378893538;7873.409494287951;7886.171951944963;7886.605669716606;7887.329576986021;7894.250046245597;6037.45662890342;6073.058675905242;6318.052292156213;6460.289368169498;6474.1907261592305;6267.2165979252595;6369.8726025480155;6374.107624932606;6379.904301435575;6380.872382552416;7190.784276471714;7255.09311336083;7341.926580734124;7368.300011498899;7381.852362952818;7156.069710937545;7247.891281630885;7345.081864766904;7523.435742319239;7526.698932042657;6075.392460753889;6170.352113028068;6176.135341052346;6176.629402235881;6182.165407669907;6510.121133646897;6564.868702625825;6581.407673309425;6584.7036883341325;6601.141851559267;6096.055111457731;6121.112438696453;6325.9683701583035;6386.680665966776;6395.936040639534;6283.528735344776;6301.338359472373;6402.679866006588;6407.743690252338;6423.807285781434;6306;6316.6841657916;6402.135711678864;6415.871682566416;6419.646919419477;5864.589478736448;5865;5921.585489015728;5929.169916211647;5930.555208359477;5691.231683722644;5929.288485381781;5952.0476723724;5971.253593300838;5975.014122669711 19:11:47 INFO - PROCESS | 2682 | |4;prototype.html;278.81180203362726;289.0864867020216;294.11178241710024;299.38028281457395;301.2183384118214;5305.442928492505;5359.330083739533;5376.8118115865955;5382.138857782756;5391.16436952273;5267.578593712504;5271.578273738101;5288.867778305545;5289.656172348795;5290.285811415458;4094.7747873866924;4097.282975479294;4099.7745124018165;4100.036491424513;4101.528324242706;3899.083715326896;4007.2185923744883;4090;4104.610062044101;4115.403266526352;3967.841286348543;3986.820593073319;3998.7000974926996;4000.359942409215;4000.9399859002137;3617.5297211362486;3964.6431821136234;3968.6825053995613;3970.642642162219;4061.715679902408;3568.37553428149;3571.499990001402;3577.3560759063357;3581.230035542345;3589.371859924529;5065.088284108859;5137.691738495665;5140.897182056338;5143.045642655767;5144.356955380577;4739.834105806281;4741.691790033637;4744.217204161309;4747.45404278509;4750.121227572876;5544.86137846553;5574.749136288877;5580.832575022756;5591.10542313232;5601.887962240773;3707.610700876396;3816.8473261069526;3833.3483307837732;3890.474785903895;3908.882733517999;5788.797392091299;5850.3564607893095;5865.824025279248;5866.090755932837;5870.207521984563;4059.1881623674794;4069.2471892699946;4074.3277359235985;4075.3683179107284;4076.6331030207425;4131.5455299916985;4146.295129827937;4146.647534959502;4150.045489537423;4153.646940010133;4468.530804265505;4648.604868586141;4661.463931647904;4665.8335416145965;4711.552402521755;5510.118381059011;5574;5581.553475721932;5589.832305030855;5596.4403559644525;1405.5150972914328;1423.5515812519022;1435.5406269993503;1437.1879887863324;1437.2669938331526;950.1970834644715;956.9138777510058;962.2398305338844;982.9262805289632;985.1822986920838;4892.461829198785;4895.143349913751;4895.265710143507;4898.632602554751;4906.435759887588;5807.5063619591965;5811.302643682785;5811.564132690065;5816.94183058164;5818.883622327615;4889.462159162489;4890.168671325883;4892.021595680878;4901.068796928572;4904.215325547966;3028.197527655173;3106.08370530694;3130.373925214966;3140.1678555182893;3140.842957852098;5563.638363506359;5570.888582228414;5580.497755202051;5581.05122129239;5581.190727344512;6019.247594050744;6030.18592490017;6031.155638210654;6032.3967603239325;6032.728527216286;5533.667979921218;5565.833025009256;5569.860753481114;5577.9442205577425;5582.218489411404;5699.743511542073;5866.325372582208;5870.207521984477;5877.35349111606;5879.794207202727;5451.236826844324;5504.779808807602;5632.493075623213;5722.284714410699;5737.311522617312;5548.944510554843;5576.86057848557;5584.0507113789945;5584.46947539983;5588.692621905834;3938.1729836734607;3949.5260568731937;3957.8021098945514;3962.821673024663;3969.0275882408996;5666.773329066791;5845.152452894392;5849.444302791228;5859.296884373903;5863.413658634273;5656.490915817596;5663.518600918968;5666.320041595035;5667.801626943202;5668.574856885833;5649.491545760737;5658.632188907708;5660.801871934463;5660.943390566042;5665.20687103814;5516.200150978166;5540.722963851872;5546.306711661043;5547.916781248366;5549.694766787704;5527.8894422112135;5668.433156684298;5678.716064196691;5679.772809087755;5685.118806584986;5478.726063696719;5491.341039075336;5492.697901615449;5492.697901615449;5505.091659876076 19:11:47 INFO - PROCESS | 2682 | |5;yui.html;603.273055967559;626.9310375858657;697.8569393274378;698.4307789151841;703.1702590942685;10377.377357358555;10539.631112911049;11291.887081129185;11420.600278990238;11445.542178312857;12107.273563586168;12235.082368822352;12240.93879530601;12243.632691019284;12246.203996740229;601.1763883479639;786.0449553792141;798.3413683710933;800.1638287989066;800.6157044618558;614.8647297594522;782.7416952405692;798.1021350980147;798.2297083314601;800.4236949396425;824.6989848705209;841.364769598952;841.5834162089743;841.8232171244047;843.1484200957016;645.3933302695498;654.7642848574509;816.7713040348652;823.567626995829;832.3466079127886;612.2683393344954;616.0482055224688;617.3486971245335;617.8177437655858;617.8362733875526;10769;10853.51159197838;10865.728356791064;10870.456477176109;10879.945600271947;10429.687109386654;10575.20685948557;10613.628523001735;10899.1280697544;10932.672019839418;8431.70489032887;8598.140185981414;8679.566021698889;8742.86885696715;8919.777005574848;3061.6938306169204;3069.8004629699;3098.8760449582214;3159.273367125574;3180.920476988094;40031.59968400308;40579.59420405817;40589.18821623551;40605.59394406077;40617.187656247006;8103.068147163034;8247.463914845635;8368.421839418319;8435.915640843514;8481.194286542892;16340.591485212964;16342.264598093114;16359.34562617482;16389.508314750576;16390.344386224417;5981;6012.969935150296;6049.032154855202;6095.817125486243;6176.536759743038;3279.147421670335;3391.084407210089;3427.674370934757;3473.3053389322235;3599.8380072896784;2525.7095434024955;2556.3097963549735;2559.8080143989278;2561.602951542514;2563.013239902651;452.50902770493724;494.5944325653002;504.8359283232964;511.97440127994196;512.8333291680219;416.95205051418867;500.97244651543787;509.69927742631285;519.0371860199351;531.0017167724653;7390.187079421259;7706.884396734054;7856.7250146244605;7858.567778772108;7964.2433968772875;455.54900648357886;511.81574633132044;515.2606010375124;548.5337463156364;576.685706290073;3416.3850506908498;3450.603180634209;3451.1717187875233;3485.19840436701;3598.1184609770776;46143;46467.76766116148;46523.30215046777;46564.534354656695;46577.30134047992;43019.13961720811;44034.55965440305;44105.338419923726;44853.77573112179;44894.55105448969;40209.597904020586;40653.390199147034;40945;41015.35938562484;41123;6633.9336606633315;6764.661766911537;6854.622995735083;6925.930740692528;7007.935954754048;28625.280598343124;29117.417651646425;29260.707392925797;29776.85111574428;29960;35018.299634007686;35018.824905875306;37270;39356.409653854644;39648.40527392034;8524.36067294943;8564.914350856661;8606.526641034803;8835.867461988204;8917.955410222907;9833.704988850346;9943.30396872212;9982.750431239278;10009.949950250202;10016.248781341574;8446.493210407396;8472.364572656952;8515.91484085176;8535.829283414421;8580.356473264404;9030.503322317072;9124;9172.633094676139;9180.081991800767;9246.398984066014;8733.432326898732;8750.737477875675;8760.167784060504;8824.382293239412;8869.157430044135;7519.774406767806;7577.734779282699;7727.884081738891;8025.678972841021;8054.194580541899;7505.136909255505;7510.962445187739;8091.697275559548;8272.503649781032;8753.08092650288 19:11:47 INFO - PROCESS | 2682 | __end_tp_report 19:11:47 INFO - PROCESS | 2682 | __start_cc_report 19:11:47 INFO - PROCESS | 2682 | _x_x_mozilla_cycle_collect,1237 19:11:47 INFO - PROCESS | 2682 | __end_cc_report 19:11:47 INFO - PROCESS | 2682 | __startTimestamp1451531507171__endTimestamp 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | ------- Summary: start ------- 19:11:47 INFO - PROCESS | 2682 | Number of tests: 6 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#0] dojo.html Cycles:165 Average:4537.70 Median:4676.46 stddev:458.41 (9.8%) stddev-sans-first:433.21 19:11:47 INFO - PROCESS | 2682 | Values: 2575.9 2692.4 2700.1 2704.7 2711.5 4419.6 4534.1 4597.8 4606.8 4615.5 4507.1 4529.3 4605.7 4609.7 4638.2 4241.0 4244.0 4255.6 4304.5 4308.7 4304.2 4316.0 4342.2 4350.2 4390.4 4103.5 4196.0 4208.2 4299.0 4325.0 4176.9 4261.3 4263.8 4271.9 4295.1 4228.5 4253.0 4256.5 4265.6 4286.7 4445.8 4539.3 4544.5 4573.6 4596.3 4806.1 4833.5 4907.1 4921.6 4956.3 4937.6 4938.2 4962.5 4974.7 5009.0 4423.3 4525.3 4588.8 4598.2 4631.7 4933.8 4949.1 5011.3 5017.1 5082.1 4867.9 4882.5 4889.4 4890.8 4922.1 4790.7 4902.7 4965.6 4988.5 5021.1 4774.5 4790.9 4859.1 4871.7 4912.0 4833.1 4847.0 4858.0 4860.6 4885.8 3938.4 4034.3 4109.1 4111.5 4169.1 3556.8 3581.7 3635.0 3656.3 3665.1 4201.1 4232.6 4233.7 4236.8 4265.8 4756.0 4880.3 4920.7 4927.2 4983.8 4169.3 4201.9 4262.2 4263.7 4289.1 4402.8 4425.5 4434.8 4439.9 4468.6 4576.4 4686.7 4730.7 4753.8 4759.9 4810.1 4837.2 4876.2 4905.1 4945.7 4683.4 4688.4 4690.3 4695.1 4742.5 4655.4 4765.5 4845.1 4863.0 4910.9 4798.2 4813.5 4916.3 4970.0 5036.8 4740.7 4745.6 4757.3 4794.7 4806.5 4727.3 4733.5 4741.9 4754.4 4786.7 4507.4 4532.3 4569.4 4589.4 4676.5 4710.7 4758.3 4891.8 4899.0 4900.0 4675.8 4707.4 4715.7 4715.9 4756.2 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#1] ext.html Cycles:180 Average:40493.95 Median:32758.01 stddev:64550.23 (197.1%) stddev-sans-first:64661.46 19:11:47 INFO - PROCESS | 2682 | Values: 497.4 533.6 563.4 571.0 578.1 24911.0 35941.8 36928.4 36937.4 37028.6 40315.0 40778.6 40866.0 40872.6 40952.4 6742.8 6818.6 7827.4 8039.2 8050.7 9790.6 10035.2 10035.4 10036.8 10038.5 9686.3 9739.0 9801.8 9808.3 9814.3 6730.9 6933.0 9806.5 9842.5 10115.7 9578.7 9751.3 9753.7 9755.2 9755.8 32355.8 32792.3 32806.0 32809.0 32833.0 2680.1 2688.8 2705.0 3103.8 3355.4 26059.2 28612.8 28691.6 28862.4 29161.6 3325.4 3425.8 3436.9 3507.1 3533.0 235319.0 237055.0 237812.0 238024.0 238237.0 55119.4 55122.4 55149.0 55698.7 55817.4 47512.5 48371.0 56194.4 57535.4 58117.4 12612.0 12930.9 12986.5 13001.7 13003.0 10195.4 10273.8 10290.3 10396.3 10398.5 17730.9 17857.6 17890.9 17900.2 17919.2 7186.5 7439.9 7538.0 7566.4 7580.7 867.4 880.2 884.1 909.2 1011.6 26676.5 26794.5 26924.2 27115.0 27207.6 938.7 956.2 969.4 974.0 991.6 13755.7 14009.0 14052.9 14191.6 14220.9 258190.0 259266.0 265739.0 265871.0 266008.0 46002.3 46189.0 46212.8 46303.8 46307.3 1207.4 1223.3 1225.5 1227.9 1229.7 25441.0 26383.7 26581.2 26890.2 26902.0 35588.8 36322.8 40260.6 40808.0 40881.8 238542.0 241370.0 244551.0 244984.0 245175.0 24083.2 24623.6 24770.5 24989.0 25029.2 36928.6 37283.4 37588.0 37736.4 37927.6 28732.0 29122.9 32476.7 33821.5 34084.3 32202.4 32406.4 32418.8 32526.7 36462.0 32640.2 32740.7 32775.3 33003.3 33068.5 28669.7 29128.1 29676.4 29806.3 30135.8 21476.8 23382.9 23563.6 23847.4 25474.9 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#2] jquery.html Cycles:180 Average:22176.80 Median:39112.42 stddev:59130.09 (151.2%) stddev-sans-first:59273.22 19:11:47 INFO - PROCESS | 2682 | Values: 333.9 334.2 336.2 336.2 336.7 12280.5 12742.2 14784.3 15175.8 15571.1 8988.0 9283.0 9286.0 12580.8 14678.5 4429.4 4545.0 4549.5 4551.9 4552.9 3278.3 3375.9 4836.5 4993.8 5024.2 4915.2 4950.6 4967.4 4973.0 4974.3 4894.5 5047.9 5115.4 5118.7 5119.2 4948.3 4950.6 4952.2 4957.4 4957.7 11236.6 11660.9 11662.6 11677.8 11680.5 1698.8 1747.0 1757.1 1762.6 1871.0 8620.8 8731.4 8981.1 10699.8 12311.6 1624.2 1639.3 1779.7 1790.2 1810.6 55380.7 58490.9 59048.4 59415.0 59868.7 9392.6 9528.4 9624.8 9629.0 9675.9 12328.9 12347.4 12353.1 12357.7 12375.1 6819.1 6837.9 6856.8 6894.2 6970.3 6615.7 6626.8 6654.5 6661.4 6689.3 4013.0 4048.2 4058.9 4080.1 4086.0 1535.7 1541.1 1586.2 1628.7 1670.8 850.6 868.4 905.8 939.8 966.0 13805.2 14168.8 15390.0 15604.9 15783.4 771.4 789.0 837.2 891.8 915.3 8738.3 9082.8 9333.1 9441.6 9536.5 319422.0 323767.0 324799.0 326009.0 473787.0 63045.7 76794.6 77970.3 78429.6 80034.6 1019.4 1040.3 1049.7 1053.6 1054.5 13990.2 14421.6 14591.2 14732.3 14738.6 29982.6 30144.8 33173.8 33861.2 34227.7 37509.6 38058.8 38418.4 38510.2 39714.6 8164.3 8339.5 8428.3 8637.7 8654.3 16010.1 16104.0 16118.8 16264.5 16281.1 12970.3 13033.3 13205.9 13601.6 14018.1 12983.8 13042.9 13255.4 13304.0 13352.5 10793.5 12522.9 13814.2 14047.8 14162.4 8328.3 8575.9 8751.4 8757.6 8770.3 8902.8 9022.9 9481.4 13335.6 13352.9 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#3] mootools.html Cycles:180 Average:4749.70 Median:6143.87 stddev:2449.24 (39.9%) stddev-sans-first:2441.61 19:11:47 INFO - PROCESS | 2682 | Values: 1204.2 1378.8 1379.9 1484.5 1713.1 5639.7 6464.1 6575.1 6576.4 6586.6 6676.3 6858.2 6862.6 6871.2 6876.3 1689.8 1726.7 1728.7 1987.9 2032.5 1676.5 1683.5 2024.2 2070.0 2087.3 1924.2 2019.0 2024.2 2026.7 2028.1 2034.2 2044.6 2059.8 2061.4 2062.4 2015.8 2029.7 2076.4 2078.6 2079.6 6809.3 6956.8 6962.4 6962.8 6973.8 3959.2 4033.6 4051.4 4061.1 4065.1 2508.4 2519.4 2537.3 2582.9 2605.4 763.4 771.3 782.6 801.7 801.8 9041.8 9109.5 9111.6 9119.8 9121.3 3631.6 3658.3 3720.3 3722.5 3764.1 7879.8 7919.8 7921.0 7923.8 7924.6 3997.8 4006.9 4018.0 4037.5 4042.8 3622.3 3634.9 3646.9 3656.3 3661.5 2885.4 3238.6 3243.6 3343.4 3344.4 897.4 907.2 911.5 1026.5 1051.3 895.9 902.5 911.5 953.5 1111.1 6080.5 6129.3 6158.4 6159.7 6167.9 1026.5 1034.5 1035.4 1041.5 1063.1 4862.4 4955.1 4963.6 4973.1 4973.7 7659.8 7888.5 7904.4 7925.5 7937.4 7873.4 7886.2 7886.6 7887.3 7894.3 6037.5 6073.1 6318.1 6460.3 6474.2 6267.2 6369.9 6374.1 6379.9 6380.9 7190.8 7255.1 7341.9 7368.3 7381.9 7156.1 7247.9 7345.1 7523.4 7526.7 6075.4 6170.4 6176.1 6176.6 6182.2 6510.1 6564.9 6581.4 6584.7 6601.1 6096.1 6121.1 6326.0 6386.7 6395.9 6283.5 6301.3 6402.7 6407.7 6423.8 6306.0 6316.7 6402.1 6415.9 6419.6 5864.6 5865.0 5921.6 5929.2 5930.6 5691.2 5929.3 5952.0 5971.3 5975.0 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#4] prototype.html Cycles:180 Average:4644.27 Median:5332.39 stddev:1382.02 (25.9%) stddev-sans-first:1346.50 19:11:47 INFO - PROCESS | 2682 | Values: 278.8 289.1 294.1 299.4 301.2 5305.4 5359.3 5376.8 5382.1 5391.2 5267.6 5271.6 5288.9 5289.7 5290.3 4094.8 4097.3 4099.8 4100.0 4101.5 3899.1 4007.2 4090.0 4104.6 4115.4 3967.8 3986.8 3998.7 4000.4 4000.9 3617.5 3964.6 3968.7 3970.6 4061.7 3568.4 3571.5 3577.4 3581.2 3589.4 5065.1 5137.7 5140.9 5143.0 5144.4 4739.8 4741.7 4744.2 4747.5 4750.1 5544.9 5574.7 5580.8 5591.1 5601.9 3707.6 3816.8 3833.3 3890.5 3908.9 5788.8 5850.4 5865.8 5866.1 5870.2 4059.2 4069.2 4074.3 4075.4 4076.6 4131.5 4146.3 4146.6 4150.0 4153.6 4468.5 4648.6 4661.5 4665.8 4711.6 5510.1 5574.0 5581.6 5589.8 5596.4 1405.5 1423.6 1435.5 1437.2 1437.3 950.2 956.9 962.2 982.9 985.2 4892.5 4895.1 4895.3 4898.6 4906.4 5807.5 5811.3 5811.6 5816.9 5818.9 4889.5 4890.2 4892.0 4901.1 4904.2 3028.2 3106.1 3130.4 3140.2 3140.8 5563.6 5570.9 5580.5 5581.1 5581.2 6019.2 6030.2 6031.2 6032.4 6032.7 5533.7 5565.8 5569.9 5577.9 5582.2 5699.7 5866.3 5870.2 5877.4 5879.8 5451.2 5504.8 5632.5 5722.3 5737.3 5548.9 5576.9 5584.1 5584.5 5588.7 3938.2 3949.5 3957.8 3962.8 3969.0 5666.8 5845.2 5849.4 5859.3 5863.4 5656.5 5663.5 5666.3 5667.8 5668.6 5649.5 5658.6 5660.8 5660.9 5665.2 5516.2 5540.7 5546.3 5547.9 5549.7 5527.9 5668.4 5678.7 5679.8 5685.1 5478.7 5491.3 5492.7 5492.7 5505.1 19:11:47 INFO - PROCESS | 2682 | 19:11:47 INFO - PROCESS | 2682 | [#5] yui.html Cycles:180 Average:11574.98 Median:562.61 stddev:13454.51 (2391.4%) stddev-sans-first:13467.02 19:11:47 INFO - PROCESS | 2682 | Values: 603.3 626.9 697.9 698.4 703.2 10377.4 10539.6 11291.9 11420.6 11445.5 12107.3 12235.1 12240.9 12243.6 12246.2 601.2 786.0 798.3 800.2 800.6 614.9 782.7 798.1 798.2 800.4 824.7 841.4 841.6 841.8 843.1 645.4 654.8 816.8 823.6 832.3 612.3 616.0 617.3 617.8 617.8 10769.0 10853.5 10865.7 10870.5 10879.9 10429.7 10575.2 10613.6 10899.1 10932.7 8431.7 8598.1 8679.6 8742.9 8919.8 3061.7 3069.8 3098.9 3159.3 3180.9 40031.6 40579.6 40589.2 40605.6 40617.2 8103.1 8247.5 8368.4 8435.9 8481.2 16340.6 16342.3 16359.3 16389.5 16390.3 5981.0 6013.0 6049.0 6095.8 6176.5 3279.1 3391.1 3427.7 3473.3 3599.8 2525.7 2556.3 2559.8 2561.6 2563.0 452.5 494.6 504.8 512.0 512.8 417.0 501.0 509.7 519.0 531.0 7390.2 7706.9 7856.7 7858.6 7964.2 455.5 511.8 515.3 548.5 576.7 3416.4 3450.6 3451.2 3485.2 3598.1 46143.0 46467.8 46523.3 46564.5 46577.3 43019.1 44034.6 44105.3 44853.8 44894.6 40209.6 40653.4 40945.0 41015.4 41123.0 6633.9 6764.7 6854.6 6925.9 7007.9 28625.3 29117.4 29260.7 29776.9 29960.0 35018.3 35018.8 37270.0 39356.4 39648.4 8524.4 8564.9 8606.5 8835.9 8918.0 9833.7 9943.3 9982.8 10009.9 10016.2 8446.5 8472.4 8515.9 8535.8 8580.4 9030.5 9124.0 9172.6 9180.1 9246.4 8733.4 8750.7 8760.2 8824.4 8869.2 7519.8 7577.7 7727.9 8025.7 8054.2 7505.1 7511.0 8091.7 8272.5 8753.1 19:11:47 INFO - PROCESS | 2682 | -------- Summary: end -------- 19:11:47 INFO - PROCESS | 2682 | 19:11:48 INFO - TEST-INFO | 2682: exit 0 19:11:48 INFO - TEST-OK | dromaeo_css | took 1118100ms 19:11:48 INFO - TEST-START | kraken 19:11:48 INFO - operating with platform_type : linux_ 19:11:48 INFO - Initialising browser for kraken test... 19:11:48 INFO - TEST-INFO | started process 2982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWEjog/profile http://localhost:45862/getInfo.html) 19:11:53 INFO - PROCESS | 2982 | __metrics Screen width/height:1600/1200 19:11:53 INFO - PROCESS | 2982 | colorDepth:24 19:11:53 INFO - PROCESS | 2982 | Browser inner width/height: 1024/697 19:11:53 INFO - PROCESS | 2982 | __metrics 19:11:53 INFO - PROCESS | 2982 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:11:53 INFO - PROCESS | 2982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:54 INFO - TEST-INFO | 2982: exit 0 19:11:54 INFO - Browser initialized. 19:11:54 INFO - Running cycle 1/1 for kraken test... 19:11:54 INFO - TEST-INFO | started process 3063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWEjog/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:06 INFO - PROCESS | 3063 | RSS: Main: 149618688 19:12:06 INFO - PROCESS | 3063 | 19:12:08 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45862/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:09 INFO - PROCESS | 3063 | RSS: Main: 184274944 19:12:09 INFO - PROCESS | 3063 | 19:12:12 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45862/tests/kraken/driver.html?testName=audio-dft) 19:12:12 INFO - PROCESS | 3063 | RSS: Main: 174522368 19:12:12 INFO - PROCESS | 3063 | 19:12:15 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45862/tests/kraken/driver.html?testName=audio-fft) 19:12:16 INFO - PROCESS | 3063 | RSS: Main: 162287616 19:12:16 INFO - PROCESS | 3063 | 19:12:18 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45862/tests/kraken/driver.html?testName=audio-oscillator) 19:12:18 INFO - PROCESS | 3063 | RSS: Main: 163594240 19:12:18 INFO - PROCESS | 3063 | 19:12:21 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:12:21 INFO - PROCESS | 3063 | RSS: Main: 164065280 19:12:21 INFO - PROCESS | 3063 | 19:12:24 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45862/tests/kraken/driver.html?testName=imaging-darkroom) 19:12:25 INFO - PROCESS | 3063 | RSS: Main: 166080512 19:12:25 INFO - PROCESS | 3063 | 19:12:28 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45862/tests/kraken/driver.html?testName=imaging-desaturate) 19:12:29 INFO - PROCESS | 3063 | RSS: Main: 166838272 19:12:29 INFO - PROCESS | 3063 | 19:12:32 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45862/tests/kraken/driver.html?testName=json-parse-financial) 19:12:32 INFO - PROCESS | 3063 | RSS: Main: 166346752 19:12:32 INFO - PROCESS | 3063 | 19:12:34 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:12:34 INFO - PROCESS | 3063 | RSS: Main: 175788032 19:12:34 INFO - PROCESS | 3063 | 19:12:36 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:12:37 INFO - PROCESS | 3063 | RSS: Main: 174899200 19:12:37 INFO - PROCESS | 3063 | 19:12:39 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:12:40 INFO - PROCESS | 3063 | RSS: Main: 185995264 19:12:40 INFO - PROCESS | 3063 | 19:12:42 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:43 INFO - PROCESS | 3063 | RSS: Main: 187744256 19:12:43 INFO - PROCESS | 3063 | 19:12:45 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:12:46 INFO - PROCESS | 3063 | RSS: Main: 186810368 19:12:46 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | Cycle 1(1): loaded http://localhost:45862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45862/tests/kraken/driver.html?testName=ai-astar) 19:12:48 INFO - PROCESS | 3063 | RSS: Main: 245440512 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | __start_tp_report 19:12:48 INFO - PROCESS | 3063 | _x_x_mozilla_page_load 19:12:48 INFO - PROCESS | 3063 | _x_x_mozilla_page_load_details 19:12:48 INFO - PROCESS | 3063 | |i|pagename|runs| 19:12:48 INFO - PROCESS | 3063 | |0;ai-astar;111;113;109;113;113;112;102;112;114;104 19:12:48 INFO - PROCESS | 3063 | |1;audio-beat-detection;156;139;159;169;134;150;151;132;175;130 19:12:48 INFO - PROCESS | 3063 | |2;audio-dft;161;160;160;169;164;160;163;163;162;162 19:12:48 INFO - PROCESS | 3063 | |3;audio-fft;74;73;85;91;73;74;72;94;96;72 19:12:48 INFO - PROCESS | 3063 | |4;audio-oscillator;98;99;140;98;98;98;136;99;98;132 19:12:48 INFO - PROCESS | 3063 | |5;imaging-gaussian-blur;109;109;109;110;110;110;110;109;109;109 19:12:48 INFO - PROCESS | 3063 | |6;imaging-darkroom;146;146;147;147;146;146;147;147;146;147 19:12:48 INFO - PROCESS | 3063 | |7;imaging-desaturate;95;95;96;96;96;96;95;96;95;95 19:12:48 INFO - PROCESS | 3063 | |8;json-parse-financial;73;73;73;73;71;71;74;80;70;70 19:12:48 INFO - PROCESS | 3063 | |9;json-stringify-tinderbox;68;69;68;69;69;70;68;68;69;69 19:12:48 INFO - PROCESS | 3063 | |10;stanford-crypto-aes;83;84;85;90;84;85;84;87;86;85 19:12:48 INFO - PROCESS | 3063 | |11;stanford-crypto-ccm;122;128;121;121;127;131;123;126;120;127 19:12:48 INFO - PROCESS | 3063 | |12;stanford-crypto-pbkdf2;139;138;151;151;154;140;141;149;147;140 19:12:48 INFO - PROCESS | 3063 | |13;stanford-crypto-sha256-iterative;76;72;71;71;72;74;70;72;71;71 19:12:48 INFO - PROCESS | 3063 | __end_tp_report 19:12:48 INFO - PROCESS | 3063 | __start_cc_report 19:12:48 INFO - PROCESS | 3063 | _x_x_mozilla_cycle_collect,978 19:12:48 INFO - PROCESS | 3063 | __end_cc_report 19:12:48 INFO - PROCESS | 3063 | __startTimestamp1451531568547__endTimestamp 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | ------- Summary: start ------- 19:12:48 INFO - PROCESS | 3063 | Number of tests: 14 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:4.11 (3.7%) stddev-sans-first:4.35 19:12:48 INFO - PROCESS | 3063 | Values: 111.0 113.0 109.0 113.0 113.0 112.0 102.0 112.0 114.0 104.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:153.50 stddev:15.64 (10.2%) stddev-sans-first:16.41 19:12:48 INFO - PROCESS | 3063 | Values: 156.0 139.0 159.0 169.0 134.0 150.0 151.0 132.0 175.0 130.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:2.72 (1.7%) stddev-sans-first:2.83 19:12:48 INFO - PROCESS | 3063 | Values: 161.0 160.0 160.0 169.0 164.0 160.0 163.0 163.0 162.0 162.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#3] audio-fft Cycles:10 Average:80.40 Median:79.50 stddev:9.97 (12.5%) stddev-sans-first:10.30 19:12:48 INFO - PROCESS | 3063 | Values: 74.0 73.0 85.0 91.0 73.0 74.0 72.0 94.0 96.0 72.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:98.00 stddev:18.32 (18.7%) stddev-sans-first:18.94 19:12:48 INFO - PROCESS | 3063 | Values: 98.0 99.0 140.0 98.0 98.0 98.0 136.0 99.0 98.0 132.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:12:48 INFO - PROCESS | 3063 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:12:48 INFO - PROCESS | 3063 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:12:48 INFO - PROCESS | 3063 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:2.90 (4.0%) stddev-sans-first:3.07 19:12:48 INFO - PROCESS | 3063 | Values: 73.0 73.0 73.0 73.0 71.0 71.0 74.0 80.0 70.0 70.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 19:12:48 INFO - PROCESS | 3063 | Values: 68.0 69.0 68.0 69.0 69.0 70.0 68.0 68.0 69.0 69.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:2.00 (2.4%) stddev-sans-first:1.94 19:12:48 INFO - PROCESS | 3063 | Values: 83.0 84.0 85.0 90.0 84.0 85.0 84.0 87.0 86.0 85.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:126.50 stddev:3.69 (2.9%) stddev-sans-first:3.79 19:12:48 INFO - PROCESS | 3063 | Values: 122.0 128.0 121.0 121.0 127.0 131.0 123.0 126.0 120.0 127.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:148.00 stddev:6.00 (4.1%) stddev-sans-first:5.96 19:12:48 INFO - PROCESS | 3063 | Values: 139.0 138.0 151.0 151.0 154.0 140.0 141.0 149.0 147.0 140.0 19:12:48 INFO - PROCESS | 3063 | 19:12:48 INFO - PROCESS | 3063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.76 (2.4%) stddev-sans-first:1.13 19:12:48 INFO - PROCESS | 3063 | Values: 76.0 72.0 71.0 71.0 72.0 74.0 70.0 72.0 71.0 71.0 19:12:48 INFO - PROCESS | 3063 | -------- Summary: end -------- 19:12:48 INFO - PROCESS | 3063 | 19:12:49 INFO - TEST-INFO | 3063: exit 0 19:12:49 INFO - TEST-OK | kraken | took 61352ms 19:12:49 INFO - TEST-START | v8_7 19:12:49 INFO - operating with platform_type : linux_ 19:12:49 INFO - Initialising browser for v8_7 test... 19:12:49 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_fww23/profile http://localhost:45862/getInfo.html) 19:12:54 INFO - PROCESS | 3311 | __metrics Screen width/height:1600/1200 19:12:54 INFO - PROCESS | 3311 | colorDepth:24 19:12:54 INFO - PROCESS | 3311 | Browser inner width/height: 1024/697 19:12:54 INFO - PROCESS | 3311 | __metrics 19:12:54 INFO - PROCESS | 3311 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:12:54 INFO - PROCESS | 3311 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:55 INFO - TEST-INFO | 3311: exit 0 19:12:55 INFO - Browser initialized. 19:12:55 INFO - Running cycle 1/1 for v8_7 test... 19:12:55 INFO - TEST-INFO | started process 3395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_fww23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:07 INFO - PROCESS | 3395 | RSS: Main: 149540864 19:13:07 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45862/tests/v8_7/run.html (next: http://localhost:45862/tests/v8_7/run.html) 19:13:29 INFO - PROCESS | 3395 | RSS: Main: 446476288 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | __start_tp_report 19:13:29 INFO - PROCESS | 3395 | _x_x_mozilla_page_load 19:13:29 INFO - PROCESS | 3395 | _x_x_mozilla_page_load_details 19:13:29 INFO - PROCESS | 3395 | |i|pagename|runs| 19:13:29 INFO - PROCESS | 3395 | |0;Richards;168.20857863751053 19:13:29 INFO - PROCESS | 3395 | |1;DeltaBlue;188.040616773223 19:13:29 INFO - PROCESS | 3395 | |2;Encrypt;279.2516056967328 19:13:29 INFO - PROCESS | 3395 | |3;Decrypt;5186.5284974093265 19:13:29 INFO - PROCESS | 3395 | |4;RayTrace;1992.03187250996 19:13:29 INFO - PROCESS | 3395 | |5;Earley;799.3605115907275 19:13:29 INFO - PROCESS | 3395 | |6;Boyer;12132.530120481928 19:13:29 INFO - PROCESS | 3395 | |7;RegExp;26552.63157894737 19:13:29 INFO - PROCESS | 3395 | |8;Splay;593.1198102016607 19:13:29 INFO - PROCESS | 3395 | |9;NavierStokes;4840.579710144928 19:13:29 INFO - PROCESS | 3395 | __end_tp_report 19:13:29 INFO - PROCESS | 3395 | __startTimestamp1451531609361__endTimestamp 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | ------- Summary: start ------- 19:13:29 INFO - PROCESS | 3395 | Number of tests: 10 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 168.2 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 188.0 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 279.3 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 5186.5 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 1992.0 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 799.4 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 12132.5 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 26552.6 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#8] Splay Cycles:1 Average:593.12 Median:593.12 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 593.1 19:13:29 INFO - PROCESS | 3395 | 19:13:29 INFO - PROCESS | 3395 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:13:29 INFO - PROCESS | 3395 | Values: 4840.6 19:13:29 INFO - PROCESS | 3395 | -------- Summary: end -------- 19:13:29 INFO - PROCESS | 3395 | 19:13:30 INFO - TEST-INFO | 3395: exit 0 19:13:30 INFO - TEST-OK | v8_7 | took 40956ms 19:13:30 INFO - SUITE-END | took 1220s 19:13:30 INFO - Completed test suite (00:20:20) 19:13:30 INFO - Working with test: dromaeo_css 19:13:30 INFO - Generating results file: dromaeo_css 19:13:30 INFO - Working with test: kraken 19:13:30 INFO - Generating results file: kraken 19:13:30 INFO - javascript benchmark 19:13:30 INFO - Working with test: v8_7 19:13:30 INFO - Generating results file: v8_7 19:13:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 19:13:30 INFO - process_Request line: dromaeo_css 6105.78 graph.html#tests=[[72,203,35]] 19:13:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:30 INFO - process_Request line: kraken 1532.00 graph.html#tests=[[232,203,35]] 19:13:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:30 INFO - process_Request line: v8_7 19792.50 graph.html#tests=[[230,203,35]] 19:13:30 INFO - RETURN: dromaeo_css: 6105.78 19:13:30 INFO - RETURN: kraken: 1532.00 19:13:30 INFO - RETURN: v8_7: 19792.50 19:13:30 INFO - javascript benchmark 19:13:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2575.9198824144887, 2692.3538350795816, 2700.06847637565, 2704.6754389473267, 2711.471263103694, 4419.580139886705, 4534.093181363724, 4597.839075632353, 4606.769661516928, 4615.515370886054, 4507.076049409871, 4529.2526733089, 4605.677602567822, 4609.746463944482, 4638.188317044521, 4240.978795106028, 4244.045089854789, 4255.5957184067465, 4304.461942257218, 4308.676849236304, 4304.203722311367, 4315.978420107911, 4342.240107981106, 4350.15172041452, 4390.363397307388, 4103.4870641169855, 4196.013936724868, 4208.179405016023, 4299.032717638522, 4325.0, 4176.937345939813, 4261.31818908973, 4263.765492897889, 4271.8718438446895, 4295.098029413827, 4228.492580890313, 4252.978735106336, 4256.531781504032, 4265.594768497019, 4286.657067434598, 4445.844395446176, 4539.251023581105, 4544.500104988449, 4573.63410927125, 4596.287575425815, 4806.0628177505405, 4833.492483289239, 4907.092187945206, 4921.557059864629, 4956.281339205831, 4937.629677774181, 4938.185199442088, 4962.503749625044, 4974.726390048546, 5009.0482808266315, 4423.270160423558, 4525.275955847049, 4588.7935042923145, 4598.218302888484, 4631.652626052992, 4933.802647894116, 4949.084419382426, 5011.323471331323, 5017.147084995559, 5082.059818933509, 4867.853964381075, 4882.462929077798, 4889.413270407574, 4890.779914903838, 4922.064807686528, 4790.688605240648, 4902.7058376497525, 4965.627577931669, 4988.5260900214425, 5021.14640511114, 4774.522547745267, 4790.856274311776, 4859.125357435625, 4871.683340582851, 4911.950880491149, 4833.130036593377, 4846.975765121152, 4857.951420485821, 4860.586850117779, 4885.780139893714, 3938.369860822255, 4034.253663072341, 4109.075458021921, 4111.527174374985, 4169.145325208386, 3556.7510274280553, 3581.6955558777277, 3634.9636503635156, 3656.341858465502, 3665.138692407282, 4201.117765269267, 4232.597903199191, 4233.661307095425, 4236.766977816188, 4265.829366825355, 4756.048790241965, 4880.292357608198, 4920.655554111249, 4927.187014142626, 4983.775730092155, 4169.332906734908, 4201.873943781691, 4262.23279809631, 4263.70154089217, 4289.077848262638, 4402.779861007001, 4425.513193548707, 4434.778261086933, 4439.889002774892, 4468.597826195658, 4576.427946506687, 4686.718796872198, 4730.668853180245, 4753.786079626494, 4759.928601070987, 4810.11012962603, 4837.2260438329695, 4876.21980483121, 4905.068037073087, 4945.653804233669, 4683.437987441529, 4688.390509233778, 4690.3199036138885, 4695.084458530554, 4742.525747425368, 4655.371524844239, 4765.475797662185, 4845.103655823684, 4862.975685121552, 4910.92633610489, 4798.2082956311815, 4813.542713442217, 4916.287138364989, 4969.950300496948, 5036.84889453317, 4740.715557066587, 4745.644076694331, 4757.262624293102, 4794.712317260975, 4806.49531799156, 4727.267273572602, 4733.502982186821, 4741.881452963566, 4754.405699287589, 4786.688865223749, 4507.3915021471685, 4532.297493888453, 4569.36028955953, 4589.426321709786, 4676.46220684612, 4710.740909249887, 4758.310045043519, 4891.779869905934, 4899.04468628614, 4900.019996000743, 4675.76621168947, 4707.411573553306, 4715.669903106749, 4715.882102947454, 4756.19144745401], "unit": "score", "name": "dojo.html", "value": 4510.171662927096}, {"lowerIsBetter": false, "replicates": [497.3608912547375, 533.607798268273, 563.3830955104161, 571.0035987202331, 578.057765841678, 24911.0, 35941.82029089854, 36928.44607330892, 36937.44593831088, 37028.62971370285, 40315.0, 40778.59221407785, 40866.0, 40872.59127408725, 40952.38571421431, 6742.7640032598865, 6818.624975626339, 7827.373810095207, 8039.236272554127, 8050.718224862131, 9790.608375665, 10035.19718422528, 10035.448050357227, 10036.799264014751, 10038.498075096217, 9686.273529485281, 9739.0, 9801.754956126082, 9808.26438017148, 9814.263930205263, 6730.865382692367, 6933.0293758873295, 9806.509674516281, 9842.507874606312, 10115.696529104138, 9578.664746733832, 9751.317407781458, 9753.707388778348, 9755.219582433388, 9755.804883902354, 32355.838220808746, 32792.34415311681, 32806.0, 32809.0, 32833.0, 2680.128958088629, 2688.8117831751783, 2705.0, 3103.8137711737368, 3355.4128027595075, 26059.21822345333, 28612.783118218365, 28691.56962645562, 28862.42275154485, 29161.56257656137, 3325.3515564464938, 3425.760196786226, 3436.862525499002, 3507.0881570791776, 3533.0284171852945, 235319.0, 237055.0, 237812.0, 238024.0, 238237.0, 55119.448805512235, 55122.44877551173, 55149.0, 55698.72150639221, 55817.441825582035, 47512.5248747515, 48371.0, 56194.438055619736, 57535.42464575385, 58117.41882581205, 12612.0, 12930.870691293156, 12986.480540778452, 13001.674958125934, 13003.024773142051, 10195.388276703421, 10273.845892311621, 10290.331128476626, 10396.272260941661, 10398.532066056894, 17730.91134544319, 17857.553561161076, 17890.91054544745, 17900.194491247927, 17919.193636286138, 7186.461015423864, 7439.85120297591, 7538.0, 7566.35685966699, 7580.734674286374, 867.3971589745066, 880.1858281090094, 884.1158841158841, 909.2180724576858, 1011.5801942194054, 26676.46647067048, 26794.464110717676, 26924.192274231806, 27115.0, 27207.591886121725, 938.7043081429327, 956.2159029595665, 969.3795970578835, 973.9659111931048, 991.6464026603634, 13755.724885502434, 14009.0, 14052.85947140536, 14191.574252772434, 14220.928895355664, 258190.0, 259266.0, 265739.0, 265871.0, 266008.0, 46002.30996535055, 46189.0, 46212.7689361551, 46303.76848115738, 46307.30539041917, 1207.4144040140525, 1223.2660403757675, 1225.5281716539196, 1227.9017678585692, 1229.7294595189044, 25441.0, 26383.736162638128, 26581.20256392234, 26890.193294201206, 26902.0, 35588.822055889555, 36322.8183859079, 40260.59739402569, 40808.0, 40881.79559102185, 238542.0, 241370.0, 244551.0, 244984.0, 245175.0, 24083.157089501783, 24623.63064553997, 24770.50458990846, 24989.0, 25029.249122526355, 36928.63071369252, 37283.44074838825, 37588.0, 37736.433953491265, 37927.62072379241, 28732.0, 29122.854385727936, 32476.675233247366, 33821.492677610346, 34084.31831363408, 32202.35595288128, 32406.351872961935, 32418.83790581032, 32526.674733252363, 36462.0, 32640.183995400304, 32740.67259327376, 32775.34449310953, 33003.339933200725, 33068.503972439954, 28669.713302867538, 29128.12615621535, 29676.40647187001, 29806.25484362908, 30135.849320753256, 21476.78523214748, 23382.883085584464, 23563.646545302177, 23847.403814904766, 25474.87262563675], "unit": "score", "name": "ext.html", "value": 16871.908481507333}, {"lowerIsBetter": false, "replicates": [333.90316808125635, 334.20459306849693, 336.1579243993795, 336.19984437039824, 336.7121111449712, 12280.508779648804, 12742.171758835693, 14784.260786960649, 15175.848241517595, 15571.143587102704, 8988.0, 9283.025282345357, 9286.024967378413, 12580.81128783069, 14678.486252981147, 4429.3798868158565, 4545.045540436512, 4549.454065512143, 4551.886202844938, 4552.9089418211615, 3278.327942771726, 3375.9156021099548, 4836.46798852126, 4993.800247990076, 5024.246363045536, 4915.238138088602, 4950.603951683875, 4967.4287456942375, 4972.950270497303, 4974.303597496353, 4894.467707965088, 5047.899042019158, 5115.386153661584, 5118.744062796845, 5119.206522988924, 4948.257761335793, 4950.603951683856, 4952.232403977389, 4957.355543779286, 4957.652964292501, 11236.550537978472, 11660.88339116615, 11662.59180928672, 11677.824832627517, 11680.532778688843, 1698.7706659601042, 1746.956326091845, 1757.1214392803597, 1762.6122253104297, 1870.9625807483774, 8620.784480387978, 8731.432456890281, 8981.101889811032, 10699.786004279871, 12311.630651080482, 1624.2447262023215, 1639.3196823318308, 1779.6974514332464, 1790.1787703412626, 1810.5654642885745, 55380.72309638426, 58490.94206508953, 59048.40951590472, 59415.0, 59868.700656496876, 9392.62429502826, 9528.380655257386, 9624.75938101539, 9628.951855240679, 9675.87130831216, 12328.938355308166, 12347.444365003596, 12353.135280530456, 12357.691057723629, 12375.071869609636, 6819.079424277659, 6837.931620683829, 6856.760013399507, 6894.24163342032, 6970.302969703091, 6615.735370585123, 6626.801195964129, 6654.4505746210725, 6661.40047395727, 6689.331066893272, 4012.9598704012587, 4048.2105989332385, 4058.939115913264, 4080.10237747695, 4086.0397806515443, 1535.692861427719, 1541.129261966985, 1586.2465328968647, 1628.6986907422165, 1670.8329167083436, 850.6087199887997, 868.444195714743, 905.8278927003848, 939.8308304505118, 966.0, 13805.24071176095, 14168.787468187986, 15390.0, 15604.92197539005, 15783.447579334668, 771.4445599168589, 788.9960550197212, 837.2116174311169, 891.790429249126, 915.33638112368, 8738.344624153215, 9082.772930676785, 9333.066693330748, 9441.575129119206, 9536.475493847765, 319422.0, 323767.0, 324799.0, 326009.0, 473787.0, 63045.68477157585, 76794.61602692063, 77970.3366114966, 78429.60785196038, 80034.5998270005, 1019.4291196929743, 1040.2718097331897, 1049.7141002272308, 1053.5575058475458, 1054.520193312041, 13990.16059036461, 14421.567352979428, 14591.227666743285, 14732.263386830402, 14738.63153421173, 29982.550261746528, 30144.84927575348, 33173.83413083015, 33861.153471163416, 34227.657723422446, 37509.62490375061, 38058.809705951295, 38418.42372364361, 38510.2297954045, 39714.60285397109, 8164.346852251924, 8339.457935234434, 8428.283595894418, 8637.654493820177, 8654.264387526879, 16010.119443430724, 16104.03375797456, 16118.838811611733, 16264.51206463808, 16281.104539249982, 12970.286634235208, 13033.283169425393, 13205.877500412573, 13601.591952241448, 14018.088824226392, 12983.805242921553, 13042.869571304545, 13255.403506842022, 13304.0, 13352.532661356807, 10793.460326983462, 12522.87477125217, 13814.171149731048, 14047.789283160557, 14162.362693678602, 8328.250457458858, 8575.914240857512, 8751.387402881737, 8757.60590773404, 8770.342224333073, 8902.821943561223, 9022.909770902206, 9481.383710058824, 13335.599932002055, 13352.933235333761], "unit": "score", "name": "jquery.html", "value": 7813.397712793327}, {"lowerIsBetter": false, "replicates": [1204.1510734931862, 1378.7793952967525, 1379.8896088312936, 1484.5026915983144, 1713.083500327325, 5639.68981706006, 6464.12734280872, 6575.112359831422, 6576.441002514792, 6586.637734924583, 6676.2989886062, 6858.177018757756, 6862.622555759432, 6871.244163142051, 6876.277990810968, 1689.847913687768, 1726.7323564847468, 1728.6629107324077, 1987.8509111816636, 2032.4715573950805, 1676.5389517882559, 1683.528611988639, 2024.2307922989316, 2070.027087268981, 2087.342487116561, 1924.191839427437, 2018.959620807583, 2024.2004408258729, 2026.7466566679166, 2028.1380413324353, 2034.2473284884613, 2044.570640165567, 2059.845511586637, 2061.443410279224, 2062.4431403520966, 2015.8084981926693, 2029.6549586570318, 2076.377086873947, 2078.615456140604, 2079.6048750737314, 6809.319068093151, 6956.826079348057, 6962.443004559623, 6962.825929351756, 6973.790786276369, 3959.208158368309, 4033.556308806029, 4051.372037334218, 4061.0659548304056, 4065.146319272956, 2508.3854455658297, 2519.3575638212324, 2537.2768760903236, 2582.9483410331877, 2605.4137818990766, 763.3549650545281, 771.3135309574483, 782.5695867272977, 801.7274126796917, 801.8195905921121, 9041.773955651095, 9109.498977556232, 9111.589978450986, 9119.772005699844, 9121.315901307362, 3631.6368363163474, 3658.323210206067, 3720.3489389356755, 3722.4602432647116, 3764.0966168119453, 7879.842403151905, 7919.841603167904, 7921.0, 7923.801904952422, 7924.564148971862, 3997.8200980955926, 4006.8797936061965, 4017.959820401817, 4037.4751282333696, 4042.777647229431, 3622.3117607654463, 3634.9091272717865, 3646.908827279339, 3656.2687462507606, 3661.5423072115987, 2885.3507960709094, 3238.5951756030495, 3243.6107667079627, 3343.36476069546, 3344.364570731553, 897.3763234551924, 907.1608761895352, 911.5168960450972, 1026.5431882812077, 1051.3271506235862, 895.861141523052, 902.4765635931276, 911.5260064766285, 953.5280036382036, 1111.0833562311125, 6080.543959203077, 6129.325774164839, 6158.414950579688, 6159.6612186330185, 6167.907481387782, 1026.5329275179774, 1034.4930983817876, 1035.3942943378058, 1041.5000799616228, 1063.0751246415514, 4862.367892173995, 4955.132851750929, 4963.57809586182, 4973.079980203674, 4973.701577905337, 7659.808504787425, 7888.526688398714, 7904.446688731734, 7925.484843485155, 7937.444378893538, 7873.409494287951, 7886.171951944963, 7886.605669716606, 7887.329576986021, 7894.250046245597, 6037.45662890342, 6073.058675905242, 6318.052292156213, 6460.289368169498, 6474.1907261592305, 6267.2165979252595, 6369.8726025480155, 6374.107624932606, 6379.904301435575, 6380.872382552416, 7190.784276471714, 7255.09311336083, 7341.926580734124, 7368.300011498899, 7381.852362952818, 7156.069710937545, 7247.891281630885, 7345.081864766904, 7523.435742319239, 7526.698932042657, 6075.392460753889, 6170.352113028068, 6176.135341052346, 6176.629402235881, 6182.165407669907, 6510.121133646897, 6564.868702625825, 6581.407673309425, 6584.7036883341325, 6601.141851559267, 6096.055111457731, 6121.112438696453, 6325.9683701583035, 6386.680665966776, 6395.936040639534, 6283.528735344776, 6301.338359472373, 6402.679866006588, 6407.743690252338, 6423.807285781434, 6306.0, 6316.6841657916, 6402.135711678864, 6415.871682566416, 6419.646919419477, 5864.589478736448, 5865.0, 5921.585489015728, 5929.169916211647, 5930.555208359477, 5691.231683722644, 5929.288485381781, 5952.0476723724, 5971.253593300838, 5975.014122669711], "unit": "score", "name": "mootools.html", "value": 3893.2576558205114}, {"lowerIsBetter": false, "replicates": [278.81180203362726, 289.0864867020216, 294.11178241710024, 299.38028281457395, 301.2183384118214, 5305.442928492505, 5359.330083739533, 5376.8118115865955, 5382.138857782756, 5391.16436952273, 5267.578593712504, 5271.578273738101, 5288.867778305545, 5289.656172348795, 5290.285811415458, 4094.7747873866924, 4097.282975479294, 4099.7745124018165, 4100.036491424513, 4101.528324242706, 3899.083715326896, 4007.2185923744883, 4090.0, 4104.610062044101, 4115.403266526352, 3967.841286348543, 3986.820593073319, 3998.7000974926996, 4000.359942409215, 4000.9399859002137, 3617.5297211362486, 3964.6431821136234, 3968.6825053995613, 3970.642642162219, 4061.715679902408, 3568.37553428149, 3571.499990001402, 3577.3560759063357, 3581.230035542345, 3589.371859924529, 5065.088284108859, 5137.691738495665, 5140.897182056338, 5143.045642655767, 5144.356955380577, 4739.834105806281, 4741.691790033637, 4744.217204161309, 4747.45404278509, 4750.121227572876, 5544.86137846553, 5574.749136288877, 5580.832575022756, 5591.10542313232, 5601.887962240773, 3707.610700876396, 3816.8473261069526, 3833.3483307837732, 3890.474785903895, 3908.882733517999, 5788.797392091299, 5850.3564607893095, 5865.824025279248, 5866.090755932837, 5870.207521984563, 4059.1881623674794, 4069.2471892699946, 4074.3277359235985, 4075.3683179107284, 4076.6331030207425, 4131.5455299916985, 4146.295129827937, 4146.647534959502, 4150.045489537423, 4153.646940010133, 4468.530804265505, 4648.604868586141, 4661.463931647904, 4665.8335416145965, 4711.552402521755, 5510.118381059011, 5574.0, 5581.553475721932, 5589.832305030855, 5596.4403559644525, 1405.5150972914328, 1423.5515812519022, 1435.5406269993503, 1437.1879887863324, 1437.2669938331526, 950.1970834644715, 956.9138777510058, 962.2398305338844, 982.9262805289632, 985.1822986920838, 4892.461829198785, 4895.143349913751, 4895.265710143507, 4898.632602554751, 4906.435759887588, 5807.5063619591965, 5811.302643682785, 5811.564132690065, 5816.94183058164, 5818.883622327615, 4889.462159162489, 4890.168671325883, 4892.021595680878, 4901.068796928572, 4904.215325547966, 3028.197527655173, 3106.08370530694, 3130.373925214966, 3140.1678555182893, 3140.842957852098, 5563.638363506359, 5570.888582228414, 5580.497755202051, 5581.05122129239, 5581.190727344512, 6019.247594050744, 6030.18592490017, 6031.155638210654, 6032.3967603239325, 6032.728527216286, 5533.667979921218, 5565.833025009256, 5569.860753481114, 5577.9442205577425, 5582.218489411404, 5699.743511542073, 5866.325372582208, 5870.207521984477, 5877.35349111606, 5879.794207202727, 5451.236826844324, 5504.779808807602, 5632.493075623213, 5722.284714410699, 5737.311522617312, 5548.944510554843, 5576.86057848557, 5584.0507113789945, 5584.46947539983, 5588.692621905834, 3938.1729836734607, 3949.5260568731937, 3957.8021098945514, 3962.821673024663, 3969.0275882408996, 5666.773329066791, 5845.152452894392, 5849.444302791228, 5859.296884373903, 5863.413658634273, 5656.490915817596, 5663.518600918968, 5666.320041595035, 5667.801626943202, 5668.574856885833, 5649.491545760737, 5658.632188907708, 5660.801871934463, 5660.943390566042, 5665.20687103814, 5516.200150978166, 5540.722963851872, 5546.306711661043, 5547.916781248366, 5549.694766787704, 5527.8894422112135, 5668.433156684298, 5678.716064196691, 5679.772809087755, 5685.118806584986, 5478.726063696719, 5491.341039075336, 5492.697901615449, 5492.697901615449, 5505.091659876076], "unit": "score", "name": "prototype.html", "value": 4196.065774365809}, {"lowerIsBetter": false, "replicates": [603.273055967559, 626.9310375858657, 697.8569393274378, 698.4307789151841, 703.1702590942685, 10377.377357358555, 10539.631112911049, 11291.887081129185, 11420.600278990238, 11445.542178312857, 12107.273563586168, 12235.082368822352, 12240.93879530601, 12243.632691019284, 12246.203996740229, 601.1763883479639, 786.0449553792141, 798.3413683710933, 800.1638287989066, 800.6157044618558, 614.8647297594522, 782.7416952405692, 798.1021350980147, 798.2297083314601, 800.4236949396425, 824.6989848705209, 841.364769598952, 841.5834162089743, 841.8232171244047, 843.1484200957016, 645.3933302695498, 654.7642848574509, 816.7713040348652, 823.567626995829, 832.3466079127886, 612.2683393344954, 616.0482055224688, 617.3486971245335, 617.8177437655858, 617.8362733875526, 10769.0, 10853.51159197838, 10865.728356791064, 10870.456477176109, 10879.945600271947, 10429.687109386654, 10575.20685948557, 10613.628523001735, 10899.1280697544, 10932.672019839418, 8431.70489032887, 8598.140185981414, 8679.566021698889, 8742.86885696715, 8919.777005574848, 3061.6938306169204, 3069.8004629699, 3098.8760449582214, 3159.273367125574, 3180.920476988094, 40031.59968400308, 40579.59420405817, 40589.18821623551, 40605.59394406077, 40617.187656247006, 8103.068147163034, 8247.463914845635, 8368.421839418319, 8435.915640843514, 8481.194286542892, 16340.591485212964, 16342.264598093114, 16359.34562617482, 16389.508314750576, 16390.344386224417, 5981.0, 6012.969935150296, 6049.032154855202, 6095.817125486243, 6176.536759743038, 3279.147421670335, 3391.084407210089, 3427.674370934757, 3473.3053389322235, 3599.8380072896784, 2525.7095434024955, 2556.3097963549735, 2559.8080143989278, 2561.602951542514, 2563.013239902651, 452.50902770493724, 494.5944325653002, 504.8359283232964, 511.97440127994196, 512.8333291680219, 416.95205051418867, 500.97244651543787, 509.69927742631285, 519.0371860199351, 531.0017167724653, 7390.187079421259, 7706.884396734054, 7856.7250146244605, 7858.567778772108, 7964.2433968772875, 455.54900648357886, 511.81574633132044, 515.2606010375124, 548.5337463156364, 576.685706290073, 3416.3850506908498, 3450.603180634209, 3451.1717187875233, 3485.19840436701, 3598.1184609770776, 46143.0, 46467.76766116148, 46523.30215046777, 46564.534354656695, 46577.30134047992, 43019.13961720811, 44034.55965440305, 44105.338419923726, 44853.77573112179, 44894.55105448969, 40209.597904020586, 40653.390199147034, 40945.0, 41015.35938562484, 41123.0, 6633.9336606633315, 6764.661766911537, 6854.622995735083, 6925.930740692528, 7007.935954754048, 28625.280598343124, 29117.417651646425, 29260.707392925797, 29776.85111574428, 29960.0, 35018.299634007686, 35018.824905875306, 37270.0, 39356.409653854644, 39648.40527392034, 8524.36067294943, 8564.914350856661, 8606.526641034803, 8835.867461988204, 8917.955410222907, 9833.704988850346, 9943.30396872212, 9982.750431239278, 10009.949950250202, 10016.248781341574, 8446.493210407396, 8472.364572656952, 8515.91484085176, 8535.829283414421, 8580.356473264404, 9030.503322317072, 9124.0, 9172.633094676139, 9180.081991800767, 9246.398984066014, 8733.432326898732, 8750.737477875675, 8760.167784060504, 8824.382293239412, 8869.157430044135, 7519.774406767806, 7577.734779282699, 7727.884081738891, 8025.678972841021, 8054.194580541899, 7505.136909255505, 7510.962445187739, 8091.697275559548, 8272.503649781032, 8753.08092650288], "unit": "score", "name": "yui.html", "value": 5333.916292148797}], "name": "dromaeo_css", "value": 6105.778206993945}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 109.0, 113.0, 113.0, 112.0, 102.0, 112.0, 114.0, 104.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [156.0, 139.0, 159.0, 169.0, 134.0, 150.0, 151.0, 132.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 169.0, 164.0, 160.0, 163.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 85.0, 91.0, 73.0, 74.0, 72.0, 94.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 140.0, 98.0, 98.0, 98.0, 136.0, 99.0, 98.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 73.0, 71.0, 71.0, 74.0, 80.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 90.0, 84.0, 85.0, 84.0, 87.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 128.0, 121.0, 121.0, 127.0, 131.0, 123.0, 126.0, 120.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 151.0, 151.0, 154.0, 140.0, 141.0, 149.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 71.0, 71.0, 72.0, 74.0, 70.0, 72.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1532.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.20857863751053], "unit": "score", "name": "Richards", "value": 209.87038999999996}, {"lowerIsBetter": false, "replicates": [188.040616773223], "unit": "score", "name": "DeltaBlue", "value": 351.6155239999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [593.1198102016607], "unit": "score", "name": "Splay", "value": 137.39382600000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19792.499898848655}]} 19:13:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19792.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1532.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6105.78"}}} 19:13:31 INFO - Return code: 0 19:13:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:31 INFO - # TBPL SUCCESS # 19:13:31 INFO - Running post-action listener: _resource_record_post_action 19:13:31 INFO - Running post-run listener: _resource_record_post_run 19:13:32 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327864320; Read time: 8; Write time: 700200 19:13:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20025344; Read time: 0; Write time: 33200 19:13:32 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 307838976; Read time: 8; Write time: 667000 19:13:32 INFO - Running post-run listener: _upload_blobber_files 19:13:32 INFO - Blob upload gear active. 19:13:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:32 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 19:13:32 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:13:32 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:13:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:33 INFO - (blobuploader) - INFO - Done attempting. 19:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:34 INFO - (blobuploader) - INFO - Done attempting. 19:13:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:34 INFO - Return code: 0 19:13:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:13:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/dc38c8c87f0a8065615c33f3967a1ce602e8cdd6e55dc18fb1d9940f720ebe18b6d5e5ef558728792fd51dcb247dad739c8f12be0ebd57e47dfab12bb6e4be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/663d95681d1751f6e873dcfcb6a7ed63bb027c033a4507d69a87e484d10d8c02c180c4fb1e9d656b34184fc380c3c805c79b07890b56f5bb965e3c5756686af4"} 19:13:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:13:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:13:34 INFO - Contents: 19:13:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/dc38c8c87f0a8065615c33f3967a1ce602e8cdd6e55dc18fb1d9940f720ebe18b6d5e5ef558728792fd51dcb247dad739c8f12be0ebd57e47dfab12bb6e4be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/663d95681d1751f6e873dcfcb6a7ed63bb027c033a4507d69a87e484d10d8c02c180c4fb1e9d656b34184fc380c3c805c79b07890b56f5bb965e3c5756686af4"} 19:13:34 INFO - Copying logs to upload dir... 19:13:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1302.404334 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2015-12-30 19:13:33.564043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:13:33.567919) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/dc38c8c87f0a8065615c33f3967a1ce602e8cdd6e55dc18fb1d9940f720ebe18b6d5e5ef558728792fd51dcb247dad739c8f12be0ebd57e47dfab12bb6e4be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/663d95681d1751f6e873dcfcb6a7ed63bb027c033a4507d69a87e484d10d8c02c180c4fb1e9d656b34184fc380c3c805c79b07890b56f5bb965e3c5756686af4"} build_url:https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/DpAvh4kgT0a9YR5QhFk_Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/dc38c8c87f0a8065615c33f3967a1ce602e8cdd6e55dc18fb1d9940f720ebe18b6d5e5ef558728792fd51dcb247dad739c8f12be0ebd57e47dfab12bb6e4be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/663d95681d1751f6e873dcfcb6a7ed63bb027c033a4507d69a87e484d10d8c02c180c4fb1e9d656b34184fc380c3c805c79b07890b56f5bb965e3c5756686af4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:13:33.592762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:13:33.593065) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451524301.320791-1436811588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:13:33.677674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:13:33.678019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:13:33.678319) ========= ========= Total master_lag: 0.20 =========