builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1450792775.24 results: success (0) buildid: 20151222034722 builduid: 74fba6dbaa7543f5b0960aa455acd95b revision: be401039fb14fdd9679121c634eeb873be2e7f08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.237182) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.237664) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.237946) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006185 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.260142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.260441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.273528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.273848) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.323156) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.323512) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.323860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.324166) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 05:59:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-22 05:59:35 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.432168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.432507) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:35.482031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 05:59:35.482419) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev be401039fb14fdd9679121c634eeb873be2e7f08 --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 be401039fb14fdd9679121c634eeb873be2e7f08 --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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 05:59:36,108 truncating revision to first 12 chars 2015-12-22 05:59:36,109 Setting DEBUG logging. 2015-12-22 05:59:36,109 attempt 1/10 2015-12-22 05:59:36,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/be401039fb14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 05:59:36,965 unpacking tar archive at: b2g-inbound-be401039fb14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.142017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 05:59:36.637568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:36.637891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:36.644329) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:36.644609) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:59:36.645007) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-22 05:59:36.645289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:37 INFO - MultiFileLogger online at 20151222 05:59:37 in /builds/slave/test 05:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 05:59:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:37 INFO - {'append_to_log': False, 05:59:37 INFO - 'base_work_dir': '/builds/slave/test', 05:59:37 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 05:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:37 INFO - 'branch': 'B2G-Inbound-Non-PGO', 05:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:37 INFO - 'config_files': ('talos/linux_config.py',), 05:59:37 INFO - 'default_actions': ('clobber', 05:59:37 INFO - 'read-buildbot-config', 05:59:37 INFO - 'download-and-extract', 05:59:37 INFO - 'populate-webroot', 05:59:37 INFO - 'create-virtualenv', 05:59:37 INFO - 'install', 05:59:37 INFO - 'run-tests'), 05:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:37 INFO - 'download_minidump_stackwalk': True, 05:59:37 INFO - 'download_symbols': 'ondemand', 05:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:37 INFO - 'installer_path': 'installer.exe', 05:59:37 INFO - 'log_level': 'info', 05:59:37 INFO - 'log_name': 'talos', 05:59:37 INFO - 'log_to_console': True, 05:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:37 INFO - 'opt_config_files': (), 05:59:37 INFO - 'pip_index': False, 05:59:37 INFO - 'sps_profile': False, 05:59:37 INFO - 'sps_profile_interval': 0, 05:59:37 INFO - 'suite': 'dromaeojs', 05:59:37 INFO - 'system_bits': '64', 05:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:37 INFO - 'title': 'talos-linux64-ix-014', 05:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:37 INFO - 'use_talos_json': True, 05:59:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:37 INFO - 'work_dir': 'build'} 05:59:37 INFO - ##### 05:59:37 INFO - ##### Running clobber step. 05:59:37 INFO - ##### 05:59:37 INFO - Running pre-action listener: _resource_record_pre_action 05:59:37 INFO - Running main action method: clobber 05:59:37 INFO - rmtree: /builds/slave/test/build 05:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:37 INFO - Running post-action listener: _resource_record_post_action 05:59:37 INFO - ##### 05:59:37 INFO - ##### Running read-buildbot-config step. 05:59:37 INFO - ##### 05:59:37 INFO - Running pre-action listener: _resource_record_pre_action 05:59:37 INFO - Running main action method: read_buildbot_config 05:59:37 INFO - Using buildbot properties: 05:59:37 INFO - { 05:59:37 INFO - "project": "", 05:59:37 INFO - "product": "firefox", 05:59:37 INFO - "script_repo_revision": "production", 05:59:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:59:37 INFO - "repository": "", 05:59:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 05:59:37 INFO - "buildid": "20151222034722", 05:59:37 INFO - "pgo_build": "False", 05:59:37 INFO - "basedir": "/builds/slave/test", 05:59:37 INFO - "buildnumber": 316, 05:59:37 INFO - "slavename": "talos-linux64-ix-014", 05:59:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:59:37 INFO - "platform": "ubuntu64_hw", 05:59:37 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 05:59:37 INFO - "branch": "b2g-inbound", 05:59:37 INFO - "repo_path": "integration/b2g-inbound", 05:59:37 INFO - "revision": "be401039fb14fdd9679121c634eeb873be2e7f08", 05:59:37 INFO - "stage_platform": "linux64", 05:59:37 INFO - "builduid": "74fba6dbaa7543f5b0960aa455acd95b", 05:59:37 INFO - "slavebuilddir": "test" 05:59:37 INFO - } 05:59:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:59:37 INFO - Running post-action listener: _resource_record_post_action 05:59:37 INFO - ##### 05:59:37 INFO - ##### Running download-and-extract step. 05:59:37 INFO - ##### 05:59:37 INFO - Running pre-action listener: _resource_record_pre_action 05:59:37 INFO - Running main action method: download_and_extract 05:59:37 INFO - mkdir: /builds/slave/test/build/tests 05:59: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')]} 05:59:37 INFO - https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/test_packages.json 05:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/test_packages.json 05:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:59:38 INFO - Downloaded 1302 bytes. 05:59:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:59:38 INFO - Using the following test package requirements: 05:59:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'jsshell-linux-x86_64.zip'], 05:59:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:59:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:59:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:38 INFO - https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:39 INFO - Downloaded 21926968 bytes. 05:59:39 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 05:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:39 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 05:59:40 INFO - Return code: 0 05:59:40 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 05:59: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')]} 05:59:40 INFO - https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:41 INFO - Downloaded 21926968 bytes. 05:59:41 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 05:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:41 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 05:59:42 INFO - Return code: 0 05:59:42 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')]} 05:59:42 INFO - https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:43 INFO - Downloaded 11132277 bytes. 05:59:43 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 05:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:43 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 05:59:43 INFO - Return code: 0 05:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:43 INFO - https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wR8AeERQR0mO9LsGaovjLA/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 05:59:45 INFO - Downloaded 53349438 bytes. 05:59:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:45 INFO - mkdir: /builds/slave/test/properties 05:59:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:45 INFO - Contents: 05:59:45 INFO - build_url:https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:45 INFO - Running post-action listener: _resource_record_post_action 05:59:45 INFO - Running post-action listener: set_extra_try_arguments 05:59:45 INFO - ##### 05:59:45 INFO - ##### Running populate-webroot step. 05:59:45 INFO - ##### 05:59:45 INFO - Running pre-action listener: _resource_record_pre_action 05:59:45 INFO - Running main action method: populate_webroot 05:59:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:45 INFO - '--tppagecycles', 05:59:45 INFO - '7'], 05:59:45 INFO - 'tests': ['tsvgm']}}, 05:59:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:59:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'tests': ['damp', 'tps']}, 05:59:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['damp', 'tps']}, 05:59:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:59:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:45 INFO - 'other': {'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'other_l64': {'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'other_nol64': {'tests': ['a11yr', 05:59:45 INFO - 'ts_paint', 05:59:45 INFO - 'tpaint', 05:59:45 INFO - 'sessionrestore', 05:59:45 INFO - 'sessionrestore_no_auto_restore']}, 05:59:45 INFO - 'svgr': {'tests': ['tsvgx', 05:59:45 INFO - 'tsvgr_opacity', 05:59:45 INFO - 'tart', 05:59:45 INFO - 'tscrollx', 05:59:45 INFO - 'cart']}, 05:59:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['tsvgx', 05:59:45 INFO - 'tsvgr_opacity', 05:59:45 INFO - 'tart', 05:59:45 INFO - 'tscrollx', 05:59:45 INFO - 'cart']}, 05:59:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'tests': ['tp5o']}, 05:59:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'talos_options': ['--e10s'], 05:59:45 INFO - 'tests': ['tp5o']}, 05:59:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'talos_options': ['--xperf_path', 05:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:45 INFO - 'tests': ['tp5n']}, 05:59:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:45 INFO - 'talos_options': ['--e10s', 05:59:45 INFO - '--xperf_path', 05:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:45 INFO - 'tests': ['tp5n']}}, 05:59:45 INFO - 'talos.zip': {'path': '', 05:59:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:45 INFO - Running post-action listener: _resource_record_post_action 05:59:45 INFO - ##### 05:59:45 INFO - ##### Running create-virtualenv step. 05:59:45 INFO - ##### 05:59:45 INFO - Running pre-action listener: _resource_record_pre_action 05:59:45 INFO - Running main action method: create_virtualenv 05:59:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:45 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 05:59:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:45 INFO - Using real prefix '/usr' 05:59:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:47 INFO - Installing pip.................done. 05:59:47 INFO - Return code: 0 05:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59: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', 'pip>=1.5'] in /builds/slave/test/build 05:59: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 pip>=1.5 05:59:47 INFO - Using env: {'DISPLAY': ':0', 05:59:47 INFO - 'HOME': '/home/cltbld', 05:59:47 INFO - 'LANG': 'en_US.UTF-8', 05:59:47 INFO - 'LANGUAGE': 'en_US:en', 05:59:47 INFO - 'LOGNAME': 'cltbld', 05:59:47 INFO - 'MAIL': '/var/mail/cltbld', 05:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:47 INFO - 'MOZ_NO_REMOTE': '1', 05:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:47 INFO - 'NO_EM_RESTART': '1', 05:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:47 INFO - 'PWD': '/builds/slave/test', 05:59:47 INFO - 'SHELL': '/bin/bash', 05:59:47 INFO - 'SHLVL': '1', 05:59:47 INFO - 'TERM': 'linux', 05:59:47 INFO - 'TMOUT': '86400', 05:59:47 INFO - 'USER': 'cltbld', 05:59:47 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:47 INFO - '_': '/tools/buildbot/bin/python'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 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 05:59:48 INFO - Cleaning up... 05:59:48 INFO - Return code: 0 05:59:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:59:48 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')]} 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 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')]} 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59:48 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 05:59:48 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 05:59:48 INFO - Using env: {'DISPLAY': ':0', 05:59:48 INFO - 'HOME': '/home/cltbld', 05:59:48 INFO - 'LANG': 'en_US.UTF-8', 05:59:48 INFO - 'LANGUAGE': 'en_US:en', 05:59:48 INFO - 'LOGNAME': 'cltbld', 05:59:48 INFO - 'MAIL': '/var/mail/cltbld', 05:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:48 INFO - 'MOZ_NO_REMOTE': '1', 05:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:48 INFO - 'NO_EM_RESTART': '1', 05:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:48 INFO - 'PWD': '/builds/slave/test', 05:59:48 INFO - 'SHELL': '/bin/bash', 05:59:48 INFO - 'SHLVL': '1', 05:59:48 INFO - 'TERM': 'linux', 05:59:48 INFO - 'TMOUT': '86400', 05:59:48 INFO - 'USER': 'cltbld', 05:59:48 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:48 INFO - '_': '/tools/buildbot/bin/python'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 INFO - Downloading/unpacking psutil>=0.7.1 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:59:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:50 INFO - Installing collected packages: psutil 05:59:50 INFO - Running setup.py install for psutil 05:59:50 INFO - building 'psutil._psutil_linux' extension 05:59:50 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 05:59:50 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 05:59:50 INFO - building 'psutil._psutil_posix' extension 05:59:50 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 05:59:50 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 05:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:50 INFO - Successfully installed psutil 05:59:50 INFO - Cleaning up... 05:59:50 INFO - Return code: 0 05:59:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:59:50 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')]} 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:50 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')]} 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:50 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59:50 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 05:59:50 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 05:59:50 INFO - Using env: {'DISPLAY': ':0', 05:59:50 INFO - 'HOME': '/home/cltbld', 05:59:50 INFO - 'LANG': 'en_US.UTF-8', 05:59:50 INFO - 'LANGUAGE': 'en_US:en', 05:59:50 INFO - 'LOGNAME': 'cltbld', 05:59:50 INFO - 'MAIL': '/var/mail/cltbld', 05:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:50 INFO - 'MOZ_NO_REMOTE': '1', 05:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:50 INFO - 'NO_EM_RESTART': '1', 05:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:50 INFO - 'PWD': '/builds/slave/test', 05:59:50 INFO - 'SHELL': '/bin/bash', 05:59:50 INFO - 'SHLVL': '1', 05:59:50 INFO - 'TERM': 'linux', 05:59:50 INFO - 'TMOUT': '86400', 05:59:50 INFO - 'USER': 'cltbld', 05:59:50 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:50 INFO - '_': '/tools/buildbot/bin/python'} 05:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:59:50 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 05:59:50 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 05:59:50 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 05:59:50 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 05:59:50 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 05:59:50 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 05:59:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:59:52 INFO - Installing collected packages: mozsystemmonitor 05:59:52 INFO - Running setup.py install for mozsystemmonitor 05:59:52 INFO - Successfully installed mozsystemmonitor 05:59:52 INFO - Cleaning up... 05:59:52 INFO - Return code: 0 05:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59:52 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 05:59:52 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 05:59:52 INFO - Using env: {'DISPLAY': ':0', 05:59:52 INFO - 'HOME': '/home/cltbld', 05:59:52 INFO - 'LANG': 'en_US.UTF-8', 05:59:52 INFO - 'LANGUAGE': 'en_US:en', 05:59:52 INFO - 'LOGNAME': 'cltbld', 05:59:52 INFO - 'MAIL': '/var/mail/cltbld', 05:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:52 INFO - 'MOZ_NO_REMOTE': '1', 05:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:52 INFO - 'NO_EM_RESTART': '1', 05:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:52 INFO - 'PWD': '/builds/slave/test', 05:59:52 INFO - 'SHELL': '/bin/bash', 05:59:52 INFO - 'SHLVL': '1', 05:59:52 INFO - 'TERM': 'linux', 05:59:52 INFO - 'TMOUT': '86400', 05:59:52 INFO - 'USER': 'cltbld', 05:59:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:52 INFO - '_': '/tools/buildbot/bin/python'} 05:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:55 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 05:59:55 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 05:59:55 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 05:59:55 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 05:59:55 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 05:59:55 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 05:59:55 INFO - Downloading docopt-0.6.1.tar.gz 05:59:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:55 INFO - Running setup.py install for blobuploader 05:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:55 INFO - Running setup.py install for requests 05:59:55 INFO - Running setup.py install for docopt 05:59:55 INFO - Successfully installed blobuploader requests docopt 05:59:55 INFO - Cleaning up... 05:59:55 INFO - Return code: 0 05:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59:55 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 05:59:55 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 05:59:55 INFO - Using env: {'DISPLAY': ':0', 05:59:55 INFO - 'HOME': '/home/cltbld', 05:59:55 INFO - 'LANG': 'en_US.UTF-8', 05:59:55 INFO - 'LANGUAGE': 'en_US:en', 05:59:55 INFO - 'LOGNAME': 'cltbld', 05:59:55 INFO - 'MAIL': '/var/mail/cltbld', 05:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:55 INFO - 'MOZ_NO_REMOTE': '1', 05:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:55 INFO - 'NO_EM_RESTART': '1', 05:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:55 INFO - 'PWD': '/builds/slave/test', 05:59:55 INFO - 'SHELL': '/bin/bash', 05:59:55 INFO - 'SHLVL': '1', 05:59:55 INFO - 'TERM': 'linux', 05:59:55 INFO - 'TMOUT': '86400', 05:59:55 INFO - 'USER': 'cltbld', 05:59:55 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:55 INFO - '_': '/tools/buildbot/bin/python'} 05:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:56 INFO - Running setup.py (path:/tmp/pip-WtNAmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:56 INFO - Running setup.py (path:/tmp/pip-CREAES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:56 INFO - Running setup.py (path:/tmp/pip-ji3i5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:56 INFO - Running setup.py (path:/tmp/pip-A_wYyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:56 INFO - Running setup.py (path:/tmp/pip-IBFtnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:56 INFO - Running setup.py (path:/tmp/pip-E2bHJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:56 INFO - Running setup.py (path:/tmp/pip-gvBtdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:56 INFO - Running setup.py (path:/tmp/pip-9nAexS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:56 INFO - Running setup.py (path:/tmp/pip-kGcWrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:56 INFO - Running setup.py (path:/tmp/pip-eiUJbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:56 INFO - Running setup.py (path:/tmp/pip-9UFgdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:56 INFO - Running setup.py (path:/tmp/pip-P6It2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:56 INFO - Running setup.py (path:/tmp/pip-z62TbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:57 INFO - Running setup.py (path:/tmp/pip-1DveAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:57 INFO - Running setup.py (path:/tmp/pip-mqM1lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:57 INFO - Running setup.py (path:/tmp/pip-MBkdHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:57 INFO - Running setup.py (path:/tmp/pip-xxYe5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:57 INFO - Running setup.py install for manifestparser 05:59:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Running setup.py install for mozcrash 05:59:57 INFO - Running setup.py install for mozdebug 05:59:57 INFO - Running setup.py install for mozdevice 05:59:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Running setup.py install for mozfile 05:59:57 INFO - Running setup.py install for mozhttpd 05:59:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Running setup.py install for mozinfo 05:59:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for mozInstall 05:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for mozleak 05:59:58 INFO - Running setup.py install for mozlog 05:59:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for moznetwork 05:59:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for mozprocess 05:59:58 INFO - Running setup.py install for mozprofile 05:59:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for mozrunner 05:59:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:58 INFO - Running setup.py install for mozscreenshot 05:59:58 INFO - Running setup.py install for moztest 05:59:58 INFO - Running setup.py install for mozversion 05:59:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:59 INFO - Cleaning up... 05:59:59 INFO - Return code: 0 05:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 05:59:59 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 05:59:59 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 05:59:59 INFO - Using env: {'DISPLAY': ':0', 05:59:59 INFO - 'HOME': '/home/cltbld', 05:59:59 INFO - 'LANG': 'en_US.UTF-8', 05:59:59 INFO - 'LANGUAGE': 'en_US:en', 05:59:59 INFO - 'LOGNAME': 'cltbld', 05:59:59 INFO - 'MAIL': '/var/mail/cltbld', 05:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:59 INFO - 'MOZ_NO_REMOTE': '1', 05:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:59 INFO - 'NO_EM_RESTART': '1', 05:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:59 INFO - 'PWD': '/builds/slave/test', 05:59:59 INFO - 'SHELL': '/bin/bash', 05:59:59 INFO - 'SHLVL': '1', 05:59:59 INFO - 'TERM': 'linux', 05:59:59 INFO - 'TMOUT': '86400', 05:59:59 INFO - 'USER': 'cltbld', 05:59:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 05:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:59 INFO - Running setup.py (path:/tmp/pip-DSWoWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:59 INFO - Running setup.py (path:/tmp/pip-ywUr1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:59 INFO - Running setup.py (path:/tmp/pip-Xr6Bow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:59 INFO - Running setup.py (path:/tmp/pip-cqhKOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:59 INFO - Running setup.py (path:/tmp/pip-qxnV0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:59 INFO - Running setup.py (path:/tmp/pip-rgulIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:59 INFO - Running setup.py (path:/tmp/pip-3LY7U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:59 INFO - Running setup.py (path:/tmp/pip-DEhD88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:59 INFO - Running setup.py (path:/tmp/pip-W__gvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:59 INFO - Running setup.py (path:/tmp/pip-SVmu4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:00 INFO - Running setup.py (path:/tmp/pip-nBHZtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:00 INFO - Running setup.py (path:/tmp/pip-Xc_1LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:00 INFO - Running setup.py (path:/tmp/pip-AWtKTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:00 INFO - Running setup.py (path:/tmp/pip-d1rSLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:00 INFO - Running setup.py (path:/tmp/pip-vT0qJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:00 INFO - Running setup.py (path:/tmp/pip-yCC8_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:00 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)) 06:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:00 INFO - Running setup.py (path:/tmp/pip-2tEpnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:00 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)) 06:00:00 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)) 06:00:00 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)) 06:00:00 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)) 06:00:00 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)) 06:00:00 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)) 06:00:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:02 INFO - Downloading blessings-1.5.1.tar.gz 06:00:02 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 06:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:02 INFO - Installing collected packages: blessings 06:00:02 INFO - Running setup.py install for blessings 06:00:02 INFO - Successfully installed blessings 06:00:02 INFO - Cleaning up... 06:00:02 INFO - Return code: 0 06:00:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:02 INFO - Reading from file tmpfile_stdout 06:00:02 INFO - Current package versions: 06:00:02 INFO - argparse == 1.2.1 06:00:02 INFO - blessings == 1.5.1 06:00:02 INFO - blobuploader == 1.2.4 06:00:02 INFO - docopt == 0.6.1 06:00:02 INFO - manifestparser == 1.1 06:00:02 INFO - mozInstall == 1.12 06:00:02 INFO - mozcrash == 0.16 06:00:02 INFO - mozdebug == 0.1 06:00:02 INFO - mozdevice == 0.47 06:00:02 INFO - mozfile == 1.2 06:00:02 INFO - mozhttpd == 0.7 06:00:02 INFO - mozinfo == 0.9 06:00:02 INFO - mozleak == 0.1 06:00:02 INFO - mozlog == 3.1 06:00:02 INFO - moznetwork == 0.27 06:00:02 INFO - mozprocess == 0.22 06:00:02 INFO - mozprofile == 0.28 06:00:02 INFO - mozrunner == 6.11 06:00:02 INFO - mozscreenshot == 0.1 06:00:02 INFO - mozsystemmonitor == 0.0 06:00:02 INFO - moztest == 0.7 06:00:02 INFO - mozversion == 1.4 06:00:02 INFO - psutil == 3.1.1 06:00:02 INFO - requests == 1.2.3 06:00:02 INFO - wsgiref == 0.1.2 06:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 06:00:02 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 06:00:02 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 06:00:02 INFO - Using env: {'DISPLAY': ':0', 06:00:02 INFO - 'HOME': '/home/cltbld', 06:00:02 INFO - 'LANG': 'en_US.UTF-8', 06:00:02 INFO - 'LANGUAGE': 'en_US:en', 06:00:02 INFO - 'LOGNAME': 'cltbld', 06:00:02 INFO - 'MAIL': '/var/mail/cltbld', 06:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:02 INFO - 'MOZ_NO_REMOTE': '1', 06:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:02 INFO - 'NO_EM_RESTART': '1', 06:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:02 INFO - 'PWD': '/builds/slave/test', 06:00:02 INFO - 'SHELL': '/bin/bash', 06:00:02 INFO - 'SHLVL': '1', 06:00:02 INFO - 'TERM': 'linux', 06:00:02 INFO - 'TMOUT': '86400', 06:00:02 INFO - 'USER': 'cltbld', 06:00:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 06:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:02 INFO - '_': '/tools/buildbot/bin/python'} 06:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 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)) 06:00:02 INFO - Cleaning up... 06:00:02 INFO - Return code: 0 06:00:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 06:00:02 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 06:00:02 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 06:00:02 INFO - Using env: {'DISPLAY': ':0', 06:00:02 INFO - 'HOME': '/home/cltbld', 06:00:02 INFO - 'LANG': 'en_US.UTF-8', 06:00:02 INFO - 'LANGUAGE': 'en_US:en', 06:00:02 INFO - 'LOGNAME': 'cltbld', 06:00:02 INFO - 'MAIL': '/var/mail/cltbld', 06:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:02 INFO - 'MOZ_NO_REMOTE': '1', 06:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:02 INFO - 'NO_EM_RESTART': '1', 06:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:02 INFO - 'PWD': '/builds/slave/test', 06:00:02 INFO - 'SHELL': '/bin/bash', 06:00:02 INFO - 'SHLVL': '1', 06:00:02 INFO - 'TERM': 'linux', 06:00:02 INFO - 'TMOUT': '86400', 06:00:02 INFO - 'USER': 'cltbld', 06:00:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 06:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:02 INFO - '_': '/tools/buildbot/bin/python'} 06:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:03 INFO - Downloading/unpacking jsonschema 06:00:03 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 06:00:03 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 06:00:03 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 06:00:03 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 06:00:03 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 06:00:03 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 06:00:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:04 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 06:00:04 INFO - Downloading/unpacking functools32 (from jsonschema) 06:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:05 INFO - warning: no files found matching '*.txt' 06:00:05 INFO - no previously-included directories found matching 'build' 06:00:05 INFO - no previously-included directories found matching 'dist' 06:00:05 INFO - no previously-included directories found matching '.git*' 06:00:05 INFO - Installing collected packages: jsonschema, functools32 06:00:05 INFO - Running setup.py install for functools32 06:00:05 INFO - warning: no files found matching '*.txt' 06:00:05 INFO - no previously-included directories found matching 'build' 06:00:05 INFO - no previously-included directories found matching 'dist' 06:00:05 INFO - no previously-included directories found matching '.git*' 06:00:05 INFO - Successfully installed jsonschema functools32 06:00:05 INFO - Cleaning up... 06:00:05 INFO - Return code: 0 06:00:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:00:05 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')]} 06:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:05 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')]} 06:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:05 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 0x7ff10f3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', '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 06:00:05 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 06:00:05 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 06:00:05 INFO - Using env: {'DISPLAY': ':0', 06:00:05 INFO - 'HOME': '/home/cltbld', 06:00:05 INFO - 'LANG': 'en_US.UTF-8', 06:00:05 INFO - 'LANGUAGE': 'en_US:en', 06:00:05 INFO - 'LOGNAME': 'cltbld', 06:00:05 INFO - 'MAIL': '/var/mail/cltbld', 06:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:05 INFO - 'MOZ_NO_REMOTE': '1', 06:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:05 INFO - 'NO_EM_RESTART': '1', 06:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:05 INFO - 'PWD': '/builds/slave/test', 06:00:05 INFO - 'SHELL': '/bin/bash', 06:00:05 INFO - 'SHLVL': '1', 06:00:05 INFO - 'TERM': 'linux', 06:00:05 INFO - 'TMOUT': '86400', 06:00:05 INFO - 'USER': 'cltbld', 06:00:05 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 06:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:05 INFO - '_': '/tools/buildbot/bin/python'} 06:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:05 INFO - Downloading/unpacking flake8 06:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:07 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 06:00:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:07 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 06:00:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 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 06:00:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:08 INFO - no previously-included directories found matching 'docs/_build' 06:00:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:00:08 INFO - Running setup.py install for pep8 06:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:08 INFO - no previously-included directories found matching 'docs/_build' 06:00:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:00:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:00:08 INFO - Cleaning up... 06:00:08 INFO - Return code: 0 06:00:08 INFO - Running post-action listener: _resource_record_post_action 06:00:08 INFO - Running post-action listener: _start_resource_monitoring 06:00:08 INFO - Starting resource monitoring. 06:00:08 INFO - ##### 06:00:08 INFO - ##### Running install step. 06:00:08 INFO - ##### 06:00:08 INFO - Running pre-action listener: _resource_record_pre_action 06:00:08 INFO - Running main action method: install 06:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:08 INFO - Reading from file tmpfile_stdout 06:00:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:08 INFO - Reading from file tmpfile_stdout 06:00:08 INFO - Output received: 06:00:08 INFO - Usage: mozinstall [options] installer 06:00:08 INFO - Options: 06:00:08 INFO - -h, --help show this help message and exit 06:00:08 INFO - -d DEST, --destination=DEST 06:00:08 INFO - Directory to install application into. [default: 06:00:08 INFO - "/builds/slave/test"] 06:00:08 INFO - --app=APP Application being installed. [default: firefox] 06:00:08 INFO - mkdir: /builds/slave/test/build/application 06:00:08 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'] 06:00:08 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 06:00:24 INFO - Reading from file tmpfile_stdout 06:00:24 INFO - Output received: 06:00:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:00:24 INFO - Running post-action listener: _resource_record_post_action 06:00:24 INFO - ##### 06:00:24 INFO - ##### Running run-tests step. 06:00:24 INFO - ##### 06:00:24 INFO - Running pre-action listener: _resource_record_pre_action 06:00:24 INFO - Running main action method: run_tests 06:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:24 INFO - Python 2.7.3 06:00:24 INFO - Return code: 0 06:00:24 INFO - grabbing minidump binary from tooltool 06:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:24 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 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:24 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 06:00:24 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 06:00:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:24 INFO - Return code: 0 06:00:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:00:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:00:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:00:25 INFO - Return code: 0 06:00:25 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/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:00:25 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/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 06:00:25 INFO - Using env: {'DISPLAY': ':0', 06:00:25 INFO - 'HOME': '/home/cltbld', 06:00:25 INFO - 'LANG': 'en_US.UTF-8', 06:00:25 INFO - 'LANGUAGE': 'en_US:en', 06:00:25 INFO - 'LOGNAME': 'cltbld', 06:00:25 INFO - 'MAIL': '/var/mail/cltbld', 06:00:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:25 INFO - 'MOZ_NO_REMOTE': '1', 06:00:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:25 INFO - 'NO_EM_RESTART': '1', 06:00:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:25 INFO - 'PWD': '/builds/slave/test', 06:00:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:25 INFO - 'SHELL': '/bin/bash', 06:00:25 INFO - 'SHLVL': '1', 06:00:25 INFO - 'TERM': 'linux', 06:00:25 INFO - 'TMOUT': '86400', 06:00:25 INFO - 'USER': 'cltbld', 06:00:25 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450792775.195989-49025379', 06:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:25 INFO - '_': '/tools/buildbot/bin/python'} 06:00:25 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/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:00:25 INFO - mozversion application_buildid: 20151222034722 06:00:25 INFO - mozversion application_changeset: be401039fb14fdd9679121c634eeb873be2e7f08 06:00:25 INFO - mozversion application_display_name: Nightly 06:00:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:25 INFO - mozversion application_name: Firefox 06:00:25 INFO - mozversion application_remotingname: firefox 06:00:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 06:00:25 INFO - mozversion application_vendor: Mozilla 06:00:25 INFO - mozversion application_version: 46.0a1 06:00:25 INFO - mozversion platform_buildid: 20151222034722 06:00:25 INFO - mozversion platform_changeset: be401039fb14fdd9679121c634eeb873be2e7f08 06:00:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 06:00:25 INFO - mozversion platform_version: 46.0a1 06:00:25 INFO - using testdate: 1450792825 06:00:25 INFO - actual date: 1450792825 06:00:25 INFO - starting webserver on 'localhost:49371' 06:00:25 INFO - SUITE-START | Running 3 tests 06:00:25 INFO - TEST-START | dromaeo_css 06:00:25 INFO - operating with platform_type : linux_ 06:00:25 INFO - Initialising browser for dromaeo_css test... 06:00:25 INFO - TEST-INFO | started process 1334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNySG9/profile http://localhost:49371/getInfo.html) 06:00:30 INFO - PROCESS | 1334 | __metrics Screen width/height:1600/1200 06:00:30 INFO - PROCESS | 1334 | colorDepth:24 06:00:30 INFO - PROCESS | 1334 | Browser inner width/height: 1024/697 06:00:30 INFO - PROCESS | 1334 | __metrics 06:00:30 INFO - PROCESS | 1334 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:00:30 INFO - PROCESS | 1334 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:30 ERROR - PROCESS | 1334 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:00:31 INFO - TEST-INFO | 1334: exit 0 06:00:31 INFO - Browser initialized. 06:00:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:31 INFO - TEST-INFO | started process 1430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNySG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:43 INFO - PROCESS | 1430 | RSS: Main: 149884928 06:00:43 INFO - PROCESS | 1430 | 06:01:34 INFO - PROCESS | 1430 | 1450792894394 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] 06:03:46 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49371/tests/dromaeo/cssquery-ext.html) 06:03:47 INFO - PROCESS | 1430 | RSS: Main: 239435776 06:03:47 INFO - PROCESS | 1430 | 06:06:49 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-ext.html (next: http://localhost:49371/tests/dromaeo/cssquery-jquery.html) 06:06:50 INFO - PROCESS | 1430 | RSS: Main: 225972224 06:06:50 INFO - PROCESS | 1430 | 06:09:52 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49371/tests/dromaeo/cssquery-mootools.html) 06:09:53 INFO - PROCESS | 1430 | RSS: Main: 227942400 06:09:53 INFO - PROCESS | 1430 | 06:12:55 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49371/tests/dromaeo/cssquery-prototype.html) 06:12:55 INFO - PROCESS | 1430 | RSS: Main: 207929344 06:12:55 INFO - PROCESS | 1430 | 06:15:58 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49371/tests/dromaeo/cssquery-yui.html) 06:15:59 INFO - PROCESS | 1430 | RSS: Main: 214687744 06:15:59 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | Cycle 1(1): loaded http://localhost:49371/tests/dromaeo/cssquery-yui.html (next: http://localhost:49371/tests/dromaeo/cssquery-dojo.html) 06:19:01 INFO - PROCESS | 1430 | RSS: Main: 256643072 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | __start_tp_report 06:19:01 INFO - PROCESS | 1430 | _x_x_mozilla_page_load 06:19:01 INFO - PROCESS | 1430 | _x_x_mozilla_page_load_details 06:19:01 INFO - PROCESS | 1430 | |i|pagename|runs| 06:19:01 INFO - PROCESS | 1430 | |0;dojo.html;2604.296839853239;2685.4245376814483;2686.6775986881576;2697.136916186821;2701.9459610807785;4463.799129039193;4576.244919588272;4624.075184963008;4703.788329525171;4706.811727530895;4590.38029865968;4617.053504031674;4677;4677.602403795681;4686.55477729616;4254.085371645096;4327.523972363046;4339.305711086226;4358.237308471021;4393.231184542708;4110.794460276974;4315.848945286915;4344.370066340379;4404.66964977628;4427.512973572921;4156.584341565849;4242.045539753562;4243.087736136746;4262.531121576624;4265.914681706379;4313.331433627762;4324.740515569076;4325.740455572675;4339.869803905856;4366.454193225847;4310.116426132635;4320.265554855682;4331.155424692186;4332.220200363933;4360.149770794696;4387.407699960497;4429.490608580022;4477.73133611981;4492.707973981681;4531.184386810372;5027.924581131286;5046.873828154289;5049.469805670426;5066.265391518246;5066.758644132211;5083.769477520779;5088.669236499616;5092.185250359962;5114.59083273341;5120.718360490171;4438.068005718836;4526.253168227271;4538.432695913011;4540.228161212602;4705.764711764398;5016.774245158977;5121.308623335876;5140.563052140536;5156.510131537498;5162.845114646567;4943.703377797344;4944.208926571731;4953.67801092935;4954.182559877652;4990.101781679333;4857.6599638025;4981.576565991932;5037.471065538066;5038.798448062036;5040.36995375578;4832.081904438216;4869.561739443397;4883.072216278895;4968.130577148984;4983.775730092155;4919.65562410635;4965.553100220925;4968.254761785689;4996.825111121093;5017.774200161001;4216.599423054805;4257.212415703105;4258.276093064186;4281.507626622978;4296.7851607420125;3575.4636804479537;3675.3935600625596;3676.7793932364143;3691.1141326082084;3743.831527581265;4191.811368488426;4258.68059895509;4260.126674031816;4297.076128632359;4299.9570004300185;4937.1113199624415;4957.454679985199;4961.131801934647;4963.478834722375;5059.165237735732;4093.283675356801;4162.021924847659;4179.937300940488;4317.503487098961;4317.503487098961;4293.806778694966;4335;4339.045410009856;4368.868933931987;4379.9781001095425;4721.315409265706;4759.309900064541;4772.928406073981;4775.379200703886;4808.543188397097;4780.091782561302;4901.828436004723;4914.140025495595;5000.899982000413;5002.149634562206;4717.952820471752;4762.785674644719;4782.545658162469;4785.784639691292;4823.493533178966;4979.203327467588;4999.450060493416;5006.5994720423005;5011.824586139468;5024.4473107957365;4786.090642777861;4891.33966914462;4892.094962431962;5061.240813877947;5133.10170720115;4729.3378926950945;4770.0936822003705;4794.232922732346;4802.855914322576;4842.031593681349;4854.63590230727;4900.852974410774;4903.215485522299;4910.92633610489;4915.0415668944215;4613.630909527297;4744.122337367598;4748.833790817443;4804.447488538863;4827.493113223201;4795.736234507136;4833;4848.539388758062;4855.708657480563;4896.338994235733;4684.578387945101;4699.600533954515;4702.600278976325;4753.334533165291;4798.04039192156 06:19:01 INFO - PROCESS | 1430 | |1;ext.html;564.4158296163472;565.7765182752813;567.6962824888684;576.6741790888148;587.8647910980475;27429.58855617165;28027.15918522445;32005;32392;32417.351652966925;38437;39171.21657566854;39199.608003920024;39209.411858822066;39222.41166382506;6990.650467476631;8000.359971202304;8085.231902969238;8096.3118134958595;8165.183481651847;7168.032315637374;10304.433256170907;10600.363978161296;10601.522931468102;10610.257281990263;10179.694609161737;10314.12329951955;10316.071553560178;10317.277790554665;10317.793644127112;7256.129264488295;7477.476576639638;10140.391576505397;10208.89791102087;10248.948755256213;9693.273004524688;9833.704988850275;9833.704988850346;9868.111869931741;9919.454430006346;36820.63179368199;37212.62787372119;37334.626653733656;37394;37439.43840842389;2810.5784132380104;2814.535601625729;2818.7040360762235;2953.601263829377;3567.36583710859;27814.443711125663;28066.43867122646;28288.43423131526;28420.573691394646;28696.42607147866;3303.6696330367013;3317.93364132716;3332.8333583320737;3368.1747971746836;3434.0384692286198;210874;213895;213973;214551;214972;52915.206271905954;55262.17106743402;55707;55725.44274557203;55775;46427;65628.34371656318;67076.32923670701;67270;67355.66322168456;14542.709145817236;14694.412223511154;14779.778303325458;14803.703925921636;14815.555533334018;10035;10060;10061.4466204358;10064.14454771338;10117.038881306264;19054.618907622047;19448.90275548613;19511.707324390147;19533.706994395096;19556.804431955497;7392.815179620553;7723.7682869514;7733.7679869604;7770.611469426619;7832.177621349791;878.789090618247;889.4885440871525;892.6607889002267;931.2131249094505;980.1766516126488;26392;26447.206583802516;26614.201573952814;26707.73292267091;26760.866195669285;930.0745757970863;943.2972435535432;983.4246965525248;1002.7793885345212;1058.0107599394437;14009.299535023209;14169.574912752634;14229.85770142306;14241.78637320441;14273.85726142746;252756;255492;255551;255907;256749;45122.32316515255;45555.77222113935;45592.54407455883;45610.54389456129;45626.77186614112;1090.9945450272699;1128.311729844794;1153.296489141623;1157.6874243954253;1163.7032556697989;22517.32448026562;24793.876030619733;24889.37776555528;25855.741442585335;28219.43561128807;40008;40419.1916161681;40424.59575404326;40445.797771010955;40452.19095618012;189653;189948;190067;190125;190258;24533.141340053728;25047.373815654755;25063.87468062648;28071.859640701667;28392.57411138876;32419.513707294882;32578.51132232971;32667.509987349735;33349;33352.66647333593;27801;28479;28856.855715722126;29101;29182;29376.853115734284;31037.068887933397;31176.844115779277;37582.24835503329;39362.80318598389;32271.193220169684;32756.672433275362;32767.508487373187;32900.67099328976;32987.505187421724;28069.157925262276;29364.778997271147;29978;33864.15339616529;35661.82169089138;22925.65611515862;23098.653520196873;23334.416639584146;23401.648975265725;23498.647520286868 06:19:01 INFO - PROCESS | 1430 | |2;jquery.html;335.40298269081035;335.66098240776813;335.7392989325084;337.9966200337999;338.20521773831484;11823.645290641272;12227.816582751266;14887.106773593592;14926.328315225814;15614.531564053068;12031.699207519816;14251.429942802275;14370.353334099964;14571.125732456034;14687.926560367183;4678.4619768726525;4938.086454006011;5103.948960510403;5110.7700153493;5988.550858685594;3770.377887648535;3886.339322315199;5634.183043458696;5874.089516124986;5876.118582212681;5623.80316688916;5721.828345149632;5763.423657634224;5804.796832110877;5813.157092221625;5702.572307076965;5721.998650236192;5725.971370143165;5735.025045742193;5750.7412166452405;4904.092742842586;5013.674111182798;5043.672161309503;5049.368828896388;5051.974740126276;18529.166187521594;18572.721409178874;18785.530361741065;18954.52613684655;19016.714749278774;1801.5225965119255;1871.1184775445797;1890.6313268912568;1918.1560113550133;1977.6637971544872;12682.429290681941;12823.61529154127;12934.87065129346;12939.935300323532;13102.606921792361;1746.4236801855357;1751.3082332478727;1763.8677099217482;1771.2295151608962;1772.459399883035;52297.73851130758;53976.46023539793;54119.729401353135;54916.9999999996;55448.168277475466;9315.487648179414;9460.290478214161;9593.952030239805;9598.136167744797;9638.373505722106;12147.271163730204;12153;12168.148229623841;12174;12182.208156469802;7074.858502829915;7099.219085900547;7116.679749411289;7124.786256412316;7143.42852571793;6797.4901882358035;6831.726730930707;6844.555103918229;6864.656767161622;6909.1018167637885;5703.74333155009;5713.457221564028;5750.6837123958585;5756.884862302731;5776.971115144397;1562.2969663651174;1652.1335482937095;1672.180631490561;1724.6636905803498;1727.6717423689458;796.717165406284;836.8326334733077;857.7383897911197;890.2299510923134;965.2374624047064;13846.65383365424;15725.606859828367;16302.347906083862;16320.183990800413;16754.664906701797;807.6930766308765;835.8495470815311;854;857.3784006595168;861.2335021830576;7735.729249476241;9574.712758617252;9579.664711735195;9740.464274464972;9811.852822207673;427620;434260;435847;443994;444161;63571;64495;65947.34052659413;66230.33769662338;66363.66818165878;1077.7628921637227;1083.853679753239;1086.6251143355687;1097.961571345015;1101.4767985206963;14647.414103435744;14674.119552826865;14970;14996.400143994555;15043.097414155185;30900.22749431282;31603.36793264168;31680.841595791873;32028;32028.5195722069;40613;41026.79486602548;41454;41699.37450938178;41841.79079104707;8883.600237989176;8900.287976961958;9061.275097992013;9100.271978241592;9107.08929107084;16229.67540649204;16276.674466510367;16334.754978675091;16848.747268790732;16932.74600880963;13616.93191534036;13820.378082986088;13943.093698909539;14258.857411426168;14264;13413.530526431528;13634.5917418813;13866.930665346608;13982.440702372198;14234;14153.363098660378;14223.431062757787;14274.71450570962;14512.274386280855;14698.265086745407;8760.956195218983;8920;8927.732168034969;8932.598033088396;8938.4190027648;13751.106178098391;13937.930310348384;13992.650183745487;14265.786013210018;14365.569032929028 06:19:01 INFO - PROCESS | 1430 | |3;mootools.html;1366.303185375459;1401.7546929287378;1433.684589390335;1607.1401800036979;1681.7477378393244;5801.506871915887;6853.31466853315;7030.824229394261;7033.648317584113;7043.366097051265;6838.829029274259;6981.301869813016;7034.437245020386;7053.470989675782;7072.717091316341;1718.278323104293;1744.590021344983;2014.0533949043927;2063.288165582875;2096.758872729633;2055.3628375203734;2055.845811564131;2058.4853786553363;2059.8455115866295;2064.762552306489;1998.2406685459505;2009.5578972626;2060.4024832798546;2062.6390381683223;2062.8762274263518;2017.5258814178655;2035.2571311471281;2068.2347531413325;2070.3478404302673;2072.5440403111293;2058.907349169291;2085.5307555799823;2086.968695469569;2087.4468265909545;2087.6137914485867;7023.9648801756175;7110.253423390522;7114.64426778659;7115.53749006313;7123.2520585338825;4119.773412462313;4197.244495990721;4246.617804397588;4248.511421186572;4254.638355739766;2628.829126106797;2705.6753189617175;2710.7695845853127;2715.4840580289683;2720.3471166919994;829.6847198064697;836.5540332435826;850.7745447456429;852.5311078906576;864.1703964194381;9491.905080949171;9495.90504094957;9499.572519236583;9504;9526.9523652382;3845.288621605012;3861.343571592836;3923.7645741255615;3946.3291240489184;3967.2858885400906;8143.51138931666;8227.053888802744;8235.176482351717;8241.381896357798;8251.463654862415;4312.935305970413;4328.48058233014;4329.718568293051;4337.175936572041;4343.457067866517;3921.490206273166;3939.783311917815;3960.7227494075137;3969.166475040216;3971.602839716063;2941.2058744138963;2985.940281194364;3301.620313663959;3304.454764963754;3347.146477648233;1022.7238645565656;1053.5206481051102;1063.1016790811752;1065;1068.0547715271884;867.9522626255616;873.3406278259873;879.7712594725417;880.7665968518347;907.5008745190119;6645.435138013227;6707.295733947963;6715.3620406061345;6721.529492935545;6721.630310332881;993.965211217604;1009.1674368645896;1037.4138611684375;1044.1959691037857;1046.5865982936698;5273.235380869753;5297.973510132425;5298.417174110845;5303.28405665238;5310.867228319323;8202.671893124209;8312.6674933002;8393.916060839314;8466.872996905051;8572.785680358042;8393.580320983927;8472.49165050099;8473.195046470575;8474.66101355939;8519.701810436605;6383.234011918599;6622.37087476689;6728.461723062143;6730.697118629673;6761.560498567577;6201.193844800147;6521.5108866834225;6553.934460655523;6557.344265573595;6569.737210511526;7523.849523009619;7534;7640.3505702015955;7640.541567505968;7692.4230682700145;7698.461107722405;7737.419693522896;7818.140004599603;7833.686652533835;8038.638261278374;6597.934020659924;6677.198736151693;6688.699008544724;6693;6697.497687673346;5951.7024148791525;6299.464545513682;6334.809955701337;6359.745610175726;6366.681665916778;5952.345242023287;6000.129981152796;6118.694065296806;6234.6570938597;6239.7504099837315;6013.819585412444;6038.486728628116;6105.633661980295;6127.877442451215;6144.692765361625;5943.405659434195;5959.255093113361;5989.401059893976;6036.396360363929;6064.06007068905;5591.440855914376;5656.858578535405;5672.2058911751565;5688.061469857427;5690.317161940594;5572.359178694502;5594.664320140804;5609.719514024364;5619.185218143428;5635.464630860061 06:19:01 INFO - PROCESS | 1430 | |4;prototype.html;306.4285108273071;310.3900834859502;312.6966842163101;315.4227763193358;317.87285085965624;5263.078961181792;5286.524212820846;5356.250124982505;5392.975334686407;5410.675359478434;5333.35999680038;5334.546563542094;5339.679619222849;5353.5984801139875;5366.302380690515;3997.1206334606486;4084.9387259191135;4225.704200705952;4227.408162857202;4232.682548808836;4102.958970410303;4142.130152667944;4151.875443736678;4181.7490950542915;4187.036981494258;4118.9702574356415;4127.649149822269;4165.937510937339;4176.540580536139;4177.937330940038;3979.4030895365636;4065.10567675111;4075.9592404075875;4171.374293855915;4186.476690413699;3679.7608155469807;3690.815459227055;3693.0582701411236;3700.204456041964;3712.424574191005;5128.640995130342;5142.434332223453;5142.6914385137015;5153.458886816905;5158.819441319573;4807.326974223612;4808.35087263222;4819.1325561398935;4822.758862056883;4834.129856625806;5491.093969495068;5620.5503559715125;5640.74616642248;5644.153376993484;5646.802361917313;4016.5782592827622;4020.2964481215963;4028.0735430850777;4029.6373326400767;4036.9394459083137;5924.644521328691;5932.11018347247;5942.524598032147;5946.8810623787285;5947.078202878561;4119.546849846514;4149.37759336102;4149.543550209474;4155.958440415618;4159.521655009713;3970.563238043813;4075.53280818905;4090.631843134073;4205.558416366238;4218.514870789899;4699.506551812079;4731.408573928259;4735.621150307967;4740.644451666139;4745.620350371962;5681.744321505542;5686.744096515667;5689.743961521742;5694.800681976111;5707.029804933171;1421.7654087075516;1450.789635502846;1450.9056911300731;1454.6217983324411;1455.4396557325294;970.2383628851318;973.8490533967247;980.7793246519618;999.0958182844537;1000.1398797034544;4951.628627852925;4965.677230979974;4967.925481117786;4968.726720030433;4969.155243608523;5819.185314056035;5821.679807610622;5824.3302020267365;5830.533557315404;5846.298444186725;4944.332515110414;4952.925706114411;4953.801847926043;4955.727434991038;4959.454460009396;2937.500624893773;3031.7119873611973;3096.643885953099;3120.188750924776;3161.2571045804216;5473.534749546333;5527.226188333637;5574.108142697149;5591.608587398924;5599.740058486889;6075.058365953284;6085.056816193497;6088.817335479854;6089.725962331706;6089.847753806191;5576.107822748422;5585.050541407889;5587.189857470644;5592.888142237214;5597.63615365;5755.683437410982;5887.793927212699;5896.086106653475;5896.764129434946;5897.41025897424;5773.884522309446;5782.971085144547;5786.652800831964;5788.131780232999;5796.797112101056;5577.2191893135805;5577.498025177753;5581.6371935824045;5583.888322233452;5587.217789509391;3973.477382538148;4026.2350153470748;4047.655949244347;4052.878413647595;4053.452783874139;5887.587868849139;5898.9115163273445;5918.7928422505;5919.763209471573;5923.052311630291;5690.430956904276;5695.288088988877;5698.4016678249845;5699.686517241592;5705.7147142643535;5702.714864256854;5703.8859222816145;5706.543476521785;5707.143928410605;5712.857178570569;5441.591880608891;5586.329640443173;5586.944130558642;5592.636478628876;5598.468145526169;5706.201131841629;5721;5721.971390143022;5733.3406658234835;5734.913976290442;5356.705381203916;5442.619016668795;5446.754896029609;5625.071863142535;5627.831165065055 06:19:01 INFO - PROCESS | 1430 | |5;yui.html;642.309517268936;670.3330186464468;751.3313151295347;779.3375630713894;787.712484942996;10284.280100392976;10544;10545;10545.525451354688;10570.154387648989;11782.705432364173;11830.7633847323;13356.933215333935;13717.314134293296;13728.58814235572;628.7485005997614;637.7704026550462;799.1968072087558;809.8501777171213;810.3436216664492;790.1782146567563;809.4293523066253;809.821839195379;809.9838003239961;811.407672399149;837.5937670229933;849.8767678686587;850.6980022092162;851.1998721202082;851.3572252949015;652.6834485274662;656.5797889350772;821.8931538899905;850.5449584472309;850.7150104714927;621.8911690454153;622.0110025060176;622.1103821535203;622.6575383539035;622.7477871462065;11812.409379531075;12074.27554346742;12104.576339828152;12108.820412325778;12109.878901210963;10316.896831031743;10557.155427565776;10788.08301294391;11062.889371106266;11142.944285278521;8357.289630381425;8947.150020748019;9339.953300233523;9617.23062155026;9694;2918.8978385756395;3015.8190508569555;3041.847907604633;3058.3118798270434;3061.127578640077;38802.22395552101;39402.60597394018;39447.802760986015;39469.80265098685;39762;8911.643534258686;9184.81630367389;9482.810343793086;9916.157126644315;10062.899371006342;16246.431374901822;16407.42574009904;16423.91788041052;16428.1785910704;16546.83453165477;6518.706658200297;6522.543421960418;6526.738930442824;6589.110470086477;6723.058771771955;3685.7788532688123;3707.1102935295335;3712.9561110310588;3750.1374683822874;3756.9060773480883;2549.247971848309;2550.2731721459295;2559.9760095961765;2561.0652111979366;2563.5898256278906;472.17840956735034;496.52333759590476;505.5273319446329;516.7390467813805;517.2990597740084;463.88866671998477;566.8214512428572;567.2483958754667;572.4475880775072;594.9405059494103;7164.0328555645365;7437.442191835634;7444.8883266751045;7473.887891681629;7585.393168546503;431.56627589273205;478.3112318261692;525.4719007397541;545.4599946053379;570.8030729398351;3466.445368740989;3619.6199399063244;3635.1457407509215;3661.229361448148;3756.7933763642714;48320;49309.753451232515;49629;49850.750746246034;50106.49893501091;41909.58090419057;42446;44151.558484414745;44319.335209971876;44331;39162.60837391647;39520.40719389211;40027.79986100051;40086.599134008284;40195;7315.780526584211;7513.2111128330735;7674.424418168548;7717.807054823675;7830.491018083806;30279;30281.091567253017;31091.84454077715;31185.376292474477;31211.063668089995;37573.24853502969;37903.43144852885;38285.808570956964;38288.80855595704;38382.424263636625;10186.796264074825;10304.381737095799;10364.378137311785;10376.533056012346;10617;10975.231733778559;11009.119270458505;11369.886301136883;11489.827652585385;11608.825867611824;9434.905650943678;9910.950445248016;10085.69742907714;10363.481825908524;11053.392063436266;10060.446675432922;10067.69796906094;10118.08937195656;10392.324498907547;10883.292585982203;7996.1333977767035;9283.303752218475;9591.184749296388;9910.554025069034;10034.749131271778;8268.503889766633;9403.153716165578;9451.669191578261;9481.905180948379;9483.383580067273;8468.585801846295;8710.303175746052;8826.823463530565;8831.425957312755;8978.102189781232 06:19:01 INFO - PROCESS | 1430 | __end_tp_report 06:19:01 INFO - PROCESS | 1430 | __start_cc_report 06:19:01 INFO - PROCESS | 1430 | _x_x_mozilla_cycle_collect,782 06:19:01 INFO - PROCESS | 1430 | __end_cc_report 06:19:01 INFO - PROCESS | 1430 | __startTimestamp1450793941794__endTimestamp 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | ------- Summary: start ------- 06:19:01 INFO - PROCESS | 1430 | Number of tests: 6 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#0] dojo.html Cycles:165 Average:4598.83 Median:4744.12 stddev:481.70 (10.2%) stddev-sans-first:457.06 06:19:01 INFO - PROCESS | 1430 | Values: 2604.3 2685.4 2686.7 2697.1 2701.9 4463.8 4576.2 4624.1 4703.8 4706.8 4590.4 4617.1 4677.0 4677.6 4686.6 4254.1 4327.5 4339.3 4358.2 4393.2 4110.8 4315.8 4344.4 4404.7 4427.5 4156.6 4242.0 4243.1 4262.5 4265.9 4313.3 4324.7 4325.7 4339.9 4366.5 4310.1 4320.3 4331.2 4332.2 4360.1 4387.4 4429.5 4477.7 4492.7 4531.2 5027.9 5046.9 5049.5 5066.3 5066.8 5083.8 5088.7 5092.2 5114.6 5120.7 4438.1 4526.3 4538.4 4540.2 4705.8 5016.8 5121.3 5140.6 5156.5 5162.8 4943.7 4944.2 4953.7 4954.2 4990.1 4857.7 4981.6 5037.5 5038.8 5040.4 4832.1 4869.6 4883.1 4968.1 4983.8 4919.7 4965.6 4968.3 4996.8 5017.8 4216.6 4257.2 4258.3 4281.5 4296.8 3575.5 3675.4 3676.8 3691.1 3743.8 4191.8 4258.7 4260.1 4297.1 4300.0 4937.1 4957.5 4961.1 4963.5 5059.2 4093.3 4162.0 4179.9 4317.5 4317.5 4293.8 4335.0 4339.0 4368.9 4380.0 4721.3 4759.3 4772.9 4775.4 4808.5 4780.1 4901.8 4914.1 5000.9 5002.1 4718.0 4762.8 4782.5 4785.8 4823.5 4979.2 4999.5 5006.6 5011.8 5024.4 4786.1 4891.3 4892.1 5061.2 5133.1 4729.3 4770.1 4794.2 4802.9 4842.0 4854.6 4900.9 4903.2 4910.9 4915.0 4613.6 4744.1 4748.8 4804.4 4827.5 4795.7 4833.0 4848.5 4855.7 4896.3 4684.6 4699.6 4702.6 4753.3 4798.0 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#1] ext.html Cycles:180 Average:38369.17 Median:29370.82 stddev:57518.05 (195.8%) stddev-sans-first:57609.36 06:19:01 INFO - PROCESS | 1430 | Values: 564.4 565.8 567.7 576.7 587.9 27429.6 28027.2 32005.0 32392.0 32417.4 38437.0 39171.2 39199.6 39209.4 39222.4 6990.7 8000.4 8085.2 8096.3 8165.2 7168.0 10304.4 10600.4 10601.5 10610.3 10179.7 10314.1 10316.1 10317.3 10317.8 7256.1 7477.5 10140.4 10208.9 10248.9 9693.3 9833.7 9833.7 9868.1 9919.5 36820.6 37212.6 37334.6 37394.0 37439.4 2810.6 2814.5 2818.7 2953.6 3567.4 27814.4 28066.4 28288.4 28420.6 28696.4 3303.7 3317.9 3332.8 3368.2 3434.0 210874.0 213895.0 213973.0 214551.0 214972.0 52915.2 55262.2 55707.0 55725.4 55775.0 46427.0 65628.3 67076.3 67270.0 67355.7 14542.7 14694.4 14779.8 14803.7 14815.6 10035.0 10060.0 10061.4 10064.1 10117.0 19054.6 19448.9 19511.7 19533.7 19556.8 7392.8 7723.8 7733.8 7770.6 7832.2 878.8 889.5 892.7 931.2 980.2 26392.0 26447.2 26614.2 26707.7 26760.9 930.1 943.3 983.4 1002.8 1058.0 14009.3 14169.6 14229.9 14241.8 14273.9 252756.0 255492.0 255551.0 255907.0 256749.0 45122.3 45555.8 45592.5 45610.5 45626.8 1091.0 1128.3 1153.3 1157.7 1163.7 22517.3 24793.9 24889.4 25855.7 28219.4 40008.0 40419.2 40424.6 40445.8 40452.2 189653.0 189948.0 190067.0 190125.0 190258.0 24533.1 25047.4 25063.9 28071.9 28392.6 32419.5 32578.5 32667.5 33349.0 33352.7 27801.0 28479.0 28856.9 29101.0 29182.0 29376.9 31037.1 31176.8 37582.2 39362.8 32271.2 32756.7 32767.5 32900.7 32987.5 28069.2 29364.8 29978.0 33864.2 35661.8 22925.7 23098.7 23334.4 23401.6 23498.6 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#2] jquery.html Cycles:180 Average:24897.05 Median:3828.36 stddev:71296.45 (1862.3%) stddev-sans-first:71472.60 06:19:01 INFO - PROCESS | 1430 | Values: 335.4 335.7 335.7 338.0 338.2 11823.6 12227.8 14887.1 14926.3 15614.5 12031.7 14251.4 14370.4 14571.1 14687.9 4678.5 4938.1 5103.9 5110.8 5988.6 3770.4 3886.3 5634.2 5874.1 5876.1 5623.8 5721.8 5763.4 5804.8 5813.2 5702.6 5722.0 5726.0 5735.0 5750.7 4904.1 5013.7 5043.7 5049.4 5052.0 18529.2 18572.7 18785.5 18954.5 19016.7 1801.5 1871.1 1890.6 1918.2 1977.7 12682.4 12823.6 12934.9 12939.9 13102.6 1746.4 1751.3 1763.9 1771.2 1772.5 52297.7 53976.5 54119.7 54917.0 55448.2 9315.5 9460.3 9594.0 9598.1 9638.4 12147.3 12153.0 12168.1 12174.0 12182.2 7074.9 7099.2 7116.7 7124.8 7143.4 6797.5 6831.7 6844.6 6864.7 6909.1 5703.7 5713.5 5750.7 5756.9 5777.0 1562.3 1652.1 1672.2 1724.7 1727.7 796.7 836.8 857.7 890.2 965.2 13846.7 15725.6 16302.3 16320.2 16754.7 807.7 835.8 854.0 857.4 861.2 7735.7 9574.7 9579.7 9740.5 9811.9 427620.0 434260.0 435847.0 443994.0 444161.0 63571.0 64495.0 65947.3 66230.3 66363.7 1077.8 1083.9 1086.6 1098.0 1101.5 14647.4 14674.1 14970.0 14996.4 15043.1 30900.2 31603.4 31680.8 32028.0 32028.5 40613.0 41026.8 41454.0 41699.4 41841.8 8883.6 8900.3 9061.3 9100.3 9107.1 16229.7 16276.7 16334.8 16848.7 16932.7 13616.9 13820.4 13943.1 14258.9 14264.0 13413.5 13634.6 13866.9 13982.4 14234.0 14153.4 14223.4 14274.7 14512.3 14698.3 8761.0 8920.0 8927.7 8932.6 8938.4 13751.1 13937.9 13992.7 14265.8 14365.6 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#3] mootools.html Cycles:180 Average:4892.21 Median:6006.97 stddev:2538.97 (42.3%) stddev-sans-first:2532.26 06:19:01 INFO - PROCESS | 1430 | Values: 1366.3 1401.8 1433.7 1607.1 1681.7 5801.5 6853.3 7030.8 7033.6 7043.4 6838.8 6981.3 7034.4 7053.5 7072.7 1718.3 1744.6 2014.1 2063.3 2096.8 2055.4 2055.8 2058.5 2059.8 2064.8 1998.2 2009.6 2060.4 2062.6 2062.9 2017.5 2035.3 2068.2 2070.3 2072.5 2058.9 2085.5 2087.0 2087.4 2087.6 7024.0 7110.3 7114.6 7115.5 7123.3 4119.8 4197.2 4246.6 4248.5 4254.6 2628.8 2705.7 2710.8 2715.5 2720.3 829.7 836.6 850.8 852.5 864.2 9491.9 9495.9 9499.6 9504.0 9527.0 3845.3 3861.3 3923.8 3946.3 3967.3 8143.5 8227.1 8235.2 8241.4 8251.5 4312.9 4328.5 4329.7 4337.2 4343.5 3921.5 3939.8 3960.7 3969.2 3971.6 2941.2 2985.9 3301.6 3304.5 3347.1 1022.7 1053.5 1063.1 1065.0 1068.1 868.0 873.3 879.8 880.8 907.5 6645.4 6707.3 6715.4 6721.5 6721.6 994.0 1009.2 1037.4 1044.2 1046.6 5273.2 5298.0 5298.4 5303.3 5310.9 8202.7 8312.7 8393.9 8466.9 8572.8 8393.6 8472.5 8473.2 8474.7 8519.7 6383.2 6622.4 6728.5 6730.7 6761.6 6201.2 6521.5 6553.9 6557.3 6569.7 7523.8 7534.0 7640.4 7640.5 7692.4 7698.5 7737.4 7818.1 7833.7 8038.6 6597.9 6677.2 6688.7 6693.0 6697.5 5951.7 6299.5 6334.8 6359.7 6366.7 5952.3 6000.1 6118.7 6234.7 6239.8 6013.8 6038.5 6105.6 6127.9 6144.7 5943.4 5959.3 5989.4 6036.4 6064.1 5591.4 5656.9 5672.2 5688.1 5690.3 5572.4 5594.7 5609.7 5619.2 5635.5 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#4] prototype.html Cycles:180 Average:4702.97 Median:5346.64 stddev:1384.56 (25.9%) stddev-sans-first:1348.54 06:19:01 INFO - PROCESS | 1430 | Values: 306.4 310.4 312.7 315.4 317.9 5263.1 5286.5 5356.3 5393.0 5410.7 5333.4 5334.5 5339.7 5353.6 5366.3 3997.1 4084.9 4225.7 4227.4 4232.7 4103.0 4142.1 4151.9 4181.7 4187.0 4119.0 4127.6 4165.9 4176.5 4177.9 3979.4 4065.1 4076.0 4171.4 4186.5 3679.8 3690.8 3693.1 3700.2 3712.4 5128.6 5142.4 5142.7 5153.5 5158.8 4807.3 4808.4 4819.1 4822.8 4834.1 5491.1 5620.6 5640.7 5644.2 5646.8 4016.6 4020.3 4028.1 4029.6 4036.9 5924.6 5932.1 5942.5 5946.9 5947.1 4119.5 4149.4 4149.5 4156.0 4159.5 3970.6 4075.5 4090.6 4205.6 4218.5 4699.5 4731.4 4735.6 4740.6 4745.6 5681.7 5686.7 5689.7 5694.8 5707.0 1421.8 1450.8 1450.9 1454.6 1455.4 970.2 973.8 980.8 999.1 1000.1 4951.6 4965.7 4967.9 4968.7 4969.2 5819.2 5821.7 5824.3 5830.5 5846.3 4944.3 4952.9 4953.8 4955.7 4959.5 2937.5 3031.7 3096.6 3120.2 3161.3 5473.5 5527.2 5574.1 5591.6 5599.7 6075.1 6085.1 6088.8 6089.7 6089.8 5576.1 5585.1 5587.2 5592.9 5597.6 5755.7 5887.8 5896.1 5896.8 5897.4 5773.9 5783.0 5786.7 5788.1 5796.8 5577.2 5577.5 5581.6 5583.9 5587.2 3973.5 4026.2 4047.7 4052.9 4053.5 5887.6 5898.9 5918.8 5919.8 5923.1 5690.4 5695.3 5698.4 5699.7 5705.7 5702.7 5703.9 5706.5 5707.1 5712.9 5441.6 5586.3 5586.9 5592.6 5598.5 5706.2 5721.0 5722.0 5733.3 5734.9 5356.7 5442.6 5446.8 5625.1 5627.8 06:19:01 INFO - PROCESS | 1430 | 06:19:01 INFO - PROCESS | 1430 | [#5] yui.html Cycles:180 Average:12009.45 Median:22397.44 stddev:13532.96 (60.4%) stddev-sans-first:13544.00 06:19:01 INFO - PROCESS | 1430 | Values: 642.3 670.3 751.3 779.3 787.7 10284.3 10544.0 10545.0 10545.5 10570.2 11782.7 11830.8 13356.9 13717.3 13728.6 628.7 637.8 799.2 809.9 810.3 790.2 809.4 809.8 810.0 811.4 837.6 849.9 850.7 851.2 851.4 652.7 656.6 821.9 850.5 850.7 621.9 622.0 622.1 622.7 622.7 11812.4 12074.3 12104.6 12108.8 12109.9 10316.9 10557.2 10788.1 11062.9 11142.9 8357.3 8947.2 9340.0 9617.2 9694.0 2918.9 3015.8 3041.8 3058.3 3061.1 38802.2 39402.6 39447.8 39469.8 39762.0 8911.6 9184.8 9482.8 9916.2 10062.9 16246.4 16407.4 16423.9 16428.2 16546.8 6518.7 6522.5 6526.7 6589.1 6723.1 3685.8 3707.1 3713.0 3750.1 3756.9 2549.2 2550.3 2560.0 2561.1 2563.6 472.2 496.5 505.5 516.7 517.3 463.9 566.8 567.2 572.4 594.9 7164.0 7437.4 7444.9 7473.9 7585.4 431.6 478.3 525.5 545.5 570.8 3466.4 3619.6 3635.1 3661.2 3756.8 48320.0 49309.8 49629.0 49850.8 50106.5 41909.6 42446.0 44151.6 44319.3 44331.0 39162.6 39520.4 40027.8 40086.6 40195.0 7315.8 7513.2 7674.4 7717.8 7830.5 30279.0 30281.1 31091.8 31185.4 31211.1 37573.2 37903.4 38285.8 38288.8 38382.4 10186.8 10304.4 10364.4 10376.5 10617.0 10975.2 11009.1 11369.9 11489.8 11608.8 9434.9 9911.0 10085.7 10363.5 11053.4 10060.4 10067.7 10118.1 10392.3 10883.3 7996.1 9283.3 9591.2 9910.6 10034.7 8268.5 9403.2 9451.7 9481.9 9483.4 8468.6 8710.3 8826.8 8831.4 8978.1 06:19:01 INFO - PROCESS | 1430 | -------- Summary: end -------- 06:19:01 INFO - PROCESS | 1430 | 06:19:02 INFO - TEST-INFO | 1430: exit 0 06:19:02 INFO - TEST-OK | dromaeo_css | took 1117144ms 06:19:02 INFO - TEST-START | kraken 06:19:02 INFO - operating with platform_type : linux_ 06:19:02 INFO - Initialising browser for kraken test... 06:19:02 INFO - TEST-INFO | started process 1624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCwbFs/profile http://localhost:49371/getInfo.html) 06:19:07 INFO - PROCESS | 1624 | __metrics Screen width/height:1600/1200 06:19:07 INFO - PROCESS | 1624 | colorDepth:24 06:19:07 INFO - PROCESS | 1624 | Browser inner width/height: 1024/697 06:19:07 INFO - PROCESS | 1624 | __metrics 06:19:07 INFO - PROCESS | 1624 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:19:07 INFO - PROCESS | 1624 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:07 ERROR - PROCESS | 1624 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:19:08 INFO - TEST-INFO | 1624: exit 0 06:19:08 INFO - Browser initialized. 06:19:08 INFO - Running cycle 1/1 for kraken test... 06:19:08 INFO - TEST-INFO | started process 1709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCwbFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:20 INFO - PROCESS | 1709 | RSS: Main: 150110208 06:19:20 INFO - PROCESS | 1709 | 06:19:22 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49371/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:23 INFO - PROCESS | 1709 | RSS: Main: 185491456 06:19:23 INFO - PROCESS | 1709 | 06:19:26 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49371/tests/kraken/driver.html?testName=audio-dft) 06:19:26 INFO - PROCESS | 1709 | RSS: Main: 174919680 06:19:26 INFO - PROCESS | 1709 | 06:19:29 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49371/tests/kraken/driver.html?testName=audio-fft) 06:19:30 INFO - PROCESS | 1709 | RSS: Main: 161898496 06:19:30 INFO - PROCESS | 1709 | 06:19:32 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49371/tests/kraken/driver.html?testName=audio-oscillator) 06:19:32 INFO - PROCESS | 1709 | RSS: Main: 163491840 06:19:32 INFO - PROCESS | 1709 | 06:19:35 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:35 INFO - PROCESS | 1709 | RSS: Main: 164511744 06:19:35 INFO - PROCESS | 1709 | 06:19:38 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49371/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:39 INFO - PROCESS | 1709 | RSS: Main: 165412864 06:19:39 INFO - PROCESS | 1709 | 06:19:42 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49371/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:43 INFO - PROCESS | 1709 | RSS: Main: 166670336 06:19:43 INFO - PROCESS | 1709 | 06:19:46 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49371/tests/kraken/driver.html?testName=json-parse-financial) 06:19:46 INFO - PROCESS | 1709 | RSS: Main: 165089280 06:19:46 INFO - PROCESS | 1709 | 06:19:48 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:48 INFO - PROCESS | 1709 | RSS: Main: 174600192 06:19:48 INFO - PROCESS | 1709 | 06:19:50 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:51 INFO - PROCESS | 1709 | RSS: Main: 173858816 06:19:51 INFO - PROCESS | 1709 | 06:19:53 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:54 INFO - PROCESS | 1709 | RSS: Main: 187101184 06:19:54 INFO - PROCESS | 1709 | 06:19:56 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:57 INFO - PROCESS | 1709 | RSS: Main: 191115264 06:19:57 INFO - PROCESS | 1709 | 06:19:59 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:00 INFO - PROCESS | 1709 | RSS: Main: 188628992 06:20:00 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | Cycle 1(1): loaded http://localhost:49371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49371/tests/kraken/driver.html?testName=ai-astar) 06:20:02 INFO - PROCESS | 1709 | RSS: Main: 245800960 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | __start_tp_report 06:20:02 INFO - PROCESS | 1709 | _x_x_mozilla_page_load 06:20:02 INFO - PROCESS | 1709 | _x_x_mozilla_page_load_details 06:20:02 INFO - PROCESS | 1709 | |i|pagename|runs| 06:20:02 INFO - PROCESS | 1709 | |0;ai-astar;112;116;108;113;114;113;104;111;113;103 06:20:02 INFO - PROCESS | 1709 | |1;audio-beat-detection;156;130;157;162;135;154;162;134;175;131 06:20:02 INFO - PROCESS | 1709 | |2;audio-dft;159;162;161;161;163;160;162;161;161;161 06:20:02 INFO - PROCESS | 1709 | |3;audio-fft;72;74;84;92;75;72;72;102;90;72 06:20:02 INFO - PROCESS | 1709 | |4;audio-oscillator;96;96;137;95;94;96;132;95;97;132 06:20:02 INFO - PROCESS | 1709 | |5;imaging-gaussian-blur;109;109;109;110;110;110;110;110;110;110 06:20:02 INFO - PROCESS | 1709 | |6;imaging-darkroom;147;147;147;146;147;148;148;146;146;146 06:20:02 INFO - PROCESS | 1709 | |7;imaging-desaturate;96;95;95;96;95;96;96;95;95;95 06:20:02 INFO - PROCESS | 1709 | |8;json-parse-financial;71;70;71;70;71;73;70;80;67;67 06:20:02 INFO - PROCESS | 1709 | |9;json-stringify-tinderbox;67;69;68;68;68;68;68;68;68;68 06:20:02 INFO - PROCESS | 1709 | |10;stanford-crypto-aes;82;86;84;92;83;85;85;84;86;84 06:20:02 INFO - PROCESS | 1709 | |11;stanford-crypto-ccm;120;120;120;127;120;121;125;119;118;127 06:20:02 INFO - PROCESS | 1709 | |12;stanford-crypto-pbkdf2;139;138;161;148;150;136;148;148;147;134 06:20:02 INFO - PROCESS | 1709 | |13;stanford-crypto-sha256-iterative;70;69;72;69;71;70;69;69;70;68 06:20:02 INFO - PROCESS | 1709 | __end_tp_report 06:20:02 INFO - PROCESS | 1709 | __start_cc_report 06:20:02 INFO - PROCESS | 1709 | _x_x_mozilla_cycle_collect,981 06:20:02 INFO - PROCESS | 1709 | __end_cc_report 06:20:02 INFO - PROCESS | 1709 | __startTimestamp1450794002323__endTimestamp 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | ------- Summary: start ------- 06:20:02 INFO - PROCESS | 1709 | Number of tests: 14 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:4.32 (3.8%) stddev-sans-first:4.56 06:20:02 INFO - PROCESS | 1709 | Values: 112.0 116.0 108.0 113.0 114.0 113.0 104.0 111.0 113.0 103.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.50 stddev:15.83 (10.1%) stddev-sans-first:16.62 06:20:02 INFO - PROCESS | 1709 | Values: 156.0 130.0 157.0 162.0 135.0 154.0 162.0 134.0 175.0 131.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 06:20:02 INFO - PROCESS | 1709 | Values: 159.0 162.0 161.0 161.0 163.0 160.0 162.0 161.0 161.0 161.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:10.84 (14.6%) stddev-sans-first:11.06 06:20:02 INFO - PROCESS | 1709 | Values: 72.0 74.0 84.0 92.0 75.0 72.0 72.0 102.0 90.0 72.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:95.50 stddev:18.47 (19.3%) stddev-sans-first:19.16 06:20:02 INFO - PROCESS | 1709 | Values: 96.0 96.0 137.0 95.0 94.0 96.0 132.0 95.0 97.0 132.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:20:02 INFO - PROCESS | 1709 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:20:02 INFO - PROCESS | 1709 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 148.0 146.0 146.0 146.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:20:02 INFO - PROCESS | 1709 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:3.65 (5.1%) stddev-sans-first:3.87 06:20:02 INFO - PROCESS | 1709 | Values: 71.0 70.0 71.0 70.0 71.0 73.0 70.0 80.0 67.0 67.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 06:20:02 INFO - PROCESS | 1709 | Values: 67.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.73 (3.2%) stddev-sans-first:2.65 06:20:02 INFO - PROCESS | 1709 | Values: 82.0 86.0 84.0 92.0 83.0 85.0 85.0 84.0 86.0 84.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:120.50 stddev:3.33 (2.8%) stddev-sans-first:3.48 06:20:02 INFO - PROCESS | 1709 | Values: 120.0 120.0 120.0 127.0 120.0 121.0 125.0 119.0 118.0 127.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:148.00 stddev:8.16 (5.5%) stddev-sans-first:8.37 06:20:02 INFO - PROCESS | 1709 | Values: 139.0 138.0 161.0 148.0 150.0 136.0 148.0 148.0 147.0 134.0 06:20:02 INFO - PROCESS | 1709 | 06:20:02 INFO - PROCESS | 1709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 06:20:02 INFO - PROCESS | 1709 | Values: 70.0 69.0 72.0 69.0 71.0 70.0 69.0 69.0 70.0 68.0 06:20:02 INFO - PROCESS | 1709 | -------- Summary: end -------- 06:20:02 INFO - PROCESS | 1709 | 06:20:03 INFO - TEST-INFO | 1709: exit 0 06:20:03 INFO - TEST-OK | kraken | took 60666ms 06:20:03 INFO - TEST-START | v8_7 06:20:03 INFO - operating with platform_type : linux_ 06:20:03 INFO - Initialising browser for v8_7 test... 06:20:03 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4gZup/profile http://localhost:49371/getInfo.html) 06:20:07 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 06:20:07 INFO - PROCESS | 1957 | colorDepth:24 06:20:07 INFO - PROCESS | 1957 | Browser inner width/height: 1024/697 06:20:07 INFO - PROCESS | 1957 | __metrics 06:20:08 INFO - PROCESS | 1957 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:20:08 INFO - PROCESS | 1957 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:08 ERROR - PROCESS | 1957 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:20:09 INFO - TEST-INFO | 1957: exit 0 06:20:09 INFO - Browser initialized. 06:20:09 INFO - Running cycle 1/1 for v8_7 test... 06:20:09 INFO - TEST-INFO | started process 2036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4gZup/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:21 INFO - PROCESS | 2036 | RSS: Main: 149037056 06:20:21 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49371/tests/v8_7/run.html (next: http://localhost:49371/tests/v8_7/run.html) 06:20:42 INFO - PROCESS | 2036 | RSS: Main: 453046272 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | __start_tp_report 06:20:42 INFO - PROCESS | 2036 | _x_x_mozilla_page_load 06:20:42 INFO - PROCESS | 2036 | _x_x_mozilla_page_load_details 06:20:42 INFO - PROCESS | 2036 | |i|pagename|runs| 06:20:42 INFO - PROCESS | 2036 | |0;Richards;170.15484090522375 06:20:42 INFO - PROCESS | 2036 | |1;DeltaBlue;186.46280067126608 06:20:42 INFO - PROCESS | 2036 | |2;Encrypt;277.9321845469705 06:20:42 INFO - PROCESS | 2036 | |3;Decrypt;5181.347150259067 06:20:42 INFO - PROCESS | 2036 | |4;RayTrace;1968.5039370078741 06:20:42 INFO - PROCESS | 2036 | |5;Earley;813.6696501220505 06:20:42 INFO - PROCESS | 2036 | |6;Boyer;11800 06:20:42 INFO - PROCESS | 2036 | |7;RegExp;27351.35135135135 06:20:42 INFO - PROCESS | 2036 | |8;Splay;615.8574062692071 06:20:42 INFO - PROCESS | 2036 | |9;NavierStokes;4826.923076923077 06:20:42 INFO - PROCESS | 2036 | __end_tp_report 06:20:42 INFO - PROCESS | 2036 | __startTimestamp1450794042760__endTimestamp 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | ------- Summary: start ------- 06:20:42 INFO - PROCESS | 2036 | Number of tests: 10 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#0] Richards Cycles:1 Average:170.15 Median:170.15 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 170.2 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#1] DeltaBlue Cycles:1 Average:186.46 Median:186.46 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 186.5 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 277.9 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 5181.3 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 1968.5 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#5] Earley Cycles:1 Average:813.67 Median:813.67 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 813.7 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#6] Boyer Cycles:1 Average:11800.00 Median:11800.00 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 11800.0 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#7] RegExp Cycles:1 Average:27351.35 Median:27351.35 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 27351.4 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#8] Splay Cycles:1 Average:615.86 Median:615.86 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 615.9 06:20:42 INFO - PROCESS | 2036 | 06:20:42 INFO - PROCESS | 2036 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 06:20:42 INFO - PROCESS | 2036 | Values: 4826.9 06:20:42 INFO - PROCESS | 2036 | -------- Summary: end -------- 06:20:42 INFO - PROCESS | 2036 | 06:20:43 INFO - TEST-INFO | 2036: exit 0 06:20:43 INFO - TEST-OK | v8_7 | took 40403ms 06:20:43 INFO - SUITE-END | took 1218s 06:20:43 INFO - Completed test suite (00:20:18) 06:20:43 INFO - Working with test: dromaeo_css 06:20:43 INFO - Generating results file: dromaeo_css 06:20:43 INFO - Working with test: kraken 06:20:43 INFO - Generating results file: kraken 06:20:43 INFO - javascript benchmark 06:20:43 INFO - Working with test: v8_7 06:20:43 INFO - Generating results file: v8_7 06:20:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 06:20:43 INFO - process_Request line: dromaeo_css 6294.44 graph.html#tests=[[72,203,35]] 06:20:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:44 INFO - process_Request line: kraken 1521.20 graph.html#tests=[[232,203,35]] 06:20:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:44 INFO - process_Request line: v8_7 19714.64 graph.html#tests=[[230,203,35]] 06:20:44 INFO - RETURN: dromaeo_css: 6294.44 06:20:44 INFO - RETURN: kraken: 1521.20 06:20:44 INFO - RETURN: v8_7: 19714.64 06:20:44 INFO - javascript benchmark 06:20:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.296839853239, 2685.4245376814483, 2686.6775986881576, 2697.136916186821, 2701.9459610807785, 4463.799129039193, 4576.244919588272, 4624.075184963008, 4703.788329525171, 4706.811727530895, 4590.38029865968, 4617.053504031674, 4677.0, 4677.602403795681, 4686.55477729616, 4254.085371645096, 4327.523972363046, 4339.305711086226, 4358.237308471021, 4393.231184542708, 4110.794460276974, 4315.848945286915, 4344.370066340379, 4404.66964977628, 4427.512973572921, 4156.584341565849, 4242.045539753562, 4243.087736136746, 4262.531121576624, 4265.914681706379, 4313.331433627762, 4324.740515569076, 4325.740455572675, 4339.869803905856, 4366.454193225847, 4310.116426132635, 4320.265554855682, 4331.155424692186, 4332.220200363933, 4360.149770794696, 4387.407699960497, 4429.490608580022, 4477.73133611981, 4492.707973981681, 4531.184386810372, 5027.924581131286, 5046.873828154289, 5049.469805670426, 5066.265391518246, 5066.758644132211, 5083.769477520779, 5088.669236499616, 5092.185250359962, 5114.59083273341, 5120.718360490171, 4438.068005718836, 4526.253168227271, 4538.432695913011, 4540.228161212602, 4705.764711764398, 5016.774245158977, 5121.308623335876, 5140.563052140536, 5156.510131537498, 5162.845114646567, 4943.703377797344, 4944.208926571731, 4953.67801092935, 4954.182559877652, 4990.101781679333, 4857.6599638025, 4981.576565991932, 5037.471065538066, 5038.798448062036, 5040.36995375578, 4832.081904438216, 4869.561739443397, 4883.072216278895, 4968.130577148984, 4983.775730092155, 4919.65562410635, 4965.553100220925, 4968.254761785689, 4996.825111121093, 5017.774200161001, 4216.599423054805, 4257.212415703105, 4258.276093064186, 4281.507626622978, 4296.7851607420125, 3575.4636804479537, 3675.3935600625596, 3676.7793932364143, 3691.1141326082084, 3743.831527581265, 4191.811368488426, 4258.68059895509, 4260.126674031816, 4297.076128632359, 4299.9570004300185, 4937.1113199624415, 4957.454679985199, 4961.131801934647, 4963.478834722375, 5059.165237735732, 4093.283675356801, 4162.021924847659, 4179.937300940488, 4317.503487098961, 4317.503487098961, 4293.806778694966, 4335.0, 4339.045410009856, 4368.868933931987, 4379.9781001095425, 4721.315409265706, 4759.309900064541, 4772.928406073981, 4775.379200703886, 4808.543188397097, 4780.091782561302, 4901.828436004723, 4914.140025495595, 5000.899982000413, 5002.149634562206, 4717.952820471752, 4762.785674644719, 4782.545658162469, 4785.784639691292, 4823.493533178966, 4979.203327467588, 4999.450060493416, 5006.5994720423005, 5011.824586139468, 5024.4473107957365, 4786.090642777861, 4891.33966914462, 4892.094962431962, 5061.240813877947, 5133.10170720115, 4729.3378926950945, 4770.0936822003705, 4794.232922732346, 4802.855914322576, 4842.031593681349, 4854.63590230727, 4900.852974410774, 4903.215485522299, 4910.92633610489, 4915.0415668944215, 4613.630909527297, 4744.122337367598, 4748.833790817443, 4804.447488538863, 4827.493113223201, 4795.736234507136, 4833.0, 4848.539388758062, 4855.708657480563, 4896.338994235733, 4684.578387945101, 4699.600533954515, 4702.600278976325, 4753.334533165291, 4798.04039192156], "unit": "score", "name": "dojo.html", "value": 4568.952924185918}, {"lowerIsBetter": false, "replicates": [564.4158296163472, 565.7765182752813, 567.6962824888684, 576.6741790888148, 587.8647910980475, 27429.58855617165, 28027.15918522445, 32005.0, 32392.0, 32417.351652966925, 38437.0, 39171.21657566854, 39199.608003920024, 39209.411858822066, 39222.41166382506, 6990.650467476631, 8000.359971202304, 8085.231902969238, 8096.3118134958595, 8165.183481651847, 7168.032315637374, 10304.433256170907, 10600.363978161296, 10601.522931468102, 10610.257281990263, 10179.694609161737, 10314.12329951955, 10316.071553560178, 10317.277790554665, 10317.793644127112, 7256.129264488295, 7477.476576639638, 10140.391576505397, 10208.89791102087, 10248.948755256213, 9693.273004524688, 9833.704988850275, 9833.704988850346, 9868.111869931741, 9919.454430006346, 36820.63179368199, 37212.62787372119, 37334.626653733656, 37394.0, 37439.43840842389, 2810.5784132380104, 2814.535601625729, 2818.7040360762235, 2953.601263829377, 3567.36583710859, 27814.443711125663, 28066.43867122646, 28288.43423131526, 28420.573691394646, 28696.42607147866, 3303.6696330367013, 3317.93364132716, 3332.8333583320737, 3368.1747971746836, 3434.0384692286198, 210874.0, 213895.0, 213973.0, 214551.0, 214972.0, 52915.206271905954, 55262.17106743402, 55707.0, 55725.44274557203, 55775.0, 46427.0, 65628.34371656318, 67076.32923670701, 67270.0, 67355.66322168456, 14542.709145817236, 14694.412223511154, 14779.778303325458, 14803.703925921636, 14815.555533334018, 10035.0, 10060.0, 10061.4466204358, 10064.14454771338, 10117.038881306264, 19054.618907622047, 19448.90275548613, 19511.707324390147, 19533.706994395096, 19556.804431955497, 7392.815179620553, 7723.7682869514, 7733.7679869604, 7770.611469426619, 7832.177621349791, 878.789090618247, 889.4885440871525, 892.6607889002267, 931.2131249094505, 980.1766516126488, 26392.0, 26447.206583802516, 26614.201573952814, 26707.73292267091, 26760.866195669285, 930.0745757970863, 943.2972435535432, 983.4246965525248, 1002.7793885345212, 1058.0107599394437, 14009.299535023209, 14169.574912752634, 14229.85770142306, 14241.78637320441, 14273.85726142746, 252756.0, 255492.0, 255551.0, 255907.0, 256749.0, 45122.32316515255, 45555.77222113935, 45592.54407455883, 45610.54389456129, 45626.77186614112, 1090.9945450272699, 1128.311729844794, 1153.296489141623, 1157.6874243954253, 1163.7032556697989, 22517.32448026562, 24793.876030619733, 24889.37776555528, 25855.741442585335, 28219.43561128807, 40008.0, 40419.1916161681, 40424.59575404326, 40445.797771010955, 40452.19095618012, 189653.0, 189948.0, 190067.0, 190125.0, 190258.0, 24533.141340053728, 25047.373815654755, 25063.87468062648, 28071.859640701667, 28392.57411138876, 32419.513707294882, 32578.51132232971, 32667.509987349735, 33349.0, 33352.66647333593, 27801.0, 28479.0, 28856.855715722126, 29101.0, 29182.0, 29376.853115734284, 31037.068887933397, 31176.844115779277, 37582.24835503329, 39362.80318598389, 32271.193220169684, 32756.672433275362, 32767.508487373187, 32900.67099328976, 32987.505187421724, 28069.157925262276, 29364.778997271147, 29978.0, 33864.15339616529, 35661.82169089138, 22925.65611515862, 23098.653520196873, 23334.416639584146, 23401.648975265725, 23498.647520286868], "unit": "score", "name": "ext.html", "value": 16854.77481744297}, {"lowerIsBetter": false, "replicates": [335.40298269081035, 335.66098240776813, 335.7392989325084, 337.9966200337999, 338.20521773831484, 11823.645290641272, 12227.816582751266, 14887.106773593592, 14926.328315225814, 15614.531564053068, 12031.699207519816, 14251.429942802275, 14370.353334099964, 14571.125732456034, 14687.926560367183, 4678.4619768726525, 4938.086454006011, 5103.948960510403, 5110.7700153493, 5988.550858685594, 3770.377887648535, 3886.339322315199, 5634.183043458696, 5874.089516124986, 5876.118582212681, 5623.80316688916, 5721.828345149632, 5763.423657634224, 5804.796832110877, 5813.157092221625, 5702.572307076965, 5721.998650236192, 5725.971370143165, 5735.025045742193, 5750.7412166452405, 4904.092742842586, 5013.674111182798, 5043.672161309503, 5049.368828896388, 5051.974740126276, 18529.166187521594, 18572.721409178874, 18785.530361741065, 18954.52613684655, 19016.714749278774, 1801.5225965119255, 1871.1184775445797, 1890.6313268912568, 1918.1560113550133, 1977.6637971544872, 12682.429290681941, 12823.61529154127, 12934.87065129346, 12939.935300323532, 13102.606921792361, 1746.4236801855357, 1751.3082332478727, 1763.8677099217482, 1771.2295151608962, 1772.459399883035, 52297.73851130758, 53976.46023539793, 54119.729401353135, 54916.9999999996, 55448.168277475466, 9315.487648179414, 9460.290478214161, 9593.952030239805, 9598.136167744797, 9638.373505722106, 12147.271163730204, 12153.0, 12168.148229623841, 12174.0, 12182.208156469802, 7074.858502829915, 7099.219085900547, 7116.679749411289, 7124.786256412316, 7143.42852571793, 6797.4901882358035, 6831.726730930707, 6844.555103918229, 6864.656767161622, 6909.1018167637885, 5703.74333155009, 5713.457221564028, 5750.6837123958585, 5756.884862302731, 5776.971115144397, 1562.2969663651174, 1652.1335482937095, 1672.180631490561, 1724.6636905803498, 1727.6717423689458, 796.717165406284, 836.8326334733077, 857.7383897911197, 890.2299510923134, 965.2374624047064, 13846.65383365424, 15725.606859828367, 16302.347906083862, 16320.183990800413, 16754.664906701797, 807.6930766308765, 835.8495470815311, 854.0, 857.3784006595168, 861.2335021830576, 7735.729249476241, 9574.712758617252, 9579.664711735195, 9740.464274464972, 9811.852822207673, 427620.0, 434260.0, 435847.0, 443994.0, 444161.0, 63571.0, 64495.0, 65947.34052659413, 66230.33769662338, 66363.66818165878, 1077.7628921637227, 1083.853679753239, 1086.6251143355687, 1097.961571345015, 1101.4767985206963, 14647.414103435744, 14674.119552826865, 14970.0, 14996.400143994555, 15043.097414155185, 30900.22749431282, 31603.36793264168, 31680.841595791873, 32028.0, 32028.5195722069, 40613.0, 41026.79486602548, 41454.0, 41699.37450938178, 41841.79079104707, 8883.600237989176, 8900.287976961958, 9061.275097992013, 9100.271978241592, 9107.08929107084, 16229.67540649204, 16276.674466510367, 16334.754978675091, 16848.747268790732, 16932.74600880963, 13616.93191534036, 13820.378082986088, 13943.093698909539, 14258.857411426168, 14264.0, 13413.530526431528, 13634.5917418813, 13866.930665346608, 13982.440702372198, 14234.0, 14153.363098660378, 14223.431062757787, 14274.71450570962, 14512.274386280855, 14698.265086745407, 8760.956195218983, 8920.0, 8927.732168034969, 8932.598033088396, 8938.4190027648, 13751.106178098391, 13937.930310348384, 13992.650183745487, 14265.786013210018, 14365.569032929028], "unit": "score", "name": "jquery.html", "value": 8439.950301644642}, {"lowerIsBetter": false, "replicates": [1366.303185375459, 1401.7546929287378, 1433.684589390335, 1607.1401800036979, 1681.7477378393244, 5801.506871915887, 6853.31466853315, 7030.824229394261, 7033.648317584113, 7043.366097051265, 6838.829029274259, 6981.301869813016, 7034.437245020386, 7053.470989675782, 7072.717091316341, 1718.278323104293, 1744.590021344983, 2014.0533949043927, 2063.288165582875, 2096.758872729633, 2055.3628375203734, 2055.845811564131, 2058.4853786553363, 2059.8455115866295, 2064.762552306489, 1998.2406685459505, 2009.5578972626, 2060.4024832798546, 2062.6390381683223, 2062.8762274263518, 2017.5258814178655, 2035.2571311471281, 2068.2347531413325, 2070.3478404302673, 2072.5440403111293, 2058.907349169291, 2085.5307555799823, 2086.968695469569, 2087.4468265909545, 2087.6137914485867, 7023.9648801756175, 7110.253423390522, 7114.64426778659, 7115.53749006313, 7123.2520585338825, 4119.773412462313, 4197.244495990721, 4246.617804397588, 4248.511421186572, 4254.638355739766, 2628.829126106797, 2705.6753189617175, 2710.7695845853127, 2715.4840580289683, 2720.3471166919994, 829.6847198064697, 836.5540332435826, 850.7745447456429, 852.5311078906576, 864.1703964194381, 9491.905080949171, 9495.90504094957, 9499.572519236583, 9504.0, 9526.9523652382, 3845.288621605012, 3861.343571592836, 3923.7645741255615, 3946.3291240489184, 3967.2858885400906, 8143.51138931666, 8227.053888802744, 8235.176482351717, 8241.381896357798, 8251.463654862415, 4312.935305970413, 4328.48058233014, 4329.718568293051, 4337.175936572041, 4343.457067866517, 3921.490206273166, 3939.783311917815, 3960.7227494075137, 3969.166475040216, 3971.602839716063, 2941.2058744138963, 2985.940281194364, 3301.620313663959, 3304.454764963754, 3347.146477648233, 1022.7238645565656, 1053.5206481051102, 1063.1016790811752, 1065.0, 1068.0547715271884, 867.9522626255616, 873.3406278259873, 879.7712594725417, 880.7665968518347, 907.5008745190119, 6645.435138013227, 6707.295733947963, 6715.3620406061345, 6721.529492935545, 6721.630310332881, 993.965211217604, 1009.1674368645896, 1037.4138611684375, 1044.1959691037857, 1046.5865982936698, 5273.235380869753, 5297.973510132425, 5298.417174110845, 5303.28405665238, 5310.867228319323, 8202.671893124209, 8312.6674933002, 8393.916060839314, 8466.872996905051, 8572.785680358042, 8393.580320983927, 8472.49165050099, 8473.195046470575, 8474.66101355939, 8519.701810436605, 6383.234011918599, 6622.37087476689, 6728.461723062143, 6730.697118629673, 6761.560498567577, 6201.193844800147, 6521.5108866834225, 6553.934460655523, 6557.344265573595, 6569.737210511526, 7523.849523009619, 7534.0, 7640.3505702015955, 7640.541567505968, 7692.4230682700145, 7698.461107722405, 7737.419693522896, 7818.140004599603, 7833.686652533835, 8038.638261278374, 6597.934020659924, 6677.198736151693, 6688.699008544724, 6693.0, 6697.497687673346, 5951.7024148791525, 6299.464545513682, 6334.809955701337, 6359.745610175726, 6366.681665916778, 5952.345242023287, 6000.129981152796, 6118.694065296806, 6234.6570938597, 6239.7504099837315, 6013.819585412444, 6038.486728628116, 6105.633661980295, 6127.877442451215, 6144.692765361625, 5943.405659434195, 5959.255093113361, 5989.401059893976, 6036.396360363929, 6064.06007068905, 5591.440855914376, 5656.858578535405, 5672.2058911751565, 5688.061469857427, 5690.317161940594, 5572.359178694502, 5594.664320140804, 5609.719514024364, 5619.185218143428, 5635.464630860061], "unit": "score", "name": "mootools.html", "value": 4007.92567339126}, {"lowerIsBetter": false, "replicates": [306.4285108273071, 310.3900834859502, 312.6966842163101, 315.4227763193358, 317.87285085965624, 5263.078961181792, 5286.524212820846, 5356.250124982505, 5392.975334686407, 5410.675359478434, 5333.35999680038, 5334.546563542094, 5339.679619222849, 5353.5984801139875, 5366.302380690515, 3997.1206334606486, 4084.9387259191135, 4225.704200705952, 4227.408162857202, 4232.682548808836, 4102.958970410303, 4142.130152667944, 4151.875443736678, 4181.7490950542915, 4187.036981494258, 4118.9702574356415, 4127.649149822269, 4165.937510937339, 4176.540580536139, 4177.937330940038, 3979.4030895365636, 4065.10567675111, 4075.9592404075875, 4171.374293855915, 4186.476690413699, 3679.7608155469807, 3690.815459227055, 3693.0582701411236, 3700.204456041964, 3712.424574191005, 5128.640995130342, 5142.434332223453, 5142.6914385137015, 5153.458886816905, 5158.819441319573, 4807.326974223612, 4808.35087263222, 4819.1325561398935, 4822.758862056883, 4834.129856625806, 5491.093969495068, 5620.5503559715125, 5640.74616642248, 5644.153376993484, 5646.802361917313, 4016.5782592827622, 4020.2964481215963, 4028.0735430850777, 4029.6373326400767, 4036.9394459083137, 5924.644521328691, 5932.11018347247, 5942.524598032147, 5946.8810623787285, 5947.078202878561, 4119.546849846514, 4149.37759336102, 4149.543550209474, 4155.958440415618, 4159.521655009713, 3970.563238043813, 4075.53280818905, 4090.631843134073, 4205.558416366238, 4218.514870789899, 4699.506551812079, 4731.408573928259, 4735.621150307967, 4740.644451666139, 4745.620350371962, 5681.744321505542, 5686.744096515667, 5689.743961521742, 5694.800681976111, 5707.029804933171, 1421.7654087075516, 1450.789635502846, 1450.9056911300731, 1454.6217983324411, 1455.4396557325294, 970.2383628851318, 973.8490533967247, 980.7793246519618, 999.0958182844537, 1000.1398797034544, 4951.628627852925, 4965.677230979974, 4967.925481117786, 4968.726720030433, 4969.155243608523, 5819.185314056035, 5821.679807610622, 5824.3302020267365, 5830.533557315404, 5846.298444186725, 4944.332515110414, 4952.925706114411, 4953.801847926043, 4955.727434991038, 4959.454460009396, 2937.500624893773, 3031.7119873611973, 3096.643885953099, 3120.188750924776, 3161.2571045804216, 5473.534749546333, 5527.226188333637, 5574.108142697149, 5591.608587398924, 5599.740058486889, 6075.058365953284, 6085.056816193497, 6088.817335479854, 6089.725962331706, 6089.847753806191, 5576.107822748422, 5585.050541407889, 5587.189857470644, 5592.888142237214, 5597.63615365, 5755.683437410982, 5887.793927212699, 5896.086106653475, 5896.764129434946, 5897.41025897424, 5773.884522309446, 5782.971085144547, 5786.652800831964, 5788.131780232999, 5796.797112101056, 5577.2191893135805, 5577.498025177753, 5581.6371935824045, 5583.888322233452, 5587.217789509391, 3973.477382538148, 4026.2350153470748, 4047.655949244347, 4052.878413647595, 4053.452783874139, 5887.587868849139, 5898.9115163273445, 5918.7928422505, 5919.763209471573, 5923.052311630291, 5690.430956904276, 5695.288088988877, 5698.4016678249845, 5699.686517241592, 5705.7147142643535, 5702.714864256854, 5703.8859222816145, 5706.543476521785, 5707.143928410605, 5712.857178570569, 5441.591880608891, 5586.329640443173, 5586.944130558642, 5592.636478628876, 5598.468145526169, 5706.201131841629, 5721.0, 5721.971390143022, 5733.3406658234835, 5734.913976290442, 5356.705381203916, 5442.619016668795, 5446.754896029609, 5625.071863142535, 5627.831165065055], "unit": "score", "name": "prototype.html", "value": 4258.659767809838}, {"lowerIsBetter": false, "replicates": [642.309517268936, 670.3330186464468, 751.3313151295347, 779.3375630713894, 787.712484942996, 10284.280100392976, 10544.0, 10545.0, 10545.525451354688, 10570.154387648989, 11782.705432364173, 11830.7633847323, 13356.933215333935, 13717.314134293296, 13728.58814235572, 628.7485005997614, 637.7704026550462, 799.1968072087558, 809.8501777171213, 810.3436216664492, 790.1782146567563, 809.4293523066253, 809.821839195379, 809.9838003239961, 811.407672399149, 837.5937670229933, 849.8767678686587, 850.6980022092162, 851.1998721202082, 851.3572252949015, 652.6834485274662, 656.5797889350772, 821.8931538899905, 850.5449584472309, 850.7150104714927, 621.8911690454153, 622.0110025060176, 622.1103821535203, 622.6575383539035, 622.7477871462065, 11812.409379531075, 12074.27554346742, 12104.576339828152, 12108.820412325778, 12109.878901210963, 10316.896831031743, 10557.155427565776, 10788.08301294391, 11062.889371106266, 11142.944285278521, 8357.289630381425, 8947.150020748019, 9339.953300233523, 9617.23062155026, 9694.0, 2918.8978385756395, 3015.8190508569555, 3041.847907604633, 3058.3118798270434, 3061.127578640077, 38802.22395552101, 39402.60597394018, 39447.802760986015, 39469.80265098685, 39762.0, 8911.643534258686, 9184.81630367389, 9482.810343793086, 9916.157126644315, 10062.899371006342, 16246.431374901822, 16407.42574009904, 16423.91788041052, 16428.1785910704, 16546.83453165477, 6518.706658200297, 6522.543421960418, 6526.738930442824, 6589.110470086477, 6723.058771771955, 3685.7788532688123, 3707.1102935295335, 3712.9561110310588, 3750.1374683822874, 3756.9060773480883, 2549.247971848309, 2550.2731721459295, 2559.9760095961765, 2561.0652111979366, 2563.5898256278906, 472.17840956735034, 496.52333759590476, 505.5273319446329, 516.7390467813805, 517.2990597740084, 463.88866671998477, 566.8214512428572, 567.2483958754667, 572.4475880775072, 594.9405059494103, 7164.0328555645365, 7437.442191835634, 7444.8883266751045, 7473.887891681629, 7585.393168546503, 431.56627589273205, 478.3112318261692, 525.4719007397541, 545.4599946053379, 570.8030729398351, 3466.445368740989, 3619.6199399063244, 3635.1457407509215, 3661.229361448148, 3756.7933763642714, 48320.0, 49309.753451232515, 49629.0, 49850.750746246034, 50106.49893501091, 41909.58090419057, 42446.0, 44151.558484414745, 44319.335209971876, 44331.0, 39162.60837391647, 39520.40719389211, 40027.79986100051, 40086.599134008284, 40195.0, 7315.780526584211, 7513.2111128330735, 7674.424418168548, 7717.807054823675, 7830.491018083806, 30279.0, 30281.091567253017, 31091.84454077715, 31185.376292474477, 31211.063668089995, 37573.24853502969, 37903.43144852885, 38285.808570956964, 38288.80855595704, 38382.424263636625, 10186.796264074825, 10304.381737095799, 10364.378137311785, 10376.533056012346, 10617.0, 10975.231733778559, 11009.119270458505, 11369.886301136883, 11489.827652585385, 11608.825867611824, 9434.905650943678, 9910.950445248016, 10085.69742907714, 10363.481825908524, 11053.392063436266, 10060.446675432922, 10067.69796906094, 10118.08937195656, 10392.324498907547, 10883.292585982203, 7996.1333977767035, 9283.303752218475, 9591.184749296388, 9910.554025069034, 10034.749131271778, 8268.503889766633, 9403.153716165578, 9451.669191578261, 9481.905180948379, 9483.383580067273, 8468.585801846295, 8710.303175746052, 8826.823463530565, 8831.425957312755, 8978.102189781232], "unit": "score", "name": "yui.html", "value": 5605.633496684813}], "name": "dromaeo_css", "value": 6294.440819572646}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 108.0, 113.0, 114.0, 113.0, 104.0, 111.0, 113.0, 103.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 157.0, 162.0, 135.0, 154.0, 162.0, 134.0, 175.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [159.0, 162.0, 161.0, 161.0, 163.0, 160.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 84.0, 92.0, 75.0, 72.0, 72.0, 102.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 94.0, 96.0, 132.0, 95.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 148.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 71.0, 73.0, 70.0, 80.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 86.0, 84.0, 92.0, 83.0, 85.0, 85.0, 84.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 120.0, 127.0, 120.0, 121.0, 125.0, 119.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 161.0, 148.0, 150.0, 136.0, 148.0, 148.0, 147.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 72.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1521.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.15484090522375], "unit": "score", "name": "Richards", "value": 207.46985400000003}, {"lowerIsBetter": false, "replicates": [186.46280067126608], "unit": "score", "name": "DeltaBlue", "value": 354.59083400000003}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [813.6696501220505], "unit": "score", "name": "Earley", "value": 819.0830269999999}, {"lowerIsBetter": false, "replicates": [11800.0], "unit": "score", "name": "Boyer", "value": 56.4799152542373}, {"lowerIsBetter": false, "replicates": [27351.35135135135], "unit": "score", "name": "RegExp", "value": 33.306763833992065}, {"lowerIsBetter": false, "replicates": [615.8574062692071], "unit": "score", "name": "Splay", "value": 132.3212145708583}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19714.639232348494}]} 06:20:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19714.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1521.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6294.44"}}} 06:20:44 INFO - Return code: 0 06:20:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:44 ERROR - # TBPL SUCCESS # 06:20:44 INFO - Running post-action listener: _resource_record_post_action 06:20:44 INFO - Running post-run listener: _resource_record_post_run 06:20:45 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549666816; Read time: 16; Write time: 408216 06:20:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227684352; Read time: 0; Write time: 206580 06:20:45 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321118208; Read time: 16; Write time: 201596 06:20:45 INFO - Running post-run listener: _upload_blobber_files 06:20:45 INFO - Blob upload gear active. 06:20:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:45 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 06:20:45 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'] 06:20:45 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 06:20:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:46 INFO - (blobuploader) - INFO - Done attempting. 06:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:47 INFO - (blobuploader) - INFO - Done attempting. 06:20:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:47 INFO - Return code: 0 06:20:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/3b412a0d4126b9db2bbf4e9db0a67b2765693fb4e8d7a428e9c52d64bbbd886ad6118dfd29a083b8de9d9762e3e98fa64f8f6f400c1a16398ddc046f54f28a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f4bc8e49f58585d92e09f271af05a8bfabed2dde759aa8af3addc846943156f3564bc30e5e5db031fe64732261b7a6a27c834c3b89c01fcea1cd76d3479b7112"} 06:20:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:47 INFO - Contents: 06:20:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/3b412a0d4126b9db2bbf4e9db0a67b2765693fb4e8d7a428e9c52d64bbbd886ad6118dfd29a083b8de9d9762e3e98fa64f8f6f400c1a16398ddc046f54f28a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f4bc8e49f58585d92e09f271af05a8bfabed2dde759aa8af3addc846943156f3564bc30e5e5db031fe64732261b7a6a27c834c3b89c01fcea1cd76d3479b7112"} 06:20:47 INFO - Copying logs to upload dir... 06:20:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.379648 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-22 06:20:47.037927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 06:20:47.041768) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 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/3b412a0d4126b9db2bbf4e9db0a67b2765693fb4e8d7a428e9c52d64bbbd886ad6118dfd29a083b8de9d9762e3e98fa64f8f6f400c1a16398ddc046f54f28a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f4bc8e49f58585d92e09f271af05a8bfabed2dde759aa8af3addc846943156f3564bc30e5e5db031fe64732261b7a6a27c834c3b89c01fcea1cd76d3479b7112"} build_url:https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/wR8AeERQR0mO9LsGaovjLA/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/3b412a0d4126b9db2bbf4e9db0a67b2765693fb4e8d7a428e9c52d64bbbd886ad6118dfd29a083b8de9d9762e3e98fa64f8f6f400c1a16398ddc046f54f28a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f4bc8e49f58585d92e09f271af05a8bfabed2dde759aa8af3addc846943156f3564bc30e5e5db031fe64732261b7a6a27c834c3b89c01fcea1cd76d3479b7112"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 06:20:47.066241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 06:20:47.066698) ========= 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=01deea79d00cc2c334834894000001d2-1450792775.195989-49025379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 06:20:47.149731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 06:20:47.150092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 06:20:47.150453) ========= ========= Total master_lag: 0.22 =========