builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1448464473.36 results: success (0) buildid: 20151125055133 builduid: dbcc991070f744e7a99db19f426af25f revision: 06a5ac492313d07196cecbfce01e55177536d5a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.357174) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.357650) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.357942) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006419 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.395324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.395675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.435175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.435559) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.492356) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.492642) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.492990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.493257) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 07:14:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2015-11-25 07:14:33 (18.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.236854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.743597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.743917) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.112715 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.880046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:33.880424) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06a5ac492313d07196cecbfce01e55177536d5a4 --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 06a5ac492313d07196cecbfce01e55177536d5a4 --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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 07:14:33,955 truncating revision to first 12 chars 2015-11-25 07:14:33,955 Setting DEBUG logging. 2015-11-25 07:14:33,956 attempt 1/10 2015-11-25 07:14:33,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06a5ac492313?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 07:14:34,541 unpacking tar archive at: fx-team-06a5ac492313/testing/mozharness/ program finished with exit code 0 elapsedTime=0.887893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:34.783028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:34.783334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:34.793280) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:34.793633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 07:14:34.794096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-25 07:14:34.794389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:35 INFO - MultiFileLogger online at 20151125 07:14:35 in /builds/slave/test 07:14:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:35 INFO - {'append_to_log': False, 07:14:35 INFO - 'base_work_dir': '/builds/slave/test', 07:14:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:35 INFO - 'branch': 'Fx-Team-Non-PGO', 07:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:35 INFO - 'config_files': ('talos/linux_config.py',), 07:14:35 INFO - 'default_actions': ('clobber', 07:14:35 INFO - 'read-buildbot-config', 07:14:35 INFO - 'download-and-extract', 07:14:35 INFO - 'populate-webroot', 07:14:35 INFO - 'create-virtualenv', 07:14:35 INFO - 'install', 07:14:35 INFO - 'run-tests'), 07:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:35 INFO - 'download_minidump_stackwalk': True, 07:14:35 INFO - 'download_symbols': 'ondemand', 07:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:35 INFO - 'installer_path': 'installer.exe', 07:14:35 INFO - 'log_level': 'info', 07:14:35 INFO - 'log_name': 'talos', 07:14:35 INFO - 'log_to_console': True, 07:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:35 INFO - 'opt_config_files': (), 07:14:35 INFO - 'pip_index': False, 07:14:35 INFO - 'sps_profile': False, 07:14:35 INFO - 'sps_profile_interval': 0, 07:14:35 INFO - 'suite': 'dromaeojs', 07:14:35 INFO - 'system_bits': '64', 07:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:35 INFO - 'title': 'talos-linux64-ix-025', 07:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:35 INFO - 'use_talos_json': True, 07:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:35 INFO - 'work_dir': 'build'} 07:14:35 INFO - ##### 07:14:35 INFO - ##### Running clobber step. 07:14:35 INFO - ##### 07:14:35 INFO - Running pre-action listener: _resource_record_pre_action 07:14:35 INFO - Running main action method: clobber 07:14:35 INFO - rmtree: /builds/slave/test/build 07:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:36 INFO - Running post-action listener: _resource_record_post_action 07:14:36 INFO - ##### 07:14:36 INFO - ##### Running read-buildbot-config step. 07:14:36 INFO - ##### 07:14:36 INFO - Running pre-action listener: _resource_record_pre_action 07:14:36 INFO - Running main action method: read_buildbot_config 07:14:36 INFO - Using buildbot properties: 07:14:36 INFO - { 07:14:36 INFO - "properties": { 07:14:36 INFO - "buildnumber": 927, 07:14:36 INFO - "product": "firefox", 07:14:36 INFO - "script_repo_revision": "production", 07:14:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:14:36 INFO - "repository": "", 07:14:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:14:36 INFO - "buildid": "20151125055133", 07:14:36 INFO - "slavename": "talos-linux64-ix-025", 07:14:36 INFO - "pgo_build": "False", 07:14:36 INFO - "basedir": "/builds/slave/test", 07:14:36 INFO - "project": "", 07:14:36 INFO - "platform": "ubuntu64_hw", 07:14:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:14:36 INFO - "slavebuilddir": "test", 07:14:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:14:36 INFO - "branch": "fx-team", 07:14:36 INFO - "repo_path": "integration/fx-team", 07:14:36 INFO - "stage_platform": "linux64", 07:14:36 INFO - "builduid": "dbcc991070f744e7a99db19f426af25f", 07:14:36 INFO - "revision": "06a5ac492313d07196cecbfce01e55177536d5a4" 07:14:36 INFO - }, 07:14:36 INFO - "sourcestamp": { 07:14:36 INFO - "repository": "", 07:14:36 INFO - "hasPatch": false, 07:14:36 INFO - "project": "", 07:14:36 INFO - "branch": "fx-team-linux64-talos", 07:14:36 INFO - "changes": [ 07:14:36 INFO - { 07:14:36 INFO - "category": null, 07:14:36 INFO - "files": [ 07:14:36 INFO - { 07:14:36 INFO - "url": null, 07:14:36 INFO - "name": "https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:14:36 INFO - } 07:14:36 INFO - ], 07:14:36 INFO - "repository": "", 07:14:36 INFO - "rev": "06a5ac492313d07196cecbfce01e55177536d5a4", 07:14:36 INFO - "who": "jwein@mozilla.com", 07:14:36 INFO - "when": 1448464457, 07:14:36 INFO - "number": 6705987, 07:14:36 INFO - "comments": "Bug 1211635 - Popups should be treated as top-level windows, allowing XUL alerts translucency. r=MattN r=roc", 07:14:36 INFO - "project": "", 07:14:36 INFO - "at": "Wed 25 Nov 2015 07:14:17", 07:14:36 INFO - "branch": "fx-team-linux64-talos", 07:14:36 INFO - "revlink": "", 07:14:36 INFO - "properties": [ 07:14:36 INFO - [ 07:14:36 INFO - "buildid", 07:14:36 INFO - "20151125055133", 07:14:36 INFO - "Change" 07:14:36 INFO - ], 07:14:36 INFO - [ 07:14:36 INFO - "builduid", 07:14:36 INFO - "dbcc991070f744e7a99db19f426af25f", 07:14:36 INFO - "Change" 07:14:36 INFO - ], 07:14:36 INFO - [ 07:14:36 INFO - "pgo_build", 07:14:36 INFO - "False", 07:14:36 INFO - "Change" 07:14:36 INFO - ] 07:14:36 INFO - ], 07:14:36 INFO - "revision": "06a5ac492313d07196cecbfce01e55177536d5a4" 07:14:36 INFO - } 07:14:36 INFO - ], 07:14:36 INFO - "revision": "06a5ac492313d07196cecbfce01e55177536d5a4" 07:14:36 INFO - } 07:14:36 INFO - } 07:14:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:14:36 INFO - Running post-action listener: _resource_record_post_action 07:14:36 INFO - ##### 07:14:36 INFO - ##### Running download-and-extract step. 07:14:36 INFO - ##### 07:14:36 INFO - Running pre-action listener: _resource_record_pre_action 07:14:36 INFO - Running main action method: download_and_extract 07:14:36 INFO - mkdir: /builds/slave/test/build/tests 07:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:36 INFO - https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/test_packages.json 07:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/test_packages.json 07:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:14:38 INFO - Downloaded 1302 bytes. 07:14:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:14:38 INFO - Using the following test package requirements: 07:14:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:14:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'jsshell-linux-x86_64.zip'], 07:14:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:14:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:14:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:14:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:14:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:14:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:14: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')]} 07:14:38 INFO - https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:53 INFO - Downloaded 21508487 bytes. 07:14:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:14:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:14:54 INFO - Return code: 0 07:14:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:54 INFO - https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:56 INFO - Downloaded 21508487 bytes. 07:14:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:14:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:14:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:14:58 INFO - Return code: 0 07:14: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')]} 07:14:58 INFO - https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:14:59 INFO - Downloaded 11131717 bytes. 07:14:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:14:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:14:59 INFO - Return code: 0 07:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:59 INFO - https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:15:00 INFO - Downloaded 56842203 bytes. 07:15:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:15:00 INFO - mkdir: /builds/slave/test/properties 07:15:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:00 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:00 INFO - Contents: 07:15:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:15:00 INFO - Running post-action listener: _resource_record_post_action 07:15:00 INFO - Running post-action listener: set_extra_try_arguments 07:15:00 INFO - ##### 07:15:00 INFO - ##### Running populate-webroot step. 07:15:00 INFO - ##### 07:15:00 INFO - Running pre-action listener: _resource_record_pre_action 07:15:00 INFO - Running main action method: populate_webroot 07:15:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:15:00 INFO - '../fennec_ids.txt'], 07:15:00 INFO - 'tests': ['tcheck2']}, 07:15:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:00 INFO - '--tppagecycles', 07:15:00 INFO - '7'], 07:15:00 INFO - 'tests': ['tsvgm']}}, 07:15:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:15:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:15:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:15:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'tests': ['damp', 'tps']}, 07:15:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['damp', 'tps']}, 07:15:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:15:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:00 INFO - 'other': {'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'other_l64': {'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'other_nol64': {'tests': ['a11yr', 07:15:00 INFO - 'ts_paint', 07:15:00 INFO - 'tpaint', 07:15:00 INFO - 'sessionrestore', 07:15:00 INFO - 'sessionrestore_no_auto_restore']}, 07:15:00 INFO - 'svgr': {'tests': ['tsvgx', 07:15:00 INFO - 'tsvgr_opacity', 07:15:00 INFO - 'tart', 07:15:00 INFO - 'tscrollx', 07:15:00 INFO - 'cart']}, 07:15:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['tsvgx', 07:15:00 INFO - 'tsvgr_opacity', 07:15:00 INFO - 'tart', 07:15:00 INFO - 'tscrollx', 07:15:00 INFO - 'cart']}, 07:15:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'tests': ['tp5o']}, 07:15:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'talos_options': ['--e10s'], 07:15:00 INFO - 'tests': ['tp5o']}, 07:15:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'talos_options': ['--xperf_path', 07:15:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:00 INFO - 'tests': ['tp5n']}, 07:15:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:00 INFO - 'talos_options': ['--e10s', 07:15:00 INFO - '--xperf_path', 07:15:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:00 INFO - 'tests': ['tp5n']}}, 07:15:00 INFO - 'talos.zip': {'path': '', 07:15:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:00 INFO - Running post-action listener: _resource_record_post_action 07:15:00 INFO - ##### 07:15:00 INFO - ##### Running create-virtualenv step. 07:15:00 INFO - ##### 07:15:00 INFO - Running pre-action listener: _resource_record_pre_action 07:15:00 INFO - Running main action method: create_virtualenv 07:15:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:00 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 07:15:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:01 INFO - Using real prefix '/usr' 07:15:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:03 INFO - Installing pip.................done. 07:15:03 INFO - Return code: 0 07:15:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:03 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')]} 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:03 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')]} 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:03 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:03 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 07:15:03 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 07:15:03 INFO - Using env: {'DISPLAY': ':0', 07:15:03 INFO - 'HOME': '/home/cltbld', 07:15:03 INFO - 'LANG': 'en_US.UTF-8', 07:15:03 INFO - 'LANGUAGE': 'en_US:en', 07:15:03 INFO - 'LOGNAME': 'cltbld', 07:15:03 INFO - 'MAIL': '/var/mail/cltbld', 07:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:03 INFO - 'MOZ_NO_REMOTE': '1', 07:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:03 INFO - 'NO_EM_RESTART': '1', 07:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:03 INFO - 'PWD': '/builds/slave/test', 07:15:03 INFO - 'SHELL': '/bin/bash', 07:15:03 INFO - 'SHLVL': '1', 07:15:03 INFO - 'TERM': 'linux', 07:15:03 INFO - 'TMOUT': '86400', 07:15:03 INFO - 'USER': 'cltbld', 07:15:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:03 INFO - '_': '/tools/buildbot/bin/python'} 07:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:03 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 07:15:03 INFO - Cleaning up... 07:15:03 INFO - Return code: 0 07:15:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:15:03 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')]} 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:03 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')]} 07:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:04 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:04 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 07:15:04 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 07:15:04 INFO - Using env: {'DISPLAY': ':0', 07:15:04 INFO - 'HOME': '/home/cltbld', 07:15:04 INFO - 'LANG': 'en_US.UTF-8', 07:15:04 INFO - 'LANGUAGE': 'en_US:en', 07:15:04 INFO - 'LOGNAME': 'cltbld', 07:15:04 INFO - 'MAIL': '/var/mail/cltbld', 07:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:04 INFO - 'MOZ_NO_REMOTE': '1', 07:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:04 INFO - 'NO_EM_RESTART': '1', 07:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:04 INFO - 'PWD': '/builds/slave/test', 07:15:04 INFO - 'SHELL': '/bin/bash', 07:15:04 INFO - 'SHLVL': '1', 07:15:04 INFO - 'TERM': 'linux', 07:15:04 INFO - 'TMOUT': '86400', 07:15:04 INFO - 'USER': 'cltbld', 07:15:04 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:04 INFO - '_': '/tools/buildbot/bin/python'} 07:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:04 INFO - Downloading/unpacking psutil>=0.7.1 07:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:15:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:06 INFO - Installing collected packages: psutil 07:15:06 INFO - Running setup.py install for psutil 07:15:06 INFO - building 'psutil._psutil_linux' extension 07:15:06 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 07:15:07 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 07:15:07 INFO - building 'psutil._psutil_posix' extension 07:15:07 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 07:15:07 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 07:15:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:07 INFO - Successfully installed psutil 07:15:07 INFO - Cleaning up... 07:15:07 INFO - Return code: 0 07:15:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:07 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')]} 07:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:07 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')]} 07:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:07 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:07 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 07:15:07 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 07:15:07 INFO - Using env: {'DISPLAY': ':0', 07:15:07 INFO - 'HOME': '/home/cltbld', 07:15:07 INFO - 'LANG': 'en_US.UTF-8', 07:15:07 INFO - 'LANGUAGE': 'en_US:en', 07:15:07 INFO - 'LOGNAME': 'cltbld', 07:15:07 INFO - 'MAIL': '/var/mail/cltbld', 07:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:07 INFO - 'MOZ_NO_REMOTE': '1', 07:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:07 INFO - 'NO_EM_RESTART': '1', 07:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:07 INFO - 'PWD': '/builds/slave/test', 07:15:07 INFO - 'SHELL': '/bin/bash', 07:15:07 INFO - 'SHLVL': '1', 07:15:07 INFO - 'TERM': 'linux', 07:15:07 INFO - 'TMOUT': '86400', 07:15:07 INFO - 'USER': 'cltbld', 07:15:07 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:07 INFO - '_': '/tools/buildbot/bin/python'} 07:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:09 INFO - Installing collected packages: mozsystemmonitor 07:15:09 INFO - Running setup.py install for mozsystemmonitor 07:15:09 INFO - Successfully installed mozsystemmonitor 07:15:09 INFO - Cleaning up... 07:15:09 INFO - Return code: 0 07:15:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:09 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 07:15:09 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 07:15:09 INFO - Using env: {'DISPLAY': ':0', 07:15:09 INFO - 'HOME': '/home/cltbld', 07:15:09 INFO - 'LANG': 'en_US.UTF-8', 07:15:09 INFO - 'LANGUAGE': 'en_US:en', 07:15:09 INFO - 'LOGNAME': 'cltbld', 07:15:09 INFO - 'MAIL': '/var/mail/cltbld', 07:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:09 INFO - 'MOZ_NO_REMOTE': '1', 07:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:09 INFO - 'NO_EM_RESTART': '1', 07:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:09 INFO - 'PWD': '/builds/slave/test', 07:15:09 INFO - 'SHELL': '/bin/bash', 07:15:09 INFO - 'SHLVL': '1', 07:15:09 INFO - 'TERM': 'linux', 07:15:09 INFO - 'TMOUT': '86400', 07:15:09 INFO - 'USER': 'cltbld', 07:15:09 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:09 INFO - '_': '/tools/buildbot/bin/python'} 07:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:12 INFO - Downloading docopt-0.6.1.tar.gz 07:15:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:12 INFO - Running setup.py install for blobuploader 07:15:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:12 INFO - Running setup.py install for requests 07:15:12 INFO - Running setup.py install for docopt 07:15:12 INFO - Successfully installed blobuploader requests docopt 07:15:12 INFO - Cleaning up... 07:15:12 INFO - Return code: 0 07:15:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:12 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 07:15:12 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 07:15:12 INFO - Using env: {'DISPLAY': ':0', 07:15:12 INFO - 'HOME': '/home/cltbld', 07:15:12 INFO - 'LANG': 'en_US.UTF-8', 07:15:12 INFO - 'LANGUAGE': 'en_US:en', 07:15:12 INFO - 'LOGNAME': 'cltbld', 07:15:12 INFO - 'MAIL': '/var/mail/cltbld', 07:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:12 INFO - 'MOZ_NO_REMOTE': '1', 07:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:12 INFO - 'NO_EM_RESTART': '1', 07:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:12 INFO - 'PWD': '/builds/slave/test', 07:15:12 INFO - 'SHELL': '/bin/bash', 07:15:12 INFO - 'SHLVL': '1', 07:15:12 INFO - 'TERM': 'linux', 07:15:12 INFO - 'TMOUT': '86400', 07:15:12 INFO - 'USER': 'cltbld', 07:15:12 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:12 INFO - '_': '/tools/buildbot/bin/python'} 07:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:12 INFO - Running setup.py (path:/tmp/pip-MXIPHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:13 INFO - Running setup.py (path:/tmp/pip-9etw1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:13 INFO - Running setup.py (path:/tmp/pip-Iy7h9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:13 INFO - Running setup.py (path:/tmp/pip-4FNH9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:13 INFO - Running setup.py (path:/tmp/pip-5ctx9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:13 INFO - Running setup.py (path:/tmp/pip-uLhHno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:13 INFO - Running setup.py (path:/tmp/pip-NRJH_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:13 INFO - Running setup.py (path:/tmp/pip-MGeE7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:13 INFO - Running setup.py (path:/tmp/pip-zSwUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:13 INFO - Running setup.py (path:/tmp/pip-62wDJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:13 INFO - Running setup.py (path:/tmp/pip-sto8DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:13 INFO - Running setup.py (path:/tmp/pip-NL_dge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:13 INFO - Running setup.py (path:/tmp/pip-exLXSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:13 INFO - Running setup.py (path:/tmp/pip-9AYGEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:14 INFO - Running setup.py (path:/tmp/pip-0WM4nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:14 INFO - Running setup.py (path:/tmp/pip-55rWaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:14 INFO - Running setup.py (path:/tmp/pip-Ssx9w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:14 INFO - Running setup.py install for manifestparser 07:15:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:14 INFO - Running setup.py install for mozcrash 07:15:14 INFO - Running setup.py install for mozdebug 07:15:14 INFO - Running setup.py install for mozdevice 07:15:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:14 INFO - Running setup.py install for mozfile 07:15:14 INFO - Running setup.py install for mozhttpd 07:15:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:14 INFO - Running setup.py install for mozinfo 07:15:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:14 INFO - Running setup.py install for mozInstall 07:15:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for mozleak 07:15:15 INFO - Running setup.py install for mozlog 07:15:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for moznetwork 07:15:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for mozprocess 07:15:15 INFO - Running setup.py install for mozprofile 07:15:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for mozrunner 07:15:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for mozscreenshot 07:15:15 INFO - Running setup.py install for moztest 07:15:15 INFO - Running setup.py install for mozversion 07:15:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:15 INFO - Cleaning up... 07:15:16 INFO - Return code: 0 07:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:16 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')]} 07:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:16 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')]} 07:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:16 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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:16 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 07:15:16 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 07:15:16 INFO - Using env: {'DISPLAY': ':0', 07:15:16 INFO - 'HOME': '/home/cltbld', 07:15:16 INFO - 'LANG': 'en_US.UTF-8', 07:15:16 INFO - 'LANGUAGE': 'en_US:en', 07:15:16 INFO - 'LOGNAME': 'cltbld', 07:15:16 INFO - 'MAIL': '/var/mail/cltbld', 07:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:16 INFO - 'MOZ_NO_REMOTE': '1', 07:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:16 INFO - 'NO_EM_RESTART': '1', 07:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:16 INFO - 'PWD': '/builds/slave/test', 07:15:16 INFO - 'SHELL': '/bin/bash', 07:15:16 INFO - 'SHLVL': '1', 07:15:16 INFO - 'TERM': 'linux', 07:15:16 INFO - 'TMOUT': '86400', 07:15:16 INFO - 'USER': 'cltbld', 07:15:16 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:16 INFO - '_': '/tools/buildbot/bin/python'} 07:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:16 INFO - Running setup.py (path:/tmp/pip-63rDhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:16 INFO - Running setup.py (path:/tmp/pip-W99EVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:16 INFO - Running setup.py (path:/tmp/pip-j3CFR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:16 INFO - Running setup.py (path:/tmp/pip-6IfBLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:16 INFO - Running setup.py (path:/tmp/pip-4zhden-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:16 INFO - Running setup.py (path:/tmp/pip-1_7Zwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:16 INFO - Running setup.py (path:/tmp/pip-WnLsU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:16 INFO - Running setup.py (path:/tmp/pip-Yzd34b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:16 INFO - Running setup.py (path:/tmp/pip-pxP5Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:16 INFO - Running setup.py (path:/tmp/pip-n5HJ0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:16 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)) 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:16 INFO - Running setup.py (path:/tmp/pip-7b9QL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:17 INFO - Running setup.py (path:/tmp/pip-z0KzOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:17 INFO - Running setup.py (path:/tmp/pip-5caHrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:17 INFO - Running setup.py (path:/tmp/pip-8c92px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:17 INFO - Running setup.py (path:/tmp/pip-hRsYhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:17 INFO - Running setup.py (path:/tmp/pip-WycycJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:17 INFO - Running setup.py (path:/tmp/pip-0FJCrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:17 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)) 07:15:17 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)) 07:15:17 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)) 07:15:17 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)) 07:15:17 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)) 07:15:17 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)) 07:15:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:17 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 07:15:17 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 07:15:17 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 07:15:17 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 07:15:17 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 07:15:17 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 07:15:19 INFO - Downloading blessings-1.5.1.tar.gz 07:15:19 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 07:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:19 INFO - Installing collected packages: blessings 07:15:19 INFO - Running setup.py install for blessings 07:15:19 INFO - Successfully installed blessings 07:15:19 INFO - Cleaning up... 07:15:19 INFO - Return code: 0 07:15:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:19 INFO - Reading from file tmpfile_stdout 07:15:19 INFO - Current package versions: 07:15:19 INFO - argparse == 1.2.1 07:15:19 INFO - blessings == 1.5.1 07:15:19 INFO - blobuploader == 1.2.4 07:15:19 INFO - docopt == 0.6.1 07:15:19 INFO - manifestparser == 1.1 07:15:19 INFO - mozInstall == 1.12 07:15:19 INFO - mozcrash == 0.16 07:15:19 INFO - mozdebug == 0.1 07:15:19 INFO - mozdevice == 0.47 07:15:19 INFO - mozfile == 1.2 07:15:19 INFO - mozhttpd == 0.7 07:15:19 INFO - mozinfo == 0.9 07:15:19 INFO - mozleak == 0.1 07:15:19 INFO - mozlog == 3.1 07:15:19 INFO - moznetwork == 0.27 07:15:19 INFO - mozprocess == 0.22 07:15:19 INFO - mozprofile == 0.27 07:15:19 INFO - mozrunner == 6.11 07:15:19 INFO - mozscreenshot == 0.1 07:15:19 INFO - mozsystemmonitor == 0.0 07:15:19 INFO - moztest == 0.7 07:15:19 INFO - mozversion == 1.4 07:15:19 INFO - psutil == 3.1.1 07:15:19 INFO - requests == 1.2.3 07:15:19 INFO - wsgiref == 0.1.2 07:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:19 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 07:15:19 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 07:15:19 INFO - Using env: {'DISPLAY': ':0', 07:15:19 INFO - 'HOME': '/home/cltbld', 07:15:19 INFO - 'LANG': 'en_US.UTF-8', 07:15:19 INFO - 'LANGUAGE': 'en_US:en', 07:15:19 INFO - 'LOGNAME': 'cltbld', 07:15:19 INFO - 'MAIL': '/var/mail/cltbld', 07:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:19 INFO - 'MOZ_NO_REMOTE': '1', 07:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:19 INFO - 'NO_EM_RESTART': '1', 07:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:19 INFO - 'PWD': '/builds/slave/test', 07:15:19 INFO - 'SHELL': '/bin/bash', 07:15:19 INFO - 'SHLVL': '1', 07:15:19 INFO - 'TERM': 'linux', 07:15:19 INFO - 'TMOUT': '86400', 07:15:19 INFO - 'USER': 'cltbld', 07:15:19 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:19 INFO - '_': '/tools/buildbot/bin/python'} 07:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:19 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 1)) 07:15:19 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 2)) 07:15:19 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 3)) 07:15:19 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 4)) 07:15:19 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 5)) 07:15:19 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 6)) 07:15:19 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 7)) 07:15:19 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 8)) 07:15:19 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:19 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 3)) 07:15:19 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:19 INFO - Cleaning up... 07:15:19 INFO - Return code: 0 07:15:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e6210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, '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': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', '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 07:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:15:19 INFO - Using env: {'DISPLAY': ':0', 07:15:19 INFO - 'HOME': '/home/cltbld', 07:15:19 INFO - 'LANG': 'en_US.UTF-8', 07:15:19 INFO - 'LANGUAGE': 'en_US:en', 07:15:19 INFO - 'LOGNAME': 'cltbld', 07:15:19 INFO - 'MAIL': '/var/mail/cltbld', 07:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:19 INFO - 'MOZ_NO_REMOTE': '1', 07:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:19 INFO - 'NO_EM_RESTART': '1', 07:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:19 INFO - 'PWD': '/builds/slave/test', 07:15:19 INFO - 'SHELL': '/bin/bash', 07:15:19 INFO - 'SHLVL': '1', 07:15:19 INFO - 'TERM': 'linux', 07:15:19 INFO - 'TMOUT': '86400', 07:15:19 INFO - 'USER': 'cltbld', 07:15:19 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:19 INFO - '_': '/tools/buildbot/bin/python'} 07:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:20 INFO - Downloading/unpacking jsonschema 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:21 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 07:15:21 INFO - Downloading/unpacking functools32 (from jsonschema) 07:15:21 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 07:15:21 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 07:15:21 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 07:15:21 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 07:15:21 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 07:15:21 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 07:15:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:22 INFO - warning: no files found matching '*.txt' 07:15:22 INFO - no previously-included directories found matching 'build' 07:15:22 INFO - no previously-included directories found matching 'dist' 07:15:22 INFO - no previously-included directories found matching '.git*' 07:15:22 INFO - Installing collected packages: jsonschema, functools32 07:15:22 INFO - Running setup.py install for functools32 07:15:22 INFO - warning: no files found matching '*.txt' 07:15:22 INFO - no previously-included directories found matching 'build' 07:15:22 INFO - no previously-included directories found matching 'dist' 07:15:22 INFO - no previously-included directories found matching '.git*' 07:15:22 INFO - Successfully installed jsonschema functools32 07:15:22 INFO - Cleaning up... 07:15:22 INFO - Return code: 0 07:15:22 INFO - Running post-action listener: _resource_record_post_action 07:15:22 INFO - Running post-action listener: _start_resource_monitoring 07:15:22 INFO - Starting resource monitoring. 07:15:22 INFO - ##### 07:15:22 INFO - ##### Running install step. 07:15:22 INFO - ##### 07:15:22 INFO - Running pre-action listener: _resource_record_pre_action 07:15:22 INFO - Running main action method: install 07:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:22 INFO - Reading from file tmpfile_stdout 07:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:22 INFO - Reading from file tmpfile_stdout 07:15:22 INFO - Output received: 07:15:22 INFO - Usage: mozinstall [options] installer 07:15:22 INFO - Options: 07:15:22 INFO - -h, --help show this help message and exit 07:15:22 INFO - -d DEST, --destination=DEST 07:15:22 INFO - Directory to install application into. [default: 07:15:22 INFO - "/builds/slave/test"] 07:15:22 INFO - --app=APP Application being installed. [default: firefox] 07:15:22 INFO - mkdir: /builds/slave/test/build/application 07:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:15:36 INFO - Reading from file tmpfile_stdout 07:15:36 INFO - Output received: 07:15:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:36 INFO - Running post-action listener: _resource_record_post_action 07:15:36 INFO - ##### 07:15:36 INFO - ##### Running run-tests step. 07:15:36 INFO - ##### 07:15:36 INFO - Running pre-action listener: _resource_record_pre_action 07:15:36 INFO - Running main action method: run_tests 07:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:36 INFO - Python 2.7.3 07:15:36 INFO - Return code: 0 07:15:36 INFO - grabbing minidump binary from tooltool 07:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:36 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 0x2878220>, '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 0x27e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:36 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 07:15:36 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 07:15:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:36 INFO - Return code: 0 07:15:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 07:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 07:15:36 INFO - Using env: {'DISPLAY': ':0', 07:15:36 INFO - 'HOME': '/home/cltbld', 07:15:36 INFO - 'LANG': 'en_US.UTF-8', 07:15:36 INFO - 'LANGUAGE': 'en_US:en', 07:15:36 INFO - 'LOGNAME': 'cltbld', 07:15:36 INFO - 'MAIL': '/var/mail/cltbld', 07:15:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:36 INFO - 'MOZ_NO_REMOTE': '1', 07:15:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:36 INFO - 'NO_EM_RESTART': '1', 07:15:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:36 INFO - 'PWD': '/builds/slave/test', 07:15:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:36 INFO - 'SHELL': '/bin/bash', 07:15:36 INFO - 'SHLVL': '1', 07:15:36 INFO - 'TERM': 'linux', 07:15:36 INFO - 'TMOUT': '86400', 07:15:36 INFO - 'USER': 'cltbld', 07:15:36 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448462967.221156-1019983437', 07:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:36 INFO - '_': '/tools/buildbot/bin/python'} 07:15:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 07:15:37 INFO - mozversion INFO | application_buildid: 20151125055133 07:15:37 INFO - mozversion INFO | application_changeset: 06a5ac492313d07196cecbfce01e55177536d5a4 07:15:37 INFO - mozversion INFO | application_display_name: Nightly 07:15:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:37 INFO - mozversion INFO | application_name: Firefox 07:15:37 INFO - mozversion INFO | application_remotingname: firefox 07:15:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:15:37 INFO - mozversion INFO | application_vendor: Mozilla 07:15:37 INFO - mozversion INFO | application_version: 45.0a1 07:15:37 INFO - mozversion INFO | platform_buildid: 20151125055133 07:15:37 INFO - mozversion INFO | platform_changeset: 06a5ac492313d07196cecbfce01e55177536d5a4 07:15:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:15:37 INFO - mozversion INFO | platform_version: 45.0a1 07:15:37 INFO - 2015-11-25 07:15:37,252 DEBUG : using testdate: 1448464537 07:15:37 INFO - 2015-11-25 07:15:37,252 DEBUG : actual date: 1448464537 07:15:37 INFO - 2015-11-25 07:15:37,260 INFO : starting webserver on 'localhost:51533' 07:15:37 INFO - 2015-11-25 07:15:37,261 INFO : Starting test suite talos-linux64-ix-025 07:15:37 INFO - 2015-11-25 07:15:37,261 INFO : Starting test dromaeo_css 07:15:37 INFO - 2015-11-25 07:15:37,261 DEBUG : operating with platform_type : linux_ 07:15:37 INFO - 2015-11-25 07:15:37,262 INFO : Initialising browser for dromaeo_css test... 07:15:37 INFO - 2015-11-25 07:15:37,280 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp2s6YO/profile http://localhost:51533/getInfo.html 07:15:44 INFO - 2015-11-25 07:15:44,088 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:15:44 INFO - 2015-11-25 07:15:44,088 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:15:44 INFO - 2015-11-25 07:15:44,088 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:15:44 INFO - 2015-11-25 07:15:44,088 DEBUG : BROWSER_OUTPUT: __metrics 07:15:44 INFO - 2015-11-25 07:15:44,225 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:15:45 INFO - 2015-11-25 07:15:45,600 INFO : Browser initialized. 07:15:45 INFO - 2015-11-25 07:15:45,601 INFO : Running cycle 1/1 for dromaeo_css test... 07:15:45 INFO - 2015-11-25 07:15:45,601 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp2s6YO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:15:57 INFO - 2015-11-25 07:15:57,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 139366400 07:15:57 INFO - 2015-11-25 07:15:57,504 DEBUG : BROWSER_OUTPUT: 07:16:48 INFO - 2015-11-25 07:16:48,841 DEBUG : BROWSER_OUTPUT: 1448464608839 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] 07:19:01 INFO - 2015-11-25 07:19:01,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51533/tests/dromaeo/cssquery-ext.html) 07:19:02 INFO - 2015-11-25 07:19:02,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 247480320 07:19:02 INFO - 2015-11-25 07:19:02,178 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-25 07:22:04,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-ext.html (next: http://localhost:51533/tests/dromaeo/cssquery-jquery.html) 07:22:05 INFO - 2015-11-25 07:22:05,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 216059904 07:22:05 INFO - 2015-11-25 07:22:05,250 DEBUG : BROWSER_OUTPUT: 07:25:07 INFO - 2015-11-25 07:25:07,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51533/tests/dromaeo/cssquery-mootools.html) 07:25:07 INFO - 2015-11-25 07:25:07,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 209170432 07:25:07 INFO - 2015-11-25 07:25:07,944 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-11-25 07:28:09,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51533/tests/dromaeo/cssquery-prototype.html) 07:28:10 INFO - 2015-11-25 07:28:10,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 200855552 07:28:10 INFO - 2015-11-25 07:28:10,433 DEBUG : BROWSER_OUTPUT: 07:31:13 INFO - 2015-11-25 07:31:13,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51533/tests/dromaeo/cssquery-yui.html) 07:31:13 INFO - 2015-11-25 07:31:13,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 206548992 07:31:13 INFO - 2015-11-25 07:31:13,842 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/dromaeo/cssquery-yui.html (next: http://localhost:51533/tests/dromaeo/cssquery-dojo.html) 07:34:16 INFO - 2015-11-25 07:34:16,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 249356288 07:34:16 INFO - 2015-11-25 07:34:16,640 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,642 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:34:16 INFO - 2015-11-25 07:34:16,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:34:16 INFO - 2015-11-25 07:34:16,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:34:16 INFO - 2015-11-25 07:34:16,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:34:16 INFO - 2015-11-25 07:34:16,643 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2627.684677838659;2724.7547720705134;2733.5079685656574;2746.107515057606;2751.11964171465;4517.593416592506;4642.837500687477;4676.368690226814;4710.693804902683;4724.645651576128;4588.77056147193;4654.86035418938;4683.133620280242;4698.953010469894;4823.807047718095;4300.053988122616;4316.223079845627;4325.589069038437;4335.978320108395;4340.500842403117;4208.221479026374;4375.015621485172;4378.496472905625;4428.959194589285;4429.46846378435;4192.0777428965885;4251;4270.551592082848;4313.309870420749;4331.328644060176;4342.978285108586;4344.587264209895;4354.586314300136;4358.0848021915435;4384.254676704968;4320.049589090395;4324.805383757707;4334.956650433487;4346.130773845212;4383.802728877176;4504.549545045502;4537.909241815179;4622.8150873965005;4646.814127434898;4658.1848176568965;4982.427020892607;5022.196448568212;5028.7737051832755;5029.119904016819;5029.723365214912;5039.244113383022;5048.848534543969;5051.040302342543;5085.338905942203;5094.286799848024;4489.663275254369;4595.793189306489;4607.493175750665;4670.976645116787;4724.244120940667;5024.748762561857;5098.209777484496;5098.770555325019;5152.896942061213;5153.3815942087185;4938.58022068121;4946.3817022872145;4951.678140920829;4954.47977962316;4991.401031876198;4822.156122678517;4981.402231732215;4981.800727970841;5022.196448568212;5025.170846810309;4781.976090119527;4934.555889969848;4939.209726443752;4940.407151141886;4956.628252881048;4967.503249675004;4976.253561965662;4976.278439626306;4979.601631869442;5018.949810501921;3979.343408337592;4053.8986525336513;4094.303968325392;4184.225918205142;4228.9788551057045;3579.0336609115393;3603.981980090135;3614.2410093880053;3630.8184590770356;3649.033006253345;4281.700280980302;4287.464066991626;4289.1421715657;4318.093200427883;4319.67602429819;4743.5967942724565;4814.229723244264;4850.660453768273;4989.451160372356;4999.850004499871;4199.664026877843;4257.765822879772;4268.786560671954;4298.26929421999;4309.245881970643;4397.274449715825;4424.955750442518;4437.667174961891;4437.844675436409;4480.507144214133;4576.633869290516;4689.015306785614;4691.413573303337;4757.286407038971;4814.855554333376;4878.365812444359;4940.456549779449;4958.429780575136;4962.131626965339;5001.324821149244;4693.296005599051;4695.718256904596;4702.952970470388;4739.241721324572;4748.453927798348;4682.321063445849;4791.401074865642;4802.7838747255755;4932.186189278729;4991.9500804991485;4830.106430310404;4907.631927605373;4931.0877487663465;4937.604991600591;4971.975140124277;4771.809127634856;4788.11419887322;4815.759212039454;4816.109019831342;4861.343718597944;4613.792379342871;4702.15361234981;4703.60019398355;4817.108834865421;4849.054434385402;4646.117237724821;4757.381540399864;4766.594839438548;4805.567498925114;4806.182948898766;4934.136526107988;4935.580475659609;4941.678790878582;4972.204447288561;4978.502149784992;4619.884502887455;4734.1478533862855;4737.123632128068;4769.856904292877;4881.29221262922 07:34:16 INFO - 2015-11-25 07:34:16,645 DEBUG : BROWSER_OUTPUT: |1;ext.html;471.9244920812671;489.9902001959963;571.6598623818828;572.7136431784108;579.4205794205795;22411.551768964633;22607.095716171334;23103.768962310394;23161.76838231617;36030;39853;40717.796411017975;40831.59168408315;40899;40900.795496022554;7938.483998540105;8119.959400202991;8121;8130.227628375294;8131.983502062242;6646.368594983493;6829.385355318021;6833.111695479605;7894.526328420285;9745.415275083518;9596.856047159297;9601.80796384072;9613.375130616487;9622.663206787764;9702.126808587225;9762;9878.209743220525;9879.950600247024;9881.95059024704;9882.407055576688;9652.420854748667;9803.264755143322;9804.313698041069;9806.313558050939;9957.054079862473;37588.43617345742;38125.61874381248;38128.42807357864;38169.0457738556;38175;2589.9870500647376;2687.583424569195;2729.208529526435;2736.3569561153113;2771.431856469439;28001.439971200667;28649.71350286512;28692.856535717397;29049.709502904912;29059.56410653842;3482.8432720527635;3501.6673416025437;3510.8244587770764;3521.330947120039;3578.427451607756;225962;226593;227046;227151;227180;34399.82800085984;55815.16277255763;56525;57057.42942570604;57099;29465.410691786044;47046.52953470421;48266.5173348269;48285.275720864214;48309.75845120752;12862.67843303925;13052.282124483245;13062.934685326512;13079.084464087422;13088.08383413152;9994.300398972002;10074.69775906724;10076.244281678757;10078.798424031478;10080.899191008142;18796.624067518573;18862.811371886106;18879.244830206913;19180;19202.13590388436;7160.820979475555;7349.485536012535;7384.852302953911;7396.482246242711;7443.218462061405;905.2938707807921;971.5919313888184;980.7155924781877;996.0985308296003;1026.08165691707;24121;24361.390965225655;24505.264842054767;24527.264182074567;24529.50940981206;934.9158575728081;954.6754103604808;956.4930586789013;1025.6256466389714;1049.490996866519;13894.23581703016;14624.415023399157;14882.479113230986;15135.772963405558;15248.313825877862;251179;257487;257488;258671;260268;47384.5261547387;47468;47548.76225618919;47602.5239747605;47758.76120619444;1187.0622208455395;1190.33936165429;1192.4455128365353;1200.2078628105407;1205.2226314027403;19499.112640168423;26395.472090557698;27287.863560682068;28264.43471130607;28364.43271134607;41797.1640567193;42463.787681061396;42480.78759606182;42488.78755606326;42602.78698606487;220179;221428;221652;221753;222139;20921.26775562848;21507.247246346302;26793.86603066972;28235.43529129447;28966.710332897244;36988.63011369852;37141.44287835739;37368.81315593405;37657.24685506329;37665.2466950665;31649.09439036953;32015.199620009687;32042.35915281728;32462;32638.34723305473;21001.57996840024;28146.155615331572;31682.366352673278;32060.74206019478;32424.351512969137;28871.42257154803;29123.708762912946;29484.410311794072;29500.852495737385;29827.552586711652;26317.07890223833;26582.86708566522;27047.459050819267;27182.864085679445;27397.726022739516;20868.895655521625;21833.454163646034;21871.562568748854;22108.447288817264;22173.778262217817 07:34:16 INFO - 2015-11-25 07:34:16,646 DEBUG : BROWSER_OUTPUT: |2;jquery.html;312.70293221439607;321.30758216044416;321.6301253558407;326.7141251405019;338.83566470261917;11378.089752819755;11717.70705732357;15400.30698618562;15656.295466703983;15765.054096754202;14323.498677546288;14709.485168019122;14913.32890019949;15449.296373134712;15488.457903973363;4004.63958243758;4869.391326084239;4916.43461001984;4931.605471562267;5012.122878496249;4870.780814863322;4908.656394052417;4909.705417674951;4911.607071434295;4915.557599816016;4735.100330937111;4844.055409195191;4856.125897338477;4957.7769000395065;4959.950400495985;4813.879653008667;4828.661993660445;4829.420469543659;4863.659543831933;4902.338184345103;4231.705856521191;4312.417823593806;4319.848805291831;4322.416473776031;4322.740635561876;19805.306814261578;19866.602667946703;20011.89994050035;20048.1980720771;20172;1812.4925020994142;1879.135597625094;1904.381076150243;1954.491832123658;1971.2115153938396;11911.702207444883;12051.517939282418;12172.695682607917;12335.136540442172;12552;1602.8397160283994;1622.4402581109498;1623.3019801485357;1624.6669432766255;1640.7620894970162;47715;48096;52255.73872130653;54387.456125438635;56901;8675.566221689016;8739.344549158839;8869.73390798277;8984;9059.864102038475;10285.22860785444;10441.216908731876;10763.892361076289;10832.40421776794;11683.240589361665;6591.077249185118;6636.037774522763;6728.596284222962;6871.415929645936;6974.128233970754;6079.05774604937;6081.543884208702;6098.664573448415;6123.112148738408;6491.415772580491;4005.1589166274825;4053.7973101344814;4073.9592604073578;4140.834366625361;4179.6029377209115;1700.8129105798353;1716.1848122142133;1732.2984191402502;1735.8524525415228;1743.0848804377804;777.4635501503944;785.407017701643;797.0475282037909;898.4743924803932;935.2144198872979;15328.080315180901;15687.607809804618;15757.133357665438;15811.367545298059;15875.364985400454;790.4387884601997;794.2256300107465;809.8542262392826;810.096742132518;815.1481701621819;8738.86891696625;8774.956125219333;9234.215091717146;9254.583543740548;9362.765930851647;290769;294385;495617;500753;544923;37595.62404375976;55099.72450137804;59763.701181493816;62763.6861815688;63079.05381419283;355.7367548014502;454.8385323210279;468.0335108001965;469.16488650202695;469.2328043648591;8330.208630180123;9307.395019323721;9366.906330936603;9473.952630236805;9574.234061275221;29640.703592963793;30055.098347049625;30211.395772083997;30570.694293057673;30988.53517197289;37910.2417951645;38504;38728.419073713354;38985.805070974464;41283.1743365137;9070;9075.54622268897;9107.772305692411;9124.133207345292;9402.717918462457;15790.368385264921;16231.269592868586;16409;16589.9262592176;16818.411355602497;12176.878231217928;13057.738845223232;13220.40508177115;13578.38897249646;13604.65988350299;13535.661608459868;13680.65798355049;13779.793303100261;13797.172169669851;14310.427582896567;13692.589222323346;14324.713505729618;14623.707525849637;14645.194514301817;14649.340779664728;8381.539015354214;8738.213560779306;8739.38824282294;8849.247813935888;8876.289896808368;12634.810477842655;12679.302638354979;12707.80938285945;13611.183328999896;13660.453581856615 07:34:16 INFO - 2015-11-25 07:34:16,649 DEBUG : BROWSER_OUTPUT: |3;mootools.html;824.0358780227134;1342.664333916521;1395.6999245162287;1450.267614854499;1598.856102950735;5505.256790333309;5811.622244554106;6695.63174025429;6855.760048398307;6919.273476284993;6851.931480685192;6917.100776899008;6958.130233720785;6958.617276049815;6961.060256865321;2016.5765189310262;2033.3493282149718;2049.1393614681797;2051.984267787447;2068.1830676882623;2055.7122002919527;2080.771115177329;2088.3526106906834;2109.0193060226993;2110.1559376249547;2005.6289586426485;2019.4143698327541;2033.2985120133603;2043.5810658814908;2046.4065421027883;2044.427560283123;2053.1068984991425;2056.907439165241;2057.300517823947;2079.573687394088;1994.6509360861792;2007.65869802134;2007.7691065527506;2009.3168322770327;2028.5537181820123;5378.381486129067;6812.659367031629;6889;6889.207741109786;6922;3265.2653153040615;3827.7703337799544;3894.7273690841653;3894.766314021168;3901.200253947934;2601.609758536216;2603.336149281921;2648.589468632365;2657.601359796046;2720.9727902721115;867.4535042922981;869.5565261716507;1725.577233577769;1740.6431681505387;1766.1081154017268;9079.727608171765;9141.588628511667;9145.222656074242;9147.771305717344;9151.77120571991;3713.350163721338;3750.081230098643;3800.638939300762;3812.961870381316;3825.9808700956874;7329.413646908234;7352.926470735331;7356.485046046725;7365;7411.407087432993;4003.01926028125;4004.95871073523;4007.8196481158416;4009.0979529605606;4009.3184158693093;3673.1918977824835;3674.430463278196;3676.4117741161285;3677.2093999790172;3679.7424180307657;3029.242689327668;3033.2871775132826;3047.1772621392543;3055.495843185894;3065.4788685923445;898.9011208767031;899.964001439935;906.8367693815045;919.9448033118034;920.2178148573659;823.0534884882313;823.3413269384469;825.2119226139023;825.9752207433787;826.6197549127469;6209.565330426917;6247.5939063961605;6288.937110628926;6311.873762524724;6380.457661098766;434.2227412930882;437.1061179887075;438;441.99446259759304;443.4545509023919;4343;4957.529034741694;4995.625328100407;5018.974905125524;5023.598112151019;7376.262373762688;8155.877661835078;8223.588820558949;8329.583520823935;8357.164283571594;8109.837803243902;8113.148119447491;8200.58997050145;8215.958920205361;8230.806533052673;5906.940930590639;5941.405859414111;6021.849453763603;6036.486898613579;6090.512758979183;6351.587146835625;6371.108044873628;6378.394052564999;6379.776707815204;6385.946318857336;7237.276272372721;7301.050863387725;7437.181909990005;7439.256074392734;7469.477136600603;7442.8511429770015;7613.124490683642;7650.65572049248;7656.196099409704;7673.002509673706;5526.309211348582;5622.269105016322;5686.175504551899;5711.171880077282;5723.914141287801;6384.968075159594;6443.806685799434;6447.290798012309;6451.48388128958;6454.322296158835;6047.153398524298;6137.570370074052;6214.627122372672;6261.123442718114;6312.147860038836;6013.428724271187;6019.307779605401;6034.487068599043;6106.5114790817515;6199;6049.032154855378;6152.661603611844;6161.322254552086;6163;6172.5679202457195;5710.628809127394;5736.254286942671;5750.942490575041;5757.366689664217;5794.739236734273;5601.103823388401;5706.372299047019;5737.8565535861935;5744.827655170185;5759.366469688414 07:34:16 INFO - 2015-11-25 07:34:16,650 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.66625046822327;305.58287936966036;310.27395893608957;311.850311850312;312.9937401251975;5395.136778115502;5440.265564148839;5444.455554444564;5448.700321482322;5483.643563168392;5116.1814109742445;5224.484899379176;5268.5521730652845;5385.865353366168;5392.649477783942;4189.141226048668;4195.832166713343;4209.621134097923;4212.136512015029;4219.831206751726;3899.25914076326;4201.327787553992;4206;4214.7681877496725;4222.239996800575;3950.2889479893606;3963.8414463421573;4034.273830710471;4156.231097247004;4158;4157.397177409259;4159.064210552617;4159.105792254664;4161.667066634662;4166;3658.1951970566433;3662.7069834413182;3662.7619204751604;3663.065918190871;3663.9633603663888;5161.587073034186;5192.039472697563;5201.115810312256;5213.296205012312;5215.0873597120735;4601.148787474328;4713.952860471386;4716.410448693913;4718.433787945434;4774.594159496447;5614.831555053355;5630.605857589971;5631.4087020863035;5633.63381380209;5639.915401268984;3891.630295121959;3891.9610803892165;3893.3381325174787;3895.5325360956585;3897.9805100974313;5827.533797296206;5894.4989675877605;5900.262467191601;5902.1146827976145;5917.55618328627;3881.728279020498;3985.123272879962;4002.079521710023;4004.759714417144;4007.7996100194873;4029.0531725044593;4050.10897602527;4051.534073581517;4052.1895620875944;4058.2695114879016;4678.953210467852;4681.063787242565;4687.414073240845;4688.765561721901;4695.882602934954;5634.830955071355;5634.887302254014;5640.5487560995025;5641.210230567724;5643.661380317194;1299.8895093916933;1321.5242512695422;1329.9002574806927;1416.1644629668544;1430.6494908747422;955.9187469065068;960.7406000379858;963.1476143612953;972.1590823937244;978.8923218445965;4933.112039832793;4940.530649588283;4941.061198372297;4946.282788995575;4957.628177886673;5812.59311848175;5813.6221145625395;5814.883702325929;5824.825255242349;5827.883442331215;4847.321375007502;4892.975535122373;4895.975520122377;4901.09329773993;4906.165951788204;3046.34503581731;3075.4617941860083;3128.6402063762503;3138.5919830422354;3141.277506173593;5505.917411238835;5508.338999320027;5508.889822203533;5518.696471694096;5521.171824226398;5967.731452084667;5971.79098731551;5973.1338955852025;5976.043832986788;5978;5506.697131657797;5510.779568817203;5514.310711161105;5516.172574113834;5521.889562208814;5732.570057245806;5807.738651760766;5903.881922361615;5912.142739302691;5913.940860591339;5765.250517432707;5770.826875193751;5774.942250577608;5777.711114444177;5778.306603207642;5608.383077861514;5613.719314034363;5614;5617.325920889356;5617.578681598815;3922.431247469044;4014.437978682928;4044.9595504044582;4052.8378864846254;4067.91864162721;5628.605997580294;5848.064309710426;5848.444397782204;5851.327097383855;5853.619514731528;5583.180493850579;5594.3286805581965;5694.231278777312;5702.743376548148;5704.372519022987;5670;5674.432556744293;5684;5687.374388817309;5697.54419646419;5552.750126244248;5556.805511807067;5570.303712035996;5576.721163941867;5580.35825880029;5563.666180029211;5715.428457154251;5718.599698021098;5724.542036636975;5727.942720572741;5551.666899986014;5579.69311687861;5582.190582365615;5588.245586845724;5588.748506317307 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: |5;yui.html;548.1284757235994;615.6490800243863;617.080549980529;689.4932224814763;703.1421665568008;11423.257488263267;11527.423628818568;11602.303861768289;11606.59376921808;11626.244294120897;8521.446106003106;12226;12335.876641233584;12339.938300308486;12345.13584049117;768.6272158003378;783.6081959020489;784.145281643009;784.2667106255641;784.3803395317692;771.2595907928395;776.0183368039435;777.3625626985873;777.5995362388375;777.9844403111935;813.5078277642031;819.4837252530897;821.0885916632533;821.7288294862681;822.2846123872209;792.2513225002375;809.3161278719473;809.8299357135008;811.0672726364669;811.9594020299021;598.7395482964924;598.9936905997922;599.0744300056423;599.595273190599;600.1477901380051;10670.413127277996;10787.083097936606;10806.945965270123;10808.243422960395;11650.650480485514;10942.015218630362;11101.500432480558;11149.609763658233;11564.768704625945;11629.360385178812;9255.722328330161;9496.43021418717;9609.711708648752;9669.08143726352;9731.464769437678;3209.1014515935576;3268.1829542614346;3297.3075654112663;3334.4664853623303;3339.716124129452;32817;34742;35046.12384690403;38331.808340958116;38855.61144388576;7304.415646748247;8435.873461898076;8647.308215342757;9020.774480638036;9337.206337461255;15629.3748250071;15686.294116764773;15712.921435392978;15735.134567598892;15735.68528629421;5895.35151133375;6161.7227224775;6235.657038862906;6271.560990730605;6306.873862522724;3518.20840310928;3606.6213047630145;3625.6736893679167;3674.797886116236;3688.7602305850032;2650.907218247352;2683.7047924728263;2684.302081458835;2688.3010417291644;2689.435218604076;474.7175430618776;478.5501628469228;483.9709617422966;484.1889834527223;484.791539637952;458.55978260869273;543.9755211015514;557.2115456628906;587.2864469669372;618.0667192539298;7277.52564128199;8370.246677799027;8412.15878412166;8594.398392112493;8616.655333786579;492.778249787597;503.4688403734096;566.6147020026422;582.6853499110517;596.582392325374;3406.9659303407143;3452.723782097426;3515.226650136966;3559.2347645256395;3644.7084233261276;50267.49732502701;51010.74494627503;51285.23072153921;51793;52294.21558676623;43662.56337436585;43703.12593748107;43740.125197496505;44009.77995110068;44052.3392149118;34131.31737365239;40442.59557404447;42768.78615606902;46411.30383044325;47328;7841.607919604111;7974.322182614543;7977.401694872791;8016.238457346542;8142.552159631277;30308.24229394283;31174;31267;31389.959652622507;32391.51412728764;40097.79951100226;40636.59363406446;40773.388399174626;43313;43327.13345733131;9158.496282704515;9478.478683672463;9518.809623807623;9645.9035409645;9671.758206044906;10407.375557466576;11252.718682033015;11278.830817537908;11362.772744545227;11579.13156513248;10223.488825558841;10237.846432303373;10353.119984801075;10418.843717344094;10635.94682026585;9810.362326448758;9923.454210018519;10085.899141008496;10396.58413663445;10830.566777328819;9869.851952220579;10043.497825108861;10566.8414973777;10727.624533141303;10900.890991090304;7691.5769632670745;8132.87800683002;8262.628181731716;8406.705765298186;8599.355048371272;8083.9191608083165;8106.432549721699;8176.528224919572;8287.834243315221;8391.244787968868 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,891 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: __startTimestamp1448465656641__endTimestamp 07:34:16 INFO - 2015-11-25 07:34:16,651 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4596.11 Median:4703.60 stddev:469.80 (10.0%) stddev-sans-first:445.14 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: Values: 2627.7 2724.8 2733.5 2746.1 2751.1 4517.6 4642.8 4676.4 4710.7 4724.6 4588.8 4654.9 4683.1 4699.0 4823.8 4300.1 4316.2 4325.6 4336.0 4340.5 4208.2 4375.0 4378.5 4429.0 4429.5 4192.1 4251.0 4270.6 4313.3 4331.3 4343.0 4344.6 4354.6 4358.1 4384.3 4320.0 4324.8 4335.0 4346.1 4383.8 4504.5 4537.9 4622.8 4646.8 4658.2 4982.4 5022.2 5028.8 5029.1 5029.7 5039.2 5048.8 5051.0 5085.3 5094.3 4489.7 4595.8 4607.5 4671.0 4724.2 5024.7 5098.2 5098.8 5152.9 5153.4 4938.6 4946.4 4951.7 4954.5 4991.4 4822.2 4981.4 4981.8 5022.2 5025.2 4782.0 4934.6 4939.2 4940.4 4956.6 4967.5 4976.3 4976.3 4979.6 5018.9 3979.3 4053.9 4094.3 4184.2 4229.0 3579.0 3604.0 3614.2 3630.8 3649.0 4281.7 4287.5 4289.1 4318.1 4319.7 4743.6 4814.2 4850.7 4989.5 4999.9 4199.7 4257.8 4268.8 4298.3 4309.2 4397.3 4425.0 4437.7 4437.8 4480.5 4576.6 4689.0 4691.4 4757.3 4814.9 4878.4 4940.5 4958.4 4962.1 5001.3 4693.3 4695.7 4703.0 4739.2 4748.5 4682.3 4791.4 4802.8 4932.2 4992.0 4830.1 4907.6 4931.1 4937.6 4972.0 4771.8 4788.1 4815.8 4816.1 4861.3 4613.8 4702.2 4703.6 4817.1 4849.1 4646.1 4757.4 4766.6 4805.6 4806.2 4934.1 4935.6 4941.7 4972.2 4978.5 4619.9 4734.1 4737.1 4769.9 4881.3 07:34:16 INFO - 2015-11-25 07:34:16,652 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,653 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38771.73 Median:31848.78 stddev:61296.60 (192.5%) stddev-sans-first:61401.09 07:34:16 INFO - 2015-11-25 07:34:16,653 DEBUG : BROWSER_OUTPUT: Values: 471.9 490.0 571.7 572.7 579.4 22411.6 22607.1 23103.8 23161.8 36030.0 39853.0 40717.8 40831.6 40899.0 40900.8 7938.5 8120.0 8121.0 8130.2 8132.0 6646.4 6829.4 6833.1 7894.5 9745.4 9596.9 9601.8 9613.4 9622.7 9702.1 9762.0 9878.2 9880.0 9882.0 9882.4 9652.4 9803.3 9804.3 9806.3 9957.1 37588.4 38125.6 38128.4 38169.0 38175.0 2590.0 2687.6 2729.2 2736.4 2771.4 28001.4 28649.7 28692.9 29049.7 29059.6 3482.8 3501.7 3510.8 3521.3 3578.4 225962.0 226593.0 227046.0 227151.0 227180.0 34399.8 55815.2 56525.0 57057.4 57099.0 29465.4 47046.5 48266.5 48285.3 48309.8 12862.7 13052.3 13062.9 13079.1 13088.1 9994.3 10074.7 10076.2 10078.8 10080.9 18796.6 18862.8 18879.2 19180.0 19202.1 7160.8 7349.5 7384.9 7396.5 7443.2 905.3 971.6 980.7 996.1 1026.1 24121.0 24361.4 24505.3 24527.3 24529.5 934.9 954.7 956.5 1025.6 1049.5 13894.2 14624.4 14882.5 15135.8 15248.3 251179.0 257487.0 257488.0 258671.0 260268.0 47384.5 47468.0 47548.8 47602.5 47758.8 1187.1 1190.3 1192.4 1200.2 1205.2 19499.1 26395.5 27287.9 28264.4 28364.4 41797.2 42463.8 42480.8 42488.8 42602.8 220179.0 221428.0 221652.0 221753.0 222139.0 20921.3 21507.2 26793.9 28235.4 28966.7 36988.6 37141.4 37368.8 37657.2 37665.2 31649.1 32015.2 32042.4 32462.0 32638.3 21001.6 28146.2 31682.4 32060.7 32424.4 28871.4 29123.7 29484.4 29500.9 29827.6 26317.1 26582.9 27047.5 27182.9 27397.7 20868.9 21833.5 21871.6 22108.4 22173.8 07:34:16 INFO - 2015-11-25 07:34:16,653 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,653 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23721.62 Median:4063.88 stddev:71684.24 (1763.9%) stddev-sans-first:71863.78 07:34:16 INFO - 2015-11-25 07:34:16,653 DEBUG : BROWSER_OUTPUT: Values: 312.7 321.3 321.6 326.7 338.8 11378.1 11717.7 15400.3 15656.3 15765.1 14323.5 14709.5 14913.3 15449.3 15488.5 4004.6 4869.4 4916.4 4931.6 5012.1 4870.8 4908.7 4909.7 4911.6 4915.6 4735.1 4844.1 4856.1 4957.8 4960.0 4813.9 4828.7 4829.4 4863.7 4902.3 4231.7 4312.4 4319.8 4322.4 4322.7 19805.3 19866.6 20011.9 20048.2 20172.0 1812.5 1879.1 1904.4 1954.5 1971.2 11911.7 12051.5 12172.7 12335.1 12552.0 1602.8 1622.4 1623.3 1624.7 1640.8 47715.0 48096.0 52255.7 54387.5 56901.0 8675.6 8739.3 8869.7 8984.0 9059.9 10285.2 10441.2 10763.9 10832.4 11683.2 6591.1 6636.0 6728.6 6871.4 6974.1 6079.1 6081.5 6098.7 6123.1 6491.4 4005.2 4053.8 4074.0 4140.8 4179.6 1700.8 1716.2 1732.3 1735.9 1743.1 777.5 785.4 797.0 898.5 935.2 15328.1 15687.6 15757.1 15811.4 15875.4 790.4 794.2 809.9 810.1 815.1 8738.9 8775.0 9234.2 9254.6 9362.8 290769.0 294385.0 495617.0 500753.0 544923.0 37595.6 55099.7 59763.7 62763.7 63079.1 355.7 454.8 468.0 469.2 469.2 8330.2 9307.4 9366.9 9474.0 9574.2 29640.7 30055.1 30211.4 30570.7 30988.5 37910.2 38504.0 38728.4 38985.8 41283.2 9070.0 9075.5 9107.8 9124.1 9402.7 15790.4 16231.3 16409.0 16589.9 16818.4 12176.9 13057.7 13220.4 13578.4 13604.7 13535.7 13680.7 13779.8 13797.2 14310.4 13692.6 14324.7 14623.7 14645.2 14649.3 8381.5 8738.2 8739.4 8849.2 8876.3 12634.8 12679.3 12707.8 13611.2 13660.5 07:34:16 INFO - 2015-11-25 07:34:16,654 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,654 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4697.99 Median:5924.17 stddev:2439.42 (41.2%) stddev-sans-first:2428.87 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: Values: 824.0 1342.7 1395.7 1450.3 1598.9 5505.3 5811.6 6695.6 6855.8 6919.3 6851.9 6917.1 6958.1 6958.6 6961.1 2016.6 2033.3 2049.1 2052.0 2068.2 2055.7 2080.8 2088.4 2109.0 2110.2 2005.6 2019.4 2033.3 2043.6 2046.4 2044.4 2053.1 2056.9 2057.3 2079.6 1994.7 2007.7 2007.8 2009.3 2028.6 5378.4 6812.7 6889.0 6889.2 6922.0 3265.3 3827.8 3894.7 3894.8 3901.2 2601.6 2603.3 2648.6 2657.6 2721.0 867.5 869.6 1725.6 1740.6 1766.1 9079.7 9141.6 9145.2 9147.8 9151.8 3713.4 3750.1 3800.6 3813.0 3826.0 7329.4 7352.9 7356.5 7365.0 7411.4 4003.0 4005.0 4007.8 4009.1 4009.3 3673.2 3674.4 3676.4 3677.2 3679.7 3029.2 3033.3 3047.2 3055.5 3065.5 898.9 900.0 906.8 919.9 920.2 823.1 823.3 825.2 826.0 826.6 6209.6 6247.6 6288.9 6311.9 6380.5 434.2 437.1 438.0 442.0 443.5 4343.0 4957.5 4995.6 5019.0 5023.6 7376.3 8155.9 8223.6 8329.6 8357.2 8109.8 8113.1 8200.6 8216.0 8230.8 5906.9 5941.4 6021.8 6036.5 6090.5 6351.6 6371.1 6378.4 6379.8 6385.9 7237.3 7301.1 7437.2 7439.3 7469.5 7442.9 7613.1 7650.7 7656.2 7673.0 5526.3 5622.3 5686.2 5711.2 5723.9 6385.0 6443.8 6447.3 6451.5 6454.3 6047.2 6137.6 6214.6 6261.1 6312.1 6013.4 6019.3 6034.5 6106.5 6199.0 6049.0 6152.7 6161.3 6163.0 6172.6 5710.6 5736.3 5750.9 5757.4 5794.7 5601.1 5706.4 5737.9 5744.8 5759.4 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4673.50 Median:5417.70 stddev:1387.12 (25.6%) stddev-sans-first:1351.55 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: Values: 296.7 305.6 310.3 311.9 313.0 5395.1 5440.3 5444.5 5448.7 5483.6 5116.2 5224.5 5268.6 5385.9 5392.6 4189.1 4195.8 4209.6 4212.1 4219.8 3899.3 4201.3 4206.0 4214.8 4222.2 3950.3 3963.8 4034.3 4156.2 4158.0 4157.4 4159.1 4159.1 4161.7 4166.0 3658.2 3662.7 3662.8 3663.1 3664.0 5161.6 5192.0 5201.1 5213.3 5215.1 4601.1 4714.0 4716.4 4718.4 4774.6 5614.8 5630.6 5631.4 5633.6 5639.9 3891.6 3892.0 3893.3 3895.5 3898.0 5827.5 5894.5 5900.3 5902.1 5917.6 3881.7 3985.1 4002.1 4004.8 4007.8 4029.1 4050.1 4051.5 4052.2 4058.3 4679.0 4681.1 4687.4 4688.8 4695.9 5634.8 5634.9 5640.5 5641.2 5643.7 1299.9 1321.5 1329.9 1416.2 1430.6 955.9 960.7 963.1 972.2 978.9 4933.1 4940.5 4941.1 4946.3 4957.6 5812.6 5813.6 5814.9 5824.8 5827.9 4847.3 4893.0 4896.0 4901.1 4906.2 3046.3 3075.5 3128.6 3138.6 3141.3 5505.9 5508.3 5508.9 5518.7 5521.2 5967.7 5971.8 5973.1 5976.0 5978.0 5506.7 5510.8 5514.3 5516.2 5521.9 5732.6 5807.7 5903.9 5912.1 5913.9 5765.3 5770.8 5774.9 5777.7 5778.3 5608.4 5613.7 5614.0 5617.3 5617.6 3922.4 4014.4 4045.0 4052.8 4067.9 5628.6 5848.1 5848.4 5851.3 5853.6 5583.2 5594.3 5694.2 5702.7 5704.4 5670.0 5674.4 5684.0 5687.4 5697.5 5552.8 5556.8 5570.3 5576.7 5580.4 5563.7 5715.4 5718.6 5724.5 5727.9 5551.7 5579.7 5582.2 5588.2 5588.7 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: 07:34:16 INFO - 2015-11-25 07:34:16,655 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12084.42 Median:484.49 stddev:13918.07 (2872.7%) stddev-sans-first:13930.15 07:34:16 INFO - 2015-11-25 07:34:16,657 DEBUG : BROWSER_OUTPUT: Values: 548.1 615.6 617.1 689.5 703.1 11423.3 11527.4 11602.3 11606.6 11626.2 8521.4 12226.0 12335.9 12339.9 12345.1 768.6 783.6 784.1 784.3 784.4 771.3 776.0 777.4 777.6 778.0 813.5 819.5 821.1 821.7 822.3 792.3 809.3 809.8 811.1 812.0 598.7 599.0 599.1 599.6 600.1 10670.4 10787.1 10806.9 10808.2 11650.7 10942.0 11101.5 11149.6 11564.8 11629.4 9255.7 9496.4 9609.7 9669.1 9731.5 3209.1 3268.2 3297.3 3334.5 3339.7 32817.0 34742.0 35046.1 38331.8 38855.6 7304.4 8435.9 8647.3 9020.8 9337.2 15629.4 15686.3 15712.9 15735.1 15735.7 5895.4 6161.7 6235.7 6271.6 6306.9 3518.2 3606.6 3625.7 3674.8 3688.8 2650.9 2683.7 2684.3 2688.3 2689.4 474.7 478.6 484.0 484.2 484.8 458.6 544.0 557.2 587.3 618.1 7277.5 8370.2 8412.2 8594.4 8616.7 492.8 503.5 566.6 582.7 596.6 3407.0 3452.7 3515.2 3559.2 3644.7 50267.5 51010.7 51285.2 51793.0 52294.2 43662.6 43703.1 43740.1 44009.8 44052.3 34131.3 40442.6 42768.8 46411.3 47328.0 7841.6 7974.3 7977.4 8016.2 8142.6 30308.2 31174.0 31267.0 31390.0 32391.5 40097.8 40636.6 40773.4 43313.0 43327.1 9158.5 9478.5 9518.8 9645.9 9671.8 10407.4 11252.7 11278.8 11362.8 11579.1 10223.5 10237.8 10353.1 10418.8 10635.9 9810.4 9923.5 10085.9 10396.6 10830.6 9869.9 10043.5 10566.8 10727.6 10900.9 7691.6 8132.9 8262.6 8406.7 8599.4 8083.9 8106.4 8176.5 8287.8 8391.2 07:34:16 INFO - 2015-11-25 07:34:16,657 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:34:16 INFO - 2015-11-25 07:34:16,657 DEBUG : BROWSER_OUTPUT: 07:34:17 INFO - 2015-11-25 07:34:17,454 INFO : Browser exited with error code: 0 07:34:17 INFO - 2015-11-25 07:34:17,473 INFO : Completed test dromaeo_css (00:18:40) 07:34:17 INFO - 2015-11-25 07:34:17,473 INFO : Starting test kraken 07:34:17 INFO - 2015-11-25 07:34:17,473 DEBUG : operating with platform_type : linux_ 07:34:17 INFO - 2015-11-25 07:34:17,473 INFO : Initialising browser for kraken test... 07:34:17 INFO - 2015-11-25 07:34:17,479 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_DUvQ/profile http://localhost:51533/getInfo.html 07:34:21 INFO - 2015-11-25 07:34:21,784 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:34:21 INFO - 2015-11-25 07:34:21,784 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:34:21 INFO - 2015-11-25 07:34:21,784 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:34:21 INFO - 2015-11-25 07:34:21,784 DEBUG : BROWSER_OUTPUT: __metrics 07:34:21 INFO - 2015-11-25 07:34:21,909 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:23 INFO - 2015-11-25 07:34:23,250 INFO : Browser initialized. 07:34:23 INFO - 2015-11-25 07:34:23,250 INFO : Running cycle 1/1 for kraken test... 07:34:23 INFO - 2015-11-25 07:34:23,250 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_DUvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:34:35 INFO - 2015-11-25 07:34:35,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 139272192 07:34:35 INFO - 2015-11-25 07:34:35,109 DEBUG : BROWSER_OUTPUT: 07:34:37 INFO - 2015-11-25 07:34:37,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51533/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:38 INFO - 2015-11-25 07:34:38,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 177233920 07:34:38 INFO - 2015-11-25 07:34:38,315 DEBUG : BROWSER_OUTPUT: 07:34:41 INFO - 2015-11-25 07:34:41,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51533/tests/kraken/driver.html?testName=audio-dft) 07:34:41 INFO - 2015-11-25 07:34:41,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 167186432 07:34:41 INFO - 2015-11-25 07:34:41,614 DEBUG : BROWSER_OUTPUT: 07:34:44 INFO - 2015-11-25 07:34:44,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51533/tests/kraken/driver.html?testName=audio-fft) 07:34:45 INFO - 2015-11-25 07:34:45,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 152215552 07:34:45 INFO - 2015-11-25 07:34:45,216 DEBUG : BROWSER_OUTPUT: 07:34:47 INFO - 2015-11-25 07:34:47,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51533/tests/kraken/driver.html?testName=audio-oscillator) 07:34:47 INFO - 2015-11-25 07:34:47,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 153473024 07:34:47 INFO - 2015-11-25 07:34:47,834 DEBUG : BROWSER_OUTPUT: 07:34:50 INFO - 2015-11-25 07:34:50,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:50 INFO - 2015-11-25 07:34:50,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 155291648 07:34:50 INFO - 2015-11-25 07:34:50,658 DEBUG : BROWSER_OUTPUT: 07:34:53 INFO - 2015-11-25 07:34:53,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51533/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:54 INFO - 2015-11-25 07:34:54,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 153755648 07:34:54 INFO - 2015-11-25 07:34:54,230 DEBUG : BROWSER_OUTPUT: 07:34:57 INFO - 2015-11-25 07:34:57,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51533/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:58 INFO - 2015-11-25 07:34:58,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 154497024 07:34:58 INFO - 2015-11-25 07:34:58,231 DEBUG : BROWSER_OUTPUT: 07:35:01 INFO - 2015-11-25 07:35:01,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51533/tests/kraken/driver.html?testName=json-parse-financial) 07:35:01 INFO - 2015-11-25 07:35:01,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 154484736 07:35:01 INFO - 2015-11-25 07:35:01,648 DEBUG : BROWSER_OUTPUT: 07:35:03 INFO - 2015-11-25 07:35:03,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:03 INFO - 2015-11-25 07:35:03,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 167723008 07:35:03 INFO - 2015-11-25 07:35:03,949 DEBUG : BROWSER_OUTPUT: 07:35:05 INFO - 2015-11-25 07:35:05,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:06 INFO - 2015-11-25 07:35:06,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 165330944 07:35:06 INFO - 2015-11-25 07:35:06,445 DEBUG : BROWSER_OUTPUT: 07:35:09 INFO - 2015-11-25 07:35:09,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:09 INFO - 2015-11-25 07:35:09,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 175333376 07:35:09 INFO - 2015-11-25 07:35:09,736 DEBUG : BROWSER_OUTPUT: 07:35:12 INFO - 2015-11-25 07:35:12,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:12 INFO - 2015-11-25 07:35:12,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 182710272 07:35:12 INFO - 2015-11-25 07:35:12,837 DEBUG : BROWSER_OUTPUT: 07:35:15 INFO - 2015-11-25 07:35:15,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:16 INFO - 2015-11-25 07:35:16,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 180858880 07:35:16 INFO - 2015-11-25 07:35:16,024 DEBUG : BROWSER_OUTPUT: 07:35:17 INFO - 2015-11-25 07:35:17,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51533/tests/kraken/driver.html?testName=ai-astar) 07:35:18 INFO - 2015-11-25 07:35:18,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 241954816 07:35:18 INFO - 2015-11-25 07:35:18,028 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;116;108;112;113;112;101;114;112;107 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;133;163;163;134;151;155;132;169;139 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;161;162;163;160;165;164;163;162 07:35:18 INFO - 2015-11-25 07:35:18,032 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;83;93;78;72;72;102;90;72 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;133;95;96;95;134;95;96;132 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;111;111;110;110;110 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;147;154;146;146;147;148 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;95;95;95;95 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;70;71;70;70;70;72;69 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;69;69;70;70;71;69;76 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;83;93;83;83;85;84;83 07:35:18 INFO - 2015-11-25 07:35:18,033 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;124;116;122;125;121;123;130;128;121 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;146;153;158;146;140;154;146;147;135 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;69;70;70;72;69;68;67;68 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:35:18 INFO - 2015-11-25 07:35:18,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1448465718030__endTimestamp 07:35:18 INFO - 2015-11-25 07:35:18,035 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,042 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:35:18 INFO - 2015-11-25 07:35:18,042 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:35:18 INFO - 2015-11-25 07:35:18,042 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,042 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:4.34 (3.9%) stddev-sans-first:4.53 07:35:18 INFO - 2015-11-25 07:35:18,042 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 108.0 112.0 113.0 112.0 101.0 114.0 112.0 107.0 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.00 stddev:13.89 (9.0%) stddev-sans-first:14.58 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: Values: 155.0 133.0 163.0 163.0 134.0 151.0 155.0 132.0 169.0 139.0 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 161.0 162.0 163.0 160.0 165.0 164.0 163.0 162.0 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:76.50 stddev:10.74 (14.0%) stddev-sans-first:11.18 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 83.0 93.0 78.0 72.0 72.0 102.0 90.0 72.0 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,043 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:18.30 (19.3%) stddev-sans-first:18.84 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 133.0 95.0 96.0 95.0 134.0 95.0 96.0 132.0 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 111.0 111.0 110.0 110.0 110.0 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.37 (1.6%) stddev-sans-first:2.51 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 147.0 154.0 146.0 146.0 147.0 148.0 07:35:18 INFO - 2015-11-25 07:35:18,044 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.60 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 70.0 71.0 70.0 70.0 70.0 72.0 69.0 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:2.26 (3.3%) stddev-sans-first:2.37 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 69.0 70.0 70.0 71.0 69.0 76.0 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.19 07:35:18 INFO - 2015-11-25 07:35:18,045 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 83.0 93.0 83.0 83.0 85.0 84.0 83.0 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:124.50 stddev:4.42 (3.6%) stddev-sans-first:4.12 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: Values: 130.0 124.0 116.0 122.0 125.0 121.0 123.0 130.0 128.0 121.0 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:146.50 stddev:7.17 (4.9%) stddev-sans-first:7.08 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: Values: 139.0 146.0 153.0 158.0 146.0 140.0 154.0 146.0 147.0 135.0 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 69.0 70.0 70.0 72.0 69.0 68.0 67.0 68.0 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:35:18 INFO - 2015-11-25 07:35:18,046 DEBUG : BROWSER_OUTPUT: 07:35:18 INFO - 2015-11-25 07:35:18,882 INFO : Browser exited with error code: 0 07:35:18 INFO - 2015-11-25 07:35:18,931 INFO : Completed test kraken (00:01:01) 07:35:18 INFO - 2015-11-25 07:35:18,931 INFO : Starting test v8_7 07:35:18 INFO - 2015-11-25 07:35:18,931 DEBUG : operating with platform_type : linux_ 07:35:18 INFO - 2015-11-25 07:35:18,931 INFO : Initialising browser for v8_7 test... 07:35:18 INFO - 2015-11-25 07:35:18,937 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOataBp/profile http://localhost:51533/getInfo.html 07:35:23 INFO - 2015-11-25 07:35:23,311 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:35:23 INFO - 2015-11-25 07:35:23,311 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:35:23 INFO - 2015-11-25 07:35:23,311 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:35:23 INFO - 2015-11-25 07:35:23,311 DEBUG : BROWSER_OUTPUT: __metrics 07:35:23 INFO - 2015-11-25 07:35:23,387 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:24 INFO - 2015-11-25 07:35:24,129 DEBUG : BROWSER_OUTPUT: console.error: 07:35:24 INFO - 2015-11-25 07:35:24,129 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 07:35:24 INFO - 2015-11-25 07:35:24,129 DEBUG : BROWSER_OUTPUT: Stack: 07:35:24 INFO - 2015-11-25 07:35:24,129 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 07:35:24 INFO - 2015-11-25 07:35:24,130 DEBUG : BROWSER_OUTPUT: 07:35:24 INFO - 2015-11-25 07:35:24,707 INFO : Browser initialized. 07:35:24 INFO - 2015-11-25 07:35:24,707 INFO : Running cycle 1/1 for v8_7 test... 07:35:24 INFO - 2015-11-25 07:35:24,708 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOataBp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:35:36 INFO - 2015-11-25 07:35:36,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 07:35:36 INFO - 2015-11-25 07:35:36,654 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51533/tests/v8_7/run.html (next: http://localhost:51533/tests/v8_7/run.html) 07:35:58 INFO - 2015-11-25 07:35:58,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 458022912 07:35:58 INFO - 2015-11-25 07:35:58,420 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,420 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:35:58 INFO - 2015-11-25 07:35:58,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:35:58 INFO - 2015-11-25 07:35:58,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:35:58 INFO - 2015-11-25 07:35:58,421 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:35:58 INFO - 2015-11-25 07:35:58,421 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6726308813784 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.06271379703537 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |5;Earley;821.0180623973728 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |6;Boyer;12365.853658536585 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |7;RegExp;26605.263157894737 07:35:58 INFO - 2015-11-25 07:35:58,423 DEBUG : BROWSER_OUTPUT: |8;Splay;603.8531005418423 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: __startTimestamp1448465758420__endTimestamp 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,424 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.67 Median:165.67 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: Values: 165.7 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: Values: 194.3 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: Values: 285.1 07:35:58 INFO - 2015-11-25 07:35:58,425 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: Values: 5170.1 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: Values: 2006.0 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:821.02 Median:821.02 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,426 DEBUG : BROWSER_OUTPUT: Values: 821.0 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: Values: 12365.9 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: Values: 26605.3 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.85 Median:603.85 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: Values: 603.9 07:35:58 INFO - 2015-11-25 07:35:58,427 DEBUG : BROWSER_OUTPUT: 07:35:58 INFO - 2015-11-25 07:35:58,428 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 07:35:58 INFO - 2015-11-25 07:35:58,428 DEBUG : BROWSER_OUTPUT: Values: 4850.2 07:35:58 INFO - 2015-11-25 07:35:58,428 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:35:58 INFO - 2015-11-25 07:35:58,428 DEBUG : BROWSER_OUTPUT: 07:35:59 INFO - 2015-11-25 07:35:59,378 INFO : Browser exited with error code: 0 07:35:59 INFO - 2015-11-25 07:35:59,397 INFO : Completed test v8_7 (00:00:40) 07:35:59 INFO - 2015-11-25 07:35:59,855 INFO : Completed test suite (00:20:22) 07:35:59 INFO - 2015-11-25 07:35:59,855 DEBUG : Working with test: dromaeo_css 07:35:59 INFO - 2015-11-25 07:35:59,855 DEBUG : Generating results file: dromaeo_css 07:35:59 INFO - 2015-11-25 07:35:59,856 DEBUG : Working with test: kraken 07:35:59 INFO - 2015-11-25 07:35:59,856 DEBUG : Generating results file: kraken 07:35:59 INFO - 2015-11-25 07:35:59,856 INFO : javascript benchmark 07:35:59 INFO - 2015-11-25 07:35:59,857 DEBUG : Working with test: v8_7 07:35:59 INFO - 2015-11-25 07:35:59,857 DEBUG : Generating results file: v8_7 07:35:59 INFO - 2015-11-25 07:35:59,857 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:35:59 INFO - 2015-11-25 07:35:59,994 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:35:59 INFO - 2015-11-25 07:35:59,994 DEBUG : process_Request line: dromaeo_css 6111.56 graph.html#tests=[[72,132,35]] 07:35:59 INFO - 2015-11-25 07:35:59,994 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:36:00 INFO - 2015-11-25 07:36:00,153 DEBUG : process_Request line: kraken 1527.70 graph.html#tests=[[232,132,35]] 07:36:00 INFO - 2015-11-25 07:36:00,153 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:36:00 INFO - 2015-11-25 07:36:00,214 DEBUG : process_Request line: v8_7 19576.79 graph.html#tests=[[230,132,35]] 07:36:00 INFO - 2015-11-25 07:36:00,215 INFO : javascript benchmark 07:36:00 INFO - 2015-11-25 07:36:00,219 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2627.684677838659, 2724.7547720705134, 2733.5079685656574, 2746.107515057606, 2751.11964171465, 4517.593416592506, 4642.837500687477, 4676.368690226814, 4710.693804902683, 4724.645651576128, 4588.77056147193, 4654.86035418938, 4683.133620280242, 4698.953010469894, 4823.807047718095, 4300.053988122616, 4316.223079845627, 4325.589069038437, 4335.978320108395, 4340.500842403117, 4208.221479026374, 4375.015621485172, 4378.496472905625, 4428.959194589285, 4429.46846378435, 4192.0777428965885, 4251.0, 4270.551592082848, 4313.309870420749, 4331.328644060176, 4342.978285108586, 4344.587264209895, 4354.586314300136, 4358.0848021915435, 4384.254676704968, 4320.049589090395, 4324.805383757707, 4334.956650433487, 4346.130773845212, 4383.802728877176, 4504.549545045502, 4537.909241815179, 4622.8150873965005, 4646.814127434898, 4658.1848176568965, 4982.427020892607, 5022.196448568212, 5028.7737051832755, 5029.119904016819, 5029.723365214912, 5039.244113383022, 5048.848534543969, 5051.040302342543, 5085.338905942203, 5094.286799848024, 4489.663275254369, 4595.793189306489, 4607.493175750665, 4670.976645116787, 4724.244120940667, 5024.748762561857, 5098.209777484496, 5098.770555325019, 5152.896942061213, 5153.3815942087185, 4938.58022068121, 4946.3817022872145, 4951.678140920829, 4954.47977962316, 4991.401031876198, 4822.156122678517, 4981.402231732215, 4981.800727970841, 5022.196448568212, 5025.170846810309, 4781.976090119527, 4934.555889969848, 4939.209726443752, 4940.407151141886, 4956.628252881048, 4967.503249675004, 4976.253561965662, 4976.278439626306, 4979.601631869442, 5018.949810501921, 3979.343408337592, 4053.8986525336513, 4094.303968325392, 4184.225918205142, 4228.9788551057045, 3579.0336609115393, 3603.981980090135, 3614.2410093880053, 3630.8184590770356, 3649.033006253345, 4281.700280980302, 4287.464066991626, 4289.1421715657, 4318.093200427883, 4319.67602429819, 4743.5967942724565, 4814.229723244264, 4850.660453768273, 4989.451160372356, 4999.850004499871, 4199.664026877843, 4257.765822879772, 4268.786560671954, 4298.26929421999, 4309.245881970643, 4397.274449715825, 4424.955750442518, 4437.667174961891, 4437.844675436409, 4480.507144214133, 4576.633869290516, 4689.015306785614, 4691.413573303337, 4757.286407038971, 4814.855554333376, 4878.365812444359, 4940.456549779449, 4958.429780575136, 4962.131626965339, 5001.324821149244, 4693.296005599051, 4695.718256904596, 4702.952970470388, 4739.241721324572, 4748.453927798348, 4682.321063445849, 4791.401074865642, 4802.7838747255755, 4932.186189278729, 4991.9500804991485, 4830.106430310404, 4907.631927605373, 4931.0877487663465, 4937.604991600591, 4971.975140124277, 4771.809127634856, 4788.11419887322, 4815.759212039454, 4816.109019831342, 4861.343718597944, 4613.792379342871, 4702.15361234981, 4703.60019398355, 4817.108834865421, 4849.054434385402, 4646.117237724821, 4757.381540399864, 4766.594839438548, 4805.567498925114, 4806.182948898766, 4934.136526107988, 4935.580475659609, 4941.678790878582, 4972.204447288561, 4978.502149784992, 4619.884502887455, 4734.1478533862855, 4737.123632128068, 4769.856904292877, 4881.29221262922], "unit": "ms", "name": "dojo.html", "value": 4567.688333204786}, {"lowerIsBetter": false, "replicates": [471.9244920812671, 489.9902001959963, 571.6598623818828, 572.7136431784108, 579.4205794205795, 22411.551768964633, 22607.095716171334, 23103.768962310394, 23161.76838231617, 36030.0, 39853.0, 40717.796411017975, 40831.59168408315, 40899.0, 40900.795496022554, 7938.483998540105, 8119.959400202991, 8121.0, 8130.227628375294, 8131.983502062242, 6646.368594983493, 6829.385355318021, 6833.111695479605, 7894.526328420285, 9745.415275083518, 9596.856047159297, 9601.80796384072, 9613.375130616487, 9622.663206787764, 9702.126808587225, 9762.0, 9878.209743220525, 9879.950600247024, 9881.95059024704, 9882.407055576688, 9652.420854748667, 9803.264755143322, 9804.313698041069, 9806.313558050939, 9957.054079862473, 37588.43617345742, 38125.61874381248, 38128.42807357864, 38169.0457738556, 38175.0, 2589.9870500647376, 2687.583424569195, 2729.208529526435, 2736.3569561153113, 2771.431856469439, 28001.439971200667, 28649.71350286512, 28692.856535717397, 29049.709502904912, 29059.56410653842, 3482.8432720527635, 3501.6673416025437, 3510.8244587770764, 3521.330947120039, 3578.427451607756, 225962.0, 226593.0, 227046.0, 227151.0, 227180.0, 34399.82800085984, 55815.16277255763, 56525.0, 57057.42942570604, 57099.0, 29465.410691786044, 47046.52953470421, 48266.5173348269, 48285.275720864214, 48309.75845120752, 12862.67843303925, 13052.282124483245, 13062.934685326512, 13079.084464087422, 13088.08383413152, 9994.300398972002, 10074.69775906724, 10076.244281678757, 10078.798424031478, 10080.899191008142, 18796.624067518573, 18862.811371886106, 18879.244830206913, 19180.0, 19202.13590388436, 7160.820979475555, 7349.485536012535, 7384.852302953911, 7396.482246242711, 7443.218462061405, 905.2938707807921, 971.5919313888184, 980.7155924781877, 996.0985308296003, 1026.08165691707, 24121.0, 24361.390965225655, 24505.264842054767, 24527.264182074567, 24529.50940981206, 934.9158575728081, 954.6754103604808, 956.4930586789013, 1025.6256466389714, 1049.490996866519, 13894.23581703016, 14624.415023399157, 14882.479113230986, 15135.772963405558, 15248.313825877862, 251179.0, 257487.0, 257488.0, 258671.0, 260268.0, 47384.5261547387, 47468.0, 47548.76225618919, 47602.5239747605, 47758.76120619444, 1187.0622208455395, 1190.33936165429, 1192.4455128365353, 1200.2078628105407, 1205.2226314027403, 19499.112640168423, 26395.472090557698, 27287.863560682068, 28264.43471130607, 28364.43271134607, 41797.1640567193, 42463.787681061396, 42480.78759606182, 42488.78755606326, 42602.78698606487, 220179.0, 221428.0, 221652.0, 221753.0, 222139.0, 20921.26775562848, 21507.247246346302, 26793.86603066972, 28235.43529129447, 28966.710332897244, 36988.63011369852, 37141.44287835739, 37368.81315593405, 37657.24685506329, 37665.2466950665, 31649.09439036953, 32015.199620009687, 32042.35915281728, 32462.0, 32638.34723305473, 21001.57996840024, 28146.155615331572, 31682.366352673278, 32060.74206019478, 32424.351512969137, 28871.42257154803, 29123.708762912946, 29484.410311794072, 29500.852495737385, 29827.552586711652, 26317.07890223833, 26582.86708566522, 27047.459050819267, 27182.864085679445, 27397.726022739516, 20868.895655521625, 21833.454163646034, 21871.562568748854, 22108.447288817264, 22173.778262217817], "unit": "ms", "name": "ext.html", "value": 16440.581947084727}, {"lowerIsBetter": false, "replicates": [312.70293221439607, 321.30758216044416, 321.6301253558407, 326.7141251405019, 338.83566470261917, 11378.089752819755, 11717.70705732357, 15400.30698618562, 15656.295466703983, 15765.054096754202, 14323.498677546288, 14709.485168019122, 14913.32890019949, 15449.296373134712, 15488.457903973363, 4004.63958243758, 4869.391326084239, 4916.43461001984, 4931.605471562267, 5012.122878496249, 4870.780814863322, 4908.656394052417, 4909.705417674951, 4911.607071434295, 4915.557599816016, 4735.100330937111, 4844.055409195191, 4856.125897338477, 4957.7769000395065, 4959.950400495985, 4813.879653008667, 4828.661993660445, 4829.420469543659, 4863.659543831933, 4902.338184345103, 4231.705856521191, 4312.417823593806, 4319.848805291831, 4322.416473776031, 4322.740635561876, 19805.306814261578, 19866.602667946703, 20011.89994050035, 20048.1980720771, 20172.0, 1812.4925020994142, 1879.135597625094, 1904.381076150243, 1954.491832123658, 1971.2115153938396, 11911.702207444883, 12051.517939282418, 12172.695682607917, 12335.136540442172, 12552.0, 1602.8397160283994, 1622.4402581109498, 1623.3019801485357, 1624.6669432766255, 1640.7620894970162, 47715.0, 48096.0, 52255.73872130653, 54387.456125438635, 56901.0, 8675.566221689016, 8739.344549158839, 8869.73390798277, 8984.0, 9059.864102038475, 10285.22860785444, 10441.216908731876, 10763.892361076289, 10832.40421776794, 11683.240589361665, 6591.077249185118, 6636.037774522763, 6728.596284222962, 6871.415929645936, 6974.128233970754, 6079.05774604937, 6081.543884208702, 6098.664573448415, 6123.112148738408, 6491.415772580491, 4005.1589166274825, 4053.7973101344814, 4073.9592604073578, 4140.834366625361, 4179.6029377209115, 1700.8129105798353, 1716.1848122142133, 1732.2984191402502, 1735.8524525415228, 1743.0848804377804, 777.4635501503944, 785.407017701643, 797.0475282037909, 898.4743924803932, 935.2144198872979, 15328.080315180901, 15687.607809804618, 15757.133357665438, 15811.367545298059, 15875.364985400454, 790.4387884601997, 794.2256300107465, 809.8542262392826, 810.096742132518, 815.1481701621819, 8738.86891696625, 8774.956125219333, 9234.215091717146, 9254.583543740548, 9362.765930851647, 290769.0, 294385.0, 495617.0, 500753.0, 544923.0, 37595.62404375976, 55099.72450137804, 59763.701181493816, 62763.6861815688, 63079.05381419283, 355.7367548014502, 454.8385323210279, 468.0335108001965, 469.16488650202695, 469.2328043648591, 8330.208630180123, 9307.395019323721, 9366.906330936603, 9473.952630236805, 9574.234061275221, 29640.703592963793, 30055.098347049625, 30211.395772083997, 30570.694293057673, 30988.53517197289, 37910.2417951645, 38504.0, 38728.419073713354, 38985.805070974464, 41283.1743365137, 9070.0, 9075.54622268897, 9107.772305692411, 9124.133207345292, 9402.717918462457, 15790.368385264921, 16231.269592868586, 16409.0, 16589.9262592176, 16818.411355602497, 12176.878231217928, 13057.738845223232, 13220.40508177115, 13578.38897249646, 13604.65988350299, 13535.661608459868, 13680.65798355049, 13779.793303100261, 13797.172169669851, 14310.427582896567, 13692.589222323346, 14324.713505729618, 14623.707525849637, 14645.194514301817, 14649.340779664728, 8381.539015354214, 8738.213560779306, 8739.38824282294, 8849.247813935888, 8876.289896808368, 12634.810477842655, 12679.302638354979, 12707.80938285945, 13611.183328999896, 13660.453581856615], "unit": "ms", "name": "jquery.html", "value": 7713.535201695255}, {"lowerIsBetter": false, "replicates": [824.0358780227134, 1342.664333916521, 1395.6999245162287, 1450.267614854499, 1598.856102950735, 5505.256790333309, 5811.622244554106, 6695.63174025429, 6855.760048398307, 6919.273476284993, 6851.931480685192, 6917.100776899008, 6958.130233720785, 6958.617276049815, 6961.060256865321, 2016.5765189310262, 2033.3493282149718, 2049.1393614681797, 2051.984267787447, 2068.1830676882623, 2055.7122002919527, 2080.771115177329, 2088.3526106906834, 2109.0193060226993, 2110.1559376249547, 2005.6289586426485, 2019.4143698327541, 2033.2985120133603, 2043.5810658814908, 2046.4065421027883, 2044.427560283123, 2053.1068984991425, 2056.907439165241, 2057.300517823947, 2079.573687394088, 1994.6509360861792, 2007.65869802134, 2007.7691065527506, 2009.3168322770327, 2028.5537181820123, 5378.381486129067, 6812.659367031629, 6889.0, 6889.207741109786, 6922.0, 3265.2653153040615, 3827.7703337799544, 3894.7273690841653, 3894.766314021168, 3901.200253947934, 2601.609758536216, 2603.336149281921, 2648.589468632365, 2657.601359796046, 2720.9727902721115, 867.4535042922981, 869.5565261716507, 1725.577233577769, 1740.6431681505387, 1766.1081154017268, 9079.727608171765, 9141.588628511667, 9145.222656074242, 9147.771305717344, 9151.77120571991, 3713.350163721338, 3750.081230098643, 3800.638939300762, 3812.961870381316, 3825.9808700956874, 7329.413646908234, 7352.926470735331, 7356.485046046725, 7365.0, 7411.407087432993, 4003.01926028125, 4004.95871073523, 4007.8196481158416, 4009.0979529605606, 4009.3184158693093, 3673.1918977824835, 3674.430463278196, 3676.4117741161285, 3677.2093999790172, 3679.7424180307657, 3029.242689327668, 3033.2871775132826, 3047.1772621392543, 3055.495843185894, 3065.4788685923445, 898.9011208767031, 899.964001439935, 906.8367693815045, 919.9448033118034, 920.2178148573659, 823.0534884882313, 823.3413269384469, 825.2119226139023, 825.9752207433787, 826.6197549127469, 6209.565330426917, 6247.5939063961605, 6288.937110628926, 6311.873762524724, 6380.457661098766, 434.2227412930882, 437.1061179887075, 438.0, 441.99446259759304, 443.4545509023919, 4343.0, 4957.529034741694, 4995.625328100407, 5018.974905125524, 5023.598112151019, 7376.262373762688, 8155.877661835078, 8223.588820558949, 8329.583520823935, 8357.164283571594, 8109.837803243902, 8113.148119447491, 8200.58997050145, 8215.958920205361, 8230.806533052673, 5906.940930590639, 5941.405859414111, 6021.849453763603, 6036.486898613579, 6090.512758979183, 6351.587146835625, 6371.108044873628, 6378.394052564999, 6379.776707815204, 6385.946318857336, 7237.276272372721, 7301.050863387725, 7437.181909990005, 7439.256074392734, 7469.477136600603, 7442.8511429770015, 7613.124490683642, 7650.65572049248, 7656.196099409704, 7673.002509673706, 5526.309211348582, 5622.269105016322, 5686.175504551899, 5711.171880077282, 5723.914141287801, 6384.968075159594, 6443.806685799434, 6447.290798012309, 6451.48388128958, 6454.322296158835, 6047.153398524298, 6137.570370074052, 6214.627122372672, 6261.123442718114, 6312.147860038836, 6013.428724271187, 6019.307779605401, 6034.487068599043, 6106.5114790817515, 6199.0, 6049.032154855378, 6152.661603611844, 6161.322254552086, 6163.0, 6172.5679202457195, 5710.628809127394, 5736.254286942671, 5750.942490575041, 5757.366689664217, 5794.739236734273, 5601.103823388401, 5706.372299047019, 5737.8565535861935, 5744.827655170185, 5759.366469688414], "unit": "ms", "name": "mootools.html", "value": 3815.163529359126}, {"lowerIsBetter": false, "replicates": [296.66625046822327, 305.58287936966036, 310.27395893608957, 311.850311850312, 312.9937401251975, 5395.136778115502, 5440.265564148839, 5444.455554444564, 5448.700321482322, 5483.643563168392, 5116.1814109742445, 5224.484899379176, 5268.5521730652845, 5385.865353366168, 5392.649477783942, 4189.141226048668, 4195.832166713343, 4209.621134097923, 4212.136512015029, 4219.831206751726, 3899.25914076326, 4201.327787553992, 4206.0, 4214.7681877496725, 4222.239996800575, 3950.2889479893606, 3963.8414463421573, 4034.273830710471, 4156.231097247004, 4158.0, 4157.397177409259, 4159.064210552617, 4159.105792254664, 4161.667066634662, 4166.0, 3658.1951970566433, 3662.7069834413182, 3662.7619204751604, 3663.065918190871, 3663.9633603663888, 5161.587073034186, 5192.039472697563, 5201.115810312256, 5213.296205012312, 5215.0873597120735, 4601.148787474328, 4713.952860471386, 4716.410448693913, 4718.433787945434, 4774.594159496447, 5614.831555053355, 5630.605857589971, 5631.4087020863035, 5633.63381380209, 5639.915401268984, 3891.630295121959, 3891.9610803892165, 3893.3381325174787, 3895.5325360956585, 3897.9805100974313, 5827.533797296206, 5894.4989675877605, 5900.262467191601, 5902.1146827976145, 5917.55618328627, 3881.728279020498, 3985.123272879962, 4002.079521710023, 4004.759714417144, 4007.7996100194873, 4029.0531725044593, 4050.10897602527, 4051.534073581517, 4052.1895620875944, 4058.2695114879016, 4678.953210467852, 4681.063787242565, 4687.414073240845, 4688.765561721901, 4695.882602934954, 5634.830955071355, 5634.887302254014, 5640.5487560995025, 5641.210230567724, 5643.661380317194, 1299.8895093916933, 1321.5242512695422, 1329.9002574806927, 1416.1644629668544, 1430.6494908747422, 955.9187469065068, 960.7406000379858, 963.1476143612953, 972.1590823937244, 978.8923218445965, 4933.112039832793, 4940.530649588283, 4941.061198372297, 4946.282788995575, 4957.628177886673, 5812.59311848175, 5813.6221145625395, 5814.883702325929, 5824.825255242349, 5827.883442331215, 4847.321375007502, 4892.975535122373, 4895.975520122377, 4901.09329773993, 4906.165951788204, 3046.34503581731, 3075.4617941860083, 3128.6402063762503, 3138.5919830422354, 3141.277506173593, 5505.917411238835, 5508.338999320027, 5508.889822203533, 5518.696471694096, 5521.171824226398, 5967.731452084667, 5971.79098731551, 5973.1338955852025, 5976.043832986788, 5978.0, 5506.697131657797, 5510.779568817203, 5514.310711161105, 5516.172574113834, 5521.889562208814, 5732.570057245806, 5807.738651760766, 5903.881922361615, 5912.142739302691, 5913.940860591339, 5765.250517432707, 5770.826875193751, 5774.942250577608, 5777.711114444177, 5778.306603207642, 5608.383077861514, 5613.719314034363, 5614.0, 5617.325920889356, 5617.578681598815, 3922.431247469044, 4014.437978682928, 4044.9595504044582, 4052.8378864846254, 4067.91864162721, 5628.605997580294, 5848.064309710426, 5848.444397782204, 5851.327097383855, 5853.619514731528, 5583.180493850579, 5594.3286805581965, 5694.231278777312, 5702.743376548148, 5704.372519022987, 5670.0, 5674.432556744293, 5684.0, 5687.374388817309, 5697.54419646419, 5552.750126244248, 5556.805511807067, 5570.303712035996, 5576.721163941867, 5580.35825880029, 5563.666180029211, 5715.428457154251, 5718.599698021098, 5724.542036636975, 5727.942720572741, 5551.666899986014, 5579.69311687861, 5582.190582365615, 5588.245586845724, 5588.748506317307], "unit": "ms", "name": "prototype.html", "value": 4224.037681042985}, {"lowerIsBetter": false, "replicates": [548.1284757235994, 615.6490800243863, 617.080549980529, 689.4932224814763, 703.1421665568008, 11423.257488263267, 11527.423628818568, 11602.303861768289, 11606.59376921808, 11626.244294120897, 8521.446106003106, 12226.0, 12335.876641233584, 12339.938300308486, 12345.13584049117, 768.6272158003378, 783.6081959020489, 784.145281643009, 784.2667106255641, 784.3803395317692, 771.2595907928395, 776.0183368039435, 777.3625626985873, 777.5995362388375, 777.9844403111935, 813.5078277642031, 819.4837252530897, 821.0885916632533, 821.7288294862681, 822.2846123872209, 792.2513225002375, 809.3161278719473, 809.8299357135008, 811.0672726364669, 811.9594020299021, 598.7395482964924, 598.9936905997922, 599.0744300056423, 599.595273190599, 600.1477901380051, 10670.413127277996, 10787.083097936606, 10806.945965270123, 10808.243422960395, 11650.650480485514, 10942.015218630362, 11101.500432480558, 11149.609763658233, 11564.768704625945, 11629.360385178812, 9255.722328330161, 9496.43021418717, 9609.711708648752, 9669.08143726352, 9731.464769437678, 3209.1014515935576, 3268.1829542614346, 3297.3075654112663, 3334.4664853623303, 3339.716124129452, 32817.0, 34742.0, 35046.12384690403, 38331.808340958116, 38855.61144388576, 7304.415646748247, 8435.873461898076, 8647.308215342757, 9020.774480638036, 9337.206337461255, 15629.3748250071, 15686.294116764773, 15712.921435392978, 15735.134567598892, 15735.68528629421, 5895.35151133375, 6161.7227224775, 6235.657038862906, 6271.560990730605, 6306.873862522724, 3518.20840310928, 3606.6213047630145, 3625.6736893679167, 3674.797886116236, 3688.7602305850032, 2650.907218247352, 2683.7047924728263, 2684.302081458835, 2688.3010417291644, 2689.435218604076, 474.7175430618776, 478.5501628469228, 483.9709617422966, 484.1889834527223, 484.791539637952, 458.55978260869273, 543.9755211015514, 557.2115456628906, 587.2864469669372, 618.0667192539298, 7277.52564128199, 8370.246677799027, 8412.15878412166, 8594.398392112493, 8616.655333786579, 492.778249787597, 503.4688403734096, 566.6147020026422, 582.6853499110517, 596.582392325374, 3406.9659303407143, 3452.723782097426, 3515.226650136966, 3559.2347645256395, 3644.7084233261276, 50267.49732502701, 51010.74494627503, 51285.23072153921, 51793.0, 52294.21558676623, 43662.56337436585, 43703.12593748107, 43740.125197496505, 44009.77995110068, 44052.3392149118, 34131.31737365239, 40442.59557404447, 42768.78615606902, 46411.30383044325, 47328.0, 7841.607919604111, 7974.322182614543, 7977.401694872791, 8016.238457346542, 8142.552159631277, 30308.24229394283, 31174.0, 31267.0, 31389.959652622507, 32391.51412728764, 40097.79951100226, 40636.59363406446, 40773.388399174626, 43313.0, 43327.13345733131, 9158.496282704515, 9478.478683672463, 9518.809623807623, 9645.9035409645, 9671.758206044906, 10407.375557466576, 11252.718682033015, 11278.830817537908, 11362.772744545227, 11579.13156513248, 10223.488825558841, 10237.846432303373, 10353.119984801075, 10418.843717344094, 10635.94682026585, 9810.362326448758, 9923.454210018519, 10085.899141008496, 10396.58413663445, 10830.566777328819, 9869.851952220579, 10043.497825108861, 10566.8414973777, 10727.624533141303, 10900.890991090304, 7691.5769632670745, 8132.87800683002, 8262.628181731716, 8406.705765298186, 8599.355048371272, 8083.9191608083165, 8106.432549721699, 8176.528224919572, 8287.834243315221, 8391.244787968868], "unit": "ms", "name": "yui.html", "value": 5581.594159960018}], "name": "dromaeo_css", "value": 6111.55931572949}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 108.0, 112.0, 113.0, 112.0, 101.0, 114.0, 112.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 163.0, 163.0, 134.0, 151.0, 155.0, 132.0, 169.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 162.0, 163.0, 160.0, 165.0, 164.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 83.0, 93.0, 78.0, 72.0, 72.0, 102.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 133.0, 95.0, 96.0, 95.0, 134.0, 95.0, 96.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 154.0, 146.0, 146.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 71.0, 70.0, 70.0, 70.0, 72.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 70.0, 71.0, 69.0, 76.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 83.0, 93.0, 83.0, 83.0, 85.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [130.0, 124.0, 116.0, 122.0, 125.0, 121.0, 123.0, 130.0, 128.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [139.0, 146.0, 153.0, 158.0, 146.0, 140.0, 154.0, 146.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 70.0, 70.0, 72.0, 69.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1527.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6726308813784], "unit": "score", "name": "Richards", "value": 213.0828719999999}, {"lowerIsBetter": false, "replicates": [194.28793471925394], "unit": "score", "name": "DeltaBlue", "value": 340.309346}, {"lowerIsBetter": false, "replicates": [285.06271379703537], "unit": "score", "name": "Encrypt", "value": 933.7629479999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [821.0180623973728], "unit": "score", "name": "Earley", "value": 811.7519340000001}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [603.8531005418423], "unit": "score", "name": "Splay", "value": 134.95169591226326}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19576.794252097152}]} 07:36:00 INFO - RETURN: dromaeo_css: 6111.56 07:36:00 INFO - RETURN: kraken: 1527.70 07:36:00 INFO - RETURN: v8_7: 19576.79 07:36:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19576.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1527.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6111.56"}}} 07:36:00 INFO - Return code: 0 07:36:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:36:00 INFO - # TBPL SUCCESS # 07:36:00 INFO - Running post-action listener: _resource_record_post_action 07:36:00 INFO - Running post-run listener: _resource_record_post_run 07:36:01 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 10428416; Write bytes: 395776000; Read time: 3516; Write time: 339104 07:36:01 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 671744; Read time: 0; Write time: 40 07:36:01 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 8237056; Write bytes: 395104256; Read time: 3360; Write time: 339064 07:36:01 INFO - Running post-run listener: _upload_blobber_files 07:36:01 INFO - Blob upload gear active. 07:36:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:36:01 INFO - Copying logs to upload dir... 07:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.679171 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-25 07:36:01.476584) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:36:01.479733) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009871 build_url: 'https://queue.taskcluster.net/v1/task/ls7Qvc6AT5yK9L5ku_Xt1g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 07:36:01.531475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:36:01.531841) ========= 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=3cd289541638898829117e0a000001bd-1448462967.221156-1019983437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 07:36:01.583283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 07:36:01.583642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 07:36:01.583918) ========= ========= Total master_lag: 0.23 =========