builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1448513973.25 results: success (0) buildid: 20151125164213 builduid: 6a9cfe2a83c44a0aaf7af38dd3a64641 revision: 34c9087517ea31fc1a0204dd5635e7384a94ae3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.253503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.253963) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.254244) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006526 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.282798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.283382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.334757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.335316) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.391202) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.391482) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.391823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.392084) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 20:59: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% 223M=0s 2015-11-25 20:59:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.519500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.519773) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.569326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:33.569641) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34c9087517ea31fc1a0204dd5635e7384a94ae3a --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 34c9087517ea31fc1a0204dd5635e7384a94ae3a --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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 20:59:33,964 truncating revision to first 12 chars 2015-11-25 20:59:33,964 Setting DEBUG logging. 2015-11-25 20:59:33,964 attempt 1/10 2015-11-25 20:59:33,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34c9087517ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 20:59:34,492 unpacking tar archive at: fx-team-34c9087517ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:34.366052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:34.366377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:34.375849) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:34.376132) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:59:34.376532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-25 20:59:34.376829) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:59:34 INFO - MultiFileLogger online at 20151125 20:59:34 in /builds/slave/test 20:59:34 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 20:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:59:34 INFO - {'append_to_log': False, 20:59:34 INFO - 'base_work_dir': '/builds/slave/test', 20:59:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:59:34 INFO - 'branch': 'Fx-Team-Non-PGO', 20:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:59:34 INFO - 'config_files': ('talos/linux_config.py',), 20:59:34 INFO - 'default_actions': ('clobber', 20:59:34 INFO - 'read-buildbot-config', 20:59:34 INFO - 'download-and-extract', 20:59:34 INFO - 'populate-webroot', 20:59:34 INFO - 'create-virtualenv', 20:59:34 INFO - 'install', 20:59:34 INFO - 'run-tests'), 20:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:59:34 INFO - 'download_minidump_stackwalk': True, 20:59:34 INFO - 'download_symbols': 'ondemand', 20:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:59:34 INFO - 'installer_path': 'installer.exe', 20:59:34 INFO - 'log_level': 'info', 20:59:34 INFO - 'log_name': 'talos', 20:59:34 INFO - 'log_to_console': True, 20:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:59:34 INFO - 'opt_config_files': (), 20:59:34 INFO - 'pip_index': False, 20:59:34 INFO - 'sps_profile': False, 20:59:34 INFO - 'sps_profile_interval': 0, 20:59:34 INFO - 'suite': 'dromaeojs', 20:59:34 INFO - 'system_bits': '64', 20:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:59:34 INFO - 'title': 'talos-linux64-ix-010', 20:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:59:34 INFO - 'use_talos_json': True, 20:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:59:34 INFO - 'work_dir': 'build'} 20:59:34 INFO - ##### 20:59:34 INFO - ##### Running clobber step. 20:59:34 INFO - ##### 20:59:34 INFO - Running pre-action listener: _resource_record_pre_action 20:59:34 INFO - Running main action method: clobber 20:59:34 INFO - rmtree: /builds/slave/test/build 20:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:59:35 INFO - Running post-action listener: _resource_record_post_action 20:59:35 INFO - ##### 20:59:35 INFO - ##### Running read-buildbot-config step. 20:59:35 INFO - ##### 20:59:35 INFO - Running pre-action listener: _resource_record_pre_action 20:59:35 INFO - Running main action method: read_buildbot_config 20:59:35 INFO - Using buildbot properties: 20:59:35 INFO - { 20:59:35 INFO - "properties": { 20:59:35 INFO - "buildnumber": 931, 20:59:35 INFO - "product": "firefox", 20:59:35 INFO - "script_repo_revision": "production", 20:59:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:59:35 INFO - "repository": "", 20:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:59:35 INFO - "buildid": "20151125164213", 20:59:35 INFO - "slavename": "talos-linux64-ix-010", 20:59:35 INFO - "pgo_build": "False", 20:59:35 INFO - "basedir": "/builds/slave/test", 20:59:35 INFO - "project": "", 20:59:35 INFO - "platform": "ubuntu64_hw", 20:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:59:35 INFO - "slavebuilddir": "test", 20:59:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:59:35 INFO - "branch": "fx-team", 20:59:35 INFO - "repo_path": "integration/fx-team", 20:59:35 INFO - "stage_platform": "linux64", 20:59:35 INFO - "builduid": "6a9cfe2a83c44a0aaf7af38dd3a64641", 20:59:35 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:59:35 INFO - }, 20:59:35 INFO - "sourcestamp": { 20:59:35 INFO - "repository": "", 20:59:35 INFO - "hasPatch": false, 20:59:35 INFO - "project": "", 20:59:35 INFO - "branch": "fx-team-linux64-talos", 20:59:35 INFO - "changes": [ 20:59:35 INFO - { 20:59:35 INFO - "category": null, 20:59:35 INFO - "files": [ 20:59:35 INFO - { 20:59:35 INFO - "url": null, 20:59:35 INFO - "name": "https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:59:35 INFO - } 20:59:35 INFO - ], 20:59:35 INFO - "repository": "", 20:59:35 INFO - "rev": "34c9087517ea31fc1a0204dd5635e7384a94ae3a", 20:59:35 INFO - "who": "jlong@mozilla.com", 20:59:35 INFO - "when": 1448513964, 20:59:35 INFO - "number": 6708895, 20:59:35 INFO - "comments": "Bug 1200798 - refactor sources and breakpoints in debugger to use redux r=ejpbruel", 20:59:35 INFO - "project": "", 20:59:35 INFO - "at": "Wed 25 Nov 2015 20:59:24", 20:59:35 INFO - "branch": "fx-team-linux64-talos", 20:59:35 INFO - "revlink": "", 20:59:35 INFO - "properties": [ 20:59:35 INFO - [ 20:59:35 INFO - "buildid", 20:59:35 INFO - "20151125164213", 20:59:35 INFO - "Change" 20:59:35 INFO - ], 20:59:35 INFO - [ 20:59:35 INFO - "builduid", 20:59:35 INFO - "6a9cfe2a83c44a0aaf7af38dd3a64641", 20:59:35 INFO - "Change" 20:59:35 INFO - ], 20:59:35 INFO - [ 20:59:35 INFO - "pgo_build", 20:59:35 INFO - "False", 20:59:35 INFO - "Change" 20:59:35 INFO - ] 20:59:35 INFO - ], 20:59:35 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:59:35 INFO - } 20:59:35 INFO - ], 20:59:35 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:59:35 INFO - } 20:59:35 INFO - } 20:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:59:35 INFO - Running post-action listener: _resource_record_post_action 20:59:35 INFO - ##### 20:59:35 INFO - ##### Running download-and-extract step. 20:59:35 INFO - ##### 20:59:35 INFO - Running pre-action listener: _resource_record_pre_action 20:59:35 INFO - Running main action method: download_and_extract 20:59:35 INFO - mkdir: /builds/slave/test/build/tests 20:59:35 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')]} 20:59:35 INFO - https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/test_packages.json 20:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/test_packages.json 20:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:59:42 INFO - Downloaded 1302 bytes. 20:59:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:59:42 INFO - Using the following test package requirements: 20:59:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:59:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:59:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'jsshell-linux-x86_64.zip'], 20:59:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:59:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:59:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:59:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:59:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:59:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:59:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:59:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:59:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:42 INFO - https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:49 INFO - Downloaded 21508487 bytes. 20:59:49 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 20:59:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:49 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 20:59:50 INFO - Return code: 0 20:59:50 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 20:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:50 INFO - https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:55 INFO - Downloaded 21508487 bytes. 20:59:55 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 20:59:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:59:55 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 20:59:56 INFO - Return code: 0 20:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:56 INFO - https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:58 INFO - Downloaded 11131717 bytes. 20:59:58 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 20:59:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:59:58 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 20:59:58 INFO - Return code: 0 20:59: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')]} 20:59:58 INFO - https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:59:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:59:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:59:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 20:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 21:00:00 INFO - Downloaded 56851042 bytes. 21:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:00:00 INFO - mkdir: /builds/slave/test/properties 21:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 21:00:00 INFO - Contents: 21:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:00:00 INFO - Running post-action listener: _resource_record_post_action 21:00:00 INFO - Running post-action listener: set_extra_try_arguments 21:00:00 INFO - ##### 21:00:00 INFO - ##### Running populate-webroot step. 21:00:00 INFO - ##### 21:00:00 INFO - Running pre-action listener: _resource_record_pre_action 21:00:00 INFO - Running main action method: populate_webroot 21:00:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:00:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:00:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:00:00 INFO - '../fennec_ids.txt'], 21:00:00 INFO - 'tests': ['tcheck2']}, 21:00:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:00:00 INFO - '--tppagecycles', 21:00:00 INFO - '7'], 21:00:00 INFO - 'tests': ['tsvgm']}}, 21:00:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:00:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:00:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:00:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:00:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'tests': ['damp', 'tps']}, 21:00:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['damp', 'tps']}, 21:00:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:00:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:00:00 INFO - 'other': {'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'other_l64': {'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'other_nol64': {'tests': ['a11yr', 21:00:00 INFO - 'ts_paint', 21:00:00 INFO - 'tpaint', 21:00:00 INFO - 'sessionrestore', 21:00:00 INFO - 'sessionrestore_no_auto_restore']}, 21:00:00 INFO - 'svgr': {'tests': ['tsvgx', 21:00:00 INFO - 'tsvgr_opacity', 21:00:00 INFO - 'tart', 21:00:00 INFO - 'tscrollx', 21:00:00 INFO - 'cart']}, 21:00:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['tsvgx', 21:00:00 INFO - 'tsvgr_opacity', 21:00:00 INFO - 'tart', 21:00:00 INFO - 'tscrollx', 21:00:00 INFO - 'cart']}, 21:00:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'tests': ['tp5o']}, 21:00:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'talos_options': ['--e10s'], 21:00:00 INFO - 'tests': ['tp5o']}, 21:00:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'talos_options': ['--xperf_path', 21:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:00 INFO - 'tests': ['tp5n']}, 21:00:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:00 INFO - 'talos_options': ['--e10s', 21:00:00 INFO - '--xperf_path', 21:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:00 INFO - 'tests': ['tp5n']}}, 21:00:00 INFO - 'talos.zip': {'path': '', 21:00:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:00:00 INFO - Running post-action listener: _resource_record_post_action 21:00:00 INFO - ##### 21:00:00 INFO - ##### Running create-virtualenv step. 21:00:00 INFO - ##### 21:00:00 INFO - Running pre-action listener: _resource_record_pre_action 21:00:00 INFO - Running main action method: create_virtualenv 21:00:00 INFO - Creating virtualenv /builds/slave/test/build/venv 21:00: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 21:00:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:00:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:00:00 INFO - Using real prefix '/usr' 21:00:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:00:00 INFO - Installing distribute.............................................................................................................................................................................................done. 21:00:02 INFO - Installing pip.................done. 21:00:02 INFO - Return code: 0 21:00:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:00:02 INFO - Using env: {'DISPLAY': ':0', 21:00:02 INFO - 'HOME': '/home/cltbld', 21:00:02 INFO - 'LANG': 'en_US.UTF-8', 21:00:02 INFO - 'LANGUAGE': 'en_US:en', 21:00:02 INFO - 'LOGNAME': 'cltbld', 21:00:02 INFO - 'MAIL': '/var/mail/cltbld', 21:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:02 INFO - 'MOZ_NO_REMOTE': '1', 21:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:02 INFO - 'NO_EM_RESTART': '1', 21:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:02 INFO - 'PWD': '/builds/slave/test', 21:00:02 INFO - 'SHELL': '/bin/bash', 21:00:02 INFO - 'SHLVL': '1', 21:00:02 INFO - 'TERM': 'linux', 21:00:02 INFO - 'TMOUT': '86400', 21:00:02 INFO - 'USER': 'cltbld', 21:00:02 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:02 INFO - '_': '/tools/buildbot/bin/python'} 21:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:02 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 21:00:02 INFO - Cleaning up... 21:00:02 INFO - Return code: 0 21:00:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:00:02 INFO - Using env: {'DISPLAY': ':0', 21:00:02 INFO - 'HOME': '/home/cltbld', 21:00:02 INFO - 'LANG': 'en_US.UTF-8', 21:00:02 INFO - 'LANGUAGE': 'en_US:en', 21:00:02 INFO - 'LOGNAME': 'cltbld', 21:00:02 INFO - 'MAIL': '/var/mail/cltbld', 21:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:02 INFO - 'MOZ_NO_REMOTE': '1', 21:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:02 INFO - 'NO_EM_RESTART': '1', 21:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:02 INFO - 'PWD': '/builds/slave/test', 21:00:02 INFO - 'SHELL': '/bin/bash', 21:00:02 INFO - 'SHLVL': '1', 21:00:02 INFO - 'TERM': 'linux', 21:00:02 INFO - 'TMOUT': '86400', 21:00:02 INFO - 'USER': 'cltbld', 21:00:02 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:02 INFO - '_': '/tools/buildbot/bin/python'} 21:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:03 INFO - Downloading/unpacking psutil>=0.7.1 21:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:00:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:00:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:00:04 INFO - Installing collected packages: psutil 21:00:04 INFO - Running setup.py install for psutil 21:00:05 INFO - building 'psutil._psutil_linux' extension 21:00:05 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 21:00:05 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 21:00:05 INFO - building 'psutil._psutil_posix' extension 21:00:05 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 21:00:05 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 21:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:00:05 INFO - Successfully installed psutil 21:00:05 INFO - Cleaning up... 21:00:05 INFO - Return code: 0 21:00:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:00:05 INFO - Using env: {'DISPLAY': ':0', 21:00:05 INFO - 'HOME': '/home/cltbld', 21:00:05 INFO - 'LANG': 'en_US.UTF-8', 21:00:05 INFO - 'LANGUAGE': 'en_US:en', 21:00:05 INFO - 'LOGNAME': 'cltbld', 21:00:05 INFO - 'MAIL': '/var/mail/cltbld', 21:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:05 INFO - 'MOZ_NO_REMOTE': '1', 21:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:05 INFO - 'NO_EM_RESTART': '1', 21:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:05 INFO - 'PWD': '/builds/slave/test', 21:00:05 INFO - 'SHELL': '/bin/bash', 21:00:05 INFO - 'SHLVL': '1', 21:00:05 INFO - 'TERM': 'linux', 21:00:05 INFO - 'TMOUT': '86400', 21:00:05 INFO - 'USER': 'cltbld', 21:00:05 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:05 INFO - '_': '/tools/buildbot/bin/python'} 21:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:00:07 INFO - Installing collected packages: mozsystemmonitor 21:00:07 INFO - Running setup.py install for mozsystemmonitor 21:00:07 INFO - Successfully installed mozsystemmonitor 21:00:07 INFO - Cleaning up... 21:00:07 INFO - Return code: 0 21:00:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:00: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')]} 21:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00: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')]} 21:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00: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', '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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:00: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 blobuploader==1.2.4 21:00:07 INFO - Using env: {'DISPLAY': ':0', 21:00:07 INFO - 'HOME': '/home/cltbld', 21:00:07 INFO - 'LANG': 'en_US.UTF-8', 21:00:07 INFO - 'LANGUAGE': 'en_US:en', 21:00:07 INFO - 'LOGNAME': 'cltbld', 21:00:07 INFO - 'MAIL': '/var/mail/cltbld', 21:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:07 INFO - 'MOZ_NO_REMOTE': '1', 21:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:07 INFO - 'NO_EM_RESTART': '1', 21:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:07 INFO - 'PWD': '/builds/slave/test', 21:00:07 INFO - 'SHELL': '/bin/bash', 21:00:07 INFO - 'SHLVL': '1', 21:00:07 INFO - 'TERM': 'linux', 21:00:07 INFO - 'TMOUT': '86400', 21:00:07 INFO - 'USER': 'cltbld', 21:00:07 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:07 INFO - '_': '/tools/buildbot/bin/python'} 21:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:00:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:00: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 21:00: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 21:00: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 21:00: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 21:00: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 21:00: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 21:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:00:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:10 INFO - Downloading docopt-0.6.1.tar.gz 21:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:00:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:00:10 INFO - Running setup.py install for blobuploader 21:00:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:00:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:00:10 INFO - Running setup.py install for requests 21:00:10 INFO - Running setup.py install for docopt 21:00:10 INFO - Successfully installed blobuploader requests docopt 21:00:10 INFO - Cleaning up... 21:00:10 INFO - Return code: 0 21:00:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:10 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')]} 21:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:10 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')]} 21:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:10 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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:10 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 21:00:10 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 21:00:11 INFO - Using env: {'DISPLAY': ':0', 21:00:11 INFO - 'HOME': '/home/cltbld', 21:00:11 INFO - 'LANG': 'en_US.UTF-8', 21:00:11 INFO - 'LANGUAGE': 'en_US:en', 21:00:11 INFO - 'LOGNAME': 'cltbld', 21:00:11 INFO - 'MAIL': '/var/mail/cltbld', 21:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:11 INFO - 'MOZ_NO_REMOTE': '1', 21:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:11 INFO - 'NO_EM_RESTART': '1', 21:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:11 INFO - 'PWD': '/builds/slave/test', 21:00:11 INFO - 'SHELL': '/bin/bash', 21:00:11 INFO - 'SHLVL': '1', 21:00:11 INFO - 'TERM': 'linux', 21:00:11 INFO - 'TMOUT': '86400', 21:00:11 INFO - 'USER': 'cltbld', 21:00:11 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:11 INFO - '_': '/tools/buildbot/bin/python'} 21:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:00:11 INFO - Running setup.py (path:/tmp/pip-Uy9oX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:00:11 INFO - Running setup.py (path:/tmp/pip-1qNQXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:00:11 INFO - Running setup.py (path:/tmp/pip-qgx9nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:00:11 INFO - Running setup.py (path:/tmp/pip-SKOEqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:00:11 INFO - Running setup.py (path:/tmp/pip-n9ZvDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:00:11 INFO - Running setup.py (path:/tmp/pip-gvnSRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:00:11 INFO - Running setup.py (path:/tmp/pip-25hNWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:00:11 INFO - Running setup.py (path:/tmp/pip-QyXIbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:00:11 INFO - Running setup.py (path:/tmp/pip-NZLdrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:00:11 INFO - Running setup.py (path:/tmp/pip-tiyhP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:00:11 INFO - Running setup.py (path:/tmp/pip-jSsCvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:00:11 INFO - Running setup.py (path:/tmp/pip-xkXxhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:00:12 INFO - Running setup.py (path:/tmp/pip-HDin10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:00:12 INFO - Running setup.py (path:/tmp/pip-S3qWRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:12 INFO - Running setup.py (path:/tmp/pip-Tfw4oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:00:12 INFO - Running setup.py (path:/tmp/pip-2eJXMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:00:12 INFO - Running setup.py (path:/tmp/pip-a7ILev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:00:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:00:12 INFO - Running setup.py install for manifestparser 21:00:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:00:12 INFO - Running setup.py install for mozcrash 21:00:12 INFO - Running setup.py install for mozdebug 21:00:12 INFO - Running setup.py install for mozdevice 21:00:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:00:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:00:12 INFO - Running setup.py install for mozfile 21:00:12 INFO - Running setup.py install for mozhttpd 21:00:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozinfo 21:00:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozInstall 21:00:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozleak 21:00:13 INFO - Running setup.py install for mozlog 21:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for moznetwork 21:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozprocess 21:00:13 INFO - Running setup.py install for mozprofile 21:00:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozrunner 21:00:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:00:13 INFO - Running setup.py install for mozscreenshot 21:00:13 INFO - Running setup.py install for moztest 21:00:14 INFO - Running setup.py install for mozversion 21:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:00:14 INFO - Cleaning up... 21:00:14 INFO - Return code: 0 21:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:14 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')]} 21:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:14 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')]} 21:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:14 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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:14 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 21:00:14 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 21:00:14 INFO - Using env: {'DISPLAY': ':0', 21:00:14 INFO - 'HOME': '/home/cltbld', 21:00:14 INFO - 'LANG': 'en_US.UTF-8', 21:00:14 INFO - 'LANGUAGE': 'en_US:en', 21:00:14 INFO - 'LOGNAME': 'cltbld', 21:00:14 INFO - 'MAIL': '/var/mail/cltbld', 21:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:14 INFO - 'MOZ_NO_REMOTE': '1', 21:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:14 INFO - 'NO_EM_RESTART': '1', 21:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:14 INFO - 'PWD': '/builds/slave/test', 21:00:14 INFO - 'SHELL': '/bin/bash', 21:00:14 INFO - 'SHLVL': '1', 21:00:14 INFO - 'TERM': 'linux', 21:00:14 INFO - 'TMOUT': '86400', 21:00:14 INFO - 'USER': 'cltbld', 21:00:14 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:14 INFO - '_': '/tools/buildbot/bin/python'} 21:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:00:14 INFO - Running setup.py (path:/tmp/pip-smN1k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:00:14 INFO - Running setup.py (path:/tmp/pip-cFkilr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:00:14 INFO - Running setup.py (path:/tmp/pip-lXxnH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:00:14 INFO - Running setup.py (path:/tmp/pip-nyOKuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:00:14 INFO - Running setup.py (path:/tmp/pip-gQwlYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:00:14 INFO - Running setup.py (path:/tmp/pip-m2E6zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:00:14 INFO - Running setup.py (path:/tmp/pip-BDOF9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:00:14 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)) 21:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:00:14 INFO - Running setup.py (path:/tmp/pip-BibvAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:00:15 INFO - Running setup.py (path:/tmp/pip-5BKFE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:00:15 INFO - Running setup.py (path:/tmp/pip-fISezj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:00:15 INFO - Running setup.py (path:/tmp/pip-UwiqCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:00:15 INFO - Running setup.py (path:/tmp/pip-LGvxEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:00:15 INFO - Running setup.py (path:/tmp/pip-zWzvcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:00:15 INFO - Running setup.py (path:/tmp/pip-O5bbyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:15 INFO - Running setup.py (path:/tmp/pip-Fsfg5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:00:15 INFO - Running setup.py (path:/tmp/pip-JzuldO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:00:15 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)) 21:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:00:15 INFO - Running setup.py (path:/tmp/pip-94gLkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:00:15 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)) 21:00:15 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)) 21:00:15 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)) 21:00:15 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)) 21:00:15 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)) 21:00:15 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)) 21:00:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:17 INFO - Downloading blessings-1.5.1.tar.gz 21:00:17 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 21:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:00:17 INFO - Installing collected packages: blessings 21:00:17 INFO - Running setup.py install for blessings 21:00:17 INFO - Successfully installed blessings 21:00:17 INFO - Cleaning up... 21:00:17 INFO - Return code: 0 21:00:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:00:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:00:17 INFO - Reading from file tmpfile_stdout 21:00:17 INFO - Current package versions: 21:00:17 INFO - argparse == 1.2.1 21:00:17 INFO - blessings == 1.5.1 21:00:17 INFO - blobuploader == 1.2.4 21:00:17 INFO - docopt == 0.6.1 21:00:17 INFO - manifestparser == 1.1 21:00:17 INFO - mozInstall == 1.12 21:00:17 INFO - mozcrash == 0.16 21:00:17 INFO - mozdebug == 0.1 21:00:17 INFO - mozdevice == 0.47 21:00:17 INFO - mozfile == 1.2 21:00:17 INFO - mozhttpd == 0.7 21:00:17 INFO - mozinfo == 0.9 21:00:17 INFO - mozleak == 0.1 21:00:17 INFO - mozlog == 3.1 21:00:17 INFO - moznetwork == 0.27 21:00:17 INFO - mozprocess == 0.22 21:00:17 INFO - mozprofile == 0.27 21:00:17 INFO - mozrunner == 6.11 21:00:17 INFO - mozscreenshot == 0.1 21:00:17 INFO - mozsystemmonitor == 0.0 21:00:17 INFO - moztest == 0.7 21:00:17 INFO - mozversion == 1.4 21:00:17 INFO - psutil == 3.1.1 21:00:17 INFO - requests == 1.2.3 21:00:17 INFO - wsgiref == 0.1.2 21:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:17 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')]} 21:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:17 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')]} 21:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:17 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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:17 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 21:00:17 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 21:00:17 INFO - Using env: {'DISPLAY': ':0', 21:00:17 INFO - 'HOME': '/home/cltbld', 21:00:17 INFO - 'LANG': 'en_US.UTF-8', 21:00:17 INFO - 'LANGUAGE': 'en_US:en', 21:00:17 INFO - 'LOGNAME': 'cltbld', 21:00:17 INFO - 'MAIL': '/var/mail/cltbld', 21:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:17 INFO - 'MOZ_NO_REMOTE': '1', 21:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:17 INFO - 'NO_EM_RESTART': '1', 21:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:17 INFO - 'PWD': '/builds/slave/test', 21:00:17 INFO - 'SHELL': '/bin/bash', 21:00:17 INFO - 'SHLVL': '1', 21:00:17 INFO - 'TERM': 'linux', 21:00:17 INFO - 'TMOUT': '86400', 21:00:17 INFO - 'USER': 'cltbld', 21:00:17 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:17 INFO - '_': '/tools/buildbot/bin/python'} 21:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 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)) 21:00:18 INFO - Cleaning up... 21:00:18 INFO - Return code: 0 21:00:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:00:18 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')]} 21:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:18 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')]} 21:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:18 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 0x259c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', '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 21:00:18 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 21:00:18 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 21:00:18 INFO - Using env: {'DISPLAY': ':0', 21:00:18 INFO - 'HOME': '/home/cltbld', 21:00:18 INFO - 'LANG': 'en_US.UTF-8', 21:00:18 INFO - 'LANGUAGE': 'en_US:en', 21:00:18 INFO - 'LOGNAME': 'cltbld', 21:00:18 INFO - 'MAIL': '/var/mail/cltbld', 21:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:18 INFO - 'MOZ_NO_REMOTE': '1', 21:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:18 INFO - 'NO_EM_RESTART': '1', 21:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:18 INFO - 'PWD': '/builds/slave/test', 21:00:18 INFO - 'SHELL': '/bin/bash', 21:00:18 INFO - 'SHLVL': '1', 21:00:18 INFO - 'TERM': 'linux', 21:00:18 INFO - 'TMOUT': '86400', 21:00:18 INFO - 'USER': 'cltbld', 21:00:18 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:18 INFO - '_': '/tools/buildbot/bin/python'} 21:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:18 INFO - Downloading/unpacking jsonschema 21:00:18 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 21:00:18 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 21:00:18 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 21:00:18 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 21:00:18 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 21:00:18 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 21:00:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:00:19 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 21:00:19 INFO - Downloading/unpacking functools32 (from jsonschema) 21:00:19 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 21:00:19 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 21:00:19 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 21:00:19 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 21:00:19 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 21:00:19 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 21:00:20 INFO - Downloading functools32-3.2.3-2.tar.gz 21:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:00:20 INFO - warning: no files found matching '*.txt' 21:00:20 INFO - no previously-included directories found matching 'build' 21:00:20 INFO - no previously-included directories found matching 'dist' 21:00:20 INFO - no previously-included directories found matching '.git*' 21:00:20 INFO - Installing collected packages: jsonschema, functools32 21:00:20 INFO - Running setup.py install for functools32 21:00:20 INFO - warning: no files found matching '*.txt' 21:00:20 INFO - no previously-included directories found matching 'build' 21:00:20 INFO - no previously-included directories found matching 'dist' 21:00:20 INFO - no previously-included directories found matching '.git*' 21:00:20 INFO - Successfully installed jsonschema functools32 21:00:20 INFO - Cleaning up... 21:00:20 INFO - Return code: 0 21:00:20 INFO - Running post-action listener: _resource_record_post_action 21:00:20 INFO - Running post-action listener: _start_resource_monitoring 21:00:20 INFO - Starting resource monitoring. 21:00:20 INFO - ##### 21:00:20 INFO - ##### Running install step. 21:00:20 INFO - ##### 21:00:20 INFO - Running pre-action listener: _resource_record_pre_action 21:00:20 INFO - Running main action method: install 21:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:00:20 INFO - Reading from file tmpfile_stdout 21:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 21:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:00:20 INFO - Reading from file tmpfile_stdout 21:00:20 INFO - Output received: 21:00:20 INFO - Usage: mozinstall [options] installer 21:00:20 INFO - Options: 21:00:20 INFO - -h, --help show this help message and exit 21:00:20 INFO - -d DEST, --destination=DEST 21:00:20 INFO - Directory to install application into. [default: 21:00:20 INFO - "/builds/slave/test"] 21:00:20 INFO - --app=APP Application being installed. [default: firefox] 21:00:20 INFO - mkdir: /builds/slave/test/build/application 21:00:20 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'] 21:00:20 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 21:00:35 INFO - Reading from file tmpfile_stdout 21:00:35 INFO - Output received: 21:00:35 INFO - /builds/slave/test/build/application/firefox/firefox 21:00:35 INFO - Running post-action listener: _resource_record_post_action 21:00:35 INFO - ##### 21:00:35 INFO - ##### Running run-tests step. 21:00:35 INFO - ##### 21:00:35 INFO - Running pre-action listener: _resource_record_pre_action 21:00:35 INFO - Running main action method: run_tests 21:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:00:35 INFO - Python 2.7.3 21:00:35 INFO - Return code: 0 21:00:35 INFO - grabbing minidump binary from tooltool 21:00:35 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')]} 21:00:35 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 0x285f220>, '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 0x27cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cb740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:00:35 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 21:00:35 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 21:00:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:00:35 INFO - Return code: 0 21:00:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:00:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:00:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:00:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:00:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:00:35 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/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test/build 21:00:35 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/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 21:00:35 INFO - Using env: {'DISPLAY': ':0', 21:00:35 INFO - 'HOME': '/home/cltbld', 21:00:35 INFO - 'LANG': 'en_US.UTF-8', 21:00:35 INFO - 'LANGUAGE': 'en_US:en', 21:00:35 INFO - 'LOGNAME': 'cltbld', 21:00:35 INFO - 'MAIL': '/var/mail/cltbld', 21:00:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:00:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:35 INFO - 'MOZ_NO_REMOTE': '1', 21:00:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:35 INFO - 'NO_EM_RESTART': '1', 21:00:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:35 INFO - 'PWD': '/builds/slave/test', 21:00:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:00:35 INFO - 'SHELL': '/bin/bash', 21:00:35 INFO - 'SHLVL': '1', 21:00:35 INFO - 'TERM': 'linux', 21:00:35 INFO - 'TMOUT': '86400', 21:00:35 INFO - 'USER': 'cltbld', 21:00:35 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850', 21:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:35 INFO - '_': '/tools/buildbot/bin/python'} 21:00:35 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/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 21:00:35 INFO - mozversion INFO | application_buildid: 20151125164213 21:00:35 INFO - mozversion INFO | application_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 21:00:35 INFO - mozversion INFO | application_display_name: Nightly 21:00:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:00:35 INFO - mozversion INFO | application_name: Firefox 21:00:35 INFO - mozversion INFO | application_remotingname: firefox 21:00:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:00:35 INFO - mozversion INFO | application_vendor: Mozilla 21:00:35 INFO - mozversion INFO | application_version: 45.0a1 21:00:35 INFO - mozversion INFO | platform_buildid: 20151125164213 21:00:35 INFO - mozversion INFO | platform_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 21:00:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:00:35 INFO - mozversion INFO | platform_version: 45.0a1 21:00:35 INFO - 2015-11-25 21:00:35,296 DEBUG : using testdate: 1448514035 21:00:35 INFO - 2015-11-25 21:00:35,296 DEBUG : actual date: 1448514035 21:00:35 INFO - 2015-11-25 21:00:35,371 INFO : starting webserver on 'localhost:59866' 21:00:35 INFO - 2015-11-25 21:00:35,372 INFO : Starting test suite talos-linux64-ix-010 21:00:35 INFO - 2015-11-25 21:00:35,372 INFO : Starting test dromaeo_css 21:00:35 INFO - 2015-11-25 21:00:35,372 DEBUG : operating with platform_type : linux_ 21:00:35 INFO - 2015-11-25 21:00:35,372 INFO : Initialising browser for dromaeo_css test... 21:00:35 INFO - 2015-11-25 21:00:35,384 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__ZEEz/profile http://localhost:59866/getInfo.html 21:00:39 INFO - 2015-11-25 21:00:39,301 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:00:39 INFO - 2015-11-25 21:00:39,301 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:00:39 INFO - 2015-11-25 21:00:39,302 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:00:39 INFO - 2015-11-25 21:00:39,302 DEBUG : BROWSER_OUTPUT: __metrics 21:00:39 INFO - 2015-11-25 21:00:39,438 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] 21:00:40 INFO - 2015-11-25 21:00:40,704 INFO : Browser initialized. 21:00:40 INFO - 2015-11-25 21:00:40,704 INFO : Running cycle 1/1 for dromaeo_css test... 21:00:40 INFO - 2015-11-25 21:00:40,704 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__ZEEz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:00:52 INFO - 2015-11-25 21:00:52,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 21:00:52 INFO - 2015-11-25 21:00:52,569 DEBUG : BROWSER_OUTPUT: 21:01:43 INFO - 2015-11-25 21:01:43,813 DEBUG : BROWSER_OUTPUT: 1448514103813 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] 21:03:55 INFO - 2015-11-25 21:03:55,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59866/tests/dromaeo/cssquery-ext.html) 21:03:56 INFO - 2015-11-25 21:03:56,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 222109696 21:03:56 INFO - 2015-11-25 21:03:56,803 DEBUG : BROWSER_OUTPUT: 21:06:59 INFO - 2015-11-25 21:06:59,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-ext.html (next: http://localhost:59866/tests/dromaeo/cssquery-jquery.html) 21:06:59 INFO - 2015-11-25 21:06:59,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 224890880 21:06:59 INFO - 2015-11-25 21:06:59,761 DEBUG : BROWSER_OUTPUT: 21:10:01 INFO - 2015-11-25 21:10:01,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59866/tests/dromaeo/cssquery-mootools.html) 21:10:02 INFO - 2015-11-25 21:10:02,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 223019008 21:10:02 INFO - 2015-11-25 21:10:02,355 DEBUG : BROWSER_OUTPUT: 21:13:04 INFO - 2015-11-25 21:13:04,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59866/tests/dromaeo/cssquery-prototype.html) 21:13:04 INFO - 2015-11-25 21:13:04,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 199315456 21:13:04 INFO - 2015-11-25 21:13:04,841 DEBUG : BROWSER_OUTPUT: 21:16:07 INFO - 2015-11-25 21:16:07,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59866/tests/dromaeo/cssquery-yui.html) 21:16:08 INFO - 2015-11-25 21:16:08,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 202010624 21:16:08 INFO - 2015-11-25 21:16:08,236 DEBUG : BROWSER_OUTPUT: 21:19:10 INFO - 2015-11-25 21:19:10,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/dromaeo/cssquery-yui.html (next: http://localhost:59866/tests/dromaeo/cssquery-dojo.html) 21:19:11 INFO - 2015-11-25 21:19:11,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 243228672 21:19:11 INFO - 2015-11-25 21:19:11,123 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,124 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:19:11 INFO - 2015-11-25 21:19:11,124 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:19:11 INFO - 2015-11-25 21:19:11,124 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:19:11 INFO - 2015-11-25 21:19:11,124 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:19:11 INFO - 2015-11-25 21:19:11,124 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.343664083979;2700.7704345130664;2715.524783162946;2725.427660191359;2729.1266794625717;4489.787757305526;4647.512011238822;4650.813967441299;4662.137504561659;4666.813327466902;4524.932126018112;4585.358049873021;4642.466116396616;4661.58045775881;4684;4265.658747300216;4303.720258183208;4320.135972805451;4320.611144996949;4340.08858139791;4111.958880411203;4377.1683380157665;4393.362962370455;4421.911561768763;4423.0711550574415;4158.6673066154635;4223.493180818306;4242.406063151161;4267.466566679165;4285.8499952501825;4282.486101667789;4302.397664326997;4323.82704691812;4325.351197320396;4346.369776382438;4103.774292413916;4259.10558782656;4282.657387409;4295.871123866289;4304.634106100985;4436.290193569013;4463.152001119777;4476.664250181249;4515.593596576324;4553.544645535453;4976.502349765031;5024.924626130611;5039.949600503985;5041.269015992697;5093.465186155438;4750.026244619845;5049.722265275408;5051.823186188502;5065.138926382487;5065.290859279667;4574.428196475441;4576.702514336557;4601.240795268776;4622.306654001926;4681;5041.168207245763;5052.671576347526;5055.772490237948;5058.822941197041;5099.56653684441;4661.743604101739;4857.878553036202;4859.757012149378;4867.148249056472;4901.926471102936;4886.3403440535785;4894.681845680019;4896.95103048972;4899.1426500362295;4943;4818.638602104857;4861.465238823726;4862.756862156878;4887.511248875084;4898.975505122523;4793;4803.663743537989;4830.516948305211;4839.564439200489;4896.828610998669;3982.143839074613;4051.756894586334;4075.3886916962692;4091.7954102294766;4137.441445404892;3577.1951310955346;3621.5292012038794;3643.981780091083;3663.0476076220375;3675.9081022974106;4300.7634580097765;4306.095719898856;4322.913541729148;4341.45731783527;4353.238183317907;4783.5933945614315;4895.045466134141;4898.951010489921;4996.025774973918;5009.474005229471;4218.810153543098;4231.7672528010635;4242.384854196124;4281.100968796525;4299.376590394375;4437.06821567468;4442.111577684476;4442.4669039715445;4454.844080457168;4473.6868419211;4746.430428348551;4756.6908150970075;4760.071786001697;4767.523247675204;4801.447833499123;4715.198416269174;4840.104580652591;4842.15262329084;4846.006568653347;4989.501049895127;4591.540845915515;4657.953420465752;4681.040386720646;4716.151092803191;4729.479757226771;4902.9019419610695;4916.06594746997;4953.157963146202;4958.504149585013;4998.275250088789;4801.9039619208115;5026.5727413168825;5036.974815125901;5037.798488060436;5089.720065396439;4701.600363969101;4755.500672429345;4772.570468657837;4774.618030557616;4820.276958456259;4786.138495070921;4788.664793464563;4789.353437285922;4799.328094066903;4814.20565606671;4525.524819893995;4706.647001474971;4715.080559291043;4719.882002949954;4756.215224487921;4733.5266473352385;4784.282357646381;4788.233882578771;4821.325014498043;4830.6135509159885;4767.356406885165;4778.354922085474;4784.545468180518;4788.329633851194;4832.613390928647 21:19:11 INFO - 2015-11-25 21:19:11,125 DEBUG : BROWSER_OUTPUT: |1;ext.html;479.41032529988115;493.6766417996214;555.0720433226961;581.834177259481;591.1576004194023;21808.454788630293;36015.63984360159;36082.8195859021;36084.81957590212;36145.27709445809;39589.8020509897;40108;40189.39715904264;40244;40272.59727402725;6633.568818026813;6752.291009444011;7908.3673306135515;8079.272865442109;8079.717209897654;10255.128314093312;10520.736981575445;10522.42126683032;10530.631427900025;10536.631217907374;10122.392656440637;10225.846612300822;10249.282550221487;10251.487425628726;10253.077223049924;6663.167104111986;6815.863682726318;6823.215330236987;6831.2144103428245;9938;6676.065350850885;6816.693248803816;10067.848982265272;10472;10513.842292365543;37057.444138337945;37420;37538.249235015144;37572.81213593942;37585.81207093947;2646.695630002555;2750.642416485864;2759.1722483254944;3261.184703824044;3486.4421692529327;27900.581491277648;28144;28162.71837281642;28329;28459.715402845915;3357.142502100075;3487.232808782064;3492.266624008961;3558.3594952908466;3581.6418358164237;225108;226426;226568;226708.86645566832;227483;56483.43516564782;56986;57072.14391784126;57083;57084.42915570874;36329.81835090861;36342.818285908405;58147.41852581505;59203.407965920655;59236;12186.878131218751;12259.448324825404;12354.876451235552;12372.566960156531;12375.75248495025;9933;9977.80044399108;9984.850227246598;9986.101250887456;9988;17981.460556183334;18043.909780451013;18132.63734725298;18692.158852851655;18752.24991000372;6760.763373281911;6986.790396288018;7016.754413595601;7069.752558660422;7110.857782844314;828.7928017995501;860.8149247911604;888.3426264564176;896.7085697148453;936.3398803843274;25558.872205638854;25864.094756683426;25924.74075259223;26039.349016274744;26122.346941326618;923.2890674180977;926.4117285523741;927.79124696944;951.5622813505727;1036.4713995862164;13671.863281367258;13743.244121573209;13880.93059534696;14408.855911440962;14595.92702036483;204509;208471;209556;210170;210828;40690.79654601708;40767;40840.59159408368;40902.772916812544;40913.181736365106;1179.0744265751343;1184.3130984029242;1191.1007189571817;1194.1282863509687;1201.7055821323656;15256.283613214919;23637.881810590836;25975.480490390466;26479.60280595831;27068.32329191786;36816.63183368132;37212.44181337228;37251.25497490089;37260;37264.78293038922;220983;223667;223875;224350;224635;19760.703589446457;20068.297609583595;26550.203493895213;28320.575191371732;28422.14733557914;31305.68694313119;31415.52876706897;31585.8420707895;31899.202519937186;31923;28996.565051523823;29426.852865735535;31828;32884.83557582197;33300;29725.108246752632;29969.400611988076;30001.549976750804;30048;30168.84915575408;29502.409951801274;31809.204769880937;32121.196970075936;32208.516872246466;32318.83840580782;25597.47264447554;27482.862585686944;27509.86245068842;27528.449431011668;27541.31146721348;21157.576848463254;21195;21924.23265185711;22684.618115097677;22847.428814279778 21:19:11 INFO - 2015-11-25 21:19:11,125 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.186075507456;323.57288379339275;329.56661989483814;332.08841729452655;337.9239671074007;11234.382108984002;11528.135389845775;14975.775363369545;15423.537293881187;15730.842691573094;13368.131071480348;13613.795793063113;13728.588142355746;14077;14096.506622268224;4344.565543445646;4912.828051018215;5044.848654540351;5066.240063990394;5067.49325067494;3510.912227194328;3549.432090865462;4985.152524070899;5602.523785478239;5801.593888427812;5840.737166827503;5853;5867.442592953684;5870.354261031283;5894.351621321673;5690.317161940552;5902.2327097477055;5903;5904.645721256738;5909.7340619672;5160.535551800356;5170.069387510247;5170.767315470813;5171.741412929376;5171.7672704728;19029.429117126507;19079.904600477046;19319.613607727766;19365.612687746307;19403.126859291366;1808.7558179645712;1819.3177558415593;1954.9120289587004;1964.4695932098252;2008.708737233093;11566.53733850645;11856.525738970431;11871.050315974788;11883.405829708567;12054;1767.7701898753207;1770.2122555462824;1773.4502304285713;1780.287884846059;1784.3041213926579;54222.72888635571;54439;55282.447175528134;55445.72277138629;56785.43214567843;9028.774280643036;9153.267738580898;9295.11696388842;9296.140771845523;9369.531523423939;11708.88291117095;11727.472263748152;11733.647990560297;11734;11738;6218.347073557302;6222.12890195373;6389.840253993687;6409.455196308366;6423.325550817191;6031.758729650853;6040.577159598786;6084.5132389408745;6091.14723938649;6091.878162436727;5350.705711185922;5356.892862142735;5360.597955153379;5390.8921821563345;5396.9730151348995;1396.9301534923213;1430.342042660367;1622.5700189449806;1625.2036502114115;1676.513810994798;377.58277103799907;379.2774764074443;422.9788510574459;826.7850358906608;851.0340763233775;8554.230119289294;9120.17918387335;9683.128518433234;9881.703548893545;9886.357386769982;407.84094203260753;409.92826255405186;425.61907093152075;426.54359834976276;446.4464064559987;5463.83608491738;5468.808591699271;5671.035923892948;5732.369439361667;5789.594728369058;462794;470334;475953;488225;488412;67545.66227168833;68701.31298687049;69717.65141174261;70565.2943470569;70958.22604434827;454.31398588132157;459.5725974843428;460.13953906195627;460.62919349923635;461.3702296365437;9764.316497845082;9837.754056148653;9871.703848884545;10030.849537256801;10036.347637403545;31550;32164;32594;32812;32848;38870;39208.215835683695;39315.60684393119;39544;41024;8892.688755893512;8994.505302208441;9214.124658157465;9333.626654933727;9341.532923353669;16237.756433653269;16325.83674163243;16355.836441635907;16482.093484858447;16760.66478670444;12297.815532766837;12343.19769214998;12899.161554498927;13459.528916487876;13629.795553066513;11291.209615326849;11374.772504549697;11708.531658733897;12915.935420322838;13014.479420823061;8862.86705699402;9134.771630709285;9166;9241.21449676785;9349.813003740022;13400.463981440633;13543.729125417634;13651.04442689042;14081.859181408465;14089.365978531196;11785.88214117848;11802.586909458129;12549.87450125487;13782.862171378158;14333 21:19:11 INFO - 2015-11-25 21:19:11,128 DEBUG : BROWSER_OUTPUT: |3;mootools.html;878.8330217258716;1580.8735301175907;1625.057466669332;1649.0765171503958;1652.917354132293;5537.003339398907;6789.25318214996;6999.755008574701;7005.299470052993;7017.122859642544;6621.370969757865;6782.8304292392595;6790.966045169767;6799.048133261347;6800.285969973143;1954.6090781843582;1984.9007549622534;1986.2055177928871;1986.6026794641057;1988.4730546405215;2047.9795202048012;2076.49125964139;2082.2191678120703;2106.7471903371616;2110.2192188890053;1965.5380985468403;1978.9901050494727;1998.830099441542;1999.7100420439028;2000.8599398042143;2037.4193354893857;2074.678424844152;2074.7614024387085;2076.2733043434678;2077.1172251793005;2027.168860767093;2056.5475595368994;2094.057674046685;2096.2872623307994;2096.6540520814046;5343.625946183769;5486.807961721321;6829.692663830139;6890.827729306758;6899.379055884944;3307.2724000719804;3900.1419687668667;3931.3906344516645;3938.6652134568594;3943.0339566806315;2702.3649442381025;2746.382064035596;2759.1722483254944;2778.5554311310298;2858;878.775912142406;887.6138879587401;896.381496767235;911.4759013567225;913.0458670689146;9043.050479699668;9117.179453849185;9126.908730912739;9138.223251023672;9162.083791620851;3903.375459926398;3935.0555866591812;3964.6718349352714;3968.1071758854027;3985.5217373915316;7981.880271795928;7995.120536740954;8002.83994320122;8007.399445041645;8008.39937004727;4067.8779636610357;4086.7752273625238;4087.693422993287;4088.9386659200136;4089.0595163112653;3753.3994560870674;3756.7558108722847;3757.830897609614;3759.285735710206;3762.0406796267325;3067.6778938211614;3073.3699591583672;3091.829949352762;3126.515390114536;3136.686331366845;1018.7402212435929;1019.3781793106199;1023.2785885950387;1026.4508487959056;1026.4867566216892;910.5674804467825;919.5586118662945;931.6971984105193;931.9720408387759;934.2525979216599;6294.716737746812;6317.4946004319545;6360.363963603602;6369.490440764727;6383.840403989844;440.3087153169557;446.88157638225897;447.73583585684605;450.0346756207916;454.3344001038495;4306.095719898856;4980;5039.017391608601;5041.344625198701;5044.1929291313945;6984.371406573433;7047.119110111236;7072.3634872861685;7150.7497237596435;7300.525465844703;7968.920310796933;8073.192680731997;8183.468074575134;8198.426110172231;8202.343812494986;6148.846278842975;6184.381561843779;6190.938090619126;6211.16149319836;6228.159198508234;6378.936210637834;6383.616982981036;6389.808305750835;6396.168498095218;6399;7188.640567971685;7457.291557302047;7470.813229669085;7497.062867141607;7505;7412.851742965003;7646.120696120018;7660.2722741339485;7662.73180438682;7675.309222170032;5588.329400471969;5690.971545142248;5724.284464441945;5735.139729040678;5738.708790522099;6385.68071596409;6445.4199122079235;6455.289918109098;6461.935380646133;6463.224413070274;6112.113743507078;6139.29398119222;6190.907136393048;6242.2509298882605;6271.122042914087;5887.1757953887345;5921.851953701192;5939.91090133657;5972.940270597239;6088.543359248163;5880.382559831156;5989.610675306091;5994.220751302303;6005;6009.87980240384;5760.0783874579865;5799.449052340021;5807.970960145172;5819.563532734977;5826.446487583673;5791.305043394819;5800.245968024298;5813.82558523245;5820.126980952721;5876.3536011037895 21:19:11 INFO - 2015-11-25 21:19:11,129 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.23556867594846;294.8231061363182;296.81004157339294;308.2863171757383;310.86632747918384;5379.246905433238;5397.649152805065;5422.240886275925;5438.293021907147;5439.836804895859;5124.564412024973;5219.556337711299;5233.293505376773;5241.816536421226;5343.625946183769;4023.1752490739473;4026.1142548639255;4033.2336855997414;4103.8563650272245;4125.2780763366445;4140.192662430827;4143.544210136883;4150.501939767232;4161.854335098272;4164.292070348033;3891.182851601153;4113.56807535209;4127.752334859903;4132.090939993212;4136.420901073852;4016.5380981187245;4036.899077523056;4131.049858532554;4139.234241665302;4161.729487583328;3649;3649.59854416014;3651.014226158949;3657.2685462907257;3657.963420365789;5114.539691427789;5140.691558506502;5148.433672296044;5153.66501177426;5158.7678554464765;4726.76366181693;4729.148753224418;4730.290456431529;4731.290306454025;4731.384919960417;5457.781688732446;5585.5531557475715;5587.413321601254;5591.329040515124;5595.132754423071;3940.5271367435803;3940.763554186758;3954.703397245218;3956.307646161939;3964.920701585952;5870.823875283749;5872.647641141502;5873.588848780587;5878.647281163144;5889.204957330749;4067.186562687474;4073.490813648294;4074.7555146691293;4077.429159917614;4078.6940979426663;4039.414284928669;4137.565555616678;4140.047789008545;4143.97928010364;4156.646685031807;4701.694389864648;4705.200115980291;4709.481956984729;4710.481846996828;4712.340272361872;5520.337559492807;5574.303212098488;5578.30271216098;5580.581456390706;5582.8325150245555;1430.9141451512942;1468.214505239713;1470.147314557554;1470.624990627383;1471.2055490035261;1000.9449480278508;1005.5776573838859;1006.6929586476049;1013.0274936061317;1032.0505135275564;4871.926921096187;4881.096997055556;4881.292212629149;4884.096442158212;4888.706677599284;5728.541716662657;5732.226149469769;5735.1684005818925;5737.426257374313;5742.368339482737;4874.049560335771;4879.341288926021;4882.7558622068755;4883.194272944996;4883.487233840467;2911.4177164567172;3011.5031019881476;3051.5727798108283;3087.459694553444;3111.0200286909553;5449.3188351456065;5539.9169012464845;5555.083411237181;5555.749991250404;5559.221708960748;6002.759889604455;6005.519558435315;6007.068904319837;6021.6989150542295;6028.487578555872;5552.167174923794;5552.91670624941;5561.221428999943;5561.416051314634;5569.805056822992;5723.828285151452;5872.265966754156;5879.911801322898;5880.852978675567;5888.558358123072;5687.971560142173;5716.456936591017;5718.142278658234;5722.4277572242445;5731.455511726379;5543.52880005204;5547.306586676666;5554.222408862844;5554.805581804618;5555.50000499957;3823.4073718573663;3998.3402738548975;4031.09300407406;4035.4955630546183;4035.8497828118843;5798.217240672455;5829.067349224104;5829.679367634821;5830.679312637845;5842.853928651818;5535.5848311376;5573.888522229451;5574.358948720949;5576.86057848557;5636.718164091697;5622.156676498558;5622.606417550732;5628.915566266427;5630.380658127685;5634.070378387521;5327.840164794908;5498.422665620053;5499.175123731472;5503.559715222853;5508.338999320107;5638.464345887134;5641.633293835887;5641.689707066151;5644;5645.040343141593;5337.6797392156595;5478.671279723229;5479.315085614298;5482.80810171642;5488.1493368527945 21:19:11 INFO - 2015-11-25 21:19:11,130 DEBUG : BROWSER_OUTPUT: |5;yui.html;688.5077169823575;733.6148522025939;752.2214507984237;773.7175930785263;809.0655293136427;10901.29141605796;10974.341539507635;11020.173486988468;11031.117510599153;11061.170412219086;8244.58777061146;11509.366984815832;11594.826077608843;11630;11635.941820290887;283.868001379358;757.5795433534386;770.9190534993829;771.4329967473931;772.4013889235831;767.5394763142126;778.7585848387018;779.5517577392993;780.3055280800093;781.3592853859838;346.7416774502999;355.6727810414425;792.3067316098413;806.4234072638062;814.2020819596798;801.4950581133877;806.4838503357855;807.2049031703767;810.4691427115249;810.5703976892256;594.7739858853608;599.730121445347;600.7626987339976;600.9639421634716;601.1253625974241;11052.889471105267;11100.888991110067;11102.55589776408;11145.944270278596;11150;10670.466476676134;10727.517261723242;10829.404382758945;11154.386508742016;11608.245464044894;8965.820683586291;9048.728538143867;9168.404053736485;9255.67605133817;9320.580573874191;3198.0565733108556;3206.8396580170897;3239.3683231769814;3248.902532924016;3301.2077101495706;37865.621343786486;38656.61343386558;38666.806665966775;38726.22547549062;39746.60253397487;9015.684451044313;9031.683891063913;9087;9138.954305228564;9328.253739700807;15681.764773528406;15707.293171807296;15724;15728;15733.68532629341;5926.822195334147;5996.610220335664;6014.18808460861;6020.759169633166;6039.275286965592;3580.7851528907827;3595.5505561804775;3616.4936908832783;3634.491171236029;3711.387621042498;2546.2870396289068;2584.831985920909;2589.8705064746687;2592.4815036992677;2594;479.84405068352225;482.72967138402606;486.69824708680846;493.1419330365139;502.20400664945737;466.94863565007824;519.7479222577047;545.5172172627254;580.825752274316;606.0152252589542;7578;7658.387329013665;7712.15166331703;7834.647440865175;8062.314703250289;409.7193422505593;418.0426822576327;424.6496640271788;453.360761326528;564.9293838270216;3614.493970844084;3695.371786796251;3744.8127593620757;3806.8667596633986;3835.463035175078;50680.49319506832;53597.248192626925;54158.7292063545;54317.45682543203;54374.45625543773;42905;43381.132377352274;43954.34068488975;44166.558334416244;44395.556044439785;40090.599094008685;40936;41420.58579414227;41477.792611036755;41535.37696934548;7376.151742549676;7531.435142364235;7565.810854728676;7636.236376362319;7672.462927595015;30947.381052378376;31364.37271254608;32261;33190.336193275514;33660.66339336575;39538.62768233915;39980.800096000494;40316.79841600773;40694.389584155666;41005.1798964025;9088.54557272147;9162.404443711137;9334.579943902405;9799.755006124904;9844.458554779556;10868.130549556176;10947.34315941046;10947.83578246343;10965;11083.66748997499;9638.807223855623;10390.324628899098;10417.687469375931;10803.513841876977;11083.944580277048;9616.807663846825;9630.807383852423;9648.179904708179;9828.655997040356;9874.901250987397;9882;9974;10018.1985441166;10063.748406289902;10235.078842904175;8435.915640843514;8591.183837535424;8755.168259015383;8804.251638610789;8906.643734250816;8511.531865747444;8620.741377758677;8794.340424468062;9104.908950910407;9407.764805879633 21:19:11 INFO - 2015-11-25 21:19:11,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:19:11 INFO - 2015-11-25 21:19:11,130 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:19:11 INFO - 2015-11-25 21:19:11,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,952 21:19:11 INFO - 2015-11-25 21:19:11,130 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: __startTimestamp1448515151117__endTimestamp 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4567.71 Median:4715.08 stddev:463.94 (9.8%) stddev-sans-first:439.63 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: Values: 2625.3 2700.8 2715.5 2725.4 2729.1 4489.8 4647.5 4650.8 4662.1 4666.8 4524.9 4585.4 4642.5 4661.6 4684.0 4265.7 4303.7 4320.1 4320.6 4340.1 4112.0 4377.2 4393.4 4421.9 4423.1 4158.7 4223.5 4242.4 4267.5 4285.8 4282.5 4302.4 4323.8 4325.4 4346.4 4103.8 4259.1 4282.7 4295.9 4304.6 4436.3 4463.2 4476.7 4515.6 4553.5 4976.5 5024.9 5039.9 5041.3 5093.5 4750.0 5049.7 5051.8 5065.1 5065.3 4574.4 4576.7 4601.2 4622.3 4681.0 5041.2 5052.7 5055.8 5058.8 5099.6 4661.7 4857.9 4859.8 4867.1 4901.9 4886.3 4894.7 4897.0 4899.1 4943.0 4818.6 4861.5 4862.8 4887.5 4899.0 4793.0 4803.7 4830.5 4839.6 4896.8 3982.1 4051.8 4075.4 4091.8 4137.4 3577.2 3621.5 3644.0 3663.0 3675.9 4300.8 4306.1 4322.9 4341.5 4353.2 4783.6 4895.0 4899.0 4996.0 5009.5 4218.8 4231.8 4242.4 4281.1 4299.4 4437.1 4442.1 4442.5 4454.8 4473.7 4746.4 4756.7 4760.1 4767.5 4801.4 4715.2 4840.1 4842.2 4846.0 4989.5 4591.5 4658.0 4681.0 4716.2 4729.5 4902.9 4916.1 4953.2 4958.5 4998.3 4801.9 5026.6 5037.0 5037.8 5089.7 4701.6 4755.5 4772.6 4774.6 4820.3 4786.1 4788.7 4789.4 4799.3 4814.2 4525.5 4706.6 4715.1 4719.9 4756.2 4733.5 4784.3 4788.2 4821.3 4830.6 4767.4 4778.4 4784.5 4788.3 4832.6 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,131 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37399.49 Median:30737.27 stddev:57051.84 (185.6%) stddev-sans-first:57144.53 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: Values: 479.4 493.7 555.1 581.8 591.2 21808.5 36015.6 36082.8 36084.8 36145.3 39589.8 40108.0 40189.4 40244.0 40272.6 6633.6 6752.3 7908.4 8079.3 8079.7 10255.1 10520.7 10522.4 10530.6 10536.6 10122.4 10225.8 10249.3 10251.5 10253.1 6663.2 6815.9 6823.2 6831.2 9938.0 6676.1 6816.7 10067.8 10472.0 10513.8 37057.4 37420.0 37538.2 37572.8 37585.8 2646.7 2750.6 2759.2 3261.2 3486.4 27900.6 28144.0 28162.7 28329.0 28459.7 3357.1 3487.2 3492.3 3558.4 3581.6 225108.0 226426.0 226568.0 226708.9 227483.0 56483.4 56986.0 57072.1 57083.0 57084.4 36329.8 36342.8 58147.4 59203.4 59236.0 12186.9 12259.4 12354.9 12372.6 12375.8 9933.0 9977.8 9984.9 9986.1 9988.0 17981.5 18043.9 18132.6 18692.2 18752.2 6760.8 6986.8 7016.8 7069.8 7110.9 828.8 860.8 888.3 896.7 936.3 25558.9 25864.1 25924.7 26039.3 26122.3 923.3 926.4 927.8 951.6 1036.5 13671.9 13743.2 13880.9 14408.9 14595.9 204509.0 208471.0 209556.0 210170.0 210828.0 40690.8 40767.0 40840.6 40902.8 40913.2 1179.1 1184.3 1191.1 1194.1 1201.7 15256.3 23637.9 25975.5 26479.6 27068.3 36816.6 37212.4 37251.3 37260.0 37264.8 220983.0 223667.0 223875.0 224350.0 224635.0 19760.7 20068.3 26550.2 28320.6 28422.1 31305.7 31415.5 31585.8 31899.2 31923.0 28996.6 29426.9 31828.0 32884.8 33300.0 29725.1 29969.4 30001.5 30048.0 30168.8 29502.4 31809.2 32121.2 32208.5 32318.8 25597.5 27482.9 27509.9 27528.4 27541.3 21157.6 21195.0 21924.2 22684.6 22847.4 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25444.80 Median:2385.55 stddev:77973.74 (3268.6%) stddev-sans-first:78169.65 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: Values: 319.2 323.6 329.6 332.1 337.9 11234.4 11528.1 14975.8 15423.5 15730.8 13368.1 13613.8 13728.6 14077.0 14096.5 4344.6 4912.8 5044.8 5066.2 5067.5 3510.9 3549.4 4985.2 5602.5 5801.6 5840.7 5853.0 5867.4 5870.4 5894.4 5690.3 5902.2 5903.0 5904.6 5909.7 5160.5 5170.1 5170.8 5171.7 5171.8 19029.4 19079.9 19319.6 19365.6 19403.1 1808.8 1819.3 1954.9 1964.5 2008.7 11566.5 11856.5 11871.1 11883.4 12054.0 1767.8 1770.2 1773.5 1780.3 1784.3 54222.7 54439.0 55282.4 55445.7 56785.4 9028.8 9153.3 9295.1 9296.1 9369.5 11708.9 11727.5 11733.6 11734.0 11738.0 6218.3 6222.1 6389.8 6409.5 6423.3 6031.8 6040.6 6084.5 6091.1 6091.9 5350.7 5356.9 5360.6 5390.9 5397.0 1396.9 1430.3 1622.6 1625.2 1676.5 377.6 379.3 423.0 826.8 851.0 8554.2 9120.2 9683.1 9881.7 9886.4 407.8 409.9 425.6 426.5 446.4 5463.8 5468.8 5671.0 5732.4 5789.6 462794.0 470334.0 475953.0 488225.0 488412.0 67545.7 68701.3 69717.7 70565.3 70958.2 454.3 459.6 460.1 460.6 461.4 9764.3 9837.8 9871.7 10030.8 10036.3 31550.0 32164.0 32594.0 32812.0 32848.0 38870.0 39208.2 39315.6 39544.0 41024.0 8892.7 8994.5 9214.1 9333.6 9341.5 16237.8 16325.8 16355.8 16482.1 16760.7 12297.8 12343.2 12899.2 13459.5 13629.8 11291.2 11374.8 11708.5 12915.9 13014.5 8862.9 9134.8 9166.0 9241.2 9349.8 13400.5 13543.7 13651.0 14081.9 14089.4 11785.9 11802.6 12549.9 13782.9 14333.0 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4701.08 Median:5851.40 stddev:2424.43 (41.4%) stddev-sans-first:2414.20 21:19:11 INFO - 2015-11-25 21:19:11,133 DEBUG : BROWSER_OUTPUT: Values: 878.8 1580.9 1625.1 1649.1 1652.9 5537.0 6789.3 6999.8 7005.3 7017.1 6621.4 6782.8 6791.0 6799.0 6800.3 1954.6 1984.9 1986.2 1986.6 1988.5 2048.0 2076.5 2082.2 2106.7 2110.2 1965.5 1979.0 1998.8 1999.7 2000.9 2037.4 2074.7 2074.8 2076.3 2077.1 2027.2 2056.5 2094.1 2096.3 2096.7 5343.6 5486.8 6829.7 6890.8 6899.4 3307.3 3900.1 3931.4 3938.7 3943.0 2702.4 2746.4 2759.2 2778.6 2858.0 878.8 887.6 896.4 911.5 913.0 9043.1 9117.2 9126.9 9138.2 9162.1 3903.4 3935.1 3964.7 3968.1 3985.5 7981.9 7995.1 8002.8 8007.4 8008.4 4067.9 4086.8 4087.7 4088.9 4089.1 3753.4 3756.8 3757.8 3759.3 3762.0 3067.7 3073.4 3091.8 3126.5 3136.7 1018.7 1019.4 1023.3 1026.5 1026.5 910.6 919.6 931.7 932.0 934.3 6294.7 6317.5 6360.4 6369.5 6383.8 440.3 446.9 447.7 450.0 454.3 4306.1 4980.0 5039.0 5041.3 5044.2 6984.4 7047.1 7072.4 7150.7 7300.5 7968.9 8073.2 8183.5 8198.4 8202.3 6148.8 6184.4 6190.9 6211.2 6228.2 6378.9 6383.6 6389.8 6396.2 6399.0 7188.6 7457.3 7470.8 7497.1 7505.0 7412.9 7646.1 7660.3 7662.7 7675.3 5588.3 5691.0 5724.3 5735.1 5738.7 6385.7 6445.4 6455.3 6461.9 6463.2 6112.1 6139.3 6190.9 6242.3 6271.1 5887.2 5921.9 5939.9 5972.9 6088.5 5880.4 5989.6 5994.2 6005.0 6009.9 5760.1 5799.4 5808.0 5819.6 5826.4 5791.3 5800.2 5813.8 5820.1 5876.4 21:19:11 INFO - 2015-11-25 21:19:11,134 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4653.78 Median:5189.16 stddev:1365.37 (26.3%) stddev-sans-first:1329.25 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: Values: 285.2 294.8 296.8 308.3 310.9 5379.2 5397.6 5422.2 5438.3 5439.8 5124.6 5219.6 5233.3 5241.8 5343.6 4023.2 4026.1 4033.2 4103.9 4125.3 4140.2 4143.5 4150.5 4161.9 4164.3 3891.2 4113.6 4127.8 4132.1 4136.4 4016.5 4036.9 4131.0 4139.2 4161.7 3649.0 3649.6 3651.0 3657.3 3658.0 5114.5 5140.7 5148.4 5153.7 5158.8 4726.8 4729.1 4730.3 4731.3 4731.4 5457.8 5585.6 5587.4 5591.3 5595.1 3940.5 3940.8 3954.7 3956.3 3964.9 5870.8 5872.6 5873.6 5878.6 5889.2 4067.2 4073.5 4074.8 4077.4 4078.7 4039.4 4137.6 4140.0 4144.0 4156.6 4701.7 4705.2 4709.5 4710.5 4712.3 5520.3 5574.3 5578.3 5580.6 5582.8 1430.9 1468.2 1470.1 1470.6 1471.2 1000.9 1005.6 1006.7 1013.0 1032.1 4871.9 4881.1 4881.3 4884.1 4888.7 5728.5 5732.2 5735.2 5737.4 5742.4 4874.0 4879.3 4882.8 4883.2 4883.5 2911.4 3011.5 3051.6 3087.5 3111.0 5449.3 5539.9 5555.1 5555.7 5559.2 6002.8 6005.5 6007.1 6021.7 6028.5 5552.2 5552.9 5561.2 5561.4 5569.8 5723.8 5872.3 5879.9 5880.9 5888.6 5688.0 5716.5 5718.1 5722.4 5731.5 5543.5 5547.3 5554.2 5554.8 5555.5 3823.4 3998.3 4031.1 4035.5 4035.8 5798.2 5829.1 5829.7 5830.7 5842.9 5535.6 5573.9 5574.4 5576.9 5636.7 5622.2 5622.6 5628.9 5630.4 5634.1 5327.8 5498.4 5499.2 5503.6 5508.3 5638.5 5641.6 5641.7 5644.0 5645.0 5337.7 5478.7 5479.3 5482.8 5488.1 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12112.90 Median:484.71 stddev:14101.30 (2909.2%) stddev-sans-first:14114.76 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: Values: 688.5 733.6 752.2 773.7 809.1 10901.3 10974.3 11020.2 11031.1 11061.2 8244.6 11509.4 11594.8 11630.0 11635.9 283.9 757.6 770.9 771.4 772.4 767.5 778.8 779.6 780.3 781.4 346.7 355.7 792.3 806.4 814.2 801.5 806.5 807.2 810.5 810.6 594.8 599.7 600.8 601.0 601.1 11052.9 11100.9 11102.6 11145.9 11150.0 10670.5 10727.5 10829.4 11154.4 11608.2 8965.8 9048.7 9168.4 9255.7 9320.6 3198.1 3206.8 3239.4 3248.9 3301.2 37865.6 38656.6 38666.8 38726.2 39746.6 9015.7 9031.7 9087.0 9139.0 9328.3 15681.8 15707.3 15724.0 15728.0 15733.7 5926.8 5996.6 6014.2 6020.8 6039.3 3580.8 3595.6 3616.5 3634.5 3711.4 2546.3 2584.8 2589.9 2592.5 2594.0 479.8 482.7 486.7 493.1 502.2 466.9 519.7 545.5 580.8 606.0 7578.0 7658.4 7712.2 7834.6 8062.3 409.7 418.0 424.6 453.4 564.9 3614.5 3695.4 3744.8 3806.9 3835.5 50680.5 53597.2 54158.7 54317.5 54374.5 42905.0 43381.1 43954.3 44166.6 44395.6 40090.6 40936.0 41420.6 41477.8 41535.4 7376.2 7531.4 7565.8 7636.2 7672.5 30947.4 31364.4 32261.0 33190.3 33660.7 39538.6 39980.8 40316.8 40694.4 41005.2 9088.5 9162.4 9334.6 9799.8 9844.5 10868.1 10947.3 10947.8 10965.0 11083.7 9638.8 10390.3 10417.7 10803.5 11083.9 9616.8 9630.8 9648.2 9828.7 9874.9 9882.0 9974.0 10018.2 10063.7 10235.1 8435.9 8591.2 8755.2 8804.3 8906.6 8511.5 8620.7 8794.3 9104.9 9407.8 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:19:11 INFO - 2015-11-25 21:19:11,135 DEBUG : BROWSER_OUTPUT: 21:19:11 INFO - 2015-11-25 21:19:11,865 INFO : Browser exited with error code: 0 21:19:11 INFO - 2015-11-25 21:19:11,881 INFO : Completed test dromaeo_css (00:18:36) 21:19:11 INFO - 2015-11-25 21:19:11,882 INFO : Starting test kraken 21:19:11 INFO - 2015-11-25 21:19:11,882 DEBUG : operating with platform_type : linux_ 21:19:11 INFO - 2015-11-25 21:19:11,882 INFO : Initialising browser for kraken test... 21:19:11 INFO - 2015-11-25 21:19:11,888 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhz3Jv/profile http://localhost:59866/getInfo.html 21:19:15 INFO - 2015-11-25 21:19:15,679 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:19:15 INFO - 2015-11-25 21:19:15,680 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:19:15 INFO - 2015-11-25 21:19:15,680 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:19:15 INFO - 2015-11-25 21:19:15,680 DEBUG : BROWSER_OUTPUT: __metrics 21:19:15 INFO - 2015-11-25 21:19:15,837 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] 21:19:17 INFO - 2015-11-25 21:19:17,006 INFO : Browser initialized. 21:19:17 INFO - 2015-11-25 21:19:17,007 INFO : Running cycle 1/1 for kraken test... 21:19:17 INFO - 2015-11-25 21:19:17,007 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhz3Jv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:19:28 INFO - 2015-11-25 21:19:28,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 21:19:28 INFO - 2015-11-25 21:19:28,837 DEBUG : BROWSER_OUTPUT: 21:19:31 INFO - 2015-11-25 21:19:31,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59866/tests/kraken/driver.html?testName=audio-beat-detection) 21:19:32 INFO - 2015-11-25 21:19:32,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 178683904 21:19:32 INFO - 2015-11-25 21:19:32,008 DEBUG : BROWSER_OUTPUT: 21:19:34 INFO - 2015-11-25 21:19:34,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59866/tests/kraken/driver.html?testName=audio-dft) 21:19:35 INFO - 2015-11-25 21:19:35,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 167157760 21:19:35 INFO - 2015-11-25 21:19:35,292 DEBUG : BROWSER_OUTPUT: 21:19:38 INFO - 2015-11-25 21:19:38,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59866/tests/kraken/driver.html?testName=audio-fft) 21:19:38 INFO - 2015-11-25 21:19:38,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 150319104 21:19:38 INFO - 2015-11-25 21:19:38,858 DEBUG : BROWSER_OUTPUT: 21:19:40 INFO - 2015-11-25 21:19:40,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59866/tests/kraken/driver.html?testName=audio-oscillator) 21:19:41 INFO - 2015-11-25 21:19:41,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 153133056 21:19:41 INFO - 2015-11-25 21:19:41,484 DEBUG : BROWSER_OUTPUT: 21:19:43 INFO - 2015-11-25 21:19:43,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:19:44 INFO - 2015-11-25 21:19:44,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 154640384 21:19:44 INFO - 2015-11-25 21:19:44,295 DEBUG : BROWSER_OUTPUT: 21:19:47 INFO - 2015-11-25 21:19:47,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59866/tests/kraken/driver.html?testName=imaging-darkroom) 21:19:47 INFO - 2015-11-25 21:19:47,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 155340800 21:19:47 INFO - 2015-11-25 21:19:47,836 DEBUG : BROWSER_OUTPUT: 21:19:51 INFO - 2015-11-25 21:19:51,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59866/tests/kraken/driver.html?testName=imaging-desaturate) 21:19:51 INFO - 2015-11-25 21:19:51,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 157261824 21:19:51 INFO - 2015-11-25 21:19:51,831 DEBUG : BROWSER_OUTPUT: 21:19:54 INFO - 2015-11-25 21:19:54,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59866/tests/kraken/driver.html?testName=json-parse-financial) 21:19:55 INFO - 2015-11-25 21:19:55,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 155561984 21:19:55 INFO - 2015-11-25 21:19:55,217 DEBUG : BROWSER_OUTPUT: 21:19:56 INFO - 2015-11-25 21:19:56,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:19:57 INFO - 2015-11-25 21:19:57,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 164982784 21:19:57 INFO - 2015-11-25 21:19:57,517 DEBUG : BROWSER_OUTPUT: 21:19:59 INFO - 2015-11-25 21:19:59,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:20:00 INFO - 2015-11-25 21:20:00,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 163999744 21:20:00 INFO - 2015-11-25 21:20:00,019 DEBUG : BROWSER_OUTPUT: 21:20:02 INFO - 2015-11-25 21:20:02,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:20:02 INFO - 2015-11-25 21:20:02,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 173252608 21:20:02 INFO - 2015-11-25 21:20:02,753 DEBUG : BROWSER_OUTPUT: 21:20:05 INFO - 2015-11-25 21:20:05,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:20:05 INFO - 2015-11-25 21:20:05,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 179118080 21:20:05 INFO - 2015-11-25 21:20:05,899 DEBUG : BROWSER_OUTPUT: 21:20:08 INFO - 2015-11-25 21:20:08,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:20:09 INFO - 2015-11-25 21:20:09,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 178204672 21:20:09 INFO - 2015-11-25 21:20:09,087 DEBUG : BROWSER_OUTPUT: 21:20:10 INFO - 2015-11-25 21:20:10,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59866/tests/kraken/driver.html?testName=ai-astar) 21:20:11 INFO - 2015-11-25 21:20:11,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 237756416 21:20:11 INFO - 2015-11-25 21:20:11,086 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,090 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:20:11 INFO - 2015-11-25 21:20:11,090 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:20:11 INFO - 2015-11-25 21:20:11,090 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:20:11 INFO - 2015-11-25 21:20:11,090 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:20:11 INFO - 2015-11-25 21:20:11,090 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;115;107;111;113;112;102;111;112;106 21:20:11 INFO - 2015-11-25 21:20:11,091 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;157;173;131;164;153;136;166;134 21:20:11 INFO - 2015-11-25 21:20:11,091 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;161;161;161;163;162;163;163;161 21:20:11 INFO - 2015-11-25 21:20:11,091 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;91;72;71;72;99;96;72 21:20:11 INFO - 2015-11-25 21:20:11,091 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;126;94;95;94;139;94;95;126 21:20:11 INFO - 2015-11-25 21:20:11,091 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;111;110;109;110 21:20:11 INFO - 2015-11-25 21:20:11,092 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;147;147;146;147;147;147;146;147 21:20:11 INFO - 2015-11-25 21:20:11,092 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;96;95;96;95 21:20:11 INFO - 2015-11-25 21:20:11,092 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;70;71;70;71;78;68;68 21:20:11 INFO - 2015-11-25 21:20:11,092 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;69;70;68;69;69;69 21:20:11 INFO - 2015-11-25 21:20:11,092 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;92;84;87;85;85;83;84;86;84 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;128;120;120;128;123;121;133;127;128 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;138;145;149;157;136;146;145;148;134 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;68;69;68;68;70;68;68;68 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:20:11 INFO - 2015-11-25 21:20:11,093 DEBUG : BROWSER_OUTPUT: __startTimestamp1448515211087__endTimestamp 21:20:11 INFO - 2015-11-25 21:20:11,094 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.08 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: Values: 113.0 115.0 107.0 111.0 113.0 112.0 102.0 111.0 112.0 106.0 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,095 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.50 stddev:15.94 (10.2%) stddev-sans-first:16.76 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 157.0 173.0 131.0 164.0 153.0 136.0 166.0 134.0 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 161.0 161.0 161.0 163.0 162.0 163.0 163.0 161.0 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:78.00 stddev:11.33 (14.5%) stddev-sans-first:11.63 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 91.0 72.0 71.0 72.0 99.0 96.0 72.0 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,096 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:94.50 stddev:17.58 (18.6%) stddev-sans-first:18.31 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 126.0 94.0 95.0 94.0 139.0 94.0 95.0 126.0 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.50 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,097 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:2.79 (4.0%) stddev-sans-first:2.96 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 70.0 71.0 70.0 71.0 78.0 68.0 68.0 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,098 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 69.0 70.0 68.0 69.0 69.0 69.0 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:3.07 (3.6%) stddev-sans-first:2.70 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 84.0 87.0 85.0 85.0 83.0 84.0 86.0 84.0 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:128.00 stddev:4.91 (3.8%) stddev-sans-first:4.53 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: Values: 133.0 128.0 120.0 120.0 128.0 123.0 121.0 133.0 127.0 128.0 21:20:11 INFO - 2015-11-25 21:20:11,099 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:145.50 stddev:6.99 (4.8%) stddev-sans-first:7.21 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: Values: 139.0 138.0 145.0 149.0 157.0 136.0 146.0 145.0 148.0 134.0 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 69.0 68.0 68.0 70.0 68.0 68.0 68.0 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:20:11 INFO - 2015-11-25 21:20:11,100 DEBUG : BROWSER_OUTPUT: 21:20:12 INFO - 2015-11-25 21:20:12,021 INFO : Browser exited with error code: 0 21:20:12 INFO - 2015-11-25 21:20:12,077 INFO : Completed test kraken (00:01:00) 21:20:12 INFO - 2015-11-25 21:20:12,078 INFO : Starting test v8_7 21:20:12 INFO - 2015-11-25 21:20:12,078 DEBUG : operating with platform_type : linux_ 21:20:12 INFO - 2015-11-25 21:20:12,078 INFO : Initialising browser for v8_7 test... 21:20:12 INFO - 2015-11-25 21:20:12,084 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgGB4bM/profile http://localhost:59866/getInfo.html 21:20:16 INFO - 2015-11-25 21:20:16,037 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:20:16 INFO - 2015-11-25 21:20:16,037 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:20:16 INFO - 2015-11-25 21:20:16,037 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:20:16 INFO - 2015-11-25 21:20:16,037 DEBUG : BROWSER_OUTPUT: __metrics 21:20:16 INFO - 2015-11-25 21:20:16,138 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] 21:20:17 INFO - 2015-11-25 21:20:17,453 INFO : Browser initialized. 21:20:17 INFO - 2015-11-25 21:20:17,454 INFO : Running cycle 1/1 for v8_7 test... 21:20:17 INFO - 2015-11-25 21:20:17,454 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgGB4bM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:20:29 INFO - 2015-11-25 21:20:29,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 140955648 21:20:29 INFO - 2015-11-25 21:20:29,312 DEBUG : BROWSER_OUTPUT: 21:20:50 INFO - 2015-11-25 21:20:50,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59866/tests/v8_7/run.html (next: http://localhost:59866/tests/v8_7/run.html) 21:20:51 INFO - 2015-11-25 21:20:51,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 465768448 21:20:51 INFO - 2015-11-25 21:20:51,023 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,023 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:20:51 INFO - 2015-11-25 21:20:51,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:20:51 INFO - 2015-11-25 21:20:51,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |0;Richards;164.31153466973382 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.16206297083252 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.6455624646693 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 21:20:51 INFO - 2015-11-25 21:20:51,024 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 21:20:51 INFO - 2015-11-25 21:20:51,025 DEBUG : BROWSER_OUTPUT: |5;Earley;805.1529790660226 21:20:51 INFO - 2015-11-25 21:20:51,025 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 21:20:51 INFO - 2015-11-25 21:20:51,025 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 21:20:51 INFO - 2015-11-25 21:20:51,025 DEBUG : BROWSER_OUTPUT: |8;Splay;651.4657980456026 21:20:51 INFO - 2015-11-25 21:20:51,025 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: __startTimestamp1448515251021__endTimestamp 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:20:51 INFO - 2015-11-25 21:20:51,026 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.31 Median:164.31 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: Values: 164.3 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.16 Median:193.16 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: Values: 193.2 21:20:51 INFO - 2015-11-25 21:20:51,027 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,028 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.65 Median:282.65 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,028 DEBUG : BROWSER_OUTPUT: Values: 282.6 21:20:51 INFO - 2015-11-25 21:20:51,028 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,028 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,028 DEBUG : BROWSER_OUTPUT: Values: 5117.3 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: Values: 1990.1 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:805.15 Median:805.15 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: Values: 805.2 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,029 DEBUG : BROWSER_OUTPUT: Values: 12317.1 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: Values: 26894.7 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.47 Median:651.47 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: Values: 651.5 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 21:20:51 INFO - 2015-11-25 21:20:51,030 DEBUG : BROWSER_OUTPUT: Values: 4845.4 21:20:51 INFO - 2015-11-25 21:20:51,031 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:20:51 INFO - 2015-11-25 21:20:51,031 DEBUG : BROWSER_OUTPUT: 21:20:51 INFO - 2015-11-25 21:20:51,890 INFO : Browser exited with error code: 0 21:20:51 INFO - 2015-11-25 21:20:51,907 INFO : Completed test v8_7 (00:00:39) 21:20:51 INFO - 2015-11-25 21:20:51,990 INFO : Completed test suite (00:20:16) 21:20:51 INFO - 2015-11-25 21:20:51,990 DEBUG : Working with test: dromaeo_css 21:20:51 INFO - 2015-11-25 21:20:51,990 DEBUG : Generating results file: dromaeo_css 21:20:51 INFO - 2015-11-25 21:20:51,991 DEBUG : Working with test: kraken 21:20:51 INFO - 2015-11-25 21:20:51,991 DEBUG : Generating results file: kraken 21:20:51 INFO - 2015-11-25 21:20:51,991 INFO : javascript benchmark 21:20:51 INFO - 2015-11-25 21:20:51,992 DEBUG : Working with test: v8_7 21:20:51 INFO - 2015-11-25 21:20:51,992 DEBUG : Generating results file: v8_7 21:20:51 INFO - 2015-11-25 21:20:51,992 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:20:52 INFO - 2015-11-25 21:20:52,050 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 21:20:52 INFO - 2015-11-25 21:20:52,050 DEBUG : process_Request line: dromaeo_css 6049.34 graph.html#tests=[[72,132,35]] 21:20:52 INFO - 2015-11-25 21:20:52,050 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:20:52 INFO - 2015-11-25 21:20:52,081 DEBUG : process_Request line: kraken 1524.00 graph.html#tests=[[232,132,35]] 21:20:52 INFO - 2015-11-25 21:20:52,081 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:20:52 INFO - 2015-11-25 21:20:52,114 DEBUG : process_Request line: v8_7 19535.66 graph.html#tests=[[230,132,35]] 21:20:52 INFO - 2015-11-25 21:20:52,116 INFO : javascript benchmark 21:20:52 INFO - 2015-11-25 21:20:52,119 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.343664083979, 2700.7704345130664, 2715.524783162946, 2725.427660191359, 2729.1266794625717, 4489.787757305526, 4647.512011238822, 4650.813967441299, 4662.137504561659, 4666.813327466902, 4524.932126018112, 4585.358049873021, 4642.466116396616, 4661.58045775881, 4684.0, 4265.658747300216, 4303.720258183208, 4320.135972805451, 4320.611144996949, 4340.08858139791, 4111.958880411203, 4377.1683380157665, 4393.362962370455, 4421.911561768763, 4423.0711550574415, 4158.6673066154635, 4223.493180818306, 4242.406063151161, 4267.466566679165, 4285.8499952501825, 4282.486101667789, 4302.397664326997, 4323.82704691812, 4325.351197320396, 4346.369776382438, 4103.774292413916, 4259.10558782656, 4282.657387409, 4295.871123866289, 4304.634106100985, 4436.290193569013, 4463.152001119777, 4476.664250181249, 4515.593596576324, 4553.544645535453, 4976.502349765031, 5024.924626130611, 5039.949600503985, 5041.269015992697, 5093.465186155438, 4750.026244619845, 5049.722265275408, 5051.823186188502, 5065.138926382487, 5065.290859279667, 4574.428196475441, 4576.702514336557, 4601.240795268776, 4622.306654001926, 4681.0, 5041.168207245763, 5052.671576347526, 5055.772490237948, 5058.822941197041, 5099.56653684441, 4661.743604101739, 4857.878553036202, 4859.757012149378, 4867.148249056472, 4901.926471102936, 4886.3403440535785, 4894.681845680019, 4896.95103048972, 4899.1426500362295, 4943.0, 4818.638602104857, 4861.465238823726, 4862.756862156878, 4887.511248875084, 4898.975505122523, 4793.0, 4803.663743537989, 4830.516948305211, 4839.564439200489, 4896.828610998669, 3982.143839074613, 4051.756894586334, 4075.3886916962692, 4091.7954102294766, 4137.441445404892, 3577.1951310955346, 3621.5292012038794, 3643.981780091083, 3663.0476076220375, 3675.9081022974106, 4300.7634580097765, 4306.095719898856, 4322.913541729148, 4341.45731783527, 4353.238183317907, 4783.5933945614315, 4895.045466134141, 4898.951010489921, 4996.025774973918, 5009.474005229471, 4218.810153543098, 4231.7672528010635, 4242.384854196124, 4281.100968796525, 4299.376590394375, 4437.06821567468, 4442.111577684476, 4442.4669039715445, 4454.844080457168, 4473.6868419211, 4746.430428348551, 4756.6908150970075, 4760.071786001697, 4767.523247675204, 4801.447833499123, 4715.198416269174, 4840.104580652591, 4842.15262329084, 4846.006568653347, 4989.501049895127, 4591.540845915515, 4657.953420465752, 4681.040386720646, 4716.151092803191, 4729.479757226771, 4902.9019419610695, 4916.06594746997, 4953.157963146202, 4958.504149585013, 4998.275250088789, 4801.9039619208115, 5026.5727413168825, 5036.974815125901, 5037.798488060436, 5089.720065396439, 4701.600363969101, 4755.500672429345, 4772.570468657837, 4774.618030557616, 4820.276958456259, 4786.138495070921, 4788.664793464563, 4789.353437285922, 4799.328094066903, 4814.20565606671, 4525.524819893995, 4706.647001474971, 4715.080559291043, 4719.882002949954, 4756.215224487921, 4733.5266473352385, 4784.282357646381, 4788.233882578771, 4821.325014498043, 4830.6135509159885, 4767.356406885165, 4778.354922085474, 4784.545468180518, 4788.329633851194, 4832.613390928647], "unit": "ms", "name": "dojo.html", "value": 4539.8059981329725}, {"lowerIsBetter": false, "replicates": [479.41032529988115, 493.6766417996214, 555.0720433226961, 581.834177259481, 591.1576004194023, 21808.454788630293, 36015.63984360159, 36082.8195859021, 36084.81957590212, 36145.27709445809, 39589.8020509897, 40108.0, 40189.39715904264, 40244.0, 40272.59727402725, 6633.568818026813, 6752.291009444011, 7908.3673306135515, 8079.272865442109, 8079.717209897654, 10255.128314093312, 10520.736981575445, 10522.42126683032, 10530.631427900025, 10536.631217907374, 10122.392656440637, 10225.846612300822, 10249.282550221487, 10251.487425628726, 10253.077223049924, 6663.167104111986, 6815.863682726318, 6823.215330236987, 6831.2144103428245, 9938.0, 6676.065350850885, 6816.693248803816, 10067.848982265272, 10472.0, 10513.842292365543, 37057.444138337945, 37420.0, 37538.249235015144, 37572.81213593942, 37585.81207093947, 2646.695630002555, 2750.642416485864, 2759.1722483254944, 3261.184703824044, 3486.4421692529327, 27900.581491277648, 28144.0, 28162.71837281642, 28329.0, 28459.715402845915, 3357.142502100075, 3487.232808782064, 3492.266624008961, 3558.3594952908466, 3581.6418358164237, 225108.0, 226426.0, 226568.0, 226708.86645566832, 227483.0, 56483.43516564782, 56986.0, 57072.14391784126, 57083.0, 57084.42915570874, 36329.81835090861, 36342.818285908405, 58147.41852581505, 59203.407965920655, 59236.0, 12186.878131218751, 12259.448324825404, 12354.876451235552, 12372.566960156531, 12375.75248495025, 9933.0, 9977.80044399108, 9984.850227246598, 9986.101250887456, 9988.0, 17981.460556183334, 18043.909780451013, 18132.63734725298, 18692.158852851655, 18752.24991000372, 6760.763373281911, 6986.790396288018, 7016.754413595601, 7069.752558660422, 7110.857782844314, 828.7928017995501, 860.8149247911604, 888.3426264564176, 896.7085697148453, 936.3398803843274, 25558.872205638854, 25864.094756683426, 25924.74075259223, 26039.349016274744, 26122.346941326618, 923.2890674180977, 926.4117285523741, 927.79124696944, 951.5622813505727, 1036.4713995862164, 13671.863281367258, 13743.244121573209, 13880.93059534696, 14408.855911440962, 14595.92702036483, 204509.0, 208471.0, 209556.0, 210170.0, 210828.0, 40690.79654601708, 40767.0, 40840.59159408368, 40902.772916812544, 40913.181736365106, 1179.0744265751343, 1184.3130984029242, 1191.1007189571817, 1194.1282863509687, 1201.7055821323656, 15256.283613214919, 23637.881810590836, 25975.480490390466, 26479.60280595831, 27068.32329191786, 36816.63183368132, 37212.44181337228, 37251.25497490089, 37260.0, 37264.78293038922, 220983.0, 223667.0, 223875.0, 224350.0, 224635.0, 19760.703589446457, 20068.297609583595, 26550.203493895213, 28320.575191371732, 28422.14733557914, 31305.68694313119, 31415.52876706897, 31585.8420707895, 31899.202519937186, 31923.0, 28996.565051523823, 29426.852865735535, 31828.0, 32884.83557582197, 33300.0, 29725.108246752632, 29969.400611988076, 30001.549976750804, 30048.0, 30168.84915575408, 29502.409951801274, 31809.204769880937, 32121.196970075936, 32208.516872246466, 32318.83840580782, 25597.47264447554, 27482.862585686944, 27509.86245068842, 27528.449431011668, 27541.31146721348, 21157.576848463254, 21195.0, 21924.23265185711, 22684.618115097677, 22847.428814279778], "unit": "ms", "name": "ext.html", "value": 16211.081493398737}, {"lowerIsBetter": false, "replicates": [319.186075507456, 323.57288379339275, 329.56661989483814, 332.08841729452655, 337.9239671074007, 11234.382108984002, 11528.135389845775, 14975.775363369545, 15423.537293881187, 15730.842691573094, 13368.131071480348, 13613.795793063113, 13728.588142355746, 14077.0, 14096.506622268224, 4344.565543445646, 4912.828051018215, 5044.848654540351, 5066.240063990394, 5067.49325067494, 3510.912227194328, 3549.432090865462, 4985.152524070899, 5602.523785478239, 5801.593888427812, 5840.737166827503, 5853.0, 5867.442592953684, 5870.354261031283, 5894.351621321673, 5690.317161940552, 5902.2327097477055, 5903.0, 5904.645721256738, 5909.7340619672, 5160.535551800356, 5170.069387510247, 5170.767315470813, 5171.741412929376, 5171.7672704728, 19029.429117126507, 19079.904600477046, 19319.613607727766, 19365.612687746307, 19403.126859291366, 1808.7558179645712, 1819.3177558415593, 1954.9120289587004, 1964.4695932098252, 2008.708737233093, 11566.53733850645, 11856.525738970431, 11871.050315974788, 11883.405829708567, 12054.0, 1767.7701898753207, 1770.2122555462824, 1773.4502304285713, 1780.287884846059, 1784.3041213926579, 54222.72888635571, 54439.0, 55282.447175528134, 55445.72277138629, 56785.43214567843, 9028.774280643036, 9153.267738580898, 9295.11696388842, 9296.140771845523, 9369.531523423939, 11708.88291117095, 11727.472263748152, 11733.647990560297, 11734.0, 11738.0, 6218.347073557302, 6222.12890195373, 6389.840253993687, 6409.455196308366, 6423.325550817191, 6031.758729650853, 6040.577159598786, 6084.5132389408745, 6091.14723938649, 6091.878162436727, 5350.705711185922, 5356.892862142735, 5360.597955153379, 5390.8921821563345, 5396.9730151348995, 1396.9301534923213, 1430.342042660367, 1622.5700189449806, 1625.2036502114115, 1676.513810994798, 377.58277103799907, 379.2774764074443, 422.9788510574459, 826.7850358906608, 851.0340763233775, 8554.230119289294, 9120.17918387335, 9683.128518433234, 9881.703548893545, 9886.357386769982, 407.84094203260753, 409.92826255405186, 425.61907093152075, 426.54359834976276, 446.4464064559987, 5463.83608491738, 5468.808591699271, 5671.035923892948, 5732.369439361667, 5789.594728369058, 462794.0, 470334.0, 475953.0, 488225.0, 488412.0, 67545.66227168833, 68701.31298687049, 69717.65141174261, 70565.2943470569, 70958.22604434827, 454.31398588132157, 459.5725974843428, 460.13953906195627, 460.62919349923635, 461.3702296365437, 9764.316497845082, 9837.754056148653, 9871.703848884545, 10030.849537256801, 10036.347637403545, 31550.0, 32164.0, 32594.0, 32812.0, 32848.0, 38870.0, 39208.215835683695, 39315.60684393119, 39544.0, 41024.0, 8892.688755893512, 8994.505302208441, 9214.124658157465, 9333.626654933727, 9341.532923353669, 16237.756433653269, 16325.83674163243, 16355.836441635907, 16482.093484858447, 16760.66478670444, 12297.815532766837, 12343.19769214998, 12899.161554498927, 13459.528916487876, 13629.795553066513, 11291.209615326849, 11374.772504549697, 11708.531658733897, 12915.935420322838, 13014.479420823061, 8862.86705699402, 9134.771630709285, 9166.0, 9241.21449676785, 9349.813003740022, 13400.463981440633, 13543.729125417634, 13651.04442689042, 14081.859181408465, 14089.365978531196, 11785.88214117848, 11802.586909458129, 12549.87450125487, 13782.862171378158, 14333.0], "unit": "ms", "name": "jquery.html", "value": 7524.246287988767}, {"lowerIsBetter": false, "replicates": [878.8330217258716, 1580.8735301175907, 1625.057466669332, 1649.0765171503958, 1652.917354132293, 5537.003339398907, 6789.25318214996, 6999.755008574701, 7005.299470052993, 7017.122859642544, 6621.370969757865, 6782.8304292392595, 6790.966045169767, 6799.048133261347, 6800.285969973143, 1954.6090781843582, 1984.9007549622534, 1986.2055177928871, 1986.6026794641057, 1988.4730546405215, 2047.9795202048012, 2076.49125964139, 2082.2191678120703, 2106.7471903371616, 2110.2192188890053, 1965.5380985468403, 1978.9901050494727, 1998.830099441542, 1999.7100420439028, 2000.8599398042143, 2037.4193354893857, 2074.678424844152, 2074.7614024387085, 2076.2733043434678, 2077.1172251793005, 2027.168860767093, 2056.5475595368994, 2094.057674046685, 2096.2872623307994, 2096.6540520814046, 5343.625946183769, 5486.807961721321, 6829.692663830139, 6890.827729306758, 6899.379055884944, 3307.2724000719804, 3900.1419687668667, 3931.3906344516645, 3938.6652134568594, 3943.0339566806315, 2702.3649442381025, 2746.382064035596, 2759.1722483254944, 2778.5554311310298, 2858.0, 878.775912142406, 887.6138879587401, 896.381496767235, 911.4759013567225, 913.0458670689146, 9043.050479699668, 9117.179453849185, 9126.908730912739, 9138.223251023672, 9162.083791620851, 3903.375459926398, 3935.0555866591812, 3964.6718349352714, 3968.1071758854027, 3985.5217373915316, 7981.880271795928, 7995.120536740954, 8002.83994320122, 8007.399445041645, 8008.39937004727, 4067.8779636610357, 4086.7752273625238, 4087.693422993287, 4088.9386659200136, 4089.0595163112653, 3753.3994560870674, 3756.7558108722847, 3757.830897609614, 3759.285735710206, 3762.0406796267325, 3067.6778938211614, 3073.3699591583672, 3091.829949352762, 3126.515390114536, 3136.686331366845, 1018.7402212435929, 1019.3781793106199, 1023.2785885950387, 1026.4508487959056, 1026.4867566216892, 910.5674804467825, 919.5586118662945, 931.6971984105193, 931.9720408387759, 934.2525979216599, 6294.716737746812, 6317.4946004319545, 6360.363963603602, 6369.490440764727, 6383.840403989844, 440.3087153169557, 446.88157638225897, 447.73583585684605, 450.0346756207916, 454.3344001038495, 4306.095719898856, 4980.0, 5039.017391608601, 5041.344625198701, 5044.1929291313945, 6984.371406573433, 7047.119110111236, 7072.3634872861685, 7150.7497237596435, 7300.525465844703, 7968.920310796933, 8073.192680731997, 8183.468074575134, 8198.426110172231, 8202.343812494986, 6148.846278842975, 6184.381561843779, 6190.938090619126, 6211.16149319836, 6228.159198508234, 6378.936210637834, 6383.616982981036, 6389.808305750835, 6396.168498095218, 6399.0, 7188.640567971685, 7457.291557302047, 7470.813229669085, 7497.062867141607, 7505.0, 7412.851742965003, 7646.120696120018, 7660.2722741339485, 7662.73180438682, 7675.309222170032, 5588.329400471969, 5690.971545142248, 5724.284464441945, 5735.139729040678, 5738.708790522099, 6385.68071596409, 6445.4199122079235, 6455.289918109098, 6461.935380646133, 6463.224413070274, 6112.113743507078, 6139.29398119222, 6190.907136393048, 6242.2509298882605, 6271.122042914087, 5887.1757953887345, 5921.851953701192, 5939.91090133657, 5972.940270597239, 6088.543359248163, 5880.382559831156, 5989.610675306091, 5994.220751302303, 6005.0, 6009.87980240384, 5760.0783874579865, 5799.449052340021, 5807.970960145172, 5819.563532734977, 5826.446487583673, 5791.305043394819, 5800.245968024298, 5813.82558523245, 5820.126980952721, 5876.3536011037895], "unit": "ms", "name": "mootools.html", "value": 3818.817035810376}, {"lowerIsBetter": false, "replicates": [285.23556867594846, 294.8231061363182, 296.81004157339294, 308.2863171757383, 310.86632747918384, 5379.246905433238, 5397.649152805065, 5422.240886275925, 5438.293021907147, 5439.836804895859, 5124.564412024973, 5219.556337711299, 5233.293505376773, 5241.816536421226, 5343.625946183769, 4023.1752490739473, 4026.1142548639255, 4033.2336855997414, 4103.8563650272245, 4125.2780763366445, 4140.192662430827, 4143.544210136883, 4150.501939767232, 4161.854335098272, 4164.292070348033, 3891.182851601153, 4113.56807535209, 4127.752334859903, 4132.090939993212, 4136.420901073852, 4016.5380981187245, 4036.899077523056, 4131.049858532554, 4139.234241665302, 4161.729487583328, 3649.0, 3649.59854416014, 3651.014226158949, 3657.2685462907257, 3657.963420365789, 5114.539691427789, 5140.691558506502, 5148.433672296044, 5153.66501177426, 5158.7678554464765, 4726.76366181693, 4729.148753224418, 4730.290456431529, 4731.290306454025, 4731.384919960417, 5457.781688732446, 5585.5531557475715, 5587.413321601254, 5591.329040515124, 5595.132754423071, 3940.5271367435803, 3940.763554186758, 3954.703397245218, 3956.307646161939, 3964.920701585952, 5870.823875283749, 5872.647641141502, 5873.588848780587, 5878.647281163144, 5889.204957330749, 4067.186562687474, 4073.490813648294, 4074.7555146691293, 4077.429159917614, 4078.6940979426663, 4039.414284928669, 4137.565555616678, 4140.047789008545, 4143.97928010364, 4156.646685031807, 4701.694389864648, 4705.200115980291, 4709.481956984729, 4710.481846996828, 4712.340272361872, 5520.337559492807, 5574.303212098488, 5578.30271216098, 5580.581456390706, 5582.8325150245555, 1430.9141451512942, 1468.214505239713, 1470.147314557554, 1470.624990627383, 1471.2055490035261, 1000.9449480278508, 1005.5776573838859, 1006.6929586476049, 1013.0274936061317, 1032.0505135275564, 4871.926921096187, 4881.096997055556, 4881.292212629149, 4884.096442158212, 4888.706677599284, 5728.541716662657, 5732.226149469769, 5735.1684005818925, 5737.426257374313, 5742.368339482737, 4874.049560335771, 4879.341288926021, 4882.7558622068755, 4883.194272944996, 4883.487233840467, 2911.4177164567172, 3011.5031019881476, 3051.5727798108283, 3087.459694553444, 3111.0200286909553, 5449.3188351456065, 5539.9169012464845, 5555.083411237181, 5555.749991250404, 5559.221708960748, 6002.759889604455, 6005.519558435315, 6007.068904319837, 6021.6989150542295, 6028.487578555872, 5552.167174923794, 5552.91670624941, 5561.221428999943, 5561.416051314634, 5569.805056822992, 5723.828285151452, 5872.265966754156, 5879.911801322898, 5880.852978675567, 5888.558358123072, 5687.971560142173, 5716.456936591017, 5718.142278658234, 5722.4277572242445, 5731.455511726379, 5543.52880005204, 5547.306586676666, 5554.222408862844, 5554.805581804618, 5555.50000499957, 3823.4073718573663, 3998.3402738548975, 4031.09300407406, 4035.4955630546183, 4035.8497828118843, 5798.217240672455, 5829.067349224104, 5829.679367634821, 5830.679312637845, 5842.853928651818, 5535.5848311376, 5573.888522229451, 5574.358948720949, 5576.86057848557, 5636.718164091697, 5622.156676498558, 5622.606417550732, 5628.915566266427, 5630.380658127685, 5634.070378387521, 5327.840164794908, 5498.422665620053, 5499.175123731472, 5503.559715222853, 5508.338999320107, 5638.464345887134, 5641.633293835887, 5641.689707066151, 5644.0, 5645.040343141593, 5337.6797392156595, 5478.671279723229, 5479.315085614298, 5482.80810171642, 5488.1493368527945], "unit": "ms", "name": "prototype.html", "value": 4215.756731131553}, {"lowerIsBetter": false, "replicates": [688.5077169823575, 733.6148522025939, 752.2214507984237, 773.7175930785263, 809.0655293136427, 10901.29141605796, 10974.341539507635, 11020.173486988468, 11031.117510599153, 11061.170412219086, 8244.58777061146, 11509.366984815832, 11594.826077608843, 11630.0, 11635.941820290887, 283.868001379358, 757.5795433534386, 770.9190534993829, 771.4329967473931, 772.4013889235831, 767.5394763142126, 778.7585848387018, 779.5517577392993, 780.3055280800093, 781.3592853859838, 346.7416774502999, 355.6727810414425, 792.3067316098413, 806.4234072638062, 814.2020819596798, 801.4950581133877, 806.4838503357855, 807.2049031703767, 810.4691427115249, 810.5703976892256, 594.7739858853608, 599.730121445347, 600.7626987339976, 600.9639421634716, 601.1253625974241, 11052.889471105267, 11100.888991110067, 11102.55589776408, 11145.944270278596, 11150.0, 10670.466476676134, 10727.517261723242, 10829.404382758945, 11154.386508742016, 11608.245464044894, 8965.820683586291, 9048.728538143867, 9168.404053736485, 9255.67605133817, 9320.580573874191, 3198.0565733108556, 3206.8396580170897, 3239.3683231769814, 3248.902532924016, 3301.2077101495706, 37865.621343786486, 38656.61343386558, 38666.806665966775, 38726.22547549062, 39746.60253397487, 9015.684451044313, 9031.683891063913, 9087.0, 9138.954305228564, 9328.253739700807, 15681.764773528406, 15707.293171807296, 15724.0, 15728.0, 15733.68532629341, 5926.822195334147, 5996.610220335664, 6014.18808460861, 6020.759169633166, 6039.275286965592, 3580.7851528907827, 3595.5505561804775, 3616.4936908832783, 3634.491171236029, 3711.387621042498, 2546.2870396289068, 2584.831985920909, 2589.8705064746687, 2592.4815036992677, 2594.0, 479.84405068352225, 482.72967138402606, 486.69824708680846, 493.1419330365139, 502.20400664945737, 466.94863565007824, 519.7479222577047, 545.5172172627254, 580.825752274316, 606.0152252589542, 7578.0, 7658.387329013665, 7712.15166331703, 7834.647440865175, 8062.314703250289, 409.7193422505593, 418.0426822576327, 424.6496640271788, 453.360761326528, 564.9293838270216, 3614.493970844084, 3695.371786796251, 3744.8127593620757, 3806.8667596633986, 3835.463035175078, 50680.49319506832, 53597.248192626925, 54158.7292063545, 54317.45682543203, 54374.45625543773, 42905.0, 43381.132377352274, 43954.34068488975, 44166.558334416244, 44395.556044439785, 40090.599094008685, 40936.0, 41420.58579414227, 41477.792611036755, 41535.37696934548, 7376.151742549676, 7531.435142364235, 7565.810854728676, 7636.236376362319, 7672.462927595015, 30947.381052378376, 31364.37271254608, 32261.0, 33190.336193275514, 33660.66339336575, 39538.62768233915, 39980.800096000494, 40316.79841600773, 40694.389584155666, 41005.1798964025, 9088.54557272147, 9162.404443711137, 9334.579943902405, 9799.755006124904, 9844.458554779556, 10868.130549556176, 10947.34315941046, 10947.83578246343, 10965.0, 11083.66748997499, 9638.807223855623, 10390.324628899098, 10417.687469375931, 10803.513841876977, 11083.944580277048, 9616.807663846825, 9630.807383852423, 9648.179904708179, 9828.655997040356, 9874.901250987397, 9882.0, 9974.0, 10018.1985441166, 10063.748406289902, 10235.078842904175, 8435.915640843514, 8591.183837535424, 8755.168259015383, 8804.251638610789, 8906.643734250816, 8511.531865747444, 8620.741377758677, 8794.340424468062, 9104.908950910407, 9407.764805879633], "unit": "ms", "name": "yui.html", "value": 5496.469409978604}], "name": "dromaeo_css", "value": 6049.334635924525}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 107.0, 111.0, 113.0, 112.0, 102.0, 111.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 157.0, 173.0, 131.0, 164.0, 153.0, 136.0, 166.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 161.0, 161.0, 163.0, 162.0, 163.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 91.0, 72.0, 71.0, 72.0, 99.0, 96.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 126.0, 94.0, 95.0, 94.0, 139.0, 94.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 70.0, 71.0, 70.0, 71.0, 78.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 84.0, 87.0, 85.0, 85.0, 83.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [133.0, 128.0, 120.0, 120.0, 128.0, 123.0, 121.0, 133.0, 127.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 145.0, 149.0, 157.0, 136.0, 146.0, 145.0, 148.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1523.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.31153466973382], "unit": "score", "name": "Richards", "value": 214.84797200000008}, {"lowerIsBetter": false, "replicates": [193.16206297083252], "unit": "score", "name": "DeltaBlue", "value": 342.292886}, {"lowerIsBetter": false, "replicates": [282.6455624646693], "unit": "score", "name": "Encrypt", "value": 941.7483780000005}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [805.1529790660226], "unit": "score", "name": "Earley", "value": 827.747046}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [651.4657980456026], "unit": "score", "name": "Splay", "value": 125.08868499999998}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19535.659646520737}]} 21:20:52 INFO - RETURN: dromaeo_css: 6049.34 21:20:52 INFO - RETURN: kraken: 1524.00 21:20:52 INFO - RETURN: v8_7: 19535.66 21:20:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19535.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6049.34"}}} 21:20:52 INFO - Return code: 0 21:20:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:20:52 INFO - # TBPL SUCCESS # 21:20:52 INFO - Running post-action listener: _resource_record_post_action 21:20:52 INFO - Running post-run listener: _resource_record_post_run 21:20:53 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502538240; Read time: 8; Write time: 392480 21:20:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 169541632; Read time: 0; Write time: 146948 21:20:53 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 273498112; Read time: 0; Write time: 165176 21:20:53 INFO - Running post-run listener: _upload_blobber_files 21:20:53 INFO - Blob upload gear active. 21:20:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:20:53 INFO - Copying logs to upload dir... 21:20:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.629320 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-25 21:20:53.022255) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 21:20:53.025783) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009913 build_url: 'https://queue.taskcluster.net/v1/task/E-k5UXeeRxi5U1Tvh0cjoQ/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 21:20:53.077754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:20:53.078110) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448513904.819795-963425850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:20:53.128342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:20:53.128695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:20:53.128997) ========= ========= Total master_lag: 0.23 =========