builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1448304517.76 results: success (0) buildid: 20151123083122 builduid: 166a724ce7554a29a834d04db32ec956 revision: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.757180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.757912) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.758262) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007292 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.781036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.781328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.806259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.806624) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004736 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.857043) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.857341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.857694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:37.857959) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 10:48:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-23 10:48:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:38.011103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:38.011392) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021954 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:38.080005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:48:38.080676) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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 bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 10:48:38,833 truncating revision to first 12 chars 2015-11-23 10:48:38,833 Setting DEBUG logging. 2015-11-23 10:48:38,833 attempt 1/10 2015-11-23 10:48:38,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfd81e42d1dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 10:48:39,519 unpacking tar archive at: fx-team-bfd81e42d1dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973708 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:48:39.080862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:39.081171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:39.093115) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:39.093497) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:48:39.094052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 10:48:39.094646) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:48:39 INFO - MultiFileLogger online at 20151123 10:48:39 in /builds/slave/test-pgo 10:48:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 10:48:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:48:39 INFO - {'append_to_log': False, 10:48:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:48:39 INFO - 'blob_upload_branch': 'Fx-Team', 10:48:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:48:39 INFO - 'branch': 'Fx-Team', 10:48:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:48:39 INFO - 'config_files': ('talos/linux_config.py',), 10:48:39 INFO - 'default_actions': ('clobber', 10:48:39 INFO - 'read-buildbot-config', 10:48:39 INFO - 'download-and-extract', 10:48:39 INFO - 'populate-webroot', 10:48:39 INFO - 'create-virtualenv', 10:48:39 INFO - 'install', 10:48:39 INFO - 'run-tests'), 10:48:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:48:39 INFO - 'download_minidump_stackwalk': True, 10:48:39 INFO - 'download_symbols': 'ondemand', 10:48:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:48:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:48:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:48:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:48:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:48:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:48:39 INFO - 'installer_path': 'installer.exe', 10:48:39 INFO - 'log_level': 'info', 10:48:39 INFO - 'log_name': 'talos', 10:48:39 INFO - 'log_to_console': True, 10:48:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:48:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:48:39 INFO - 'opt_config_files': (), 10:48:39 INFO - 'pip_index': False, 10:48:39 INFO - 'sps_profile': False, 10:48:39 INFO - 'sps_profile_interval': 0, 10:48:39 INFO - 'suite': 'dromaeojs-e10s', 10:48:39 INFO - 'system_bits': '64', 10:48:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:48:39 INFO - 'title': 'talos-linux64-ix-017', 10:48:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:48:39 INFO - 'use_talos_json': True, 10:48:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:48:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:48:39 INFO - 'work_dir': 'build'} 10:48:39 INFO - ##### 10:48:39 INFO - ##### Running clobber step. 10:48:39 INFO - ##### 10:48:39 INFO - Running pre-action listener: _resource_record_pre_action 10:48:39 INFO - Running main action method: clobber 10:48:39 INFO - rmtree: /builds/slave/test-pgo/build 10:48:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:48:40 INFO - Running post-action listener: _resource_record_post_action 10:48:40 INFO - ##### 10:48:40 INFO - ##### Running read-buildbot-config step. 10:48:40 INFO - ##### 10:48:40 INFO - Running pre-action listener: _resource_record_pre_action 10:48:40 INFO - Running main action method: read_buildbot_config 10:48:40 INFO - Using buildbot properties: 10:48:40 INFO - { 10:48:40 INFO - "properties": { 10:48:40 INFO - "buildnumber": 352, 10:48:40 INFO - "product": "firefox", 10:48:40 INFO - "script_repo_revision": "production", 10:48:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:48:40 INFO - "repository": "", 10:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:48:40 INFO - "buildid": "20151123083122", 10:48:40 INFO - "slavename": "talos-linux64-ix-017", 10:48:40 INFO - "pgo_build": "True", 10:48:40 INFO - "basedir": "/builds/slave/test-pgo", 10:48:40 INFO - "project": "", 10:48:40 INFO - "platform": "ubuntu64_hw", 10:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:48:40 INFO - "slavebuilddir": "test", 10:48:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:48:40 INFO - "branch": "fx-team", 10:48:40 INFO - "repo_path": "integration/fx-team", 10:48:40 INFO - "stage_platform": "linux64-pgo", 10:48:40 INFO - "builduid": "166a724ce7554a29a834d04db32ec956", 10:48:40 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:48:40 INFO - }, 10:48:40 INFO - "sourcestamp": { 10:48:40 INFO - "repository": "", 10:48:40 INFO - "hasPatch": false, 10:48:40 INFO - "project": "", 10:48:40 INFO - "branch": "fx-team-linux64-pgo-talos", 10:48:40 INFO - "changes": [ 10:48:40 INFO - { 10:48:40 INFO - "category": null, 10:48:40 INFO - "files": [ 10:48:40 INFO - { 10:48:40 INFO - "url": null, 10:48:40 INFO - "name": "https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:48:40 INFO - } 10:48:40 INFO - ], 10:48:40 INFO - "repository": "", 10:48:40 INFO - "rev": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92", 10:48:40 INFO - "who": "sendchange", 10:48:40 INFO - "when": 1448304482, 10:48:40 INFO - "number": 6696209, 10:48:40 INFO - "comments": "", 10:48:40 INFO - "project": "", 10:48:40 INFO - "at": "Mon 23 Nov 2015 10:48:02", 10:48:40 INFO - "branch": "fx-team-linux64-pgo-talos", 10:48:40 INFO - "revlink": "", 10:48:40 INFO - "properties": [ 10:48:40 INFO - [ 10:48:40 INFO - "buildid", 10:48:40 INFO - "20151123083122", 10:48:40 INFO - "Change" 10:48:40 INFO - ], 10:48:40 INFO - [ 10:48:40 INFO - "builduid", 10:48:40 INFO - "166a724ce7554a29a834d04db32ec956", 10:48:40 INFO - "Change" 10:48:40 INFO - ], 10:48:40 INFO - [ 10:48:40 INFO - "pgo_build", 10:48:40 INFO - "True", 10:48:40 INFO - "Change" 10:48:40 INFO - ] 10:48:40 INFO - ], 10:48:40 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:48:40 INFO - } 10:48:40 INFO - ], 10:48:40 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:48:40 INFO - } 10:48:40 INFO - } 10:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:48:40 INFO - Running post-action listener: _resource_record_post_action 10:48:40 INFO - ##### 10:48:40 INFO - ##### Running download-and-extract step. 10:48:40 INFO - ##### 10:48:40 INFO - Running pre-action listener: _resource_record_pre_action 10:48:40 INFO - Running main action method: download_and_extract 10:48:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:48: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')]} 10:48:40 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json 10:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json 10:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:48:46 INFO - Downloaded 1302 bytes. 10:48:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:48:46 INFO - Using the following test package requirements: 10:48:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:48:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'jsshell-linux-x86_64.zip'], 10:48:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:48:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:48:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:48:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:48:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:48:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:46 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:47 INFO - Downloaded 22525651 bytes. 10:48:47 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 10:48:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:47 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 10:48:48 INFO - Return code: 0 10:48:48 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 10:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:48 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:50 INFO - Downloaded 22525651 bytes. 10:48:50 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 10:48:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:48:50 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 10:48:51 INFO - Return code: 0 10:48:51 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')]} 10:48:51 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:52 INFO - Downloaded 11130997 bytes. 10:48:52 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 10:48:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:52 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 10:48:53 INFO - Return code: 0 10:48: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')]} 10:48:53 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:48:54 INFO - Downloaded 57562603 bytes. 10:48:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:48:54 INFO - mkdir: /builds/slave/test-pgo/properties 10:48:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:48:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:48:54 INFO - Contents: 10:48:54 INFO - build_url:https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:48:54 INFO - Running post-action listener: _resource_record_post_action 10:48:54 INFO - Running post-action listener: set_extra_try_arguments 10:48:54 INFO - ##### 10:48:54 INFO - ##### Running populate-webroot step. 10:48:54 INFO - ##### 10:48:54 INFO - Running pre-action listener: _resource_record_pre_action 10:48:54 INFO - Running main action method: populate_webroot 10:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:48:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:48:54 INFO - '../fennec_ids.txt'], 10:48:54 INFO - 'tests': ['tcheck2']}, 10:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:48:54 INFO - '--tppagecycles', 10:48:54 INFO - '7'], 10:48:54 INFO - 'tests': ['tsvgm']}}, 10:48:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:48:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:48:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:48:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'tests': ['damp', 'tps']}, 10:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['damp', 'tps']}, 10:48:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:48:54 INFO - 'other': {'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'other_l64': {'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'other_nol64': {'tests': ['a11yr', 10:48:54 INFO - 'ts_paint', 10:48:54 INFO - 'tpaint', 10:48:54 INFO - 'sessionrestore', 10:48:54 INFO - 'sessionrestore_no_auto_restore']}, 10:48:54 INFO - 'svgr': {'tests': ['tsvgx', 10:48:54 INFO - 'tsvgr_opacity', 10:48:54 INFO - 'tart', 10:48:54 INFO - 'tscrollx', 10:48:54 INFO - 'cart']}, 10:48:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['tsvgx', 10:48:54 INFO - 'tsvgr_opacity', 10:48:54 INFO - 'tart', 10:48:54 INFO - 'tscrollx', 10:48:54 INFO - 'cart']}, 10:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'tests': ['tp5o']}, 10:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'talos_options': ['--e10s'], 10:48:54 INFO - 'tests': ['tp5o']}, 10:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'talos_options': ['--xperf_path', 10:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:54 INFO - 'tests': ['tp5n']}, 10:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:54 INFO - 'talos_options': ['--e10s', 10:48:54 INFO - '--xperf_path', 10:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:54 INFO - 'tests': ['tp5n']}}, 10:48:54 INFO - 'talos.zip': {'path': '', 10:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:48:54 INFO - Running post-action listener: _resource_record_post_action 10:48:54 INFO - ##### 10:48:54 INFO - ##### Running create-virtualenv step. 10:48:54 INFO - ##### 10:48:54 INFO - Running pre-action listener: _resource_record_pre_action 10:48:54 INFO - Running main action method: create_virtualenv 10:48:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:48:54 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 10:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:48:54 INFO - Using real prefix '/usr' 10:48:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:48:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:48:57 INFO - Installing pip.................done. 10:48:57 INFO - Return code: 0 10:48:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:57 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:48:57 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 10:48:57 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 10:48:57 INFO - Using env: {'DISPLAY': ':0', 10:48:57 INFO - 'HOME': '/home/cltbld', 10:48:57 INFO - 'LANG': 'en_US.UTF-8', 10:48:57 INFO - 'LANGUAGE': 'en_US:en', 10:48:57 INFO - 'LOGNAME': 'cltbld', 10:48:57 INFO - 'MAIL': '/var/mail/cltbld', 10:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:57 INFO - 'MOZ_NO_REMOTE': '1', 10:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:57 INFO - 'NO_EM_RESTART': '1', 10:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:57 INFO - 'SHELL': '/bin/bash', 10:48:57 INFO - 'SHLVL': '1', 10:48:57 INFO - 'TERM': 'linux', 10:48:57 INFO - 'TMOUT': '86400', 10:48:57 INFO - 'USER': 'cltbld', 10:48:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:57 INFO - '_': '/tools/buildbot/bin/python'} 10:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:57 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 10:48:57 INFO - Cleaning up... 10:48:57 INFO - Return code: 0 10:48:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:57 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:48:57 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 10:48:57 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 10:48:57 INFO - Using env: {'DISPLAY': ':0', 10:48:57 INFO - 'HOME': '/home/cltbld', 10:48:57 INFO - 'LANG': 'en_US.UTF-8', 10:48:57 INFO - 'LANGUAGE': 'en_US:en', 10:48:57 INFO - 'LOGNAME': 'cltbld', 10:48:57 INFO - 'MAIL': '/var/mail/cltbld', 10:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:57 INFO - 'MOZ_NO_REMOTE': '1', 10:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:57 INFO - 'NO_EM_RESTART': '1', 10:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:57 INFO - 'SHELL': '/bin/bash', 10:48:57 INFO - 'SHLVL': '1', 10:48:57 INFO - 'TERM': 'linux', 10:48:57 INFO - 'TMOUT': '86400', 10:48:57 INFO - 'USER': 'cltbld', 10:48:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:57 INFO - '_': '/tools/buildbot/bin/python'} 10:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:57 INFO - Downloading/unpacking psutil>=0.7.1 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:59 INFO - Installing collected packages: psutil 10:48:59 INFO - Running setup.py install for psutil 10:48:59 INFO - building 'psutil._psutil_linux' extension 10:48:59 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 10:48:59 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 10:48:59 INFO - building 'psutil._psutil_posix' extension 10:48:59 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 10:48:59 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 10:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:59 INFO - Successfully installed psutil 10:48:59 INFO - Cleaning up... 10:48:59 INFO - Return code: 0 10:48:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:59 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:48:59 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 10:48:59 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 10:48:59 INFO - Using env: {'DISPLAY': ':0', 10:48:59 INFO - 'HOME': '/home/cltbld', 10:48:59 INFO - 'LANG': 'en_US.UTF-8', 10:48:59 INFO - 'LANGUAGE': 'en_US:en', 10:48:59 INFO - 'LOGNAME': 'cltbld', 10:48:59 INFO - 'MAIL': '/var/mail/cltbld', 10:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:59 INFO - 'MOZ_NO_REMOTE': '1', 10:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:59 INFO - 'NO_EM_RESTART': '1', 10:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:59 INFO - 'SHELL': '/bin/bash', 10:48:59 INFO - 'SHLVL': '1', 10:48:59 INFO - 'TERM': 'linux', 10:48:59 INFO - 'TMOUT': '86400', 10:48:59 INFO - 'USER': 'cltbld', 10:48:59 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:59 INFO - '_': '/tools/buildbot/bin/python'} 10:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:49:01 INFO - Installing collected packages: mozsystemmonitor 10:49:01 INFO - Running setup.py install for mozsystemmonitor 10:49:01 INFO - Successfully installed mozsystemmonitor 10:49:01 INFO - Cleaning up... 10:49:01 INFO - Return code: 0 10:49:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:49: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')]} 10:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:01 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:49:01 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 10:49:01 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 10:49:01 INFO - Using env: {'DISPLAY': ':0', 10:49:01 INFO - 'HOME': '/home/cltbld', 10:49:01 INFO - 'LANG': 'en_US.UTF-8', 10:49:01 INFO - 'LANGUAGE': 'en_US:en', 10:49:01 INFO - 'LOGNAME': 'cltbld', 10:49:01 INFO - 'MAIL': '/var/mail/cltbld', 10:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:01 INFO - 'MOZ_NO_REMOTE': '1', 10:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:01 INFO - 'NO_EM_RESTART': '1', 10:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:01 INFO - 'SHELL': '/bin/bash', 10:49:01 INFO - 'SHLVL': '1', 10:49:01 INFO - 'TERM': 'linux', 10:49:01 INFO - 'TMOUT': '86400', 10:49:01 INFO - 'USER': 'cltbld', 10:49:01 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:01 INFO - '_': '/tools/buildbot/bin/python'} 10:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:49:02 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 10:49:02 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 10:49:02 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 10:49:02 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 10:49:02 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 10:49:02 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 10:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:04 INFO - Downloading docopt-0.6.1.tar.gz 10:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:49:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:49:04 INFO - Running setup.py install for blobuploader 10:49:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:49:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:49:04 INFO - Running setup.py install for requests 10:49:05 INFO - Running setup.py install for docopt 10:49:05 INFO - Successfully installed blobuploader requests docopt 10:49:05 INFO - Cleaning up... 10:49:05 INFO - Return code: 0 10:49:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:05 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:49:05 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 10:49:05 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 10:49:05 INFO - Using env: {'DISPLAY': ':0', 10:49:05 INFO - 'HOME': '/home/cltbld', 10:49:05 INFO - 'LANG': 'en_US.UTF-8', 10:49:05 INFO - 'LANGUAGE': 'en_US:en', 10:49:05 INFO - 'LOGNAME': 'cltbld', 10:49:05 INFO - 'MAIL': '/var/mail/cltbld', 10:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:05 INFO - 'MOZ_NO_REMOTE': '1', 10:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:05 INFO - 'NO_EM_RESTART': '1', 10:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:05 INFO - 'SHELL': '/bin/bash', 10:49:05 INFO - 'SHLVL': '1', 10:49:05 INFO - 'TERM': 'linux', 10:49:05 INFO - 'TMOUT': '86400', 10:49:05 INFO - 'USER': 'cltbld', 10:49:05 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:05 INFO - '_': '/tools/buildbot/bin/python'} 10:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:05 INFO - Running setup.py (path:/tmp/pip-jgmufT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:05 INFO - Running setup.py (path:/tmp/pip-vrY_uy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:05 INFO - Running setup.py (path:/tmp/pip-lpb1gy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:05 INFO - Running setup.py (path:/tmp/pip-tAUjTg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:05 INFO - Running setup.py (path:/tmp/pip-YWAemz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:05 INFO - Running setup.py (path:/tmp/pip-nTBxOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:05 INFO - Running setup.py (path:/tmp/pip-Guop8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:05 INFO - Running setup.py (path:/tmp/pip-v702Jj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:05 INFO - Running setup.py (path:/tmp/pip-LDvPc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:06 INFO - Running setup.py (path:/tmp/pip-JiboEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:06 INFO - Running setup.py (path:/tmp/pip-D6tcoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:06 INFO - Running setup.py (path:/tmp/pip-j9Jai8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:06 INFO - Running setup.py (path:/tmp/pip-ojdT2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:06 INFO - Running setup.py (path:/tmp/pip-I818dt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:06 INFO - Running setup.py (path:/tmp/pip-YX5vgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:06 INFO - Running setup.py (path:/tmp/pip-k6qB9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:06 INFO - Running setup.py (path:/tmp/pip-gJXaHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:49:06 INFO - Running setup.py install for manifestparser 10:49:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:49:06 INFO - Running setup.py install for mozcrash 10:49:06 INFO - Running setup.py install for mozdebug 10:49:06 INFO - Running setup.py install for mozdevice 10:49:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozfile 10:49:07 INFO - Running setup.py install for mozhttpd 10:49:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozinfo 10:49:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozInstall 10:49:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozleak 10:49:07 INFO - Running setup.py install for mozlog 10:49:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for moznetwork 10:49:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozprocess 10:49:07 INFO - Running setup.py install for mozprofile 10:49:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:49:07 INFO - Running setup.py install for mozrunner 10:49:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:49:08 INFO - Running setup.py install for mozscreenshot 10:49:08 INFO - Running setup.py install for moztest 10:49:08 INFO - Running setup.py install for mozversion 10:49:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:49:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:49:08 INFO - Cleaning up... 10:49:08 INFO - Return code: 0 10:49:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:08 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:49:08 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 10:49:08 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 10:49:08 INFO - Using env: {'DISPLAY': ':0', 10:49:08 INFO - 'HOME': '/home/cltbld', 10:49:08 INFO - 'LANG': 'en_US.UTF-8', 10:49:08 INFO - 'LANGUAGE': 'en_US:en', 10:49:08 INFO - 'LOGNAME': 'cltbld', 10:49:08 INFO - 'MAIL': '/var/mail/cltbld', 10:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:08 INFO - 'MOZ_NO_REMOTE': '1', 10:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:08 INFO - 'NO_EM_RESTART': '1', 10:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:08 INFO - 'SHELL': '/bin/bash', 10:49:08 INFO - 'SHLVL': '1', 10:49:08 INFO - 'TERM': 'linux', 10:49:08 INFO - 'TMOUT': '86400', 10:49:08 INFO - 'USER': 'cltbld', 10:49:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:08 INFO - '_': '/tools/buildbot/bin/python'} 10:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:08 INFO - Running setup.py (path:/tmp/pip-0vDcAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:08 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)) 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:08 INFO - Running setup.py (path:/tmp/pip-PUWhdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:08 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)) 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:08 INFO - Running setup.py (path:/tmp/pip-9LrN__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:08 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)) 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:08 INFO - Running setup.py (path:/tmp/pip-JsamwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:08 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)) 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:08 INFO - Running setup.py (path:/tmp/pip-Q5NCHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:08 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)) 10:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:08 INFO - Running setup.py (path:/tmp/pip-5RbtrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:09 INFO - Running setup.py (path:/tmp/pip-V9NBes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:09 INFO - Running setup.py (path:/tmp/pip-30TA1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:09 INFO - Running setup.py (path:/tmp/pip-ZkZMKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:09 INFO - Running setup.py (path:/tmp/pip-DghfLn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:09 INFO - Running setup.py (path:/tmp/pip-qNPSLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:09 INFO - Running setup.py (path:/tmp/pip-7VrBTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:09 INFO - Running setup.py (path:/tmp/pip-Tt0XDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:09 INFO - Running setup.py (path:/tmp/pip-LQwebD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:09 INFO - Running setup.py (path:/tmp/pip-q1lI9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:09 INFO - Running setup.py (path:/tmp/pip-Dxq2QN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:09 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)) 10:49:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:09 INFO - Running setup.py (path:/tmp/pip-cPamj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:09 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)) 10:49:09 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)) 10:49:09 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)) 10:49:09 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)) 10:49:09 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)) 10:49:09 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)) 10:49:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:11 INFO - Downloading blessings-1.5.1.tar.gz 10:49:11 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 10:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:49:11 INFO - Installing collected packages: blessings 10:49:11 INFO - Running setup.py install for blessings 10:49:11 INFO - Successfully installed blessings 10:49:11 INFO - Cleaning up... 10:49:11 INFO - Return code: 0 10:49:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:11 INFO - Reading from file tmpfile_stdout 10:49:11 INFO - Current package versions: 10:49:11 INFO - argparse == 1.2.1 10:49:11 INFO - blessings == 1.5.1 10:49:11 INFO - blobuploader == 1.2.4 10:49:11 INFO - docopt == 0.6.1 10:49:11 INFO - manifestparser == 1.1 10:49:11 INFO - mozInstall == 1.12 10:49:11 INFO - mozcrash == 0.16 10:49:11 INFO - mozdebug == 0.1 10:49:11 INFO - mozdevice == 0.47 10:49:11 INFO - mozfile == 1.2 10:49:11 INFO - mozhttpd == 0.7 10:49:11 INFO - mozinfo == 0.9 10:49:11 INFO - mozleak == 0.1 10:49:11 INFO - mozlog == 3.1 10:49:11 INFO - moznetwork == 0.27 10:49:11 INFO - mozprocess == 0.22 10:49:11 INFO - mozprofile == 0.27 10:49:11 INFO - mozrunner == 6.11 10:49:11 INFO - mozscreenshot == 0.1 10:49:11 INFO - mozsystemmonitor == 0.0 10:49:11 INFO - moztest == 0.7 10:49:11 INFO - mozversion == 1.4 10:49:11 INFO - psutil == 3.1.1 10:49:11 INFO - requests == 1.2.3 10:49:11 INFO - wsgiref == 0.1.2 10:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:11 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')]} 10:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:11 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')]} 10:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:11 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 0x7fe366386c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, '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': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', '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 10:49:11 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 10:49:11 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 10:49:11 INFO - Using env: {'DISPLAY': ':0', 10:49:11 INFO - 'HOME': '/home/cltbld', 10:49:11 INFO - 'LANG': 'en_US.UTF-8', 10:49:11 INFO - 'LANGUAGE': 'en_US:en', 10:49:11 INFO - 'LOGNAME': 'cltbld', 10:49:11 INFO - 'MAIL': '/var/mail/cltbld', 10:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:11 INFO - 'MOZ_NO_REMOTE': '1', 10:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:11 INFO - 'NO_EM_RESTART': '1', 10:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:12 INFO - 'SHELL': '/bin/bash', 10:49:12 INFO - 'SHLVL': '1', 10:49:12 INFO - 'TERM': 'linux', 10:49:12 INFO - 'TMOUT': '86400', 10:49:12 INFO - 'USER': 'cltbld', 10:49:12 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:12 INFO - '_': '/tools/buildbot/bin/python'} 10:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 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)) 10:49:12 INFO - Cleaning up... 10:49:12 INFO - Return code: 0 10:49:12 INFO - Running post-action listener: _resource_record_post_action 10:49:12 INFO - Running post-action listener: _start_resource_monitoring 10:49:12 INFO - Starting resource monitoring. 10:49:12 INFO - ##### 10:49:12 INFO - ##### Running install step. 10:49:12 INFO - ##### 10:49:12 INFO - Running pre-action listener: _resource_record_pre_action 10:49:12 INFO - Running main action method: install 10:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:12 INFO - Reading from file tmpfile_stdout 10:49:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:49:12 INFO - Reading from file tmpfile_stdout 10:49:12 INFO - Output received: 10:49:12 INFO - Usage: mozinstall [options] installer 10:49:12 INFO - Options: 10:49:12 INFO - -h, --help show this help message and exit 10:49:12 INFO - -d DEST, --destination=DEST 10:49:12 INFO - Directory to install application into. [default: 10:49:12 INFO - "/builds/slave/test-pgo"] 10:49:12 INFO - --app=APP Application being installed. [default: firefox] 10:49:12 INFO - mkdir: /builds/slave/test-pgo/build/application 10:49:12 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'] 10:49:12 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 10:49:26 INFO - Reading from file tmpfile_stdout 10:49:26 INFO - Output received: 10:49:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:49:27 INFO - Running post-action listener: _resource_record_post_action 10:49:27 INFO - ##### 10:49:27 INFO - ##### Running run-tests step. 10:49:27 INFO - ##### 10:49:27 INFO - Running pre-action listener: _resource_record_pre_action 10:49:27 INFO - Running main action method: run_tests 10:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:49:27 INFO - Python 2.7.3 10:49:27 INFO - Return code: 0 10:49:27 INFO - grabbing minidump binary from tooltool 10:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-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 0x1156a90>, '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 0x11a8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a92e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:49:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:49:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:49:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:27 INFO - Return code: 0 10:49:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:49:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:27 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:49:27 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 10:49:27 INFO - Using env: {'DISPLAY': ':0', 10:49:27 INFO - 'HOME': '/home/cltbld', 10:49:27 INFO - 'LANG': 'en_US.UTF-8', 10:49:27 INFO - 'LANGUAGE': 'en_US:en', 10:49:27 INFO - 'LOGNAME': 'cltbld', 10:49:27 INFO - 'MAIL': '/var/mail/cltbld', 10:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:27 INFO - 'MOZ_NO_REMOTE': '1', 10:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:27 INFO - 'NO_EM_RESTART': '1', 10:49:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:49:27 INFO - 'SHELL': '/bin/bash', 10:49:27 INFO - 'SHLVL': '1', 10:49:27 INFO - 'TERM': 'linux', 10:49:27 INFO - 'TMOUT': '86400', 10:49:27 INFO - 'USER': 'cltbld', 10:49:27 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180', 10:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:27 INFO - '_': '/tools/buildbot/bin/python'} 10:49:27 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 10:49:27 INFO - mozversion INFO | application_buildid: 20151123083122 10:49:27 INFO - mozversion INFO | application_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 10:49:27 INFO - mozversion INFO | application_display_name: Nightly 10:49:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:49:27 INFO - mozversion INFO | application_name: Firefox 10:49:27 INFO - mozversion INFO | application_remotingname: firefox 10:49:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:49:27 INFO - mozversion INFO | application_vendor: Mozilla 10:49:27 INFO - mozversion INFO | application_version: 45.0a1 10:49:27 INFO - mozversion INFO | platform_buildid: 20151123083122 10:49:27 INFO - mozversion INFO | platform_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 10:49:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:49:27 INFO - mozversion INFO | platform_version: 45.0a1 10:49:27 INFO - 2015-11-23 10:49:27,256 DEBUG : using testdate: 1448304567 10:49:27 INFO - 2015-11-23 10:49:27,256 DEBUG : actual date: 1448304567 10:49:27 INFO - 2015-11-23 10:49:27,264 INFO : starting webserver on 'localhost:36456' 10:49:27 INFO - 2015-11-23 10:49:27,265 INFO : Starting test suite talos-linux64-ix-017.e 10:49:27 INFO - 2015-11-23 10:49:27,266 INFO : Starting test dromaeo_css 10:49:27 INFO - 2015-11-23 10:49:27,266 DEBUG : operating with platform_type : linux_ 10:49:27 INFO - 2015-11-23 10:49:27,266 INFO : Initialising browser for dromaeo_css test... 10:49:27 INFO - 2015-11-23 10:49:27,282 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4dTfg5/profile http://localhost:36456/getInfo.html 10:49:31 INFO - 2015-11-23 10:49:31,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:49:31 INFO - 2015-11-23 10:49:31,277 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:49:31 INFO - 2015-11-23 10:49:31,277 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:49:31 INFO - 2015-11-23 10:49:31,277 DEBUG : BROWSER_OUTPUT: __metrics 10:49:32 INFO - 2015-11-23 10:49:32,257 INFO : Browser initialized. 10:49:32 INFO - 2015-11-23 10:49:32,258 INFO : Running cycle 1/1 for dromaeo_css test... 10:49:32 INFO - 2015-11-23 10:49:32,258 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4dTfg5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:49:44 INFO - 2015-11-23 10:49:44,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 140279808 10:49:44 INFO - 2015-11-23 10:49:44,038 DEBUG : BROWSER_OUTPUT: 10:50:33 INFO - 2015-11-23 10:50:33,675 DEBUG : BROWSER_OUTPUT: 1448304633675 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] 10:52:42 INFO - 2015-11-23 10:52:42,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36456/tests/dromaeo/cssquery-ext.html) 10:52:43 INFO - 2015-11-23 10:52:43,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 148140032 10:52:43 INFO - 2015-11-23 10:52:43,930 DEBUG : BROWSER_OUTPUT: 10:55:45 INFO - 2015-11-23 10:55:45,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-ext.html (next: http://localhost:36456/tests/dromaeo/cssquery-jquery.html) 10:55:46 INFO - 2015-11-23 10:55:46,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 142213120 10:55:46 INFO - 2015-11-23 10:55:46,418 DEBUG : BROWSER_OUTPUT: 10:58:48 INFO - 2015-11-23 10:58:48,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36456/tests/dromaeo/cssquery-mootools.html) 10:58:48 INFO - 2015-11-23 10:58:48,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 10:58:48 INFO - 2015-11-23 10:58:48,690 DEBUG : BROWSER_OUTPUT: 11:01:50 INFO - 2015-11-23 11:01:50,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36456/tests/dromaeo/cssquery-prototype.html) 11:01:50 INFO - 2015-11-23 11:01:50,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 142225408 11:01:50 INFO - 2015-11-23 11:01:50,925 DEBUG : BROWSER_OUTPUT: 11:04:53 INFO - 2015-11-23 11:04:53,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36456/tests/dromaeo/cssquery-yui.html) 11:04:53 INFO - 2015-11-23 11:04:53,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 142397440 11:04:53 INFO - 2015-11-23 11:04:53,831 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/dromaeo/cssquery-yui.html (next: http://localhost:36456/tests/dromaeo/cssquery-dojo.html) 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 144896000 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:56 INFO - 2015-11-23 11:07:56,590 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:56 INFO - 2015-11-23 11:07:56,592 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3271.1985563536928;3305.3719793239297;3317.170707323168;3329.084501762015;3387.102417859268;5377.4084850666395;5579.246801681777;5614.915776263354;5635.351934527531;5641.68970706611;5449.04641687705;5475.069238229501;5542.057850165472;5546.057170281052;5574.554035677146;5065.670731402456;5101.132807422729;5122.795088196468;5138.563222126124;5201.713905735183;5194.688318700871;5209.921851172236;5232.764525596338;5257.158854583267;5265.578753699714;4972.129877271463;4981.078500477423;5106.08090543702;5119.334486516766;5119.8208062717995;5119.846404607868;5129.589632829365;5141.948580514184;5149.918517111411;5180.766865491062;4912;5096.79612815487;5120;5120.462351453081;5137;5179.14544100223;5287.889543195934;5351.384590772072;5383.246345511631;5410.242566040757;6003.729832157564;6052.667103309316;6068.059450785091;6083.330833608299;6118.265808103011;5849.7660093596205;5970.761169553212;6102.328743838174;6107.26712794463;6122.908156377658;5518.613697041209;5587.078132108238;5593.077142271521;5596.552275817925;5639.577031722637;6208.161898143693;6210.472109870711;6241.843953901189;6244.906326405107;6254.3745625437095;5780.306363236438;5811.15738217956;5977.641341519436;5987.520998320124;5996.850078747979;5896.262967129109;5966.0752583348785;5980.491658209014;5991.790287340009;6022.066579680157;6025.9397406026255;6027.547933904887;6027.9095813562835;6042.909356359658;6047.818565443044;5811.099279611667;5863.794767183128;5933.406659334119;6002.189704389852;6033.939660603338;4662.184117779375;4662.254039353687;4664.883377915511;4675.906481870344;4680.836170734008;4110.157417729359;4150.792460376969;4159.188958153131;4167.499900011957;4208.494980602347;5464.9180262296095;5671.064274394678;5726.083826587809;5728.914066289009;5903.173555702205;6104.175936248638;6142.232220972379;6147.231596050494;6147.354527774519;6168.568200226031;5700.515456186271;5741.598088133874;5745.798897038583;5747.540196784247;5775;5021.899562008739;5109.770060347293;5203.687778733288;5215.035218484517;5272.815451459257;6304.117423560705;6307.621542707452;6322.873542529123;6323.272823625342;6333.714982825784;5872.618279811799;6130.2030736004035;6138.877222455615;6150.907736384047;6189.102580125947;6131.5295901671125;6178;6248.937510625017;6267.561270711007;6270.6551139685935;5904.645721256738;5946.226990491382;5953.76184952597;5964.015937370285;5982.880342393215;5865.237519122486;5915.91126133117;6017.638941663514;6019.398060194121;6028.306744724413;5773.220615216892;5858.091995740667;5869.73586188614;5869.970650146722;5891.823245302648;5890.028145355968;5935.970320148372;5942.108683697307;5972.402759724167;5974.970125149346;5666.829995100154;5667.773289068391;5822.94177058224;5825.970870145622;5872.618279811799;5939.287285525592;5974.551908606785;5975.282966044103;5982.222311099529;6009.849753756016;5786.826395208151;5796.94203057964;5807.332156801853;5838.036723940502;5850.765969361178 11:07:56 INFO - 2015-11-23 11:07:56,595 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.5763074440337;573.5239751006665;585.9003969325214;614.7633161232924;617.2962822382482;36397.45403818945;36913.81543092284;37010.44484332737;37142.257154856954;37206;41372.17255654885;41416.792916035454;41782;41839.58160418395;42169;8678.566071696421;8809.95595022024;8819.735407937773;8823.470591764515;8823.823523529525;8515.148485151498;8552.572371381437;8661.783455413633;8676.52279124651;8678.479291242515;8646.48121112732;8732.738017859474;8769.736907892773;8774.517401542913;8788.73633790984;8710.346723995694;8733.951925768917;8759.912400875974;8788.692395766182;8804.295656347476;8552.444091134057;8646.394752367336;8717.607707653171;8722.781930451725;8730.607122679494;39028.21943561141;39454.802725986476;39501.40747888784;39540.406893896325;39562.40656390157;3149.1812128846436;3229.919252018695;3243.2702641905616;3255.7232635226032;3483.1814523586936;29261.56107658387;29507.40985180306;29511.262218444495;29727.25681857971;29986;3835.673967712748;3882.2623701496627;3894.883153505399;3950.4666869972475;3988;246946;249128;249764;250386;250777;52838;53780.46219537754;54741.726291368286;54809.72595136999;55004.174937375974;64218.67890660517;65441;65461.345386546476;65554.34445655577;65557.67221163864;14490.85509144916;14571.198584077765;14578.562643120724;14703.632409189855;14704.485343013157;10609.681709548726;10629.362238265729;10646.414447205478;10648;10653.733656658645;18905.90547047256;19046.61906761885;19126.139323730466;19161.32935347256;19192.71210931837;7700.691972321157;7955.920440795634;7965.283124518821;7983.2016798320865;8075.959620201861;822.8562298405221;913.6528119314618;944.5749412764284;984.3109823123842;1031.566741968375;27798.583021254697;28818.279543011173;28857.711422885503;29081.272968175967;29499.410011799642;957.3107362698846;1028.5011769291887;1036.1503567075076;1053.562771449855;1099.8130317845985;13677.769000789778;14125;14264.714705705828;14364.281785910664;14462.927685361507;309632;314376;315714;317290;317391;48118.75940620274;48646.513534864906;48669.756651216514;48762.756186218845;48786.268205976936;1301.9349032548334;1308.5289295853675;1328.5748560460754;1341.6779972806455;1362.346073884541;26184;26667.199984000512;27028.33975992025;27161.185164445098;27385.726142738316;44485;44753;44768.10463790771;44803.775981119885;45061.32408013948;285593;286821;287054;287238;287368;29880.85059574688;31498.527522087647;31759.206019849687;31829.20426989344;31932.840335798173;38365.424518631684;38489;38861.2227755449;39366.409503858034;39470.2105957885;32937.17657058593;34593;35549;35697.82151089228;36098.63901360953;34868;34946;34977.825110874284;35466.64533354736;35650.28699426049;34466.138346541535;34749.13127171841;34843.30313393667;35017.32318106664;35177.12057198488;31334;31660.366792664478;32069.358612827145;32132.35735285328;32161.715185207624;24759.133430329854;24928.87535562383;24964.500709986063;25019;25157.87421062883 11:07:56 INFO - 2015-11-23 11:07:56,597 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.7594435783666;354.14120757163886;358.9766665166764;359.1631498608243;364.0353064379395;16498.175091245434;16854.578635534104;17382.652346953055;17560;18037.27850885966;15536.300866461008;15751.60620984476;15875.126868022255;15905.681886362267;16128.193590320496;4788.856334309968;4951.059298733229;4956.950430495703;4957.231629097496;4962.5533701966815;4869.123557759602;4891.437484689271;4924.28597853311;4926.45808961014;4954.033963377143;4934;5095.6942583444925;5249.711265880375;5272.23552584875;5281.392639846428;4387.62705170061;5293.761780719858;5301.1783173608155;5321.973390133044;5533.529649979716;5295.920561191547;5301.655392399482;5319.414864364917;5324.387695415038;5329.094054010828;12257.693557661041;14791;20292.188312467482;20976;21023.789762102337;2013.224908410258;2084.770675225724;2086.3636590839787;2096.2139197800825;2130.8082272595384;9230.630774769;9406.153446189875;9409.200217981479;9747.756306092333;10159.33964292326;1807.4396936949456;1864.766904136983;1873.9250429982785;1884.8774829636168;1899.2118270917554;59003.70498147482;59081.40918590802;59906.70046649739;60089.5964161433;60664.69667651634;10062.24533160016;10172.593096276067;10230.6419275325;10392.636257730943;10420.635277765241;12771.489140434465;13240.602781916557;13254.73490530184;13265.66835829112;13334.399952002183;7004.334588214111;7193.820154496075;7276.272372762787;7315.341619254293;7324.08448943882;7064.50548461613;7140;7159.821004474929;7160.785176444715;7177.318154775288;4413.16149931512;4471.396361491157;4477.440319960005;4501.909961800746;4571.38286331341;1821.7267409888357;1821.7358483020153;1837.044736736916;1889;1917.2618541861204;857.5497863621524;920.9585568649427;925.1904583489446;996.1831298335295;1067.754416484213;15080.849191508163;16338.18309084541;16472.25874835635;16835.494935151964;17193.570160745832;902.5126431726794;905.7871400220943;1001.1690297053428;1020.9387436753818;1043.0404028293988;9620.182284505756;9984;9992.950035249924;10001.649942251986;10027.949860250797;501763;516536;517427;532671;538169;77822.6108869452;80277.97220278042;80436;82513.58743206246;82634.58682706548;1159.9362035087981;1163.96508104757;1171.6485054483792;1172.935488548121;1176.2824676947055;14894.106353618818;14954.700905982038;15057.17185554805;15134.545963621109;15207.391704331703;31180.844095779375;32461.350772983937;33254.334913301114;33433.492488063006;34194.82902585571;43138.254791973486;43568.56431435772;44994.32508512309;45057.774711126236;45169;9336.813263734823;9472.763180920532;9742.853857192005;9781.41311521311;9818.361806482555;11432.885671143182;11475.770484590428;16985.575360616083;17756.112194390487;18092.547686307422;14486.130832150106;14716;14814;15005.474808381654;15108.169050702318;13850.238236897067;14489.913256506015;14612.415503379745;14849.777253340992;15103.622409439413;14855.92572037133;14933.178675172536;15058.397664093314;15068.472603458826;15201.163935983184;9324.254059675346;9376.906230937604;9443.386179898285;9558.044195580387;9739.9026009739;9986.400815951067;10095.44475053879;13426.39581218867;13642.727145456836;14386.568402947929 11:07:56 INFO - 2015-11-23 11:07:56,598 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.2167672810133;1629.5437277562282;1742.6950283700357;1745.8777885548018;1760.5862622283762;6659.034440006196;6731.8653626927435;7284.890726639098;7422.960785490036;7452.254774522552;7514.81212969676;7694.576798276093;7744.186860379664;7748.031496062992;7761.57311347877;2263.321003698888;2294.7705229477087;2299.41364951937;2300.861948283108;2301.6547517872286;2291.46150654596;2292.1289909834322;2303.193882141254;2325.848819826714;2333.1017558240114;2257.3228031590456;2272.8068114210314;2293.2317673579373;2299.1148407862925;2307.088699963522;2249.640057590778;2265.1732117777055;2283.0525331987205;2283.9200627978025;2294.7705229477;2339.181286549711;2350.3771500552366;2359.3393849722106;2361.929142125739;2362.043372434167;7606;7676.309132178131;7689.38484921205;7690.615469226516;7695.692172313101;4698.318743782167;4761.262004389325;4764.857054288377;4793.9280910786365;4798.640101992364;3142.4500712375243;3169.5721077654453;3186.4105140549073;3219.983900080508;3239.951400728991;1057.2176589323922;1064.239069065614;1073.4364458659188;1078.8975047370486;1081.3836113415357;10627.84058239127;10648.840267395995;10709.78580428387;10721.624743133953;10740.462976851126;4331.696781225284;4333.9133217335475;4407.2507673695545;4409.382686423904;4424.623906967944;9165;9168.083191680778;9217.308701847389;9224.584893679801;9228.307876909259;4793.13723529768;4801.663883528119;4802.759862006886;4803.759812009385;4811.326414302001;4335.566443355639;4369.191699535596;4369.563043695605;4449.933251001173;4474.105178964221;3759.2293579816073;3786.583475817658;3818.1981783825154;3835.271298453285;3841.9039524012123;1243.7636848998661;1249.6001279590444;1250.7185883176212;1253.185429470833;1265.1333836322149;1285.9035572332114;1287.8325817643647;1296.1963582578674;1311.2132720367895;1311.8819306262292;7153.998440218374;7272.527285726411;7304.963475182696;7328.377087947478;7348.559086454829;449.98425055122914;453.14582012905254;458.601017115112;460.1579110228274;461.0985523301937;5661.179129026268;5695.857603559944;5701.315842098892;5708;5746.166805813217;8967.686130985385;9003.864942025875;9214;9362.06379362072;9386.202172815387;9042.547872606343;9092.727218183465;9160.221381182673;9172.220361269234;9173;7173.246809084971;7248.130224373003;7249.673764680708;7316.780496585111;7319.597422141726;6910.101686780687;6943.722251109899;6943.861122777617;6955.826104347432;6966.12923384577;8008.079070906921;8219.671213151407;8240.464369815943;8292.626831792462;8297.917020829957;8300.667973281;8349.248567628943;8350.665973361241;8458.873116903129;8506.829863402822;5961.940380596312;6297.307296197506;6389.648569328731;6516.185476815398;6796.66016699173;7474.103107627119;7474.7757567273065;7515.661795219119;7551.962240188764;7559.3196612305155;6817.216020157745;7048.823779405351;7070.787876363717;7099.112610923635;7117.501774875916;6872.587644741331;6940.236573976959;7018.2630823762765;7063.57618542889;7132.465065120033;6703.765368212089;6742.393184613408;6785.491088168308;6793.72825086991;6815.89776153368;6436.742530298736;6483.740650373932;6484.059811327425;6484.837879053061;6488.772892948913;6250.3749625037135;6407.743690252338;6480.611163330215;6486.740530378921;6527.967360163168 11:07:56 INFO - 2015-11-23 11:07:56,599 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.3347438174887;336.9157710572357;338.6613386613387;341.085889815295;342.9777064490808;6359.55483116182;6365.331640177778;6376.521760867942;6387.744490220397;6537.9212429949;6325.810225693236;6399.2640846302575;6418.646974416405;6427.871442571158;6435.710393032313;4858.955324605209;4860.513948605147;4861.416630004404;4863.68386054907;4868.2697595360805;4856.781444834974;4859.757012149396;4881.145799485093;4884.560389564938;4900.558949694527;4582.427196600425;4634.768261586907;4707.882302942419;4716.481187069419;4725.763711814413;4717.127331443694;4719.174144524729;4733.053389322132;4736.052789442108;4740.07568524138;4057.2696914555368;4061.959380406188;4069.7558146511305;4071.4503542021744;4072.816723247461;6086.513078953673;6094.725737341831;6094.963856144466;6096.908546371808;6101.420365065312;5442.673439593597;5535.529479994206;5581.916271255935;5588.966041282376;5591.993441180586;6739.561928474683;6749.493787965922;6752.189737231514;6761.4590832733265;6778.661066946633;4543.341215523764;4546.613537849286;4561.40701708779;4573.222552166139;4576.199165146119;6954.09596752424;7055.25919778421;7136;7142.392896603795;7146.24964378738;4503.851517862924;4504.887377815581;4509.774511274489;4518.864434066983;4527.366168736379;4553.749543775124;4564.269716845289;4571.291449825282;4575.81696732127;4578.542145785462;5433.972830135903;5441.2654291670115;5446.8910621787345;5447.319085114361;5449.700266485382;6716.126903502513;6851.45188384928;6859.348361905611;6862.245153033163;6872.312768723188;1647;1647.8681705463534;1648.332425367728;1648.4724888035714;1649.8102718187322;1097.9066779323846;1099.6096385782932;1102.2780079048237;1105.3754628634795;1118.4631376939114;6571.3757193066585;6580.868382632416;6581.440577550866;6603.70283337251;6611.371919667624;7002;7016;7023.543469674455;7026.683799229047;7085.43316534676;6464.41820236181;6568.8029359118345;6573.7370505180215;6657.800265992028;6691.5650482718465;3837.6929845612285;3851.383778595411;3863.285292220948;3866.7873266970587;3892.2215556888737;7398.186199518049;7402.925970740223;7419.183889772121;7420.9257907421315;7428.591427471433;7160.355567998905;7325.047743793273;7338.816529586697;7345.485815992829;7371.926280737124;7376.889346659805;7384;7394;7394.667239974106;7416.629168541552;7006.6846991886505;7116.501844871016;7139.535930164523;7149.0706208192605;7155.606441645759;7030.367266945999;7034.788956331318;7037.683304251219;7039.8944015840825;7041.3310735480045;7376.7049318026675;7389;7398.11222653285;7400.851982960418;7415.1101867776215;4642.862498687843;4668.369770080995;4679.27471241958;4691.249400095969;4724.503927087744;7072.3634872861685;7100.715971361088;7123.430125590044;7134.643267836484;7142.428605711634;6874.828129296808;6883.690233939385;6896.896546551706;6901.137357830271;6926.896096558455;6777.593344399352;6801.2858649841055;6864.553804002724;6868.244493105654;6869.347411995853;6748.325167483213;6761.850485417589;6796.524243302922;6803.217629972419;6810.761623343159;6870;6911.827204319932;6932.549384290005;6933.237343892269;6939.375456208965;6581.3747693969;6729.2934241903895;6742.157230346207;6753.561018533779;6763.695633696397 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.2847116417314;812.3988248695966;830.5755629096101;845.4082142500248;860.2902605350587;13502.527411540597;13652.24912629805;13811.447542098316;13821.51624693136;13877.583672489829;12881.098323117385;12944;12984.545540906047;12991.545295914644;13006.284654344006;663.8174502011962;666.3436515032689;781.7576551269096;790.8062524681446;809.0574480729942;808.337163525909;810.8297257575916;815.2458975447717;816.0207750699155;818.8976377952756;837.8910741603582;846.2595229174473;846.4202021615213;847.4195176304252;850.090403268503;838.4633834345993;838.8573942429801;839.7858546070713;843.8734189871507;846.6571038729325;619.3837132053591;619.6932518403374;619.7211254935252;621.8631900981777;622.2408661433044;13670.384832682554;13833.170009799444;13836.584902452943;13843.377048032862;13887.79168312476;11868;12276;12351.505939762399;12540.310282934435;12678;10184.694459166238;10528.210384221138;10665.253432259746;10929.781404371868;11063.612773552886;3716.721245906541;3764.0025393270807;3796.1268908151005;3883.7475564088527;3892.5912779158066;45617.54382456166;46309;46397.768011160064;46451;46543.767281163375;9464.290178236659;9822.65620703272;9885.901140988643;9976.301658883809;10118.139958103644;18333.633327333646;18400.907995459937;18441.53896152607;19313.8068619312;19373.612527749367;7603.847923041508;7734.961325193338;7786.766397007986;7889.447738658238;7935.325497332791;4148.983499042693;4233.386159006988;4243.405923170759;4286.978565107154;4376;3233.4664780311455;3267.18320419895;3272.1165285372817;3284.819334936554;3290.8025518468967;575.3383608849856;581.8778056608076;582.3972188784587;586.2818047891299;612.8988716861757;549.4258499867648;649.2792999770252;653.8103949854489;662.5461558832216;671.3286713286714;7945.801354966172;8123.837523249502;8365.205305495969;8419.536925469036;8437.746867593982;518.346882927514;594.9261582842923;607.2106261859565;624.6658037949675;663.9900401493982;3740.3080430120513;3795.7153213509096;3860.4595356650093;3909.980450097788;3941.1723538056754;53808;57316.426835731945;57848;57986.7100664494;58491.70754146202;51378.22932655938;51693.48306516887;52149.7392513035;52201.2169817453;52231.47768522342;47305.76347118242;47533;47953.28070078952;48644.27033594499;48649.51350486521;8110.107888132418;8242.587870606565;8309;8346.62440190205;8455.450395724258;33904.3219135611;33923.32153356968;34473.482897756054;34764;35016.47475287822;43591;46976.7651161742;47230.76384618055;47740.7612961933;47885.28172077491;11121.610743623934;11141;11174.659040915143;11188.384638844942;11204.271722338022;12244.877551224374;12305.138640295094;12330.260184388966;12550.560730374393;12575.434105465092;10702.571897124028;10778.29941053829;10796;11101.333919964827;11320.26418282809;10989.560417583207;11265.324080555192;11303.71740706456;11518.539258429904;11566.421678915853;10689.251752377259;10978.725531861448;11097.722556936142;11123.221374503708;11476.426178690865;9869.132786599312;9873.111419972238;9933.701988940344;10161.085502304531;10182.083612474913;8378.77642001367;8394.202550757669;8801.38390312672;9543.42739435636;9622.230221582116 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:07:56 INFO - 2015-11-23 11:07:56,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305676589__endTimestamp 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5594.53 Median:5811.16 stddev:632.63 (10.9%) stddev-sans-first:607.75 11:07:56 INFO - 2015-11-23 11:07:56,604 DEBUG : BROWSER_OUTPUT: Values: 3271.2 3305.4 3317.2 3329.1 3387.1 5377.4 5579.2 5614.9 5635.4 5641.7 5449.0 5475.1 5542.1 5546.1 5574.6 5065.7 5101.1 5122.8 5138.6 5201.7 5194.7 5209.9 5232.8 5257.2 5265.6 4972.1 4981.1 5106.1 5119.3 5119.8 5119.8 5129.6 5141.9 5149.9 5180.8 4912.0 5096.8 5120.0 5120.5 5137.0 5179.1 5287.9 5351.4 5383.2 5410.2 6003.7 6052.7 6068.1 6083.3 6118.3 5849.8 5970.8 6102.3 6107.3 6122.9 5518.6 5587.1 5593.1 5596.6 5639.6 6208.2 6210.5 6241.8 6244.9 6254.4 5780.3 5811.2 5977.6 5987.5 5996.9 5896.3 5966.1 5980.5 5991.8 6022.1 6025.9 6027.5 6027.9 6042.9 6047.8 5811.1 5863.8 5933.4 6002.2 6033.9 4662.2 4662.3 4664.9 4675.9 4680.8 4110.2 4150.8 4159.2 4167.5 4208.5 5464.9 5671.1 5726.1 5728.9 5903.2 6104.2 6142.2 6147.2 6147.4 6168.6 5700.5 5741.6 5745.8 5747.5 5775.0 5021.9 5109.8 5203.7 5215.0 5272.8 6304.1 6307.6 6322.9 6323.3 6333.7 5872.6 6130.2 6138.9 6150.9 6189.1 6131.5 6178.0 6248.9 6267.6 6270.7 5904.6 5946.2 5953.8 5964.0 5982.9 5865.2 5915.9 6017.6 6019.4 6028.3 5773.2 5858.1 5869.7 5870.0 5891.8 5890.0 5936.0 5942.1 5972.4 5975.0 5666.8 5667.8 5822.9 5826.0 5872.6 5939.3 5974.6 5975.3 5982.2 6009.8 5786.8 5796.9 5807.3 5838.0 5850.8 11:07:56 INFO - 2015-11-23 11:07:56,605 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,605 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45015.45 Median:35507.82 stddev:74464.16 (209.7%) stddev-sans-first:74598.27 11:07:56 INFO - 2015-11-23 11:07:56,605 DEBUG : BROWSER_OUTPUT: Values: 568.6 573.5 585.9 614.8 617.3 36397.5 36913.8 37010.4 37142.3 37206.0 41372.2 41416.8 41782.0 41839.6 42169.0 8678.6 8810.0 8819.7 8823.5 8823.8 8515.1 8552.6 8661.8 8676.5 8678.5 8646.5 8732.7 8769.7 8774.5 8788.7 8710.3 8734.0 8759.9 8788.7 8804.3 8552.4 8646.4 8717.6 8722.8 8730.6 39028.2 39454.8 39501.4 39540.4 39562.4 3149.2 3229.9 3243.3 3255.7 3483.2 29261.6 29507.4 29511.3 29727.3 29986.0 3835.7 3882.3 3894.9 3950.5 3988.0 246946.0 249128.0 249764.0 250386.0 250777.0 52838.0 53780.5 54741.7 54809.7 55004.2 64218.7 65441.0 65461.3 65554.3 65557.7 14490.9 14571.2 14578.6 14703.6 14704.5 10609.7 10629.4 10646.4 10648.0 10653.7 18905.9 19046.6 19126.1 19161.3 19192.7 7700.7 7955.9 7965.3 7983.2 8076.0 822.9 913.7 944.6 984.3 1031.6 27798.6 28818.3 28857.7 29081.3 29499.4 957.3 1028.5 1036.2 1053.6 1099.8 13677.8 14125.0 14264.7 14364.3 14462.9 309632.0 314376.0 315714.0 317290.0 317391.0 48118.8 48646.5 48669.8 48762.8 48786.3 1301.9 1308.5 1328.6 1341.7 1362.3 26184.0 26667.2 27028.3 27161.2 27385.7 44485.0 44753.0 44768.1 44803.8 45061.3 285593.0 286821.0 287054.0 287238.0 287368.0 29880.9 31498.5 31759.2 31829.2 31932.8 38365.4 38489.0 38861.2 39366.4 39470.2 32937.2 34593.0 35549.0 35697.8 36098.6 34868.0 34946.0 34977.8 35466.6 35650.3 34466.1 34749.1 34843.3 35017.3 35177.1 31334.0 31660.4 32069.4 32132.4 32161.7 24759.1 24928.9 24964.5 25019.0 25157.9 11:07:56 INFO - 2015-11-23 11:07:56,605 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,605 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28029.01 Median:17274.29 stddev:85244.95 (493.5%) stddev-sans-first:85458.76 11:07:56 INFO - 2015-11-23 11:07:56,607 DEBUG : BROWSER_OUTPUT: Values: 353.8 354.1 359.0 359.2 364.0 16498.2 16854.6 17382.7 17560.0 18037.3 15536.3 15751.6 15875.1 15905.7 16128.2 4788.9 4951.1 4957.0 4957.2 4962.6 4869.1 4891.4 4924.3 4926.5 4954.0 4934.0 5095.7 5249.7 5272.2 5281.4 4387.6 5293.8 5301.2 5322.0 5533.5 5295.9 5301.7 5319.4 5324.4 5329.1 12257.7 14791.0 20292.2 20976.0 21023.8 2013.2 2084.8 2086.4 2096.2 2130.8 9230.6 9406.2 9409.2 9747.8 10159.3 1807.4 1864.8 1873.9 1884.9 1899.2 59003.7 59081.4 59906.7 60089.6 60664.7 10062.2 10172.6 10230.6 10392.6 10420.6 12771.5 13240.6 13254.7 13265.7 13334.4 7004.3 7193.8 7276.3 7315.3 7324.1 7064.5 7140.0 7159.8 7160.8 7177.3 4413.2 4471.4 4477.4 4501.9 4571.4 1821.7 1821.7 1837.0 1889.0 1917.3 857.5 921.0 925.2 996.2 1067.8 15080.8 16338.2 16472.3 16835.5 17193.6 902.5 905.8 1001.2 1020.9 1043.0 9620.2 9984.0 9993.0 10001.6 10027.9 501763.0 516536.0 517427.0 532671.0 538169.0 77822.6 80278.0 80436.0 82513.6 82634.6 1159.9 1164.0 1171.6 1172.9 1176.3 14894.1 14954.7 15057.2 15134.5 15207.4 31180.8 32461.4 33254.3 33433.5 34194.8 43138.3 43568.6 44994.3 45057.8 45169.0 9336.8 9472.8 9742.9 9781.4 9818.4 11432.9 11475.8 16985.6 17756.1 18092.5 14486.1 14716.0 14814.0 15005.5 15108.2 13850.2 14489.9 14612.4 14849.8 15103.6 14855.9 14933.2 15058.4 15068.5 15201.2 9324.3 9376.9 9443.4 9558.0 9739.9 9986.4 10095.4 13426.4 13642.7 14386.6 11:07:56 INFO - 2015-11-23 11:07:56,607 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,607 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5408.67 Median:6106.16 stddev:2769.92 (45.4%) stddev-sans-first:2762.16 11:07:56 INFO - 2015-11-23 11:07:56,608 DEBUG : BROWSER_OUTPUT: Values: 1506.2 1629.5 1742.7 1745.9 1760.6 6659.0 6731.9 7284.9 7423.0 7452.3 7514.8 7694.6 7744.2 7748.0 7761.6 2263.3 2294.8 2299.4 2300.9 2301.7 2291.5 2292.1 2303.2 2325.8 2333.1 2257.3 2272.8 2293.2 2299.1 2307.1 2249.6 2265.2 2283.1 2283.9 2294.8 2339.2 2350.4 2359.3 2361.9 2362.0 7606.0 7676.3 7689.4 7690.6 7695.7 4698.3 4761.3 4764.9 4793.9 4798.6 3142.5 3169.6 3186.4 3220.0 3240.0 1057.2 1064.2 1073.4 1078.9 1081.4 10627.8 10648.8 10709.8 10721.6 10740.5 4331.7 4333.9 4407.3 4409.4 4424.6 9165.0 9168.1 9217.3 9224.6 9228.3 4793.1 4801.7 4802.8 4803.8 4811.3 4335.6 4369.2 4369.6 4449.9 4474.1 3759.2 3786.6 3818.2 3835.3 3841.9 1243.8 1249.6 1250.7 1253.2 1265.1 1285.9 1287.8 1296.2 1311.2 1311.9 7154.0 7272.5 7305.0 7328.4 7348.6 450.0 453.1 458.6 460.2 461.1 5661.2 5695.9 5701.3 5708.0 5746.2 8967.7 9003.9 9214.0 9362.1 9386.2 9042.5 9092.7 9160.2 9172.2 9173.0 7173.2 7248.1 7249.7 7316.8 7319.6 6910.1 6943.7 6943.9 6955.8 6966.1 8008.1 8219.7 8240.5 8292.6 8297.9 8300.7 8349.2 8350.7 8458.9 8506.8 5961.9 6297.3 6389.6 6516.2 6796.7 7474.1 7474.8 7515.7 7552.0 7559.3 6817.2 7048.8 7070.8 7099.1 7117.5 6872.6 6940.2 7018.3 7063.6 7132.5 6703.8 6742.4 6785.5 6793.7 6815.9 6436.7 6483.7 6484.1 6484.8 6488.8 6250.4 6407.7 6480.6 6486.7 6528.0 11:07:56 INFO - 2015-11-23 11:07:56,608 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,608 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5671.96 Median:6553.36 stddev:1777.64 (27.1%) stddev-sans-first:1736.80 11:07:56 INFO - 2015-11-23 11:07:56,610 DEBUG : BROWSER_OUTPUT: Values: 329.3 336.9 338.7 341.1 343.0 6359.6 6365.3 6376.5 6387.7 6537.9 6325.8 6399.3 6418.6 6427.9 6435.7 4859.0 4860.5 4861.4 4863.7 4868.3 4856.8 4859.8 4881.1 4884.6 4900.6 4582.4 4634.8 4707.9 4716.5 4725.8 4717.1 4719.2 4733.1 4736.1 4740.1 4057.3 4062.0 4069.8 4071.5 4072.8 6086.5 6094.7 6095.0 6096.9 6101.4 5442.7 5535.5 5581.9 5589.0 5592.0 6739.6 6749.5 6752.2 6761.5 6778.7 4543.3 4546.6 4561.4 4573.2 4576.2 6954.1 7055.3 7136.0 7142.4 7146.2 4503.9 4504.9 4509.8 4518.9 4527.4 4553.7 4564.3 4571.3 4575.8 4578.5 5434.0 5441.3 5446.9 5447.3 5449.7 6716.1 6851.5 6859.3 6862.2 6872.3 1647.0 1647.9 1648.3 1648.5 1649.8 1097.9 1099.6 1102.3 1105.4 1118.5 6571.4 6580.9 6581.4 6603.7 6611.4 7002.0 7016.0 7023.5 7026.7 7085.4 6464.4 6568.8 6573.7 6657.8 6691.6 3837.7 3851.4 3863.3 3866.8 3892.2 7398.2 7402.9 7419.2 7420.9 7428.6 7160.4 7325.0 7338.8 7345.5 7371.9 7376.9 7384.0 7394.0 7394.7 7416.6 7006.7 7116.5 7139.5 7149.1 7155.6 7030.4 7034.8 7037.7 7039.9 7041.3 7376.7 7389.0 7398.1 7400.9 7415.1 4642.9 4668.4 4679.3 4691.2 4724.5 7072.4 7100.7 7123.4 7134.6 7142.4 6874.8 6883.7 6896.9 6901.1 6926.9 6777.6 6801.3 6864.6 6868.2 6869.3 6748.3 6761.9 6796.5 6803.2 6810.8 6870.0 6911.8 6932.5 6933.2 6939.4 6581.4 6729.3 6742.2 6753.6 6763.7 11:07:56 INFO - 2015-11-23 11:07:56,610 DEBUG : BROWSER_OUTPUT: 11:07:56 INFO - 2015-11-23 11:07:56,610 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13846.11 Median:47268.26 stddev:16052.05 (34.0%) stddev-sans-first:16067.06 11:07:56 INFO - 2015-11-23 11:07:56,610 DEBUG : BROWSER_OUTPUT: Values: 773.3 812.4 830.6 845.4 860.3 13502.5 13652.2 13811.4 13821.5 13877.6 12881.1 12944.0 12984.5 12991.5 13006.3 663.8 666.3 781.8 790.8 809.1 808.3 810.8 815.2 816.0 818.9 837.9 846.3 846.4 847.4 850.1 838.5 838.9 839.8 843.9 846.7 619.4 619.7 619.7 621.9 622.2 13670.4 13833.2 13836.6 13843.4 13887.8 11868.0 12276.0 12351.5 12540.3 12678.0 10184.7 10528.2 10665.3 10929.8 11063.6 3716.7 3764.0 3796.1 3883.7 3892.6 45617.5 46309.0 46397.8 46451.0 46543.8 9464.3 9822.7 9885.9 9976.3 10118.1 18333.6 18400.9 18441.5 19313.8 19373.6 7603.8 7735.0 7786.8 7889.4 7935.3 4149.0 4233.4 4243.4 4287.0 4376.0 3233.5 3267.2 3272.1 3284.8 3290.8 575.3 581.9 582.4 586.3 612.9 549.4 649.3 653.8 662.5 671.3 7945.8 8123.8 8365.2 8419.5 8437.7 518.3 594.9 607.2 624.7 664.0 3740.3 3795.7 3860.5 3910.0 3941.2 53808.0 57316.4 57848.0 57986.7 58491.7 51378.2 51693.5 52149.7 52201.2 52231.5 47305.8 47533.0 47953.3 48644.3 48649.5 8110.1 8242.6 8309.0 8346.6 8455.5 33904.3 33923.3 34473.5 34764.0 35016.5 43591.0 46976.8 47230.8 47740.8 47885.3 11121.6 11141.0 11174.7 11188.4 11204.3 12244.9 12305.1 12330.3 12550.6 12575.4 10702.6 10778.3 10796.0 11101.3 11320.3 10989.6 11265.3 11303.7 11518.5 11566.4 10689.3 10978.7 11097.7 11123.2 11476.4 9869.1 9873.1 9933.7 10161.1 10182.1 8378.8 8394.2 8801.4 9543.4 9622.2 11:07:56 INFO - 2015-11-23 11:07:56,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:56 INFO - 2015-11-23 11:07:56,611 DEBUG : BROWSER_OUTPUT: 11:07:57 INFO - 2015-11-23 11:07:57,321 INFO : Browser exited with error code: 0 11:07:57 INFO - 2015-11-23 11:07:57,343 INFO : Completed test dromaeo_css (00:18:30) 11:07:57 INFO - 2015-11-23 11:07:57,343 INFO : Starting test kraken 11:07:57 INFO - 2015-11-23 11:07:57,343 DEBUG : operating with platform_type : linux_ 11:07:57 INFO - 2015-11-23 11:07:57,343 INFO : Initialising browser for kraken test... 11:07:57 INFO - 2015-11-23 11:07:57,349 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9XaRGt/profile http://localhost:36456/getInfo.html 11:08:01 INFO - 2015-11-23 11:08:01,126 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:08:01 INFO - 2015-11-23 11:08:01,126 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:08:01 INFO - 2015-11-23 11:08:01,126 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:08:01 INFO - 2015-11-23 11:08:01,126 DEBUG : BROWSER_OUTPUT: __metrics 11:08:02 INFO - 2015-11-23 11:08:02,141 INFO : Browser initialized. 11:08:02 INFO - 2015-11-23 11:08:02,142 INFO : Running cycle 1/1 for kraken test... 11:08:02 INFO - 2015-11-23 11:08:02,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9XaRGt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:08:13 INFO - 2015-11-23 11:08:13,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 139972608 11:08:13 INFO - 2015-11-23 11:08:13,903 DEBUG : BROWSER_OUTPUT: 11:08:16 INFO - 2015-11-23 11:08:16,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:16 INFO - 2015-11-23 11:08:16,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 142770176 11:08:16 INFO - 2015-11-23 11:08:16,980 DEBUG : BROWSER_OUTPUT: 11:08:19 INFO - 2015-11-23 11:08:19,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-dft) 11:08:20 INFO - 2015-11-23 11:08:20,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 142700544 11:08:20 INFO - 2015-11-23 11:08:20,264 DEBUG : BROWSER_OUTPUT: 11:08:23 INFO - 2015-11-23 11:08:23,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-fft) 11:08:23 INFO - 2015-11-23 11:08:23,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 136507392 11:08:23 INFO - 2015-11-23 11:08:23,689 DEBUG : BROWSER_OUTPUT: 11:08:25 INFO - 2015-11-23 11:08:25,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36456/tests/kraken/driver.html?testName=audio-oscillator) 11:08:26 INFO - 2015-11-23 11:08:26,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 138113024 11:08:26 INFO - 2015-11-23 11:08:26,284 DEBUG : BROWSER_OUTPUT: 11:08:28 INFO - 2015-11-23 11:08:28,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:08:29 INFO - 2015-11-23 11:08:29,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 139358208 11:08:29 INFO - 2015-11-23 11:08:29,084 DEBUG : BROWSER_OUTPUT: 11:08:32 INFO - 2015-11-23 11:08:32,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-darkroom) 11:08:32 INFO - 2015-11-23 11:08:32,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920 11:08:32 INFO - 2015-11-23 11:08:32,691 DEBUG : BROWSER_OUTPUT: 11:08:36 INFO - 2015-11-23 11:08:36,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36456/tests/kraken/driver.html?testName=imaging-desaturate) 11:08:36 INFO - 2015-11-23 11:08:36,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 139354112 11:08:36 INFO - 2015-11-23 11:08:36,667 DEBUG : BROWSER_OUTPUT: 11:08:39 INFO - 2015-11-23 11:08:39,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36456/tests/kraken/driver.html?testName=json-parse-financial) 11:08:40 INFO - 2015-11-23 11:08:40,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 11:08:40 INFO - 2015-11-23 11:08:40,102 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:08:42 INFO - 2015-11-23 11:08:42,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 140251136 11:08:42 INFO - 2015-11-23 11:08:42,280 DEBUG : BROWSER_OUTPUT: 11:08:44 INFO - 2015-11-23 11:08:44,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:08:44 INFO - 2015-11-23 11:08:44,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 139362304 11:08:44 INFO - 2015-11-23 11:08:44,724 DEBUG : BROWSER_OUTPUT: 11:08:46 INFO - 2015-11-23 11:08:46,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:08:47 INFO - 2015-11-23 11:08:47,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 139206656 11:08:47 INFO - 2015-11-23 11:08:47,410 DEBUG : BROWSER_OUTPUT: 11:08:49 INFO - 2015-11-23 11:08:49,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:08:50 INFO - 2015-11-23 11:08:50,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 11:08:50 INFO - 2015-11-23 11:08:50,484 DEBUG : BROWSER_OUTPUT: 11:08:53 INFO - 2015-11-23 11:08:53,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:08:53 INFO - 2015-11-23 11:08:53,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 139681792 11:08:53 INFO - 2015-11-23 11:08:53,678 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36456/tests/kraken/driver.html?testName=ai-astar) 11:08:55 INFO - 2015-11-23 11:08:55,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 139472896 11:08:55 INFO - 2015-11-23 11:08:55,598 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,598 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:08:55 INFO - 2015-11-23 11:08:55,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:08:55 INFO - 2015-11-23 11:08:55,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:08:55 INFO - 2015-11-23 11:08:55,599 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:08:55 INFO - 2015-11-23 11:08:55,600 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;111;110;110;121;110;111;109;109 11:08:55 INFO - 2015-11-23 11:08:55,600 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;130;152;169;137;161;164;126;163;129 11:08:55 INFO - 2015-11-23 11:08:55,600 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;166;162;162;164;163;163;163;171;162 11:08:55 INFO - 2015-11-23 11:08:55,601 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;70;71;74;148;72;72;72 11:08:55 INFO - 2015-11-23 11:08:55,601 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;134;92;94;93;137;93;94;136 11:08:55 INFO - 2015-11-23 11:08:55,601 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;110;109;111;110;110 11:08:55 INFO - 2015-11-23 11:08:55,601 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;148;147;147;147;149;146 11:08:55 INFO - 2015-11-23 11:08:55,601 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;102;97;97;97;96 11:08:55 INFO - 2015-11-23 11:08:55,602 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;63;61;62;63;65;65;62;61;60 11:08:55 INFO - 2015-11-23 11:08:55,602 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;69;69;69;71;70 11:08:55 INFO - 2015-11-23 11:08:55,602 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;92;85;86;91;85;87;91 11:08:55 INFO - 2015-11-23 11:08:55,602 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;120;132;121;122;123;121;123;138 11:08:55 INFO - 2015-11-23 11:08:55,602 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;151;159;152;151;150;153;150;151;139 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;68;68;68;75;68;67;67 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:08:55 INFO - 2015-11-23 11:08:55,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305735597__endTimestamp 11:08:55 INFO - 2015-11-23 11:08:55,604 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,605 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:08:55 INFO - 2015-11-23 11:08:55,605 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:08:55 INFO - 2015-11-23 11:08:55,605 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,606 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:3.81 (3.5%) stddev-sans-first:3.98 11:08:55 INFO - 2015-11-23 11:08:55,606 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 111.0 110.0 110.0 121.0 110.0 111.0 109.0 109.0 11:08:55 INFO - 2015-11-23 11:08:55,606 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,606 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.50 stddev:16.32 (10.4%) stddev-sans-first:17.31 11:08:55 INFO - 2015-11-23 11:08:55,607 DEBUG : BROWSER_OUTPUT: Values: 148.0 130.0 152.0 169.0 137.0 161.0 164.0 126.0 163.0 129.0 11:08:55 INFO - 2015-11-23 11:08:55,607 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,607 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.91 (1.8%) stddev-sans-first:2.92 11:08:55 INFO - 2015-11-23 11:08:55,608 DEBUG : BROWSER_OUTPUT: Values: 161.0 166.0 162.0 162.0 164.0 163.0 163.0 163.0 171.0 162.0 11:08:55 INFO - 2015-11-23 11:08:55,608 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,608 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:72.00 stddev:24.06 (33.4%) stddev-sans-first:25.36 11:08:55 INFO - 2015-11-23 11:08:55,608 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 70.0 71.0 74.0 148.0 72.0 72.0 72.0 11:08:55 INFO - 2015-11-23 11:08:55,609 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,609 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:93.00 stddev:20.57 (22.1%) stddev-sans-first:21.19 11:08:55 INFO - 2015-11-23 11:08:55,610 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 134.0 92.0 94.0 93.0 137.0 93.0 94.0 136.0 11:08:55 INFO - 2015-11-23 11:08:55,610 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,611 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:08:55 INFO - 2015-11-23 11:08:55,611 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 110.0 109.0 111.0 110.0 110.0 11:08:55 INFO - 2015-11-23 11:08:55,611 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,611 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 11:08:55 INFO - 2015-11-23 11:08:55,612 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 149.0 146.0 11:08:55 INFO - 2015-11-23 11:08:55,612 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,612 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 11:08:55 INFO - 2015-11-23 11:08:55,612 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 102.0 97.0 97.0 97.0 96.0 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:1.65 (2.6%) stddev-sans-first:1.74 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 61.0 62.0 63.0 65.0 65.0 62.0 61.0 60.0 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 71.0 70.0 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,613 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.33 (3.8%) stddev-sans-first:3.37 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 92.0 85.0 86.0 91.0 85.0 87.0 91.0 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:123.00 stddev:5.84 (4.7%) stddev-sans-first:6.05 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 120.0 132.0 121.0 122.0 123.0 121.0 123.0 138.0 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:151.50 stddev:4.89 (3.2%) stddev-sans-first:5.17 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: Values: 152.0 151.0 159.0 152.0 151.0 150.0 153.0 150.0 151.0 139.0 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.44 (3.6%) stddev-sans-first:2.55 11:08:55 INFO - 2015-11-23 11:08:55,614 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 68.0 68.0 68.0 75.0 68.0 67.0 67.0 11:08:55 INFO - 2015-11-23 11:08:55,615 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:08:55 INFO - 2015-11-23 11:08:55,615 DEBUG : BROWSER_OUTPUT: 11:08:56 INFO - 2015-11-23 11:08:56,461 INFO : Browser exited with error code: 0 11:08:56 INFO - 2015-11-23 11:08:56,512 INFO : Completed test kraken (00:00:59) 11:08:56 INFO - 2015-11-23 11:08:56,513 INFO : Starting test v8_7 11:08:56 INFO - 2015-11-23 11:08:56,513 DEBUG : operating with platform_type : linux_ 11:08:56 INFO - 2015-11-23 11:08:56,513 INFO : Initialising browser for v8_7 test... 11:08:56 INFO - 2015-11-23 11:08:56,519 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVP2hgE/profile http://localhost:36456/getInfo.html 11:09:00 INFO - 2015-11-23 11:09:00,161 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:09:00 INFO - 2015-11-23 11:09:00,161 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:09:00 INFO - 2015-11-23 11:09:00,161 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:09:00 INFO - 2015-11-23 11:09:00,161 DEBUG : BROWSER_OUTPUT: __metrics 11:09:01 INFO - 2015-11-23 11:09:01,137 INFO : Browser initialized. 11:09:01 INFO - 2015-11-23 11:09:01,138 INFO : Running cycle 1/1 for v8_7 test... 11:09:01 INFO - 2015-11-23 11:09:01,139 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVP2hgE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:09:12 INFO - 2015-11-23 11:09:12,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 142024704 11:09:12 INFO - 2015-11-23 11:09:12,960 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36456/tests/v8_7/run.html (next: http://localhost:36456/tests/v8_7/run.html) 11:09:34 INFO - 2015-11-23 11:09:34,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 139255808 11:09:34 INFO - 2015-11-23 11:09:34,639 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:09:34 INFO - 2015-11-23 11:09:34,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:09:34 INFO - 2015-11-23 11:09:34,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |0;Richards;185.2881230313137 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1041.6666666666667 11:09:34 INFO - 2015-11-23 11:09:34,641 DEBUG : BROWSER_OUTPUT: |5;Earley;697.075208913649 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: |7;RegExp;25550 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: |8;Splay;683.2669322709163 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:09:34 INFO - 2015-11-23 11:09:34,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305774639__endTimestamp 11:09:34 INFO - 2015-11-23 11:09:34,643 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,644 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:09:34 INFO - 2015-11-23 11:09:34,644 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:09:34 INFO - 2015-11-23 11:09:34,644 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,644 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.29 Median:185.29 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,644 DEBUG : BROWSER_OUTPUT: Values: 185.3 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: Values: 188.7 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: Values: 281.4 11:09:34 INFO - 2015-11-23 11:09:34,645 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: Values: 5015.0 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1041.67 Median:1041.67 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: Values: 1041.7 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.08 Median:697.08 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,646 DEBUG : BROWSER_OUTPUT: Values: 697.1 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: Values: 12207.3 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: Values: 25550.0 11:09:34 INFO - 2015-11-23 11:09:34,647 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:683.27 Median:683.27 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: Values: 683.3 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:09:34 INFO - 2015-11-23 11:09:34,648 DEBUG : BROWSER_OUTPUT: 11:09:35 INFO - 2015-11-23 11:09:35,553 INFO : Browser exited with error code: 0 11:09:35 INFO - 2015-11-23 11:09:35,570 INFO : Completed test v8_7 (00:00:39) 11:09:35 INFO - 2015-11-23 11:09:35,631 INFO : Completed test suite (00:20:08) 11:09:35 INFO - 2015-11-23 11:09:35,632 DEBUG : Working with test: dromaeo_css 11:09:35 INFO - 2015-11-23 11:09:35,632 DEBUG : Generating results file: dromaeo_css 11:09:35 INFO - 2015-11-23 11:09:35,633 DEBUG : Working with test: kraken 11:09:35 INFO - 2015-11-23 11:09:35,633 DEBUG : Generating results file: kraken 11:09:35 INFO - 2015-11-23 11:09:35,633 INFO : javascript benchmark 11:09:35 INFO - 2015-11-23 11:09:35,633 DEBUG : Working with test: v8_7 11:09:35 INFO - 2015-11-23 11:09:35,634 DEBUG : Generating results file: v8_7 11:09:35 INFO - 2015-11-23 11:09:35,634 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:35 INFO - 2015-11-23 11:09:35,681 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:09:35 INFO - 2015-11-23 11:09:35,681 DEBUG : process_Request line: dromaeo_css 7053.45 graph.html#tests=[[72,64,43]] 11:09:35 INFO - 2015-11-23 11:09:35,681 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:35 INFO - 2015-11-23 11:09:35,712 DEBUG : process_Request line: kraken 1524.40 graph.html#tests=[[232,64,43]] 11:09:35 INFO - 2015-11-23 11:09:35,712 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:35 INFO - 2015-11-23 11:09:35,743 DEBUG : process_Request line: v8_7 21023.94 graph.html#tests=[[230,64,43]] 11:09:35 INFO - 2015-11-23 11:09:35,744 INFO : javascript benchmark 11:09:35 INFO - 2015-11-23 11:09:35,748 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.1985563536928, 3305.3719793239297, 3317.170707323168, 3329.084501762015, 3387.102417859268, 5377.4084850666395, 5579.246801681777, 5614.915776263354, 5635.351934527531, 5641.68970706611, 5449.04641687705, 5475.069238229501, 5542.057850165472, 5546.057170281052, 5574.554035677146, 5065.670731402456, 5101.132807422729, 5122.795088196468, 5138.563222126124, 5201.713905735183, 5194.688318700871, 5209.921851172236, 5232.764525596338, 5257.158854583267, 5265.578753699714, 4972.129877271463, 4981.078500477423, 5106.08090543702, 5119.334486516766, 5119.8208062717995, 5119.846404607868, 5129.589632829365, 5141.948580514184, 5149.918517111411, 5180.766865491062, 4912.0, 5096.79612815487, 5120.0, 5120.462351453081, 5137.0, 5179.14544100223, 5287.889543195934, 5351.384590772072, 5383.246345511631, 5410.242566040757, 6003.729832157564, 6052.667103309316, 6068.059450785091, 6083.330833608299, 6118.265808103011, 5849.7660093596205, 5970.761169553212, 6102.328743838174, 6107.26712794463, 6122.908156377658, 5518.613697041209, 5587.078132108238, 5593.077142271521, 5596.552275817925, 5639.577031722637, 6208.161898143693, 6210.472109870711, 6241.843953901189, 6244.906326405107, 6254.3745625437095, 5780.306363236438, 5811.15738217956, 5977.641341519436, 5987.520998320124, 5996.850078747979, 5896.262967129109, 5966.0752583348785, 5980.491658209014, 5991.790287340009, 6022.066579680157, 6025.9397406026255, 6027.547933904887, 6027.9095813562835, 6042.909356359658, 6047.818565443044, 5811.099279611667, 5863.794767183128, 5933.406659334119, 6002.189704389852, 6033.939660603338, 4662.184117779375, 4662.254039353687, 4664.883377915511, 4675.906481870344, 4680.836170734008, 4110.157417729359, 4150.792460376969, 4159.188958153131, 4167.499900011957, 4208.494980602347, 5464.9180262296095, 5671.064274394678, 5726.083826587809, 5728.914066289009, 5903.173555702205, 6104.175936248638, 6142.232220972379, 6147.231596050494, 6147.354527774519, 6168.568200226031, 5700.515456186271, 5741.598088133874, 5745.798897038583, 5747.540196784247, 5775.0, 5021.899562008739, 5109.770060347293, 5203.687778733288, 5215.035218484517, 5272.815451459257, 6304.117423560705, 6307.621542707452, 6322.873542529123, 6323.272823625342, 6333.714982825784, 5872.618279811799, 6130.2030736004035, 6138.877222455615, 6150.907736384047, 6189.102580125947, 6131.5295901671125, 6178.0, 6248.937510625017, 6267.561270711007, 6270.6551139685935, 5904.645721256738, 5946.226990491382, 5953.76184952597, 5964.015937370285, 5982.880342393215, 5865.237519122486, 5915.91126133117, 6017.638941663514, 6019.398060194121, 6028.306744724413, 5773.220615216892, 5858.091995740667, 5869.73586188614, 5869.970650146722, 5891.823245302648, 5890.028145355968, 5935.970320148372, 5942.108683697307, 5972.402759724167, 5974.970125149346, 5666.829995100154, 5667.773289068391, 5822.94177058224, 5825.970870145622, 5872.618279811799, 5939.287285525592, 5974.551908606785, 5975.282966044103, 5982.222311099529, 6009.849753756016, 5786.826395208151, 5796.94203057964, 5807.332156801853, 5838.036723940502, 5850.765969361178], "unit": "ms", "name": "dojo.html", "value": 5552.826496502163}, {"lowerIsBetter": false, "replicates": [568.5763074440337, 573.5239751006665, 585.9003969325214, 614.7633161232924, 617.2962822382482, 36397.45403818945, 36913.81543092284, 37010.44484332737, 37142.257154856954, 37206.0, 41372.17255654885, 41416.792916035454, 41782.0, 41839.58160418395, 42169.0, 8678.566071696421, 8809.95595022024, 8819.735407937773, 8823.470591764515, 8823.823523529525, 8515.148485151498, 8552.572371381437, 8661.783455413633, 8676.52279124651, 8678.479291242515, 8646.48121112732, 8732.738017859474, 8769.736907892773, 8774.517401542913, 8788.73633790984, 8710.346723995694, 8733.951925768917, 8759.912400875974, 8788.692395766182, 8804.295656347476, 8552.444091134057, 8646.394752367336, 8717.607707653171, 8722.781930451725, 8730.607122679494, 39028.21943561141, 39454.802725986476, 39501.40747888784, 39540.406893896325, 39562.40656390157, 3149.1812128846436, 3229.919252018695, 3243.2702641905616, 3255.7232635226032, 3483.1814523586936, 29261.56107658387, 29507.40985180306, 29511.262218444495, 29727.25681857971, 29986.0, 3835.673967712748, 3882.2623701496627, 3894.883153505399, 3950.4666869972475, 3988.0, 246946.0, 249128.0, 249764.0, 250386.0, 250777.0, 52838.0, 53780.46219537754, 54741.726291368286, 54809.72595136999, 55004.174937375974, 64218.67890660517, 65441.0, 65461.345386546476, 65554.34445655577, 65557.67221163864, 14490.85509144916, 14571.198584077765, 14578.562643120724, 14703.632409189855, 14704.485343013157, 10609.681709548726, 10629.362238265729, 10646.414447205478, 10648.0, 10653.733656658645, 18905.90547047256, 19046.61906761885, 19126.139323730466, 19161.32935347256, 19192.71210931837, 7700.691972321157, 7955.920440795634, 7965.283124518821, 7983.2016798320865, 8075.959620201861, 822.8562298405221, 913.6528119314618, 944.5749412764284, 984.3109823123842, 1031.566741968375, 27798.583021254697, 28818.279543011173, 28857.711422885503, 29081.272968175967, 29499.410011799642, 957.3107362698846, 1028.5011769291887, 1036.1503567075076, 1053.562771449855, 1099.8130317845985, 13677.769000789778, 14125.0, 14264.714705705828, 14364.281785910664, 14462.927685361507, 309632.0, 314376.0, 315714.0, 317290.0, 317391.0, 48118.75940620274, 48646.513534864906, 48669.756651216514, 48762.756186218845, 48786.268205976936, 1301.9349032548334, 1308.5289295853675, 1328.5748560460754, 1341.6779972806455, 1362.346073884541, 26184.0, 26667.199984000512, 27028.33975992025, 27161.185164445098, 27385.726142738316, 44485.0, 44753.0, 44768.10463790771, 44803.775981119885, 45061.32408013948, 285593.0, 286821.0, 287054.0, 287238.0, 287368.0, 29880.85059574688, 31498.527522087647, 31759.206019849687, 31829.20426989344, 31932.840335798173, 38365.424518631684, 38489.0, 38861.2227755449, 39366.409503858034, 39470.2105957885, 32937.17657058593, 34593.0, 35549.0, 35697.82151089228, 36098.63901360953, 34868.0, 34946.0, 34977.825110874284, 35466.64533354736, 35650.28699426049, 34466.138346541535, 34749.13127171841, 34843.30313393667, 35017.32318106664, 35177.12057198488, 31334.0, 31660.366792664478, 32069.358612827145, 32132.35735285328, 32161.715185207624, 24759.133430329854, 24928.87535562383, 24964.500709986063, 25019.0, 25157.87421062883], "unit": "ms", "name": "ext.html", "value": 18035.22502019395}, {"lowerIsBetter": false, "replicates": [353.7594435783666, 354.14120757163886, 358.9766665166764, 359.1631498608243, 364.0353064379395, 16498.175091245434, 16854.578635534104, 17382.652346953055, 17560.0, 18037.27850885966, 15536.300866461008, 15751.60620984476, 15875.126868022255, 15905.681886362267, 16128.193590320496, 4788.856334309968, 4951.059298733229, 4956.950430495703, 4957.231629097496, 4962.5533701966815, 4869.123557759602, 4891.437484689271, 4924.28597853311, 4926.45808961014, 4954.033963377143, 4934.0, 5095.6942583444925, 5249.711265880375, 5272.23552584875, 5281.392639846428, 4387.62705170061, 5293.761780719858, 5301.1783173608155, 5321.973390133044, 5533.529649979716, 5295.920561191547, 5301.655392399482, 5319.414864364917, 5324.387695415038, 5329.094054010828, 12257.693557661041, 14791.0, 20292.188312467482, 20976.0, 21023.789762102337, 2013.224908410258, 2084.770675225724, 2086.3636590839787, 2096.2139197800825, 2130.8082272595384, 9230.630774769, 9406.153446189875, 9409.200217981479, 9747.756306092333, 10159.33964292326, 1807.4396936949456, 1864.766904136983, 1873.9250429982785, 1884.8774829636168, 1899.2118270917554, 59003.70498147482, 59081.40918590802, 59906.70046649739, 60089.5964161433, 60664.69667651634, 10062.24533160016, 10172.593096276067, 10230.6419275325, 10392.636257730943, 10420.635277765241, 12771.489140434465, 13240.602781916557, 13254.73490530184, 13265.66835829112, 13334.399952002183, 7004.334588214111, 7193.820154496075, 7276.272372762787, 7315.341619254293, 7324.08448943882, 7064.50548461613, 7140.0, 7159.821004474929, 7160.785176444715, 7177.318154775288, 4413.16149931512, 4471.396361491157, 4477.440319960005, 4501.909961800746, 4571.38286331341, 1821.7267409888357, 1821.7358483020153, 1837.044736736916, 1889.0, 1917.2618541861204, 857.5497863621524, 920.9585568649427, 925.1904583489446, 996.1831298335295, 1067.754416484213, 15080.849191508163, 16338.18309084541, 16472.25874835635, 16835.494935151964, 17193.570160745832, 902.5126431726794, 905.7871400220943, 1001.1690297053428, 1020.9387436753818, 1043.0404028293988, 9620.182284505756, 9984.0, 9992.950035249924, 10001.649942251986, 10027.949860250797, 501763.0, 516536.0, 517427.0, 532671.0, 538169.0, 77822.6108869452, 80277.97220278042, 80436.0, 82513.58743206246, 82634.58682706548, 1159.9362035087981, 1163.96508104757, 1171.6485054483792, 1172.935488548121, 1176.2824676947055, 14894.106353618818, 14954.700905982038, 15057.17185554805, 15134.545963621109, 15207.391704331703, 31180.844095779375, 32461.350772983937, 33254.334913301114, 33433.492488063006, 34194.82902585571, 43138.254791973486, 43568.56431435772, 44994.32508512309, 45057.774711126236, 45169.0, 9336.813263734823, 9472.763180920532, 9742.853857192005, 9781.41311521311, 9818.361806482555, 11432.885671143182, 11475.770484590428, 16985.575360616083, 17756.112194390487, 18092.547686307422, 14486.130832150106, 14716.0, 14814.0, 15005.474808381654, 15108.169050702318, 13850.238236897067, 14489.913256506015, 14612.415503379745, 14849.777253340992, 15103.622409439413, 14855.92572037133, 14933.178675172536, 15058.397664093314, 15068.472603458826, 15201.163935983184, 9324.254059675346, 9376.906230937604, 9443.386179898285, 9558.044195580387, 9739.9026009739, 9986.400815951067, 10095.44475053879, 13426.39581218867, 13642.727145456836, 14386.568402947929], "unit": "ms", "name": "jquery.html", "value": 8714.634310909953}, {"lowerIsBetter": false, "replicates": [1506.2167672810133, 1629.5437277562282, 1742.6950283700357, 1745.8777885548018, 1760.5862622283762, 6659.034440006196, 6731.8653626927435, 7284.890726639098, 7422.960785490036, 7452.254774522552, 7514.81212969676, 7694.576798276093, 7744.186860379664, 7748.031496062992, 7761.57311347877, 2263.321003698888, 2294.7705229477087, 2299.41364951937, 2300.861948283108, 2301.6547517872286, 2291.46150654596, 2292.1289909834322, 2303.193882141254, 2325.848819826714, 2333.1017558240114, 2257.3228031590456, 2272.8068114210314, 2293.2317673579373, 2299.1148407862925, 2307.088699963522, 2249.640057590778, 2265.1732117777055, 2283.0525331987205, 2283.9200627978025, 2294.7705229477, 2339.181286549711, 2350.3771500552366, 2359.3393849722106, 2361.929142125739, 2362.043372434167, 7606.0, 7676.309132178131, 7689.38484921205, 7690.615469226516, 7695.692172313101, 4698.318743782167, 4761.262004389325, 4764.857054288377, 4793.9280910786365, 4798.640101992364, 3142.4500712375243, 3169.5721077654453, 3186.4105140549073, 3219.983900080508, 3239.951400728991, 1057.2176589323922, 1064.239069065614, 1073.4364458659188, 1078.8975047370486, 1081.3836113415357, 10627.84058239127, 10648.840267395995, 10709.78580428387, 10721.624743133953, 10740.462976851126, 4331.696781225284, 4333.9133217335475, 4407.2507673695545, 4409.382686423904, 4424.623906967944, 9165.0, 9168.083191680778, 9217.308701847389, 9224.584893679801, 9228.307876909259, 4793.13723529768, 4801.663883528119, 4802.759862006886, 4803.759812009385, 4811.326414302001, 4335.566443355639, 4369.191699535596, 4369.563043695605, 4449.933251001173, 4474.105178964221, 3759.2293579816073, 3786.583475817658, 3818.1981783825154, 3835.271298453285, 3841.9039524012123, 1243.7636848998661, 1249.6001279590444, 1250.7185883176212, 1253.185429470833, 1265.1333836322149, 1285.9035572332114, 1287.8325817643647, 1296.1963582578674, 1311.2132720367895, 1311.8819306262292, 7153.998440218374, 7272.527285726411, 7304.963475182696, 7328.377087947478, 7348.559086454829, 449.98425055122914, 453.14582012905254, 458.601017115112, 460.1579110228274, 461.0985523301937, 5661.179129026268, 5695.857603559944, 5701.315842098892, 5708.0, 5746.166805813217, 8967.686130985385, 9003.864942025875, 9214.0, 9362.06379362072, 9386.202172815387, 9042.547872606343, 9092.727218183465, 9160.221381182673, 9172.220361269234, 9173.0, 7173.246809084971, 7248.130224373003, 7249.673764680708, 7316.780496585111, 7319.597422141726, 6910.101686780687, 6943.722251109899, 6943.861122777617, 6955.826104347432, 6966.12923384577, 8008.079070906921, 8219.671213151407, 8240.464369815943, 8292.626831792462, 8297.917020829957, 8300.667973281, 8349.248567628943, 8350.665973361241, 8458.873116903129, 8506.829863402822, 5961.940380596312, 6297.307296197506, 6389.648569328731, 6516.185476815398, 6796.66016699173, 7474.103107627119, 7474.7757567273065, 7515.661795219119, 7551.962240188764, 7559.3196612305155, 6817.216020157745, 7048.823779405351, 7070.787876363717, 7099.112610923635, 7117.501774875916, 6872.587644741331, 6940.236573976959, 7018.2630823762765, 7063.57618542889, 7132.465065120033, 6703.765368212089, 6742.393184613408, 6785.491088168308, 6793.72825086991, 6815.89776153368, 6436.742530298736, 6483.740650373932, 6484.059811327425, 6484.837879053061, 6488.772892948913, 6250.3749625037135, 6407.743690252338, 6480.611163330215, 6486.740530378921, 6527.967360163168], "unit": "ms", "name": "mootools.html", "value": 4407.2275940829795}, {"lowerIsBetter": false, "replicates": [329.3347438174887, 336.9157710572357, 338.6613386613387, 341.085889815295, 342.9777064490808, 6359.55483116182, 6365.331640177778, 6376.521760867942, 6387.744490220397, 6537.9212429949, 6325.810225693236, 6399.2640846302575, 6418.646974416405, 6427.871442571158, 6435.710393032313, 4858.955324605209, 4860.513948605147, 4861.416630004404, 4863.68386054907, 4868.2697595360805, 4856.781444834974, 4859.757012149396, 4881.145799485093, 4884.560389564938, 4900.558949694527, 4582.427196600425, 4634.768261586907, 4707.882302942419, 4716.481187069419, 4725.763711814413, 4717.127331443694, 4719.174144524729, 4733.053389322132, 4736.052789442108, 4740.07568524138, 4057.2696914555368, 4061.959380406188, 4069.7558146511305, 4071.4503542021744, 4072.816723247461, 6086.513078953673, 6094.725737341831, 6094.963856144466, 6096.908546371808, 6101.420365065312, 5442.673439593597, 5535.529479994206, 5581.916271255935, 5588.966041282376, 5591.993441180586, 6739.561928474683, 6749.493787965922, 6752.189737231514, 6761.4590832733265, 6778.661066946633, 4543.341215523764, 4546.613537849286, 4561.40701708779, 4573.222552166139, 4576.199165146119, 6954.09596752424, 7055.25919778421, 7136.0, 7142.392896603795, 7146.24964378738, 4503.851517862924, 4504.887377815581, 4509.774511274489, 4518.864434066983, 4527.366168736379, 4553.749543775124, 4564.269716845289, 4571.291449825282, 4575.81696732127, 4578.542145785462, 5433.972830135903, 5441.2654291670115, 5446.8910621787345, 5447.319085114361, 5449.700266485382, 6716.126903502513, 6851.45188384928, 6859.348361905611, 6862.245153033163, 6872.312768723188, 1647.0, 1647.8681705463534, 1648.332425367728, 1648.4724888035714, 1649.8102718187322, 1097.9066779323846, 1099.6096385782932, 1102.2780079048237, 1105.3754628634795, 1118.4631376939114, 6571.3757193066585, 6580.868382632416, 6581.440577550866, 6603.70283337251, 6611.371919667624, 7002.0, 7016.0, 7023.543469674455, 7026.683799229047, 7085.43316534676, 6464.41820236181, 6568.8029359118345, 6573.7370505180215, 6657.800265992028, 6691.5650482718465, 3837.6929845612285, 3851.383778595411, 3863.285292220948, 3866.7873266970587, 3892.2215556888737, 7398.186199518049, 7402.925970740223, 7419.183889772121, 7420.9257907421315, 7428.591427471433, 7160.355567998905, 7325.047743793273, 7338.816529586697, 7345.485815992829, 7371.926280737124, 7376.889346659805, 7384.0, 7394.0, 7394.667239974106, 7416.629168541552, 7006.6846991886505, 7116.501844871016, 7139.535930164523, 7149.0706208192605, 7155.606441645759, 7030.367266945999, 7034.788956331318, 7037.683304251219, 7039.8944015840825, 7041.3310735480045, 7376.7049318026675, 7389.0, 7398.11222653285, 7400.851982960418, 7415.1101867776215, 4642.862498687843, 4668.369770080995, 4679.27471241958, 4691.249400095969, 4724.503927087744, 7072.3634872861685, 7100.715971361088, 7123.430125590044, 7134.643267836484, 7142.428605711634, 6874.828129296808, 6883.690233939385, 6896.896546551706, 6901.137357830271, 6926.896096558455, 6777.593344399352, 6801.2858649841055, 6864.553804002724, 6868.244493105654, 6869.347411995853, 6748.325167483213, 6761.850485417589, 6796.524243302922, 6803.217629972419, 6810.761623343159, 6870.0, 6911.827204319932, 6932.549384290005, 6933.237343892269, 6939.375456208965, 6581.3747693969, 6729.2934241903895, 6742.157230346207, 6753.561018533779, 6763.695633696397], "unit": "ms", "name": "prototype.html", "value": 5083.522614005132}, {"lowerIsBetter": false, "replicates": [773.2847116417314, 812.3988248695966, 830.5755629096101, 845.4082142500248, 860.2902605350587, 13502.527411540597, 13652.24912629805, 13811.447542098316, 13821.51624693136, 13877.583672489829, 12881.098323117385, 12944.0, 12984.545540906047, 12991.545295914644, 13006.284654344006, 663.8174502011962, 666.3436515032689, 781.7576551269096, 790.8062524681446, 809.0574480729942, 808.337163525909, 810.8297257575916, 815.2458975447717, 816.0207750699155, 818.8976377952756, 837.8910741603582, 846.2595229174473, 846.4202021615213, 847.4195176304252, 850.090403268503, 838.4633834345993, 838.8573942429801, 839.7858546070713, 843.8734189871507, 846.6571038729325, 619.3837132053591, 619.6932518403374, 619.7211254935252, 621.8631900981777, 622.2408661433044, 13670.384832682554, 13833.170009799444, 13836.584902452943, 13843.377048032862, 13887.79168312476, 11868.0, 12276.0, 12351.505939762399, 12540.310282934435, 12678.0, 10184.694459166238, 10528.210384221138, 10665.253432259746, 10929.781404371868, 11063.612773552886, 3716.721245906541, 3764.0025393270807, 3796.1268908151005, 3883.7475564088527, 3892.5912779158066, 45617.54382456166, 46309.0, 46397.768011160064, 46451.0, 46543.767281163375, 9464.290178236659, 9822.65620703272, 9885.901140988643, 9976.301658883809, 10118.139958103644, 18333.633327333646, 18400.907995459937, 18441.53896152607, 19313.8068619312, 19373.612527749367, 7603.847923041508, 7734.961325193338, 7786.766397007986, 7889.447738658238, 7935.325497332791, 4148.983499042693, 4233.386159006988, 4243.405923170759, 4286.978565107154, 4376.0, 3233.4664780311455, 3267.18320419895, 3272.1165285372817, 3284.819334936554, 3290.8025518468967, 575.3383608849856, 581.8778056608076, 582.3972188784587, 586.2818047891299, 612.8988716861757, 549.4258499867648, 649.2792999770252, 653.8103949854489, 662.5461558832216, 671.3286713286714, 7945.801354966172, 8123.837523249502, 8365.205305495969, 8419.536925469036, 8437.746867593982, 518.346882927514, 594.9261582842923, 607.2106261859565, 624.6658037949675, 663.9900401493982, 3740.3080430120513, 3795.7153213509096, 3860.4595356650093, 3909.980450097788, 3941.1723538056754, 53808.0, 57316.426835731945, 57848.0, 57986.7100664494, 58491.70754146202, 51378.22932655938, 51693.48306516887, 52149.7392513035, 52201.2169817453, 52231.47768522342, 47305.76347118242, 47533.0, 47953.28070078952, 48644.27033594499, 48649.51350486521, 8110.107888132418, 8242.587870606565, 8309.0, 8346.62440190205, 8455.450395724258, 33904.3219135611, 33923.32153356968, 34473.482897756054, 34764.0, 35016.47475287822, 43591.0, 46976.7651161742, 47230.76384618055, 47740.7612961933, 47885.28172077491, 11121.610743623934, 11141.0, 11174.659040915143, 11188.384638844942, 11204.271722338022, 12244.877551224374, 12305.138640295094, 12330.260184388966, 12550.560730374393, 12575.434105465092, 10702.571897124028, 10778.29941053829, 10796.0, 11101.333919964827, 11320.26418282809, 10989.560417583207, 11265.324080555192, 11303.71740706456, 11518.539258429904, 11566.421678915853, 10689.251752377259, 10978.725531861448, 11097.722556936142, 11123.221374503708, 11476.426178690865, 9869.132786599312, 9873.111419972238, 9933.701988940344, 10161.085502304531, 10182.083612474913, 8378.77642001367, 8394.202550757669, 8801.38390312672, 9543.42739435636, 9622.230221582116], "unit": "ms", "name": "yui.html", "value": 6297.353459857899}], "name": "dromaeo_css", "value": 7053.447878586684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 110.0, 110.0, 121.0, 110.0, 111.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [148.0, 130.0, 152.0, 169.0, 137.0, 161.0, 164.0, 126.0, 163.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 166.0, 162.0, 162.0, 164.0, 163.0, 163.0, 163.0, 171.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 70.0, 71.0, 74.0, 148.0, 72.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 134.0, 92.0, 94.0, 93.0, 137.0, 93.0, 94.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 149.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 102.0, 97.0, 97.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 65.0, 65.0, 62.0, 61.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 92.0, 85.0, 86.0, 91.0, 85.0, 87.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 120.0, 132.0, 121.0, 122.0, 123.0, 121.0, 123.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [152.0, 151.0, 159.0, 152.0, 151.0, 150.0, 153.0, 150.0, 151.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 75.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1524.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [185.2881230313137], "unit": "score", "name": "Richards", "value": 190.52489399999993}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [1041.6666666666667], "unit": "score", "name": "RayTrace", "value": 710.3894399999999}, {"lowerIsBetter": false, "replicates": [697.075208913649], "unit": "score", "name": "Earley", "value": 956.084783216783}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [683.2669322709163], "unit": "score", "name": "Splay", "value": 119.2667113702624}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21023.94293385637}]} 11:09:35 INFO - RETURN: dromaeo_css: 7053.45 11:09:35 INFO - RETURN: kraken: 1524.40 11:09:35 INFO - RETURN: v8_7: 21023.94 11:09:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21023.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7053.45"}}} 11:09:35 INFO - Return code: 0 11:09:35 INFO - # TBPL SUCCESS # 11:09:35 INFO - Running post-action listener: _resource_record_post_action 11:09:35 INFO - Running post-run listener: _resource_record_post_run 11:09:36 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526209024; Read time: 12; Write time: 449824 11:09:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242225152; Read time: 0; Write time: 284956 11:09:36 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283983872; Read time: 12; Write time: 164868 11:09:36 INFO - Running post-run listener: _upload_blobber_files 11:09:36 INFO - Blob upload gear active. 11:09:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:09:36 INFO - Copying logs to upload dir... 11:09:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.137796 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 11:09:36.260202) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:09:36.263761) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010095 build_url: 'https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:09:36.319288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:09:36.319647) ========= 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=6587686cb2da90a5f91b3170000001be-1448298994.439915-2054025180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:09:36.370200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:09:36.370511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:09:36.370825) ========= ========= Total master_lag: 0.27 =========