builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1448513687.36 results: success (0) buildid: 20151125173020 builduid: 9de007e3ffd847dabac6890943cdea15 revision: 34c9087517ea31fc1a0204dd5635e7384a94ae3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.362996) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.363542) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.363846) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006447 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.36 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.732743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.733209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.749976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.750393) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.799052) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.799375) ========= 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:54:47.799727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.799994) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 20:54:48-- 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% 16.2M=0.001s 2015-11-25 20:54:48 (16.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.958193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:47.961627) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013458 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.010955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.014336) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34c9087517ea31fc1a0204dd5635e7384a94ae3a --destination scripts --debug' in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 20:54:48,483 truncating revision to first 12 chars 2015-11-25 20:54:48,483 Setting DEBUG logging. 2015-11-25 20:54:48,483 attempt 1/10 2015-11-25 20:54:48,483 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:54:48,748 unpacking tar archive at: fx-team-34c9087517ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.580957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.581278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.591598) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:48.591959) ========= 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:54:48.592399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-25 20:54:48.592699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (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', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:54:49 INFO - MultiFileLogger online at 20151125 20:54:49 in /builds/slave/test-pgo 20:54:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:54:49 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:54:49 INFO - {'append_to_log': False, 20:54:49 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:54:49 INFO - 'blob_upload_branch': 'Fx-Team', 20:54:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:54:49 INFO - 'branch': 'Fx-Team', 20:54:49 INFO - 'buildbot_json_path': 'buildprops.json', 20:54:49 INFO - 'config_files': ('talos/linux_config.py',), 20:54:49 INFO - 'default_actions': ('clobber', 20:54:49 INFO - 'read-buildbot-config', 20:54:49 INFO - 'download-and-extract', 20:54:49 INFO - 'populate-webroot', 20:54:49 INFO - 'create-virtualenv', 20:54:49 INFO - 'install', 20:54:49 INFO - 'run-tests'), 20:54:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:54:49 INFO - 'download_minidump_stackwalk': True, 20:54:49 INFO - 'download_symbols': 'ondemand', 20:54:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:54:49 INFO - 'tooltool.py': '/tools/tooltool.py', 20:54:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:54:49 INFO - '/tools/misc-python/virtualenv.py')}, 20:54:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:54:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:54:49 INFO - 'installer_path': 'installer.exe', 20:54:49 INFO - 'log_level': 'info', 20:54:49 INFO - 'log_name': 'talos', 20:54:49 INFO - 'log_to_console': True, 20:54:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:54:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:54:49 INFO - 'opt_config_files': (), 20:54:49 INFO - 'pip_index': False, 20:54:49 INFO - 'sps_profile': False, 20:54:49 INFO - 'sps_profile_interval': 0, 20:54:49 INFO - 'suite': 'dromaeojs', 20:54:49 INFO - 'system_bits': '64', 20:54:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:54:49 INFO - 'title': 'talos-linux64-ix-055', 20:54:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:54:49 INFO - 'use_talos_json': True, 20:54:49 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:54:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:54:49 INFO - 'work_dir': 'build'} 20:54:49 INFO - ##### 20:54:49 INFO - ##### Running clobber step. 20:54:49 INFO - ##### 20:54:49 INFO - Running pre-action listener: _resource_record_pre_action 20:54:49 INFO - Running main action method: clobber 20:54:49 INFO - rmtree: /builds/slave/test-pgo/build 20:54:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:54:49 INFO - Running post-action listener: _resource_record_post_action 20:54:49 INFO - ##### 20:54:49 INFO - ##### Running read-buildbot-config step. 20:54:49 INFO - ##### 20:54:49 INFO - Running pre-action listener: _resource_record_pre_action 20:54:49 INFO - Running main action method: read_buildbot_config 20:54:49 INFO - Using buildbot properties: 20:54:49 INFO - { 20:54:49 INFO - "properties": { 20:54:49 INFO - "buildnumber": 339, 20:54:49 INFO - "product": "firefox", 20:54:49 INFO - "script_repo_revision": "production", 20:54:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:54:49 INFO - "repository": "", 20:54:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:54:49 INFO - "buildid": "20151125173020", 20:54:49 INFO - "slavename": "talos-linux64-ix-055", 20:54:49 INFO - "pgo_build": "True", 20:54:49 INFO - "basedir": "/builds/slave/test-pgo", 20:54:49 INFO - "project": "", 20:54:49 INFO - "platform": "ubuntu64_hw", 20:54:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:54:49 INFO - "slavebuilddir": "test", 20:54:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:54:49 INFO - "branch": "fx-team", 20:54:49 INFO - "repo_path": "integration/fx-team", 20:54:49 INFO - "stage_platform": "linux64-pgo", 20:54:49 INFO - "builduid": "9de007e3ffd847dabac6890943cdea15", 20:54:49 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:49 INFO - }, 20:54:49 INFO - "sourcestamp": { 20:54:49 INFO - "repository": "", 20:54:49 INFO - "hasPatch": false, 20:54:49 INFO - "project": "", 20:54:49 INFO - "branch": "fx-team-linux64-pgo-talos", 20:54:49 INFO - "changes": [ 20:54:49 INFO - { 20:54:49 INFO - "category": null, 20:54:49 INFO - "files": [ 20:54:49 INFO - { 20:54:49 INFO - "url": null, 20:54:49 INFO - "name": "https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:54:49 INFO - } 20:54:49 INFO - ], 20:54:49 INFO - "repository": "", 20:54:49 INFO - "rev": "34c9087517ea31fc1a0204dd5635e7384a94ae3a", 20:54:49 INFO - "who": "sendchange", 20:54:49 INFO - "when": 1448513650, 20:54:49 INFO - "number": 6708889, 20:54:49 INFO - "comments": "", 20:54:49 INFO - "project": "", 20:54:49 INFO - "at": "Wed 25 Nov 2015 20:54:10", 20:54:49 INFO - "branch": "fx-team-linux64-pgo-talos", 20:54:49 INFO - "revlink": "", 20:54:49 INFO - "properties": [ 20:54:49 INFO - [ 20:54:49 INFO - "buildid", 20:54:49 INFO - "20151125173020", 20:54:49 INFO - "Change" 20:54:49 INFO - ], 20:54:49 INFO - [ 20:54:49 INFO - "builduid", 20:54:49 INFO - "9de007e3ffd847dabac6890943cdea15", 20:54:49 INFO - "Change" 20:54:49 INFO - ], 20:54:49 INFO - [ 20:54:49 INFO - "pgo_build", 20:54:49 INFO - "True", 20:54:49 INFO - "Change" 20:54:49 INFO - ] 20:54:49 INFO - ], 20:54:49 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:49 INFO - } 20:54:49 INFO - ], 20:54:49 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:49 INFO - } 20:54:49 INFO - } 20:54:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:54:49 INFO - Running post-action listener: _resource_record_post_action 20:54:49 INFO - ##### 20:54:49 INFO - ##### Running download-and-extract step. 20:54:49 INFO - ##### 20:54:49 INFO - Running pre-action listener: _resource_record_pre_action 20:54:49 INFO - Running main action method: download_and_extract 20:54:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:54:49 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:54:49 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json 20:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json 20:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:54:53 INFO - Downloaded 1302 bytes. 20:54:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:54:53 INFO - Using the following test package requirements: 20:54:53 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:54:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'jsshell-linux-x86_64.zip'], 20:54:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:54:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:54:53 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:54:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:54:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:54:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:53 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:54:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:54:56 INFO - Downloaded 22754615 bytes. 20:54:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:54:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:54:57 INFO - Return code: 0 20:54:57 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:54:57 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:54:57 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:54:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:54:59 INFO - Downloaded 22754615 bytes. 20:54:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:54:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:55:01 INFO - Return code: 0 20:55:01 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:55:01 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:55:03 INFO - Downloaded 11131717 bytes. 20:55:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 20:55:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:55:03 INFO - Return code: 0 20:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:03 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:55:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:55:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:55:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:55:04 INFO - Downloaded 58393933 bytes. 20:55:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:55:04 INFO - mkdir: /builds/slave/test-pgo/properties 20:55:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:55:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:55:04 INFO - Contents: 20:55:04 INFO - build_url:https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:55:04 INFO - Running post-action listener: _resource_record_post_action 20:55:04 INFO - Running post-action listener: set_extra_try_arguments 20:55:04 INFO - ##### 20:55:04 INFO - ##### Running populate-webroot step. 20:55:04 INFO - ##### 20:55:04 INFO - Running pre-action listener: _resource_record_pre_action 20:55:04 INFO - Running main action method: populate_webroot 20:55:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:55:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:55:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:55:04 INFO - '../fennec_ids.txt'], 20:55:04 INFO - 'tests': ['tcheck2']}, 20:55:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:55:04 INFO - '--tppagecycles', 20:55:04 INFO - '7'], 20:55:04 INFO - 'tests': ['tsvgm']}}, 20:55:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:55:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:55:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:55:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:55:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'tests': ['damp', 'tps']}, 20:55:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['damp', 'tps']}, 20:55:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:55:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:55:04 INFO - 'other': {'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'other_l64': {'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'other_nol64': {'tests': ['a11yr', 20:55:04 INFO - 'ts_paint', 20:55:04 INFO - 'tpaint', 20:55:04 INFO - 'sessionrestore', 20:55:04 INFO - 'sessionrestore_no_auto_restore']}, 20:55:04 INFO - 'svgr': {'tests': ['tsvgx', 20:55:04 INFO - 'tsvgr_opacity', 20:55:04 INFO - 'tart', 20:55:04 INFO - 'tscrollx', 20:55:04 INFO - 'cart']}, 20:55:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['tsvgx', 20:55:04 INFO - 'tsvgr_opacity', 20:55:04 INFO - 'tart', 20:55:04 INFO - 'tscrollx', 20:55:04 INFO - 'cart']}, 20:55:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'tests': ['tp5o']}, 20:55:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'talos_options': ['--e10s'], 20:55:04 INFO - 'tests': ['tp5o']}, 20:55:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'talos_options': ['--xperf_path', 20:55:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:04 INFO - 'tests': ['tp5n']}, 20:55:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:04 INFO - 'talos_options': ['--e10s', 20:55:04 INFO - '--xperf_path', 20:55:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:04 INFO - 'tests': ['tp5n']}}, 20:55:04 INFO - 'talos.zip': {'path': '', 20:55:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:55:04 INFO - Running post-action listener: _resource_record_post_action 20:55:04 INFO - ##### 20:55:04 INFO - ##### Running create-virtualenv step. 20:55:04 INFO - ##### 20:55:04 INFO - Running pre-action listener: _resource_record_pre_action 20:55:04 INFO - Running main action method: create_virtualenv 20:55:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:55:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 20:55:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:55:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:55:04 INFO - Using real prefix '/usr' 20:55:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:55:05 INFO - Installing distribute.............................................................................................................................................................................................done. 20:55:07 INFO - Installing pip.................done. 20:55:07 INFO - Return code: 0 20:55:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 20:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 20:55:07 INFO - Using env: {'DISPLAY': ':0', 20:55:07 INFO - 'HOME': '/home/cltbld', 20:55:07 INFO - 'LANG': 'en_US.UTF-8', 20:55:07 INFO - 'LANGUAGE': 'en_US:en', 20:55:07 INFO - 'LOGNAME': 'cltbld', 20:55:07 INFO - 'MAIL': '/var/mail/cltbld', 20:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:07 INFO - 'MOZ_NO_REMOTE': '1', 20:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:07 INFO - 'NO_EM_RESTART': '1', 20:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:07 INFO - 'SHELL': '/bin/bash', 20:55:07 INFO - 'SHLVL': '1', 20:55:07 INFO - 'TERM': 'linux', 20:55:07 INFO - 'TMOUT': '86400', 20:55:07 INFO - 'USER': 'cltbld', 20:55:07 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:07 INFO - '_': '/tools/buildbot/bin/python'} 20:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:07 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 20:55:07 INFO - Cleaning up... 20:55:07 INFO - Return code: 0 20:55:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 20:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 20:55:07 INFO - Using env: {'DISPLAY': ':0', 20:55:07 INFO - 'HOME': '/home/cltbld', 20:55:07 INFO - 'LANG': 'en_US.UTF-8', 20:55:07 INFO - 'LANGUAGE': 'en_US:en', 20:55:07 INFO - 'LOGNAME': 'cltbld', 20:55:07 INFO - 'MAIL': '/var/mail/cltbld', 20:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:07 INFO - 'MOZ_NO_REMOTE': '1', 20:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:07 INFO - 'NO_EM_RESTART': '1', 20:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:07 INFO - 'SHELL': '/bin/bash', 20:55:07 INFO - 'SHLVL': '1', 20:55:07 INFO - 'TERM': 'linux', 20:55:07 INFO - 'TMOUT': '86400', 20:55:07 INFO - 'USER': 'cltbld', 20:55:07 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:07 INFO - '_': '/tools/buildbot/bin/python'} 20:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:07 INFO - Downloading/unpacking psutil>=0.7.1 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:55:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:55:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:55:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:55:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:55:09 INFO - Installing collected packages: psutil 20:55:09 INFO - Running setup.py install for psutil 20:55:09 INFO - building 'psutil._psutil_linux' extension 20:55:09 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 20:55:09 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 20:55:09 INFO - building 'psutil._psutil_posix' extension 20:55:09 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 20:55:09 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 20:55:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:55:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:55:09 INFO - Successfully installed psutil 20:55:09 INFO - Cleaning up... 20:55:10 INFO - Return code: 0 20:55:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 20:55:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 20:55:10 INFO - Using env: {'DISPLAY': ':0', 20:55:10 INFO - 'HOME': '/home/cltbld', 20:55:10 INFO - 'LANG': 'en_US.UTF-8', 20:55:10 INFO - 'LANGUAGE': 'en_US:en', 20:55:10 INFO - 'LOGNAME': 'cltbld', 20:55:10 INFO - 'MAIL': '/var/mail/cltbld', 20:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:10 INFO - 'MOZ_NO_REMOTE': '1', 20:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:10 INFO - 'NO_EM_RESTART': '1', 20:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:10 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:10 INFO - 'SHELL': '/bin/bash', 20:55:10 INFO - 'SHLVL': '1', 20:55:10 INFO - 'TERM': 'linux', 20:55:10 INFO - 'TMOUT': '86400', 20:55:10 INFO - 'USER': 'cltbld', 20:55:10 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:10 INFO - '_': '/tools/buildbot/bin/python'} 20:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:55:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:55:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:55:11 INFO - Installing collected packages: mozsystemmonitor 20:55:11 INFO - Running setup.py install for mozsystemmonitor 20:55:12 INFO - Successfully installed mozsystemmonitor 20:55:12 INFO - Cleaning up... 20:55:12 INFO - Return code: 0 20:55:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 20:55:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 20:55:12 INFO - Using env: {'DISPLAY': ':0', 20:55:12 INFO - 'HOME': '/home/cltbld', 20:55:12 INFO - 'LANG': 'en_US.UTF-8', 20:55:12 INFO - 'LANGUAGE': 'en_US:en', 20:55:12 INFO - 'LOGNAME': 'cltbld', 20:55:12 INFO - 'MAIL': '/var/mail/cltbld', 20:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:12 INFO - 'MOZ_NO_REMOTE': '1', 20:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:12 INFO - 'NO_EM_RESTART': '1', 20:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:12 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:12 INFO - 'SHELL': '/bin/bash', 20:55:12 INFO - 'SHLVL': '1', 20:55:12 INFO - 'TERM': 'linux', 20:55:12 INFO - 'TMOUT': '86400', 20:55:12 INFO - 'USER': 'cltbld', 20:55:12 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:12 INFO - '_': '/tools/buildbot/bin/python'} 20:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:12 INFO - Downloading/unpacking blobuploader==1.2.4 20:55:12 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 20:55:12 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 20:55:12 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 20:55:12 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 20:55:12 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 20:55:12 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 20:55:14 INFO - Downloading blobuploader-1.2.4.tar.gz 20:55:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:55:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:55:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:55:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:55:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:15 INFO - Downloading docopt-0.6.1.tar.gz 20:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:55:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:55:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:55:15 INFO - Running setup.py install for blobuploader 20:55:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:55:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:55:15 INFO - Running setup.py install for requests 20:55:16 INFO - Running setup.py install for docopt 20:55:16 INFO - Successfully installed blobuploader requests docopt 20:55:16 INFO - Cleaning up... 20:55:16 INFO - Return code: 0 20:55:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 20:55:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 20:55:16 INFO - Using env: {'DISPLAY': ':0', 20:55:16 INFO - 'HOME': '/home/cltbld', 20:55:16 INFO - 'LANG': 'en_US.UTF-8', 20:55:16 INFO - 'LANGUAGE': 'en_US:en', 20:55:16 INFO - 'LOGNAME': 'cltbld', 20:55:16 INFO - 'MAIL': '/var/mail/cltbld', 20:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:16 INFO - 'MOZ_NO_REMOTE': '1', 20:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:16 INFO - 'NO_EM_RESTART': '1', 20:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:16 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:16 INFO - 'SHELL': '/bin/bash', 20:55:16 INFO - 'SHLVL': '1', 20:55:16 INFO - 'TERM': 'linux', 20:55:16 INFO - 'TMOUT': '86400', 20:55:16 INFO - 'USER': 'cltbld', 20:55:16 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:16 INFO - '_': '/tools/buildbot/bin/python'} 20:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:16 INFO - Running setup.py (path:/tmp/pip-cKQB0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:16 INFO - Running setup.py (path:/tmp/pip-nILkz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:16 INFO - Running setup.py (path:/tmp/pip-30_s2B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:16 INFO - Running setup.py (path:/tmp/pip-eGcGQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:16 INFO - Running setup.py (path:/tmp/pip-fZaO6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:16 INFO - Running setup.py (path:/tmp/pip-aDVxor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:16 INFO - Running setup.py (path:/tmp/pip-35WIXS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:17 INFO - Running setup.py (path:/tmp/pip-dctjAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:17 INFO - Running setup.py (path:/tmp/pip-wtbTIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:17 INFO - Running setup.py (path:/tmp/pip-kX01qE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:17 INFO - Running setup.py (path:/tmp/pip-eaYXMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:17 INFO - Running setup.py (path:/tmp/pip-RD1e5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:17 INFO - Running setup.py (path:/tmp/pip-FvdVM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:17 INFO - Running setup.py (path:/tmp/pip-x9Zood-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:17 INFO - Running setup.py (path:/tmp/pip-FrR11D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:17 INFO - Running setup.py (path:/tmp/pip-VS76rB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:17 INFO - Running setup.py (path:/tmp/pip-DlQ70A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:55:17 INFO - Running setup.py install for manifestparser 20:55:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:55:17 INFO - Running setup.py install for mozcrash 20:55:17 INFO - Running setup.py install for mozdebug 20:55:18 INFO - Running setup.py install for mozdevice 20:55:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for mozfile 20:55:18 INFO - Running setup.py install for mozhttpd 20:55:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for mozinfo 20:55:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for mozInstall 20:55:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for mozleak 20:55:18 INFO - Running setup.py install for mozlog 20:55:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for moznetwork 20:55:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:55:18 INFO - Running setup.py install for mozprocess 20:55:18 INFO - Running setup.py install for mozprofile 20:55:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:55:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:55:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:55:19 INFO - Running setup.py install for mozrunner 20:55:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:55:19 INFO - Running setup.py install for mozscreenshot 20:55:19 INFO - Running setup.py install for moztest 20:55:19 INFO - Running setup.py install for mozversion 20:55:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:55:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:55:19 INFO - Cleaning up... 20:55:19 INFO - Return code: 0 20:55:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 20:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 20:55:19 INFO - Using env: {'DISPLAY': ':0', 20:55:19 INFO - 'HOME': '/home/cltbld', 20:55:19 INFO - 'LANG': 'en_US.UTF-8', 20:55:19 INFO - 'LANGUAGE': 'en_US:en', 20:55:19 INFO - 'LOGNAME': 'cltbld', 20:55:19 INFO - 'MAIL': '/var/mail/cltbld', 20:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:19 INFO - 'MOZ_NO_REMOTE': '1', 20:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:19 INFO - 'NO_EM_RESTART': '1', 20:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:19 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:19 INFO - 'SHELL': '/bin/bash', 20:55:19 INFO - 'SHLVL': '1', 20:55:19 INFO - 'TERM': 'linux', 20:55:19 INFO - 'TMOUT': '86400', 20:55:19 INFO - 'USER': 'cltbld', 20:55:19 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:19 INFO - '_': '/tools/buildbot/bin/python'} 20:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:19 INFO - Running setup.py (path:/tmp/pip-MQHY7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 20:55:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:19 INFO - Running setup.py (path:/tmp/pip-7Dq_x_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:55:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:19 INFO - Running setup.py (path:/tmp/pip-xIznwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 20:55:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:20 INFO - Running setup.py (path:/tmp/pip-7yuF07-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:20 INFO - Running setup.py (path:/tmp/pip-NVRtwH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:20 INFO - Running setup.py (path:/tmp/pip-zBjDJa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:20 INFO - Running setup.py (path:/tmp/pip-NIGG9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:20 INFO - Running setup.py (path:/tmp/pip-7TgN7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:20 INFO - Running setup.py (path:/tmp/pip-6mnG1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:20 INFO - Running setup.py (path:/tmp/pip-DUt0NC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:20 INFO - Running setup.py (path:/tmp/pip-h4NQ4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:20 INFO - Running setup.py (path:/tmp/pip-m25QQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:20 INFO - Running setup.py (path:/tmp/pip-4yAwmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:20 INFO - Running setup.py (path:/tmp/pip-oJNsHb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:20 INFO - Running setup.py (path:/tmp/pip-VwklQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:20 INFO - Running setup.py (path:/tmp/pip-WV9eQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 20:55:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:20 INFO - Running setup.py (path:/tmp/pip-CTRu4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:55:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:55:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:55:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:55:22 INFO - Downloading blessings-1.5.1.tar.gz 20:55:22 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:55:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:55:22 INFO - Installing collected packages: blessings 20:55:22 INFO - Running setup.py install for blessings 20:55:22 INFO - Successfully installed blessings 20:55:22 INFO - Cleaning up... 20:55:22 INFO - Return code: 0 20:55:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:55:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:55:23 INFO - Reading from file tmpfile_stdout 20:55:23 INFO - Current package versions: 20:55:23 INFO - argparse == 1.2.1 20:55:23 INFO - blessings == 1.5.1 20:55:23 INFO - blobuploader == 1.2.4 20:55:23 INFO - docopt == 0.6.1 20:55:23 INFO - manifestparser == 1.1 20:55:23 INFO - mozInstall == 1.12 20:55:23 INFO - mozcrash == 0.16 20:55:23 INFO - mozdebug == 0.1 20:55:23 INFO - mozdevice == 0.47 20:55:23 INFO - mozfile == 1.2 20:55:23 INFO - mozhttpd == 0.7 20:55:23 INFO - mozinfo == 0.9 20:55:23 INFO - mozleak == 0.1 20:55:23 INFO - mozlog == 3.1 20:55:23 INFO - moznetwork == 0.27 20:55:23 INFO - mozprocess == 0.22 20:55:23 INFO - mozprofile == 0.27 20:55:23 INFO - mozrunner == 6.11 20:55:23 INFO - mozscreenshot == 0.1 20:55:23 INFO - mozsystemmonitor == 0.0 20:55:23 INFO - moztest == 0.7 20:55:23 INFO - mozversion == 1.4 20:55:23 INFO - psutil == 3.1.1 20:55:23 INFO - requests == 1.2.3 20:55:23 INFO - wsgiref == 0.1.2 20:55:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:55:23 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:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:23 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:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 20:55:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 20:55:23 INFO - Using env: {'DISPLAY': ':0', 20:55:23 INFO - 'HOME': '/home/cltbld', 20:55:23 INFO - 'LANG': 'en_US.UTF-8', 20:55:23 INFO - 'LANGUAGE': 'en_US:en', 20:55:23 INFO - 'LOGNAME': 'cltbld', 20:55:23 INFO - 'MAIL': '/var/mail/cltbld', 20:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:23 INFO - 'MOZ_NO_REMOTE': '1', 20:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:23 INFO - 'NO_EM_RESTART': '1', 20:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:23 INFO - 'SHELL': '/bin/bash', 20:55:23 INFO - 'SHLVL': '1', 20:55:23 INFO - 'TERM': 'linux', 20:55:23 INFO - 'TMOUT': '86400', 20:55:23 INFO - 'USER': 'cltbld', 20:55:23 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:23 INFO - '_': '/tools/buildbot/bin/python'} 20:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 20:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:55:23 INFO - Cleaning up... 20:55:23 INFO - Return code: 0 20:55:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:55:23 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:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:23 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:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x107f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 20:55:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 20:55:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 20:55:23 INFO - Using env: {'DISPLAY': ':0', 20:55:23 INFO - 'HOME': '/home/cltbld', 20:55:23 INFO - 'LANG': 'en_US.UTF-8', 20:55:23 INFO - 'LANGUAGE': 'en_US:en', 20:55:23 INFO - 'LOGNAME': 'cltbld', 20:55:23 INFO - 'MAIL': '/var/mail/cltbld', 20:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:23 INFO - 'MOZ_NO_REMOTE': '1', 20:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:23 INFO - 'NO_EM_RESTART': '1', 20:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:23 INFO - 'SHELL': '/bin/bash', 20:55:23 INFO - 'SHLVL': '1', 20:55:23 INFO - 'TERM': 'linux', 20:55:23 INFO - 'TMOUT': '86400', 20:55:23 INFO - 'USER': 'cltbld', 20:55:23 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:23 INFO - '_': '/tools/buildbot/bin/python'} 20:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:23 INFO - Downloading/unpacking jsonschema 20:55:23 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 20:55:23 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 20:55:23 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 20:55:23 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 20:55:23 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 20:55:23 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 20:55:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:55:25 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 20:55:25 INFO - Downloading/unpacking functools32 (from jsonschema) 20:55:25 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 20:55:25 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 20:55:25 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 20:55:25 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 20:55:25 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 20:55:25 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 20:55:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:55:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:55:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:55:25 INFO - warning: no files found matching '*.txt' 20:55:25 INFO - no previously-included directories found matching 'build' 20:55:25 INFO - no previously-included directories found matching 'dist' 20:55:25 INFO - no previously-included directories found matching '.git*' 20:55:25 INFO - Installing collected packages: jsonschema, functools32 20:55:25 INFO - Running setup.py install for functools32 20:55:25 INFO - warning: no files found matching '*.txt' 20:55:25 INFO - no previously-included directories found matching 'build' 20:55:25 INFO - no previously-included directories found matching 'dist' 20:55:25 INFO - no previously-included directories found matching '.git*' 20:55:25 INFO - Successfully installed jsonschema functools32 20:55:25 INFO - Cleaning up... 20:55:25 INFO - Return code: 0 20:55:25 INFO - Running post-action listener: _resource_record_post_action 20:55:25 INFO - Running post-action listener: _start_resource_monitoring 20:55:25 INFO - Starting resource monitoring. 20:55:25 INFO - ##### 20:55:25 INFO - ##### Running install step. 20:55:25 INFO - ##### 20:55:25 INFO - Running pre-action listener: _resource_record_pre_action 20:55:25 INFO - Running main action method: install 20:55:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:55:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:55:25 INFO - Reading from file tmpfile_stdout 20:55:25 INFO - Detecting whether we're running mozinstall >=1.0... 20:55:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:55:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:55:26 INFO - Reading from file tmpfile_stdout 20:55:26 INFO - Output received: 20:55:26 INFO - Usage: mozinstall [options] installer 20:55:26 INFO - Options: 20:55:26 INFO - -h, --help show this help message and exit 20:55:26 INFO - -d DEST, --destination=DEST 20:55:26 INFO - Directory to install application into. [default: 20:55:26 INFO - "/builds/slave/test-pgo"] 20:55:26 INFO - --app=APP Application being installed. [default: firefox] 20:55:26 INFO - mkdir: /builds/slave/test-pgo/build/application 20:55:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:55:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:55:40 INFO - Reading from file tmpfile_stdout 20:55:40 INFO - Output received: 20:55:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:55:40 INFO - Running post-action listener: _resource_record_post_action 20:55:40 INFO - ##### 20:55:40 INFO - ##### Running run-tests step. 20:55:40 INFO - ##### 20:55:40 INFO - Running pre-action listener: _resource_record_pre_action 20:55:40 INFO - Running main action method: run_tests 20:55:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:55:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:55:40 INFO - Python 2.7.3 20:55:40 INFO - Return code: 0 20:55:40 INFO - grabbing minidump binary from tooltool 20:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:40 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-pgo/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 0x133b640>, '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 0x133c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:55:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 20:55:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:55:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:55:40 INFO - Return code: 0 20:55:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:55:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:55:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:55:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:55:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:55:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:55:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 20:55:40 INFO - Using env: {'DISPLAY': ':0', 20:55:40 INFO - 'HOME': '/home/cltbld', 20:55:40 INFO - 'LANG': 'en_US.UTF-8', 20:55:40 INFO - 'LANGUAGE': 'en_US:en', 20:55:40 INFO - 'LOGNAME': 'cltbld', 20:55:40 INFO - 'MAIL': '/var/mail/cltbld', 20:55:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:55:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:40 INFO - 'MOZ_NO_REMOTE': '1', 20:55:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:40 INFO - 'NO_EM_RESTART': '1', 20:55:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:40 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:55:40 INFO - 'SHELL': '/bin/bash', 20:55:40 INFO - 'SHLVL': '1', 20:55:40 INFO - 'TERM': 'linux', 20:55:40 INFO - 'TMOUT': '86400', 20:55:40 INFO - 'USER': 'cltbld', 20:55:40 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633', 20:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:40 INFO - '_': '/tools/buildbot/bin/python'} 20:55:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 20:55:40 INFO - mozversion INFO | application_buildid: 20151125173020 20:55:40 INFO - mozversion INFO | application_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 20:55:40 INFO - mozversion INFO | application_display_name: Nightly 20:55:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:55:40 INFO - mozversion INFO | application_name: Firefox 20:55:40 INFO - mozversion INFO | application_remotingname: firefox 20:55:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:55:40 INFO - mozversion INFO | application_vendor: Mozilla 20:55:40 INFO - mozversion INFO | application_version: 45.0a1 20:55:40 INFO - mozversion INFO | platform_buildid: 20151125173020 20:55:40 INFO - mozversion INFO | platform_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 20:55:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:55:40 INFO - mozversion INFO | platform_version: 45.0a1 20:55:40 INFO - 2015-11-25 20:55:40,926 DEBUG : using testdate: 1448513740 20:55:40 INFO - 2015-11-25 20:55:40,926 DEBUG : actual date: 1448513740 20:55:40 INFO - 2015-11-25 20:55:40,934 INFO : starting webserver on 'localhost:56292' 20:55:40 INFO - 2015-11-25 20:55:40,935 INFO : Starting test suite talos-linux64-ix-055 20:55:40 INFO - 2015-11-25 20:55:40,935 INFO : Starting test dromaeo_css 20:55:40 INFO - 2015-11-25 20:55:40,935 DEBUG : operating with platform_type : linux_ 20:55:40 INFO - 2015-11-25 20:55:40,936 INFO : Initialising browser for dromaeo_css test... 20:55:40 INFO - 2015-11-25 20:55:40,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXnXDkM/profile http://localhost:56292/getInfo.html 20:55:44 INFO - 2015-11-25 20:55:44,691 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:55:44 INFO - 2015-11-25 20:55:44,691 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:55:44 INFO - 2015-11-25 20:55:44,691 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:55:44 INFO - 2015-11-25 20:55:44,691 DEBUG : BROWSER_OUTPUT: __metrics 20:55:44 INFO - 2015-11-25 20:55:44,788 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] 20:55:46 INFO - 2015-11-25 20:55:46,070 INFO : Browser initialized. 20:55:46 INFO - 2015-11-25 20:55:46,071 INFO : Running cycle 1/1 for dromaeo_css test... 20:55:46 INFO - 2015-11-25 20:55:46,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXnXDkM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:55:57 INFO - 2015-11-25 20:55:57,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 138616832 20:55:57 INFO - 2015-11-25 20:55:57,812 DEBUG : BROWSER_OUTPUT: 20:56:48 INFO - 2015-11-25 20:56:48,547 DEBUG : BROWSER_OUTPUT: 1448513808544 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] 20:58:58 INFO - 2015-11-25 20:58:58,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56292/tests/dromaeo/cssquery-ext.html) 20:58:59 INFO - 2015-11-25 20:58:59,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 248786944 20:58:59 INFO - 2015-11-25 20:58:59,489 DEBUG : BROWSER_OUTPUT: 21:02:01 INFO - 2015-11-25 21:02:01,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-ext.html (next: http://localhost:56292/tests/dromaeo/cssquery-jquery.html) 21:02:02 INFO - 2015-11-25 21:02:02,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 223436800 21:02:02 INFO - 2015-11-25 21:02:02,380 DEBUG : BROWSER_OUTPUT: 21:05:04 INFO - 2015-11-25 21:05:04,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56292/tests/dromaeo/cssquery-mootools.html) 21:05:04 INFO - 2015-11-25 21:05:04,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 223911936 21:05:04 INFO - 2015-11-25 21:05:04,925 DEBUG : BROWSER_OUTPUT: 21:08:06 INFO - 2015-11-25 21:08:06,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56292/tests/dromaeo/cssquery-prototype.html) 21:08:07 INFO - 2015-11-25 21:08:07,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 200622080 21:08:07 INFO - 2015-11-25 21:08:07,348 DEBUG : BROWSER_OUTPUT: 21:11:09 INFO - 2015-11-25 21:11:09,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56292/tests/dromaeo/cssquery-yui.html) 21:11:10 INFO - 2015-11-25 21:11:10,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 205807616 21:11:10 INFO - 2015-11-25 21:11:10,391 DEBUG : BROWSER_OUTPUT: 21:14:12 INFO - 2015-11-25 21:14:12,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/dromaeo/cssquery-yui.html (next: http://localhost:56292/tests/dromaeo/cssquery-dojo.html) 21:14:13 INFO - 2015-11-25 21:14:13,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 269692928 21:14:13 INFO - 2015-11-25 21:14:13,257 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,257 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:14:13 INFO - 2015-11-25 21:14:13,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:14:13 INFO - 2015-11-25 21:14:13,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:14:13 INFO - 2015-11-25 21:14:13,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:14:13 INFO - 2015-11-25 21:14:13,258 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3200.9756877799105;3251.756118291126;3278.1804548862783;3281.491368837831;3294.6375898651145;5195.324607800981;5319.20211968204;5371.793592174865;5425.457454254578;5432.348118225814;5360.2763626910355;5402.405735369106;5424.159255315432;5517.972410137943;5521;4951.23255895335;4967.726775027372;4984.32711583937;4986.127427700156;5006.22403527452;5025.422076461217;5038.143515602356;5098.898022039557;5101.51535604117;5109.642325037249;4734.834280800173;4838.709677419331;4840.661153719258;4940.308356830046;4953.182724850395;4999.150144475448;5038.622103342264;5043.092243396187;5049.015441988814;5090.821821236239;4636.768161591907;5008.9499105008845;5011.699298042093;5025.271335656346;5074.923876141861;5097.286379906779;5147.073526765181;5196.818111366084;5199.584033277329;5233.162693968985;5846;5868.178455016301;5877.471027607493;5880.647161170344;5882;5682.715864206814;5844.620099693507;5893.941060589382;5900.498457631106;5905.822825315247;5278.868028299285;5412.323459567554;5427.3758517770175;5427.3758517770175;5428.077226871442;5978.3124940631515;5989.940100599026;6041.818745437644;6050.183225264621;6051.243594550681;5781.19063331134;5789.913151302734;5792.88414231713;5795.246617939725;5796.826095217066;5529.502344788988;5708.343540492813;5714.79998200061;5850.765969361178;5989.970050149721;5841.065429531254;5871.530277577784;5894.233749612608;5894.469497745138;5897.144913987448;5889.499392551681;5905.527557795366;5910.202122713465;5911.674857882857;5915.053591425351;4332.740035597874;4433.334999749999;4445.5776701213335;4509.751963642031;4540.931886021713;4063.349864021742;4066.1054567994993;4069.593040695907;4105.651019663303;4114.238865809834;5351.866203344947;5600.159976003551;5602.075657516546;5602.635828671123;5613.607047506717;5736.168255602997;5748.7125643717645;5800.477956983892;5858.150568167592;5865.178874957509;5568.470995255525;5584.720763961867;5592.552595792326;5592.692401917852;5596.972015139898;5156.381234251839;5158.948410515922;5160.174372100446;5161.7677204525135;5201.817936372285;5842.065269556851;5960.254968128984;5967.8209653710455;5970;6021.668808215591;5907.9704601476715;5925.911111333419;5934.109883517507;5935.169076329231;5943.049112142036;6064.423879731418;6105.053716673922;6107.786227482017;6137.324894261538;6142.078688196806;5592.3009623797025;5706.514946229617;5707;5708.400617935057;5735.254416925773;5784.942150578609;5873.295204575478;5877.73550190251;5900.409959004065;5902.645841249367;5821.563382746395;5835.416458354301;5839.620424672383;5843.065109582446;5853.2976042875125;5763.625364351304;5813.09896965971;5820.679862607597;5822.097574875901;5824.068149096124;5367;5455.8363249102595;5470.972645136749;5472.288602481652;5573.359063707563;5686.488216060575;5744.798932037359;5775.1914731938405;5798.217240672455;5869.941300586939;5668.404817494269;5674.205611214351;5676.262085928803;5681.9431805681415;5682.119271512922 21:14:13 INFO - 2015-11-25 21:14:13,259 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.3340957441495;595.2589026661807;596.0046721974304;602.5240060352322;614.8124821929315;31831.204219894513;32410.18974525638;32475.837620811893;32491.02526924193;40302.39546406799;43757.34363984543;44161.33757993633;44254;44263.336049959194;44307;8720.781980450492;8871.201591856732;8880.28957683387;8882.422642528216;8883.51140687262;7997.920020799776;8153.714619988302;10607.946960265188;10823;10825.512851921683;10443;10538.841917371246;10541.894581054206;10544.209184311168;10548.894511054868;7996.64015119321;8143.307818835406;10489.737756556071;10590.41752703601;10591.364518128898;7829.491083079582;10522.631707890263;10701.304415212986;10726.141908647289;10735.302205356627;39714.404283935764;40495.1900961982;40508;40512.392314115314;40550.39174412386;3373.190434295776;3465.549478567795;3783.4324851272254;3930.8231129599235;4235.3646952957;30317.696823031707;30813.537796933066;31019.844900775577;31236.531452028237;31680.841595792102;3911.4915061041884;3951.4072889066583;3973.721839471238;4044.1102957349335;4045.575214602454;278438;278564;279046;281149;281554.99999999796;58787.412125878196;60009.699951500836;62120.68939655273;62588.37411625917;62706;58810;58822.70588647029;59138;59142.40857591455;59198.40801592015;15563.688726225411;15900.840991590167;15922.283497242652;15934.840651593335;15943.521694349189;12257.938710306391;12274;12323.445444955;12328.50685972569;12330.753384932252;20126.89936550308;20824.791752082587;20848.687269690967;20899.582008360052;20943.37169884906;7451.180370159278;7557.962210188914;7585.544867307979;7609.277118673717;7722.459427839997;951.8762560867043;974.3228456222857;989.6387818446216;1008.9899101009042;1089.8201796703613;28605;29173.56239656407;29234.415311694072;29389.853050734608;29600;1040.5265604150093;1115.0912006714502;1125.9067872403987;1181.385967439859;1189.4528516882158;14830.703385932437;14957.90828959101;14991.2504374783;15006;15016.924915375572;310918;311191;312627;312890;313011;51917.22124168141;51985.7400712994;52165.47834521606;52181.217281740806;52226;1368.1449094316054;1380.9343257967496;1384.8338199416135;1387.1607677355055;1387.9722405551831;27817.582736258566;28628.42743145167;28867;28889;28970.275743105747;47136.52863471459;47491.762541187076;47892.76053619709;47919;47938.280925785446;294696;296158;296915;297040;297171;28608;29102;31778.682213178497;32342.514862276614;32950.176245594055;39334.60665393309;39381.2123757529;40226.79886600548;40344.19311613693;40346.394804077376;32965.34069318648;33110.5033424494;33702.662973370934;33935.490967635014;34144.65855341415;32045.519317209793;33552;35759;36769;37064.44403333898;34609.65390346065;34653.48019779655;35965.82017089898;36212.456813148354;36705.26589468249;29464;30553.388932221675;33176.66823331832;34241.65758342385;34329.485057724654;25378.365540861625;25662.871685641454;25757.098501552355;25757.871210643825;25837 21:14:13 INFO - 2015-11-25 21:14:13,259 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.8293961549417;339.3416771463361;339.6196260188589;341.71808258186985;342.9434143366345;14203.360848761804;14623.561293161196;16616.58458538537;16754.664906701873;18775.34286299978;16296.266667999938;16438.260278287475;16502.504924852245;16861.66276674466;16889.23998420071;5053.772580233889;5151.175811870102;5157.355330583677;5162.174052151657;5170.870728231786;3920.8039598020127;3993.3011722948368;5123.692578445287;5898.085796701518;6055.486128467883;5926.170336152942;5937.406259374071;5972.522198224132;5983.222181116471;6009.1587177795145;5684.090545512719;5758.309002919635;5763.39484354143;5764.279465066867;5770.2210201622665;4985.626078044161;5022.447530771612;5026.8240611578785;5031;5052.115879721034;21175.576488470146;21388.893055534623;21417;21461.248856289956;21718.348449546538;2150.7204063471804;2270.693456383384;2288.439332363565;2300.7814257645496;2306.6770652108717;9012.41419307743;9370.062993700643;13209.471621135142;13512.797308040388;13627.659308517268;1772.4151030160017;1837.935672251478;1838.8712790104698;1850.6391253705533;1858.9628207435776;59110.40889591092;59976.40023599796;61179;61304.69347653233;62482.68758656223;8865.911340886638;8869.157430044135;8920.509371984474;8928.553572321358;9080.59137338808;11629.418529073513;11698.766024679458;11700.70748231284;11725.120615953838;11725.35510546911;7339.70641174347;7516;7530.171681115073;7604.80987975305;7621.31408173256;7403.259674032553;7428.517146385468;7448.255174482509;7480.625968701544;7550.509216900884;3871.05159235989;3950.802459877052;3967.4643923070594;3980.283548961215;4150.979245103756;1686.3844696685621;1758.648270345936;2815.001349042203;2998.250437390652;3152.243461569207;918.7886786039114;938.3947353956796;1003.1022235099545;1017.7964407118458;1080.9729756756144;16837.32650693983;17572.560685982953;17868.910655446638;18065.909670451827;18099.72850407245;917;919.4896832258161;939.3283802081545;955.073578628729;963.5074043664499;7764.611769411506;10082.596696132072;10093;10107.39355638664;10156.4921753912;506823.7270509212;508835;510068;519475;522413;78609.60695196487;79693.20306796858;80108.19891801124;80538.59730701309;80760.59619701981;1081.1837063017372;1084.3006260961636;1087.5160553553592;1097.983530247047;1098.9725256868483;15634.9218253908;15673.451429199924;15848.44530441429;15894.682106357577;16097.67804643924;36519.63480365268;36977.713788655456;37350.439743404415;37843.81078094592;38268.32121751451;49834.50165498299;49936;50022;50336.979781213246;52785;9618;9662.420254784736;9698.466584337646;9770.85343719859;9788.216942644429;9598.088181622734;9935.105840474393;10382.636607718694;10615.734606634896;11358.26171298863;10086.495675216356;10157.238207134642;10161.288709790244;10336.948315258376;10344.069033786995;10056.195504359488;10126.696199114038;10185.185185185019;10214.846777298199;10236.027577380137;10160.644377446753;10278.588856445958;10457.790844182922;10486.737831554272;10539.314944528582;13898.374573144434;14603.70792584121;14730.705385892437;14977.400903964155;15345.539633811004;15565.84434155644;15866.52400427989;15881.285342159861;16285;16470.67058658844 21:14:13 INFO - 2015-11-25 21:14:13,260 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1286.5175559165314;1430.3706369197553;1475.5352064099804;1586.3654538184724;1734.904580248086;6311.084892690563;7034.683439245234;7287.453440991921;7294.270572942703;7297.927020729791;7280.817979550514;7460;7460.216677248892;7461.5523068615785;7461.776146715593;1915.6456055629753;1977.7824439311664;1981.0490964337127;2177.8366622503295;2214.689943407924;2203.867767933921;2249.910003599854;2250.032486031006;2251.448395143184;2251.9887400562975;2153.8923053847325;2188.627933251343;2200.7359116905996;2202.4714068623575;2204.2505548113636;1913.253831005902;1951.063489525029;1952.4825921130912;2151.7202763640626;2203.713517242756;2209.591225623265;2214.734231892167;2215.8227341812617;2217.090992692988;2218.5119273759747;7100.644967751643;7169.856602867913;7177.282271772833;7182.42540596751;7182.42540596751;4434.379186913835;4484.618807401374;4499.280115181556;4502.144592527409;4516.051629157881;2973.6580293266334;2978.2107741448535;3060.785744997851;3065.2490139915863;3099.3336432667083;1007.6473234367986;1029.891861354562;1049.8792638846553;1050.669039252633;1064.255021484956;9625.229981601455;9625.60428737836;9665.275104367201;9676.274279429072;9715.514224288758;4009.4186342980106;4061.735987160825;4097.590240975878;4098.303288440972;4146.606072423176;8280.71017514384;8285.461445006054;8333.416660833806;8334.374921880883;8362.874556881652;4491.842785502492;4494.213512635276;4503.684742068024;4507.166174257773;4509.932351014738;4058.837646494166;4058.898527536835;4081.795910204478;4087.3051581230666;4092.4270602115726;3524.5770507538746;3541.15012397028;3551.893443196708;3592.497050412944;3598.4962105305276;1140.5551834784442;1162.6918866500384;1164.1618035014776;1172.1384782185087;1178.7171078941165;1029.46467836726;1038.231708535678;1045.2526443592715;1268.194696367813;1269.0862578943147;6840.521163518605;6844.4182244508775;6931.514793964374;6944.375006249462;6949.7567585134275;482.85755702067974;489.82856000399573;492.61329856063537;495.52731867978525;495.8983408401341;5067.695938243717;5180;5524.558035357162;5693.146028095819;5694.288213973254;8377.6230069647;8491.575421228914;8496.277816385676;8532.914670853335;8771.868421973675;8613.913860861436;8633.22300992901;8692.434991725517;8726.214640682241;8741.34439916996;6886.48351373649;6910.378065973986;6942.236354001056;7003.509754317251;7063.6821343038655;6853.4859885507785;6894.655267236518;6908.3091690830515;6916.688749006206;6928.965355173394;7718.073831140299;7735.149133595412;7931.325837303893;7945.602719863868;7964;7945.48354356965;8014.398920080901;8029.919700802917;8087.797805054921;8178.141295163922;6311.368863113652;6353.9046914295395;6417.294097649348;6426.935730642821;6435.324290949383;6701.899471507833;6757.425618822455;6768.052472653931;6780.118584583973;6782.1861376635115;6313.337099604659;6409.294977552372;6494.220693516808;6504.934950650433;6509.218893732783;6379.234491861006;6398.296187419473;6403.423691867568;6487.416132548094;6547.1161393213215;6469.611823290617;6490.286068532363;6496.967515162394;6500.28496865335;6504.1869766279215;5995.430434108753;6038;6046.7581296749395;6050.183225264709;6058.4244496772735;5576.665400076008;5983.102534619842;6125.877482450415;6132.754689812357;6139.508839292756 21:14:13 INFO - 2015-11-25 21:14:13,262 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.4026349935124;317.59189441567577;321.73778370627934;322.1222169587872;324.3140757298315;6070.180525629039;6095.969520152393;6102.786402475915;6104.1759362486055;6155.507559395249;5734;5798.217240672508;5843.532517398608;6012.428819262174;6028.879422411549;4582.633389328846;4592.7014744041535;4593.471750748657;4607.562281583244;4615.376924115252;4379.868603941887;4583.152116858392;4594.104149690812;4603.539646035403;4612.0545288215835;4411.183930972764;4466.12910482456;4535.206338890681;4557.2708366661345;4568.703034302776;4529.252673308933;4541.500434952152;4545.318202269653;4555.476120246181;4560.475545312282;3942.310095733264;3946.2304850554156;3948;3951.0714981979213;3962.6235507627016;5626.6624002559565;5760.913586296167;5761.769529218826;5766.971165144148;5771.307443106812;5309.840704778863;5311.336082989626;5320.600954928357;5322.068637988336;5327.627066105374;6353.30113687494;6361.554691171574;6368.554201205918;6371.267304259976;6385.138006369174;4410.955890441119;4414.735115893057;4416.359627853975;4418.602325790662;4421.778911054466;6510.837229069264;6675.766348177839;6678.332166783282;6683.2314283857;6684.699188536479;4403.867883963486;4423.756693381831;4430.091831174602;4430.734155950653;4433.578810013044;4483.21543729846;4484.215262329079;4484.439445069366;4485.977570112129;4489.842855500107;5251.737413129328;5259.289995850511;5259.710715910662;5264.42091369949;5268.841934741964;6298.779542715983;6380.489560835122;6452.35476452351;6472.029195620695;6475.222973243241;1564.0381165583312;1571.7720930465018;1573;1579.565619454659;1584.595928038343;1021.9729172182058;1026.3072426112344;1030.5517100061497;1038.4288641247283;1054.4147997861107;6215.96892015537;6221.06683997395;6225.564210505221;6228.4705800007505;6234.1583886174785;6643.1031810704935;6644.202695676549;6645.933540664628;6647.5679080860555;6666.96666516674;6073.908891366633;6164.630122192593;6177.96911015442;6289.0880822280515;6292;3610.458431235283;3621.257642183346;3625.3111908737255;3626;3630.7458477906293;6722.092517510171;6752.763653272112;6753.324667533306;6762.763303284361;6834.555753875982;6681.2650608434005;6840.213375461786;6845.691943862438;6869.900815869537;6881.793546193622;6940.895886561706;6945.305469453015;6957.965210173917;6958.234594194634;6958.47811414146;6707.698153583003;6713.697883595152;6715.328467153441;6719.731210751515;6722.294159113419;6433.517486188461;6627.900581491185;6633.2040155181685;6646.235682896336;6651.7006734698025;6942.028116063856;6944.062551555476;6946.722131114699;6948.5483443576;6955.1653801544135;4399.054203346296;4425.867223983286;4429.269170586817;4429.512753597166;4433.955660443355;6521.902171467337;6658.067870498231;6681.832954176184;6690.13028306317;6698.531102822755;6526.314736952741;6527.05357723118;6532.967335163294;6533.346665333429;6540.37866402691;6519.576227545194;6522.804315870531;6523.902141467976;6524.902126468011;6525.2822189558165;6259.749610015549;6356;6367.395097465734;6373.171487706569;6374.808755737336;6544.3782840630065;6576.967115164393;6579.17760279965;6579.572327798678;6579.934200657932;6240.937590624218;6339.619622822645;6398.744050237939;6411.3909178627955;6417.1657684500715 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: |5;yui.html;716.953398029128;731.6268702961488;786.4573444323416;809.259527532308;887.8268737596168;13720.862791372083;13824.239666818321;13880.097793643406;13921.582352529414;13980.161190328587;14615;14747;14779.187144707037;14779.926100369483;14803.33384997675;694.7846167688033;711.9750808721695;841.1084250694269;843.7637461510786;862.2326129744532;849.8130411309533;854.0690647194557;856.220839036477;857.0187135729586;858.1675774498726;729.4638440746047;893.0845882969943;893.3969570539892;893.63361021981;894.883665123533;729.0267492896962;868.7871471489494;876.7764220123892;882.642529775442;883.0374891368439;642.3415998601424;646.3052218864739;648.9935100649028;650.6941737383422;651.7555916531301;13534.187948723109;13626.523071692542;13689.86310136896;13704.24626645534;13736.725265494733;11978.341191234478;12162.635120946386;12206.572769953098;12435.12954093214;12590.43343049565;10064.144547713453;10672.573097076107;10750.354978701303;10817.134629229642;10877.238593298473;3561.394562924309;3635.8182090895616;3641.6540428659237;3649.872254471081;3672.100335417813;48833.26750098752;48970.26544601834;49125.50874491281;49309.01381972376;49684.254736178984;9273.443593384283;9533.52332383378;9613.086756758097;9796.461194634221;9886.555105020292;17949.820501795075;17969.550761230814;18007.279708811762;18009.459716208534;18014.459566213034;7445.925540744632;7486.588237646982;7636.427267954815;7850.332721718603;7960;4229.873103806891;4331.155424692155;4442.089371678798;4457.598816106566;4512.029913568598;3026.576279320897;3052.4810782167083;3057.342671325676;3057.357954829466;3058.816471011702;515.6673945305332;523.500057445139;526.9314989051476;535.4832586553994;549.198170670817;628.8522197283635;654.7282877605741;662.5792621685265;675.6317806795308;693.0470602920983;8489.617967191367;8957;9092.545372731336;9098.272138228926;9389.201917836925;495.96776209546266;650.8080116365588;652.9575577587536;675.6858061001658;697.7348607529208;3763.774173549541;3897.666450459704;4078.7960601969785;4143.295639741251;4224;57196;63700.36299637037;63932.36067639357;64007;64038;51634.74182629063;53581.196282055804;53582.464175358524;53939.730301348245;54977.45022549723;46867;47295.29057064147;48089.5191048092;48125;48349.75825120852;7842.393068491053;7922.366210703015;7964.641591128529;8127.837443250984;8263.917360826315;34068.488972665924;34194.82902585471;34803.477947830295;36108.09729756777;37343;42510.787446062575;42696.35955460733;43422;44455;46256;10623.150147988297;11349.773004540028;11364.374959377314;11534.1926065178;11741.706457338294;11971.16201865861;12058.75882482363;12171.2697238166;12241.571544995883;12281.692957675772;10720.19598530129;11051.113395682007;11410.315381077162;11678.182527223353;12046.698832529257;11403.372814495282;11570.421478926188;11690.649280521598;12053.276803391824;12061.51753929833;11091.50088246047;11381.658550243506;11527.423628818693;11771.014881351428;11864.11019173548;9450.393144709979;9671.17794987434;9685.9031409685;10058.798824023625;10287.382757034602;8570.74287771368;8776.91223087761;9297.581608827755;9590.136887680143;9604.75988100303 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,872 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:14:13 INFO - 2015-11-25 21:14:13,265 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514853250__endTimestamp 21:14:13 INFO - 2015-11-25 21:14:13,266 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,266 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:14:13 INFO - 2015-11-25 21:14:13,266 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:14:13 INFO - 2015-11-25 21:14:13,266 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5435.61 Median:5668.40 stddev:606.48 (10.7%) stddev-sans-first:582.46 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: Values: 3201.0 3251.8 3278.2 3281.5 3294.6 5195.3 5319.2 5371.8 5425.5 5432.3 5360.3 5402.4 5424.2 5518.0 5521.0 4951.2 4967.7 4984.3 4986.1 5006.2 5025.4 5038.1 5098.9 5101.5 5109.6 4734.8 4838.7 4840.7 4940.3 4953.2 4999.2 5038.6 5043.1 5049.0 5090.8 4636.8 5008.9 5011.7 5025.3 5074.9 5097.3 5147.1 5196.8 5199.6 5233.2 5846.0 5868.2 5877.5 5880.6 5882.0 5682.7 5844.6 5893.9 5900.5 5905.8 5278.9 5412.3 5427.4 5427.4 5428.1 5978.3 5989.9 6041.8 6050.2 6051.2 5781.2 5789.9 5792.9 5795.2 5796.8 5529.5 5708.3 5714.8 5850.8 5990.0 5841.1 5871.5 5894.2 5894.5 5897.1 5889.5 5905.5 5910.2 5911.7 5915.1 4332.7 4433.3 4445.6 4509.8 4540.9 4063.3 4066.1 4069.6 4105.7 4114.2 5351.9 5600.2 5602.1 5602.6 5613.6 5736.2 5748.7 5800.5 5858.2 5865.2 5568.5 5584.7 5592.6 5592.7 5597.0 5156.4 5158.9 5160.2 5161.8 5201.8 5842.1 5960.3 5967.8 5970.0 6021.7 5908.0 5925.9 5934.1 5935.2 5943.0 6064.4 6105.1 6107.8 6137.3 6142.1 5592.3 5706.5 5707.0 5708.4 5735.3 5784.9 5873.3 5877.7 5900.4 5902.6 5821.6 5835.4 5839.6 5843.1 5853.3 5763.6 5813.1 5820.7 5822.1 5824.1 5367.0 5455.8 5471.0 5472.3 5573.4 5686.5 5744.8 5775.2 5798.2 5869.9 5668.4 5674.2 5676.3 5681.9 5682.1 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46686.58 Median:32443.01 stddev:77349.79 (238.4%) stddev-sans-first:77489.21 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: Values: 550.3 595.3 596.0 602.5 614.8 31831.2 32410.2 32475.8 32491.0 40302.4 43757.3 44161.3 44254.0 44263.3 44307.0 8720.8 8871.2 8880.3 8882.4 8883.5 7997.9 8153.7 10607.9 10823.0 10825.5 10443.0 10538.8 10541.9 10544.2 10548.9 7996.6 8143.3 10489.7 10590.4 10591.4 7829.5 10522.6 10701.3 10726.1 10735.3 39714.4 40495.2 40508.0 40512.4 40550.4 3373.2 3465.5 3783.4 3930.8 4235.4 30317.7 30813.5 31019.8 31236.5 31680.8 3911.5 3951.4 3973.7 4044.1 4045.6 278438.0 278564.0 279046.0 281149.0 281555.0 58787.4 60009.7 62120.7 62588.4 62706.0 58810.0 58822.7 59138.0 59142.4 59198.4 15563.7 15900.8 15922.3 15934.8 15943.5 12257.9 12274.0 12323.4 12328.5 12330.8 20126.9 20824.8 20848.7 20899.6 20943.4 7451.2 7558.0 7585.5 7609.3 7722.5 951.9 974.3 989.6 1009.0 1089.8 28605.0 29173.6 29234.4 29389.9 29600.0 1040.5 1115.1 1125.9 1181.4 1189.5 14830.7 14957.9 14991.3 15006.0 15016.9 310918.0 311191.0 312627.0 312890.0 313011.0 51917.2 51985.7 52165.5 52181.2 52226.0 1368.1 1380.9 1384.8 1387.2 1388.0 27817.6 28628.4 28867.0 28889.0 28970.3 47136.5 47491.8 47892.8 47919.0 47938.3 294696.0 296158.0 296915.0 297040.0 297171.0 28608.0 29102.0 31778.7 32342.5 32950.2 39334.6 39381.2 40226.8 40344.2 40346.4 32965.3 33110.5 33702.7 33935.5 34144.7 32045.5 33552.0 35759.0 36769.0 37064.4 34609.7 34653.5 35965.8 36212.5 36705.3 29464.0 30553.4 33176.7 34241.7 34329.5 25378.4 25662.9 25757.1 25757.9 25837.0 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28037.99 Median:340.67 stddev:84031.25 (24666.5%) stddev-sans-first:84241.23 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: Values: 337.8 339.3 339.6 341.7 342.9 14203.4 14623.6 16616.6 16754.7 18775.3 16296.3 16438.3 16502.5 16861.7 16889.2 5053.8 5151.2 5157.4 5162.2 5170.9 3920.8 3993.3 5123.7 5898.1 6055.5 5926.2 5937.4 5972.5 5983.2 6009.2 5684.1 5758.3 5763.4 5764.3 5770.2 4985.6 5022.4 5026.8 5031.0 5052.1 21175.6 21388.9 21417.0 21461.2 21718.3 2150.7 2270.7 2288.4 2300.8 2306.7 9012.4 9370.1 13209.5 13512.8 13627.7 1772.4 1837.9 1838.9 1850.6 1859.0 59110.4 59976.4 61179.0 61304.7 62482.7 8865.9 8869.2 8920.5 8928.6 9080.6 11629.4 11698.8 11700.7 11725.1 11725.4 7339.7 7516.0 7530.2 7604.8 7621.3 7403.3 7428.5 7448.3 7480.6 7550.5 3871.1 3950.8 3967.5 3980.3 4151.0 1686.4 1758.6 2815.0 2998.3 3152.2 918.8 938.4 1003.1 1017.8 1081.0 16837.3 17572.6 17868.9 18065.9 18099.7 917.0 919.5 939.3 955.1 963.5 7764.6 10082.6 10093.0 10107.4 10156.5 506823.7 508835.0 510068.0 519475.0 522413.0 78609.6 79693.2 80108.2 80538.6 80760.6 1081.2 1084.3 1087.5 1098.0 1099.0 15634.9 15673.5 15848.4 15894.7 16097.7 36519.6 36977.7 37350.4 37843.8 38268.3 49834.5 49936.0 50022.0 50337.0 52785.0 9618.0 9662.4 9698.5 9770.9 9788.2 9598.1 9935.1 10382.6 10615.7 11358.3 10086.5 10157.2 10161.3 10336.9 10344.1 10056.2 10126.7 10185.2 10214.8 10236.0 10160.6 10278.6 10457.8 10486.7 10539.3 13898.4 14603.7 14730.7 14977.4 15345.5 15565.8 15866.5 15881.3 16285.0 16470.7 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5091.65 Median:6054.30 stddev:2603.47 (43.0%) stddev-sans-first:2595.06 21:14:13 INFO - 2015-11-25 21:14:13,267 DEBUG : BROWSER_OUTPUT: Values: 1286.5 1430.4 1475.5 1586.4 1734.9 6311.1 7034.7 7287.5 7294.3 7297.9 7280.8 7460.0 7460.2 7461.6 7461.8 1915.6 1977.8 1981.0 2177.8 2214.7 2203.9 2249.9 2250.0 2251.4 2252.0 2153.9 2188.6 2200.7 2202.5 2204.3 1913.3 1951.1 1952.5 2151.7 2203.7 2209.6 2214.7 2215.8 2217.1 2218.5 7100.6 7169.9 7177.3 7182.4 7182.4 4434.4 4484.6 4499.3 4502.1 4516.1 2973.7 2978.2 3060.8 3065.2 3099.3 1007.6 1029.9 1049.9 1050.7 1064.3 9625.2 9625.6 9665.3 9676.3 9715.5 4009.4 4061.7 4097.6 4098.3 4146.6 8280.7 8285.5 8333.4 8334.4 8362.9 4491.8 4494.2 4503.7 4507.2 4509.9 4058.8 4058.9 4081.8 4087.3 4092.4 3524.6 3541.2 3551.9 3592.5 3598.5 1140.6 1162.7 1164.2 1172.1 1178.7 1029.5 1038.2 1045.3 1268.2 1269.1 6840.5 6844.4 6931.5 6944.4 6949.8 482.9 489.8 492.6 495.5 495.9 5067.7 5180.0 5524.6 5693.1 5694.3 8377.6 8491.6 8496.3 8532.9 8771.9 8613.9 8633.2 8692.4 8726.2 8741.3 6886.5 6910.4 6942.2 7003.5 7063.7 6853.5 6894.7 6908.3 6916.7 6929.0 7718.1 7735.1 7931.3 7945.6 7964.0 7945.5 8014.4 8029.9 8087.8 8178.1 6311.4 6353.9 6417.3 6426.9 6435.3 6701.9 6757.4 6768.1 6780.1 6782.2 6313.3 6409.3 6494.2 6504.9 6509.2 6379.2 6398.3 6403.4 6487.4 6547.1 6469.6 6490.3 6497.0 6500.3 6504.2 5995.4 6038.0 6046.8 6050.2 6058.4 5576.7 5983.1 6125.9 6132.8 6139.5 21:14:13 INFO - 2015-11-25 21:14:13,268 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,268 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5362.69 Median:6160.07 stddev:1652.90 (26.8%) stddev-sans-first:1613.52 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: Values: 314.4 317.6 321.7 322.1 324.3 6070.2 6096.0 6102.8 6104.2 6155.5 5734.0 5798.2 5843.5 6012.4 6028.9 4582.6 4592.7 4593.5 4607.6 4615.4 4379.9 4583.2 4594.1 4603.5 4612.1 4411.2 4466.1 4535.2 4557.3 4568.7 4529.3 4541.5 4545.3 4555.5 4560.5 3942.3 3946.2 3948.0 3951.1 3962.6 5626.7 5760.9 5761.8 5767.0 5771.3 5309.8 5311.3 5320.6 5322.1 5327.6 6353.3 6361.6 6368.6 6371.3 6385.1 4411.0 4414.7 4416.4 4418.6 4421.8 6510.8 6675.8 6678.3 6683.2 6684.7 4403.9 4423.8 4430.1 4430.7 4433.6 4483.2 4484.2 4484.4 4486.0 4489.8 5251.7 5259.3 5259.7 5264.4 5268.8 6298.8 6380.5 6452.4 6472.0 6475.2 1564.0 1571.8 1573.0 1579.6 1584.6 1022.0 1026.3 1030.6 1038.4 1054.4 6216.0 6221.1 6225.6 6228.5 6234.2 6643.1 6644.2 6645.9 6647.6 6667.0 6073.9 6164.6 6178.0 6289.1 6292.0 3610.5 3621.3 3625.3 3626.0 3630.7 6722.1 6752.8 6753.3 6762.8 6834.6 6681.3 6840.2 6845.7 6869.9 6881.8 6940.9 6945.3 6958.0 6958.2 6958.5 6707.7 6713.7 6715.3 6719.7 6722.3 6433.5 6627.9 6633.2 6646.2 6651.7 6942.0 6944.1 6946.7 6948.5 6955.2 4399.1 4425.9 4429.3 4429.5 4434.0 6521.9 6658.1 6681.8 6690.1 6698.5 6526.3 6527.1 6533.0 6533.3 6540.4 6519.6 6522.8 6523.9 6524.9 6525.3 6259.7 6356.0 6367.4 6373.2 6374.8 6544.4 6577.0 6579.2 6579.6 6579.9 6240.9 6339.6 6398.7 6411.4 6417.2 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14126.70 Median:48237.38 stddev:16614.00 (34.4%) stddev-sans-first:16630.09 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: Values: 717.0 731.6 786.5 809.3 887.8 13720.9 13824.2 13880.1 13921.6 13980.2 14615.0 14747.0 14779.2 14779.9 14803.3 694.8 712.0 841.1 843.8 862.2 849.8 854.1 856.2 857.0 858.2 729.5 893.1 893.4 893.6 894.9 729.0 868.8 876.8 882.6 883.0 642.3 646.3 649.0 650.7 651.8 13534.2 13626.5 13689.9 13704.2 13736.7 11978.3 12162.6 12206.6 12435.1 12590.4 10064.1 10672.6 10750.4 10817.1 10877.2 3561.4 3635.8 3641.7 3649.9 3672.1 48833.3 48970.3 49125.5 49309.0 49684.3 9273.4 9533.5 9613.1 9796.5 9886.6 17949.8 17969.6 18007.3 18009.5 18014.5 7445.9 7486.6 7636.4 7850.3 7960.0 4229.9 4331.2 4442.1 4457.6 4512.0 3026.6 3052.5 3057.3 3057.4 3058.8 515.7 523.5 526.9 535.5 549.2 628.9 654.7 662.6 675.6 693.0 8489.6 8957.0 9092.5 9098.3 9389.2 496.0 650.8 653.0 675.7 697.7 3763.8 3897.7 4078.8 4143.3 4224.0 57196.0 63700.4 63932.4 64007.0 64038.0 51634.7 53581.2 53582.5 53939.7 54977.5 46867.0 47295.3 48089.5 48125.0 48349.8 7842.4 7922.4 7964.6 8127.8 8263.9 34068.5 34194.8 34803.5 36108.1 37343.0 42510.8 42696.4 43422.0 44455.0 46256.0 10623.2 11349.8 11364.4 11534.2 11741.7 11971.2 12058.8 12171.3 12241.6 12281.7 10720.2 11051.1 11410.3 11678.2 12046.7 11403.4 11570.4 11690.6 12053.3 12061.5 11091.5 11381.7 11527.4 11771.0 11864.1 9450.4 9671.2 9685.9 10058.8 10287.4 8570.7 8776.9 9297.6 9590.1 9604.8 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:14:13 INFO - 2015-11-25 21:14:13,269 DEBUG : BROWSER_OUTPUT: 21:14:13 INFO - 2015-11-25 21:14:13,932 INFO : Browser exited with error code: 0 21:14:13 INFO - 2015-11-25 21:14:13,953 INFO : Completed test dromaeo_css (00:18:33) 21:14:13 INFO - 2015-11-25 21:14:13,953 INFO : Starting test kraken 21:14:13 INFO - 2015-11-25 21:14:13,953 DEBUG : operating with platform_type : linux_ 21:14:13 INFO - 2015-11-25 21:14:13,953 INFO : Initialising browser for kraken test... 21:14:13 INFO - 2015-11-25 21:14:13,960 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx2uE8R/profile http://localhost:56292/getInfo.html 21:14:17 INFO - 2015-11-25 21:14:17,757 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:14:17 INFO - 2015-11-25 21:14:17,757 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:14:17 INFO - 2015-11-25 21:14:17,757 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:14:17 INFO - 2015-11-25 21:14:17,757 DEBUG : BROWSER_OUTPUT: __metrics 21:14:17 INFO - 2015-11-25 21:14:17,858 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:14:18 INFO - 2015-11-25 21:14:18,480 DEBUG : BROWSER_OUTPUT: console.error: 21:14:18 INFO - 2015-11-25 21:14:18,480 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 21:14:18 INFO - 2015-11-25 21:14:18,480 DEBUG : BROWSER_OUTPUT: Stack: 21:14:18 INFO - 2015-11-25 21:14:18,480 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 21:14:18 INFO - 2015-11-25 21:14:18,481 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 21:14:18 INFO - 2015-11-25 21:14:18,482 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 21:14:18 INFO - 2015-11-25 21:14:18,482 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 21:14:18 INFO - 2015-11-25 21:14:18,482 DEBUG : BROWSER_OUTPUT: 21:14:18 INFO - 2015-11-25 21:14:18,996 INFO : Browser initialized. 21:14:18 INFO - 2015-11-25 21:14:18,997 INFO : Running cycle 1/1 for kraken test... 21:14:18 INFO - 2015-11-25 21:14:18,997 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx2uE8R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:14:30 INFO - 2015-11-25 21:14:30,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 139272192 21:14:30 INFO - 2015-11-25 21:14:30,677 DEBUG : BROWSER_OUTPUT: 21:14:33 INFO - 2015-11-25 21:14:33,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56292/tests/kraken/driver.html?testName=audio-beat-detection) 21:14:33 INFO - 2015-11-25 21:14:33,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 178569216 21:14:33 INFO - 2015-11-25 21:14:33,711 DEBUG : BROWSER_OUTPUT: 21:14:36 INFO - 2015-11-25 21:14:36,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56292/tests/kraken/driver.html?testName=audio-dft) 21:14:36 INFO - 2015-11-25 21:14:36,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 167727104 21:14:36 INFO - 2015-11-25 21:14:36,880 DEBUG : BROWSER_OUTPUT: 21:14:39 INFO - 2015-11-25 21:14:39,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56292/tests/kraken/driver.html?testName=audio-fft) 21:14:40 INFO - 2015-11-25 21:14:40,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 151293952 21:14:40 INFO - 2015-11-25 21:14:40,354 DEBUG : BROWSER_OUTPUT: 21:14:42 INFO - 2015-11-25 21:14:42,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56292/tests/kraken/driver.html?testName=audio-oscillator) 21:14:42 INFO - 2015-11-25 21:14:42,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 152735744 21:14:42 INFO - 2015-11-25 21:14:42,881 DEBUG : BROWSER_OUTPUT: 21:14:45 INFO - 2015-11-25 21:14:45,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:14:45 INFO - 2015-11-25 21:14:45,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 155389952 21:14:45 INFO - 2015-11-25 21:14:45,615 DEBUG : BROWSER_OUTPUT: 21:14:48 INFO - 2015-11-25 21:14:48,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56292/tests/kraken/driver.html?testName=imaging-darkroom) 21:14:49 INFO - 2015-11-25 21:14:49,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 155611136 21:14:49 INFO - 2015-11-25 21:14:49,098 DEBUG : BROWSER_OUTPUT: 21:14:52 INFO - 2015-11-25 21:14:52,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56292/tests/kraken/driver.html?testName=imaging-desaturate) 21:14:53 INFO - 2015-11-25 21:14:53,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 156610560 21:14:53 INFO - 2015-11-25 21:14:53,066 DEBUG : BROWSER_OUTPUT: 21:14:55 INFO - 2015-11-25 21:14:55,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56292/tests/kraken/driver.html?testName=json-parse-financial) 21:14:56 INFO - 2015-11-25 21:14:56,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 156549120 21:14:56 INFO - 2015-11-25 21:14:56,411 DEBUG : BROWSER_OUTPUT: 21:14:57 INFO - 2015-11-25 21:14:57,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:14:58 INFO - 2015-11-25 21:14:58,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 168136704 21:14:58 INFO - 2015-11-25 21:14:58,522 DEBUG : BROWSER_OUTPUT: 21:15:00 INFO - 2015-11-25 21:15:00,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:15:00 INFO - 2015-11-25 21:15:00,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 167673856 21:15:00 INFO - 2015-11-25 21:15:00,918 DEBUG : BROWSER_OUTPUT: 21:15:02 INFO - 2015-11-25 21:15:02,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:15:03 INFO - 2015-11-25 21:15:03,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 175849472 21:15:03 INFO - 2015-11-25 21:15:03,519 DEBUG : BROWSER_OUTPUT: 21:15:05 INFO - 2015-11-25 21:15:05,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:15:06 INFO - 2015-11-25 21:15:06,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 181440512 21:15:06 INFO - 2015-11-25 21:15:06,513 DEBUG : BROWSER_OUTPUT: 21:15:09 INFO - 2015-11-25 21:15:09,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:15:09 INFO - 2015-11-25 21:15:09,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 179130368 21:15:09 INFO - 2015-11-25 21:15:09,655 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56292/tests/kraken/driver.html?testName=ai-astar) 21:15:11 INFO - 2015-11-25 21:15:11,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 237940736 21:15:11 INFO - 2015-11-25 21:15:11,574 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,574 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;110;111;110;100;111;109;100 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;149;160;129;148;154;126;165;124 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;163;159;161;159;160;163;160;161 21:15:11 INFO - 2015-11-25 21:15:11,576 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;89;88;71;72;73;98;89;71 21:15:11 INFO - 2015-11-25 21:15:11,577 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;140;92;93;93;141;93;94;136 21:15:11 INFO - 2015-11-25 21:15:11,577 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;110;109;109;109 21:15:11 INFO - 2015-11-25 21:15:11,577 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;145;146;146;145;144;146;144 21:15:11 INFO - 2015-11-25 21:15:11,577 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;96;96;95;95;95 21:15:11 INFO - 2015-11-25 21:15:11,577 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;57;57;57;57;57;59;54 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;71;70;70;70;70;69;70;70;70 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;84;83;86;84;84;83;85;84 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;117;120;130;114;119;125;118;117;122 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;151;149;161;139;152;148;151;141 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;66;69;66;67;67;69;67 21:15:11 INFO - 2015-11-25 21:15:11,578 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:15:11 INFO - 2015-11-25 21:15:11,579 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:15:11 INFO - 2015-11-25 21:15:11,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 21:15:11 INFO - 2015-11-25 21:15:11,579 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:15:11 INFO - 2015-11-25 21:15:11,579 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514911573__endTimestamp 21:15:11 INFO - 2015-11-25 21:15:11,579 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:4.42 (4.0%) stddev-sans-first:4.61 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 110.0 111.0 110.0 100.0 111.0 109.0 100.0 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:151.50 stddev:16.08 (10.6%) stddev-sans-first:16.41 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 149.0 160.0 129.0 148.0 154.0 126.0 165.0 124.0 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 21:15:11 INFO - 2015-11-25 21:15:11,587 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 163.0 159.0 161.0 159.0 160.0 163.0 160.0 161.0 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:80.50 stddev:10.29 (12.8%) stddev-sans-first:10.44 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 89.0 88.0 71.0 72.0 73.0 98.0 89.0 71.0 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.27 (23.9%) stddev-sans-first:22.96 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 140.0 92.0 93.0 93.0 141.0 93.0 94.0 136.0 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 144.0 146.0 144.0 21:15:11 INFO - 2015-11-25 21:15:11,588 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,589 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:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 59.0 54.0 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 70.0 70.0 70.0 70.0 69.0 70.0 70.0 70.0 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 84.0 83.0 86.0 84.0 84.0 83.0 85.0 84.0 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,589 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.00 stddev:4.92 (4.1%) stddev-sans-first:4.84 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: Values: 126.0 117.0 120.0 130.0 114.0 119.0 125.0 118.0 117.0 122.0 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:150.00 stddev:6.80 (4.5%) stddev-sans-first:6.38 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 151.0 149.0 161.0 139.0 152.0 148.0 151.0 141.0 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 66.0 69.0 66.0 67.0 67.0 69.0 67.0 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:15:11 INFO - 2015-11-25 21:15:11,590 DEBUG : BROWSER_OUTPUT: 21:15:12 INFO - 2015-11-25 21:15:12,364 INFO : Browser exited with error code: 0 21:15:12 INFO - 2015-11-25 21:15:12,415 INFO : Completed test kraken (00:00:58) 21:15:12 INFO - 2015-11-25 21:15:12,415 INFO : Starting test v8_7 21:15:12 INFO - 2015-11-25 21:15:12,415 DEBUG : operating with platform_type : linux_ 21:15:12 INFO - 2015-11-25 21:15:12,415 INFO : Initialising browser for v8_7 test... 21:15:12 INFO - 2015-11-25 21:15:12,421 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY1hyoY/profile http://localhost:56292/getInfo.html 21:15:16 INFO - 2015-11-25 21:15:16,092 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:15:16 INFO - 2015-11-25 21:15:16,093 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:15:16 INFO - 2015-11-25 21:15:16,093 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:15:16 INFO - 2015-11-25 21:15:16,093 DEBUG : BROWSER_OUTPUT: __metrics 21:15:16 INFO - 2015-11-25 21:15:16,217 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:15:17 INFO - 2015-11-25 21:15:17,392 INFO : Browser initialized. 21:15:17 INFO - 2015-11-25 21:15:17,392 INFO : Running cycle 1/1 for v8_7 test... 21:15:17 INFO - 2015-11-25 21:15:17,393 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY1hyoY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:15:29 INFO - 2015-11-25 21:15:29,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 139255808 21:15:29 INFO - 2015-11-25 21:15:29,165 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56292/tests/v8_7/run.html (next: http://localhost:56292/tests/v8_7/run.html) 21:15:50 INFO - 2015-11-25 21:15:50,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 621486080 21:15:50 INFO - 2015-11-25 21:15:50,894 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,894 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:15:50 INFO - 2015-11-25 21:15:50,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:15:50 INFO - 2015-11-25 21:15:50,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:15:50 INFO - 2015-11-25 21:15:50,895 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:15:50 INFO - 2015-11-25 21:15:50,895 DEBUG : BROWSER_OUTPUT: |0;Richards;164.52780519907864 21:15:50 INFO - 2015-11-25 21:15:50,895 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.82175226586102 21:15:50 INFO - 2015-11-25 21:15:50,895 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 21:15:50 INFO - 2015-11-25 21:15:50,895 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |7;RegExp;25769.23076923077 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |8;Splay;677.3985833869929 21:15:50 INFO - 2015-11-25 21:15:50,896 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 21:15:50 INFO - 2015-11-25 21:15:50,897 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:15:50 INFO - 2015-11-25 21:15:50,897 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514950893__endTimestamp 21:15:50 INFO - 2015-11-25 21:15:50,897 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,897 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:15:50 INFO - 2015-11-25 21:15:50,898 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.53 Median:164.53 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: Values: 164.5 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.82 Median:188.82 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: Values: 188.8 21:15:50 INFO - 2015-11-25 21:15:50,899 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: Values: 279.6 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: Values: 5181.3 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,900 DEBUG : BROWSER_OUTPUT: Values: 1982.2 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: Values: 781.3 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: Values: 12180.7 21:15:50 INFO - 2015-11-25 21:15:50,901 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: Values: 25769.2 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.40 Median:677.40 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: Values: 677.4 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 21:15:50 INFO - 2015-11-25 21:15:50,902 DEBUG : BROWSER_OUTPUT: Values: 4826.9 21:15:50 INFO - 2015-11-25 21:15:50,903 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:15:50 INFO - 2015-11-25 21:15:50,903 DEBUG : BROWSER_OUTPUT: 21:15:51 INFO - 2015-11-25 21:15:51,704 INFO : Browser exited with error code: 0 21:15:51 INFO - 2015-11-25 21:15:51,716 INFO : Completed test v8_7 (00:00:39) 21:15:51 INFO - 2015-11-25 21:15:51,844 INFO : Completed test suite (00:20:10) 21:15:51 INFO - 2015-11-25 21:15:51,844 DEBUG : Working with test: dromaeo_css 21:15:51 INFO - 2015-11-25 21:15:51,844 DEBUG : Generating results file: dromaeo_css 21:15:51 INFO - 2015-11-25 21:15:51,845 DEBUG : Working with test: kraken 21:15:51 INFO - 2015-11-25 21:15:51,845 DEBUG : Generating results file: kraken 21:15:51 INFO - 2015-11-25 21:15:51,846 INFO : javascript benchmark 21:15:51 INFO - 2015-11-25 21:15:51,846 DEBUG : Working with test: v8_7 21:15:51 INFO - 2015-11-25 21:15:51,846 DEBUG : Generating results file: v8_7 21:15:51 INFO - 2015-11-25 21:15:51,846 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:51 INFO - 2015-11-25 21:15:51,986 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 21:15:51 INFO - 2015-11-25 21:15:51,987 DEBUG : process_Request line: dromaeo_css 6958.94 graph.html#tests=[[72,64,35]] 21:15:51 INFO - 2015-11-25 21:15:51,987 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:52 INFO - 2015-11-25 21:15:52,109 DEBUG : process_Request line: kraken 1494.90 graph.html#tests=[[232,64,35]] 21:15:52 INFO - 2015-11-25 21:15:52,109 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:52 INFO - 2015-11-25 21:15:52,142 DEBUG : process_Request line: v8_7 19676.48 graph.html#tests=[[230,64,35]] 21:15:52 INFO - 2015-11-25 21:15:52,143 INFO : javascript benchmark 21:15:52 INFO - 2015-11-25 21:15:52,146 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3200.9756877799105, 3251.756118291126, 3278.1804548862783, 3281.491368837831, 3294.6375898651145, 5195.324607800981, 5319.20211968204, 5371.793592174865, 5425.457454254578, 5432.348118225814, 5360.2763626910355, 5402.405735369106, 5424.159255315432, 5517.972410137943, 5521.0, 4951.23255895335, 4967.726775027372, 4984.32711583937, 4986.127427700156, 5006.22403527452, 5025.422076461217, 5038.143515602356, 5098.898022039557, 5101.51535604117, 5109.642325037249, 4734.834280800173, 4838.709677419331, 4840.661153719258, 4940.308356830046, 4953.182724850395, 4999.150144475448, 5038.622103342264, 5043.092243396187, 5049.015441988814, 5090.821821236239, 4636.768161591907, 5008.9499105008845, 5011.699298042093, 5025.271335656346, 5074.923876141861, 5097.286379906779, 5147.073526765181, 5196.818111366084, 5199.584033277329, 5233.162693968985, 5846.0, 5868.178455016301, 5877.471027607493, 5880.647161170344, 5882.0, 5682.715864206814, 5844.620099693507, 5893.941060589382, 5900.498457631106, 5905.822825315247, 5278.868028299285, 5412.323459567554, 5427.3758517770175, 5427.3758517770175, 5428.077226871442, 5978.3124940631515, 5989.940100599026, 6041.818745437644, 6050.183225264621, 6051.243594550681, 5781.19063331134, 5789.913151302734, 5792.88414231713, 5795.246617939725, 5796.826095217066, 5529.502344788988, 5708.343540492813, 5714.79998200061, 5850.765969361178, 5989.970050149721, 5841.065429531254, 5871.530277577784, 5894.233749612608, 5894.469497745138, 5897.144913987448, 5889.499392551681, 5905.527557795366, 5910.202122713465, 5911.674857882857, 5915.053591425351, 4332.740035597874, 4433.334999749999, 4445.5776701213335, 4509.751963642031, 4540.931886021713, 4063.349864021742, 4066.1054567994993, 4069.593040695907, 4105.651019663303, 4114.238865809834, 5351.866203344947, 5600.159976003551, 5602.075657516546, 5602.635828671123, 5613.607047506717, 5736.168255602997, 5748.7125643717645, 5800.477956983892, 5858.150568167592, 5865.178874957509, 5568.470995255525, 5584.720763961867, 5592.552595792326, 5592.692401917852, 5596.972015139898, 5156.381234251839, 5158.948410515922, 5160.174372100446, 5161.7677204525135, 5201.817936372285, 5842.065269556851, 5960.254968128984, 5967.8209653710455, 5970.0, 6021.668808215591, 5907.9704601476715, 5925.911111333419, 5934.109883517507, 5935.169076329231, 5943.049112142036, 6064.423879731418, 6105.053716673922, 6107.786227482017, 6137.324894261538, 6142.078688196806, 5592.3009623797025, 5706.514946229617, 5707.0, 5708.400617935057, 5735.254416925773, 5784.942150578609, 5873.295204575478, 5877.73550190251, 5900.409959004065, 5902.645841249367, 5821.563382746395, 5835.416458354301, 5839.620424672383, 5843.065109582446, 5853.2976042875125, 5763.625364351304, 5813.09896965971, 5820.679862607597, 5822.097574875901, 5824.068149096124, 5367.0, 5455.8363249102595, 5470.972645136749, 5472.288602481652, 5573.359063707563, 5686.488216060575, 5744.798932037359, 5775.1914731938405, 5798.217240672455, 5869.941300586939, 5668.404817494269, 5674.205611214351, 5676.262085928803, 5681.9431805681415, 5682.119271512922], "unit": "ms", "name": "dojo.html", "value": 5396.257842393695}, {"lowerIsBetter": false, "replicates": [550.3340957441495, 595.2589026661807, 596.0046721974304, 602.5240060352322, 614.8124821929315, 31831.204219894513, 32410.18974525638, 32475.837620811893, 32491.02526924193, 40302.39546406799, 43757.34363984543, 44161.33757993633, 44254.0, 44263.336049959194, 44307.0, 8720.781980450492, 8871.201591856732, 8880.28957683387, 8882.422642528216, 8883.51140687262, 7997.920020799776, 8153.714619988302, 10607.946960265188, 10823.0, 10825.512851921683, 10443.0, 10538.841917371246, 10541.894581054206, 10544.209184311168, 10548.894511054868, 7996.64015119321, 8143.307818835406, 10489.737756556071, 10590.41752703601, 10591.364518128898, 7829.491083079582, 10522.631707890263, 10701.304415212986, 10726.141908647289, 10735.302205356627, 39714.404283935764, 40495.1900961982, 40508.0, 40512.392314115314, 40550.39174412386, 3373.190434295776, 3465.549478567795, 3783.4324851272254, 3930.8231129599235, 4235.3646952957, 30317.696823031707, 30813.537796933066, 31019.844900775577, 31236.531452028237, 31680.841595792102, 3911.4915061041884, 3951.4072889066583, 3973.721839471238, 4044.1102957349335, 4045.575214602454, 278438.0, 278564.0, 279046.0, 281149.0, 281554.99999999796, 58787.412125878196, 60009.699951500836, 62120.68939655273, 62588.37411625917, 62706.0, 58810.0, 58822.70588647029, 59138.0, 59142.40857591455, 59198.40801592015, 15563.688726225411, 15900.840991590167, 15922.283497242652, 15934.840651593335, 15943.521694349189, 12257.938710306391, 12274.0, 12323.445444955, 12328.50685972569, 12330.753384932252, 20126.89936550308, 20824.791752082587, 20848.687269690967, 20899.582008360052, 20943.37169884906, 7451.180370159278, 7557.962210188914, 7585.544867307979, 7609.277118673717, 7722.459427839997, 951.8762560867043, 974.3228456222857, 989.6387818446216, 1008.9899101009042, 1089.8201796703613, 28605.0, 29173.56239656407, 29234.415311694072, 29389.853050734608, 29600.0, 1040.5265604150093, 1115.0912006714502, 1125.9067872403987, 1181.385967439859, 1189.4528516882158, 14830.703385932437, 14957.90828959101, 14991.2504374783, 15006.0, 15016.924915375572, 310918.0, 311191.0, 312627.0, 312890.0, 313011.0, 51917.22124168141, 51985.7400712994, 52165.47834521606, 52181.217281740806, 52226.0, 1368.1449094316054, 1380.9343257967496, 1384.8338199416135, 1387.1607677355055, 1387.9722405551831, 27817.582736258566, 28628.42743145167, 28867.0, 28889.0, 28970.275743105747, 47136.52863471459, 47491.762541187076, 47892.76053619709, 47919.0, 47938.280925785446, 294696.0, 296158.0, 296915.0, 297040.0, 297171.0, 28608.0, 29102.0, 31778.682213178497, 32342.514862276614, 32950.176245594055, 39334.60665393309, 39381.2123757529, 40226.79886600548, 40344.19311613693, 40346.394804077376, 32965.34069318648, 33110.5033424494, 33702.662973370934, 33935.490967635014, 34144.65855341415, 32045.519317209793, 33552.0, 35759.0, 36769.0, 37064.44403333898, 34609.65390346065, 34653.48019779655, 35965.82017089898, 36212.456813148354, 36705.26589468249, 29464.0, 30553.388932221675, 33176.66823331832, 34241.65758342385, 34329.485057724654, 25378.365540861625, 25662.871685641454, 25757.098501552355, 25757.871210643825, 25837.0], "unit": "ms", "name": "ext.html", "value": 18885.683427886597}, {"lowerIsBetter": false, "replicates": [337.8293961549417, 339.3416771463361, 339.6196260188589, 341.71808258186985, 342.9434143366345, 14203.360848761804, 14623.561293161196, 16616.58458538537, 16754.664906701873, 18775.34286299978, 16296.266667999938, 16438.260278287475, 16502.504924852245, 16861.66276674466, 16889.23998420071, 5053.772580233889, 5151.175811870102, 5157.355330583677, 5162.174052151657, 5170.870728231786, 3920.8039598020127, 3993.3011722948368, 5123.692578445287, 5898.085796701518, 6055.486128467883, 5926.170336152942, 5937.406259374071, 5972.522198224132, 5983.222181116471, 6009.1587177795145, 5684.090545512719, 5758.309002919635, 5763.39484354143, 5764.279465066867, 5770.2210201622665, 4985.626078044161, 5022.447530771612, 5026.8240611578785, 5031.0, 5052.115879721034, 21175.576488470146, 21388.893055534623, 21417.0, 21461.248856289956, 21718.348449546538, 2150.7204063471804, 2270.693456383384, 2288.439332363565, 2300.7814257645496, 2306.6770652108717, 9012.41419307743, 9370.062993700643, 13209.471621135142, 13512.797308040388, 13627.659308517268, 1772.4151030160017, 1837.935672251478, 1838.8712790104698, 1850.6391253705533, 1858.9628207435776, 59110.40889591092, 59976.40023599796, 61179.0, 61304.69347653233, 62482.68758656223, 8865.911340886638, 8869.157430044135, 8920.509371984474, 8928.553572321358, 9080.59137338808, 11629.418529073513, 11698.766024679458, 11700.70748231284, 11725.120615953838, 11725.35510546911, 7339.70641174347, 7516.0, 7530.171681115073, 7604.80987975305, 7621.31408173256, 7403.259674032553, 7428.517146385468, 7448.255174482509, 7480.625968701544, 7550.509216900884, 3871.05159235989, 3950.802459877052, 3967.4643923070594, 3980.283548961215, 4150.979245103756, 1686.3844696685621, 1758.648270345936, 2815.001349042203, 2998.250437390652, 3152.243461569207, 918.7886786039114, 938.3947353956796, 1003.1022235099545, 1017.7964407118458, 1080.9729756756144, 16837.32650693983, 17572.560685982953, 17868.910655446638, 18065.909670451827, 18099.72850407245, 917.0, 919.4896832258161, 939.3283802081545, 955.073578628729, 963.5074043664499, 7764.611769411506, 10082.596696132072, 10093.0, 10107.39355638664, 10156.4921753912, 506823.7270509212, 508835.0, 510068.0, 519475.0, 522413.0, 78609.60695196487, 79693.20306796858, 80108.19891801124, 80538.59730701309, 80760.59619701981, 1081.1837063017372, 1084.3006260961636, 1087.5160553553592, 1097.983530247047, 1098.9725256868483, 15634.9218253908, 15673.451429199924, 15848.44530441429, 15894.682106357577, 16097.67804643924, 36519.63480365268, 36977.713788655456, 37350.439743404415, 37843.81078094592, 38268.32121751451, 49834.50165498299, 49936.0, 50022.0, 50336.979781213246, 52785.0, 9618.0, 9662.420254784736, 9698.466584337646, 9770.85343719859, 9788.216942644429, 9598.088181622734, 9935.105840474393, 10382.636607718694, 10615.734606634896, 11358.26171298863, 10086.495675216356, 10157.238207134642, 10161.288709790244, 10336.948315258376, 10344.069033786995, 10056.195504359488, 10126.696199114038, 10185.185185185019, 10214.846777298199, 10236.027577380137, 10160.644377446753, 10278.588856445958, 10457.790844182922, 10486.737831554272, 10539.314944528582, 13898.374573144434, 14603.70792584121, 14730.705385892437, 14977.400903964155, 15345.539633811004, 15565.84434155644, 15866.52400427989, 15881.285342159861, 16285.0, 16470.67058658844], "unit": "ms", "name": "jquery.html", "value": 8749.728307733982}, {"lowerIsBetter": false, "replicates": [1286.5175559165314, 1430.3706369197553, 1475.5352064099804, 1586.3654538184724, 1734.904580248086, 6311.084892690563, 7034.683439245234, 7287.453440991921, 7294.270572942703, 7297.927020729791, 7280.817979550514, 7460.0, 7460.216677248892, 7461.5523068615785, 7461.776146715593, 1915.6456055629753, 1977.7824439311664, 1981.0490964337127, 2177.8366622503295, 2214.689943407924, 2203.867767933921, 2249.910003599854, 2250.032486031006, 2251.448395143184, 2251.9887400562975, 2153.8923053847325, 2188.627933251343, 2200.7359116905996, 2202.4714068623575, 2204.2505548113636, 1913.253831005902, 1951.063489525029, 1952.4825921130912, 2151.7202763640626, 2203.713517242756, 2209.591225623265, 2214.734231892167, 2215.8227341812617, 2217.090992692988, 2218.5119273759747, 7100.644967751643, 7169.856602867913, 7177.282271772833, 7182.42540596751, 7182.42540596751, 4434.379186913835, 4484.618807401374, 4499.280115181556, 4502.144592527409, 4516.051629157881, 2973.6580293266334, 2978.2107741448535, 3060.785744997851, 3065.2490139915863, 3099.3336432667083, 1007.6473234367986, 1029.891861354562, 1049.8792638846553, 1050.669039252633, 1064.255021484956, 9625.229981601455, 9625.60428737836, 9665.275104367201, 9676.274279429072, 9715.514224288758, 4009.4186342980106, 4061.735987160825, 4097.590240975878, 4098.303288440972, 4146.606072423176, 8280.71017514384, 8285.461445006054, 8333.416660833806, 8334.374921880883, 8362.874556881652, 4491.842785502492, 4494.213512635276, 4503.684742068024, 4507.166174257773, 4509.932351014738, 4058.837646494166, 4058.898527536835, 4081.795910204478, 4087.3051581230666, 4092.4270602115726, 3524.5770507538746, 3541.15012397028, 3551.893443196708, 3592.497050412944, 3598.4962105305276, 1140.5551834784442, 1162.6918866500384, 1164.1618035014776, 1172.1384782185087, 1178.7171078941165, 1029.46467836726, 1038.231708535678, 1045.2526443592715, 1268.194696367813, 1269.0862578943147, 6840.521163518605, 6844.4182244508775, 6931.514793964374, 6944.375006249462, 6949.7567585134275, 482.85755702067974, 489.82856000399573, 492.61329856063537, 495.52731867978525, 495.8983408401341, 5067.695938243717, 5180.0, 5524.558035357162, 5693.146028095819, 5694.288213973254, 8377.6230069647, 8491.575421228914, 8496.277816385676, 8532.914670853335, 8771.868421973675, 8613.913860861436, 8633.22300992901, 8692.434991725517, 8726.214640682241, 8741.34439916996, 6886.48351373649, 6910.378065973986, 6942.236354001056, 7003.509754317251, 7063.6821343038655, 6853.4859885507785, 6894.655267236518, 6908.3091690830515, 6916.688749006206, 6928.965355173394, 7718.073831140299, 7735.149133595412, 7931.325837303893, 7945.602719863868, 7964.0, 7945.48354356965, 8014.398920080901, 8029.919700802917, 8087.797805054921, 8178.141295163922, 6311.368863113652, 6353.9046914295395, 6417.294097649348, 6426.935730642821, 6435.324290949383, 6701.899471507833, 6757.425618822455, 6768.052472653931, 6780.118584583973, 6782.1861376635115, 6313.337099604659, 6409.294977552372, 6494.220693516808, 6504.934950650433, 6509.218893732783, 6379.234491861006, 6398.296187419473, 6403.423691867568, 6487.416132548094, 6547.1161393213215, 6469.611823290617, 6490.286068532363, 6496.967515162394, 6500.28496865335, 6504.1869766279215, 5995.430434108753, 6038.0, 6046.7581296749395, 6050.183225264709, 6058.4244496772735, 5576.665400076008, 5983.102534619842, 6125.877482450415, 6132.754689812357, 6139.508839292756], "unit": "ms", "name": "mootools.html", "value": 4150.945499885278}, {"lowerIsBetter": false, "replicates": [314.4026349935124, 317.59189441567577, 321.73778370627934, 322.1222169587872, 324.3140757298315, 6070.180525629039, 6095.969520152393, 6102.786402475915, 6104.1759362486055, 6155.507559395249, 5734.0, 5798.217240672508, 5843.532517398608, 6012.428819262174, 6028.879422411549, 4582.633389328846, 4592.7014744041535, 4593.471750748657, 4607.562281583244, 4615.376924115252, 4379.868603941887, 4583.152116858392, 4594.104149690812, 4603.539646035403, 4612.0545288215835, 4411.183930972764, 4466.12910482456, 4535.206338890681, 4557.2708366661345, 4568.703034302776, 4529.252673308933, 4541.500434952152, 4545.318202269653, 4555.476120246181, 4560.475545312282, 3942.310095733264, 3946.2304850554156, 3948.0, 3951.0714981979213, 3962.6235507627016, 5626.6624002559565, 5760.913586296167, 5761.769529218826, 5766.971165144148, 5771.307443106812, 5309.840704778863, 5311.336082989626, 5320.600954928357, 5322.068637988336, 5327.627066105374, 6353.30113687494, 6361.554691171574, 6368.554201205918, 6371.267304259976, 6385.138006369174, 4410.955890441119, 4414.735115893057, 4416.359627853975, 4418.602325790662, 4421.778911054466, 6510.837229069264, 6675.766348177839, 6678.332166783282, 6683.2314283857, 6684.699188536479, 4403.867883963486, 4423.756693381831, 4430.091831174602, 4430.734155950653, 4433.578810013044, 4483.21543729846, 4484.215262329079, 4484.439445069366, 4485.977570112129, 4489.842855500107, 5251.737413129328, 5259.289995850511, 5259.710715910662, 5264.42091369949, 5268.841934741964, 6298.779542715983, 6380.489560835122, 6452.35476452351, 6472.029195620695, 6475.222973243241, 1564.0381165583312, 1571.7720930465018, 1573.0, 1579.565619454659, 1584.595928038343, 1021.9729172182058, 1026.3072426112344, 1030.5517100061497, 1038.4288641247283, 1054.4147997861107, 6215.96892015537, 6221.06683997395, 6225.564210505221, 6228.4705800007505, 6234.1583886174785, 6643.1031810704935, 6644.202695676549, 6645.933540664628, 6647.5679080860555, 6666.96666516674, 6073.908891366633, 6164.630122192593, 6177.96911015442, 6289.0880822280515, 6292.0, 3610.458431235283, 3621.257642183346, 3625.3111908737255, 3626.0, 3630.7458477906293, 6722.092517510171, 6752.763653272112, 6753.324667533306, 6762.763303284361, 6834.555753875982, 6681.2650608434005, 6840.213375461786, 6845.691943862438, 6869.900815869537, 6881.793546193622, 6940.895886561706, 6945.305469453015, 6957.965210173917, 6958.234594194634, 6958.47811414146, 6707.698153583003, 6713.697883595152, 6715.328467153441, 6719.731210751515, 6722.294159113419, 6433.517486188461, 6627.900581491185, 6633.2040155181685, 6646.235682896336, 6651.7006734698025, 6942.028116063856, 6944.062551555476, 6946.722131114699, 6948.5483443576, 6955.1653801544135, 4399.054203346296, 4425.867223983286, 4429.269170586817, 4429.512753597166, 4433.955660443355, 6521.902171467337, 6658.067870498231, 6681.832954176184, 6690.13028306317, 6698.531102822755, 6526.314736952741, 6527.05357723118, 6532.967335163294, 6533.346665333429, 6540.37866402691, 6519.576227545194, 6522.804315870531, 6523.902141467976, 6524.902126468011, 6525.2822189558165, 6259.749610015549, 6356.0, 6367.395097465734, 6373.171487706569, 6374.808755737336, 6544.3782840630065, 6576.967115164393, 6579.17760279965, 6579.572327798678, 6579.934200657932, 6240.937590624218, 6339.619622822645, 6398.744050237939, 6411.3909178627955, 6417.1657684500715], "unit": "ms", "name": "prototype.html", "value": 4813.989572104562}, {"lowerIsBetter": false, "replicates": [716.953398029128, 731.6268702961488, 786.4573444323416, 809.259527532308, 887.8268737596168, 13720.862791372083, 13824.239666818321, 13880.097793643406, 13921.582352529414, 13980.161190328587, 14615.0, 14747.0, 14779.187144707037, 14779.926100369483, 14803.33384997675, 694.7846167688033, 711.9750808721695, 841.1084250694269, 843.7637461510786, 862.2326129744532, 849.8130411309533, 854.0690647194557, 856.220839036477, 857.0187135729586, 858.1675774498726, 729.4638440746047, 893.0845882969943, 893.3969570539892, 893.63361021981, 894.883665123533, 729.0267492896962, 868.7871471489494, 876.7764220123892, 882.642529775442, 883.0374891368439, 642.3415998601424, 646.3052218864739, 648.9935100649028, 650.6941737383422, 651.7555916531301, 13534.187948723109, 13626.523071692542, 13689.86310136896, 13704.24626645534, 13736.725265494733, 11978.341191234478, 12162.635120946386, 12206.572769953098, 12435.12954093214, 12590.43343049565, 10064.144547713453, 10672.573097076107, 10750.354978701303, 10817.134629229642, 10877.238593298473, 3561.394562924309, 3635.8182090895616, 3641.6540428659237, 3649.872254471081, 3672.100335417813, 48833.26750098752, 48970.26544601834, 49125.50874491281, 49309.01381972376, 49684.254736178984, 9273.443593384283, 9533.52332383378, 9613.086756758097, 9796.461194634221, 9886.555105020292, 17949.820501795075, 17969.550761230814, 18007.279708811762, 18009.459716208534, 18014.459566213034, 7445.925540744632, 7486.588237646982, 7636.427267954815, 7850.332721718603, 7960.0, 4229.873103806891, 4331.155424692155, 4442.089371678798, 4457.598816106566, 4512.029913568598, 3026.576279320897, 3052.4810782167083, 3057.342671325676, 3057.357954829466, 3058.816471011702, 515.6673945305332, 523.500057445139, 526.9314989051476, 535.4832586553994, 549.198170670817, 628.8522197283635, 654.7282877605741, 662.5792621685265, 675.6317806795308, 693.0470602920983, 8489.617967191367, 8957.0, 9092.545372731336, 9098.272138228926, 9389.201917836925, 495.96776209546266, 650.8080116365588, 652.9575577587536, 675.6858061001658, 697.7348607529208, 3763.774173549541, 3897.666450459704, 4078.7960601969785, 4143.295639741251, 4224.0, 57196.0, 63700.36299637037, 63932.36067639357, 64007.0, 64038.0, 51634.74182629063, 53581.196282055804, 53582.464175358524, 53939.730301348245, 54977.45022549723, 46867.0, 47295.29057064147, 48089.5191048092, 48125.0, 48349.75825120852, 7842.393068491053, 7922.366210703015, 7964.641591128529, 8127.837443250984, 8263.917360826315, 34068.488972665924, 34194.82902585471, 34803.477947830295, 36108.09729756777, 37343.0, 42510.787446062575, 42696.35955460733, 43422.0, 44455.0, 46256.0, 10623.150147988297, 11349.773004540028, 11364.374959377314, 11534.1926065178, 11741.706457338294, 11971.16201865861, 12058.75882482363, 12171.2697238166, 12241.571544995883, 12281.692957675772, 10720.19598530129, 11051.113395682007, 11410.315381077162, 11678.182527223353, 12046.698832529257, 11403.372814495282, 11570.421478926188, 11690.649280521598, 12053.276803391824, 12061.51753929833, 11091.50088246047, 11381.658550243506, 11527.423628818693, 11771.014881351428, 11864.11019173548, 9450.393144709979, 9671.17794987434, 9685.9031409685, 10058.798824023625, 10287.382757034602, 8570.74287771368, 8776.91223087761, 9297.581608827755, 9590.136887680143, 9604.75988100303], "unit": "ms", "name": "yui.html", "value": 6372.9891397761785}], "name": "dromaeo_css", "value": 6958.935745655016}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 110.0, 111.0, 110.0, 100.0, 111.0, 109.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 149.0, 160.0, 129.0, 148.0, 154.0, 126.0, 165.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 163.0, 159.0, 161.0, 159.0, 160.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 89.0, 88.0, 71.0, 72.0, 73.0, 98.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 140.0, 92.0, 93.0, 93.0, 141.0, 93.0, 94.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 144.0, 146.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 59.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 83.0, 86.0, 84.0, 84.0, 83.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [126.0, 117.0, 120.0, 130.0, 114.0, 119.0, 125.0, 118.0, 117.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 151.0, 149.0, 161.0, 139.0, 152.0, 148.0, 151.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 66.0, 69.0, 66.0, 67.0, 67.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1494.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.52780519907864], "unit": "score", "name": "Richards", "value": 214.56555600000002}, {"lowerIsBetter": false, "replicates": [188.82175226586102], "unit": "score", "name": "DeltaBlue", "value": 350.16092799999996}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25769.23076923077], "unit": "score", "name": "RegExp", "value": 35.3516567164179}, {"lowerIsBetter": false, "replicates": [677.3985833869929], "unit": "score", "name": "Splay", "value": 120.29992680608363}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19676.478136871556}]} 21:15:52 INFO - RETURN: dromaeo_css: 6958.94 21:15:52 INFO - RETURN: kraken: 1494.90 21:15:52 INFO - RETURN: v8_7: 19676.48 21:15:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19676.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6958.94"}}} 21:15:52 INFO - Return code: 0 21:15:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:15:52 INFO - # TBPL SUCCESS # 21:15:52 INFO - Running post-action listener: _resource_record_post_action 21:15:52 INFO - Running post-run listener: _resource_record_post_run 21:15:53 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 81920; Write bytes: 511688704; Read time: 44; Write time: 441724 21:15:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 247570432; Read time: 0; Write time: 303644 21:15:53 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 81920; Write bytes: 264118272; Read time: 44; Write time: 138080 21:15:53 INFO - Running post-run listener: _upload_blobber_files 21:15:53 INFO - Blob upload gear active. 21:15:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:15:53 INFO - Copying logs to upload dir... 21:15:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.371138 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-25 21:15:52.974378) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:52.977800) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009926 build_url: 'https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/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:15:53.029643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:53.029981) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448513180.874102-14937633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:53.080523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:15:53.080860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:15:53.081179) ========= ========= Total master_lag: 0.57 =========