builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1451925450.01 results: success (0) buildid: 20160104082037 builduid: 01ae443294414c98a9b3f75f00bb3829 revision: 9d5029646b5297649513b648d9109f20fdab9845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.011099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.011555) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.011842) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006320 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.035095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.035438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.049535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.050119) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.100262) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.100595) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.100988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.101281) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 08:37:30-- 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% 223M=0s 2016-01-04 08:37:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.263346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.263692) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022091 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.314423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:30.314949) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d5029646b5297649513b648d9109f20fdab9845 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9d5029646b5297649513b648d9109f20fdab9845 --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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 08:37:30,410 truncating revision to first 12 chars 2016-01-04 08:37:30,411 Setting DEBUG logging. 2016-01-04 08:37:30,411 attempt 1/10 2016-01-04 08:37:30,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d5029646b52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 08:37:30,653 unpacking tar archive at: fx-team-9d5029646b52/testing/mozharness/ program finished with exit code 0 elapsedTime=0.876099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:31.204877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:31.205192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:31.212572) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:31.212873) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 08:37:31.213272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-04 08:37:31.213572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:37:31 INFO - MultiFileLogger online at 20160104 08:37:31 in /builds/slave/test 08:37:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:37:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:31 INFO - {'append_to_log': False, 08:37:31 INFO - 'base_work_dir': '/builds/slave/test', 08:37:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:37:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:31 INFO - 'branch': 'Fx-Team-Non-PGO', 08:37:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:31 INFO - 'config_files': ('talos/linux_config.py',), 08:37:31 INFO - 'default_actions': ('clobber', 08:37:31 INFO - 'read-buildbot-config', 08:37:31 INFO - 'download-and-extract', 08:37:31 INFO - 'populate-webroot', 08:37:31 INFO - 'create-virtualenv', 08:37:31 INFO - 'install', 08:37:31 INFO - 'run-tests'), 08:37:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:31 INFO - 'download_minidump_stackwalk': True, 08:37:31 INFO - 'download_symbols': 'ondemand', 08:37:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:31 INFO - 'installer_path': 'installer.exe', 08:37:31 INFO - 'log_level': 'info', 08:37:31 INFO - 'log_name': 'talos', 08:37:31 INFO - 'log_to_console': True, 08:37:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:37:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:37:31 INFO - 'opt_config_files': (), 08:37:31 INFO - 'pip_index': False, 08:37:31 INFO - 'sps_profile': False, 08:37:31 INFO - 'sps_profile_interval': 0, 08:37:31 INFO - 'suite': 'dromaeojs', 08:37:31 INFO - 'system_bits': '32', 08:37:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:31 INFO - 'title': 'talos-linux64-ix-007', 08:37:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:31 INFO - 'use_talos_json': True, 08:37:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:31 INFO - 'work_dir': 'build'} 08:37:31 INFO - ##### 08:37:31 INFO - ##### Running clobber step. 08:37:31 INFO - ##### 08:37:31 INFO - Running pre-action listener: _resource_record_pre_action 08:37:31 INFO - Running main action method: clobber 08:37:31 INFO - rmtree: /builds/slave/test/build 08:37:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:32 INFO - Running post-action listener: _resource_record_post_action 08:37:32 INFO - ##### 08:37:32 INFO - ##### Running read-buildbot-config step. 08:37:32 INFO - ##### 08:37:32 INFO - Running pre-action listener: _resource_record_pre_action 08:37:32 INFO - Running main action method: read_buildbot_config 08:37:32 INFO - Using buildbot properties: 08:37:32 INFO - { 08:37:32 INFO - "project": "", 08:37:32 INFO - "product": "firefox", 08:37:32 INFO - "script_repo_revision": "production", 08:37:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:37:32 INFO - "repository": "", 08:37:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:37:32 INFO - "buildid": "20160104082037", 08:37:32 INFO - "pgo_build": "False", 08:37:32 INFO - "basedir": "/builds/slave/test", 08:37:32 INFO - "buildnumber": 1072, 08:37:32 INFO - "slavename": "talos-linux64-ix-007", 08:37:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:37:32 INFO - "platform": "ubuntu64_hw", 08:37:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:37:32 INFO - "branch": "fx-team", 08:37:32 INFO - "repo_path": "integration/fx-team", 08:37:32 INFO - "revision": "9d5029646b5297649513b648d9109f20fdab9845", 08:37:32 INFO - "stage_platform": "linux64", 08:37:32 INFO - "builduid": "01ae443294414c98a9b3f75f00bb3829", 08:37:32 INFO - "slavebuilddir": "test" 08:37:32 INFO - } 08:37:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:37:32 INFO - Running post-action listener: _resource_record_post_action 08:37:32 INFO - ##### 08:37:32 INFO - ##### Running download-and-extract step. 08:37:32 INFO - ##### 08:37:32 INFO - Running pre-action listener: _resource_record_pre_action 08:37:32 INFO - Running main action method: download_and_extract 08:37:32 INFO - mkdir: /builds/slave/test/build/tests 08:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:32 INFO - https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/test_packages.json 08:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/test_packages.json 08:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:37:32 INFO - Downloaded 1302 bytes. 08:37:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:37:32 INFO - Using the following test package requirements: 08:37:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:37:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'jsshell-linux-x86_64.zip'], 08:37:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:37:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:37:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:37:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:37:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:37:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:32 INFO - https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:36 INFO - Downloaded 21950003 bytes. 08:37:36 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 08:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:36 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 08:37:38 INFO - Return code: 0 08:37:38 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 08:37: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')]} 08:37:38 INFO - https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:43 INFO - Downloaded 21950003 bytes. 08:37:43 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 08:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:37:43 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 08:37:45 INFO - Return code: 0 08:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:45 INFO - https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:46 INFO - Downloaded 11132285 bytes. 08:37:46 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 08:37:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:46 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 08:37:46 INFO - Return code: 0 08:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:46 INFO - https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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 08:37:48 INFO - Downloaded 53374962 bytes. 08:37:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:37:48 INFO - mkdir: /builds/slave/test/properties 08:37:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:48 INFO - Contents: 08:37:48 INFO - build_url:https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:37:48 INFO - Running post-action listener: _resource_record_post_action 08:37:48 INFO - Running post-action listener: set_extra_try_arguments 08:37:48 INFO - ##### 08:37:48 INFO - ##### Running populate-webroot step. 08:37:48 INFO - ##### 08:37:48 INFO - Running pre-action listener: _resource_record_pre_action 08:37:48 INFO - Running main action method: populate_webroot 08:37:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:48 INFO - '--tppagecycles', 08:37:48 INFO - '7'], 08:37:48 INFO - 'tests': ['tsvgm']}}, 08:37:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:37:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:37:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:37:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'tests': ['damp', 'tps']}, 08:37:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['damp', 'tps']}, 08:37:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:37:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:48 INFO - 'other': {'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'other_l64': {'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'other_nol64': {'tests': ['a11yr', 08:37:48 INFO - 'ts_paint', 08:37:48 INFO - 'tpaint', 08:37:48 INFO - 'sessionrestore', 08:37:48 INFO - 'sessionrestore_no_auto_restore']}, 08:37:48 INFO - 'svgr': {'tests': ['tsvgx', 08:37:48 INFO - 'tsvgr_opacity', 08:37:48 INFO - 'tart', 08:37:48 INFO - 'tscrollx', 08:37:48 INFO - 'cart']}, 08:37:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['tsvgx', 08:37:48 INFO - 'tsvgr_opacity', 08:37:48 INFO - 'tart', 08:37:48 INFO - 'tscrollx', 08:37:48 INFO - 'cart']}, 08:37:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'tests': ['tp5o']}, 08:37:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'talos_options': ['--e10s'], 08:37:48 INFO - 'tests': ['tp5o']}, 08:37:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'talos_options': ['--xperf_path', 08:37:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:48 INFO - 'tests': ['tp5n']}, 08:37:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:48 INFO - 'talos_options': ['--e10s', 08:37:48 INFO - '--xperf_path', 08:37:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:48 INFO - 'tests': ['tp5n']}}, 08:37:48 INFO - 'talos.zip': {'path': '', 08:37:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:48 INFO - Running post-action listener: _resource_record_post_action 08:37:48 INFO - ##### 08:37:48 INFO - ##### Running create-virtualenv step. 08:37:48 INFO - ##### 08:37:48 INFO - Running pre-action listener: _resource_record_pre_action 08:37:48 INFO - Running main action method: create_virtualenv 08:37:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:37:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:48 INFO - Using real prefix '/usr' 08:37:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:50 INFO - Installing pip.................done. 08:37:50 INFO - Return code: 0 08:37:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:37: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', 'pip>=1.5'] in /builds/slave/test/build 08:37: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 pip>=1.5 08:37:50 INFO - Using env: {'DISPLAY': ':0', 08:37:50 INFO - 'HOME': '/home/cltbld', 08:37:50 INFO - 'LANG': 'en_US.UTF-8', 08:37:50 INFO - 'LANGUAGE': 'en_US:en', 08:37:50 INFO - 'LOGNAME': 'cltbld', 08:37:50 INFO - 'MAIL': '/var/mail/cltbld', 08:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:50 INFO - 'MOZ_NO_REMOTE': '1', 08:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:50 INFO - 'NO_EM_RESTART': '1', 08:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:50 INFO - 'PWD': '/builds/slave/test', 08:37:50 INFO - 'SHELL': '/bin/bash', 08:37:50 INFO - 'SHLVL': '1', 08:37:50 INFO - 'TERM': 'linux', 08:37:50 INFO - 'TMOUT': '86400', 08:37:50 INFO - 'USER': 'cltbld', 08:37:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:50 INFO - '_': '/tools/buildbot/bin/python'} 08:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:50 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 08:37:50 INFO - Cleaning up... 08:37:50 INFO - Return code: 0 08:37:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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', '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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:37: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:37: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 psutil>=0.7.1 08:37:50 INFO - Using env: {'DISPLAY': ':0', 08:37:50 INFO - 'HOME': '/home/cltbld', 08:37:50 INFO - 'LANG': 'en_US.UTF-8', 08:37:50 INFO - 'LANGUAGE': 'en_US:en', 08:37:50 INFO - 'LOGNAME': 'cltbld', 08:37:50 INFO - 'MAIL': '/var/mail/cltbld', 08:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:50 INFO - 'MOZ_NO_REMOTE': '1', 08:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:50 INFO - 'NO_EM_RESTART': '1', 08:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:50 INFO - 'PWD': '/builds/slave/test', 08:37:50 INFO - 'SHELL': '/bin/bash', 08:37:50 INFO - 'SHLVL': '1', 08:37:50 INFO - 'TERM': 'linux', 08:37:50 INFO - 'TMOUT': '86400', 08:37:50 INFO - 'USER': 'cltbld', 08:37:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:50 INFO - '_': '/tools/buildbot/bin/python'} 08:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:51 INFO - Downloading/unpacking psutil>=0.7.1 08:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:37:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:52 INFO - Installing collected packages: psutil 08:37:52 INFO - Running setup.py install for psutil 08:37:53 INFO - building 'psutil._psutil_linux' extension 08:37:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:37:53 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 08:37:53 INFO - building 'psutil._psutil_posix' extension 08:37:53 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 08:37:53 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 08:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:53 INFO - Successfully installed psutil 08:37:53 INFO - Cleaning up... 08:37:53 INFO - Return code: 0 08:37:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:37:53 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 08:37:53 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 08:37:53 INFO - Using env: {'DISPLAY': ':0', 08:37:53 INFO - 'HOME': '/home/cltbld', 08:37:53 INFO - 'LANG': 'en_US.UTF-8', 08:37:53 INFO - 'LANGUAGE': 'en_US:en', 08:37:53 INFO - 'LOGNAME': 'cltbld', 08:37:53 INFO - 'MAIL': '/var/mail/cltbld', 08:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:53 INFO - 'MOZ_NO_REMOTE': '1', 08:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:53 INFO - 'NO_EM_RESTART': '1', 08:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:53 INFO - 'PWD': '/builds/slave/test', 08:37:53 INFO - 'SHELL': '/bin/bash', 08:37:53 INFO - 'SHLVL': '1', 08:37:53 INFO - 'TERM': 'linux', 08:37:53 INFO - 'TMOUT': '86400', 08:37:53 INFO - 'USER': 'cltbld', 08:37:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:53 INFO - '_': '/tools/buildbot/bin/python'} 08:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:37:53 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 08:37:53 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 08:37:53 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 08:37:53 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 08:37:53 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 08:37:53 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 08:37:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:37:55 INFO - Installing collected packages: mozsystemmonitor 08:37:55 INFO - Running setup.py install for mozsystemmonitor 08:37:55 INFO - Successfully installed mozsystemmonitor 08:37:55 INFO - Cleaning up... 08:37:55 INFO - Return code: 0 08:37:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:55 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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:37:55 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 08:37:55 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 08:37:55 INFO - Using env: {'DISPLAY': ':0', 08:37:55 INFO - 'HOME': '/home/cltbld', 08:37:55 INFO - 'LANG': 'en_US.UTF-8', 08:37:55 INFO - 'LANGUAGE': 'en_US:en', 08:37:55 INFO - 'LOGNAME': 'cltbld', 08:37:55 INFO - 'MAIL': '/var/mail/cltbld', 08:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:55 INFO - 'MOZ_NO_REMOTE': '1', 08:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:55 INFO - 'NO_EM_RESTART': '1', 08:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:55 INFO - 'PWD': '/builds/slave/test', 08:37:55 INFO - 'SHELL': '/bin/bash', 08:37:55 INFO - 'SHLVL': '1', 08:37:55 INFO - 'TERM': 'linux', 08:37:55 INFO - 'TMOUT': '86400', 08:37:55 INFO - 'USER': 'cltbld', 08:37:55 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:55 INFO - '_': '/tools/buildbot/bin/python'} 08:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:37:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:37:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:37:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:37:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:58 INFO - Downloading docopt-0.6.1.tar.gz 08:37:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:37:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:37:58 INFO - Running setup.py install for blobuploader 08:37:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:37:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:37:58 INFO - Running setup.py install for requests 08:37:58 INFO - Running setup.py install for docopt 08:37:58 INFO - Successfully installed blobuploader requests docopt 08:37:58 INFO - Cleaning up... 08:37:58 INFO - Return code: 0 08:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:58 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')]} 08:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 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')]} 08:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:37:58 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 08:37:58 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 08:37:58 INFO - Using env: {'DISPLAY': ':0', 08:37:58 INFO - 'HOME': '/home/cltbld', 08:37:58 INFO - 'LANG': 'en_US.UTF-8', 08:37:58 INFO - 'LANGUAGE': 'en_US:en', 08:37:58 INFO - 'LOGNAME': 'cltbld', 08:37:58 INFO - 'MAIL': '/var/mail/cltbld', 08:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:58 INFO - 'MOZ_NO_REMOTE': '1', 08:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:58 INFO - 'NO_EM_RESTART': '1', 08:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:58 INFO - 'PWD': '/builds/slave/test', 08:37:58 INFO - 'SHELL': '/bin/bash', 08:37:58 INFO - 'SHLVL': '1', 08:37:58 INFO - 'TERM': 'linux', 08:37:58 INFO - 'TMOUT': '86400', 08:37:58 INFO - 'USER': 'cltbld', 08:37:58 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:58 INFO - '_': '/tools/buildbot/bin/python'} 08:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:59 INFO - Running setup.py (path:/tmp/pip-npLLME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:59 INFO - Running setup.py (path:/tmp/pip-KpyeRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:59 INFO - Running setup.py (path:/tmp/pip-Q53EP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:59 INFO - Running setup.py (path:/tmp/pip-ReroL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:59 INFO - Running setup.py (path:/tmp/pip-U1SthG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:59 INFO - Running setup.py (path:/tmp/pip-LdjHMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:59 INFO - Running setup.py (path:/tmp/pip-TJFo0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:59 INFO - Running setup.py (path:/tmp/pip-J071zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:59 INFO - Running setup.py (path:/tmp/pip-_Jc2db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:59 INFO - Running setup.py (path:/tmp/pip-35V7YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:59 INFO - Running setup.py (path:/tmp/pip-i81vQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:59 INFO - Running setup.py (path:/tmp/pip-HYNd0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:59 INFO - Running setup.py (path:/tmp/pip-1wQQJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:59 INFO - Running setup.py (path:/tmp/pip-toSppU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:00 INFO - Running setup.py (path:/tmp/pip-xZoJzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:00 INFO - Running setup.py (path:/tmp/pip-uJE463-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:00 INFO - Running setup.py (path:/tmp/pip-hTNwJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:00 INFO - Running setup.py install for manifestparser 08:38:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:00 INFO - Running setup.py install for mozcrash 08:38:00 INFO - Running setup.py install for mozdebug 08:38:00 INFO - Running setup.py install for mozdevice 08:38:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:00 INFO - Running setup.py install for mozfile 08:38:00 INFO - Running setup.py install for mozhttpd 08:38:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:00 INFO - Running setup.py install for mozinfo 08:38:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:00 INFO - Running setup.py install for mozInstall 08:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Running setup.py install for mozleak 08:38:01 INFO - Running setup.py install for mozlog 08:38:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Running setup.py install for moznetwork 08:38:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Running setup.py install for mozprocess 08:38:01 INFO - Running setup.py install for mozprofile 08:38:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Running setup.py install for mozrunner 08:38:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:01 INFO - Running setup.py install for mozscreenshot 08:38:01 INFO - Running setup.py install for moztest 08:38:01 INFO - Running setup.py install for mozversion 08:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:02 INFO - Cleaning up... 08:38:02 INFO - Return code: 0 08:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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/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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:38: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/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 08:38: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/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 08:38:02 INFO - Using env: {'DISPLAY': ':0', 08:38:02 INFO - 'HOME': '/home/cltbld', 08:38:02 INFO - 'LANG': 'en_US.UTF-8', 08:38:02 INFO - 'LANGUAGE': 'en_US:en', 08:38:02 INFO - 'LOGNAME': 'cltbld', 08:38:02 INFO - 'MAIL': '/var/mail/cltbld', 08:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:02 INFO - 'MOZ_NO_REMOTE': '1', 08:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:02 INFO - 'NO_EM_RESTART': '1', 08:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:02 INFO - 'PWD': '/builds/slave/test', 08:38:02 INFO - 'SHELL': '/bin/bash', 08:38:02 INFO - 'SHLVL': '1', 08:38:02 INFO - 'TERM': 'linux', 08:38:02 INFO - 'TMOUT': '86400', 08:38:02 INFO - 'USER': 'cltbld', 08:38:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:02 INFO - '_': '/tools/buildbot/bin/python'} 08:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:02 INFO - Running setup.py (path:/tmp/pip-o5B9xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:02 INFO - Running setup.py (path:/tmp/pip-eLlWTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:02 INFO - Running setup.py (path:/tmp/pip-V4X9rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:02 INFO - Running setup.py (path:/tmp/pip-3DJXkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:02 INFO - Running setup.py (path:/tmp/pip-IieUhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:02 INFO - Running setup.py (path:/tmp/pip-Z7X7tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:02 INFO - Running setup.py (path:/tmp/pip-u29Cj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:02 INFO - Running setup.py (path:/tmp/pip-T62uFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:02 INFO - Running setup.py (path:/tmp/pip-Tk2cvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:02 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)) 08:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:02 INFO - Running setup.py (path:/tmp/pip-oFKZqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:02 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:03 INFO - Running setup.py (path:/tmp/pip-Mev5GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:03 INFO - Running setup.py (path:/tmp/pip-NCAxiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:03 INFO - Running setup.py (path:/tmp/pip-JtKo3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:03 INFO - Running setup.py (path:/tmp/pip-VgQjQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:03 INFO - Running setup.py (path:/tmp/pip-3bJEr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:03 INFO - Running setup.py (path:/tmp/pip-hcfrhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:03 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)) 08:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:03 INFO - Running setup.py (path:/tmp/pip-sa1bmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:03 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)) 08:38:03 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)) 08:38:03 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)) 08:38:03 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)) 08:38:03 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)) 08:38:03 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)) 08:38:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38:05 INFO - Downloading blessings-1.5.1.tar.gz 08:38:05 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 08:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:05 INFO - Installing collected packages: blessings 08:38:05 INFO - Running setup.py install for blessings 08:38:05 INFO - Successfully installed blessings 08:38:05 INFO - Cleaning up... 08:38:05 INFO - Return code: 0 08:38:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:05 INFO - Reading from file tmpfile_stdout 08:38:05 INFO - Current package versions: 08:38:05 INFO - argparse == 1.2.1 08:38:05 INFO - blessings == 1.5.1 08:38:05 INFO - blobuploader == 1.2.4 08:38:05 INFO - docopt == 0.6.1 08:38:05 INFO - manifestparser == 1.1 08:38:05 INFO - mozInstall == 1.12 08:38:05 INFO - mozcrash == 0.16 08:38:05 INFO - mozdebug == 0.1 08:38:05 INFO - mozdevice == 0.47 08:38:05 INFO - mozfile == 1.2 08:38:05 INFO - mozhttpd == 0.7 08:38:05 INFO - mozinfo == 0.9 08:38:05 INFO - mozleak == 0.1 08:38:05 INFO - mozlog == 3.1 08:38:05 INFO - moznetwork == 0.27 08:38:05 INFO - mozprocess == 0.22 08:38:05 INFO - mozprofile == 0.28 08:38:05 INFO - mozrunner == 6.11 08:38:05 INFO - mozscreenshot == 0.1 08:38:05 INFO - mozsystemmonitor == 0.0 08:38:05 INFO - moztest == 0.7 08:38:05 INFO - mozversion == 1.4 08:38:05 INFO - psutil == 3.1.1 08:38:05 INFO - requests == 1.2.3 08:38:05 INFO - wsgiref == 0.1.2 08:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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', '-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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:38:05 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 08:38:05 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 08:38:05 INFO - Using env: {'DISPLAY': ':0', 08:38:05 INFO - 'HOME': '/home/cltbld', 08:38:05 INFO - 'LANG': 'en_US.UTF-8', 08:38:05 INFO - 'LANGUAGE': 'en_US:en', 08:38:05 INFO - 'LOGNAME': 'cltbld', 08:38:05 INFO - 'MAIL': '/var/mail/cltbld', 08:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:05 INFO - 'MOZ_NO_REMOTE': '1', 08:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:05 INFO - 'NO_EM_RESTART': '1', 08:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:05 INFO - 'PWD': '/builds/slave/test', 08:38:05 INFO - 'SHELL': '/bin/bash', 08:38:05 INFO - 'SHLVL': '1', 08:38:05 INFO - 'TERM': 'linux', 08:38:05 INFO - 'TMOUT': '86400', 08:38:05 INFO - 'USER': 'cltbld', 08:38:05 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:05 INFO - '_': '/tools/buildbot/bin/python'} 08:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 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)) 08:38:05 INFO - Cleaning up... 08:38:05 INFO - Return code: 0 08:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:38: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', 'jsonschema'] in /builds/slave/test/build 08:38: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 jsonschema 08:38:05 INFO - Using env: {'DISPLAY': ':0', 08:38:05 INFO - 'HOME': '/home/cltbld', 08:38:05 INFO - 'LANG': 'en_US.UTF-8', 08:38:05 INFO - 'LANGUAGE': 'en_US:en', 08:38:05 INFO - 'LOGNAME': 'cltbld', 08:38:05 INFO - 'MAIL': '/var/mail/cltbld', 08:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:05 INFO - 'MOZ_NO_REMOTE': '1', 08:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:05 INFO - 'NO_EM_RESTART': '1', 08:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:05 INFO - 'PWD': '/builds/slave/test', 08:38:05 INFO - 'SHELL': '/bin/bash', 08:38:05 INFO - 'SHLVL': '1', 08:38:05 INFO - 'TERM': 'linux', 08:38:05 INFO - 'TMOUT': '86400', 08:38:05 INFO - 'USER': 'cltbld', 08:38:05 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:05 INFO - '_': '/tools/buildbot/bin/python'} 08:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:06 INFO - Downloading/unpacking jsonschema 08:38:06 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 08:38:06 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 08:38:06 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 08:38:06 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 08:38:06 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 08:38:06 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 08:38:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:07 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 08:38:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:08 INFO - warning: no files found matching '*.txt' 08:38:08 INFO - no previously-included directories found matching 'build' 08:38:08 INFO - no previously-included directories found matching 'dist' 08:38:08 INFO - no previously-included directories found matching '.git*' 08:38:08 INFO - Installing collected packages: jsonschema, functools32 08:38:08 INFO - Running setup.py install for functools32 08:38:08 INFO - warning: no files found matching '*.txt' 08:38:08 INFO - no previously-included directories found matching 'build' 08:38:08 INFO - no previously-included directories found matching 'dist' 08:38:08 INFO - no previously-included directories found matching '.git*' 08:38:08 INFO - Successfully installed jsonschema functools32 08:38:08 INFO - Cleaning up... 08:38:08 INFO - Return code: 0 08:38:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 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 0x7fa2e38fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fadd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', '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 08:38:08 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 08:38:08 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 08:38:08 INFO - Using env: {'DISPLAY': ':0', 08:38:08 INFO - 'HOME': '/home/cltbld', 08:38:08 INFO - 'LANG': 'en_US.UTF-8', 08:38:08 INFO - 'LANGUAGE': 'en_US:en', 08:38:08 INFO - 'LOGNAME': 'cltbld', 08:38:08 INFO - 'MAIL': '/var/mail/cltbld', 08:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:08 INFO - 'MOZ_NO_REMOTE': '1', 08:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:08 INFO - 'NO_EM_RESTART': '1', 08:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:08 INFO - 'PWD': '/builds/slave/test', 08:38:08 INFO - 'SHELL': '/bin/bash', 08:38:08 INFO - 'SHLVL': '1', 08:38:08 INFO - 'TERM': 'linux', 08:38:08 INFO - 'TMOUT': '86400', 08:38:08 INFO - 'USER': 'cltbld', 08:38:08 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:08 INFO - '_': '/tools/buildbot/bin/python'} 08:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:08 INFO - Downloading/unpacking flake8 08:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:38:10 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 08:38:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:38:10 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 08:38:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:10 INFO - no previously-included directories found matching 'docs/_build' 08:38:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:38:11 INFO - Running setup.py install for pep8 08:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:11 INFO - no previously-included directories found matching 'docs/_build' 08:38:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:38:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:38:11 INFO - Cleaning up... 08:38:11 INFO - Return code: 0 08:38:11 INFO - Running post-action listener: _resource_record_post_action 08:38:11 INFO - Running post-action listener: _start_resource_monitoring 08:38:11 INFO - Starting resource monitoring. 08:38:11 INFO - ##### 08:38:11 INFO - ##### Running install step. 08:38:11 INFO - ##### 08:38:11 INFO - Running pre-action listener: _resource_record_pre_action 08:38:11 INFO - Running main action method: install 08:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:11 INFO - Reading from file tmpfile_stdout 08:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:11 INFO - Reading from file tmpfile_stdout 08:38:11 INFO - Output received: 08:38:11 INFO - Usage: mozinstall [options] installer 08:38:11 INFO - Options: 08:38:11 INFO - -h, --help show this help message and exit 08:38:11 INFO - -d DEST, --destination=DEST 08:38:11 INFO - Directory to install application into. [default: 08:38:11 INFO - "/builds/slave/test"] 08:38:11 INFO - --app=APP Application being installed. [default: firefox] 08:38:11 INFO - mkdir: /builds/slave/test/build/application 08:38:11 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'] 08:38:11 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 08:38:27 INFO - Reading from file tmpfile_stdout 08:38:27 INFO - Output received: 08:38:27 INFO - /builds/slave/test/build/application/firefox/firefox 08:38:27 INFO - Running post-action listener: _resource_record_post_action 08:38:27 INFO - ##### 08:38:27 INFO - ##### Running run-tests step. 08:38:27 INFO - ##### 08:38:27 INFO - Running pre-action listener: _resource_record_pre_action 08:38:27 INFO - Running main action method: run_tests 08:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:38:27 INFO - Python 2.7.3 08:38:27 INFO - Return code: 0 08:38:27 INFO - grabbing minidump binary from tooltool 08:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:27 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 0x248d3d0>, '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 0x23f8ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f9360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:38:27 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 08:38:27 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 08:38:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:38:27 INFO - Return code: 0 08:38:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:38:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:38:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:38:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:38:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:38:28 INFO - Return code: 0 08:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 08:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 08:38:28 INFO - Using env: {'DISPLAY': ':0', 08:38:28 INFO - 'HOME': '/home/cltbld', 08:38:28 INFO - 'LANG': 'en_US.UTF-8', 08:38:28 INFO - 'LANGUAGE': 'en_US:en', 08:38:28 INFO - 'LOGNAME': 'cltbld', 08:38:28 INFO - 'MAIL': '/var/mail/cltbld', 08:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:28 INFO - 'MOZ_NO_REMOTE': '1', 08:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:28 INFO - 'NO_EM_RESTART': '1', 08:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:28 INFO - 'PWD': '/builds/slave/test', 08:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:38:28 INFO - 'SHELL': '/bin/bash', 08:38:28 INFO - 'SHLVL': '1', 08:38:28 INFO - 'TERM': 'linux', 08:38:28 INFO - 'TMOUT': '86400', 08:38:28 INFO - 'USER': 'cltbld', 08:38:28 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502', 08:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:28 INFO - '_': '/tools/buildbot/bin/python'} 08:38:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 08:38:28 INFO - mozversion application_buildid: 20160104082037 08:38:28 INFO - mozversion application_changeset: 9d5029646b5297649513b648d9109f20fdab9845 08:38:28 INFO - mozversion application_display_name: Nightly 08:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:38:28 INFO - mozversion application_name: Firefox 08:38:28 INFO - mozversion application_remotingname: firefox 08:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:38:28 INFO - mozversion application_vendor: Mozilla 08:38:28 INFO - mozversion application_version: 46.0a1 08:38:28 INFO - mozversion platform_buildid: 20160104082037 08:38:28 INFO - mozversion platform_changeset: 9d5029646b5297649513b648d9109f20fdab9845 08:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:38:28 INFO - mozversion platform_version: 46.0a1 08:38:28 INFO - using testdate: 1451925508 08:38:28 INFO - actual date: 1451925508 08:38:28 INFO - starting webserver on 'localhost:59263' 08:38:28 INFO - SUITE-START | Running 3 tests 08:38:28 INFO - TEST-START | dromaeo_css 08:38:28 INFO - operating with platform_type : linux_ 08:38:28 INFO - Initialising browser for dromaeo_css test... 08:38:28 INFO - TEST-INFO | started process 15867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rfaew/profile http://localhost:59263/getInfo.html) 08:38:32 INFO - PROCESS | 15867 | __metrics Screen width/height:1600/1200 08:38:32 INFO - PROCESS | 15867 | colorDepth:24 08:38:32 INFO - PROCESS | 15867 | Browser inner width/height: 1024/697 08:38:32 INFO - PROCESS | 15867 | __metrics 08:38:32 INFO - PROCESS | 15867 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:38:32 INFO - PROCESS | 15867 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:34 INFO - TEST-INFO | 15867: exit 0 08:38:34 INFO - Browser initialized. 08:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:34 INFO - TEST-INFO | started process 15957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rfaew/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:46 INFO - PROCESS | 15957 | RSS: Main: 150126592 08:38:46 INFO - PROCESS | 15957 | 08:39:37 INFO - PROCESS | 15957 | 1451925577205 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] 08:41:49 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59263/tests/dromaeo/cssquery-ext.html) 08:41:50 INFO - PROCESS | 15957 | RSS: Main: 266457088 08:41:50 INFO - PROCESS | 15957 | 08:44:52 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-ext.html (next: http://localhost:59263/tests/dromaeo/cssquery-jquery.html) 08:44:53 INFO - PROCESS | 15957 | RSS: Main: 232128512 08:44:53 INFO - PROCESS | 15957 | 08:47:55 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59263/tests/dromaeo/cssquery-mootools.html) 08:47:56 INFO - PROCESS | 15957 | RSS: Main: 230764544 08:47:56 INFO - PROCESS | 15957 | 08:50:58 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59263/tests/dromaeo/cssquery-prototype.html) 08:50:58 INFO - PROCESS | 15957 | RSS: Main: 211374080 08:50:58 INFO - PROCESS | 15957 | 08:54:01 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59263/tests/dromaeo/cssquery-yui.html) 08:54:02 INFO - PROCESS | 15957 | RSS: Main: 216907776 08:54:02 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | Cycle 1(1): loaded http://localhost:59263/tests/dromaeo/cssquery-yui.html (next: http://localhost:59263/tests/dromaeo/cssquery-dojo.html) 08:57:04 INFO - PROCESS | 15957 | RSS: Main: 259403776 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | __start_tp_report 08:57:04 INFO - PROCESS | 15957 | _x_x_mozilla_page_load 08:57:04 INFO - PROCESS | 15957 | _x_x_mozilla_page_load_details 08:57:04 INFO - PROCESS | 15957 | |i|pagename|runs| 08:57:04 INFO - PROCESS | 15957 | |0;dojo.html;2580.651612032376;2648.841069535828;2687;2693.501702185096;2712.538868392373;4406.889827754308;4555.453345598533;4558.293464512997;4569.5887370136725;4579.793909274083;4497.550244975509;4518.367428560005;4540.682152249344;4606.032733126048;4624.375709279247;4209.284421648312;4213.4101225828335;4225.345071513921;4280.4221430106845;4284.036091879318;4211.263028969934;4244.915101697964;4245.681573881956;4247.214265360903;4285.828566857337;4057.7159598828093;4164.7709375984305;4175.394567787654;4209.873703788891;4254.936175957363;4108.157827645326;4114.403411505315;4117.835286588533;4118.114605359832;4119.361498967664;4099.795010249505;4101.99501122224;4102.2410853992105;4105.096878686684;4145.79271036447;4433.778311084433;4448.599626033641;4472.105578884236;4501.774911254424;4517.796699148546;4858.951410485885;4859.5664279037765;4863.659543831933;4872.780724867354;4902.534259245366;4666.859994200179;4793.304970779218;4793.952060479385;4900.681455705368;4931.408231012266;4471.23988921884;4516.796744146522;4546.795394207203;4559.202139625619;4605.125026244969;4937.925931111036;4939.333190019373;4943.406791185081;4978.975105124524;4988.501149885055;4624.815007399734;4717.95282047182;4745.3593764842;4745.881352966204;4751.382320298409;4741.952580474152;4804.6876952997945;4815.903681926342;4823.782929768169;4863.3434486343895;4838.95161048392;4839.1531481991215;4839.443464001614;4844.636652251095;4847.660663753503;4623.352730617717;4735.431748190239;4739.573438390561;4817.181079216542;4853.9029219415415;3972.106276087915;4012.118071472737;4030.7783071931326;4064.04494943688;4073.0835561998315;3564.1624218308675;3592.191756854739;3598.586162591283;3616.8914932552066;3629.364861149288;4063.5733248009124;4167.499900011957;4172.624463798273;4199.496060472763;4255.765932873722;4842.225243960949;4879.4876537963;4896.4124305083615;4897.681650692693;4937.012597480519;4211.115665710174;4224.683148763855;4228.76741779199;4236.110416812442;4247.68142389322;4163.271427500175;4267.125239325931;4271.893202669959;4332.653387728974;4353.151135528605;4515.909681806345;4525.253333199985;4537.636989040803;4584.289435137559;4589.311603259471;4802.687825291345;4829.299751536078;4831.057943700945;4832.855014349575;4873.975630121827;4425.114977004548;4532.9093418132115;4597.057603191271;4600.861974140781;4633;4705.176594096088;4745.549172828576;4830.058138663067;4842.5157484251295;4894.045661096195;4794.352762377034;4796.832110876103;4821.590164836029;4832.734199619054;4864.73243971585;4513.074819662027;4630.328602352707;4684.648651351231;4686.133065382915;4692.319613656069;4656.953430465652;4667.299905014139;4721.079389519011;4740.051989602024;4778.450478195052;4641.18779213643;4659.790309436015;4661.510541393105;4669.579737823612;4707.741074240949;4584.954150458586;4703.341532185428;4785.688930219525;4809.110314591811;4824.8793780155775;4551.431071116111;4576.199165146019;4672.322513235494;4695.2487601984885;4734.313524538991 08:57:04 INFO - PROCESS | 15957 | |1;ext.html;493.3118299971542;507.55588859747724;509.63815690859485;520.2196704942586;531.1713726586524;24515;27366.179014629568;27449.90200391982;27482.999999999975;32599.348013039726;35382.053987030704;35887.46168807463;35910.2817943641;35921.64078359222;35971.64028359722;7536.660850261724;7659.885101723451;7694.076710794685;7695.307422332017;7698.769036928873;7068.540544864593;7235.240299768528;7548.358389536896;9723.513824308757;9964.402135871835;9619.80760384792;9744.464054477;9745.074217949283;9750.853737193947;9751.12239898409;7119.9288007119785;9576.569054392534;9698.903010969942;9706.272029597809;9709.514524273758;6996.250937265683;9543.952280238624;9754.317197796157;9769;9782.41305521671;32625.347493050005;33089.834550827094;33169;33234.50148247778;33238.6676133238;2474.653548503211;2531.9113831015825;2570.306017375317;2640.155150351888;2863.2698661841305;23902.880485597634;25401.87299063493;25904.611430828365;26673.09335930509;27774.3056423589;3071.43178511976;3098.984505077483;3111.595492585972;3157.700018498239;3214.903552893417;223998;224074;225011;225093;225226;39212.411813822815;44159.55840441555;45309.546904530536;50895.23657145146;52417.47582524202;47169.76415117971;47389.289160662614;47430.52569474261;47555.28667069997;47586.5241347589;10309.484525773682;10447.164226861833;10458.424786636808;10471.581136754445;10475.895241047645;8088.191180881865;8199.508029518249;8204.917950820416;8211.58942052895;8251.669933202606;17334.39329623457;17581.82418175802;17671.469855904343;17717.29130834778;17731.911340443214;6680.632565208863;6728.6635668216395;6863.073485079551;6868.325445886427;6939.30606939302;842.1031601344671;888.7022847346083;898.1333013641867;932.3520153493257;944.5843828715343;25281.367965801;25416.364590885005;26031.479370412486;26314.342141446617;26322;867.5662168915542;919.9816003679889;923.1348907309817;926.356182453202;933.5192375926404;13431.462741490426;13553.25457099869;13705.383257753425;13730.725385492235;13782.517611883737;271752;276446;277451;277509;277796;44375.55624443714;44810.32784508235;44820.55179448229;44821.327680084825;44885.32672009857;1069.2568664777905;1104.8729396119388;1106.9667909962714;1112.3881864974394;1117.2570240789946;22538.323850284516;23031.539369212856;23448.531029379657;23564.76435235626;23584.764152358945;35534.46698299579;36353.81823090868;39769;40259.19481610293;40292.3956140664;232535;235747;236994;237330;238065;22168.778312216673;23259.53480930338;23380.94785734612;23389.76610233876;23426.297211083696;35346.293074138885;35471.46792798162;36282.274354512236;36523.26953460969;36685.76342021809;30136.54795178118;30620.540691889193;31068.22329441782;31314.686853131177;31768;31299.530507041956;31461.8426907864;31769.523457148625;32779.836100819346;33107.834460827544;29543.409131817672;29695.406091878474;29805.701942980293;33074.17314567155;33150;25014;25867;26437.867810660824;26639.60243578087;28535.571966420935;22160.675858771458;22580.774192257868;22662.886685566467;22863.657045144668;22969.65545516852 08:57:04 INFO - PROCESS | 15957 | |2;jquery.html;314.41518775078356;315.2984609244431;318.1854452601342;320.6456865163994;326.041438171775;12212.51149954003;12695.11134220605;15206.467773627925;15622.531324060268;15761;12368.690782730413;12416.255024698525;12587.433565489551;12733.936330318358;12763.170393924389;4767.356406885078;4770.141374552571;4897.902041959159;4901.6078713703;4905.8773530661665;3725.4784330193793;3837.3860182370827;3837.9424308635253;3838.923221535568;4837.492063333352;5374.7850085996515;5538.723063846812;5546.889062218753;5549.556035517169;5560.332760068797;5377.7580008899695;5520.033994051045;5537.944620553783;5558.610897237195;5560;4813.181759100961;4846.806127754886;4855.295982082614;4865.586425153866;4870.318155458239;18377.632447351112;18749.437516874517;19128.904355478273;19195.52011199717;19228.615427691508;1781.3676144968479;1811.5018369948239;1816.1917946513674;1868.7570615819993;1915.52111972007;10553;12421.31682757448;12520.624381268577;12997.270573179643;13042.673933151653;1664.966700665992;1673.1216111541416;1710.9657806843918;1736.722124460093;1901.9619607607908;45948.310775338396;46173.53826461726;55147.72426137843;56028.71985640046;56595.43404565943;8904.376693631384;9182.219511341476;9193.218576420946;9204.723858284127;9318.627254909728;11984.400779960966;12151.696207594881;12155.392230388445;12157.696057598454;12159.878401216052;6317.178766760384;6325.177726895474;6336.873262534724;6374.713137908805;6385.169927909435;5749.051406517878;5772.191893134965;5819.970900145557;5831.708414579254;5862.618929769551;3998.2203470323007;4035.7780322082567;4038.2327357801923;4041.7372870763306;4065.6137666921595;1550.0854495847504;1583.794106766113;1648.4395305595915;1685.7050016247108;2546.7580579844885;742.9858243497587;763.9656215470317;819.9918000820035;840.2521755637488;863.887694599698;14387.208703521406;15459.149746764037;15705.607359816097;15925.761113583305;16030.519084427486;402.3722992132283;742.6546655804968;752.3755283115001;799.2447137455049;897.4256475855458;5354.7858085676135;5510.760078982197;5542.584306176972;5624;5674.2339784129435;493892;494759;502521;514356;516307;71067.28932710606;71246.64376678083;71336.64331678308;71439.28560714431;72193.6390318045;440.2098233670569;441.85639667107677;441.9292913133883;447.93728877957113;449.1645539296905;9456.810863782823;9548.809023819624;9582.520873956413;9795.706128816148;9837.409755414697;31730.524042138924;32384.190395240308;33157;33809.66190338164;34223.828880855435;42150.36774448447;42524.57475425206;43445.13109737724;43943.56056439395;46328.07343853171;8413.822064910795;8473.618687159216;8608.65565377378;8638.913610864063;8648.956755216184;9844.704658860246;9934.900650993397;11688.70778230517;14918.254087295809;15055;13029.804552931902;13173.670658233621;13240.139390939943;13339.933300333825;13534.390952407362;12489.93755031219;12609.747805043664;12961;13203.603891883258;13305.933470332586;12634.2419454833;12637.557685480964;12674.176178548734;12712.491500339884;13262.53581124656;8463;8489.660413583635;8491.405601608076;8492.278156356531;8673.956630216808;11303.378314192798;12642.367881605698;12650.367481626066;12898.67753306175;13239.536616218385 08:57:04 INFO - PROCESS | 15957 | |3;mootools.html;1084.3439718970023;1088.9128869690423;1143.7655280667464;1229.7970834812256;1264.981025284621;5620.8313750587495;6394.7761828336015;6504.869902601945;6519.1199188109595;6523.119378883849;6410.519211059166;6570.080188773563;6570.145881035471;6572.079908812758;6578.703958321875;1939.1467754188147;1979.1192919150983;1980.8217260446556;1981.2372236688834;1981.9990904593233;1983.9504012399734;2019.5456022394917;2029;2035.28764932274;2037.5313677854103;1979.910904009323;1986.612610540945;2021.0299056452911;2022.5954809038178;2023.4840115770457;1979.5051237190703;1995.2218634732467;1996.6206420780006;1997.820196182336;1998.8300994415492;1998.400479856052;1999.3102379678987;2004.5088953206412;2036.2364113457454;2037.246218899002;6596.769113081067;6675;6687.398134167948;6691.397774200345;6696.330366963313;3794.620537946211;3872.7289089763726;3898.571157172709;3899.7075219358376;3899.8635047773478;2543.923682289534;2568.8330258533138;2590.818642695012;2658.56133737933;2681.6379788728664;816.94281400302;832.5545832979327;844.0841686769862;880.8018195905934;881.6605606841413;9338.206252468548;9342.346035777498;9343.859842102374;9353.298502612332;9368.531573421302;3793.6775374093513;3799.2401519696173;3862.6909847212155;3873.5351757789244;3881.728279020498;8104.959475202586;8149.103598604149;8149.714759983491;8151.95924020388;8158.959205204054;3917.138229589486;3938.7439816411843;3940.822662980173;3942.6845852331744;3945.585713500041;2981.493146165157;3060.173753086654;3420.196253880336;3552.165241168375;3582.874599389061;3147.826869522198;3172.159377764894;3203.2952750394875;3211.2774625709494;3216.276337823971;972.1930797438109;974.6345120579782;982.29274922056;983.6753871222479;993.0268337029752;792.1088775127981;802.5545822068691;804.1355542791406;804.5293503300635;870.3428911172025;5954.37479064692;6125.632462052291;6128.233970753656;6141.662208578482;6146.78486252979;429.2659552165769;438.29215816456195;441.45259877752;442.2261043174445;444.944381952256;4723.881902952454;4805.7597120143855;4814.566688997937;4824.589909857701;4824.6863953842885;7842.176571460029;7911.960440197878;8038.115807261197;8072.152423995396;8109.472884262504;7921.36629069673;7978.082520510099;8007.359411247086;8018.398620103516;8031.397645176635;6032.638041717511;6136.7852125175405;6151.6001459904965;6176.413240742122;6199.969000154971;5940.821775346746;6025.548083893813;6032.4570788629235;6036.396360364104;6047.637141771508;7050.506464547638;7061.929380706332;7141.64291785419;7318.487705860539;7342.265773422829;7570.129435115033;7598.924010759822;7744.341730952932;7771.261730135628;7786.299233069051;4937.0372777308085;5019.447860735389;5851.502622277154;5935.9109613356695;5939.406059394026;6137.7851775187655;6202.255729312511;6221.5333849960525;6227.719752611234;6227.782027629011;5829.7085145743395;5832.941670583409;5947.524198064058;6006.789762358297;6105.603135796159;5706.514946229617;5832.795852145155;5875.853103672272;5911.261092363455;5942.524598032233;5933.910991335047;5953.880922381441;5969.432903874125;6035.577509574287;6118.20463339763;5550.69471179089;5579.6652200868075;5582.0231459495235;5586.720663966867;5587.497125258747;5539.916901246565;5594.38461769197;5613.270274864241;5616.0452723038;5617.831465056055 08:57:04 INFO - PROCESS | 15957 | |4;prototype.html;282.30552840013564;287.0899249379468;289.2493978126761;291.8380298934092;292.73215008267437;4874.6831455955335;5021.698698078118;5220.530152286294;5264.710440925753;5274.86812829679;5152.562032227256;5234.18870075138;5237.7381130943495;5246;5250.816221432241;4032.354823228284;4066.715329926906;4070.185962807443;4075.32757095079;4080.224757296119;3853.7495062820826;3918.5885482024405;3930.921381572367;4081.3061779497557;4085.754854708712;3959.1883663848985;3967.464392307045;3967.7420967637154;3968.5436174839974;3970.7816070116132;3941.743786653887;3947.8618248361313;3948.8815335539693;3952.2885880541635;3953.782541960191;3467.063892748969;3473.270613171237;3473.322702073097;3475.6176820549717;3479.7738147020614;4896.485868983741;4931.7040977541465;4958.950410495885;4959.8016079356785;4965.801367945278;4356.8257269709175;4529.388532548097;4533.297338912474;4533.727976321431;4534.773261336953;5398.2982212312145;5399.271098401744;5400.891982160374;5401.864953376197;5416.783328666848;3521.506989021539;3609.675129238381;3637.418013117888;3721.1255354991554;3723.925521489582;5645.266115405012;5695.886082278331;5712.82861514151;5722.227499287585;5724.169995350692;3855.6722678572073;3856.7300288980064;3856.9421458678144;3858.054776579756;3862.0731024553907;3895.220955808793;3905.7656540607086;3907.4138879168354;3914;3927.6857851371824;4440.888977775581;4530.88672783183;4532.6827122101795;4533.5013148553635;4536.432945881765;5467.043267428184;5468.507834294933;5473.890522189534;5475.288212532425;5479.287692599936;1351.8377794664702;1380.4064252371577;1380.5996261084374;1380.9585712428643;1381.1781989716103;907.0430695616056;910.981780364389;920.7145784806731;949.9050094990583;954.1698722111807;4840.903181936342;4843.39457567804;4845.781939812717;4848.8787780305065;4852.228936438245;5619.775208991595;5639.351474580476;5664.716764161775;5670.914936275959;5671.546276297886;4818.831340903052;4833.05755377698;4836.588889944394;4836.685615434985;4837.274408838703;2965.3920946205976;3021.531662592302;3043.3913217356176;3044.3150291184747;3051.908442746677;5379.1393377059485;5383.2194331821665;5392.272043274186;5415.783368665288;5445.50990410865;5805.071188609887;5819.912701309484;5824.88350232993;5826.388229235869;5828.154917536934;5392.730363481889;5444.210589464506;5445.945540544623;5447.618666693294;5450.454954504677;5492.80775172883;5647.181158732043;5659.292588426447;5664.85837854057;5665.376808550974;5333.546648534918;5527.53015993645;5529.419410961791;5535.474129957647;5542.251796007487;5329.760160792696;5341.65279256847;5344.331958505187;5345.957538279998;5350.956563470086;3712.461693054546;3782.8486860526373;3789.981050094732;3797.3544497436055;3799.6960243181034;5636.098224284095;5639.125935480007;5642.379338272869;5645.887082258249;5647.915281270702;5328.813491527778;5441.129419292894;5448.155535891943;5450.438294001813;5457.918131228114;5436.184572314026;5445.128779395278;5451.781928722807;5452.400235974119;5452.482014208644;5321.175217841241;5330.733463326741;5334.253204551288;5335.253064571041;5335.706536140549;5379.112446446449;5475.561955043508;5486.341639003345;5488.341399031982;5490.203920431595;5355.732213389393;5367.141257398797;5371.435999220025;5373.086575282133;5374.7581358839725 08:57:04 INFO - PROCESS | 15957 | |5;yui.html;566.388300635314;651.4267444648708;659.1200747002752;676.4149011105395;677.5460441504192;10712.303700259477;10891.618793342235;10894.945525272373;10898.400587967659;10922.29005114668;10702.46487675617;10858.294210876307;10861.076808471289;10892.836607450874;10988.175886808502;738.4683028219687;754.7018927523625;754.811297175706;754.9396048316122;755.0599503618004;741.5661837824879;750.3209595316248;751.2074761127009;751.4063889527267;752.5146280648978;782.4640121516779;787.5668382389663;791.5211297165218;792.3106896999618;792.6710415177695;787.0673252196137;787.4055088408215;787.7124849429916;788.424450151387;788.6372268756351;581.119603800243;581.4011568084837;581.4795757796791;581.5376775463517;582.1500609110703;9659;9747.61009559624;9763.121319081316;9803.166730827888;9846.359986600848;8686.39195256326;8740.213380795696;8830.955845220797;8935.910640893573;8945.105489451067;7936.563489008102;8119.106898241189;8141.389395795339;8146.470479418819;8223.712170074019;2769.612254284382;2912.2428168676083;2938.6620538638117;2963.6147300850753;3027.1523973287512;35119;35151.64848351509;36012.81993590015;36494.8175259122;38891.61108388908;8452.1547845215;8490.066092729794;8495.95752021236;8554;8648.654053837776;14925.402983880524;14940.551783446514;14965.476208332657;15003.924980375246;15011.174385408907;5155.226715992631;5310.548603368679;5311.601629877775;5353.732313384316;5511.53151982078;3188.0754581171664;3224.2584205632834;3251.886183983549;3297.7691561590937;3320.8007519548905;2761.6685997680406;2828.533292006837;2845.5731640254126;2846.3595690969364;2854.4861924853726;489.3540526504979;489.9099503604523;490.0493043495607;491.6533843640225;496.0302608400568;382.77798876651474;387.3647218561561;394.48913656814494;399.9940000899989;404.1049076296018;6432.2602900667025;6769.086173366532;6874.896876546856;7060.3292687194635;7080.752173674;397.95821438749095;453.4603821452461;462.9930551041737;465.68333533197074;473.44606810032343;3132.401557724062;3308.354870800171;3314.038928710647;3347.56481657383;3367.326534693071;46059.76970115128;46422.53577464182;46557.30164047542;46590.767046164554;48850;39341.213175736324;39539.01152471154;39724.80137599294;41019.58980410217;44175.116497669864;35080.649193507736;36103.27793444116;40186.39720404196;43267.78366108149;43982;7319;7670.348020418104;7810.726624568113;7814.921850781419;7978.880316795136;31487.84256078705;32069.518957215194;32152.839235803673;32384.14237864339;32969.340613188084;34400.311993760486;35909.28181436409;41782.164356712085;43751;44781.32828007648;8583;8990.190882820578;9143.679971200976;9367;9628.47043412619;10134.695959121238;10192.235582331206;10271.7432064199;10282.948585257025;10406.791864162524;9872.703818885446;9892.208623310262;9906.603735850485;10319.226058045526;10344.948275258877;10185.541650625592;10230.181585473294;10278.897211027794;10352;10524.36853788775;9272.119148680864;9579.185769209695;9582.185514231369;9599.184069354184;9651.758706032406;8427.325813934993;8444.282236010007;8494.36292278094;8511.191436813493;8555.529445880537;8411.116832732476;8529.402941794015;8592.742217733477;8597.613107410056;8598.441101328393 08:57:04 INFO - PROCESS | 15957 | __end_tp_report 08:57:04 INFO - PROCESS | 15957 | __start_cc_report 08:57:04 INFO - PROCESS | 15957 | _x_x_mozilla_cycle_collect,994 08:57:04 INFO - PROCESS | 15957 | __end_cc_report 08:57:04 INFO - PROCESS | 15957 | __startTimestamp1451926624709__endTimestamp 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | ------- Summary: start ------- 08:57:04 INFO - PROCESS | 15957 | Number of tests: 6 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#0] dojo.html Cycles:165 Average:4472.91 Median:4589.31 stddev:449.97 (9.8%) stddev-sans-first:426.16 08:57:04 INFO - PROCESS | 15957 | Values: 2580.7 2648.8 2687.0 2693.5 2712.5 4406.9 4555.5 4558.3 4569.6 4579.8 4497.6 4518.4 4540.7 4606.0 4624.4 4209.3 4213.4 4225.3 4280.4 4284.0 4211.3 4244.9 4245.7 4247.2 4285.8 4057.7 4164.8 4175.4 4209.9 4254.9 4108.2 4114.4 4117.8 4118.1 4119.4 4099.8 4102.0 4102.2 4105.1 4145.8 4433.8 4448.6 4472.1 4501.8 4517.8 4859.0 4859.6 4863.7 4872.8 4902.5 4666.9 4793.3 4794.0 4900.7 4931.4 4471.2 4516.8 4546.8 4559.2 4605.1 4937.9 4939.3 4943.4 4979.0 4988.5 4624.8 4718.0 4745.4 4745.9 4751.4 4742.0 4804.7 4815.9 4823.8 4863.3 4839.0 4839.2 4839.4 4844.6 4847.7 4623.4 4735.4 4739.6 4817.2 4853.9 3972.1 4012.1 4030.8 4064.0 4073.1 3564.2 3592.2 3598.6 3616.9 3629.4 4063.6 4167.5 4172.6 4199.5 4255.8 4842.2 4879.5 4896.4 4897.7 4937.0 4211.1 4224.7 4228.8 4236.1 4247.7 4163.3 4267.1 4271.9 4332.7 4353.2 4515.9 4525.3 4537.6 4584.3 4589.3 4802.7 4829.3 4831.1 4832.9 4874.0 4425.1 4532.9 4597.1 4600.9 4633.0 4705.2 4745.5 4830.1 4842.5 4894.0 4794.4 4796.8 4821.6 4832.7 4864.7 4513.1 4630.3 4684.6 4686.1 4692.3 4657.0 4667.3 4721.1 4740.1 4778.5 4641.2 4659.8 4661.5 4669.6 4707.7 4585.0 4703.3 4785.7 4809.1 4824.9 4551.4 4576.2 4672.3 4695.2 4734.3 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#1] ext.html Cycles:180 Average:38837.70 Median:32612.35 stddev:64367.42 (197.4%) stddev-sans-first:64483.60 08:57:04 INFO - PROCESS | 15957 | Values: 493.3 507.6 509.6 520.2 531.2 24515.0 27366.2 27449.9 27483.0 32599.3 35382.1 35887.5 35910.3 35921.6 35971.6 7536.7 7659.9 7694.1 7695.3 7698.8 7068.5 7235.2 7548.4 9723.5 9964.4 9619.8 9744.5 9745.1 9750.9 9751.1 7119.9 9576.6 9698.9 9706.3 9709.5 6996.3 9544.0 9754.3 9769.0 9782.4 32625.3 33089.8 33169.0 33234.5 33238.7 2474.7 2531.9 2570.3 2640.2 2863.3 23902.9 25401.9 25904.6 26673.1 27774.3 3071.4 3099.0 3111.6 3157.7 3214.9 223998.0 224074.0 225011.0 225093.0 225226.0 39212.4 44159.6 45309.5 50895.2 52417.5 47169.8 47389.3 47430.5 47555.3 47586.5 10309.5 10447.2 10458.4 10471.6 10475.9 8088.2 8199.5 8204.9 8211.6 8251.7 17334.4 17581.8 17671.5 17717.3 17731.9 6680.6 6728.7 6863.1 6868.3 6939.3 842.1 888.7 898.1 932.4 944.6 25281.4 25416.4 26031.5 26314.3 26322.0 867.6 920.0 923.1 926.4 933.5 13431.5 13553.3 13705.4 13730.7 13782.5 271752.0 276446.0 277451.0 277509.0 277796.0 44375.6 44810.3 44820.6 44821.3 44885.3 1069.3 1104.9 1107.0 1112.4 1117.3 22538.3 23031.5 23448.5 23564.8 23584.8 35534.5 36353.8 39769.0 40259.2 40292.4 232535.0 235747.0 236994.0 237330.0 238065.0 22168.8 23259.5 23380.9 23389.8 23426.3 35346.3 35471.5 36282.3 36523.3 36685.8 30136.5 30620.5 31068.2 31314.7 31768.0 31299.5 31461.8 31769.5 32779.8 33107.8 29543.4 29695.4 29805.7 33074.2 33150.0 25014.0 25867.0 26437.9 26639.6 28535.6 22160.7 22580.8 22662.9 22863.7 22969.7 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#2] jquery.html Cycles:180 Average:26225.03 Median:43694.35 stddev:82424.02 (188.6%) stddev-sans-first:82632.28 08:57:04 INFO - PROCESS | 15957 | Values: 314.4 315.3 318.2 320.6 326.0 12212.5 12695.1 15206.5 15622.5 15761.0 12368.7 12416.3 12587.4 12733.9 12763.2 4767.4 4770.1 4897.9 4901.6 4905.9 3725.5 3837.4 3837.9 3838.9 4837.5 5374.8 5538.7 5546.9 5549.6 5560.3 5377.8 5520.0 5537.9 5558.6 5560.0 4813.2 4846.8 4855.3 4865.6 4870.3 18377.6 18749.4 19128.9 19195.5 19228.6 1781.4 1811.5 1816.2 1868.8 1915.5 10553.0 12421.3 12520.6 12997.3 13042.7 1665.0 1673.1 1711.0 1736.7 1902.0 45948.3 46173.5 55147.7 56028.7 56595.4 8904.4 9182.2 9193.2 9204.7 9318.6 11984.4 12151.7 12155.4 12157.7 12159.9 6317.2 6325.2 6336.9 6374.7 6385.2 5749.1 5772.2 5820.0 5831.7 5862.6 3998.2 4035.8 4038.2 4041.7 4065.6 1550.1 1583.8 1648.4 1685.7 2546.8 743.0 764.0 820.0 840.3 863.9 14387.2 15459.1 15705.6 15925.8 16030.5 402.4 742.7 752.4 799.2 897.4 5354.8 5510.8 5542.6 5624.0 5674.2 493892.0 494759.0 502521.0 514356.0 516307.0 71067.3 71246.6 71336.6 71439.3 72193.6 440.2 441.9 441.9 447.9 449.2 9456.8 9548.8 9582.5 9795.7 9837.4 31730.5 32384.2 33157.0 33809.7 34223.8 42150.4 42524.6 43445.1 43943.6 46328.1 8413.8 8473.6 8608.7 8638.9 8649.0 9844.7 9934.9 11688.7 14918.3 15055.0 13029.8 13173.7 13240.1 13339.9 13534.4 12489.9 12609.7 12961.0 13203.6 13305.9 12634.2 12637.6 12674.2 12712.5 13262.5 8463.0 8489.7 8491.4 8492.3 8674.0 11303.4 12642.4 12650.4 12898.7 13239.5 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#3] mootools.html Cycles:180 Average:4629.84 Median:5934.91 stddev:2460.40 (41.5%) stddev-sans-first:2452.86 08:57:04 INFO - PROCESS | 15957 | Values: 1084.3 1088.9 1143.8 1229.8 1265.0 5620.8 6394.8 6504.9 6519.1 6523.1 6410.5 6570.1 6570.1 6572.1 6578.7 1939.1 1979.1 1980.8 1981.2 1982.0 1984.0 2019.5 2029.0 2035.3 2037.5 1979.9 1986.6 2021.0 2022.6 2023.5 1979.5 1995.2 1996.6 1997.8 1998.8 1998.4 1999.3 2004.5 2036.2 2037.2 6596.8 6675.0 6687.4 6691.4 6696.3 3794.6 3872.7 3898.6 3899.7 3899.9 2543.9 2568.8 2590.8 2658.6 2681.6 816.9 832.6 844.1 880.8 881.7 9338.2 9342.3 9343.9 9353.3 9368.5 3793.7 3799.2 3862.7 3873.5 3881.7 8105.0 8149.1 8149.7 8152.0 8159.0 3917.1 3938.7 3940.8 3942.7 3945.6 2981.5 3060.2 3420.2 3552.2 3582.9 3147.8 3172.2 3203.3 3211.3 3216.3 972.2 974.6 982.3 983.7 993.0 792.1 802.6 804.1 804.5 870.3 5954.4 6125.6 6128.2 6141.7 6146.8 429.3 438.3 441.5 442.2 444.9 4723.9 4805.8 4814.6 4824.6 4824.7 7842.2 7912.0 8038.1 8072.2 8109.5 7921.4 7978.1 8007.4 8018.4 8031.4 6032.6 6136.8 6151.6 6176.4 6200.0 5940.8 6025.5 6032.5 6036.4 6047.6 7050.5 7061.9 7141.6 7318.5 7342.3 7570.1 7598.9 7744.3 7771.3 7786.3 4937.0 5019.4 5851.5 5935.9 5939.4 6137.8 6202.3 6221.5 6227.7 6227.8 5829.7 5832.9 5947.5 6006.8 6105.6 5706.5 5832.8 5875.9 5911.3 5942.5 5933.9 5953.9 5969.4 6035.6 6118.2 5550.7 5579.7 5582.0 5586.7 5587.5 5539.9 5594.4 5613.3 5616.0 5617.8 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#4] prototype.html Cycles:180 Average:4507.04 Median:5241.87 stddev:1340.61 (25.6%) stddev-sans-first:1306.33 08:57:04 INFO - PROCESS | 15957 | Values: 282.3 287.1 289.2 291.8 292.7 4874.7 5021.7 5220.5 5264.7 5274.9 5152.6 5234.2 5237.7 5246.0 5250.8 4032.4 4066.7 4070.2 4075.3 4080.2 3853.7 3918.6 3930.9 4081.3 4085.8 3959.2 3967.5 3967.7 3968.5 3970.8 3941.7 3947.9 3948.9 3952.3 3953.8 3467.1 3473.3 3473.3 3475.6 3479.8 4896.5 4931.7 4959.0 4959.8 4965.8 4356.8 4529.4 4533.3 4533.7 4534.8 5398.3 5399.3 5400.9 5401.9 5416.8 3521.5 3609.7 3637.4 3721.1 3723.9 5645.3 5695.9 5712.8 5722.2 5724.2 3855.7 3856.7 3856.9 3858.1 3862.1 3895.2 3905.8 3907.4 3914.0 3927.7 4440.9 4530.9 4532.7 4533.5 4536.4 5467.0 5468.5 5473.9 5475.3 5479.3 1351.8 1380.4 1380.6 1381.0 1381.2 907.0 911.0 920.7 949.9 954.2 4840.9 4843.4 4845.8 4848.9 4852.2 5619.8 5639.4 5664.7 5670.9 5671.5 4818.8 4833.1 4836.6 4836.7 4837.3 2965.4 3021.5 3043.4 3044.3 3051.9 5379.1 5383.2 5392.3 5415.8 5445.5 5805.1 5819.9 5824.9 5826.4 5828.2 5392.7 5444.2 5445.9 5447.6 5450.5 5492.8 5647.2 5659.3 5664.9 5665.4 5333.5 5527.5 5529.4 5535.5 5542.3 5329.8 5341.7 5344.3 5346.0 5351.0 3712.5 3782.8 3790.0 3797.4 3799.7 5636.1 5639.1 5642.4 5645.9 5647.9 5328.8 5441.1 5448.2 5450.4 5457.9 5436.2 5445.1 5451.8 5452.4 5452.5 5321.2 5330.7 5334.3 5335.3 5335.7 5379.1 5475.6 5486.3 5488.3 5490.2 5355.7 5367.1 5371.4 5373.1 5374.8 08:57:04 INFO - PROCESS | 15957 | 08:57:04 INFO - PROCESS | 15957 | [#5] yui.html Cycles:180 Average:11448.94 Median:493.84 stddev:13272.06 (2687.5%) stddev-sans-first:13284.13 08:57:04 INFO - PROCESS | 15957 | Values: 566.4 651.4 659.1 676.4 677.5 10712.3 10891.6 10894.9 10898.4 10922.3 10702.5 10858.3 10861.1 10892.8 10988.2 738.5 754.7 754.8 754.9 755.1 741.6 750.3 751.2 751.4 752.5 782.5 787.6 791.5 792.3 792.7 787.1 787.4 787.7 788.4 788.6 581.1 581.4 581.5 581.5 582.2 9659.0 9747.6 9763.1 9803.2 9846.4 8686.4 8740.2 8831.0 8935.9 8945.1 7936.6 8119.1 8141.4 8146.5 8223.7 2769.6 2912.2 2938.7 2963.6 3027.2 35119.0 35151.6 36012.8 36494.8 38891.6 8452.2 8490.1 8496.0 8554.0 8648.7 14925.4 14940.6 14965.5 15003.9 15011.2 5155.2 5310.5 5311.6 5353.7 5511.5 3188.1 3224.3 3251.9 3297.8 3320.8 2761.7 2828.5 2845.6 2846.4 2854.5 489.4 489.9 490.0 491.7 496.0 382.8 387.4 394.5 400.0 404.1 6432.3 6769.1 6874.9 7060.3 7080.8 398.0 453.5 463.0 465.7 473.4 3132.4 3308.4 3314.0 3347.6 3367.3 46059.8 46422.5 46557.3 46590.8 48850.0 39341.2 39539.0 39724.8 41019.6 44175.1 35080.6 36103.3 40186.4 43267.8 43982.0 7319.0 7670.3 7810.7 7814.9 7978.9 31487.8 32069.5 32152.8 32384.1 32969.3 34400.3 35909.3 41782.2 43751.0 44781.3 8583.0 8990.2 9143.7 9367.0 9628.5 10134.7 10192.2 10271.7 10282.9 10406.8 9872.7 9892.2 9906.6 10319.2 10344.9 10185.5 10230.2 10278.9 10352.0 10524.4 9272.1 9579.2 9582.2 9599.2 9651.8 8427.3 8444.3 8494.4 8511.2 8555.5 8411.1 8529.4 8592.7 8597.6 8598.4 08:57:04 INFO - PROCESS | 15957 | -------- Summary: end -------- 08:57:04 INFO - PROCESS | 15957 | 08:57:05 INFO - TEST-INFO | 15957: exit 0 08:57:05 INFO - TEST-OK | dromaeo_css | took 1117217ms 08:57:05 INFO - TEST-START | kraken 08:57:05 INFO - operating with platform_type : linux_ 08:57:05 INFO - Initialising browser for kraken test... 08:57:05 INFO - TEST-INFO | started process 16144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNivqi/profile http://localhost:59263/getInfo.html) 08:57:10 INFO - PROCESS | 16144 | __metrics Screen width/height:1600/1200 08:57:10 INFO - PROCESS | 16144 | colorDepth:24 08:57:10 INFO - PROCESS | 16144 | Browser inner width/height: 1024/697 08:57:10 INFO - PROCESS | 16144 | __metrics 08:57:10 INFO - PROCESS | 16144 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:57:10 INFO - PROCESS | 16144 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:11 INFO - TEST-INFO | 16144: exit 0 08:57:11 INFO - Browser initialized. 08:57:11 INFO - Running cycle 1/1 for kraken test... 08:57:11 INFO - TEST-INFO | started process 16227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNivqi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:23 INFO - PROCESS | 16227 | RSS: Main: 150032384 08:57:23 INFO - PROCESS | 16227 | 08:57:25 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59263/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:26 INFO - PROCESS | 16227 | RSS: Main: 186060800 08:57:26 INFO - PROCESS | 16227 | 08:57:29 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59263/tests/kraken/driver.html?testName=audio-dft) 08:57:29 INFO - PROCESS | 16227 | RSS: Main: 176644096 08:57:29 INFO - PROCESS | 16227 | 08:57:32 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59263/tests/kraken/driver.html?testName=audio-fft) 08:57:33 INFO - PROCESS | 16227 | RSS: Main: 162283520 08:57:33 INFO - PROCESS | 16227 | 08:57:35 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59263/tests/kraken/driver.html?testName=audio-oscillator) 08:57:35 INFO - PROCESS | 16227 | RSS: Main: 162582528 08:57:35 INFO - PROCESS | 16227 | 08:57:38 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:38 INFO - PROCESS | 16227 | RSS: Main: 164593664 08:57:38 INFO - PROCESS | 16227 | 08:57:41 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59263/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:42 INFO - PROCESS | 16227 | RSS: Main: 164540416 08:57:42 INFO - PROCESS | 16227 | 08:57:45 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59263/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:46 INFO - PROCESS | 16227 | RSS: Main: 167002112 08:57:46 INFO - PROCESS | 16227 | 08:57:49 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59263/tests/kraken/driver.html?testName=json-parse-financial) 08:57:49 INFO - PROCESS | 16227 | RSS: Main: 166055936 08:57:49 INFO - PROCESS | 16227 | 08:57:51 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:52 INFO - PROCESS | 16227 | RSS: Main: 174100480 08:57:52 INFO - PROCESS | 16227 | 08:57:54 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:54 INFO - PROCESS | 16227 | RSS: Main: 172449792 08:57:54 INFO - PROCESS | 16227 | 08:57:56 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:57 INFO - PROCESS | 16227 | RSS: Main: 185516032 08:57:57 INFO - PROCESS | 16227 | 08:57:59 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:00 INFO - PROCESS | 16227 | RSS: Main: 189681664 08:58:00 INFO - PROCESS | 16227 | 08:58:03 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:03 INFO - PROCESS | 16227 | RSS: Main: 187981824 08:58:03 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | Cycle 1(1): loaded http://localhost:59263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59263/tests/kraken/driver.html?testName=ai-astar) 08:58:05 INFO - PROCESS | 16227 | RSS: Main: 244129792 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | __start_tp_report 08:58:05 INFO - PROCESS | 16227 | _x_x_mozilla_page_load 08:58:05 INFO - PROCESS | 16227 | _x_x_mozilla_page_load_details 08:58:05 INFO - PROCESS | 16227 | |i|pagename|runs| 08:58:05 INFO - PROCESS | 16227 | |0;ai-astar;111;113;108;113;113;114;104;113;113;119 08:58:05 INFO - PROCESS | 16227 | |1;audio-beat-detection;155;131;158;166;138;157;153;142;173;134 08:58:05 INFO - PROCESS | 16227 | |2;audio-dft;161;161;161;162;161;161;162;163;163;163 08:58:05 INFO - PROCESS | 16227 | |3;audio-fft;72;72;86;91;74;73;73;113;90;75 08:58:05 INFO - PROCESS | 16227 | |4;audio-oscillator;98;99;142;100;99;99;131;99;99;133 08:58:05 INFO - PROCESS | 16227 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;110;109;111 08:58:05 INFO - PROCESS | 16227 | |6;imaging-darkroom;147;148;149;148;149;147;149;147;147;147 08:58:05 INFO - PROCESS | 16227 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;96;95 08:58:05 INFO - PROCESS | 16227 | |8;json-parse-financial;73;72;73;72;72;71;72;80;69;69 08:58:05 INFO - PROCESS | 16227 | |9;json-stringify-tinderbox;66;66;66;67;66;70;67;66;67;66 08:58:05 INFO - PROCESS | 16227 | |10;stanford-crypto-aes;85;86;85;85;84;91;85;85;86;85 08:58:05 INFO - PROCESS | 16227 | |11;stanford-crypto-ccm;122;141;124;119;129;122;131;129;121;120 08:58:05 INFO - PROCESS | 16227 | |12;stanford-crypto-pbkdf2;136;149;148;146;150;142;149;149;149;140 08:58:05 INFO - PROCESS | 16227 | |13;stanford-crypto-sha256-iterative;71;72;73;71;72;72;70;71;71;70 08:58:05 INFO - PROCESS | 16227 | __end_tp_report 08:58:05 INFO - PROCESS | 16227 | __start_cc_report 08:58:05 INFO - PROCESS | 16227 | _x_x_mozilla_cycle_collect,987 08:58:05 INFO - PROCESS | 16227 | __end_cc_report 08:58:05 INFO - PROCESS | 16227 | __startTimestamp1451926685700__endTimestamp 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | ------- Summary: start ------- 08:58:05 INFO - PROCESS | 16227 | Number of tests: 14 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.93 (3.5%) stddev-sans-first:4.15 08:58:05 INFO - PROCESS | 16227 | Values: 111.0 113.0 108.0 113.0 113.0 114.0 104.0 113.0 113.0 119.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.00 stddev:13.95 (8.9%) stddev-sans-first:14.71 08:58:05 INFO - PROCESS | 16227 | Values: 155.0 131.0 158.0 166.0 138.0 157.0 153.0 142.0 173.0 134.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:58:05 INFO - PROCESS | 16227 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 162.0 163.0 163.0 163.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:13.32 (17.9%) stddev-sans-first:13.64 08:58:05 INFO - PROCESS | 16227 | Values: 72.0 72.0 86.0 91.0 74.0 73.0 73.0 113.0 90.0 75.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:99.00 stddev:17.77 (18.0%) stddev-sans-first:18.32 08:58:05 INFO - PROCESS | 16227 | Values: 98.0 99.0 142.0 100.0 99.0 99.0 131.0 99.0 99.0 133.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:58:05 INFO - PROCESS | 16227 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 111.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:58:05 INFO - PROCESS | 16227 | Values: 147.0 148.0 149.0 148.0 149.0 147.0 149.0 147.0 147.0 147.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:58:05 INFO - PROCESS | 16227 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:3.06 (4.2%) stddev-sans-first:3.23 08:58:05 INFO - PROCESS | 16227 | Values: 73.0 72.0 73.0 72.0 72.0 71.0 72.0 80.0 69.0 69.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 08:58:05 INFO - PROCESS | 16227 | Values: 66.0 66.0 66.0 67.0 66.0 70.0 67.0 66.0 67.0 66.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:1.95 (2.3%) stddev-sans-first:2.05 08:58:05 INFO - PROCESS | 16227 | Values: 85.0 86.0 85.0 85.0 84.0 91.0 85.0 85.0 86.0 85.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:6.78 (5.4%) stddev-sans-first:7.05 08:58:05 INFO - PROCESS | 16227 | Values: 122.0 141.0 124.0 119.0 129.0 122.0 131.0 129.0 121.0 120.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:149.00 stddev:4.80 (3.2%) stddev-sans-first:3.55 08:58:05 INFO - PROCESS | 16227 | Values: 136.0 149.0 148.0 146.0 150.0 142.0 149.0 149.0 149.0 140.0 08:58:05 INFO - PROCESS | 16227 | 08:58:05 INFO - PROCESS | 16227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:0.95 (1.3%) stddev-sans-first:1.00 08:58:05 INFO - PROCESS | 16227 | Values: 71.0 72.0 73.0 71.0 72.0 72.0 70.0 71.0 71.0 70.0 08:58:05 INFO - PROCESS | 16227 | -------- Summary: end -------- 08:58:05 INFO - PROCESS | 16227 | 08:58:06 INFO - TEST-INFO | 16227: exit 0 08:58:06 INFO - TEST-OK | kraken | took 61149ms 08:58:06 INFO - TEST-START | v8_7 08:58:06 INFO - operating with platform_type : linux_ 08:58:06 INFO - Initialising browser for v8_7 test... 08:58:06 INFO - TEST-INFO | started process 16474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFimyR/profile http://localhost:59263/getInfo.html) 08:58:10 INFO - PROCESS | 16474 | __metrics Screen width/height:1600/1200 08:58:10 INFO - PROCESS | 16474 | colorDepth:24 08:58:10 INFO - PROCESS | 16474 | Browser inner width/height: 1024/697 08:58:10 INFO - PROCESS | 16474 | __metrics 08:58:11 INFO - PROCESS | 16474 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:58:11 INFO - PROCESS | 16474 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:12 INFO - TEST-INFO | 16474: exit 0 08:58:12 INFO - Browser initialized. 08:58:12 INFO - Running cycle 1/1 for v8_7 test... 08:58:12 INFO - TEST-INFO | started process 16556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFimyR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:24 INFO - PROCESS | 16556 | RSS: Main: 150020096 08:58:24 INFO - PROCESS | 16556 | 08:58:45 INFO - PROCESS | 16556 | Cycle 1(1): loaded http://localhost:59263/tests/v8_7/run.html (next: http://localhost:59263/tests/v8_7/run.html) 08:58:46 INFO - PROCESS | 16556 | RSS: Main: 448782336 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | __start_tp_report 08:58:46 INFO - PROCESS | 16556 | _x_x_mozilla_page_load 08:58:46 INFO - PROCESS | 16556 | _x_x_mozilla_page_load_details 08:58:46 INFO - PROCESS | 16556 | |i|pagename|runs| 08:58:46 INFO - PROCESS | 16556 | |0;Richards;169.7792869269949 08:58:46 INFO - PROCESS | 16556 | |1;DeltaBlue;193.4984520123839 08:58:46 INFO - PROCESS | 16556 | |2;Encrypt;281.6901408450704 08:58:46 INFO - PROCESS | 16556 | |3;Decrypt;5240.837696335078 08:58:46 INFO - PROCESS | 16556 | |4;RayTrace;1990.0596421471173 08:58:46 INFO - PROCESS | 16556 | |5;Earley;814.9959250203749 08:58:46 INFO - PROCESS | 16556 | |6;Boyer;12011.904761904761 08:58:46 INFO - PROCESS | 16556 | |7;RegExp;26868.42105263158 08:58:46 INFO - PROCESS | 16556 | |8;Splay;625.3908692933084 08:58:46 INFO - PROCESS | 16556 | |9;NavierStokes;4830.917874396136 08:58:46 INFO - PROCESS | 16556 | __end_tp_report 08:58:46 INFO - PROCESS | 16556 | __startTimestamp1451926726013__endTimestamp 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | ------- Summary: start ------- 08:58:46 INFO - PROCESS | 16556 | Number of tests: 10 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#0] Richards Cycles:1 Average:169.78 Median:169.78 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 169.8 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#1] DeltaBlue Cycles:1 Average:193.50 Median:193.50 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 193.5 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#2] Encrypt Cycles:1 Average:281.69 Median:281.69 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 281.7 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 5240.8 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 1990.1 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#5] Earley Cycles:1 Average:815.00 Median:815.00 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 815.0 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 12011.9 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 26868.4 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#8] Splay Cycles:1 Average:625.39 Median:625.39 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 625.4 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - PROCESS | 16556 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:58:46 INFO - PROCESS | 16556 | Values: 4830.9 08:58:46 INFO - PROCESS | 16556 | -------- Summary: end -------- 08:58:46 INFO - PROCESS | 16556 | 08:58:46 INFO - TEST-INFO | 16556: exit 0 08:58:46 INFO - TEST-OK | v8_7 | took 40303ms 08:58:46 INFO - SUITE-END | took 1218s 08:58:47 INFO - Completed test suite (00:20:18) 08:58:47 INFO - Working with test: dromaeo_css 08:58:47 INFO - Generating results file: dromaeo_css 08:58:47 INFO - Working with test: kraken 08:58:47 INFO - Generating results file: kraken 08:58:47 INFO - javascript benchmark 08:58:47 INFO - Working with test: v8_7 08:58:47 INFO - Generating results file: v8_7 08:58:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:58:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:58:47 INFO - process_Request line: dromaeo_css 5897.79 graph.html#tests=[[72,132,35]] 08:58:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:58:47 INFO - process_Request line: kraken 1536.80 graph.html#tests=[[232,132,35]] 08:58:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:58:47 INFO - process_Request line: v8_7 19540.86 graph.html#tests=[[230,132,35]] 08:58:47 INFO - RETURN: dromaeo_css: 5897.79 08:58:47 INFO - RETURN: kraken: 1536.80 08:58:47 INFO - RETURN: v8_7: 19540.86 08:58:47 INFO - javascript benchmark 08:58:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.651612032376, 2648.841069535828, 2687.0, 2693.501702185096, 2712.538868392373, 4406.889827754308, 4555.453345598533, 4558.293464512997, 4569.5887370136725, 4579.793909274083, 4497.550244975509, 4518.367428560005, 4540.682152249344, 4606.032733126048, 4624.375709279247, 4209.284421648312, 4213.4101225828335, 4225.345071513921, 4280.4221430106845, 4284.036091879318, 4211.263028969934, 4244.915101697964, 4245.681573881956, 4247.214265360903, 4285.828566857337, 4057.7159598828093, 4164.7709375984305, 4175.394567787654, 4209.873703788891, 4254.936175957363, 4108.157827645326, 4114.403411505315, 4117.835286588533, 4118.114605359832, 4119.361498967664, 4099.795010249505, 4101.99501122224, 4102.2410853992105, 4105.096878686684, 4145.79271036447, 4433.778311084433, 4448.599626033641, 4472.105578884236, 4501.774911254424, 4517.796699148546, 4858.951410485885, 4859.5664279037765, 4863.659543831933, 4872.780724867354, 4902.534259245366, 4666.859994200179, 4793.304970779218, 4793.952060479385, 4900.681455705368, 4931.408231012266, 4471.23988921884, 4516.796744146522, 4546.795394207203, 4559.202139625619, 4605.125026244969, 4937.925931111036, 4939.333190019373, 4943.406791185081, 4978.975105124524, 4988.501149885055, 4624.815007399734, 4717.95282047182, 4745.3593764842, 4745.881352966204, 4751.382320298409, 4741.952580474152, 4804.6876952997945, 4815.903681926342, 4823.782929768169, 4863.3434486343895, 4838.95161048392, 4839.1531481991215, 4839.443464001614, 4844.636652251095, 4847.660663753503, 4623.352730617717, 4735.431748190239, 4739.573438390561, 4817.181079216542, 4853.9029219415415, 3972.106276087915, 4012.118071472737, 4030.7783071931326, 4064.04494943688, 4073.0835561998315, 3564.1624218308675, 3592.191756854739, 3598.586162591283, 3616.8914932552066, 3629.364861149288, 4063.5733248009124, 4167.499900011957, 4172.624463798273, 4199.496060472763, 4255.765932873722, 4842.225243960949, 4879.4876537963, 4896.4124305083615, 4897.681650692693, 4937.012597480519, 4211.115665710174, 4224.683148763855, 4228.76741779199, 4236.110416812442, 4247.68142389322, 4163.271427500175, 4267.125239325931, 4271.893202669959, 4332.653387728974, 4353.151135528605, 4515.909681806345, 4525.253333199985, 4537.636989040803, 4584.289435137559, 4589.311603259471, 4802.687825291345, 4829.299751536078, 4831.057943700945, 4832.855014349575, 4873.975630121827, 4425.114977004548, 4532.9093418132115, 4597.057603191271, 4600.861974140781, 4633.0, 4705.176594096088, 4745.549172828576, 4830.058138663067, 4842.5157484251295, 4894.045661096195, 4794.352762377034, 4796.832110876103, 4821.590164836029, 4832.734199619054, 4864.73243971585, 4513.074819662027, 4630.328602352707, 4684.648651351231, 4686.133065382915, 4692.319613656069, 4656.953430465652, 4667.299905014139, 4721.079389519011, 4740.051989602024, 4778.450478195052, 4641.18779213643, 4659.790309436015, 4661.510541393105, 4669.579737823612, 4707.741074240949, 4584.954150458586, 4703.341532185428, 4785.688930219525, 4809.110314591811, 4824.8793780155775, 4551.431071116111, 4576.199165146019, 4672.322513235494, 4695.2487601984885, 4734.313524538991], "unit": "score", "name": "dojo.html", "value": 4446.177379893664}, {"lowerIsBetter": false, "replicates": [493.3118299971542, 507.55588859747724, 509.63815690859485, 520.2196704942586, 531.1713726586524, 24515.0, 27366.179014629568, 27449.90200391982, 27482.999999999975, 32599.348013039726, 35382.053987030704, 35887.46168807463, 35910.2817943641, 35921.64078359222, 35971.64028359722, 7536.660850261724, 7659.885101723451, 7694.076710794685, 7695.307422332017, 7698.769036928873, 7068.540544864593, 7235.240299768528, 7548.358389536896, 9723.513824308757, 9964.402135871835, 9619.80760384792, 9744.464054477, 9745.074217949283, 9750.853737193947, 9751.12239898409, 7119.9288007119785, 9576.569054392534, 9698.903010969942, 9706.272029597809, 9709.514524273758, 6996.250937265683, 9543.952280238624, 9754.317197796157, 9769.0, 9782.41305521671, 32625.347493050005, 33089.834550827094, 33169.0, 33234.50148247778, 33238.6676133238, 2474.653548503211, 2531.9113831015825, 2570.306017375317, 2640.155150351888, 2863.2698661841305, 23902.880485597634, 25401.87299063493, 25904.611430828365, 26673.09335930509, 27774.3056423589, 3071.43178511976, 3098.984505077483, 3111.595492585972, 3157.700018498239, 3214.903552893417, 223998.0, 224074.0, 225011.0, 225093.0, 225226.0, 39212.411813822815, 44159.55840441555, 45309.546904530536, 50895.23657145146, 52417.47582524202, 47169.76415117971, 47389.289160662614, 47430.52569474261, 47555.28667069997, 47586.5241347589, 10309.484525773682, 10447.164226861833, 10458.424786636808, 10471.581136754445, 10475.895241047645, 8088.191180881865, 8199.508029518249, 8204.917950820416, 8211.58942052895, 8251.669933202606, 17334.39329623457, 17581.82418175802, 17671.469855904343, 17717.29130834778, 17731.911340443214, 6680.632565208863, 6728.6635668216395, 6863.073485079551, 6868.325445886427, 6939.30606939302, 842.1031601344671, 888.7022847346083, 898.1333013641867, 932.3520153493257, 944.5843828715343, 25281.367965801, 25416.364590885005, 26031.479370412486, 26314.342141446617, 26322.0, 867.5662168915542, 919.9816003679889, 923.1348907309817, 926.356182453202, 933.5192375926404, 13431.462741490426, 13553.25457099869, 13705.383257753425, 13730.725385492235, 13782.517611883737, 271752.0, 276446.0, 277451.0, 277509.0, 277796.0, 44375.55624443714, 44810.32784508235, 44820.55179448229, 44821.327680084825, 44885.32672009857, 1069.2568664777905, 1104.8729396119388, 1106.9667909962714, 1112.3881864974394, 1117.2570240789946, 22538.323850284516, 23031.539369212856, 23448.531029379657, 23564.76435235626, 23584.764152358945, 35534.46698299579, 36353.81823090868, 39769.0, 40259.19481610293, 40292.3956140664, 232535.0, 235747.0, 236994.0, 237330.0, 238065.0, 22168.778312216673, 23259.53480930338, 23380.94785734612, 23389.76610233876, 23426.297211083696, 35346.293074138885, 35471.46792798162, 36282.274354512236, 36523.26953460969, 36685.76342021809, 30136.54795178118, 30620.540691889193, 31068.22329441782, 31314.686853131177, 31768.0, 31299.530507041956, 31461.8426907864, 31769.523457148625, 32779.836100819346, 33107.834460827544, 29543.409131817672, 29695.406091878474, 29805.701942980293, 33074.17314567155, 33150.0, 25014.0, 25867.0, 26437.867810660824, 26639.60243578087, 28535.571966420935, 22160.675858771458, 22580.774192257868, 22662.886685566467, 22863.657045144668, 22969.65545516852], "unit": "score", "name": "ext.html", "value": 15736.936993088511}, {"lowerIsBetter": false, "replicates": [314.41518775078356, 315.2984609244431, 318.1854452601342, 320.6456865163994, 326.041438171775, 12212.51149954003, 12695.11134220605, 15206.467773627925, 15622.531324060268, 15761.0, 12368.690782730413, 12416.255024698525, 12587.433565489551, 12733.936330318358, 12763.170393924389, 4767.356406885078, 4770.141374552571, 4897.902041959159, 4901.6078713703, 4905.8773530661665, 3725.4784330193793, 3837.3860182370827, 3837.9424308635253, 3838.923221535568, 4837.492063333352, 5374.7850085996515, 5538.723063846812, 5546.889062218753, 5549.556035517169, 5560.332760068797, 5377.7580008899695, 5520.033994051045, 5537.944620553783, 5558.610897237195, 5560.0, 4813.181759100961, 4846.806127754886, 4855.295982082614, 4865.586425153866, 4870.318155458239, 18377.632447351112, 18749.437516874517, 19128.904355478273, 19195.52011199717, 19228.615427691508, 1781.3676144968479, 1811.5018369948239, 1816.1917946513674, 1868.7570615819993, 1915.52111972007, 10553.0, 12421.31682757448, 12520.624381268577, 12997.270573179643, 13042.673933151653, 1664.966700665992, 1673.1216111541416, 1710.9657806843918, 1736.722124460093, 1901.9619607607908, 45948.310775338396, 46173.53826461726, 55147.72426137843, 56028.71985640046, 56595.43404565943, 8904.376693631384, 9182.219511341476, 9193.218576420946, 9204.723858284127, 9318.627254909728, 11984.400779960966, 12151.696207594881, 12155.392230388445, 12157.696057598454, 12159.878401216052, 6317.178766760384, 6325.177726895474, 6336.873262534724, 6374.713137908805, 6385.169927909435, 5749.051406517878, 5772.191893134965, 5819.970900145557, 5831.708414579254, 5862.618929769551, 3998.2203470323007, 4035.7780322082567, 4038.2327357801923, 4041.7372870763306, 4065.6137666921595, 1550.0854495847504, 1583.794106766113, 1648.4395305595915, 1685.7050016247108, 2546.7580579844885, 742.9858243497587, 763.9656215470317, 819.9918000820035, 840.2521755637488, 863.887694599698, 14387.208703521406, 15459.149746764037, 15705.607359816097, 15925.761113583305, 16030.519084427486, 402.3722992132283, 742.6546655804968, 752.3755283115001, 799.2447137455049, 897.4256475855458, 5354.7858085676135, 5510.760078982197, 5542.584306176972, 5624.0, 5674.2339784129435, 493892.0, 494759.0, 502521.0, 514356.0, 516307.0, 71067.28932710606, 71246.64376678083, 71336.64331678308, 71439.28560714431, 72193.6390318045, 440.2098233670569, 441.85639667107677, 441.9292913133883, 447.93728877957113, 449.1645539296905, 9456.810863782823, 9548.809023819624, 9582.520873956413, 9795.706128816148, 9837.409755414697, 31730.524042138924, 32384.190395240308, 33157.0, 33809.66190338164, 34223.828880855435, 42150.36774448447, 42524.57475425206, 43445.13109737724, 43943.56056439395, 46328.07343853171, 8413.822064910795, 8473.618687159216, 8608.65565377378, 8638.913610864063, 8648.956755216184, 9844.704658860246, 9934.900650993397, 11688.70778230517, 14918.254087295809, 15055.0, 13029.804552931902, 13173.670658233621, 13240.139390939943, 13339.933300333825, 13534.390952407362, 12489.93755031219, 12609.747805043664, 12961.0, 13203.603891883258, 13305.933470332586, 12634.2419454833, 12637.557685480964, 12674.176178548734, 12712.491500339884, 13262.53581124656, 8463.0, 8489.660413583635, 8491.405601608076, 8492.278156356531, 8673.956630216808, 11303.378314192798, 12642.367881605698, 12650.367481626066, 12898.67753306175, 13239.536616218385], "unit": "score", "name": "jquery.html", "value": 7604.26969628923}, {"lowerIsBetter": false, "replicates": [1084.3439718970023, 1088.9128869690423, 1143.7655280667464, 1229.7970834812256, 1264.981025284621, 5620.8313750587495, 6394.7761828336015, 6504.869902601945, 6519.1199188109595, 6523.119378883849, 6410.519211059166, 6570.080188773563, 6570.145881035471, 6572.079908812758, 6578.703958321875, 1939.1467754188147, 1979.1192919150983, 1980.8217260446556, 1981.2372236688834, 1981.9990904593233, 1983.9504012399734, 2019.5456022394917, 2029.0, 2035.28764932274, 2037.5313677854103, 1979.910904009323, 1986.612610540945, 2021.0299056452911, 2022.5954809038178, 2023.4840115770457, 1979.5051237190703, 1995.2218634732467, 1996.6206420780006, 1997.820196182336, 1998.8300994415492, 1998.400479856052, 1999.3102379678987, 2004.5088953206412, 2036.2364113457454, 2037.246218899002, 6596.769113081067, 6675.0, 6687.398134167948, 6691.397774200345, 6696.330366963313, 3794.620537946211, 3872.7289089763726, 3898.571157172709, 3899.7075219358376, 3899.8635047773478, 2543.923682289534, 2568.8330258533138, 2590.818642695012, 2658.56133737933, 2681.6379788728664, 816.94281400302, 832.5545832979327, 844.0841686769862, 880.8018195905934, 881.6605606841413, 9338.206252468548, 9342.346035777498, 9343.859842102374, 9353.298502612332, 9368.531573421302, 3793.6775374093513, 3799.2401519696173, 3862.6909847212155, 3873.5351757789244, 3881.728279020498, 8104.959475202586, 8149.103598604149, 8149.714759983491, 8151.95924020388, 8158.959205204054, 3917.138229589486, 3938.7439816411843, 3940.822662980173, 3942.6845852331744, 3945.585713500041, 2981.493146165157, 3060.173753086654, 3420.196253880336, 3552.165241168375, 3582.874599389061, 3147.826869522198, 3172.159377764894, 3203.2952750394875, 3211.2774625709494, 3216.276337823971, 972.1930797438109, 974.6345120579782, 982.29274922056, 983.6753871222479, 993.0268337029752, 792.1088775127981, 802.5545822068691, 804.1355542791406, 804.5293503300635, 870.3428911172025, 5954.37479064692, 6125.632462052291, 6128.233970753656, 6141.662208578482, 6146.78486252979, 429.2659552165769, 438.29215816456195, 441.45259877752, 442.2261043174445, 444.944381952256, 4723.881902952454, 4805.7597120143855, 4814.566688997937, 4824.589909857701, 4824.6863953842885, 7842.176571460029, 7911.960440197878, 8038.115807261197, 8072.152423995396, 8109.472884262504, 7921.36629069673, 7978.082520510099, 8007.359411247086, 8018.398620103516, 8031.397645176635, 6032.638041717511, 6136.7852125175405, 6151.6001459904965, 6176.413240742122, 6199.969000154971, 5940.821775346746, 6025.548083893813, 6032.4570788629235, 6036.396360364104, 6047.637141771508, 7050.506464547638, 7061.929380706332, 7141.64291785419, 7318.487705860539, 7342.265773422829, 7570.129435115033, 7598.924010759822, 7744.341730952932, 7771.261730135628, 7786.299233069051, 4937.0372777308085, 5019.447860735389, 5851.502622277154, 5935.9109613356695, 5939.406059394026, 6137.7851775187655, 6202.255729312511, 6221.5333849960525, 6227.719752611234, 6227.782027629011, 5829.7085145743395, 5832.941670583409, 5947.524198064058, 6006.789762358297, 6105.603135796159, 5706.514946229617, 5832.795852145155, 5875.853103672272, 5911.261092363455, 5942.524598032233, 5933.910991335047, 5953.880922381441, 5969.432903874125, 6035.577509574287, 6118.20463339763, 5550.69471179089, 5579.6652200868075, 5582.0231459495235, 5586.720663966867, 5587.497125258747, 5539.916901246565, 5594.38461769197, 5613.270274864241, 5616.0452723038, 5617.831465056055], "unit": "score", "name": "mootools.html", "value": 3713.473982522328}, {"lowerIsBetter": false, "replicates": [282.30552840013564, 287.0899249379468, 289.2493978126761, 291.8380298934092, 292.73215008267437, 4874.6831455955335, 5021.698698078118, 5220.530152286294, 5264.710440925753, 5274.86812829679, 5152.562032227256, 5234.18870075138, 5237.7381130943495, 5246.0, 5250.816221432241, 4032.354823228284, 4066.715329926906, 4070.185962807443, 4075.32757095079, 4080.224757296119, 3853.7495062820826, 3918.5885482024405, 3930.921381572367, 4081.3061779497557, 4085.754854708712, 3959.1883663848985, 3967.464392307045, 3967.7420967637154, 3968.5436174839974, 3970.7816070116132, 3941.743786653887, 3947.8618248361313, 3948.8815335539693, 3952.2885880541635, 3953.782541960191, 3467.063892748969, 3473.270613171237, 3473.322702073097, 3475.6176820549717, 3479.7738147020614, 4896.485868983741, 4931.7040977541465, 4958.950410495885, 4959.8016079356785, 4965.801367945278, 4356.8257269709175, 4529.388532548097, 4533.297338912474, 4533.727976321431, 4534.773261336953, 5398.2982212312145, 5399.271098401744, 5400.891982160374, 5401.864953376197, 5416.783328666848, 3521.506989021539, 3609.675129238381, 3637.418013117888, 3721.1255354991554, 3723.925521489582, 5645.266115405012, 5695.886082278331, 5712.82861514151, 5722.227499287585, 5724.169995350692, 3855.6722678572073, 3856.7300288980064, 3856.9421458678144, 3858.054776579756, 3862.0731024553907, 3895.220955808793, 3905.7656540607086, 3907.4138879168354, 3914.0, 3927.6857851371824, 4440.888977775581, 4530.88672783183, 4532.6827122101795, 4533.5013148553635, 4536.432945881765, 5467.043267428184, 5468.507834294933, 5473.890522189534, 5475.288212532425, 5479.287692599936, 1351.8377794664702, 1380.4064252371577, 1380.5996261084374, 1380.9585712428643, 1381.1781989716103, 907.0430695616056, 910.981780364389, 920.7145784806731, 949.9050094990583, 954.1698722111807, 4840.903181936342, 4843.39457567804, 4845.781939812717, 4848.8787780305065, 4852.228936438245, 5619.775208991595, 5639.351474580476, 5664.716764161775, 5670.914936275959, 5671.546276297886, 4818.831340903052, 4833.05755377698, 4836.588889944394, 4836.685615434985, 4837.274408838703, 2965.3920946205976, 3021.531662592302, 3043.3913217356176, 3044.3150291184747, 3051.908442746677, 5379.1393377059485, 5383.2194331821665, 5392.272043274186, 5415.783368665288, 5445.50990410865, 5805.071188609887, 5819.912701309484, 5824.88350232993, 5826.388229235869, 5828.154917536934, 5392.730363481889, 5444.210589464506, 5445.945540544623, 5447.618666693294, 5450.454954504677, 5492.80775172883, 5647.181158732043, 5659.292588426447, 5664.85837854057, 5665.376808550974, 5333.546648534918, 5527.53015993645, 5529.419410961791, 5535.474129957647, 5542.251796007487, 5329.760160792696, 5341.65279256847, 5344.331958505187, 5345.957538279998, 5350.956563470086, 3712.461693054546, 3782.8486860526373, 3789.981050094732, 3797.3544497436055, 3799.6960243181034, 5636.098224284095, 5639.125935480007, 5642.379338272869, 5645.887082258249, 5647.915281270702, 5328.813491527778, 5441.129419292894, 5448.155535891943, 5450.438294001813, 5457.918131228114, 5436.184572314026, 5445.128779395278, 5451.781928722807, 5452.400235974119, 5452.482014208644, 5321.175217841241, 5330.733463326741, 5334.253204551288, 5335.253064571041, 5335.706536140549, 5379.112446446449, 5475.561955043508, 5486.341639003345, 5488.341399031982, 5490.203920431595, 5355.732213389393, 5367.141257398797, 5371.435999220025, 5373.086575282133, 5374.7581358839725], "unit": "score", "name": "prototype.html", "value": 4072.5701089991485}, {"lowerIsBetter": false, "replicates": [566.388300635314, 651.4267444648708, 659.1200747002752, 676.4149011105395, 677.5460441504192, 10712.303700259477, 10891.618793342235, 10894.945525272373, 10898.400587967659, 10922.29005114668, 10702.46487675617, 10858.294210876307, 10861.076808471289, 10892.836607450874, 10988.175886808502, 738.4683028219687, 754.7018927523625, 754.811297175706, 754.9396048316122, 755.0599503618004, 741.5661837824879, 750.3209595316248, 751.2074761127009, 751.4063889527267, 752.5146280648978, 782.4640121516779, 787.5668382389663, 791.5211297165218, 792.3106896999618, 792.6710415177695, 787.0673252196137, 787.4055088408215, 787.7124849429916, 788.424450151387, 788.6372268756351, 581.119603800243, 581.4011568084837, 581.4795757796791, 581.5376775463517, 582.1500609110703, 9659.0, 9747.61009559624, 9763.121319081316, 9803.166730827888, 9846.359986600848, 8686.39195256326, 8740.213380795696, 8830.955845220797, 8935.910640893573, 8945.105489451067, 7936.563489008102, 8119.106898241189, 8141.389395795339, 8146.470479418819, 8223.712170074019, 2769.612254284382, 2912.2428168676083, 2938.6620538638117, 2963.6147300850753, 3027.1523973287512, 35119.0, 35151.64848351509, 36012.81993590015, 36494.8175259122, 38891.61108388908, 8452.1547845215, 8490.066092729794, 8495.95752021236, 8554.0, 8648.654053837776, 14925.402983880524, 14940.551783446514, 14965.476208332657, 15003.924980375246, 15011.174385408907, 5155.226715992631, 5310.548603368679, 5311.601629877775, 5353.732313384316, 5511.53151982078, 3188.0754581171664, 3224.2584205632834, 3251.886183983549, 3297.7691561590937, 3320.8007519548905, 2761.6685997680406, 2828.533292006837, 2845.5731640254126, 2846.3595690969364, 2854.4861924853726, 489.3540526504979, 489.9099503604523, 490.0493043495607, 491.6533843640225, 496.0302608400568, 382.77798876651474, 387.3647218561561, 394.48913656814494, 399.9940000899989, 404.1049076296018, 6432.2602900667025, 6769.086173366532, 6874.896876546856, 7060.3292687194635, 7080.752173674, 397.95821438749095, 453.4603821452461, 462.9930551041737, 465.68333533197074, 473.44606810032343, 3132.401557724062, 3308.354870800171, 3314.038928710647, 3347.56481657383, 3367.326534693071, 46059.76970115128, 46422.53577464182, 46557.30164047542, 46590.767046164554, 48850.0, 39341.213175736324, 39539.01152471154, 39724.80137599294, 41019.58980410217, 44175.116497669864, 35080.649193507736, 36103.27793444116, 40186.39720404196, 43267.78366108149, 43982.0, 7319.0, 7670.348020418104, 7810.726624568113, 7814.921850781419, 7978.880316795136, 31487.84256078705, 32069.518957215194, 32152.839235803673, 32384.14237864339, 32969.340613188084, 34400.311993760486, 35909.28181436409, 41782.164356712085, 43751.0, 44781.32828007648, 8583.0, 8990.190882820578, 9143.679971200976, 9367.0, 9628.47043412619, 10134.695959121238, 10192.235582331206, 10271.7432064199, 10282.948585257025, 10406.791864162524, 9872.703818885446, 9892.208623310262, 9906.603735850485, 10319.226058045526, 10344.948275258877, 10185.541650625592, 10230.181585473294, 10278.897211027794, 10352.0, 10524.36853788775, 9272.119148680864, 9579.185769209695, 9582.185514231369, 9599.184069354184, 9651.758706032406, 8427.325813934993, 8444.282236010007, 8494.36292278094, 8511.191436813493, 8555.529445880537, 8411.116832732476, 8529.402941794015, 8592.742217733477, 8597.613107410056, 8598.441101328393], "unit": "score", "name": "yui.html", "value": 5229.665142768303}], "name": "dromaeo_css", "value": 5897.7870480866995}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 113.0, 113.0, 114.0, 104.0, 113.0, 113.0, 119.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 158.0, 166.0, 138.0, 157.0, 153.0, 142.0, 173.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 91.0, 74.0, 73.0, 73.0, 113.0, 90.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 142.0, 100.0, 99.0, 99.0, 131.0, 99.0, 99.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 148.0, 149.0, 147.0, 149.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 72.0, 71.0, 72.0, 80.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 70.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 84.0, 91.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [122.0, 141.0, 124.0, 119.0, 129.0, 122.0, 131.0, 129.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [136.0, 149.0, 148.0, 146.0, 150.0, 142.0, 149.0, 149.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 71.0, 72.0, 72.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1536.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.7792869269949], "unit": "score", "name": "Richards", "value": 207.92877999999993}, {"lowerIsBetter": false, "replicates": [193.4984520123839], "unit": "score", "name": "DeltaBlue", "value": 341.6978240000001}, {"lowerIsBetter": false, "replicates": [281.6901408450704], "unit": "score", "name": "Encrypt", "value": 944.9425500000004}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [814.9959250203749], "unit": "score", "name": "Earley", "value": 817.7501010000001}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [625.3908692933084], "unit": "score", "name": "Splay", "value": 130.30410899999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19540.856142211676}]} 08:58:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19540.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5897.79"}}} 08:58:47 INFO - Return code: 0 08:58:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:58:47 INFO - # TBPL SUCCESS # 08:58:47 INFO - Running post-action listener: _resource_record_post_action 08:58:47 INFO - Running post-run listener: _resource_record_post_run 08:58:48 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542617600; Read time: 172; Write time: 373492 08:58:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228208640; Read time: 0; Write time: 222080 08:58:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314408960; Read time: 172; Write time: 151412 08:58:48 INFO - Running post-run listener: _upload_blobber_files 08:58:48 INFO - Blob upload gear active. 08:58:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:48 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 08:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:49 INFO - (blobuploader) - INFO - Done attempting. 08:58:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:50 INFO - (blobuploader) - INFO - Done attempting. 08:58:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:50 INFO - Return code: 0 08:58:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7f4f72cc12a6773ef62d51e5780e66397b05f71b2a82f014c17fcd9465e63fd1c74f00181f9efba128b2a96eb38ab2e920f6b717d6104655b407897643a874a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b4cf7ca91c6bf05e7190b89edd7edf62d80c35e61b4e87fa2ae5047a2915b63b095214533cb2c1d6f1fea622af28ccd2ba51aa8b497b122ee5123078bfdb4fd"} 08:58:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:50 INFO - Contents: 08:58:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7f4f72cc12a6773ef62d51e5780e66397b05f71b2a82f014c17fcd9465e63fd1c74f00181f9efba128b2a96eb38ab2e920f6b717d6104655b407897643a874a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b4cf7ca91c6bf05e7190b89edd7edf62d80c35e61b4e87fa2ae5047a2915b63b095214533cb2c1d6f1fea622af28ccd2ba51aa8b497b122ee5123078bfdb4fd"} 08:58:50 INFO - Copying logs to upload dir... 08:58:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.511288 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-04 08:58:52.010875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 08:58:52.014875) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7f4f72cc12a6773ef62d51e5780e66397b05f71b2a82f014c17fcd9465e63fd1c74f00181f9efba128b2a96eb38ab2e920f6b717d6104655b407897643a874a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b4cf7ca91c6bf05e7190b89edd7edf62d80c35e61b4e87fa2ae5047a2915b63b095214533cb2c1d6f1fea622af28ccd2ba51aa8b497b122ee5123078bfdb4fd"} build_url:https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009548 build_url: 'https://queue.taskcluster.net/v1/task/CKtAfTQ3R9uuERQ8bEJaUQ/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/Fx-Team-Non-PGO/sha512/c7f4f72cc12a6773ef62d51e5780e66397b05f71b2a82f014c17fcd9465e63fd1c74f00181f9efba128b2a96eb38ab2e920f6b717d6104655b407897643a874a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b4cf7ca91c6bf05e7190b89edd7edf62d80c35e61b4e87fa2ae5047a2915b63b095214533cb2c1d6f1fea622af28ccd2ba51aa8b497b122ee5123078bfdb4fd"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 08:58:52.200943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:58:52.201286) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1451923673.211187-58935502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:58:52.217684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 08:58:52.218035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 08:58:52.218341) ========= ========= Total master_lag: 1.59 =========