builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1448083368.8 results: success (0) buildid: 20151120173025 builduid: 651ab1dec87a48b596125f5f8a8ea728 revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.798487) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.798848) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.799126) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006679 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.826479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.826759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.882803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.883233) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004742 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.938152) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.938456) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.938832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:48.939120) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 21:22:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 137M=0s 2015-11-20 21:22:50 (137 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174056 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.137753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.138047) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017454 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.194315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.194661) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 21:22:50,927 truncating revision to first 12 chars 2015-11-20 21:22:50,927 Setting DEBUG logging. 2015-11-20 21:22:50,927 attempt 1/10 2015-11-20 21:22:50,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/809ef65b4a96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 21:22:51,168 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.747471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.747830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.756781) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.757194) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 21:22:49.757730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-20 21:22:49.758043) ========= /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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:22:51 INFO - MultiFileLogger online at 20151120 21:22:51 in /builds/slave/test-pgo 21:22:51 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 21:22:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:22:51 INFO - {'append_to_log': False, 21:22:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:22:51 INFO - 'blob_upload_branch': 'Fx-Team', 21:22:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:22:51 INFO - 'branch': 'Fx-Team', 21:22:51 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:51 INFO - 'config_files': ('talos/linux_config.py',), 21:22:51 INFO - 'default_actions': ('clobber', 21:22:51 INFO - 'read-buildbot-config', 21:22:51 INFO - 'download-and-extract', 21:22:51 INFO - 'populate-webroot', 21:22:51 INFO - 'create-virtualenv', 21:22:51 INFO - 'install', 21:22:51 INFO - 'run-tests'), 21:22:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:51 INFO - 'download_minidump_stackwalk': True, 21:22:51 INFO - 'download_symbols': 'ondemand', 21:22:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:51 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:51 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:51 INFO - 'installer_path': 'installer.exe', 21:22:51 INFO - 'log_level': 'info', 21:22:51 INFO - 'log_name': 'talos', 21:22:51 INFO - 'log_to_console': True, 21:22:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:22:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:22:51 INFO - 'opt_config_files': (), 21:22:51 INFO - 'pip_index': False, 21:22:51 INFO - 'sps_profile': False, 21:22:51 INFO - 'sps_profile_interval': 0, 21:22:51 INFO - 'suite': 'dromaeojs-e10s', 21:22:51 INFO - 'system_bits': '64', 21:22:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:51 INFO - 'title': 'talos-linux64-ix-061', 21:22:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:51 INFO - 'use_talos_json': True, 21:22:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:22:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:51 INFO - 'work_dir': 'build'} 21:22:51 INFO - ##### 21:22:51 INFO - ##### Running clobber step. 21:22:51 INFO - ##### 21:22:51 INFO - Running pre-action listener: _resource_record_pre_action 21:22:51 INFO - Running main action method: clobber 21:22:51 INFO - rmtree: /builds/slave/test-pgo/build 21:22:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:22:52 INFO - Running post-action listener: _resource_record_post_action 21:22:52 INFO - ##### 21:22:52 INFO - ##### Running read-buildbot-config step. 21:22:52 INFO - ##### 21:22:52 INFO - Running pre-action listener: _resource_record_pre_action 21:22:52 INFO - Running main action method: read_buildbot_config 21:22:52 INFO - Using buildbot properties: 21:22:52 INFO - { 21:22:52 INFO - "properties": { 21:22:52 INFO - "buildnumber": 69, 21:22:52 INFO - "product": "firefox", 21:22:52 INFO - "script_repo_revision": "production", 21:22:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:22:52 INFO - "repository": "", 21:22:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:22:52 INFO - "buildid": "20151120173025", 21:22:52 INFO - "slavename": "talos-linux64-ix-061", 21:22:52 INFO - "pgo_build": "True", 21:22:52 INFO - "basedir": "/builds/slave/test-pgo", 21:22:52 INFO - "project": "", 21:22:52 INFO - "platform": "ubuntu64_hw", 21:22:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:22:52 INFO - "slavebuilddir": "test", 21:22:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:22:52 INFO - "branch": "fx-team", 21:22:52 INFO - "repo_path": "integration/fx-team", 21:22:52 INFO - "stage_platform": "linux64-pgo", 21:22:52 INFO - "builduid": "651ab1dec87a48b596125f5f8a8ea728", 21:22:52 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 21:22:52 INFO - }, 21:22:52 INFO - "sourcestamp": { 21:22:52 INFO - "repository": "", 21:22:52 INFO - "hasPatch": false, 21:22:52 INFO - "project": "", 21:22:52 INFO - "branch": "fx-team-linux64-pgo-talos", 21:22:52 INFO - "changes": [ 21:22:52 INFO - { 21:22:52 INFO - "category": null, 21:22:52 INFO - "files": [ 21:22:52 INFO - { 21:22:52 INFO - "url": null, 21:22:52 INFO - "name": "https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:22:52 INFO - } 21:22:52 INFO - ], 21:22:52 INFO - "repository": "", 21:22:52 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 21:22:52 INFO - "who": "sendchange", 21:22:52 INFO - "when": 1448083317, 21:22:52 INFO - "number": 6691945, 21:22:52 INFO - "comments": "", 21:22:52 INFO - "project": "", 21:22:52 INFO - "at": "Fri 20 Nov 2015 21:21:57", 21:22:52 INFO - "branch": "fx-team-linux64-pgo-talos", 21:22:52 INFO - "revlink": "", 21:22:52 INFO - "properties": [ 21:22:52 INFO - [ 21:22:52 INFO - "buildid", 21:22:52 INFO - "20151120173025", 21:22:52 INFO - "Change" 21:22:52 INFO - ], 21:22:52 INFO - [ 21:22:52 INFO - "builduid", 21:22:52 INFO - "651ab1dec87a48b596125f5f8a8ea728", 21:22:52 INFO - "Change" 21:22:52 INFO - ], 21:22:52 INFO - [ 21:22:52 INFO - "pgo_build", 21:22:52 INFO - "True", 21:22:52 INFO - "Change" 21:22:52 INFO - ] 21:22:52 INFO - ], 21:22:52 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 21:22:52 INFO - } 21:22:52 INFO - ], 21:22:52 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 21:22:52 INFO - } 21:22:52 INFO - } 21:22:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:22:52 INFO - Running post-action listener: _resource_record_post_action 21:22:52 INFO - ##### 21:22:52 INFO - ##### Running download-and-extract step. 21:22:52 INFO - ##### 21:22:52 INFO - Running pre-action listener: _resource_record_pre_action 21:22:52 INFO - Running main action method: download_and_extract 21:22:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:52 INFO - https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/test_packages.json 21:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/test_packages.json 21:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:22:55 INFO - Downloaded 1302 bytes. 21:22:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:22:55 INFO - Using the following test package requirements: 21:22:55 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:55 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:22:55 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'jsshell-linux-x86_64.zip'], 21:22:55 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:22:55 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:55 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:22:55 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:22:55 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:22:55 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:55 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:22:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:55 INFO - https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:22:57 INFO - Downloaded 22524366 bytes. 21:22:57 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 21:22:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:22:57 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 21:22:58 INFO - Return code: 0 21:22:58 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 21:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:58 INFO - https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:23:00 INFO - Downloaded 22524366 bytes. 21:23:00 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 21:23:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:23:00 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 21:23:02 INFO - Return code: 0 21:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:02 INFO - https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:23:03 INFO - Downloaded 11130997 bytes. 21:23:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:23:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:23:03 INFO - Return code: 0 21:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:03 INFO - https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0S20jQ-QymtX058KVDJWw/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 21:23:04 INFO - Downloaded 57445965 bytes. 21:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:23:04 INFO - mkdir: /builds/slave/test-pgo/properties 21:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:23:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:23:04 INFO - Contents: 21:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:23:04 INFO - Running post-action listener: _resource_record_post_action 21:23:04 INFO - Running post-action listener: set_extra_try_arguments 21:23:04 INFO - ##### 21:23:04 INFO - ##### Running populate-webroot step. 21:23:04 INFO - ##### 21:23:04 INFO - Running pre-action listener: _resource_record_pre_action 21:23:04 INFO - Running main action method: populate_webroot 21:23:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:23:04 INFO - '../fennec_ids.txt'], 21:23:04 INFO - 'tests': ['tcheck2']}, 21:23:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:04 INFO - '--tppagecycles', 21:23:04 INFO - '7'], 21:23:04 INFO - 'tests': ['tsvgm']}}, 21:23:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:23:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:23:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:23:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'tests': ['damp', 'tps']}, 21:23:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['damp', 'tps']}, 21:23:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:23:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:04 INFO - 'other': {'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'other_l64': {'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'other_nol64': {'tests': ['a11yr', 21:23:04 INFO - 'ts_paint', 21:23:04 INFO - 'tpaint', 21:23:04 INFO - 'sessionrestore', 21:23:04 INFO - 'sessionrestore_no_auto_restore']}, 21:23:04 INFO - 'svgr': {'tests': ['tsvgx', 21:23:04 INFO - 'tsvgr_opacity', 21:23:04 INFO - 'tart', 21:23:04 INFO - 'tscrollx', 21:23:04 INFO - 'cart']}, 21:23:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['tsvgx', 21:23:04 INFO - 'tsvgr_opacity', 21:23:04 INFO - 'tart', 21:23:04 INFO - 'tscrollx', 21:23:04 INFO - 'cart']}, 21:23:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'tests': ['tp5o']}, 21:23:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'talos_options': ['--e10s'], 21:23:04 INFO - 'tests': ['tp5o']}, 21:23:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'talos_options': ['--xperf_path', 21:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:04 INFO - 'tests': ['tp5n']}, 21:23:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:04 INFO - 'talos_options': ['--e10s', 21:23:04 INFO - '--xperf_path', 21:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:04 INFO - 'tests': ['tp5n']}}, 21:23:04 INFO - 'talos.zip': {'path': '', 21:23:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:04 INFO - Running post-action listener: _resource_record_post_action 21:23:04 INFO - ##### 21:23:04 INFO - ##### Running create-virtualenv step. 21:23:04 INFO - ##### 21:23:04 INFO - Running pre-action listener: _resource_record_pre_action 21:23:04 INFO - Running main action method: create_virtualenv 21:23:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:23:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:23:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:23:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:04 INFO - Using real prefix '/usr' 21:23:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:07 INFO - Installing pip.................done. 21:23:07 INFO - Return code: 0 21:23:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:23:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:23:07 INFO - Using env: {'DISPLAY': ':0', 21:23:07 INFO - 'HOME': '/home/cltbld', 21:23:07 INFO - 'LANG': 'en_US.UTF-8', 21:23:07 INFO - 'LANGUAGE': 'en_US:en', 21:23:07 INFO - 'LOGNAME': 'cltbld', 21:23:07 INFO - 'MAIL': '/var/mail/cltbld', 21:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:07 INFO - 'MOZ_NO_REMOTE': '1', 21:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:07 INFO - 'NO_EM_RESTART': '1', 21:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:07 INFO - 'SHELL': '/bin/bash', 21:23:07 INFO - 'SHLVL': '1', 21:23:07 INFO - 'TERM': 'linux', 21:23:07 INFO - 'TMOUT': '86400', 21:23:07 INFO - 'USER': 'cltbld', 21:23:07 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:07 INFO - '_': '/tools/buildbot/bin/python'} 21:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:23:07 INFO - Cleaning up... 21:23:07 INFO - Return code: 0 21:23:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:23:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:23:07 INFO - Using env: {'DISPLAY': ':0', 21:23:07 INFO - 'HOME': '/home/cltbld', 21:23:07 INFO - 'LANG': 'en_US.UTF-8', 21:23:07 INFO - 'LANGUAGE': 'en_US:en', 21:23:07 INFO - 'LOGNAME': 'cltbld', 21:23:07 INFO - 'MAIL': '/var/mail/cltbld', 21:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:07 INFO - 'MOZ_NO_REMOTE': '1', 21:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:07 INFO - 'NO_EM_RESTART': '1', 21:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:07 INFO - 'SHELL': '/bin/bash', 21:23:07 INFO - 'SHLVL': '1', 21:23:07 INFO - 'TERM': 'linux', 21:23:07 INFO - 'TMOUT': '86400', 21:23:07 INFO - 'USER': 'cltbld', 21:23:07 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:07 INFO - '_': '/tools/buildbot/bin/python'} 21:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:07 INFO - Downloading/unpacking psutil>=0.7.1 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:23:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:23:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:09 INFO - Installing collected packages: psutil 21:23:09 INFO - Running setup.py install for psutil 21:23:09 INFO - building 'psutil._psutil_linux' extension 21:23:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:23:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:23:09 INFO - building 'psutil._psutil_posix' extension 21:23:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:23:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:09 INFO - Successfully installed psutil 21:23:09 INFO - Cleaning up... 21:23:09 INFO - Return code: 0 21:23:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:09 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 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:09 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 21:23:09 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 21:23:09 INFO - Using env: {'DISPLAY': ':0', 21:23:09 INFO - 'HOME': '/home/cltbld', 21:23:09 INFO - 'LANG': 'en_US.UTF-8', 21:23:09 INFO - 'LANGUAGE': 'en_US:en', 21:23:09 INFO - 'LOGNAME': 'cltbld', 21:23:09 INFO - 'MAIL': '/var/mail/cltbld', 21:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:09 INFO - 'MOZ_NO_REMOTE': '1', 21:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:09 INFO - 'NO_EM_RESTART': '1', 21:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:09 INFO - 'SHELL': '/bin/bash', 21:23:09 INFO - 'SHLVL': '1', 21:23:09 INFO - 'TERM': 'linux', 21:23:09 INFO - 'TMOUT': '86400', 21:23:09 INFO - 'USER': 'cltbld', 21:23:09 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:09 INFO - '_': '/tools/buildbot/bin/python'} 21:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:23:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:23:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:23:11 INFO - Installing collected packages: mozsystemmonitor 21:23:11 INFO - Running setup.py install for mozsystemmonitor 21:23:11 INFO - Successfully installed mozsystemmonitor 21:23:11 INFO - Cleaning up... 21:23:11 INFO - Return code: 0 21:23:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:23: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')]} 21:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', '--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 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:11 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 21:23:11 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 21:23:11 INFO - Using env: {'DISPLAY': ':0', 21:23:11 INFO - 'HOME': '/home/cltbld', 21:23:11 INFO - 'LANG': 'en_US.UTF-8', 21:23:11 INFO - 'LANGUAGE': 'en_US:en', 21:23:11 INFO - 'LOGNAME': 'cltbld', 21:23:11 INFO - 'MAIL': '/var/mail/cltbld', 21:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:11 INFO - 'MOZ_NO_REMOTE': '1', 21:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:11 INFO - 'NO_EM_RESTART': '1', 21:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:11 INFO - 'SHELL': '/bin/bash', 21:23:11 INFO - 'SHLVL': '1', 21:23:11 INFO - 'TERM': 'linux', 21:23:11 INFO - 'TMOUT': '86400', 21:23:11 INFO - 'USER': 'cltbld', 21:23:11 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:11 INFO - '_': '/tools/buildbot/bin/python'} 21:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:23:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:23:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:23:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:14 INFO - Downloading docopt-0.6.1.tar.gz 21:23:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:23:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:14 INFO - Running setup.py install for blobuploader 21:23:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:23:14 INFO - Running setup.py install for requests 21:23:14 INFO - Running setup.py install for docopt 21:23:15 INFO - Successfully installed blobuploader requests docopt 21:23:15 INFO - Cleaning up... 21:23:15 INFO - Return code: 0 21:23:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 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 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:15 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 21:23:15 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 21:23:15 INFO - Using env: {'DISPLAY': ':0', 21:23:15 INFO - 'HOME': '/home/cltbld', 21:23:15 INFO - 'LANG': 'en_US.UTF-8', 21:23:15 INFO - 'LANGUAGE': 'en_US:en', 21:23:15 INFO - 'LOGNAME': 'cltbld', 21:23:15 INFO - 'MAIL': '/var/mail/cltbld', 21:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:15 INFO - 'MOZ_NO_REMOTE': '1', 21:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:15 INFO - 'NO_EM_RESTART': '1', 21:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:15 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:15 INFO - 'SHELL': '/bin/bash', 21:23:15 INFO - 'SHLVL': '1', 21:23:15 INFO - 'TERM': 'linux', 21:23:15 INFO - 'TMOUT': '86400', 21:23:15 INFO - 'USER': 'cltbld', 21:23:15 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:15 INFO - '_': '/tools/buildbot/bin/python'} 21:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:23:15 INFO - Running setup.py (path:/tmp/pip-hBi71U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:23:15 INFO - Running setup.py (path:/tmp/pip-AsgyGK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:23:15 INFO - Running setup.py (path:/tmp/pip-oiJtQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:23:15 INFO - Running setup.py (path:/tmp/pip-_iGjQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:23:15 INFO - Running setup.py (path:/tmp/pip-fVqkob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:23:15 INFO - Running setup.py (path:/tmp/pip-NqvoM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:23:15 INFO - Running setup.py (path:/tmp/pip-WNVRej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:23:15 INFO - Running setup.py (path:/tmp/pip-knGL7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:23:15 INFO - Running setup.py (path:/tmp/pip-y100lv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:23:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:23:15 INFO - Running setup.py (path:/tmp/pip-HV2ViE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:23:16 INFO - Running setup.py (path:/tmp/pip-WnCmvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:23:16 INFO - Running setup.py (path:/tmp/pip-pr2BP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:23:16 INFO - Running setup.py (path:/tmp/pip-AfuWq3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:23:16 INFO - Running setup.py (path:/tmp/pip-Vs6yKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:23:16 INFO - Running setup.py (path:/tmp/pip-s4HZh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:23:16 INFO - Running setup.py (path:/tmp/pip-EEePKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:23:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:23:16 INFO - Running setup.py (path:/tmp/pip-vl5qhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:23:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:16 INFO - Running setup.py install for manifestparser 21:23:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:23:16 INFO - Running setup.py install for mozcrash 21:23:16 INFO - Running setup.py install for mozdebug 21:23:16 INFO - Running setup.py install for mozdevice 21:23:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:23:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:23:16 INFO - Running setup.py install for mozfile 21:23:17 INFO - Running setup.py install for mozhttpd 21:23:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for mozinfo 21:23:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for mozInstall 21:23:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for mozleak 21:23:17 INFO - Running setup.py install for mozlog 21:23:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for moznetwork 21:23:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for mozprocess 21:23:17 INFO - Running setup.py install for mozprofile 21:23:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:23:17 INFO - Running setup.py install for mozrunner 21:23:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:23:18 INFO - Running setup.py install for mozscreenshot 21:23:18 INFO - Running setup.py install for moztest 21:23:18 INFO - Running setup.py install for mozversion 21:23:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:23:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:18 INFO - Cleaning up... 21:23:18 INFO - Return code: 0 21:23:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:18 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 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:18 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 21:23:18 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 21:23:18 INFO - Using env: {'DISPLAY': ':0', 21:23:18 INFO - 'HOME': '/home/cltbld', 21:23:18 INFO - 'LANG': 'en_US.UTF-8', 21:23:18 INFO - 'LANGUAGE': 'en_US:en', 21:23:18 INFO - 'LOGNAME': 'cltbld', 21:23:18 INFO - 'MAIL': '/var/mail/cltbld', 21:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:18 INFO - 'MOZ_NO_REMOTE': '1', 21:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:18 INFO - 'NO_EM_RESTART': '1', 21:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:18 INFO - 'SHELL': '/bin/bash', 21:23:18 INFO - 'SHLVL': '1', 21:23:18 INFO - 'TERM': 'linux', 21:23:18 INFO - 'TMOUT': '86400', 21:23:18 INFO - 'USER': 'cltbld', 21:23:18 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:18 INFO - '_': '/tools/buildbot/bin/python'} 21:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:23:18 INFO - Running setup.py (path:/tmp/pip-0THJmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:23:18 INFO - Running setup.py (path:/tmp/pip-OkoQg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:23:18 INFO - Running setup.py (path:/tmp/pip-Y_t8gb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:23:18 INFO - Running setup.py (path:/tmp/pip-AxjKyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:23:18 INFO - Running setup.py (path:/tmp/pip-Ot_rQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:23:18 INFO - Running setup.py (path:/tmp/pip-9qtACG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:23:18 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)) 21:23:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:23:18 INFO - Running setup.py (path:/tmp/pip-6y36h7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:23:19 INFO - Running setup.py (path:/tmp/pip-VfopxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:23:19 INFO - Running setup.py (path:/tmp/pip-pFGvGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:23:19 INFO - Running setup.py (path:/tmp/pip-wRfA69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:23:19 INFO - Running setup.py (path:/tmp/pip-W842Y1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:23:19 INFO - Running setup.py (path:/tmp/pip-nmM7Wd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:23:19 INFO - Running setup.py (path:/tmp/pip-pwpN9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:23:19 INFO - Running setup.py (path:/tmp/pip-pLwoOZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:23:19 INFO - Running setup.py (path:/tmp/pip-5OHbuU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:23:19 INFO - Running setup.py (path:/tmp/pip-vSWxPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:23:19 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)) 21:23:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:23:19 INFO - Running setup.py (path:/tmp/pip-wI9UV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:21 INFO - Downloading blessings-1.5.1.tar.gz 21:23:21 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 21:23:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:21 INFO - Installing collected packages: blessings 21:23:21 INFO - Running setup.py install for blessings 21:23:21 INFO - Successfully installed blessings 21:23:21 INFO - Cleaning up... 21:23:21 INFO - Return code: 0 21:23:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:23:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:23:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:23:21 INFO - Reading from file tmpfile_stdout 21:23:21 INFO - Current package versions: 21:23:21 INFO - argparse == 1.2.1 21:23:21 INFO - blessings == 1.5.1 21:23:21 INFO - blobuploader == 1.2.4 21:23:21 INFO - docopt == 0.6.1 21:23:21 INFO - manifestparser == 1.1 21:23:21 INFO - mozInstall == 1.12 21:23:21 INFO - mozcrash == 0.16 21:23:21 INFO - mozdebug == 0.1 21:23:21 INFO - mozdevice == 0.47 21:23:21 INFO - mozfile == 1.2 21:23:21 INFO - mozhttpd == 0.7 21:23:21 INFO - mozinfo == 0.9 21:23:21 INFO - mozleak == 0.1 21:23:21 INFO - mozlog == 3.0 21:23:21 INFO - moznetwork == 0.27 21:23:21 INFO - mozprocess == 0.22 21:23:21 INFO - mozprofile == 0.27 21:23:21 INFO - mozrunner == 6.11 21:23:21 INFO - mozscreenshot == 0.1 21:23:21 INFO - mozsystemmonitor == 0.0 21:23:21 INFO - moztest == 0.7 21:23:21 INFO - mozversion == 1.4 21:23:21 INFO - psutil == 3.1.1 21:23:21 INFO - requests == 1.2.3 21:23:21 INFO - wsgiref == 0.1.2 21:23:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:21 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 0x7ff8cf679c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a466c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b076e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, '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': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', '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 21:23:21 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 21:23:21 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 21:23:21 INFO - Using env: {'DISPLAY': ':0', 21:23:21 INFO - 'HOME': '/home/cltbld', 21:23:21 INFO - 'LANG': 'en_US.UTF-8', 21:23:21 INFO - 'LANGUAGE': 'en_US:en', 21:23:21 INFO - 'LOGNAME': 'cltbld', 21:23:21 INFO - 'MAIL': '/var/mail/cltbld', 21:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:21 INFO - 'MOZ_NO_REMOTE': '1', 21:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:21 INFO - 'NO_EM_RESTART': '1', 21:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:21 INFO - 'SHELL': '/bin/bash', 21:23:21 INFO - 'SHLVL': '1', 21:23:21 INFO - 'TERM': 'linux', 21:23:21 INFO - 'TMOUT': '86400', 21:23:21 INFO - 'USER': 'cltbld', 21:23:21 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:21 INFO - '_': '/tools/buildbot/bin/python'} 21:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 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)) 21:23:22 INFO - Cleaning up... 21:23:22 INFO - Return code: 0 21:23:22 INFO - Running post-action listener: _resource_record_post_action 21:23:22 INFO - Running post-action listener: _start_resource_monitoring 21:23:22 INFO - Starting resource monitoring. 21:23:22 INFO - ##### 21:23:22 INFO - ##### Running install step. 21:23:22 INFO - ##### 21:23:22 INFO - Running pre-action listener: _resource_record_pre_action 21:23:22 INFO - Running main action method: install 21:23:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:23:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:23:22 INFO - Reading from file tmpfile_stdout 21:23:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:23:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:23:22 INFO - Reading from file tmpfile_stdout 21:23:22 INFO - Output received: 21:23:22 INFO - Usage: mozinstall [options] installer 21:23:22 INFO - Options: 21:23:22 INFO - -h, --help show this help message and exit 21:23:22 INFO - -d DEST, --destination=DEST 21:23:22 INFO - Directory to install application into. [default: 21:23:22 INFO - "/builds/slave/test-pgo"] 21:23:22 INFO - --app=APP Application being installed. [default: firefox] 21:23:22 INFO - mkdir: /builds/slave/test-pgo/build/application 21:23:22 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'] 21:23:22 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 21:23:36 INFO - Reading from file tmpfile_stdout 21:23:36 INFO - Output received: 21:23:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:23:36 INFO - Running post-action listener: _resource_record_post_action 21:23:36 INFO - ##### 21:23:36 INFO - ##### Running run-tests step. 21:23:36 INFO - ##### 21:23:36 INFO - Running pre-action listener: _resource_record_pre_action 21:23:36 INFO - Running main action method: run_tests 21:23:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:23:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:23:36 INFO - Python 2.7.3 21:23:36 INFO - Return code: 0 21:23:36 INFO - grabbing minidump binary from tooltool 21:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-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 0x1b3da90>, '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 0x1b8ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b902e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:23:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:23:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:23:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:36 INFO - Return code: 0 21:23:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:23:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:23:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:23:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:23:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:23:36 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/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:23:36 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/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 21:23:36 INFO - Using env: {'DISPLAY': ':0', 21:23:36 INFO - 'HOME': '/home/cltbld', 21:23:36 INFO - 'LANG': 'en_US.UTF-8', 21:23:36 INFO - 'LANGUAGE': 'en_US:en', 21:23:36 INFO - 'LOGNAME': 'cltbld', 21:23:36 INFO - 'MAIL': '/var/mail/cltbld', 21:23:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:23:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:36 INFO - 'MOZ_NO_REMOTE': '1', 21:23:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:36 INFO - 'NO_EM_RESTART': '1', 21:23:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:23:36 INFO - 'PWD': '/builds/slave/test-pgo', 21:23:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:23:36 INFO - 'SHELL': '/bin/bash', 21:23:36 INFO - 'SHLVL': '1', 21:23:36 INFO - 'TERM': 'linux', 21:23:36 INFO - 'TMOUT': '86400', 21:23:36 INFO - 'USER': 'cltbld', 21:23:36 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994', 21:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:36 INFO - '_': '/tools/buildbot/bin/python'} 21:23:36 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/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 21:23:37 INFO - mozversion INFO | application_buildid: 20151120173025 21:23:37 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 21:23:37 INFO - mozversion INFO | application_display_name: Nightly 21:23:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:37 INFO - mozversion INFO | application_name: Firefox 21:23:37 INFO - mozversion INFO | application_remotingname: firefox 21:23:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:23:37 INFO - mozversion INFO | application_vendor: Mozilla 21:23:37 INFO - mozversion INFO | application_version: 45.0a1 21:23:37 INFO - mozversion INFO | platform_buildid: 20151120173025 21:23:37 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 21:23:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:23:37 INFO - mozversion INFO | platform_version: 45.0a1 21:23:37 INFO - 2015-11-20 21:23:37,128 DEBUG : using testdate: 1448083417 21:23:37 INFO - 2015-11-20 21:23:37,128 DEBUG : actual date: 1448083417 21:23:37 INFO - 2015-11-20 21:23:37,135 INFO : starting webserver on 'localhost:41241' 21:23:37 INFO - 2015-11-20 21:23:37,136 INFO : Starting test suite talos-linux64-ix-061.e 21:23:37 INFO - 2015-11-20 21:23:37,136 INFO : Starting test dromaeo_css 21:23:37 INFO - 2015-11-20 21:23:37,136 DEBUG : operating with platform_type : linux_ 21:23:37 INFO - 2015-11-20 21:23:37,136 INFO : Initialising browser for dromaeo_css test... 21:23:37 INFO - 2015-11-20 21:23:37,143 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3k44lP/profile http://localhost:41241/getInfo.html 21:23:41 INFO - 2015-11-20 21:23:41,927 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:23:41 INFO - 2015-11-20 21:23:41,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:23:41 INFO - 2015-11-20 21:23:41,927 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:23:41 INFO - 2015-11-20 21:23:41,927 DEBUG : BROWSER_OUTPUT: __metrics 21:23:42 INFO - 2015-11-20 21:23:42,952 INFO : Browser initialized. 21:23:42 INFO - 2015-11-20 21:23:42,952 INFO : Running cycle 1/1 for dromaeo_css test... 21:23:42 INFO - 2015-11-20 21:23:42,953 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3k44lP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:23:54 INFO - 2015-11-20 21:23:54,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 21:23:54 INFO - 2015-11-20 21:23:54,807 DEBUG : BROWSER_OUTPUT: 21:24:44 INFO - 2015-11-20 21:24:44,436 DEBUG : BROWSER_OUTPUT: 1448083484435 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:26:53 INFO - 2015-11-20 21:26:53,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41241/tests/dromaeo/cssquery-ext.html) 21:26:54 INFO - 2015-11-20 21:26:54,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 146006016 21:26:54 INFO - 2015-11-20 21:26:54,431 DEBUG : BROWSER_OUTPUT: 21:29:56 INFO - 2015-11-20 21:29:56,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-ext.html (next: http://localhost:41241/tests/dromaeo/cssquery-jquery.html) 21:29:56 INFO - 2015-11-20 21:29:56,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 21:29:56 INFO - 2015-11-20 21:29:56,970 DEBUG : BROWSER_OUTPUT: 21:32:58 INFO - 2015-11-20 21:32:58,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41241/tests/dromaeo/cssquery-mootools.html) 21:32:59 INFO - 2015-11-20 21:32:59,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 142372864 21:32:59 INFO - 2015-11-20 21:32:59,207 DEBUG : BROWSER_OUTPUT: 21:36:00 INFO - 2015-11-20 21:36:00,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41241/tests/dromaeo/cssquery-prototype.html) 21:36:01 INFO - 2015-11-20 21:36:01,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 141398016 21:36:01 INFO - 2015-11-20 21:36:01,409 DEBUG : BROWSER_OUTPUT: 21:39:03 INFO - 2015-11-20 21:39:03,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41241/tests/dromaeo/cssquery-yui.html) 21:39:04 INFO - 2015-11-20 21:39:04,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 141987840 21:39:04 INFO - 2015-11-20 21:39:04,267 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/dromaeo/cssquery-yui.html (next: http://localhost:41241/tests/dromaeo/cssquery-dojo.html) 21:42:06 INFO - 2015-11-20 21:42:06,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 144175104 21:42:06 INFO - 2015-11-20 21:42:06,869 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,870 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:42:06 INFO - 2015-11-20 21:42:06,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:42:06 INFO - 2015-11-20 21:42:06,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:42:06 INFO - 2015-11-20 21:42:06,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:42:06 INFO - 2015-11-20 21:42:06,872 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3245.870165193392;3322.966770332296;3359.378514974729;3361.630220675727;3379.0876463354894;5265.9473405265935;5439.265699130616;5474.835754927353;5487.725613719318;5528.253685752422;5460.863478413042;5483.972580137094;5508.531774799137;5600.18797274395;5608.887822243552;5027.597792176617;5086.135356989303;5133.794648214067;5160.122779127557;5160.535551800337;5008.123578373788;5049.116404629193;5084.644074914758;5103.081445339837;5105.18317069269;4848.903021939542;4912.435069966964;4923.827666031708;5061.316722242505;5136.049830781299;4988.152014157602;5028.949710502921;5042.344495215599;5046.419661738911;5050.696958182521;4993.275974983643;5027;5041.672291301091;5046.596272298244;5050.949490505084;5049.798008079672;5176.430592634807;5228.686278823283;5284.233786101032;5307.469253074701;5985.25184351956;6039.365866583989;6041.577089603729;6043.758249670008;6045.214122164134;6022.277326720821;6047.909281360783;6061.242344706911;6064.939350606482;6074.848128796772;5346.4386239445075;5445.618806683534;5512.118061110203;5599.188117722907;5655.5475561954945;6009.729562169713;6056.394360563909;6061.757529698851;6067.271927368655;6070.0591408331775;5853.824385268449;5854.443827836349;5862.824115276549;5863.618864773776;5873.882522349614;5746.281714785652;5787.421257874179;5930.703464826742;5987.64074155552;6045.879082418415;5766.913496297559;5783.479486846204;5798.536117110621;5813.09896965971;5849.473547380756;5747.482726554546;5748.137779333133;5777.364489906107;5836.591438599257;5847.093700476433;4531.501534831166;4532.79602417892;4544.681872268976;4582.404287442611;4608.193566125915;4043.272211001989;4079.755214687069;4081.4490043843703;4092.979535102365;4134.3178375567695;5435.184722291688;5576.498115169654;5682.943170568242;5699;5708.600397972185;5898.351181370046;5899.262592175978;5933.288005439289;5967.1347654589845;5999.4900433463645;5678.744456499468;5722.37053924068;5723.084306510938;5725.198472213893;5727.255456790591;5017.648764586444;5041.747912604355;5088.72012039334;5232.686038837682;5235.921461178085;6153.353897840662;6186.1648677427975;6193.969030154821;6202.782902598387;6220.284667263232;5945.702714864153;5987.850303742442;6025.548083893638;6034.63792172471;6047.0929360596265;5903.144044113494;5961.701914904151;6047.909281360871;6142.529470849135;6211.875762484635;5729.512991395612;5795.188673585786;5797;5805.883882322414;5813.331466881194;5859.44335288147;5918.378570250062;5925.555583331181;5926.822195334147;5937.614055086406;5586.301712285965;5756.971215143897;5771.134329850556;5849.327327357409;5894.6757928314355;5777.7977770777825;5789.739461724148;5796.333421656564;5802.65184088956;5821.068629019336;5544.500994910478;5717.885642287214;5730.770769169187;5731.512821410227;5732.226149469769;5726.914096288476;5732.942670573408;5816.883662326814;5863.501602363847;5911.083782013795;5646.830595082154;5665.065264231355;5681.659100453986;5726.742296596746;5735.713214339183 21:42:06 INFO - 2015-11-20 21:42:06,875 DEBUG : BROWSER_OUTPUT: |1;ext.html;603.3453702732535;610.9205803245577;612.8958077126889;614.3089024847044;667.1827011910414;39144.2171156577;39350;39450.8027459863;39621.80189099057;39906.60093399065;40618;40983.795081024626;41058.38412423816;41063.38404923921;41232.58767412325;8664.696735614254;8803.867941980876;8824.426412283214;8826.64693412266;8831.911680883173;8631.654733810672;8697.130286971316;8741.038485766561;8753.95623021884;8763.824723505526;8633.784155396133;8739.257163141141;8770.386072974894;8782.077881822412;8804.823903521925;8686.478811271343;8690.913090869106;8729.7817554561;8751.868721969175;8773.34199935001;8496.277816385615;8604.913950860473;8689.7827554311;8698.739037828875;8706.259967902735;38402.80798596017;38690;38942.22115557701;38989.415158772645;39043.219135617415;3331.4503106987318;3398.8470518826466;3472.895813125585;3713.442983552489;3767.2653832502674;29222.269443263875;29807;29864.850675746482;31218.84390578055;31236.843815781;3860.9806950965344;3877.0888841122314;3878.650921417058;3981.8009099544906;4079.653229475498;259983;261353;261454;261998;265881.9999999981;57524.71237643785;57612.423875761546;57762.71118644464;57831.42168578345;58249;66029.66985165044;66803.33196667972;66804;67149;67338;15449.304781284643;15712.68574628501;15751.054936703835;15777.526674199793;15812.446564370191;11849.34828584419;11881.5841445549;11882.643520694393;11939.940300298444;11970.281783093042;20107.29624463166;20581.279655211994;20621.89689051545;20676.689849652266;20814;8050.476719013245;8183.795405114801;8271.17288271168;8311.877896483897;8369.372297077743;932.5197523275518;962;1063.7234319077095;1068.316277582348;1125.5554056147776;32800.343993120005;33425.49861752027;33456.1635959103;33551;33767.324653506796;1007.5063219022626;1040.6305761454726;1051.3796859852723;1074.3446497636435;1107.2581370481796;15008.324625391884;15159.924200378928;15164.696706065817;15419.92290038565;15489.767653485207;415545;415742;417089;419380;421992;52350.73824630929;52524;52601.73699131556;52664;53022.469775302525;1348.716769478401;1360.1567028442232;1365.8975576831776;1370.7532644124153;1373.1006190944947;27532.311692207855;28850;29095.56356654694;29109.272268192617;29121.7087829119;48643.054277829906;49644.50355496399;49682.75158624184;49725.75137124291;49802;302827;302980;304937;306482;306499;41698.791506042275;45160.54839451695;45377.54622453865;45391.773041134584;46277;43459.13081738411;43550.56449435465;43551.78224108859;43967.78016109899;44252;36312.45531317085;36475.27049459049;36573.63426365809;36956;37562.62437375591;36502.45246321254;37027.44458833174;40117.398239027025;40671;41603.37594936139;36461.45307820332;36502.45246321254;36610.26779464449;40036;40651.390229145996;31844.840775795972;33690.663093368756;33775;33907.321853563284;34152.82923585465;25954.35114122162;26096.73903261019;26102.216933492025;26330.605040924784;26359.472810544066 21:42:06 INFO - 2015-11-20 21:42:06,875 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359;363.69086276664837;364.2787281183258;366.4082506751597;368.55773072313224;16767.580810479743;17092.572685682848;17604.735928961043;17654.47036588901;18296.725549116774;11055.170862185329;11065.944670276658;11141.442927853615;11155.665330040092;11227.045701115416;4836;5020.824271150511;5037.59699224063;5050.141475949097;5375.3280839895015;5367.946320536784;5371.435999220084;5374.167004114369;5397.811076612319;5403.324584426927;4895.143349913768;5044.167712327461;5387.757550910218;5388.4611538846;5388.595855310848;5081.872953176163;5094.337736094302;5100.081985242655;5102.770375333119;5118.616103792212;4819.6867203631655;5088.931324421839;5099.566536844372;5101.540861322499;5112.41207261166;16149.111798851058;19926.900365498226;20062.297819576244;21306.78693213079;21364.359069227947;2126.776688447706;2154.7306586676664;2179.6403593407067;2200.4388880835445;2258.2322010516505;9207.907920920772;9416;9677;10896.18278629106;13375.665608359772;1841.2082804394106;1850.6668799616064;1857.0807450312047;1867.3837633580886;1947.3476385410904;59133;60775.39224607741;62874.37125628731;63011;63075.6846215766;10010.849837252446;10092.798144037224;10189.23580731448;10202.33684810485;10237.7440563985;13022.218666880017;13084.476620935246;13106.868931310755;13111.672208194872;13141.737165256642;7743.303102720783;7755.53466791983;7769.300762931363;7777;7841.255080767318;7534.811629709191;7586.81032974169;7589.279018493235;7599.962000189964;7635.160132385433;4125.64931980779;4194.958050419456;4260.552641972548;4298.011457364823;4312.288472402081;1741.8432341089363;1818.3908390689003;1839.117223732589;1855.2949879046146;1875.3061367294188;919.0855099176363;941.1435593609782;959.2421986630484;988.8862780780303;1063.3407287481812;14188.787168192486;15592.610184745245;15750.68498630021;16422;17521.7371739424;933.0110083311712;943.0428115462811;990.4799980010553;997.5012493753123;1027.075631931268;8449.619767110495;9760.219182465386;9804.803903922024;9897.554610042422;9942.850857237147;507569;576275;576930;581268;590189;78164.60917695375;82349.58825205835;83471.16528834634;84716.15283847206;84902;1161.8896204860525;1179.5871444994355;1181.1967861854023;1182.645206438065;1187.7861984842639;15463.371226891231;15713.214339282762;15713.292901819217;15745.405343332355;15813.446529371417;34664.306713866084;34924.825375872955;35731.10672233215;35834.10414739652;36114.8194259027;48100.27849582329;49253;49584.50415495799;50073.74963125161;50604.74697626635;9398.765030874009;9404.482753448352;9430.811383772423;9558.426494410358;13364.599062028155;18456.26174952987;18563.90718046401;19150.138243778783;19395.8060419394;19723.901380493007;15833.129177895325;16215.837841621433;16275.75586366229;16521;16644.334226631283;15343.156126413154;15700.293486792893;15902.443414480438;15948.920255398649;16259.918700406422;15926.840731592536;15969.281382337591;16199.676006479569;16354.836451635332;16770;14840.332185051915;14862.554123376316;15058.397664093314;15180.696386072437;15187.164705940837;15765.211739413213;15917.363305467652;15963.04221746699;16122.274497647868;16272.91863540722 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1539.5227479481355;1687.4853169783214;1750.7636469076672;1771.796243432005;1793.3006127610226;6559.344065593438;6577.638229897354;7443.590602516866;7802.609869506523;7808.1801410851895;7476.3645090167265;7647.923520764791;7657.731979380709;7658.54048757075;7706.768796936087;2215.9778402215934;2224;2235.5417139486367;2237.071615279657;2249.224017713886;2254.1884921428273;2262.2986874069093;2275.180934863448;2281.3954302109955;2283.54329134173;2233.6314508106225;2275.9886200568976;2278.3278932714807;2280.304507125326;2312.9306120816404;2228.576570451609;2252.718410198725;2290.8510946788488;2307.596170670126;2310.4223944013997;2240.764719704424;2262.694536237603;2279.464325883416;2288.290629904735;2292.060255295338;7583.924160758377;7649.732259370951;7656.042994625672;7664.501807382502;7673.194314596943;4475.239209334421;4534.183846907556;4535.047639995605;4553.2942393929;4571.565701258375;2942.264433891527;2944.8085874418307;3000.0999700089887;3040.543918412234;3040.7111324424145;954.8997355277735;956.789506308611;963.7349728824629;972.0473935543207;994.4977786217986;10387.324823886423;10389.168866490663;10438.060574548326;10455.424951627658;10455.424951627658;4211.810468528924;4215.114825886598;4219.810108545123;4249.277622804131;4251.659867210616;9057.411268267542;9097.1812536872;9127.954360228288;9130.589123489459;9135.406198597202;4719.811207551728;4728.196206644879;4728.621710263171;4730.006698593265;4732.858014259577;3642.21692336149;3662.633736626316;4168.979155104265;4225.450691410097;4261.382099595541;3755.849766009329;3791.33651610967;3814.237152569497;3833.789141597239;3846.0384903774057;1199.5501686867424;1237.9690507737378;1242.2049888071642;1247.4760600547793;1248.3196657821509;1087.3584585094832;1106.253279036647;1111.7276267314398;1163.0869767232682;1232.9815052774215;7146.535475194096;7158.677859496335;7221.386182174469;7224.891626625605;7238.52949558277;433.2483141749063;444.2625242098102;453.85703503396326;456.5525784730916;457.7505259633441;5663.773449061991;5685.459881311269;5707.429257074259;5716.485516303469;5721.885562288731;8815.867761983576;8844.911550884537;9025.729228123168;9128.361014728906;9158.67944621935;8871.334649901155;8882.289416846637;8891.822163556693;9002.594883230271;9017.368784185044;6929.653517324114;7026.2271150174465;7052.259512751088;7060;7101.644917754195;7109.324614161646;7138.928610713826;7158.463115266271;7180.030695855992;7196.568205907663;7886.526808391515;8172.978377702787;8215.137410572042;8262.297704695167;8283.751487455385;8103.149169337371;8192.139825318494;8218.835623287381;8237.917620823715;8353.164683531599;6760.391564759196;6792.083068785848;6894.207166175954;6936.930630693629;6942.791716248521;7030.683619237045;7082.468814838805;7085.397741192057;7111.964440177766;7113.608751518509;6941.93058069433;6968.198657154492;7126.572405655677;7220.277972202738;7237.529560578546;6914.481413893877;6917.342852429011;6940;7088.432925366062;7130.393916517154;6961.582305061713;7019.29807019294;7075.575465472089;7115.928840711526;7127;6530.738770449128;6532.967335163294;6572.342765723581;6572.507061970276;6590.934090659032;6295.527835412271;6529.151210342625;6550.443212327005;6620.073189753534;6620.90068648961 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: |4;prototype.html;345.28353666142755;349.91077275294793;355.92881423715255;357.42097801561476;359.1309032142216;6225.7509699611965;6252.999520076794;6260.342664020275;6261.686915654216;6457.580257283274;6220.315765265817;6271.623702577837;6289.40250676185;6293.653849038301;6297.244330680313;4719.834805781798;4750.548697873696;4753.47711751707;4756.548127927841;4763.595094416979;4754.072955773626;4756.31033500144;4758.405199350082;4759.190937540627;4760.666753327251;4612.3542704021465;4691.554302341272;4709.270063140201;4714.245720684691;4729.432468103832;4707.552782485693;4708.646851486135;4717.221658426355;4720.409948756405;4721.74030428328;4095.3652183911245;4111.588841115894;4112.403701463271;4113.01287690955;4126.834926602963;5847.970760146172;5893.616914900518;5936.317323507808;5947.583669143161;5957.136215248808;5405.648587853037;5473.0969390050595;5478.397376288605;5499.065158922993;5516.089845175541;6543.541952063358;6580.86838263232;6583.144191255106;6584.835379115512;6624.436922861562;4530.411046563959;4542.500324964251;4546.20441422753;4551.8179272829375;4556.453225612948;6790.388865002174;6838.658067096675;6906.965465172692;6929.480288978297;6933.618650974195;4649.721016739007;4659.836905708284;4660.813567457264;4665.090307390026;4676.602488788423;4721.881952951204;4724.881877953078;4728.810847566127;4729.196036673774;4741.5495527924795;5409.350877894678;5454.154606036071;5457.863553411117;5463.180522921593;5467.20725494809;6530.2816690164045;6688.862893308149;6698.22970358415;6703.430208432241;6708.798736037927;1625.447347901719;1646.0452937296338;1681.7897762779653;1685.3258696521489;1686.207482483231;1107.4739498738195;1112.7663190730038;1118.189312748251;1127.3630398824803;1130.1862658885755;6425.807225783234;6427;6427.2929977702415;6431.324710905287;6433.871322573522;6726.495512836557;6770.966145169341;6771.492138089663;6775.0514927910135;6777.864442711217;6362.713677884413;6373.139626150503;6399.840003999844;6415;6419.390157934989;3737.6822970047306;3769.076576238839;3772.490713753608;3774.471573979645;3775.3959366501776;7201.855962880713;7215.530990485601;7215.711371545184;7237.457190710717;7259.564426134449;6999.475039372068;7115.71537138519;7161.820954476179;7167.749128780468;7183.245759195313;7266.745663901738;7282.927170728331;7286.890696639554;7290.4167666586545;7302.963485182647;6891;6932.064171337007;6933.826654333682;6944.895826562504;6959.791206263821;6742.730290788313;6851.794446166623;6898.1377327834025;6899.89650155238;6909.343612356818;7271.4546409020595;7272.090988626422;7283.817904552428;7295.489315747846;7296.890546641698;4662.696924699883;4695.906081878412;4705.482396936266;4708.905821883612;4714.080754253025;6822.215445223863;6888.483363747639;6958.408535274559;6966.825829354307;6972.651367431709;6750.898736518858;6755.898661519983;6757.155355580552;6760.3239676032;6768.052472653734;6709.094272273181;6723.697433615401;6740.797776066725;6745.5952642841585;6746.595204287759;6473.48212143018;6584.572002819801;6610.272869984202;6616.7022483987375;6645.634490103091;6768.7292508299115;6777.966110169417;6790.45676345901;6800.217974932946;6818.113645226089;6594.934050659432;6616.2060552732055;6620.867582648224;6624.768133115318;6630.436412904957 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: |5;yui.html;843.6330196364582;860.7934095817002;866.7313132928789;872.437277955719;875.2123089219701;12199.207051541654;12449;12476.750464990695;12482.0638452116;12496.375181240935;11389.430528473584;11623.418829058535;12178.51285948561;12190.81713774294;12193.695157621063;811.8863359129726;819.2667562531531;821.8602837517636;833.754042557444;838.0153319849184;818.1082619944259;828.0022572799792;832.138736407815;832.7168762620707;834.3658819297317;852.654674856684;855.6235256487157;858.8883445152153;860.2945584620613;863.8445079885618;850.3239924260259;851.3189448441223;851.7742798158462;854.5727136431784;857.3741168946641;607.4593611685603;609.9817005489842;613.2610204703321;622.5984240165113;623.8783437229697;12370.938145309306;12410.627681169579;12464.252144871336;12470.937645311715;12476.688082797911;11337.659870203825;11531.596394126165;11538.423078846108;11539.884601154048;12026.15816892818;10108.24188185889;10176.135028522585;10370.066693997576;10482.63310784119;10758;3510.684038436553;3564.3762341590377;3590.4255319149074;3600.063983364318;3615.0781550704664;46391.30413043807;46409.535904640856;47572.76213618944;47995.52004479946;48293.275600866014;9697.321187516805;9772.657956971472;9796.804063918824;9820.950895245622;9839.163671087894;17719.202635881415;17796.644067118585;17849.286028558712;17862.374816881606;17904.28382864697;7220.566765993952;7225.74709885162;7299.927000730031;7402.074740657418;7553.282438168365;4372.8906777330185;4379.794759390205;4382;4426.535213802505;4432.889177770517;3094.4430002599747;3102.37952409519;3106.751459883204;3114.1591770222367;3123.9062828115193;555.089652969131;570.8801151758178;573.4294377094817;578.4735890339771;580.9186713860063;619.5384438593277;647.95788273763;680.7481231944213;682.6518475577491;686.8832298509166;7969.561674107979;8140.267375936194;8443.662253509914;8482.787930301793;8666.826663466822;675.3584095109666;685;686.6257889450262;688.6797639097744;701.0675801184412;3662.956057523593;3985.601439856049;3996.5803590623145;4031.596840315945;4078.4290199372113;54616.726916365165;58979.41020589825;59055;59242;59278.11082833761;48997.26504102441;49590.99999999928;49592;50071.49928500741;50237.497625024014;45965.310520342224;47043.294350584765;48207.27689084667;48592.999999999294;49059.754701226266;8288.917110828814;8422.663093476192;8513.787155321166;8555.35834812404;8803.779905502413;34838.30323393569;34857.302853943285;35191;35448.645513544536;35702.4644630336;45202.321965171206;45575.08849822919;46323.768381157875;46332.53667463282;47396.52603474059;10976.835347469954;11050.33697978124;11055.83416248773;11158.146206400243;11203.71990700239;12445.688857778629;12653.304068275966;12763.978881689256;13241.602751917459;13316.201027938354;11295.491702873225;11327.433628318386;11444.656660300205;11562.30626162433;11778.057755379721;11288.20982531215;11398.259113157617;11482.311061336346;12035.338056406981;12068;9951.800963980535;10934.125269978224;11276.548938042386;11433.256838305484;11441.771164576496;9738.707838764849;9754.122129008423;9962.203023758228;10107.39355638664;10116.08955194036;8770.042873782608;8817.779555511164;8870.467771933705;9477.147056764925;9489.193418559224 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,304 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: __startTimestamp1448084526869__endTimestamp 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:42:06 INFO - 2015-11-20 21:42:06,880 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:42:06 INFO - 2015-11-20 21:42:06,880 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,880 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5500.15 Median:5727.26 stddev:610.57 (10.7%) stddev-sans-first:586.27 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: Values: 3245.9 3323.0 3359.4 3361.6 3379.1 5265.9 5439.3 5474.8 5487.7 5528.3 5460.9 5484.0 5508.5 5600.2 5608.9 5027.6 5086.1 5133.8 5160.1 5160.5 5008.1 5049.1 5084.6 5103.1 5105.2 4848.9 4912.4 4923.8 5061.3 5136.0 4988.2 5028.9 5042.3 5046.4 5050.7 4993.3 5027.0 5041.7 5046.6 5050.9 5049.8 5176.4 5228.7 5284.2 5307.5 5985.3 6039.4 6041.6 6043.8 6045.2 6022.3 6047.9 6061.2 6064.9 6074.8 5346.4 5445.6 5512.1 5599.2 5655.5 6009.7 6056.4 6061.8 6067.3 6070.1 5853.8 5854.4 5862.8 5863.6 5873.9 5746.3 5787.4 5930.7 5987.6 6045.9 5766.9 5783.5 5798.5 5813.1 5849.5 5747.5 5748.1 5777.4 5836.6 5847.1 4531.5 4532.8 4544.7 4582.4 4608.2 4043.3 4079.8 4081.4 4093.0 4134.3 5435.2 5576.5 5682.9 5699.0 5708.6 5898.4 5899.3 5933.3 5967.1 5999.5 5678.7 5722.4 5723.1 5725.2 5727.3 5017.6 5041.7 5088.7 5232.7 5235.9 6153.4 6186.2 6194.0 6202.8 6220.3 5945.7 5987.9 6025.5 6034.6 6047.1 5903.1 5961.7 6047.9 6142.5 6211.9 5729.5 5795.2 5797.0 5805.9 5813.3 5859.4 5918.4 5925.6 5926.8 5937.6 5586.3 5757.0 5771.1 5849.3 5894.7 5777.8 5789.7 5796.3 5802.7 5821.1 5544.5 5717.9 5730.8 5731.5 5732.2 5726.9 5732.9 5816.9 5863.5 5911.1 5646.8 5665.1 5681.7 5726.7 5735.7 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50341.70 Median:39093.72 stddev:88006.04 (225.1%) stddev-sans-first:88173.69 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: Values: 603.3 610.9 612.9 614.3 667.2 39144.2 39350.0 39450.8 39621.8 39906.6 40618.0 40983.8 41058.4 41063.4 41232.6 8664.7 8803.9 8824.4 8826.6 8831.9 8631.7 8697.1 8741.0 8754.0 8763.8 8633.8 8739.3 8770.4 8782.1 8804.8 8686.5 8690.9 8729.8 8751.9 8773.3 8496.3 8604.9 8689.8 8698.7 8706.3 38402.8 38690.0 38942.2 38989.4 39043.2 3331.5 3398.8 3472.9 3713.4 3767.3 29222.3 29807.0 29864.9 31218.8 31236.8 3861.0 3877.1 3878.7 3981.8 4079.7 259983.0 261353.0 261454.0 261998.0 265882.0 57524.7 57612.4 57762.7 57831.4 58249.0 66029.7 66803.3 66804.0 67149.0 67338.0 15449.3 15712.7 15751.1 15777.5 15812.4 11849.3 11881.6 11882.6 11939.9 11970.3 20107.3 20581.3 20621.9 20676.7 20814.0 8050.5 8183.8 8271.2 8311.9 8369.4 932.5 962.0 1063.7 1068.3 1125.6 32800.3 33425.5 33456.2 33551.0 33767.3 1007.5 1040.6 1051.4 1074.3 1107.3 15008.3 15159.9 15164.7 15419.9 15489.8 415545.0 415742.0 417089.0 419380.0 421992.0 52350.7 52524.0 52601.7 52664.0 53022.5 1348.7 1360.2 1365.9 1370.8 1373.1 27532.3 28850.0 29095.6 29109.3 29121.7 48643.1 49644.5 49682.8 49725.8 49802.0 302827.0 302980.0 304937.0 306482.0 306499.0 41698.8 45160.5 45377.5 45391.8 46277.0 43459.1 43550.6 43551.8 43967.8 44252.0 36312.5 36475.3 36573.6 36956.0 37562.6 36502.5 37027.4 40117.4 40671.0 41603.4 36461.5 36502.5 36610.3 40036.0 40651.4 31844.8 33690.7 33775.0 33907.3 34152.8 25954.4 26096.7 26102.2 26330.6 26359.5 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,881 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30074.83 Median:34794.57 stddev:92662.27 (266.3%) stddev-sans-first:92895.34 21:42:06 INFO - 2015-11-20 21:42:06,882 DEBUG : BROWSER_OUTPUT: Values: 359.0 363.7 364.3 366.4 368.6 16767.6 17092.6 17604.7 17654.5 18296.7 11055.2 11065.9 11141.4 11155.7 11227.0 4836.0 5020.8 5037.6 5050.1 5375.3 5367.9 5371.4 5374.2 5397.8 5403.3 4895.1 5044.2 5387.8 5388.5 5388.6 5081.9 5094.3 5100.1 5102.8 5118.6 4819.7 5088.9 5099.6 5101.5 5112.4 16149.1 19926.9 20062.3 21306.8 21364.4 2126.8 2154.7 2179.6 2200.4 2258.2 9207.9 9416.0 9677.0 10896.2 13375.7 1841.2 1850.7 1857.1 1867.4 1947.3 59133.0 60775.4 62874.4 63011.0 63075.7 10010.8 10092.8 10189.2 10202.3 10237.7 13022.2 13084.5 13106.9 13111.7 13141.7 7743.3 7755.5 7769.3 7777.0 7841.3 7534.8 7586.8 7589.3 7600.0 7635.2 4125.6 4195.0 4260.6 4298.0 4312.3 1741.8 1818.4 1839.1 1855.3 1875.3 919.1 941.1 959.2 988.9 1063.3 14188.8 15592.6 15750.7 16422.0 17521.7 933.0 943.0 990.5 997.5 1027.1 8449.6 9760.2 9804.8 9897.6 9942.9 507569.0 576275.0 576930.0 581268.0 590189.0 78164.6 82349.6 83471.2 84716.2 84902.0 1161.9 1179.6 1181.2 1182.6 1187.8 15463.4 15713.2 15713.3 15745.4 15813.4 34664.3 34924.8 35731.1 35834.1 36114.8 48100.3 49253.0 49584.5 50073.7 50604.7 9398.8 9404.5 9430.8 9558.4 13364.6 18456.3 18563.9 19150.1 19395.8 19723.9 15833.1 16215.8 16275.8 16521.0 16644.3 15343.2 15700.3 15902.4 15948.9 16259.9 15926.8 15969.3 16199.7 16354.8 16770.0 14840.3 14862.6 15058.4 15180.7 15187.2 15765.2 15917.4 15963.0 16122.3 16272.9 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5354.34 Median:6565.84 stddev:2766.43 (42.1%) stddev-sans-first:2759.33 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: Values: 1539.5 1687.5 1750.8 1771.8 1793.3 6559.3 6577.6 7443.6 7802.6 7808.2 7476.4 7647.9 7657.7 7658.5 7706.8 2216.0 2224.0 2235.5 2237.1 2249.2 2254.2 2262.3 2275.2 2281.4 2283.5 2233.6 2276.0 2278.3 2280.3 2312.9 2228.6 2252.7 2290.9 2307.6 2310.4 2240.8 2262.7 2279.5 2288.3 2292.1 7583.9 7649.7 7656.0 7664.5 7673.2 4475.2 4534.2 4535.0 4553.3 4571.6 2942.3 2944.8 3000.1 3040.5 3040.7 954.9 956.8 963.7 972.0 994.5 10387.3 10389.2 10438.1 10455.4 10455.4 4211.8 4215.1 4219.8 4249.3 4251.7 9057.4 9097.2 9128.0 9130.6 9135.4 4719.8 4728.2 4728.6 4730.0 4732.9 3642.2 3662.6 4169.0 4225.5 4261.4 3755.8 3791.3 3814.2 3833.8 3846.0 1199.6 1238.0 1242.2 1247.5 1248.3 1087.4 1106.3 1111.7 1163.1 1233.0 7146.5 7158.7 7221.4 7224.9 7238.5 433.2 444.3 453.9 456.6 457.8 5663.8 5685.5 5707.4 5716.5 5721.9 8815.9 8844.9 9025.7 9128.4 9158.7 8871.3 8882.3 8891.8 9002.6 9017.4 6929.7 7026.2 7052.3 7060.0 7101.6 7109.3 7138.9 7158.5 7180.0 7196.6 7886.5 8173.0 8215.1 8262.3 8283.8 8103.1 8192.1 8218.8 8237.9 8353.2 6760.4 6792.1 6894.2 6936.9 6942.8 7030.7 7082.5 7085.4 7112.0 7113.6 6941.9 6968.2 7126.6 7220.3 7237.5 6914.5 6917.3 6940.0 7088.4 7130.4 6961.6 7019.3 7075.6 7115.9 7127.0 6530.7 6533.0 6572.3 6572.5 6590.9 6295.5 6529.2 6550.4 6620.1 6620.9 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5578.03 Median:6386.49 stddev:1709.29 (26.8%) stddev-sans-first:1668.35 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: Values: 345.3 349.9 355.9 357.4 359.1 6225.8 6253.0 6260.3 6261.7 6457.6 6220.3 6271.6 6289.4 6293.7 6297.2 4719.8 4750.5 4753.5 4756.5 4763.6 4754.1 4756.3 4758.4 4759.2 4760.7 4612.4 4691.6 4709.3 4714.2 4729.4 4707.6 4708.6 4717.2 4720.4 4721.7 4095.4 4111.6 4112.4 4113.0 4126.8 5848.0 5893.6 5936.3 5947.6 5957.1 5405.6 5473.1 5478.4 5499.1 5516.1 6543.5 6580.9 6583.1 6584.8 6624.4 4530.4 4542.5 4546.2 4551.8 4556.5 6790.4 6838.7 6907.0 6929.5 6933.6 4649.7 4659.8 4660.8 4665.1 4676.6 4721.9 4724.9 4728.8 4729.2 4741.5 5409.4 5454.2 5457.9 5463.2 5467.2 6530.3 6688.9 6698.2 6703.4 6708.8 1625.4 1646.0 1681.8 1685.3 1686.2 1107.5 1112.8 1118.2 1127.4 1130.2 6425.8 6427.0 6427.3 6431.3 6433.9 6726.5 6771.0 6771.5 6775.1 6777.9 6362.7 6373.1 6399.8 6415.0 6419.4 3737.7 3769.1 3772.5 3774.5 3775.4 7201.9 7215.5 7215.7 7237.5 7259.6 6999.5 7115.7 7161.8 7167.7 7183.2 7266.7 7282.9 7286.9 7290.4 7303.0 6891.0 6932.1 6933.8 6944.9 6959.8 6742.7 6851.8 6898.1 6899.9 6909.3 7271.5 7272.1 7283.8 7295.5 7296.9 4662.7 4695.9 4705.5 4708.9 4714.1 6822.2 6888.5 6958.4 6966.8 6972.7 6750.9 6755.9 6757.2 6760.3 6768.1 6709.1 6723.7 6740.8 6745.6 6746.6 6473.5 6584.6 6610.3 6616.7 6645.6 6768.7 6778.0 6790.5 6800.2 6818.1 6594.9 6616.2 6620.9 6624.8 6630.4 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: 21:42:06 INFO - 2015-11-20 21:42:06,883 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13719.68 Median:47784.14 stddev:16039.26 (33.6%) stddev-sans-first:16055.10 21:42:06 INFO - 2015-11-20 21:42:06,884 DEBUG : BROWSER_OUTPUT: Values: 843.6 860.8 866.7 872.4 875.2 12199.2 12449.0 12476.8 12482.1 12496.4 11389.4 11623.4 12178.5 12190.8 12193.7 811.9 819.3 821.9 833.8 838.0 818.1 828.0 832.1 832.7 834.4 852.7 855.6 858.9 860.3 863.8 850.3 851.3 851.8 854.6 857.4 607.5 610.0 613.3 622.6 623.9 12370.9 12410.6 12464.3 12470.9 12476.7 11337.7 11531.6 11538.4 11539.9 12026.2 10108.2 10176.1 10370.1 10482.6 10758.0 3510.7 3564.4 3590.4 3600.1 3615.1 46391.3 46409.5 47572.8 47995.5 48293.3 9697.3 9772.7 9796.8 9821.0 9839.2 17719.2 17796.6 17849.3 17862.4 17904.3 7220.6 7225.7 7299.9 7402.1 7553.3 4372.9 4379.8 4382.0 4426.5 4432.9 3094.4 3102.4 3106.8 3114.2 3123.9 555.1 570.9 573.4 578.5 580.9 619.5 648.0 680.7 682.7 686.9 7969.6 8140.3 8443.7 8482.8 8666.8 675.4 685.0 686.6 688.7 701.1 3663.0 3985.6 3996.6 4031.6 4078.4 54616.7 58979.4 59055.0 59242.0 59278.1 48997.3 49591.0 49592.0 50071.5 50237.5 45965.3 47043.3 48207.3 48593.0 49059.8 8288.9 8422.7 8513.8 8555.4 8803.8 34838.3 34857.3 35191.0 35448.6 35702.5 45202.3 45575.1 46323.8 46332.5 47396.5 10976.8 11050.3 11055.8 11158.1 11203.7 12445.7 12653.3 12764.0 13241.6 13316.2 11295.5 11327.4 11444.7 11562.3 11778.1 11288.2 11398.3 11482.3 12035.3 12068.0 9951.8 10934.1 11276.5 11433.3 11441.8 9738.7 9754.1 9962.2 10107.4 10116.1 8770.0 8817.8 8870.5 9477.1 9489.2 21:42:06 INFO - 2015-11-20 21:42:06,884 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:42:06 INFO - 2015-11-20 21:42:06,885 DEBUG : BROWSER_OUTPUT: 21:42:07 INFO - 2015-11-20 21:42:07,513 INFO : Browser exited with error code: 0 21:42:07 INFO - 2015-11-20 21:42:07,532 INFO : Completed test dromaeo_css (00:18:30) 21:42:07 INFO - 2015-11-20 21:42:07,532 INFO : Starting test kraken 21:42:07 INFO - 2015-11-20 21:42:07,532 DEBUG : operating with platform_type : linux_ 21:42:07 INFO - 2015-11-20 21:42:07,532 INFO : Initialising browser for kraken test... 21:42:07 INFO - 2015-11-20 21:42:07,538 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW17VrM/profile http://localhost:41241/getInfo.html 21:42:11 INFO - 2015-11-20 21:42:11,957 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:42:11 INFO - 2015-11-20 21:42:11,957 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:42:11 INFO - 2015-11-20 21:42:11,957 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:42:11 INFO - 2015-11-20 21:42:11,957 DEBUG : BROWSER_OUTPUT: __metrics 21:42:12 INFO - 2015-11-20 21:42:12,969 INFO : Browser initialized. 21:42:12 INFO - 2015-11-20 21:42:12,969 INFO : Running cycle 1/1 for kraken test... 21:42:12 INFO - 2015-11-20 21:42:12,970 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW17VrM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:42:24 INFO - 2015-11-20 21:42:24,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 140152832 21:42:24 INFO - 2015-11-20 21:42:24,746 DEBUG : BROWSER_OUTPUT: 21:42:27 INFO - 2015-11-20 21:42:27,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41241/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:27 INFO - 2015-11-20 21:42:27,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 142053376 21:42:27 INFO - 2015-11-20 21:42:27,847 DEBUG : BROWSER_OUTPUT: 21:42:30 INFO - 2015-11-20 21:42:30,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41241/tests/kraken/driver.html?testName=audio-dft) 21:42:31 INFO - 2015-11-20 21:42:31,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 142282752 21:42:31 INFO - 2015-11-20 21:42:31,038 DEBUG : BROWSER_OUTPUT: 21:42:33 INFO - 2015-11-20 21:42:33,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41241/tests/kraken/driver.html?testName=audio-fft) 21:42:34 INFO - 2015-11-20 21:42:34,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 136740864 21:42:34 INFO - 2015-11-20 21:42:34,463 DEBUG : BROWSER_OUTPUT: 21:42:36 INFO - 2015-11-20 21:42:36,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41241/tests/kraken/driver.html?testName=audio-oscillator) 21:42:37 INFO - 2015-11-20 21:42:37,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 136458240 21:42:37 INFO - 2015-11-20 21:42:37,064 DEBUG : BROWSER_OUTPUT: 21:42:39 INFO - 2015-11-20 21:42:39,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:42:39 INFO - 2015-11-20 21:42:39,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 138575872 21:42:39 INFO - 2015-11-20 21:42:39,812 DEBUG : BROWSER_OUTPUT: 21:42:42 INFO - 2015-11-20 21:42:42,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41241/tests/kraken/driver.html?testName=imaging-darkroom) 21:42:43 INFO - 2015-11-20 21:42:43,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 21:42:43 INFO - 2015-11-20 21:42:43,413 DEBUG : BROWSER_OUTPUT: 21:42:46 INFO - 2015-11-20 21:42:46,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41241/tests/kraken/driver.html?testName=imaging-desaturate) 21:42:47 INFO - 2015-11-20 21:42:47,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 140197888 21:42:47 INFO - 2015-11-20 21:42:47,410 DEBUG : BROWSER_OUTPUT: 21:42:50 INFO - 2015-11-20 21:42:50,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41241/tests/kraken/driver.html?testName=json-parse-financial) 21:42:50 INFO - 2015-11-20 21:42:50,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 140386304 21:42:50 INFO - 2015-11-20 21:42:50,846 DEBUG : BROWSER_OUTPUT: 21:42:52 INFO - 2015-11-20 21:42:52,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:42:53 INFO - 2015-11-20 21:42:53,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 139575296 21:42:53 INFO - 2015-11-20 21:42:53,004 DEBUG : BROWSER_OUTPUT: 21:42:54 INFO - 2015-11-20 21:42:54,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:42:55 INFO - 2015-11-20 21:42:55,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 21:42:55 INFO - 2015-11-20 21:42:55,460 DEBUG : BROWSER_OUTPUT: 21:42:57 INFO - 2015-11-20 21:42:57,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:42:58 INFO - 2015-11-20 21:42:58,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 139448320 21:42:58 INFO - 2015-11-20 21:42:58,118 DEBUG : BROWSER_OUTPUT: 21:43:00 INFO - 2015-11-20 21:43:00,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:01 INFO - 2015-11-20 21:43:01,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 21:43:01 INFO - 2015-11-20 21:43:01,192 DEBUG : BROWSER_OUTPUT: 21:43:03 INFO - 2015-11-20 21:43:03,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:04 INFO - 2015-11-20 21:43:04,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 139771904 21:43:04 INFO - 2015-11-20 21:43:04,426 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41241/tests/kraken/driver.html?testName=ai-astar) 21:43:06 INFO - 2015-11-20 21:43:06,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 141307904 21:43:06 INFO - 2015-11-20 21:43:06,362 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;111;109;111;123;112;112;112;113 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;149;167;125;146;152;128;162;126 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |2;audio-dft;168;164;161;162;163;163;162;165;170;164 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;73;73;75;137;72;72;82 21:43:06 INFO - 2015-11-20 21:43:06,366 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;138;90;91;90;135;97;91;140 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;113;110;110;110;111;111;110 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;149;147;147;147;147;147;148;147 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;97;97;98;96;96;96;97 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;63;62;63;63;63;62;62;62;60 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;70;69;72;69;69 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;87;87;86;86;84;85;85;87 21:43:06 INFO - 2015-11-20 21:43:06,367 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;116;120;122;132;124;124;130;132;127 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;153;153;154;173;154;151;158;156 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;70;69;71;69;66;68;68 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:43:06 INFO - 2015-11-20 21:43:06,368 DEBUG : BROWSER_OUTPUT: __startTimestamp1448084586364__endTimestamp 21:43:06 INFO - 2015-11-20 21:43:06,369 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,372 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:43:06 INFO - 2015-11-20 21:43:06,372 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:43:06 INFO - 2015-11-20 21:43:06,372 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,372 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:4.51 (4.0%) stddev-sans-first:4.77 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 111.0 109.0 111.0 123.0 112.0 112.0 112.0 113.0 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.00 stddev:15.98 (10.7%) stddev-sans-first:16.79 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 149.0 167.0 125.0 146.0 152.0 128.0 162.0 126.0 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.82 (1.7%) stddev-sans-first:2.64 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: Values: 168.0 164.0 161.0 162.0 163.0 163.0 162.0 165.0 170.0 164.0 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:20.18 (27.6%) stddev-sans-first:21.19 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 73.0 73.0 75.0 137.0 72.0 72.0 82.0 21:43:06 INFO - 2015-11-20 21:43:06,373 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:90.00 stddev:22.53 (25.0%) stddev-sans-first:23.22 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 138.0 90.0 91.0 90.0 135.0 97.0 91.0 140.0 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:1.07 (1.0%) stddev-sans-first:1.01 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 113.0 110.0 110.0 110.0 111.0 111.0 110.0 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 97.0 97.0 98.0 96.0 96.0 96.0 97.0 21:43:06 INFO - 2015-11-20 21:43:06,375 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:0.97 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 62.0 63.0 63.0 63.0 62.0 62.0 62.0 60.0 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.12 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 70.0 69.0 72.0 69.0 69.0 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.05 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 87.0 87.0 86.0 86.0 84.0 85.0 85.0 87.0 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:5.37 (4.3%) stddev-sans-first:5.52 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 120.0 122.0 132.0 124.0 124.0 130.0 132.0 127.0 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:154.00 stddev:7.54 (4.9%) stddev-sans-first:6.71 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 153.0 153.0 154.0 173.0 154.0 151.0 158.0 156.0 21:43:06 INFO - 2015-11-20 21:43:06,376 DEBUG : BROWSER_OUTPUT: 21:43:06 INFO - 2015-11-20 21:43:06,377 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.62 21:43:06 INFO - 2015-11-20 21:43:06,377 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 69.0 71.0 69.0 66.0 68.0 68.0 21:43:06 INFO - 2015-11-20 21:43:06,377 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:43:06 INFO - 2015-11-20 21:43:06,377 DEBUG : BROWSER_OUTPUT: 21:43:07 INFO - 2015-11-20 21:43:07,205 INFO : Browser exited with error code: 0 21:43:07 INFO - 2015-11-20 21:43:07,254 INFO : Completed test kraken (00:00:59) 21:43:07 INFO - 2015-11-20 21:43:07,254 INFO : Starting test v8_7 21:43:07 INFO - 2015-11-20 21:43:07,254 DEBUG : operating with platform_type : linux_ 21:43:07 INFO - 2015-11-20 21:43:07,254 INFO : Initialising browser for v8_7 test... 21:43:07 INFO - 2015-11-20 21:43:07,260 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEo7zJy/profile http://localhost:41241/getInfo.html 21:43:11 INFO - 2015-11-20 21:43:11,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:43:11 INFO - 2015-11-20 21:43:11,660 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:43:11 INFO - 2015-11-20 21:43:11,660 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:43:11 INFO - 2015-11-20 21:43:11,660 DEBUG : BROWSER_OUTPUT: __metrics 21:43:12 INFO - 2015-11-20 21:43:12,705 INFO : Browser initialized. 21:43:12 INFO - 2015-11-20 21:43:12,705 INFO : Running cycle 1/1 for v8_7 test... 21:43:12 INFO - 2015-11-20 21:43:12,706 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEo7zJy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:43:24 INFO - 2015-11-20 21:43:24,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 21:43:24 INFO - 2015-11-20 21:43:24,580 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41241/tests/v8_7/run.html (next: http://localhost:41241/tests/v8_7/run.html) 21:43:46 INFO - 2015-11-20 21:43:46,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 138547200 21:43:46 INFO - 2015-11-20 21:43:46,343 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,343 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:43:46 INFO - 2015-11-20 21:43:46,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:43:46 INFO - 2015-11-20 21:43:46,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:43:46 INFO - 2015-11-20 21:43:46,344 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:43:46 INFO - 2015-11-20 21:43:46,344 DEBUG : BROWSER_OUTPUT: |0;Richards;162.5487646293888 21:43:46 INFO - 2015-11-20 21:43:46,344 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.87359441644048 21:43:46 INFO - 2015-11-20 21:43:46,344 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.1716396703609 21:43:46 INFO - 2015-11-20 21:43:46,345 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 21:43:46 INFO - 2015-11-20 21:43:46,345 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 21:43:46 INFO - 2015-11-20 21:43:46,345 DEBUG : BROWSER_OUTPUT: |5;Earley;715.8196134574088 21:43:46 INFO - 2015-11-20 21:43:46,345 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 21:43:46 INFO - 2015-11-20 21:43:46,346 DEBUG : BROWSER_OUTPUT: |7;RegExp;25475 21:43:46 INFO - 2015-11-20 21:43:46,346 DEBUG : BROWSER_OUTPUT: |8;Splay;622.9408175716901 21:43:46 INFO - 2015-11-20 21:43:46,346 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 21:43:46 INFO - 2015-11-20 21:43:46,346 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:43:46 INFO - 2015-11-20 21:43:46,347 DEBUG : BROWSER_OUTPUT: __startTimestamp1448084626335__endTimestamp 21:43:46 INFO - 2015-11-20 21:43:46,347 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,347 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:43:46 INFO - 2015-11-20 21:43:46,347 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:43:46 INFO - 2015-11-20 21:43:46,348 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,348 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.55 Median:162.55 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,348 DEBUG : BROWSER_OUTPUT: Values: 162.5 21:43:46 INFO - 2015-11-20 21:43:46,348 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,348 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.87 Median:193.87 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,349 DEBUG : BROWSER_OUTPUT: Values: 193.9 21:43:46 INFO - 2015-11-20 21:43:46,349 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,349 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.17 Median:284.17 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,349 DEBUG : BROWSER_OUTPUT: Values: 284.2 21:43:46 INFO - 2015-11-20 21:43:46,350 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,350 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,350 DEBUG : BROWSER_OUTPUT: Values: 5050.5 21:43:46 INFO - 2015-11-20 21:43:46,350 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,350 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,351 DEBUG : BROWSER_OUTPUT: Values: 1059.3 21:43:46 INFO - 2015-11-20 21:43:46,351 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,351 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,351 DEBUG : BROWSER_OUTPUT: Values: 715.8 21:43:46 INFO - 2015-11-20 21:43:46,352 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,352 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,352 DEBUG : BROWSER_OUTPUT: Values: 12072.3 21:43:46 INFO - 2015-11-20 21:43:46,352 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,352 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,353 DEBUG : BROWSER_OUTPUT: Values: 25475.0 21:43:46 INFO - 2015-11-20 21:43:46,353 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,353 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.94 Median:622.94 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,353 DEBUG : BROWSER_OUTPUT: Values: 622.9 21:43:46 INFO - 2015-11-20 21:43:46,354 DEBUG : BROWSER_OUTPUT: 21:43:46 INFO - 2015-11-20 21:43:46,354 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 21:43:46 INFO - 2015-11-20 21:43:46,354 DEBUG : BROWSER_OUTPUT: Values: 4840.6 21:43:46 INFO - 2015-11-20 21:43:46,354 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:43:46 INFO - 2015-11-20 21:43:46,355 DEBUG : BROWSER_OUTPUT: 21:43:47 INFO - 2015-11-20 21:43:47,201 INFO : Browser exited with error code: 0 21:43:47 INFO - 2015-11-20 21:43:47,213 INFO : Completed test v8_7 (00:00:39) 21:43:47 INFO - 2015-11-20 21:43:47,319 INFO : Completed test suite (00:20:10) 21:43:47 INFO - 2015-11-20 21:43:47,319 DEBUG : Working with test: dromaeo_css 21:43:47 INFO - 2015-11-20 21:43:47,319 DEBUG : Generating results file: dromaeo_css 21:43:47 INFO - 2015-11-20 21:43:47,320 DEBUG : Working with test: kraken 21:43:47 INFO - 2015-11-20 21:43:47,320 DEBUG : Generating results file: kraken 21:43:47 INFO - 2015-11-20 21:43:47,320 INFO : javascript benchmark 21:43:47 INFO - 2015-11-20 21:43:47,321 DEBUG : Working with test: v8_7 21:43:47 INFO - 2015-11-20 21:43:47,321 DEBUG : Generating results file: v8_7 21:43:47 INFO - 2015-11-20 21:43:47,321 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:43:47 INFO - 2015-11-20 21:43:47,365 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 21:43:47 INFO - 2015-11-20 21:43:47,365 DEBUG : process_Request line: dromaeo_css 7129.38 graph.html#tests=[[72,64,43]] 21:43:47 INFO - 2015-11-20 21:43:47,365 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:43:47 INFO - 2015-11-20 21:43:47,394 DEBUG : process_Request line: kraken 1524.80 graph.html#tests=[[232,64,43]] 21:43:47 INFO - 2015-11-20 21:43:47,394 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:43:47 INFO - 2015-11-20 21:43:47,423 DEBUG : process_Request line: v8_7 21340.18 graph.html#tests=[[230,64,43]] 21:43:47 INFO - 2015-11-20 21:43:47,425 INFO : javascript benchmark 21:43:47 INFO - 2015-11-20 21:43:47,428 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3245.870165193392, 3322.966770332296, 3359.378514974729, 3361.630220675727, 3379.0876463354894, 5265.9473405265935, 5439.265699130616, 5474.835754927353, 5487.725613719318, 5528.253685752422, 5460.863478413042, 5483.972580137094, 5508.531774799137, 5600.18797274395, 5608.887822243552, 5027.597792176617, 5086.135356989303, 5133.794648214067, 5160.122779127557, 5160.535551800337, 5008.123578373788, 5049.116404629193, 5084.644074914758, 5103.081445339837, 5105.18317069269, 4848.903021939542, 4912.435069966964, 4923.827666031708, 5061.316722242505, 5136.049830781299, 4988.152014157602, 5028.949710502921, 5042.344495215599, 5046.419661738911, 5050.696958182521, 4993.275974983643, 5027.0, 5041.672291301091, 5046.596272298244, 5050.949490505084, 5049.798008079672, 5176.430592634807, 5228.686278823283, 5284.233786101032, 5307.469253074701, 5985.25184351956, 6039.365866583989, 6041.577089603729, 6043.758249670008, 6045.214122164134, 6022.277326720821, 6047.909281360783, 6061.242344706911, 6064.939350606482, 6074.848128796772, 5346.4386239445075, 5445.618806683534, 5512.118061110203, 5599.188117722907, 5655.5475561954945, 6009.729562169713, 6056.394360563909, 6061.757529698851, 6067.271927368655, 6070.0591408331775, 5853.824385268449, 5854.443827836349, 5862.824115276549, 5863.618864773776, 5873.882522349614, 5746.281714785652, 5787.421257874179, 5930.703464826742, 5987.64074155552, 6045.879082418415, 5766.913496297559, 5783.479486846204, 5798.536117110621, 5813.09896965971, 5849.473547380756, 5747.482726554546, 5748.137779333133, 5777.364489906107, 5836.591438599257, 5847.093700476433, 4531.501534831166, 4532.79602417892, 4544.681872268976, 4582.404287442611, 4608.193566125915, 4043.272211001989, 4079.755214687069, 4081.4490043843703, 4092.979535102365, 4134.3178375567695, 5435.184722291688, 5576.498115169654, 5682.943170568242, 5699.0, 5708.600397972185, 5898.351181370046, 5899.262592175978, 5933.288005439289, 5967.1347654589845, 5999.4900433463645, 5678.744456499468, 5722.37053924068, 5723.084306510938, 5725.198472213893, 5727.255456790591, 5017.648764586444, 5041.747912604355, 5088.72012039334, 5232.686038837682, 5235.921461178085, 6153.353897840662, 6186.1648677427975, 6193.969030154821, 6202.782902598387, 6220.284667263232, 5945.702714864153, 5987.850303742442, 6025.548083893638, 6034.63792172471, 6047.0929360596265, 5903.144044113494, 5961.701914904151, 6047.909281360871, 6142.529470849135, 6211.875762484635, 5729.512991395612, 5795.188673585786, 5797.0, 5805.883882322414, 5813.331466881194, 5859.44335288147, 5918.378570250062, 5925.555583331181, 5926.822195334147, 5937.614055086406, 5586.301712285965, 5756.971215143897, 5771.134329850556, 5849.327327357409, 5894.6757928314355, 5777.7977770777825, 5789.739461724148, 5796.333421656564, 5802.65184088956, 5821.068629019336, 5544.500994910478, 5717.885642287214, 5730.770769169187, 5731.512821410227, 5732.226149469769, 5726.914096288476, 5732.942670573408, 5816.883662326814, 5863.501602363847, 5911.083782013795, 5646.830595082154, 5665.065264231355, 5681.659100453986, 5726.742296596746, 5735.713214339183], "unit": "ms", "name": "dojo.html", "value": 5460.895378205202}, {"lowerIsBetter": false, "replicates": [603.3453702732535, 610.9205803245577, 612.8958077126889, 614.3089024847044, 667.1827011910414, 39144.2171156577, 39350.0, 39450.8027459863, 39621.80189099057, 39906.60093399065, 40618.0, 40983.795081024626, 41058.38412423816, 41063.38404923921, 41232.58767412325, 8664.696735614254, 8803.867941980876, 8824.426412283214, 8826.64693412266, 8831.911680883173, 8631.654733810672, 8697.130286971316, 8741.038485766561, 8753.95623021884, 8763.824723505526, 8633.784155396133, 8739.257163141141, 8770.386072974894, 8782.077881822412, 8804.823903521925, 8686.478811271343, 8690.913090869106, 8729.7817554561, 8751.868721969175, 8773.34199935001, 8496.277816385615, 8604.913950860473, 8689.7827554311, 8698.739037828875, 8706.259967902735, 38402.80798596017, 38690.0, 38942.22115557701, 38989.415158772645, 39043.219135617415, 3331.4503106987318, 3398.8470518826466, 3472.895813125585, 3713.442983552489, 3767.2653832502674, 29222.269443263875, 29807.0, 29864.850675746482, 31218.84390578055, 31236.843815781, 3860.9806950965344, 3877.0888841122314, 3878.650921417058, 3981.8009099544906, 4079.653229475498, 259983.0, 261353.0, 261454.0, 261998.0, 265881.9999999981, 57524.71237643785, 57612.423875761546, 57762.71118644464, 57831.42168578345, 58249.0, 66029.66985165044, 66803.33196667972, 66804.0, 67149.0, 67338.0, 15449.304781284643, 15712.68574628501, 15751.054936703835, 15777.526674199793, 15812.446564370191, 11849.34828584419, 11881.5841445549, 11882.643520694393, 11939.940300298444, 11970.281783093042, 20107.29624463166, 20581.279655211994, 20621.89689051545, 20676.689849652266, 20814.0, 8050.476719013245, 8183.795405114801, 8271.17288271168, 8311.877896483897, 8369.372297077743, 932.5197523275518, 962.0, 1063.7234319077095, 1068.316277582348, 1125.5554056147776, 32800.343993120005, 33425.49861752027, 33456.1635959103, 33551.0, 33767.324653506796, 1007.5063219022626, 1040.6305761454726, 1051.3796859852723, 1074.3446497636435, 1107.2581370481796, 15008.324625391884, 15159.924200378928, 15164.696706065817, 15419.92290038565, 15489.767653485207, 415545.0, 415742.0, 417089.0, 419380.0, 421992.0, 52350.73824630929, 52524.0, 52601.73699131556, 52664.0, 53022.469775302525, 1348.716769478401, 1360.1567028442232, 1365.8975576831776, 1370.7532644124153, 1373.1006190944947, 27532.311692207855, 28850.0, 29095.56356654694, 29109.272268192617, 29121.7087829119, 48643.054277829906, 49644.50355496399, 49682.75158624184, 49725.75137124291, 49802.0, 302827.0, 302980.0, 304937.0, 306482.0, 306499.0, 41698.791506042275, 45160.54839451695, 45377.54622453865, 45391.773041134584, 46277.0, 43459.13081738411, 43550.56449435465, 43551.78224108859, 43967.78016109899, 44252.0, 36312.45531317085, 36475.27049459049, 36573.63426365809, 36956.0, 37562.62437375591, 36502.45246321254, 37027.44458833174, 40117.398239027025, 40671.0, 41603.37594936139, 36461.45307820332, 36502.45246321254, 36610.26779464449, 40036.0, 40651.390229145996, 31844.840775795972, 33690.663093368756, 33775.0, 33907.321853563284, 34152.82923585465, 25954.35114122162, 26096.73903261019, 26102.216933492025, 26330.605040924784, 26359.472810544066], "unit": "ms", "name": "ext.html", "value": 19274.32604236392}, {"lowerIsBetter": false, "replicates": [359.0, 363.69086276664837, 364.2787281183258, 366.4082506751597, 368.55773072313224, 16767.580810479743, 17092.572685682848, 17604.735928961043, 17654.47036588901, 18296.725549116774, 11055.170862185329, 11065.944670276658, 11141.442927853615, 11155.665330040092, 11227.045701115416, 4836.0, 5020.824271150511, 5037.59699224063, 5050.141475949097, 5375.3280839895015, 5367.946320536784, 5371.435999220084, 5374.167004114369, 5397.811076612319, 5403.324584426927, 4895.143349913768, 5044.167712327461, 5387.757550910218, 5388.4611538846, 5388.595855310848, 5081.872953176163, 5094.337736094302, 5100.081985242655, 5102.770375333119, 5118.616103792212, 4819.6867203631655, 5088.931324421839, 5099.566536844372, 5101.540861322499, 5112.41207261166, 16149.111798851058, 19926.900365498226, 20062.297819576244, 21306.78693213079, 21364.359069227947, 2126.776688447706, 2154.7306586676664, 2179.6403593407067, 2200.4388880835445, 2258.2322010516505, 9207.907920920772, 9416.0, 9677.0, 10896.18278629106, 13375.665608359772, 1841.2082804394106, 1850.6668799616064, 1857.0807450312047, 1867.3837633580886, 1947.3476385410904, 59133.0, 60775.39224607741, 62874.37125628731, 63011.0, 63075.6846215766, 10010.849837252446, 10092.798144037224, 10189.23580731448, 10202.33684810485, 10237.7440563985, 13022.218666880017, 13084.476620935246, 13106.868931310755, 13111.672208194872, 13141.737165256642, 7743.303102720783, 7755.53466791983, 7769.300762931363, 7777.0, 7841.255080767318, 7534.811629709191, 7586.81032974169, 7589.279018493235, 7599.962000189964, 7635.160132385433, 4125.64931980779, 4194.958050419456, 4260.552641972548, 4298.011457364823, 4312.288472402081, 1741.8432341089363, 1818.3908390689003, 1839.117223732589, 1855.2949879046146, 1875.3061367294188, 919.0855099176363, 941.1435593609782, 959.2421986630484, 988.8862780780303, 1063.3407287481812, 14188.787168192486, 15592.610184745245, 15750.68498630021, 16422.0, 17521.7371739424, 933.0110083311712, 943.0428115462811, 990.4799980010553, 997.5012493753123, 1027.075631931268, 8449.619767110495, 9760.219182465386, 9804.803903922024, 9897.554610042422, 9942.850857237147, 507569.0, 576275.0, 576930.0, 581268.0, 590189.0, 78164.60917695375, 82349.58825205835, 83471.16528834634, 84716.15283847206, 84902.0, 1161.8896204860525, 1179.5871444994355, 1181.1967861854023, 1182.645206438065, 1187.7861984842639, 15463.371226891231, 15713.214339282762, 15713.292901819217, 15745.405343332355, 15813.446529371417, 34664.306713866084, 34924.825375872955, 35731.10672233215, 35834.10414739652, 36114.8194259027, 48100.27849582329, 49253.0, 49584.50415495799, 50073.74963125161, 50604.74697626635, 9398.765030874009, 9404.482753448352, 9430.811383772423, 9558.426494410358, 13364.599062028155, 18456.26174952987, 18563.90718046401, 19150.138243778783, 19395.8060419394, 19723.901380493007, 15833.129177895325, 16215.837841621433, 16275.75586366229, 16521.0, 16644.334226631283, 15343.156126413154, 15700.293486792893, 15902.443414480438, 15948.920255398649, 16259.918700406422, 15926.840731592536, 15969.281382337591, 16199.676006479569, 16354.836451635332, 16770.0, 14840.332185051915, 14862.554123376316, 15058.397664093314, 15180.696386072437, 15187.164705940837, 15765.211739413213, 15917.363305467652, 15963.04221746699, 16122.274497647868, 16272.91863540722], "unit": "ms", "name": "jquery.html", "value": 9118.464923466443}, {"lowerIsBetter": false, "replicates": [1539.5227479481355, 1687.4853169783214, 1750.7636469076672, 1771.796243432005, 1793.3006127610226, 6559.344065593438, 6577.638229897354, 7443.590602516866, 7802.609869506523, 7808.1801410851895, 7476.3645090167265, 7647.923520764791, 7657.731979380709, 7658.54048757075, 7706.768796936087, 2215.9778402215934, 2224.0, 2235.5417139486367, 2237.071615279657, 2249.224017713886, 2254.1884921428273, 2262.2986874069093, 2275.180934863448, 2281.3954302109955, 2283.54329134173, 2233.6314508106225, 2275.9886200568976, 2278.3278932714807, 2280.304507125326, 2312.9306120816404, 2228.576570451609, 2252.718410198725, 2290.8510946788488, 2307.596170670126, 2310.4223944013997, 2240.764719704424, 2262.694536237603, 2279.464325883416, 2288.290629904735, 2292.060255295338, 7583.924160758377, 7649.732259370951, 7656.042994625672, 7664.501807382502, 7673.194314596943, 4475.239209334421, 4534.183846907556, 4535.047639995605, 4553.2942393929, 4571.565701258375, 2942.264433891527, 2944.8085874418307, 3000.0999700089887, 3040.543918412234, 3040.7111324424145, 954.8997355277735, 956.789506308611, 963.7349728824629, 972.0473935543207, 994.4977786217986, 10387.324823886423, 10389.168866490663, 10438.060574548326, 10455.424951627658, 10455.424951627658, 4211.810468528924, 4215.114825886598, 4219.810108545123, 4249.277622804131, 4251.659867210616, 9057.411268267542, 9097.1812536872, 9127.954360228288, 9130.589123489459, 9135.406198597202, 4719.811207551728, 4728.196206644879, 4728.621710263171, 4730.006698593265, 4732.858014259577, 3642.21692336149, 3662.633736626316, 4168.979155104265, 4225.450691410097, 4261.382099595541, 3755.849766009329, 3791.33651610967, 3814.237152569497, 3833.789141597239, 3846.0384903774057, 1199.5501686867424, 1237.9690507737378, 1242.2049888071642, 1247.4760600547793, 1248.3196657821509, 1087.3584585094832, 1106.253279036647, 1111.7276267314398, 1163.0869767232682, 1232.9815052774215, 7146.535475194096, 7158.677859496335, 7221.386182174469, 7224.891626625605, 7238.52949558277, 433.2483141749063, 444.2625242098102, 453.85703503396326, 456.5525784730916, 457.7505259633441, 5663.773449061991, 5685.459881311269, 5707.429257074259, 5716.485516303469, 5721.885562288731, 8815.867761983576, 8844.911550884537, 9025.729228123168, 9128.361014728906, 9158.67944621935, 8871.334649901155, 8882.289416846637, 8891.822163556693, 9002.594883230271, 9017.368784185044, 6929.653517324114, 7026.2271150174465, 7052.259512751088, 7060.0, 7101.644917754195, 7109.324614161646, 7138.928610713826, 7158.463115266271, 7180.030695855992, 7196.568205907663, 7886.526808391515, 8172.978377702787, 8215.137410572042, 8262.297704695167, 8283.751487455385, 8103.149169337371, 8192.139825318494, 8218.835623287381, 8237.917620823715, 8353.164683531599, 6760.391564759196, 6792.083068785848, 6894.207166175954, 6936.930630693629, 6942.791716248521, 7030.683619237045, 7082.468814838805, 7085.397741192057, 7111.964440177766, 7113.608751518509, 6941.93058069433, 6968.198657154492, 7126.572405655677, 7220.277972202738, 7237.529560578546, 6914.481413893877, 6917.342852429011, 6940.0, 7088.432925366062, 7130.393916517154, 6961.582305061713, 7019.29807019294, 7075.575465472089, 7115.928840711526, 7127.0, 6530.738770449128, 6532.967335163294, 6572.342765723581, 6572.507061970276, 6590.934090659032, 6295.527835412271, 6529.151210342625, 6550.443212327005, 6620.073189753534, 6620.90068648961], "unit": "ms", "name": "mootools.html", "value": 4333.571773112041}, {"lowerIsBetter": false, "replicates": [345.28353666142755, 349.91077275294793, 355.92881423715255, 357.42097801561476, 359.1309032142216, 6225.7509699611965, 6252.999520076794, 6260.342664020275, 6261.686915654216, 6457.580257283274, 6220.315765265817, 6271.623702577837, 6289.40250676185, 6293.653849038301, 6297.244330680313, 4719.834805781798, 4750.548697873696, 4753.47711751707, 4756.548127927841, 4763.595094416979, 4754.072955773626, 4756.31033500144, 4758.405199350082, 4759.190937540627, 4760.666753327251, 4612.3542704021465, 4691.554302341272, 4709.270063140201, 4714.245720684691, 4729.432468103832, 4707.552782485693, 4708.646851486135, 4717.221658426355, 4720.409948756405, 4721.74030428328, 4095.3652183911245, 4111.588841115894, 4112.403701463271, 4113.01287690955, 4126.834926602963, 5847.970760146172, 5893.616914900518, 5936.317323507808, 5947.583669143161, 5957.136215248808, 5405.648587853037, 5473.0969390050595, 5478.397376288605, 5499.065158922993, 5516.089845175541, 6543.541952063358, 6580.86838263232, 6583.144191255106, 6584.835379115512, 6624.436922861562, 4530.411046563959, 4542.500324964251, 4546.20441422753, 4551.8179272829375, 4556.453225612948, 6790.388865002174, 6838.658067096675, 6906.965465172692, 6929.480288978297, 6933.618650974195, 4649.721016739007, 4659.836905708284, 4660.813567457264, 4665.090307390026, 4676.602488788423, 4721.881952951204, 4724.881877953078, 4728.810847566127, 4729.196036673774, 4741.5495527924795, 5409.350877894678, 5454.154606036071, 5457.863553411117, 5463.180522921593, 5467.20725494809, 6530.2816690164045, 6688.862893308149, 6698.22970358415, 6703.430208432241, 6708.798736037927, 1625.447347901719, 1646.0452937296338, 1681.7897762779653, 1685.3258696521489, 1686.207482483231, 1107.4739498738195, 1112.7663190730038, 1118.189312748251, 1127.3630398824803, 1130.1862658885755, 6425.807225783234, 6427.0, 6427.2929977702415, 6431.324710905287, 6433.871322573522, 6726.495512836557, 6770.966145169341, 6771.492138089663, 6775.0514927910135, 6777.864442711217, 6362.713677884413, 6373.139626150503, 6399.840003999844, 6415.0, 6419.390157934989, 3737.6822970047306, 3769.076576238839, 3772.490713753608, 3774.471573979645, 3775.3959366501776, 7201.855962880713, 7215.530990485601, 7215.711371545184, 7237.457190710717, 7259.564426134449, 6999.475039372068, 7115.71537138519, 7161.820954476179, 7167.749128780468, 7183.245759195313, 7266.745663901738, 7282.927170728331, 7286.890696639554, 7290.4167666586545, 7302.963485182647, 6891.0, 6932.064171337007, 6933.826654333682, 6944.895826562504, 6959.791206263821, 6742.730290788313, 6851.794446166623, 6898.1377327834025, 6899.89650155238, 6909.343612356818, 7271.4546409020595, 7272.090988626422, 7283.817904552428, 7295.489315747846, 7296.890546641698, 4662.696924699883, 4695.906081878412, 4705.482396936266, 4708.905821883612, 4714.080754253025, 6822.215445223863, 6888.483363747639, 6958.408535274559, 6966.825829354307, 6972.651367431709, 6750.898736518858, 6755.898661519983, 6757.155355580552, 6760.3239676032, 6768.052472653734, 6709.094272273181, 6723.697433615401, 6740.797776066725, 6745.5952642841585, 6746.595204287759, 6473.48212143018, 6584.572002819801, 6610.272869984202, 6616.7022483987375, 6645.634490103091, 6768.7292508299115, 6777.966110169417, 6790.45676345901, 6800.217974932946, 6818.113645226089, 6594.934050659432, 6616.2060552732055, 6620.867582648224, 6624.768133115318, 6630.436412904957], "unit": "ms", "name": "prototype.html", "value": 5022.157373997716}, {"lowerIsBetter": false, "replicates": [843.6330196364582, 860.7934095817002, 866.7313132928789, 872.437277955719, 875.2123089219701, 12199.207051541654, 12449.0, 12476.750464990695, 12482.0638452116, 12496.375181240935, 11389.430528473584, 11623.418829058535, 12178.51285948561, 12190.81713774294, 12193.695157621063, 811.8863359129726, 819.2667562531531, 821.8602837517636, 833.754042557444, 838.0153319849184, 818.1082619944259, 828.0022572799792, 832.138736407815, 832.7168762620707, 834.3658819297317, 852.654674856684, 855.6235256487157, 858.8883445152153, 860.2945584620613, 863.8445079885618, 850.3239924260259, 851.3189448441223, 851.7742798158462, 854.5727136431784, 857.3741168946641, 607.4593611685603, 609.9817005489842, 613.2610204703321, 622.5984240165113, 623.8783437229697, 12370.938145309306, 12410.627681169579, 12464.252144871336, 12470.937645311715, 12476.688082797911, 11337.659870203825, 11531.596394126165, 11538.423078846108, 11539.884601154048, 12026.15816892818, 10108.24188185889, 10176.135028522585, 10370.066693997576, 10482.63310784119, 10758.0, 3510.684038436553, 3564.3762341590377, 3590.4255319149074, 3600.063983364318, 3615.0781550704664, 46391.30413043807, 46409.535904640856, 47572.76213618944, 47995.52004479946, 48293.275600866014, 9697.321187516805, 9772.657956971472, 9796.804063918824, 9820.950895245622, 9839.163671087894, 17719.202635881415, 17796.644067118585, 17849.286028558712, 17862.374816881606, 17904.28382864697, 7220.566765993952, 7225.74709885162, 7299.927000730031, 7402.074740657418, 7553.282438168365, 4372.8906777330185, 4379.794759390205, 4382.0, 4426.535213802505, 4432.889177770517, 3094.4430002599747, 3102.37952409519, 3106.751459883204, 3114.1591770222367, 3123.9062828115193, 555.089652969131, 570.8801151758178, 573.4294377094817, 578.4735890339771, 580.9186713860063, 619.5384438593277, 647.95788273763, 680.7481231944213, 682.6518475577491, 686.8832298509166, 7969.561674107979, 8140.267375936194, 8443.662253509914, 8482.787930301793, 8666.826663466822, 675.3584095109666, 685.0, 686.6257889450262, 688.6797639097744, 701.0675801184412, 3662.956057523593, 3985.601439856049, 3996.5803590623145, 4031.596840315945, 4078.4290199372113, 54616.726916365165, 58979.41020589825, 59055.0, 59242.0, 59278.11082833761, 48997.26504102441, 49590.99999999928, 49592.0, 50071.49928500741, 50237.497625024014, 45965.310520342224, 47043.294350584765, 48207.27689084667, 48592.999999999294, 49059.754701226266, 8288.917110828814, 8422.663093476192, 8513.787155321166, 8555.35834812404, 8803.779905502413, 34838.30323393569, 34857.302853943285, 35191.0, 35448.645513544536, 35702.4644630336, 45202.321965171206, 45575.08849822919, 46323.768381157875, 46332.53667463282, 47396.52603474059, 10976.835347469954, 11050.33697978124, 11055.83416248773, 11158.146206400243, 11203.71990700239, 12445.688857778629, 12653.304068275966, 12763.978881689256, 13241.602751917459, 13316.201027938354, 11295.491702873225, 11327.433628318386, 11444.656660300205, 11562.30626162433, 11778.057755379721, 11288.20982531215, 11398.259113157617, 11482.311061336346, 12035.338056406981, 12068.0, 9951.800963980535, 10934.125269978224, 11276.548938042386, 11433.256838305484, 11441.771164576496, 9738.707838764849, 9754.122129008423, 9962.203023758228, 10107.39355638664, 10116.08955194036, 8770.042873782608, 8817.779555511164, 8870.467771933705, 9477.147056764925, 9489.193418559224], "unit": "ms", "name": "yui.html", "value": 6285.908472883438}], "name": "dromaeo_css", "value": 7129.375993798533}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 109.0, 111.0, 123.0, 112.0, 112.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 149.0, 167.0, 125.0, 146.0, 152.0, 128.0, 162.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [168.0, 164.0, 161.0, 162.0, 163.0, 163.0, 162.0, 165.0, 170.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 73.0, 73.0, 75.0, 137.0, 72.0, 72.0, 82.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 138.0, 90.0, 91.0, 90.0, 135.0, 97.0, 91.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 113.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 72.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 87.0, 86.0, 86.0, 84.0, 85.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 120.0, 122.0, 132.0, 124.0, 124.0, 130.0, 132.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 153.0, 153.0, 154.0, 173.0, 154.0, 151.0, 158.0, 156.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 69.0, 71.0, 69.0, 66.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1524.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.5487646293888], "unit": "score", "name": "Richards", "value": 217.177904}, {"lowerIsBetter": false, "replicates": [193.87359441644048], "unit": "score", "name": "DeltaBlue", "value": 341.0366439999999}, {"lowerIsBetter": false, "replicates": [284.1716396703609], "unit": "score", "name": "Encrypt", "value": 936.6909390000004}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [622.9408175716901], "unit": "score", "name": "Splay", "value": 130.81660039177277}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21340.180644119424}]} 21:43:47 INFO - RETURN: dromaeo_css: 7129.38 21:43:47 INFO - RETURN: kraken: 1524.80 21:43:47 INFO - RETURN: v8_7: 21340.18 21:43:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21340.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7129.38"}}} 21:43:47 INFO - Return code: 0 21:43:47 INFO - # TBPL SUCCESS # 21:43:47 INFO - Running post-action listener: _resource_record_post_action 21:43:47 INFO - Running post-run listener: _resource_record_post_run 21:43:48 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523325440; Read time: 144; Write time: 382132 21:43:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 83206144; Read time: 0; Write time: 45188 21:43:48 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315314176; Read time: 144; Write time: 189792 21:43:48 INFO - Running post-run listener: _upload_blobber_files 21:43:48 INFO - Blob upload gear active. 21:43:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:43:48 INFO - Copying logs to upload dir... 21:43:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.166982 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-20 21:43:47.562574) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:43:47.570155) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010174 build_url: 'https://queue.taskcluster.net/v1/task/h0S20jQ-QymtX058KVDJWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:43:47.596031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:43:47.596343) ========= 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=5804b9f07a53938c557deee7000001c5-1448075416.331712-1752606994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:43:47.645301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:43:47.645620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:43:47.648927) ========= ========= Total master_lag: 0.85 =========