builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1447739976.11 results: success (0) buildid: 20151116193328 builduid: 2bf1d3f0823744b2be45a28d55a661b6 revision: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.108198) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.108696) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.108997) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006407 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.141965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.142251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.180120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.180385) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.256305) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.256579) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.256966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.257239) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 21:59:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2015-11-16 21:59:36 (34.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102534 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.374674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.374959) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.424945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.425246) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 21:59:36,855 truncating revision to first 12 chars 2015-11-16 21:59:36,855 Setting DEBUG logging. 2015-11-16 21:59:36,855 attempt 1/10 2015-11-16 21:59:36,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a2f83cbe53ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 21:59:37,108 unpacking tar archive at: mozilla-central-a2f83cbe53ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.952149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.952446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.962674) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.962984) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 21:59:36.963392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-16 21:59:36.963674) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:37 INFO - MultiFileLogger online at 20151116 21:59:37 in /builds/slave/test-pgo 21:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:59:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:37 INFO - {'append_to_log': False, 21:59:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:37 INFO - 'blob_upload_branch': 'Firefox', 21:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:37 INFO - 'branch': 'Firefox', 21:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:37 INFO - 'config_files': ('talos/linux_config.py',), 21:59:37 INFO - 'default_actions': ('clobber', 21:59:37 INFO - 'read-buildbot-config', 21:59:37 INFO - 'download-and-extract', 21:59:37 INFO - 'populate-webroot', 21:59:37 INFO - 'create-virtualenv', 21:59:37 INFO - 'install', 21:59:37 INFO - 'run-tests'), 21:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:37 INFO - 'download_minidump_stackwalk': True, 21:59:37 INFO - 'download_symbols': 'ondemand', 21:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:37 INFO - 'installer_path': 'installer.exe', 21:59:37 INFO - 'log_level': 'info', 21:59:37 INFO - 'log_name': 'talos', 21:59:37 INFO - 'log_to_console': True, 21:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:37 INFO - 'opt_config_files': (), 21:59:37 INFO - 'pip_index': False, 21:59:37 INFO - 'sps_profile': False, 21:59:37 INFO - 'sps_profile_interval': 0, 21:59:37 INFO - 'suite': 'dromaeojs-e10s', 21:59:37 INFO - 'system_bits': '64', 21:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:37 INFO - 'title': 'talos-linux64-ix-017', 21:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:37 INFO - 'use_talos_json': True, 21:59:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:37 INFO - 'work_dir': 'build'} 21:59:37 INFO - ##### 21:59:37 INFO - ##### Running clobber step. 21:59:37 INFO - ##### 21:59:37 INFO - Running pre-action listener: _resource_record_pre_action 21:59:37 INFO - Running main action method: clobber 21:59:37 INFO - rmtree: /builds/slave/test-pgo/build 21:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:38 INFO - Running post-action listener: _resource_record_post_action 21:59:38 INFO - ##### 21:59:38 INFO - ##### Running read-buildbot-config step. 21:59:38 INFO - ##### 21:59:38 INFO - Running pre-action listener: _resource_record_pre_action 21:59:38 INFO - Running main action method: read_buildbot_config 21:59:38 INFO - Using buildbot properties: 21:59:38 INFO - { 21:59:38 INFO - "properties": { 21:59:38 INFO - "buildnumber": 544, 21:59:38 INFO - "product": "firefox", 21:59:38 INFO - "script_repo_revision": "production", 21:59:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:59:38 INFO - "repository": "", 21:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:59:38 INFO - "buildid": "20151116193328", 21:59:38 INFO - "slavename": "talos-linux64-ix-017", 21:59:38 INFO - "pgo_build": "True", 21:59:38 INFO - "basedir": "/builds/slave/test-pgo", 21:59:38 INFO - "project": "", 21:59:38 INFO - "platform": "ubuntu64_hw", 21:59:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:38 INFO - "slavebuilddir": "test", 21:59:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:59:38 INFO - "branch": "mozilla-central", 21:59:38 INFO - "repo_path": "mozilla-central", 21:59:38 INFO - "stage_platform": "linux64-pgo", 21:59:38 INFO - "builduid": "2bf1d3f0823744b2be45a28d55a661b6", 21:59:38 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 21:59:38 INFO - }, 21:59:38 INFO - "sourcestamp": { 21:59:38 INFO - "repository": "", 21:59:38 INFO - "hasPatch": false, 21:59:38 INFO - "project": "", 21:59:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:59:38 INFO - "changes": [ 21:59:38 INFO - { 21:59:38 INFO - "category": null, 21:59:38 INFO - "files": [ 21:59:38 INFO - { 21:59:38 INFO - "url": null, 21:59:38 INFO - "name": "https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:59:38 INFO - } 21:59:38 INFO - ], 21:59:38 INFO - "repository": "", 21:59:38 INFO - "rev": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb", 21:59:38 INFO - "who": "sendchange", 21:59:38 INFO - "when": 1447739942, 21:59:38 INFO - "number": 6670185, 21:59:38 INFO - "comments": "", 21:59:38 INFO - "project": "", 21:59:38 INFO - "at": "Mon 16 Nov 2015 21:59:02", 21:59:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:59:38 INFO - "revlink": "", 21:59:38 INFO - "properties": [ 21:59:38 INFO - [ 21:59:38 INFO - "buildid", 21:59:38 INFO - "20151116193328", 21:59:38 INFO - "Change" 21:59:38 INFO - ], 21:59:38 INFO - [ 21:59:38 INFO - "builduid", 21:59:38 INFO - "2bf1d3f0823744b2be45a28d55a661b6", 21:59:38 INFO - "Change" 21:59:38 INFO - ], 21:59:38 INFO - [ 21:59:38 INFO - "pgo_build", 21:59:38 INFO - "True", 21:59:38 INFO - "Change" 21:59:38 INFO - ] 21:59:38 INFO - ], 21:59:38 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 21:59:38 INFO - } 21:59:38 INFO - ], 21:59:38 INFO - "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb" 21:59:38 INFO - } 21:59:38 INFO - } 21:59:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:59:38 INFO - Running post-action listener: _resource_record_post_action 21:59:38 INFO - ##### 21:59:38 INFO - ##### Running download-and-extract step. 21:59:38 INFO - ##### 21:59:38 INFO - Running pre-action listener: _resource_record_pre_action 21:59:38 INFO - Running main action method: download_and_extract 21:59:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:38 INFO - https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/test_packages.json 21:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/test_packages.json 21:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:59:43 INFO - Downloaded 1302 bytes. 21:59:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:59:43 INFO - Using the following test package requirements: 21:59:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'jsshell-linux-x86_64.zip'], 21:59:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:43 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:59:43 INFO - https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:45 INFO - Downloaded 22463228 bytes. 21:59:45 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:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:45 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:59:46 INFO - Return code: 0 21:59:46 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:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:46 INFO - https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:48 INFO - Downloaded 22463228 bytes. 21:59:48 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:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:59:48 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:59:50 INFO - Return code: 0 21:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:50 INFO - https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:50 INFO - Downloaded 11131693 bytes. 21:59:50 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:59:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:50 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:59:51 INFO - Return code: 0 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:51 INFO - https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2pWcTd4wR_6oVDE4vEx2_g/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:59:52 INFO - Downloaded 57164913 bytes. 21:59:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:59:52 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:52 INFO - Contents: 21:59:52 INFO - build_url:https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:59:52 INFO - Running post-action listener: _resource_record_post_action 21:59:52 INFO - Running post-action listener: set_extra_try_arguments 21:59:52 INFO - ##### 21:59:52 INFO - ##### Running populate-webroot step. 21:59:52 INFO - ##### 21:59:52 INFO - Running pre-action listener: _resource_record_pre_action 21:59:52 INFO - Running main action method: populate_webroot 21:59:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:59:52 INFO - '../fennec_ids.txt'], 21:59:52 INFO - 'tests': ['tcheck2']}, 21:59:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:52 INFO - '--tppagecycles', 21:59:52 INFO - '7'], 21:59:52 INFO - 'tests': ['tsvgm']}}, 21:59:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'tests': ['damp', 'tps']}, 21:59:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['damp', 'tps']}, 21:59:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:52 INFO - 'other': {'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'other_l64': {'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:52 INFO - 'ts_paint', 21:59:52 INFO - 'tpaint', 21:59:52 INFO - 'sessionrestore', 21:59:52 INFO - 'sessionrestore_no_auto_restore']}, 21:59:52 INFO - 'svgr': {'tests': ['tsvgx', 21:59:52 INFO - 'tsvgr_opacity', 21:59:52 INFO - 'tart', 21:59:52 INFO - 'tscrollx', 21:59:52 INFO - 'cart']}, 21:59:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['tsvgx', 21:59:52 INFO - 'tsvgr_opacity', 21:59:52 INFO - 'tart', 21:59:52 INFO - 'tscrollx', 21:59:52 INFO - 'cart']}, 21:59:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'tests': ['tp5o']}, 21:59:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'talos_options': ['--e10s'], 21:59:52 INFO - 'tests': ['tp5o']}, 21:59:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'talos_options': ['--xperf_path', 21:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:52 INFO - 'tests': ['tp5n']}, 21:59:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:52 INFO - 'talos_options': ['--e10s', 21:59:52 INFO - '--xperf_path', 21:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:52 INFO - 'tests': ['tp5n']}}, 21:59:52 INFO - 'talos.zip': {'path': '', 21:59:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:52 INFO - Running post-action listener: _resource_record_post_action 21:59:52 INFO - ##### 21:59:52 INFO - ##### Running create-virtualenv step. 21:59:52 INFO - ##### 21:59:52 INFO - Running pre-action listener: _resource_record_pre_action 21:59:52 INFO - Running main action method: create_virtualenv 21:59:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:52 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:59:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:52 INFO - Using real prefix '/usr' 21:59:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:55 INFO - Installing pip.................done. 21:59:55 INFO - Return code: 0 21:59:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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:59:55 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:59:55 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:59:55 INFO - Using env: {'DISPLAY': ':0', 21:59:55 INFO - 'HOME': '/home/cltbld', 21:59:55 INFO - 'LANG': 'en_US.UTF-8', 21:59:55 INFO - 'LANGUAGE': 'en_US:en', 21:59:55 INFO - 'LOGNAME': 'cltbld', 21:59:55 INFO - 'MAIL': '/var/mail/cltbld', 21:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:55 INFO - 'MOZ_NO_REMOTE': '1', 21:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:55 INFO - 'NO_EM_RESTART': '1', 21:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:55 INFO - 'SHELL': '/bin/bash', 21:59:55 INFO - 'SHLVL': '1', 21:59:55 INFO - 'TERM': 'linux', 21:59:55 INFO - 'TMOUT': '86400', 21:59:55 INFO - 'USER': 'cltbld', 21:59:55 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 21:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:55 INFO - '_': '/tools/buildbot/bin/python'} 21:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:55 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:59:55 INFO - Cleaning up... 21:59:55 INFO - Return code: 0 21:59:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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:59:55 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:59:55 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:59:55 INFO - Using env: {'DISPLAY': ':0', 21:59:55 INFO - 'HOME': '/home/cltbld', 21:59:55 INFO - 'LANG': 'en_US.UTF-8', 21:59:55 INFO - 'LANGUAGE': 'en_US:en', 21:59:55 INFO - 'LOGNAME': 'cltbld', 21:59:55 INFO - 'MAIL': '/var/mail/cltbld', 21:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:55 INFO - 'MOZ_NO_REMOTE': '1', 21:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:55 INFO - 'NO_EM_RESTART': '1', 21:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:55 INFO - 'SHELL': '/bin/bash', 21:59:55 INFO - 'SHLVL': '1', 21:59:55 INFO - 'TERM': 'linux', 21:59:55 INFO - 'TMOUT': '86400', 21:59:55 INFO - 'USER': 'cltbld', 21:59:55 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 21:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:55 INFO - '_': '/tools/buildbot/bin/python'} 21:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:55 INFO - Downloading/unpacking psutil>=0.7.1 21:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:59:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:57 INFO - Installing collected packages: psutil 21:59:57 INFO - Running setup.py install for psutil 21:59:57 INFO - building 'psutil._psutil_linux' extension 21:59:57 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:59:57 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:59:57 INFO - building 'psutil._psutil_posix' extension 21:59:57 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:59:57 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:59:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:58 INFO - Successfully installed psutil 21:59:58 INFO - Cleaning up... 21:59:58 INFO - Return code: 0 21:59:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:58 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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:59:58 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:59:58 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:59:58 INFO - Using env: {'DISPLAY': ':0', 21:59:58 INFO - 'HOME': '/home/cltbld', 21:59:58 INFO - 'LANG': 'en_US.UTF-8', 21:59:58 INFO - 'LANGUAGE': 'en_US:en', 21:59:58 INFO - 'LOGNAME': 'cltbld', 21:59:58 INFO - 'MAIL': '/var/mail/cltbld', 21:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:58 INFO - 'MOZ_NO_REMOTE': '1', 21:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:58 INFO - 'NO_EM_RESTART': '1', 21:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:58 INFO - 'SHELL': '/bin/bash', 21:59:58 INFO - 'SHLVL': '1', 21:59:58 INFO - 'TERM': 'linux', 21:59:58 INFO - 'TMOUT': '86400', 21:59:58 INFO - 'USER': 'cltbld', 21:59:58 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 21:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:58 INFO - '_': '/tools/buildbot/bin/python'} 21:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:00 INFO - Installing collected packages: mozsystemmonitor 22:00:00 INFO - Running setup.py install for mozsystemmonitor 22:00:00 INFO - Successfully installed mozsystemmonitor 22:00:00 INFO - Cleaning up... 22:00:00 INFO - Return code: 0 22:00:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:00:00 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')]} 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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')]} 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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 22:00:00 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 22:00:00 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 22:00:00 INFO - Using env: {'DISPLAY': ':0', 22:00:00 INFO - 'HOME': '/home/cltbld', 22:00:00 INFO - 'LANG': 'en_US.UTF-8', 22:00:00 INFO - 'LANGUAGE': 'en_US:en', 22:00:00 INFO - 'LOGNAME': 'cltbld', 22:00:00 INFO - 'MAIL': '/var/mail/cltbld', 22:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:00 INFO - 'MOZ_NO_REMOTE': '1', 22:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:00 INFO - 'NO_EM_RESTART': '1', 22:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:00 INFO - 'SHELL': '/bin/bash', 22:00:00 INFO - 'SHLVL': '1', 22:00:00 INFO - 'TERM': 'linux', 22:00:00 INFO - 'TMOUT': '86400', 22:00:00 INFO - 'USER': 'cltbld', 22:00:00 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 22:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:00 INFO - '_': '/tools/buildbot/bin/python'} 22:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:00 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading docopt-0.6.1.tar.gz 22:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:02 INFO - Running setup.py install for blobuploader 22:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:02 INFO - Running setup.py install for requests 22:00:03 INFO - Running setup.py install for docopt 22:00:03 INFO - Successfully installed blobuploader requests docopt 22:00:03 INFO - Cleaning up... 22:00:03 INFO - Return code: 0 22:00:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00: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')]} 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:03 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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 22:00:03 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 22:00:03 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 22:00:03 INFO - Using env: {'DISPLAY': ':0', 22:00:03 INFO - 'HOME': '/home/cltbld', 22:00:03 INFO - 'LANG': 'en_US.UTF-8', 22:00:03 INFO - 'LANGUAGE': 'en_US:en', 22:00:03 INFO - 'LOGNAME': 'cltbld', 22:00:03 INFO - 'MAIL': '/var/mail/cltbld', 22:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:03 INFO - 'MOZ_NO_REMOTE': '1', 22:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:03 INFO - 'NO_EM_RESTART': '1', 22:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:03 INFO - 'SHELL': '/bin/bash', 22:00:03 INFO - 'SHLVL': '1', 22:00:03 INFO - 'TERM': 'linux', 22:00:03 INFO - 'TMOUT': '86400', 22:00:03 INFO - 'USER': 'cltbld', 22:00:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 22:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:03 INFO - '_': '/tools/buildbot/bin/python'} 22:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:03 INFO - Running setup.py (path:/tmp/pip-Vu8VkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:03 INFO - Running setup.py (path:/tmp/pip-fCaZiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:03 INFO - Running setup.py (path:/tmp/pip-XpQLAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:03 INFO - Running setup.py (path:/tmp/pip-2dhOnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:03 INFO - Running setup.py (path:/tmp/pip-0xA6V0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:03 INFO - Running setup.py (path:/tmp/pip-F6PIi3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:03 INFO - Running setup.py (path:/tmp/pip-ShoqEM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:04 INFO - Running setup.py (path:/tmp/pip-FWVXGB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:04 INFO - Running setup.py (path:/tmp/pip-8u98qT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:04 INFO - Running setup.py (path:/tmp/pip-ozOZYn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:04 INFO - Running setup.py (path:/tmp/pip-_iBd1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:04 INFO - Running setup.py (path:/tmp/pip-L74Hr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:04 INFO - Running setup.py (path:/tmp/pip-PmUDoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:04 INFO - Running setup.py (path:/tmp/pip-SWK8cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:04 INFO - Running setup.py (path:/tmp/pip-eFdFCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:04 INFO - Running setup.py (path:/tmp/pip-OYy9jP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:04 INFO - Running setup.py (path:/tmp/pip-jzFMn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:04 INFO - Running setup.py install for manifestparser 22:00:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozcrash 22:00:04 INFO - Running setup.py install for mozdebug 22:00:05 INFO - Running setup.py install for mozdevice 22:00:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for mozfile 22:00:05 INFO - Running setup.py install for mozhttpd 22:00:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for mozinfo 22:00:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for mozInstall 22:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for mozleak 22:00:05 INFO - Running setup.py install for mozlog 22:00:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for moznetwork 22:00:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Running setup.py install for mozprocess 22:00:06 INFO - Running setup.py install for mozprofile 22:00:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Running setup.py install for mozrunner 22:00:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Running setup.py install for mozscreenshot 22:00:06 INFO - Running setup.py install for moztest 22:00:06 INFO - Running setup.py install for mozversion 22:00:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:06 INFO - Cleaning up... 22:00:06 INFO - Return code: 0 22:00:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:06 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')]} 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:06 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')]} 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:06 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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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 22:00:06 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 22:00:06 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 22:00:06 INFO - Using env: {'DISPLAY': ':0', 22:00:06 INFO - 'HOME': '/home/cltbld', 22:00:06 INFO - 'LANG': 'en_US.UTF-8', 22:00:06 INFO - 'LANGUAGE': 'en_US:en', 22:00:06 INFO - 'LOGNAME': 'cltbld', 22:00:06 INFO - 'MAIL': '/var/mail/cltbld', 22:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:06 INFO - 'MOZ_NO_REMOTE': '1', 22:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:06 INFO - 'NO_EM_RESTART': '1', 22:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:06 INFO - 'SHELL': '/bin/bash', 22:00:06 INFO - 'SHLVL': '1', 22:00:06 INFO - 'TERM': 'linux', 22:00:06 INFO - 'TMOUT': '86400', 22:00:06 INFO - 'USER': 'cltbld', 22:00:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 22:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:06 INFO - '_': '/tools/buildbot/bin/python'} 22:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:06 INFO - Running setup.py (path:/tmp/pip-USndfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:06 INFO - Running setup.py (path:/tmp/pip-fX2xj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:06 INFO - Running setup.py (path:/tmp/pip-h8yWYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:06 INFO - Running setup.py (path:/tmp/pip-6ewNg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:07 INFO - Running setup.py (path:/tmp/pip-G5xRMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:07 INFO - Running setup.py (path:/tmp/pip-b83FWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:07 INFO - Running setup.py (path:/tmp/pip-CoTdIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:07 INFO - Running setup.py (path:/tmp/pip-NVzWNk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:07 INFO - Running setup.py (path:/tmp/pip-X3GvYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:07 INFO - Running setup.py (path:/tmp/pip-BK84Z_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:07 INFO - Running setup.py (path:/tmp/pip-wZiRMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:07 INFO - Running setup.py (path:/tmp/pip-zqeZ1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:07 INFO - Running setup.py (path:/tmp/pip-vJPBMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:07 INFO - Running setup.py (path:/tmp/pip-6208ka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:07 INFO - Running setup.py (path:/tmp/pip-yQHdD2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:07 INFO - Running setup.py (path:/tmp/pip-tHVZzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:07 INFO - Running setup.py (path:/tmp/pip-W_sB3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - Downloading blessings-1.5.1.tar.gz 22:00:09 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 22:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:09 INFO - Installing collected packages: blessings 22:00:09 INFO - Running setup.py install for blessings 22:00:09 INFO - Successfully installed blessings 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:10 INFO - Reading from file tmpfile_stdout 22:00:10 INFO - Current package versions: 22:00:10 INFO - argparse == 1.2.1 22:00:10 INFO - blessings == 1.5.1 22:00:10 INFO - blobuploader == 1.2.4 22:00:10 INFO - docopt == 0.6.1 22:00:10 INFO - manifestparser == 1.1 22:00:10 INFO - mozInstall == 1.12 22:00:10 INFO - mozcrash == 0.16 22:00:10 INFO - mozdebug == 0.1 22:00:10 INFO - mozdevice == 0.47 22:00:10 INFO - mozfile == 1.2 22:00:10 INFO - mozhttpd == 0.7 22:00:10 INFO - mozinfo == 0.9 22:00:10 INFO - mozleak == 0.1 22:00:10 INFO - mozlog == 3.0 22:00:10 INFO - moznetwork == 0.27 22:00:10 INFO - mozprocess == 0.22 22:00:10 INFO - mozprofile == 0.27 22:00:10 INFO - mozrunner == 6.11 22:00:10 INFO - mozscreenshot == 0.1 22:00:10 INFO - mozsystemmonitor == 0.0 22:00:10 INFO - moztest == 0.7 22:00:10 INFO - mozversion == 1.4 22:00:10 INFO - psutil == 3.1.1 22:00:10 INFO - requests == 1.2.3 22:00:10 INFO - wsgiref == 0.1.2 22:00:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f5465b26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b543d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', '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 22:00:10 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 22:00:10 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 22:00:10 INFO - Using env: {'DISPLAY': ':0', 22:00:10 INFO - 'HOME': '/home/cltbld', 22:00:10 INFO - 'LANG': 'en_US.UTF-8', 22:00:10 INFO - 'LANGUAGE': 'en_US:en', 22:00:10 INFO - 'LOGNAME': 'cltbld', 22:00:10 INFO - 'MAIL': '/var/mail/cltbld', 22:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:10 INFO - 'MOZ_NO_REMOTE': '1', 22:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:10 INFO - 'NO_EM_RESTART': '1', 22:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:10 INFO - 'SHELL': '/bin/bash', 22:00:10 INFO - 'SHLVL': '1', 22:00:10 INFO - 'TERM': 'linux', 22:00:10 INFO - 'TMOUT': '86400', 22:00:10 INFO - 'USER': 'cltbld', 22:00:10 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 22:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:10 INFO - '_': '/tools/buildbot/bin/python'} 22:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 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)) 22:00:10 INFO - Cleaning up... 22:00:10 INFO - Return code: 0 22:00:10 INFO - Running post-action listener: _resource_record_post_action 22:00:10 INFO - Running post-action listener: _start_resource_monitoring 22:00:10 INFO - Starting resource monitoring. 22:00:10 INFO - ##### 22:00:10 INFO - ##### Running install step. 22:00:10 INFO - ##### 22:00:10 INFO - Running pre-action listener: _resource_record_pre_action 22:00:10 INFO - Running main action method: install 22:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:10 INFO - Reading from file tmpfile_stdout 22:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:10 INFO - Reading from file tmpfile_stdout 22:00:10 INFO - Output received: 22:00:10 INFO - Usage: mozinstall [options] installer 22:00:10 INFO - Options: 22:00:10 INFO - -h, --help show this help message and exit 22:00:10 INFO - -d DEST, --destination=DEST 22:00:10 INFO - Directory to install application into. [default: 22:00:10 INFO - "/builds/slave/test-pgo"] 22:00:10 INFO - --app=APP Application being installed. [default: firefox] 22:00:10 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:10 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'] 22:00:10 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 22:00:24 INFO - Reading from file tmpfile_stdout 22:00:24 INFO - Output received: 22:00:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:24 INFO - Running post-action listener: _resource_record_post_action 22:00:24 INFO - ##### 22:00:24 INFO - ##### Running run-tests step. 22:00:24 INFO - ##### 22:00:24 INFO - Running pre-action listener: _resource_record_pre_action 22:00:24 INFO - Running main action method: run_tests 22:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:24 INFO - Python 2.7.3 22:00:24 INFO - Return code: 0 22:00:24 INFO - grabbing minidump binary from tooltool 22:00:24 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')]} 22:00:25 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 0x1bdd8c0>, '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 0x1b8a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:25 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 22:00:25 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 22:00:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:25 INFO - Return code: 0 22:00:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:00:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 22:00:25 INFO - Using env: {'DISPLAY': ':0', 22:00:25 INFO - 'HOME': '/home/cltbld', 22:00:25 INFO - 'LANG': 'en_US.UTF-8', 22:00:25 INFO - 'LANGUAGE': 'en_US:en', 22:00:25 INFO - 'LOGNAME': 'cltbld', 22:00:25 INFO - 'MAIL': '/var/mail/cltbld', 22:00:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:25 INFO - 'MOZ_NO_REMOTE': '1', 22:00:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:25 INFO - 'NO_EM_RESTART': '1', 22:00:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:25 INFO - 'SHELL': '/bin/bash', 22:00:25 INFO - 'SHLVL': '1', 22:00:25 INFO - 'TERM': 'linux', 22:00:25 INFO - 'TMOUT': '86400', 22:00:25 INFO - 'USER': 'cltbld', 22:00:25 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947', 22:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:25 INFO - '_': '/tools/buildbot/bin/python'} 22:00:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 22:00:25 INFO - mozversion INFO | application_buildid: 20151116193328 22:00:25 INFO - mozversion INFO | application_changeset: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb 22:00:25 INFO - mozversion INFO | application_display_name: Nightly 22:00:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:25 INFO - mozversion INFO | application_name: Firefox 22:00:25 INFO - mozversion INFO | application_remotingname: firefox 22:00:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 22:00:25 INFO - mozversion INFO | application_vendor: Mozilla 22:00:25 INFO - mozversion INFO | application_version: 45.0a1 22:00:25 INFO - mozversion INFO | platform_buildid: 20151116193328 22:00:25 INFO - mozversion INFO | platform_changeset: a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb 22:00:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 22:00:25 INFO - mozversion INFO | platform_version: 45.0a1 22:00:25 INFO - 2015-11-16 22:00:25,257 DEBUG : using testdate: 1447740025 22:00:25 INFO - 2015-11-16 22:00:25,257 DEBUG : actual date: 1447740025 22:00:25 INFO - 2015-11-16 22:00:25,332 INFO : starting webserver on 'localhost:53813' 22:00:25 INFO - 2015-11-16 22:00:25,333 INFO : Starting test suite talos-linux64-ix-017.e 22:00:25 INFO - 2015-11-16 22:00:25,333 INFO : Starting test dromaeo_css 22:00:25 INFO - 2015-11-16 22:00:25,333 DEBUG : operating with platform_type : linux_ 22:00:25 INFO - 2015-11-16 22:00:25,334 INFO : Initialising browser for dromaeo_css test... 22:00:25 INFO - 2015-11-16 22:00:25,350 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpre_tSP/profile http://localhost:53813/getInfo.html 22:00:29 INFO - 2015-11-16 22:00:29,637 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:00:29 INFO - 2015-11-16 22:00:29,637 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:00:29 INFO - 2015-11-16 22:00:29,637 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:00:29 INFO - 2015-11-16 22:00:29,637 DEBUG : BROWSER_OUTPUT: __metrics 22:00:30 INFO - 2015-11-16 22:00:30,741 INFO : Browser initialized. 22:00:30 INFO - 2015-11-16 22:00:30,742 INFO : Running cycle 1/1 for dromaeo_css test... 22:00:30 INFO - 2015-11-16 22:00:30,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpre_tSP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:00:42 INFO - 2015-11-16 22:00:42,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 141074432 22:00:42 INFO - 2015-11-16 22:00:42,527 DEBUG : BROWSER_OUTPUT: 22:01:32 INFO - 2015-11-16 22:01:32,166 DEBUG : BROWSER_OUTPUT: 1447740092164 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] 22:03:40 INFO - 2015-11-16 22:03:40,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53813/tests/dromaeo/cssquery-ext.html) 22:03:41 INFO - 2015-11-16 22:03:41,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 147738624 22:03:41 INFO - 2015-11-16 22:03:41,354 DEBUG : BROWSER_OUTPUT: 22:06:43 INFO - 2015-11-16 22:06:43,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-ext.html (next: http://localhost:53813/tests/dromaeo/cssquery-jquery.html) 22:06:43 INFO - 2015-11-16 22:06:43,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 140607488 22:06:43 INFO - 2015-11-16 22:06:43,949 DEBUG : BROWSER_OUTPUT: 22:09:45 INFO - 2015-11-16 22:09:45,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53813/tests/dromaeo/cssquery-mootools.html) 22:09:46 INFO - 2015-11-16 22:09:46,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 141266944 22:09:46 INFO - 2015-11-16 22:09:46,176 DEBUG : BROWSER_OUTPUT: 22:12:47 INFO - 2015-11-16 22:12:47,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53813/tests/dromaeo/cssquery-prototype.html) 22:12:48 INFO - 2015-11-16 22:12:48,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 140533760 22:12:48 INFO - 2015-11-16 22:12:48,437 DEBUG : BROWSER_OUTPUT: 22:15:50 INFO - 2015-11-16 22:15:50,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53813/tests/dromaeo/cssquery-yui.html) 22:15:51 INFO - 2015-11-16 22:15:51,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 140382208 22:15:51 INFO - 2015-11-16 22:15:51,221 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/dromaeo/cssquery-yui.html (next: http://localhost:53813/tests/dromaeo/cssquery-dojo.html) 22:18:53 INFO - 2015-11-16 22:18:53,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 142946304 22:18:53 INFO - 2015-11-16 22:18:53,830 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,831 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:18:53 INFO - 2015-11-16 22:18:53,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:18:53 INFO - 2015-11-16 22:18:53,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:18:53 INFO - 2015-11-16 22:18:53,832 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:18:53 INFO - 2015-11-16 22:18:53,833 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3165.43022255994;3229.337985712929;3246.724028457581;3258.5112233165037;3275.5086736989465;5151.974240128803;5297.44376840432;5309.73451327434;5320.76056577454;5324.281222035033;5170.3795544534705;5247.081760691883;5249.976254630348;5265.815696450615;5306.177542480922;4845.27320901864;4972.428170760372;4973.3286006389035;4986.825461108862;5055.646104772667;4963.982383611369;4984.352034235544;5014.623903207255;5017.673851199678;5040.7731652075745;4700.788464519088;4808.951910480885;4880.731559764212;4988.7505624718615;5001.574866136383;4814;4856.3201151838775;4860.392450943632;4889.6088312935235;4911.017796440726;4612.7924243409125;4856.927146092811;4862.319275301461;4872.366592342973;4875;5095.210242412432;5106.693598384109;5158.484151584849;5173.534381905609;5173.5602473789395;5657.038303488417;5702.144678298247;5705.286839145107;5726.3414707308775;5730.283714535683;5538.529225015878;5665.716714164275;5764.308283006024;5775.48020678141;5829.067349224146;5300.098983172831;5352;5361.705106219157;5443.646162999432;5491.533219676372;5790.073588225948;5906.616069955439;5915.290165180206;5932.7033648318275;5941.70291485424;5720.742566584514;5736.168255602997;5747.827565173052;5750.137479378127;5781.682007489629;5557.916631250535;5647.068233741469;5697.145428185805;5854.970725146347;5895.056790913433;5733.197352370671;5771.163181338682;5779.3642699303045;5784.363719990798;5788;5495.587830912617;5763.94236057634;5767.22142510764;5776.68228247442;5777.913331300034;4421.602055814928;4430.379746835446;4467.508574056851;4471.441069866267;4505.752183629932;3974.6621537169085;3986.2226865761477;3993.6206060424215;4007.939880901789;4039.434479172918;5151.5363617274625;5242.711650859239;5447.782088716486;5459.972700136474;5461.9453805462235;5596.076647353222;5622.212890195376;5628.127640215773;5633.492985631313;5680.147977803363;5421.241026256327;5485.50630443262;5486.588505862076;5500.064988951888;5518.641288316247;4905.779239934212;4970.254461830755;5044.8234311798915;5087.186050231945;5116.462771408948;5848.152017957373;5854.619449735838;5856.238688970492;5872;5880.882382352329;5753.827385178284;5767.480926716616;5777.971110144423;5780.046292361713;5787.739551720183;5623.325200975909;5749.942500574941;5860.2967643883;5916.437938395846;6060.666663333559;5719.3136823581435;5720.456556627114;5741.62679425836;5752.367239603724;5755.539556835527;5802.506786923159;5815.79644712433;5820.330661973927;5823.272090988627;5829.59192856496;5450.264214331015;5567.498925096599;5582.49757521825;5667;5759.683217423082;5582.246396736388;5594.188842617879;5595.5803314752375;5616.129499927518;5631.605787594829;5388.919166212431;5490.890182196414;5500.257465242141;5505.58653634749;5508.752106155152;5588.161775733673;5606.383297837317;5679.091345384719;5695.772169113355;5707.5433965281845;5518.392976772471;5527.613067085265;5531.612787104864;5533.087040638249;5537.723113844372 22:18:53 INFO - 2015-11-16 22:18:53,834 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.3340857787811;573.3778849947805;594.7056207177448;604.3714536881644;628.4375483941869;38759.61240387595;39427.802860985656;39610.60389396105;39716.205675886464;39826.40260396097;40491.79754101225;40769;41013;41088;41145.38281925766;8577.228049475545;8720.476771393705;8797.95601021994;8820.867686984668;8825.735227943173;8434.873476897852;8664.0902705216;8681.34889883258;8689.17452841979;8691.956540217321;8585.699500517483;8612.784680382978;8667.566621668891;8668.306535477146;8683.34874884383;8599.269062129726;8675.392722509427;8680.175383338572;8687.869681954775;8696.739097827076;8474.915250847474;8515.23362897336;8537.914620853775;8556.914430855737;8613.784655383603;36633.63366366355;37005.629943700485;37163.442548361796;37168.25663486715;37178.25643487142;3170.5719727836677;3265.951010734841;3320.236345640516;3326.7172290355347;3562.69717074049;29413.11760647184;29693.257668558243;29805.552916706267;29807.25481862949;30333.848330758206;3548.3790336690977;3550.8757193498104;3590.9461358079648;3623.3659109655705;3703.166787472824;256383;256728;257217;257706;259090;41295.587044129774;41940;41991.160176796904;42120.78939605282;42284.36573451401;41014.1797164055;41027.794861025504;41315.586844131176;41447;41529;14638.560843174722;14683.19242441676;14752.778708319383;14879.256037198313;14890.627734306512;11734.589289375002;11919.582814601621;11975.401229938469;12029.398530073462;12111.697207569881;13976.510822121178;14017.649558761113;14151.221682807338;14174.858251417354;14229.50196743109;5953.880922381528;6065.423784740443;6071.726772295257;6077.17958075663;6081.648149628299;922.1746536849482;925.9166674999148;981.9051757290712;1022.943738094412;1074.8441475985937;28037.57943630847;28270.252987490607;28318.292042699097;28662.856685716855;28731.56902646462;1076.5263284154946;1084.4686103809076;1103.27184058521;1145.2613064573304;1150.332806971971;14680.192589407685;14857;16288.918555407146;16841.83158168427;16869.578260543338;396847;403046;403836;404854;405318;52651.47348526466;52679.20981185285;52875.47124528782;52964.470355296726;53185.468145318824;1321.3459337627744;1370.6915943912738;1373.9450421983008;1381.7581923163407;1382.536850155189;28556;28918.566221507113;29633.703662963955;29664.70335296706;29868.551971720008;44148.77925610352;44839.55160448354;44908.550914490435;44956.550434495235;45079.54920450754;294739;295067;296127;296618;300092;31707.524387134672;44481.33278000768;45321.32018019798;45364.77317613391;45860;43261.78369108134;43465;43784;44006.339904900815;44227;36703.449448258834;36955;37439;39800.20399591934;41344.1731165381;36109.27781444409;36499.27001459903;37236.441453378764;37260.441093384165;37705.43441848319;35775;36110.4583431254;36249.81875090607;36318.818405907805;36415.27169456543;32314.676853231165;33761.66238337683;33779.15397293132;34135.31729365449;34338.656613433544;25417.364565885262;25428.237152885442;25656.358591035372;25709.3572660685;25891 22:18:53 INFO - 2015-11-16 22:18:53,836 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.1471496336347;354.8137227955323;356.6219807004577;358.7632162772569;360.51690734415894;12379.133460657758;12887.613371598867;16607.418740344092;16978.490645280646;17666.293348266085;11903;11987.820182697267;12012.399380031007;12015.879841201586;12126.272423654587;4408.294672852337;4417.955820441803;4501.077279157765;4511.345854851044;4528.705634133771;4470.351798989144;4481.619062379702;4487.19230538503;4492.079123779634;4508.842190523333;4527.4340707411575;4529.479109902354;4534.36518887356;4556.681032327739;4645.9767701161445;4639.095376401603;4642.3500709900645;4649.53504649534;4658.254679251304;4664.97667511662;4064.512258528966;4078.5921407859273;4272.316429371317;4317.719348242385;4331.133773245364;13168.802467962989;13660.453581856715;13711.245881476514;14038.85961140396;14052.718945621133;2052.784457631942;2054.3220737156853;2079.760827504841;2107.71545841311;2113.830893528514;9614.423134611945;9837.803243935154;9913.405195688281;10000.699979000568;10082;1660.244588712133;1682.5541231573643;1694.347676144681;1705.1985566783717;1712.6574685063038;56903.43096569064;57314.713426433016;57614.42385576133;57712;58084.12873806896;7012.964935175291;7043.823904402431;7054;7077.433805295564;7117.217106118323;8370.288525475282;8378.371622128365;8398.748037558884;8460.942382202225;8475.957620211982;5700.543956483471;5711.742971566289;5782.074868021096;5799.043157878987;5824.097264923944;5847.736851841677;5879.794207202727;5907.113932910098;5953.761849526057;6048.546359023091;3206.1663967368654;3242.886498972525;3251.252211991255;3271.525628783813;3317.038058962922;1168.7662467506364;1169.6841852699724;1174.3130268792681;1181.9468123934444;1224.4795961716236;393.74996876983323;395.48389351895474;421.7933212725804;485.12015938239324;502.7260143221953;9875.851862222073;10124.54439550222;10631.787364252827;10633.149348052291;10670.626528071636;427.55107137505496;435.1862018026311;438.3578058144833;444.65983522605234;453.61216160183227;5740.368559458456;5883.558733095035;5909.704514774244;5982.162497250389;5988.37122102173;499563;504719.09887659963;511188;511696;515619;73556.26443735602;74996;76614.61692691612;76784.61607691926;78117.21882781213;451.45374097342585;452.47738861614886;453.89106614412964;454.3457421313298;455.46255418606364;10013.14888234479;10024.14794742455;10260.640877569249;10261.9486902565;10278.743031424274;34982.12544686403;35024.474632881036;35115.64884351226;35410.29179416346;35530.822345888104;47218.76390618025;48874.511254886995;48947.86047464965;49213.753931230116;50062.24906626476;6772.950192720136;6812.14848143982;6908.481863860331;7094.077769890087;7128.429725621834;12493.500259989862;12628.179168354027;12814.743705126031;12832.358382080673;12832.679183020498;10900;11052.226344156154;11084.057855082408;11190.216684832309;11206.49570769301;9343.672971445967;10395.220358472994;10557.102646275152;10761.784764304513;10852.131829453467;10031.04705053048;10076.294659374067;10127.392356458637;10211.489425528545;10303.124234439856;15354.923225383802;15363.61590960235;15428.9228553861;15554;15700.21498925072;16167;16214;16568.17159142062;16659.583510412336;16755.1622418881 22:18:53 INFO - 2015-11-16 22:18:53,837 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.435086842434;1729.3342063305627;1758.6482703459303;1763.9206235719391;1803.2246134162308;7288.416926645868;7328.890066648991;7703.614819259035;7704.845903081935;7704.961475192623;8034.799130021738;8073.071596766374;8105.148959359256;8127.796805079876;8166.836663266731;2271.1823743452346;2275.670027845961;2301.884905754714;2309.1109922679807;2310.0759696121518;2248.0895237428786;2249.055396733376;2304.9423764405856;2305.4697419593504;2311.919082832101;2106.24175296893;2119.904604292803;2136.7115439415634;2243.741969673492;2278.088764494199;2245.6856040154394;2262.6492893601353;2286.8284878634004;2290.530441259546;2304.850184737995;2256.187772401934;2271.761465046163;2276.055436993662;2285.4514916420108;2285.6571514272828;7760.611969401507;7764.650590723431;7775.261350171724;7830.334421574173;7847;4482.574155455227;4494.505604383515;4529.886752831173;4544;4547.704399214041;2923.517619592786;2987.342784587387;2999.3401451680597;3012.0813151988636;3013.2015016020773;883.1345281624044;884.4869975414244;897.919187273142;924.7919218175924;949.5157469690439;10186.439745813977;10226.89773102267;10253.589856405735;10290.897091029068;10318.226133040127;3924.7252692311836;3925.941110883339;3948.3879998600264;3965.8215380307956;4038.697097717683;8105.878411823827;8159.632816523152;8187.754367368989;8195.221453961864;8220.83558328842;4489.461264648197;4500.414946057057;4520.773961301922;4521.095780843779;4524.411826462539;4130.132672138824;4146.295129827876;4169.145325208386;4171.457710497677;4173.770442625685;3485.825708714554;3497.7376696747847;3504.3867323218333;3516.7186625069935;3540.6105328413855;1050.165118730611;1084.8698156221303;1091.165258577189;1098.4507746126937;1101.438266484099;1049.884512703602;1065.984010239847;1073.4632683658172;1185.199990006742;1312.2716892124963;7186.676599553032;7237.963810180915;7256.818579535448;7298.4891057625455;7312.597807120659;1042.4943902207424;1054.9578016879393;1116.6873275482878;1132.7791080739341;1156.4044517073714;5588.972055139699;5612.831615051555;5631.943680563224;5637;5668.26312579362;8863;9013.278937684969;9046.819063618823;9115.68095116681;9165.541722913827;8795.076516965755;8850;8876.334274929277;8988.865167022499;8997.910020899708;7213.098362704662;7277.2358902315555;7309.817254568572;7353.264673532711;7356.337929586363;7087.149542054986;7126.35862772353;7187.928120718726;7197.928020719726;7210.675519601526;8048.637811298623;8251.33989280868;8319.084900660802;8349.165083491602;8349.37379696513;8451.535165565952;8508.957455212685;8528.976522817053;8570.4000719949;8638.913610864063;6948.965255173692;6983.127109111361;7094.9290507094265;7105.182903965903;7120.7151713932935;7528.284812942762;7558;7559.979402780555;7574.3183113520045;7615.4669173157345;6516.152900122954;7104.396126329113;7256.492045556761;7367.042284502981;7391.963040184764;6642.634655094016;6880.105586273752;7060.223375428596;7067.540609860343;7132.429405647639;6948.131483564554;6967.338102880219;6984.930150698428;7012.719491220294;7021.438284937295;6529.8694026120165;6570.441512471493;6571.868562628816;6582.243042050225;6604.603723776589;6585.506087043586;6605.240397354173;6747.426468750211;6759.222689390783;6762.8985565217545 22:18:53 INFO - 2015-11-16 22:18:53,837 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.96640352762944;320.09094172549953;321.8390804597701;322.91281354034396;326.33264973129957;6228.688565571726;6290.433860952513;6322.873542529147;6368.649724265169;6450.935490645092;6110.694465276741;6275.152854364659;6287;6299.905501417483;6321;4767;4770.3560019397455;4772.355731976173;4772.57046865782;4774.904501909959;4733.905321893577;4749.833755818547;4779.426468823729;4793.808247670089;4799.856004319859;4670.719756814585;4704.153252414564;4709.599684026862;4720.858374248778;4742.478327383985;4677.158111539921;4717.9292310615365;4717.976410117962;4720.527947205286;4733.834315798965;4079.0822065035427;4105.5894410559;4106.260873042851;4112.321466957978;4119.093799364165;5942.138389933479;6001.759929602811;6006.249218847644;6013.669248191348;6021.5548268415705;5431.158170483582;5506.174073888908;5537.141743029796;5547.1679248112705;5547.278853748987;6652.2017357916875;6656.70044847983;6657.600543967329;6660.067590537328;6668.799936001928;4581.587657110843;4593.081383723235;4610.469795973472;4611.5619016193405;4614.169449499089;6829.726810927557;6970.233274339818;6972.721091156348;6980.232174460754;6981.720731170747;4640.466346370211;4648.1865673507;4648.697834640738;4652.930206046912;4661.044485880454;4690.249560070372;4708.882277943078;4715.221988371949;4717.136730991308;4724.598409135262;5499.50504454593;5504.201890725903;5506.174073888868;5507.807226747124;5512.283403157644;6611.834704132435;6730.899036514456;6767.966160169266;6779.2881747416795;6782.2200446948245;1595.0668858717547;1637.2059551117698;1640.261882153036;1645.843644853761;1663.334666133532;1060.7030031591166;1061.506399524225;1072.5495291977388;1082.8592283003159;1086.4079076903106;6318.083877837687;6345.428911397997;6380.680965951684;6381.106645069601;6383.808485745435;6823.044773731682;6846.554973926679;6858.211305699809;6866.141732283465;6872.381485666314;6241.407066328691;6311.274203466568;6346.524010699216;6363.172787537683;6363.459105975951;3717.237966216919;3740.270647223765;3756.2111956488898;3762.698984081267;3769.4722738816586;7018.824529386704;7039.507234493639;7043.7534686285735;7085.610291433917;7091.751788687475;7012.088428504364;7039.577625342496;7069.82325441868;7071.222165561784;7078.539894906815;7243.7464688735645;7315.487915845946;7325.7802265932105;7327.45044121693;7332.0834895638045;6973.721051157897;7031.718731250693;7076.433885289061;7077.398421134261;7085.2560481150795;6906.482013848881;6964.059851919926;6976.058232138596;6979.1625004997695;6989.091418115612;7244.130704315516;7266.67299971492;7274.563526188445;7294.562326260441;7295.817604559928;4602.539746025504;4647.16351056813;4656;4658.790354433991;4660.743659098782;6868.175818901764;6991.720331186695;7031.894521582282;7056.188538318159;7066.222715501188;6803.89794153098;6865.691043903136;6870.793876183722;6871.931280687129;6878.518503704692;6779.661016949231;6818.352256535622;6820.35206655367;6841.213260475109;6861;6500.252470965899;6693.732250709917;6694.163229596301;6708.6310252936555;6721.327867213239;6812;6824.658767061726;6825.317468253135;6889.276625954202;6897.172339319113;6677.899831502628;6699.162604674416;6708.798736037927;6710.765123220664;6712.966435167793 22:18:53 INFO - 2015-11-16 22:18:53,838 DEBUG : BROWSER_OUTPUT: |5;yui.html;728.475497641698;748.6219459173117;794.2375319693094;794.356571177346;862.59026962193;13868;14101.78847317291;14292.571222863318;14310.928445357771;14316.785248221258;13238.735225295512;14565.635859103528;14648.194349310783;14740.6314842129;14792.926035369808;817.0399780258188;817.342039658078;836.5900708652778;837.0792128658488;837.6314421654483;825.8183199696057;831.2394159344193;832.8459235041506;834.445094012484;835.7659855240543;862.5213006781233;864.446754077391;864.8183881384916;866.2247288676631;868.9391742578022;857.2927334948693;858.9699360522352;859.5788063848731;859.9785005374853;860.9741707748747;638.0301941049579;638.4955884850962;639.1499305923111;640.103854603554;642.601587016053;13872.514461993882;14032;14065.296735163201;14066.226357550331;14102.153870767786;12643.494260229672;12703.428345724464;12923.483060677561;13036.80444793329;13209.735805283937;9883.654072107514;9900.356476828983;9927;10233.744156396075;10470;3298;3321.21951341437;3323.0529299149625;3325.534425180477;3435.7423193260356;47356.28965565519;47447.525524744655;47940.28089578694;48061.75969120167;49917.251241231046;10206.438645874548;10388.688339349832;10512.894871051192;10568;10570.207234457446;18750.437486875417;18812.43562693094;18865.339713109974;18955.81044189568;18962.620747585246;7591.506552074097;7664.73173438927;8003.359731221488;8158.306543943712;8170.754877353689;4248.256555102845;4319.8488052918;4446.377507149002;4534.750588717652;4608.97695511527;3215.1801290671197;3245.05893290943;3257.8371081445835;3258.185453636591;3268.9346213076083;469.8247115853576;478.0319852299053;478.54060102301486;480.2100544604107;484.3364590511022;593.2732402806528;616.3682225718675;638.8211300835774;693.486819753389;708.5961002228784;8879.778005549913;8965.193132618097;9019.594118264693;9197.540122993823;9210.171084602418;582.7989343676425;622.411820829312;646.4311405962817;662.199056837925;743.2307561673642;4169;4260.147970405931;4278.08021275421;4301.978490107592;4341.218580655513;57425.42574574285;57971.420285797445;58096.4190358091;58346.708266458394;58724.706376467846;50961.23558146631;52444.21333679998;52521.212181817304;52668;52687;46135.07729845384;46730.53269467262;46874;47733.284000740015;48257.034859302614;8461.40770146084;8532.23209911111;8804.251638610789;8823.205911467998;9085.182333590008;32724.181895451853;32735.345293093527;33872.15319617029;34339.4849077269;34348.656513434544;44974.325385118595;45965.77017114893;46045;46060.30909536293;46325;8206.548639824628;8527.872081918653;8746.212840844355;8809.163129502687;8970.41692289999;12382.876171238173;12435.751284974069;12619.305938173122;12702.809457857955;12790.36048197605;11928.284302941851;12198.14612977083;12268.877311226774;12393.194442361219;12776.169548979287;12106.273623582261;12310.13829031995;12353.814692779795;12476.438560264629;12617.747645046864;11081.778364432828;11229.55081796719;11235.213535052468;11338.94330528375;11442.313461192354;10120.443375614412;10196.643117490852;10237.539310730886;10325.173986080945;11034;9929.404235745878;10068.899311006797;10078.596856125672;10177.643782467578;10323.32898361604 22:18:53 INFO - 2015-11-16 22:18:53,838 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:18:53 INFO - 2015-11-16 22:18:53,838 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,284 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741133830__endTimestamp 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:18:53 INFO - 2015-11-16 22:18:53,839 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5332.27 Median:5518.64 stddev:579.08 (10.5%) stddev-sans-first:555.34 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: Values: 3165.4 3229.3 3246.7 3258.5 3275.5 5152.0 5297.4 5309.7 5320.8 5324.3 5170.4 5247.1 5250.0 5265.8 5306.2 4845.3 4972.4 4973.3 4986.8 5055.6 4964.0 4984.4 5014.6 5017.7 5040.8 4700.8 4809.0 4880.7 4988.8 5001.6 4814.0 4856.3 4860.4 4889.6 4911.0 4612.8 4856.9 4862.3 4872.4 4875.0 5095.2 5106.7 5158.5 5173.5 5173.6 5657.0 5702.1 5705.3 5726.3 5730.3 5538.5 5665.7 5764.3 5775.5 5829.1 5300.1 5352.0 5361.7 5443.6 5491.5 5790.1 5906.6 5915.3 5932.7 5941.7 5720.7 5736.2 5747.8 5750.1 5781.7 5557.9 5647.1 5697.1 5855.0 5895.1 5733.2 5771.2 5779.4 5784.4 5788.0 5495.6 5763.9 5767.2 5776.7 5777.9 4421.6 4430.4 4467.5 4471.4 4505.8 3974.7 3986.2 3993.6 4007.9 4039.4 5151.5 5242.7 5447.8 5460.0 5461.9 5596.1 5622.2 5628.1 5633.5 5680.1 5421.2 5485.5 5486.6 5500.1 5518.6 4905.8 4970.3 5044.8 5087.2 5116.5 5848.2 5854.6 5856.2 5872.0 5880.9 5753.8 5767.5 5778.0 5780.0 5787.7 5623.3 5749.9 5860.3 5916.4 6060.7 5719.3 5720.5 5741.6 5752.4 5755.5 5802.5 5815.8 5820.3 5823.3 5829.6 5450.3 5567.5 5582.5 5667.0 5759.7 5582.2 5594.2 5595.6 5616.1 5631.6 5388.9 5490.9 5500.3 5505.6 5508.8 5588.2 5606.4 5679.1 5695.8 5707.5 5518.4 5527.6 5531.6 5533.1 5537.7 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47686.25 Median:37173.26 stddev:85376.88 (229.7%) stddev-sans-first:85543.08 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: Values: 564.3 573.4 594.7 604.4 628.4 38759.6 39427.8 39610.6 39716.2 39826.4 40491.8 40769.0 41013.0 41088.0 41145.4 8577.2 8720.5 8798.0 8820.9 8825.7 8434.9 8664.1 8681.3 8689.2 8692.0 8585.7 8612.8 8667.6 8668.3 8683.3 8599.3 8675.4 8680.2 8687.9 8696.7 8474.9 8515.2 8537.9 8556.9 8613.8 36633.6 37005.6 37163.4 37168.3 37178.3 3170.6 3266.0 3320.2 3326.7 3562.7 29413.1 29693.3 29805.6 29807.3 30333.8 3548.4 3550.9 3590.9 3623.4 3703.2 256383.0 256728.0 257217.0 257706.0 259090.0 41295.6 41940.0 41991.2 42120.8 42284.4 41014.2 41027.8 41315.6 41447.0 41529.0 14638.6 14683.2 14752.8 14879.3 14890.6 11734.6 11919.6 11975.4 12029.4 12111.7 13976.5 14017.6 14151.2 14174.9 14229.5 5953.9 6065.4 6071.7 6077.2 6081.6 922.2 925.9 981.9 1022.9 1074.8 28037.6 28270.3 28318.3 28662.9 28731.6 1076.5 1084.5 1103.3 1145.3 1150.3 14680.2 14857.0 16288.9 16841.8 16869.6 396847.0 403046.0 403836.0 404854.0 405318.0 52651.5 52679.2 52875.5 52964.5 53185.5 1321.3 1370.7 1373.9 1381.8 1382.5 28556.0 28918.6 29633.7 29664.7 29868.6 44148.8 44839.6 44908.6 44956.6 45079.5 294739.0 295067.0 296127.0 296618.0 300092.0 31707.5 44481.3 45321.3 45364.8 45860.0 43261.8 43465.0 43784.0 44006.3 44227.0 36703.4 36955.0 37439.0 39800.2 41344.2 36109.3 36499.3 37236.4 37260.4 37705.4 35775.0 36110.5 36249.8 36318.8 36415.3 32314.7 33761.7 33779.2 34135.3 34338.7 25417.4 25428.2 25656.4 25709.4 25891.0 22:18:53 INFO - 2015-11-16 22:18:53,840 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,841 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26284.71 Median:2349.93 stddev:83363.24 (3547.5%) stddev-sans-first:83574.36 22:18:53 INFO - 2015-11-16 22:18:53,842 DEBUG : BROWSER_OUTPUT: Values: 353.1 354.8 356.6 358.8 360.5 12379.1 12887.6 16607.4 16978.5 17666.3 11903.0 11987.8 12012.4 12015.9 12126.3 4408.3 4418.0 4501.1 4511.3 4528.7 4470.4 4481.6 4487.2 4492.1 4508.8 4527.4 4529.5 4534.4 4556.7 4646.0 4639.1 4642.4 4649.5 4658.3 4665.0 4064.5 4078.6 4272.3 4317.7 4331.1 13168.8 13660.5 13711.2 14038.9 14052.7 2052.8 2054.3 2079.8 2107.7 2113.8 9614.4 9837.8 9913.4 10000.7 10082.0 1660.2 1682.6 1694.3 1705.2 1712.7 56903.4 57314.7 57614.4 57712.0 58084.1 7013.0 7043.8 7054.0 7077.4 7117.2 8370.3 8378.4 8398.7 8460.9 8476.0 5700.5 5711.7 5782.1 5799.0 5824.1 5847.7 5879.8 5907.1 5953.8 6048.5 3206.2 3242.9 3251.3 3271.5 3317.0 1168.8 1169.7 1174.3 1181.9 1224.5 393.7 395.5 421.8 485.1 502.7 9875.9 10124.5 10631.8 10633.1 10670.6 427.6 435.2 438.4 444.7 453.6 5740.4 5883.6 5909.7 5982.2 5988.4 499563.0 504719.1 511188.0 511696.0 515619.0 73556.3 74996.0 76614.6 76784.6 78117.2 451.5 452.5 453.9 454.3 455.5 10013.1 10024.1 10260.6 10261.9 10278.7 34982.1 35024.5 35115.6 35410.3 35530.8 47218.8 48874.5 48947.9 49213.8 50062.2 6773.0 6812.1 6908.5 7094.1 7128.4 12493.5 12628.2 12814.7 12832.4 12832.7 10900.0 11052.2 11084.1 11190.2 11206.5 9343.7 10395.2 10557.1 10761.8 10852.1 10031.0 10076.3 10127.4 10211.5 10303.1 15354.9 15363.6 15428.9 15554.0 15700.2 16167.0 16214.0 16568.2 16659.6 16755.2 22:18:53 INFO - 2015-11-16 22:18:53,842 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,842 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5383.83 Median:6595.05 stddev:2767.77 (42.0%) stddev-sans-first:2760.19 22:18:53 INFO - 2015-11-16 22:18:53,842 DEBUG : BROWSER_OUTPUT: Values: 1506.4 1729.3 1758.6 1763.9 1803.2 7288.4 7328.9 7703.6 7704.8 7705.0 8034.8 8073.1 8105.1 8127.8 8166.8 2271.2 2275.7 2301.9 2309.1 2310.1 2248.1 2249.1 2304.9 2305.5 2311.9 2106.2 2119.9 2136.7 2243.7 2278.1 2245.7 2262.6 2286.8 2290.5 2304.9 2256.2 2271.8 2276.1 2285.5 2285.7 7760.6 7764.7 7775.3 7830.3 7847.0 4482.6 4494.5 4529.9 4544.0 4547.7 2923.5 2987.3 2999.3 3012.1 3013.2 883.1 884.5 897.9 924.8 949.5 10186.4 10226.9 10253.6 10290.9 10318.2 3924.7 3925.9 3948.4 3965.8 4038.7 8105.9 8159.6 8187.8 8195.2 8220.8 4489.5 4500.4 4520.8 4521.1 4524.4 4130.1 4146.3 4169.1 4171.5 4173.8 3485.8 3497.7 3504.4 3516.7 3540.6 1050.2 1084.9 1091.2 1098.5 1101.4 1049.9 1066.0 1073.5 1185.2 1312.3 7186.7 7238.0 7256.8 7298.5 7312.6 1042.5 1055.0 1116.7 1132.8 1156.4 5589.0 5612.8 5631.9 5637.0 5668.3 8863.0 9013.3 9046.8 9115.7 9165.5 8795.1 8850.0 8876.3 8988.9 8997.9 7213.1 7277.2 7309.8 7353.3 7356.3 7087.1 7126.4 7187.9 7197.9 7210.7 8048.6 8251.3 8319.1 8349.2 8349.4 8451.5 8509.0 8529.0 8570.4 8638.9 6949.0 6983.1 7094.9 7105.2 7120.7 7528.3 7558.0 7560.0 7574.3 7615.5 6516.2 7104.4 7256.5 7367.0 7392.0 6642.6 6880.1 7060.2 7067.5 7132.4 6948.1 6967.3 6984.9 7012.7 7021.4 6529.9 6570.4 6571.9 6582.2 6604.6 6585.5 6605.2 6747.4 6759.2 6762.9 22:18:53 INFO - 2015-11-16 22:18:53,843 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,843 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5598.74 Median:6334.15 stddev:1730.77 (27.3%) stddev-sans-first:1689.67 22:18:53 INFO - 2015-11-16 22:18:53,844 DEBUG : BROWSER_OUTPUT: Values: 320.0 320.1 321.8 322.9 326.3 6228.7 6290.4 6322.9 6368.6 6450.9 6110.7 6275.2 6287.0 6299.9 6321.0 4767.0 4770.4 4772.4 4772.6 4774.9 4733.9 4749.8 4779.4 4793.8 4799.9 4670.7 4704.2 4709.6 4720.9 4742.5 4677.2 4717.9 4718.0 4720.5 4733.8 4079.1 4105.6 4106.3 4112.3 4119.1 5942.1 6001.8 6006.2 6013.7 6021.6 5431.2 5506.2 5537.1 5547.2 5547.3 6652.2 6656.7 6657.6 6660.1 6668.8 4581.6 4593.1 4610.5 4611.6 4614.2 6829.7 6970.2 6972.7 6980.2 6981.7 4640.5 4648.2 4648.7 4652.9 4661.0 4690.2 4708.9 4715.2 4717.1 4724.6 5499.5 5504.2 5506.2 5507.8 5512.3 6611.8 6730.9 6768.0 6779.3 6782.2 1595.1 1637.2 1640.3 1645.8 1663.3 1060.7 1061.5 1072.5 1082.9 1086.4 6318.1 6345.4 6380.7 6381.1 6383.8 6823.0 6846.6 6858.2 6866.1 6872.4 6241.4 6311.3 6346.5 6363.2 6363.5 3717.2 3740.3 3756.2 3762.7 3769.5 7018.8 7039.5 7043.8 7085.6 7091.8 7012.1 7039.6 7069.8 7071.2 7078.5 7243.7 7315.5 7325.8 7327.5 7332.1 6973.7 7031.7 7076.4 7077.4 7085.3 6906.5 6964.1 6976.1 6979.2 6989.1 7244.1 7266.7 7274.6 7294.6 7295.8 4602.5 4647.2 4656.0 4658.8 4660.7 6868.2 6991.7 7031.9 7056.2 7066.2 6803.9 6865.7 6870.8 6871.9 6878.5 6779.7 6818.4 6820.4 6841.2 6861.0 6500.3 6693.7 6694.2 6708.6 6721.3 6812.0 6824.7 6825.3 6889.3 6897.2 6677.9 6699.2 6708.8 6710.8 6713.0 22:18:53 INFO - 2015-11-16 22:18:53,844 DEBUG : BROWSER_OUTPUT: 22:18:53 INFO - 2015-11-16 22:18:53,844 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14036.93 Median:46230.04 stddev:16110.47 (34.8%) stddev-sans-first:16124.66 22:18:53 INFO - 2015-11-16 22:18:53,844 DEBUG : BROWSER_OUTPUT: Values: 728.5 748.6 794.2 794.4 862.6 13868.0 14101.8 14292.6 14310.9 14316.8 13238.7 14565.6 14648.2 14740.6 14792.9 817.0 817.3 836.6 837.1 837.6 825.8 831.2 832.8 834.4 835.8 862.5 864.4 864.8 866.2 868.9 857.3 859.0 859.6 860.0 861.0 638.0 638.5 639.1 640.1 642.6 13872.5 14032.0 14065.3 14066.2 14102.2 12643.5 12703.4 12923.5 13036.8 13209.7 9883.7 9900.4 9927.0 10233.7 10470.0 3298.0 3321.2 3323.1 3325.5 3435.7 47356.3 47447.5 47940.3 48061.8 49917.3 10206.4 10388.7 10512.9 10568.0 10570.2 18750.4 18812.4 18865.3 18955.8 18962.6 7591.5 7664.7 8003.4 8158.3 8170.8 4248.3 4319.8 4446.4 4534.8 4609.0 3215.2 3245.1 3257.8 3258.2 3268.9 469.8 478.0 478.5 480.2 484.3 593.3 616.4 638.8 693.5 708.6 8879.8 8965.2 9019.6 9197.5 9210.2 582.8 622.4 646.4 662.2 743.2 4169.0 4260.1 4278.1 4302.0 4341.2 57425.4 57971.4 58096.4 58346.7 58724.7 50961.2 52444.2 52521.2 52668.0 52687.0 46135.1 46730.5 46874.0 47733.3 48257.0 8461.4 8532.2 8804.3 8823.2 9085.2 32724.2 32735.3 33872.2 34339.5 34348.7 44974.3 45965.8 46045.0 46060.3 46325.0 8206.5 8527.9 8746.2 8809.2 8970.4 12382.9 12435.8 12619.3 12702.8 12790.4 11928.3 12198.1 12268.9 12393.2 12776.2 12106.3 12310.1 12353.8 12476.4 12617.7 11081.8 11229.6 11235.2 11338.9 11442.3 10120.4 10196.6 10237.5 10325.2 11034.0 9929.4 10068.9 10078.6 10177.6 10323.3 22:18:53 INFO - 2015-11-16 22:18:53,844 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:18:53 INFO - 2015-11-16 22:18:53,845 DEBUG : BROWSER_OUTPUT: 22:18:54 INFO - 2015-11-16 22:18:54,502 INFO : Browser exited with error code: 0 22:18:54 INFO - 2015-11-16 22:18:54,523 INFO : Completed test dromaeo_css (00:18:29) 22:18:54 INFO - 2015-11-16 22:18:54,523 INFO : Starting test kraken 22:18:54 INFO - 2015-11-16 22:18:54,523 DEBUG : operating with platform_type : linux_ 22:18:54 INFO - 2015-11-16 22:18:54,523 INFO : Initialising browser for kraken test... 22:18:54 INFO - 2015-11-16 22:18:54,529 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSfOIp_/profile http://localhost:53813/getInfo.html 22:18:58 INFO - 2015-11-16 22:18:58,645 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:18:58 INFO - 2015-11-16 22:18:58,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:18:58 INFO - 2015-11-16 22:18:58,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:18:58 INFO - 2015-11-16 22:18:58,645 DEBUG : BROWSER_OUTPUT: __metrics 22:18:59 INFO - 2015-11-16 22:18:59,745 INFO : Browser initialized. 22:18:59 INFO - 2015-11-16 22:18:59,746 INFO : Running cycle 1/1 for kraken test... 22:18:59 INFO - 2015-11-16 22:18:59,746 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSfOIp_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:19:11 INFO - 2015-11-16 22:19:11,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 141139968 22:19:11 INFO - 2015-11-16 22:19:11,441 DEBUG : BROWSER_OUTPUT: 22:19:13 INFO - 2015-11-16 22:19:13,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53813/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:14 INFO - 2015-11-16 22:19:14,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 140881920 22:19:14 INFO - 2015-11-16 22:19:14,530 DEBUG : BROWSER_OUTPUT: 22:19:17 INFO - 2015-11-16 22:19:17,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53813/tests/kraken/driver.html?testName=audio-dft) 22:19:17 INFO - 2015-11-16 22:19:17,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 22:19:17 INFO - 2015-11-16 22:19:17,839 DEBUG : BROWSER_OUTPUT: 22:19:20 INFO - 2015-11-16 22:19:20,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53813/tests/kraken/driver.html?testName=audio-fft) 22:19:21 INFO - 2015-11-16 22:19:21,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 136630272 22:19:21 INFO - 2015-11-16 22:19:21,272 DEBUG : BROWSER_OUTPUT: 22:19:23 INFO - 2015-11-16 22:19:23,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53813/tests/kraken/driver.html?testName=audio-oscillator) 22:19:24 INFO - 2015-11-16 22:19:24,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 137072640 22:19:24 INFO - 2015-11-16 22:19:24,189 DEBUG : BROWSER_OUTPUT: 22:19:26 INFO - 2015-11-16 22:19:26,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:26 INFO - 2015-11-16 22:19:26,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 137428992 22:19:26 INFO - 2015-11-16 22:19:26,948 DEBUG : BROWSER_OUTPUT: 22:19:29 INFO - 2015-11-16 22:19:29,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53813/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:30 INFO - 2015-11-16 22:19:30,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 138113024 22:19:30 INFO - 2015-11-16 22:19:30,554 DEBUG : BROWSER_OUTPUT: 22:19:33 INFO - 2015-11-16 22:19:33,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53813/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:34 INFO - 2015-11-16 22:19:34,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 22:19:34 INFO - 2015-11-16 22:19:34,537 DEBUG : BROWSER_OUTPUT: 22:19:37 INFO - 2015-11-16 22:19:37,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53813/tests/kraken/driver.html?testName=json-parse-financial) 22:19:37 INFO - 2015-11-16 22:19:37,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 22:19:37 INFO - 2015-11-16 22:19:37,944 DEBUG : BROWSER_OUTPUT: 22:19:39 INFO - 2015-11-16 22:19:39,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:40 INFO - 2015-11-16 22:19:40,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 22:19:40 INFO - 2015-11-16 22:19:40,134 DEBUG : BROWSER_OUTPUT: 22:19:41 INFO - 2015-11-16 22:19:41,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:42 INFO - 2015-11-16 22:19:42,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 138457088 22:19:42 INFO - 2015-11-16 22:19:42,602 DEBUG : BROWSER_OUTPUT: 22:19:44 INFO - 2015-11-16 22:19:44,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:45 INFO - 2015-11-16 22:19:45,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 22:19:45 INFO - 2015-11-16 22:19:45,286 DEBUG : BROWSER_OUTPUT: 22:19:47 INFO - 2015-11-16 22:19:47,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:48 INFO - 2015-11-16 22:19:48,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 138665984 22:19:48 INFO - 2015-11-16 22:19:48,417 DEBUG : BROWSER_OUTPUT: 22:19:51 INFO - 2015-11-16 22:19:51,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:51 INFO - 2015-11-16 22:19:51,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920 22:19:51 INFO - 2015-11-16 22:19:51,598 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53813/tests/kraken/driver.html?testName=ai-astar) 22:19:53 INFO - 2015-11-16 22:19:53,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 22:19:53 INFO - 2015-11-16 22:19:53,543 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,546 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;104;110;112;110;124;109;111;110;109 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;174;162;134;163;161;126;176;126 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;164;162;162;163;165;173;170 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;73;72;73;144;73;72;73 22:19:53 INFO - 2015-11-16 22:19:53,547 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;133;91;92;90;136;91;91;140 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;110;109;109;109;110;110;110 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;146;148;147;147;148;146 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;97;96;97;96;96;96;95 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;61;63;63;63;63;63;60 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;69;70;70;70;70;69;69;69 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;91;87;87;86;86;85;84;94;84 22:19:53 INFO - 2015-11-16 22:19:53,548 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;120;119;124;129;134;130;126;123;118 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;153;154;144;153;148;152;162;154;150 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;73;66;67;68;66;68;66 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,724 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:19:53 INFO - 2015-11-16 22:19:53,549 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741193544__endTimestamp 22:19:53 INFO - 2015-11-16 22:19:53,550 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,553 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:19:53 INFO - 2015-11-16 22:19:53,553 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:19:53 INFO - 2015-11-16 22:19:53,554 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,554 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:5.07 (4.6%) stddev-sans-first:5.36 22:19:53 INFO - 2015-11-16 22:19:53,554 DEBUG : BROWSER_OUTPUT: Values: 112.0 104.0 110.0 112.0 110.0 124.0 109.0 111.0 110.0 109.0 22:19:53 INFO - 2015-11-16 22:19:53,554 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,554 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.60 Median:161.50 stddev:19.74 (12.2%) stddev-sans-first:20.90 22:19:53 INFO - 2015-11-16 22:19:53,555 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 174.0 162.0 134.0 163.0 161.0 126.0 176.0 126.0 22:19:53 INFO - 2015-11-16 22:19:53,555 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,555 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:3.89 (2.4%) stddev-sans-first:4.02 22:19:53 INFO - 2015-11-16 22:19:53,555 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 164.0 162.0 162.0 163.0 165.0 173.0 170.0 22:19:53 INFO - 2015-11-16 22:19:53,556 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,556 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:22.53 (30.9%) stddev-sans-first:23.75 22:19:53 INFO - 2015-11-16 22:19:53,556 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 73.0 72.0 73.0 144.0 73.0 72.0 73.0 22:19:53 INFO - 2015-11-16 22:19:53,556 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,556 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:91.00 stddev:21.97 (24.1%) stddev-sans-first:22.66 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 133.0 91.0 92.0 90.0 136.0 91.0 91.0 140.0 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,557 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 146.0 148.0 147.0 147.0 148.0 146.0 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 61.0 63.0 63.0 63.0 63.0 63.0 60.0 22:19:53 INFO - 2015-11-16 22:19:53,558 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 69.0 70.0 70.0 70.0 70.0 69.0 69.0 69.0 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:3.16 (3.7%) stddev-sans-first:3.33 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: Values: 86.0 91.0 87.0 87.0 86.0 86.0 85.0 84.0 94.0 84.0 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:5.50 (4.3%) stddev-sans-first:5.45 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: Values: 131.0 120.0 119.0 124.0 129.0 134.0 130.0 126.0 123.0 118.0 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.00 stddev:5.48 (3.6%) stddev-sans-first:4.92 22:19:53 INFO - 2015-11-16 22:19:53,559 DEBUG : BROWSER_OUTPUT: Values: 143.0 153.0 154.0 144.0 153.0 148.0 152.0 162.0 154.0 150.0 22:19:53 INFO - 2015-11-16 22:19:53,560 DEBUG : BROWSER_OUTPUT: 22:19:53 INFO - 2015-11-16 22:19:53,560 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.20 22:19:53 INFO - 2015-11-16 22:19:53,560 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 73.0 66.0 67.0 68.0 66.0 68.0 66.0 22:19:53 INFO - 2015-11-16 22:19:53,560 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:19:53 INFO - 2015-11-16 22:19:53,560 DEBUG : BROWSER_OUTPUT: 22:19:54 INFO - 2015-11-16 22:19:54,501 INFO : Browser exited with error code: 0 22:19:54 INFO - 2015-11-16 22:19:54,555 INFO : Completed test kraken (00:01:00) 22:19:54 INFO - 2015-11-16 22:19:54,555 INFO : Starting test v8_7 22:19:54 INFO - 2015-11-16 22:19:54,555 DEBUG : operating with platform_type : linux_ 22:19:54 INFO - 2015-11-16 22:19:54,555 INFO : Initialising browser for v8_7 test... 22:19:54 INFO - 2015-11-16 22:19:54,561 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_mLIIf/profile http://localhost:53813/getInfo.html 22:19:58 INFO - 2015-11-16 22:19:58,972 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:19:58 INFO - 2015-11-16 22:19:58,972 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:19:58 INFO - 2015-11-16 22:19:58,972 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:19:58 INFO - 2015-11-16 22:19:58,972 DEBUG : BROWSER_OUTPUT: __metrics 22:20:00 INFO - 2015-11-16 22:20:00,025 INFO : Browser initialized. 22:20:00 INFO - 2015-11-16 22:20:00,026 INFO : Running cycle 1/1 for v8_7 test... 22:20:00 INFO - 2015-11-16 22:20:00,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_mLIIf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:20:11 INFO - 2015-11-16 22:20:11,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 141209600 22:20:11 INFO - 2015-11-16 22:20:11,884 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53813/tests/v8_7/run.html (next: http://localhost:53813/tests/v8_7/run.html) 22:20:33 INFO - 2015-11-16 22:20:33,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 137084928 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:33 INFO - 2015-11-16 22:20:33,550 DEBUG : BROWSER_OUTPUT: |0;Richards;162.41676140977748 22:20:33 INFO - 2015-11-16 22:20:33,551 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.23671497584542 22:20:33 INFO - 2015-11-16 22:20:33,551 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 22:20:33 INFO - 2015-11-16 22:20:33,551 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 22:20:33 INFO - 2015-11-16 22:20:33,551 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1057.0824524312895 22:20:33 INFO - 2015-11-16 22:20:33,551 DEBUG : BROWSER_OUTPUT: |5;Earley;717.3601147776184 22:20:33 INFO - 2015-11-16 22:20:33,552 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 22:20:33 INFO - 2015-11-16 22:20:33,552 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 22:20:33 INFO - 2015-11-16 22:20:33,552 DEBUG : BROWSER_OUTPUT: |8;Splay;666.2225183211193 22:20:33 INFO - 2015-11-16 22:20:33,552 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 22:20:33 INFO - 2015-11-16 22:20:33,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741233548__endTimestamp 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.42 Median:162.42 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,553 DEBUG : BROWSER_OUTPUT: Values: 162.4 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.24 Median:193.24 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: Values: 193.2 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: Values: 281.5 22:20:33 INFO - 2015-11-16 22:20:33,554 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: Values: 5076.1 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: Values: 1057.1 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.36 Median:717.36 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,555 DEBUG : BROWSER_OUTPUT: Values: 717.4 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: Values: 12192.8 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: Values: 25100.0 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:666.22 Median:666.22 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,556 DEBUG : BROWSER_OUTPUT: Values: 666.2 22:20:33 INFO - 2015-11-16 22:20:33,557 DEBUG : BROWSER_OUTPUT: 22:20:33 INFO - 2015-11-16 22:20:33,558 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:20:33 INFO - 2015-11-16 22:20:33,558 DEBUG : BROWSER_OUTPUT: Values: 4830.9 22:20:33 INFO - 2015-11-16 22:20:33,558 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:33 INFO - 2015-11-16 22:20:33,558 DEBUG : BROWSER_OUTPUT: 22:20:34 INFO - 2015-11-16 22:20:34,406 INFO : Browser exited with error code: 0 22:20:34 INFO - 2015-11-16 22:20:34,420 INFO : Completed test v8_7 (00:00:39) 22:20:34 INFO - 2015-11-16 22:20:34,588 INFO : Completed test suite (00:20:09) 22:20:34 INFO - 2015-11-16 22:20:34,588 DEBUG : Working with test: dromaeo_css 22:20:34 INFO - 2015-11-16 22:20:34,588 DEBUG : Generating results file: dromaeo_css 22:20:34 INFO - 2015-11-16 22:20:34,589 DEBUG : Working with test: kraken 22:20:34 INFO - 2015-11-16 22:20:34,589 DEBUG : Generating results file: kraken 22:20:34 INFO - 2015-11-16 22:20:34,590 INFO : javascript benchmark 22:20:34 INFO - 2015-11-16 22:20:34,590 DEBUG : Working with test: v8_7 22:20:34 INFO - 2015-11-16 22:20:34,590 DEBUG : Generating results file: v8_7 22:20:34 INFO - 2015-11-16 22:20:34,590 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:34 INFO - 2015-11-16 22:20:34,716 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:20:34 INFO - 2015-11-16 22:20:34,716 DEBUG : process_Request line: dromaeo_css 6755.90 graph.html#tests=[[72,1,43]] 22:20:34 INFO - 2015-11-16 22:20:34,717 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:34 INFO - 2015-11-16 22:20:34,818 DEBUG : process_Request line: kraken 1527.10 graph.html#tests=[[232,1,43]] 22:20:34 INFO - 2015-11-16 22:20:34,819 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:34 INFO - 2015-11-16 22:20:34,853 DEBUG : process_Request line: v8_7 21229.90 graph.html#tests=[[230,1,43]] 22:20:34 INFO - 2015-11-16 22:20:34,854 INFO : javascript benchmark 22:20:34 INFO - 2015-11-16 22:20:34,858 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [353.1471496336347, 354.8137227955323, 356.6219807004577, 358.7632162772569, 360.51690734415894, 12379.133460657758, 12887.613371598867, 16607.418740344092, 16978.490645280646, 17666.293348266085, 11903.0, 11987.820182697267, 12012.399380031007, 12015.879841201586, 12126.272423654587, 4408.294672852337, 4417.955820441803, 4501.077279157765, 4511.345854851044, 4528.705634133771, 4470.351798989144, 4481.619062379702, 4487.19230538503, 4492.079123779634, 4508.842190523333, 4527.4340707411575, 4529.479109902354, 4534.36518887356, 4556.681032327739, 4645.9767701161445, 4639.095376401603, 4642.3500709900645, 4649.53504649534, 4658.254679251304, 4664.97667511662, 4064.512258528966, 4078.5921407859273, 4272.316429371317, 4317.719348242385, 4331.133773245364, 13168.802467962989, 13660.453581856715, 13711.245881476514, 14038.85961140396, 14052.718945621133, 2052.784457631942, 2054.3220737156853, 2079.760827504841, 2107.71545841311, 2113.830893528514, 9614.423134611945, 9837.803243935154, 9913.405195688281, 10000.699979000568, 10082.0, 1660.244588712133, 1682.5541231573643, 1694.347676144681, 1705.1985566783717, 1712.6574685063038, 56903.43096569064, 57314.713426433016, 57614.42385576133, 57712.0, 58084.12873806896, 7012.964935175291, 7043.823904402431, 7054.0, 7077.433805295564, 7117.217106118323, 8370.288525475282, 8378.371622128365, 8398.748037558884, 8460.942382202225, 8475.957620211982, 5700.543956483471, 5711.742971566289, 5782.074868021096, 5799.043157878987, 5824.097264923944, 5847.736851841677, 5879.794207202727, 5907.113932910098, 5953.761849526057, 6048.546359023091, 3206.1663967368654, 3242.886498972525, 3251.252211991255, 3271.525628783813, 3317.038058962922, 1168.7662467506364, 1169.6841852699724, 1174.3130268792681, 1181.9468123934444, 1224.4795961716236, 393.74996876983323, 395.48389351895474, 421.7933212725804, 485.12015938239324, 502.7260143221953, 9875.851862222073, 10124.54439550222, 10631.787364252827, 10633.149348052291, 10670.626528071636, 427.55107137505496, 435.1862018026311, 438.3578058144833, 444.65983522605234, 453.61216160183227, 5740.368559458456, 5883.558733095035, 5909.704514774244, 5982.162497250389, 5988.37122102173, 499563.0, 504719.09887659963, 511188.0, 511696.0, 515619.0, 73556.26443735602, 74996.0, 76614.61692691612, 76784.61607691926, 78117.21882781213, 451.45374097342585, 452.47738861614886, 453.89106614412964, 454.3457421313298, 455.46255418606364, 10013.14888234479, 10024.14794742455, 10260.640877569249, 10261.9486902565, 10278.743031424274, 34982.12544686403, 35024.474632881036, 35115.64884351226, 35410.29179416346, 35530.822345888104, 47218.76390618025, 48874.511254886995, 48947.86047464965, 49213.753931230116, 50062.24906626476, 6772.950192720136, 6812.14848143982, 6908.481863860331, 7094.077769890087, 7128.429725621834, 12493.500259989862, 12628.179168354027, 12814.743705126031, 12832.358382080673, 12832.679183020498, 10900.0, 11052.226344156154, 11084.057855082408, 11190.216684832309, 11206.49570769301, 9343.672971445967, 10395.220358472994, 10557.102646275152, 10761.784764304513, 10852.131829453467, 10031.04705053048, 10076.294659374067, 10127.392356458637, 10211.489425528545, 10303.124234439856, 15354.923225383802, 15363.61590960235, 15428.9228553861, 15554.0, 15700.21498925072, 16167.0, 16214.0, 16568.17159142062, 16659.583510412336, 16755.1622418881], "dojo.html": [3165.43022255994, 3229.337985712929, 3246.724028457581, 3258.5112233165037, 3275.5086736989465, 5151.974240128803, 5297.44376840432, 5309.73451327434, 5320.76056577454, 5324.281222035033, 5170.3795544534705, 5247.081760691883, 5249.976254630348, 5265.815696450615, 5306.177542480922, 4845.27320901864, 4972.428170760372, 4973.3286006389035, 4986.825461108862, 5055.646104772667, 4963.982383611369, 4984.352034235544, 5014.623903207255, 5017.673851199678, 5040.7731652075745, 4700.788464519088, 4808.951910480885, 4880.731559764212, 4988.7505624718615, 5001.574866136383, 4814.0, 4856.3201151838775, 4860.392450943632, 4889.6088312935235, 4911.017796440726, 4612.7924243409125, 4856.927146092811, 4862.319275301461, 4872.366592342973, 4875.0, 5095.210242412432, 5106.693598384109, 5158.484151584849, 5173.534381905609, 5173.5602473789395, 5657.038303488417, 5702.144678298247, 5705.286839145107, 5726.3414707308775, 5730.283714535683, 5538.529225015878, 5665.716714164275, 5764.308283006024, 5775.48020678141, 5829.067349224146, 5300.098983172831, 5352.0, 5361.705106219157, 5443.646162999432, 5491.533219676372, 5790.073588225948, 5906.616069955439, 5915.290165180206, 5932.7033648318275, 5941.70291485424, 5720.742566584514, 5736.168255602997, 5747.827565173052, 5750.137479378127, 5781.682007489629, 5557.916631250535, 5647.068233741469, 5697.145428185805, 5854.970725146347, 5895.056790913433, 5733.197352370671, 5771.163181338682, 5779.3642699303045, 5784.363719990798, 5788.0, 5495.587830912617, 5763.94236057634, 5767.22142510764, 5776.68228247442, 5777.913331300034, 4421.602055814928, 4430.379746835446, 4467.508574056851, 4471.441069866267, 4505.752183629932, 3974.6621537169085, 3986.2226865761477, 3993.6206060424215, 4007.939880901789, 4039.434479172918, 5151.5363617274625, 5242.711650859239, 5447.782088716486, 5459.972700136474, 5461.9453805462235, 5596.076647353222, 5622.212890195376, 5628.127640215773, 5633.492985631313, 5680.147977803363, 5421.241026256327, 5485.50630443262, 5486.588505862076, 5500.064988951888, 5518.641288316247, 4905.779239934212, 4970.254461830755, 5044.8234311798915, 5087.186050231945, 5116.462771408948, 5848.152017957373, 5854.619449735838, 5856.238688970492, 5872.0, 5880.882382352329, 5753.827385178284, 5767.480926716616, 5777.971110144423, 5780.046292361713, 5787.739551720183, 5623.325200975909, 5749.942500574941, 5860.2967643883, 5916.437938395846, 6060.666663333559, 5719.3136823581435, 5720.456556627114, 5741.62679425836, 5752.367239603724, 5755.539556835527, 5802.506786923159, 5815.79644712433, 5820.330661973927, 5823.272090988627, 5829.59192856496, 5450.264214331015, 5567.498925096599, 5582.49757521825, 5667.0, 5759.683217423082, 5582.246396736388, 5594.188842617879, 5595.5803314752375, 5616.129499927518, 5631.605787594829, 5388.919166212431, 5490.890182196414, 5500.257465242141, 5505.58653634749, 5508.752106155152, 5588.161775733673, 5606.383297837317, 5679.091345384719, 5695.772169113355, 5707.5433965281845, 5518.392976772471, 5527.613067085265, 5531.612787104864, 5533.087040638249, 5537.723113844372], "mootools.html": [1506.435086842434, 1729.3342063305627, 1758.6482703459303, 1763.9206235719391, 1803.2246134162308, 7288.416926645868, 7328.890066648991, 7703.614819259035, 7704.845903081935, 7704.961475192623, 8034.799130021738, 8073.071596766374, 8105.148959359256, 8127.796805079876, 8166.836663266731, 2271.1823743452346, 2275.670027845961, 2301.884905754714, 2309.1109922679807, 2310.0759696121518, 2248.0895237428786, 2249.055396733376, 2304.9423764405856, 2305.4697419593504, 2311.919082832101, 2106.24175296893, 2119.904604292803, 2136.7115439415634, 2243.741969673492, 2278.088764494199, 2245.6856040154394, 2262.6492893601353, 2286.8284878634004, 2290.530441259546, 2304.850184737995, 2256.187772401934, 2271.761465046163, 2276.055436993662, 2285.4514916420108, 2285.6571514272828, 7760.611969401507, 7764.650590723431, 7775.261350171724, 7830.334421574173, 7847.0, 4482.574155455227, 4494.505604383515, 4529.886752831173, 4544.0, 4547.704399214041, 2923.517619592786, 2987.342784587387, 2999.3401451680597, 3012.0813151988636, 3013.2015016020773, 883.1345281624044, 884.4869975414244, 897.919187273142, 924.7919218175924, 949.5157469690439, 10186.439745813977, 10226.89773102267, 10253.589856405735, 10290.897091029068, 10318.226133040127, 3924.7252692311836, 3925.941110883339, 3948.3879998600264, 3965.8215380307956, 4038.697097717683, 8105.878411823827, 8159.632816523152, 8187.754367368989, 8195.221453961864, 8220.83558328842, 4489.461264648197, 4500.414946057057, 4520.773961301922, 4521.095780843779, 4524.411826462539, 4130.132672138824, 4146.295129827876, 4169.145325208386, 4171.457710497677, 4173.770442625685, 3485.825708714554, 3497.7376696747847, 3504.3867323218333, 3516.7186625069935, 3540.6105328413855, 1050.165118730611, 1084.8698156221303, 1091.165258577189, 1098.4507746126937, 1101.438266484099, 1049.884512703602, 1065.984010239847, 1073.4632683658172, 1185.199990006742, 1312.2716892124963, 7186.676599553032, 7237.963810180915, 7256.818579535448, 7298.4891057625455, 7312.597807120659, 1042.4943902207424, 1054.9578016879393, 1116.6873275482878, 1132.7791080739341, 1156.4044517073714, 5588.972055139699, 5612.831615051555, 5631.943680563224, 5637.0, 5668.26312579362, 8863.0, 9013.278937684969, 9046.819063618823, 9115.68095116681, 9165.541722913827, 8795.076516965755, 8850.0, 8876.334274929277, 8988.865167022499, 8997.910020899708, 7213.098362704662, 7277.2358902315555, 7309.817254568572, 7353.264673532711, 7356.337929586363, 7087.149542054986, 7126.35862772353, 7187.928120718726, 7197.928020719726, 7210.675519601526, 8048.637811298623, 8251.33989280868, 8319.084900660802, 8349.165083491602, 8349.37379696513, 8451.535165565952, 8508.957455212685, 8528.976522817053, 8570.4000719949, 8638.913610864063, 6948.965255173692, 6983.127109111361, 7094.9290507094265, 7105.182903965903, 7120.7151713932935, 7528.284812942762, 7558.0, 7559.979402780555, 7574.3183113520045, 7615.4669173157345, 6516.152900122954, 7104.396126329113, 7256.492045556761, 7367.042284502981, 7391.963040184764, 6642.634655094016, 6880.105586273752, 7060.223375428596, 7067.540609860343, 7132.429405647639, 6948.131483564554, 6967.338102880219, 6984.930150698428, 7012.719491220294, 7021.438284937295, 6529.8694026120165, 6570.441512471493, 6571.868562628816, 6582.243042050225, 6604.603723776589, 6585.506087043586, 6605.240397354173, 6747.426468750211, 6759.222689390783, 6762.8985565217545], "ext.html": [564.3340857787811, 573.3778849947805, 594.7056207177448, 604.3714536881644, 628.4375483941869, 38759.61240387595, 39427.802860985656, 39610.60389396105, 39716.205675886464, 39826.40260396097, 40491.79754101225, 40769.0, 41013.0, 41088.0, 41145.38281925766, 8577.228049475545, 8720.476771393705, 8797.95601021994, 8820.867686984668, 8825.735227943173, 8434.873476897852, 8664.0902705216, 8681.34889883258, 8689.17452841979, 8691.956540217321, 8585.699500517483, 8612.784680382978, 8667.566621668891, 8668.306535477146, 8683.34874884383, 8599.269062129726, 8675.392722509427, 8680.175383338572, 8687.869681954775, 8696.739097827076, 8474.915250847474, 8515.23362897336, 8537.914620853775, 8556.914430855737, 8613.784655383603, 36633.63366366355, 37005.629943700485, 37163.442548361796, 37168.25663486715, 37178.25643487142, 3170.5719727836677, 3265.951010734841, 3320.236345640516, 3326.7172290355347, 3562.69717074049, 29413.11760647184, 29693.257668558243, 29805.552916706267, 29807.25481862949, 30333.848330758206, 3548.3790336690977, 3550.8757193498104, 3590.9461358079648, 3623.3659109655705, 3703.166787472824, 256383.0, 256728.0, 257217.0, 257706.0, 259090.0, 41295.587044129774, 41940.0, 41991.160176796904, 42120.78939605282, 42284.36573451401, 41014.1797164055, 41027.794861025504, 41315.586844131176, 41447.0, 41529.0, 14638.560843174722, 14683.19242441676, 14752.778708319383, 14879.256037198313, 14890.627734306512, 11734.589289375002, 11919.582814601621, 11975.401229938469, 12029.398530073462, 12111.697207569881, 13976.510822121178, 14017.649558761113, 14151.221682807338, 14174.858251417354, 14229.50196743109, 5953.880922381528, 6065.423784740443, 6071.726772295257, 6077.17958075663, 6081.648149628299, 922.1746536849482, 925.9166674999148, 981.9051757290712, 1022.943738094412, 1074.8441475985937, 28037.57943630847, 28270.252987490607, 28318.292042699097, 28662.856685716855, 28731.56902646462, 1076.5263284154946, 1084.4686103809076, 1103.27184058521, 1145.2613064573304, 1150.332806971971, 14680.192589407685, 14857.0, 16288.918555407146, 16841.83158168427, 16869.578260543338, 396847.0, 403046.0, 403836.0, 404854.0, 405318.0, 52651.47348526466, 52679.20981185285, 52875.47124528782, 52964.470355296726, 53185.468145318824, 1321.3459337627744, 1370.6915943912738, 1373.9450421983008, 1381.7581923163407, 1382.536850155189, 28556.0, 28918.566221507113, 29633.703662963955, 29664.70335296706, 29868.551971720008, 44148.77925610352, 44839.55160448354, 44908.550914490435, 44956.550434495235, 45079.54920450754, 294739.0, 295067.0, 296127.0, 296618.0, 300092.0, 31707.524387134672, 44481.33278000768, 45321.32018019798, 45364.77317613391, 45860.0, 43261.78369108134, 43465.0, 43784.0, 44006.339904900815, 44227.0, 36703.449448258834, 36955.0, 37439.0, 39800.20399591934, 41344.1731165381, 36109.27781444409, 36499.27001459903, 37236.441453378764, 37260.441093384165, 37705.43441848319, 35775.0, 36110.4583431254, 36249.81875090607, 36318.818405907805, 36415.27169456543, 32314.676853231165, 33761.66238337683, 33779.15397293132, 34135.31729365449, 34338.656613433544, 25417.364565885262, 25428.237152885442, 25656.358591035372, 25709.3572660685, 25891.0], "prototype.html": [319.96640352762944, 320.09094172549953, 321.8390804597701, 322.91281354034396, 326.33264973129957, 6228.688565571726, 6290.433860952513, 6322.873542529147, 6368.649724265169, 6450.935490645092, 6110.694465276741, 6275.152854364659, 6287.0, 6299.905501417483, 6321.0, 4767.0, 4770.3560019397455, 4772.355731976173, 4772.57046865782, 4774.904501909959, 4733.905321893577, 4749.833755818547, 4779.426468823729, 4793.808247670089, 4799.856004319859, 4670.719756814585, 4704.153252414564, 4709.599684026862, 4720.858374248778, 4742.478327383985, 4677.158111539921, 4717.9292310615365, 4717.976410117962, 4720.527947205286, 4733.834315798965, 4079.0822065035427, 4105.5894410559, 4106.260873042851, 4112.321466957978, 4119.093799364165, 5942.138389933479, 6001.759929602811, 6006.249218847644, 6013.669248191348, 6021.5548268415705, 5431.158170483582, 5506.174073888908, 5537.141743029796, 5547.1679248112705, 5547.278853748987, 6652.2017357916875, 6656.70044847983, 6657.600543967329, 6660.067590537328, 6668.799936001928, 4581.587657110843, 4593.081383723235, 4610.469795973472, 4611.5619016193405, 4614.169449499089, 6829.726810927557, 6970.233274339818, 6972.721091156348, 6980.232174460754, 6981.720731170747, 4640.466346370211, 4648.1865673507, 4648.697834640738, 4652.930206046912, 4661.044485880454, 4690.249560070372, 4708.882277943078, 4715.221988371949, 4717.136730991308, 4724.598409135262, 5499.50504454593, 5504.201890725903, 5506.174073888868, 5507.807226747124, 5512.283403157644, 6611.834704132435, 6730.899036514456, 6767.966160169266, 6779.2881747416795, 6782.2200446948245, 1595.0668858717547, 1637.2059551117698, 1640.261882153036, 1645.843644853761, 1663.334666133532, 1060.7030031591166, 1061.506399524225, 1072.5495291977388, 1082.8592283003159, 1086.4079076903106, 6318.083877837687, 6345.428911397997, 6380.680965951684, 6381.106645069601, 6383.808485745435, 6823.044773731682, 6846.554973926679, 6858.211305699809, 6866.141732283465, 6872.381485666314, 6241.407066328691, 6311.274203466568, 6346.524010699216, 6363.172787537683, 6363.459105975951, 3717.237966216919, 3740.270647223765, 3756.2111956488898, 3762.698984081267, 3769.4722738816586, 7018.824529386704, 7039.507234493639, 7043.7534686285735, 7085.610291433917, 7091.751788687475, 7012.088428504364, 7039.577625342496, 7069.82325441868, 7071.222165561784, 7078.539894906815, 7243.7464688735645, 7315.487915845946, 7325.7802265932105, 7327.45044121693, 7332.0834895638045, 6973.721051157897, 7031.718731250693, 7076.433885289061, 7077.398421134261, 7085.2560481150795, 6906.482013848881, 6964.059851919926, 6976.058232138596, 6979.1625004997695, 6989.091418115612, 7244.130704315516, 7266.67299971492, 7274.563526188445, 7294.562326260441, 7295.817604559928, 4602.539746025504, 4647.16351056813, 4656.0, 4658.790354433991, 4660.743659098782, 6868.175818901764, 6991.720331186695, 7031.894521582282, 7056.188538318159, 7066.222715501188, 6803.89794153098, 6865.691043903136, 6870.793876183722, 6871.931280687129, 6878.518503704692, 6779.661016949231, 6818.352256535622, 6820.35206655367, 6841.213260475109, 6861.0, 6500.252470965899, 6693.732250709917, 6694.163229596301, 6708.6310252936555, 6721.327867213239, 6812.0, 6824.658767061726, 6825.317468253135, 6889.276625954202, 6897.172339319113, 6677.899831502628, 6699.162604674416, 6708.798736037927, 6710.765123220664, 6712.966435167793], "yui.html": [728.475497641698, 748.6219459173117, 794.2375319693094, 794.356571177346, 862.59026962193, 13868.0, 14101.78847317291, 14292.571222863318, 14310.928445357771, 14316.785248221258, 13238.735225295512, 14565.635859103528, 14648.194349310783, 14740.6314842129, 14792.926035369808, 817.0399780258188, 817.342039658078, 836.5900708652778, 837.0792128658488, 837.6314421654483, 825.8183199696057, 831.2394159344193, 832.8459235041506, 834.445094012484, 835.7659855240543, 862.5213006781233, 864.446754077391, 864.8183881384916, 866.2247288676631, 868.9391742578022, 857.2927334948693, 858.9699360522352, 859.5788063848731, 859.9785005374853, 860.9741707748747, 638.0301941049579, 638.4955884850962, 639.1499305923111, 640.103854603554, 642.601587016053, 13872.514461993882, 14032.0, 14065.296735163201, 14066.226357550331, 14102.153870767786, 12643.494260229672, 12703.428345724464, 12923.483060677561, 13036.80444793329, 13209.735805283937, 9883.654072107514, 9900.356476828983, 9927.0, 10233.744156396075, 10470.0, 3298.0, 3321.21951341437, 3323.0529299149625, 3325.534425180477, 3435.7423193260356, 47356.28965565519, 47447.525524744655, 47940.28089578694, 48061.75969120167, 49917.251241231046, 10206.438645874548, 10388.688339349832, 10512.894871051192, 10568.0, 10570.207234457446, 18750.437486875417, 18812.43562693094, 18865.339713109974, 18955.81044189568, 18962.620747585246, 7591.506552074097, 7664.73173438927, 8003.359731221488, 8158.306543943712, 8170.754877353689, 4248.256555102845, 4319.8488052918, 4446.377507149002, 4534.750588717652, 4608.97695511527, 3215.1801290671197, 3245.05893290943, 3257.8371081445835, 3258.185453636591, 3268.9346213076083, 469.8247115853576, 478.0319852299053, 478.54060102301486, 480.2100544604107, 484.3364590511022, 593.2732402806528, 616.3682225718675, 638.8211300835774, 693.486819753389, 708.5961002228784, 8879.778005549913, 8965.193132618097, 9019.594118264693, 9197.540122993823, 9210.171084602418, 582.7989343676425, 622.411820829312, 646.4311405962817, 662.199056837925, 743.2307561673642, 4169.0, 4260.147970405931, 4278.08021275421, 4301.978490107592, 4341.218580655513, 57425.42574574285, 57971.420285797445, 58096.4190358091, 58346.708266458394, 58724.706376467846, 50961.23558146631, 52444.21333679998, 52521.212181817304, 52668.0, 52687.0, 46135.07729845384, 46730.53269467262, 46874.0, 47733.284000740015, 48257.034859302614, 8461.40770146084, 8532.23209911111, 8804.251638610789, 8823.205911467998, 9085.182333590008, 32724.181895451853, 32735.345293093527, 33872.15319617029, 34339.4849077269, 34348.656513434544, 44974.325385118595, 45965.77017114893, 46045.0, 46060.30909536293, 46325.0, 8206.548639824628, 8527.872081918653, 8746.212840844355, 8809.163129502687, 8970.41692289999, 12382.876171238173, 12435.751284974069, 12619.305938173122, 12702.809457857955, 12790.36048197605, 11928.284302941851, 12198.14612977083, 12268.877311226774, 12393.194442361219, 12776.169548979287, 12106.273623582261, 12310.13829031995, 12353.814692779795, 12476.438560264629, 12617.747645046864, 11081.778364432828, 11229.55081796719, 11235.213535052468, 11338.94330528375, 11442.313461192354, 10120.443375614412, 10196.643117490852, 10237.539310730886, 10325.173986080945, 11034.0, 9929.404235745878, 10068.899311006797, 10078.596856125672, 10177.643782467578, 10323.32898361604]}, "summary": {"lowerIsBetter": false, "suite": 6755.903987641556, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6984.281768267051, "unit": "ms", "value": 6984.281768267051}, "dojo.html": {"lowerIsBetter": false, "filtered": 5295.813733283674, "unit": "ms", "value": 5295.813733283674}, "mootools.html": {"lowerIsBetter": false, "filtered": 4421.208454841948, "unit": "ms", "value": 4421.208454841948}, "ext.html": {"lowerIsBetter": false, "filtered": 18106.00558621099, "unit": "ms", "value": 18106.00558621099}, "prototype.html": {"lowerIsBetter": false, "filtered": 5019.044815758533, "unit": "ms", "value": 5019.044815758533}, "yui.html": {"lowerIsBetter": false, "filtered": 6397.739305265649, "unit": "ms", "value": 6397.739305265649}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447740025, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116193328", "branch": "Firefox", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 164.0, 162.0, 162.0, 163.0, 165.0, 173.0, 170.0], "ai-astar": [112.0, 104.0, 110.0, 112.0, 110.0, 124.0, 109.0, 111.0, 110.0, 109.0], "imaging-gaussian-blur": [111.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "audio-beat-detection": [154.0, 130.0, 174.0, 162.0, 134.0, 163.0, 161.0, 126.0, 176.0, 126.0], "json-stringify-tinderbox": [68.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [143.0, 153.0, 154.0, 144.0, 153.0, 148.0, 152.0, 162.0, 154.0, 150.0], "json-parse-financial": [63.0, 63.0, 63.0, 61.0, 63.0, 63.0, 63.0, 63.0, 63.0, 60.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 68.0, 73.0, 66.0, 67.0, 68.0, 66.0, 68.0, 66.0], "audio-fft": [73.0, 73.0, 73.0, 73.0, 72.0, 73.0, 144.0, 73.0, 72.0, 73.0], "imaging-darkroom": [148.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 146.0], "stanford-crypto-ccm": [131.0, 120.0, 119.0, 124.0, 129.0, 134.0, 130.0, 126.0, 123.0, 118.0], "audio-oscillator": [90.0, 92.0, 133.0, 91.0, 92.0, 90.0, 136.0, 91.0, 91.0, 140.0], "stanford-crypto-aes": [86.0, 91.0, 87.0, 87.0, 86.0, 86.0, 85.0, 84.0, 94.0, 84.0], "imaging-desaturate": [96.0, 95.0, 95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1527.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.9, "unit": "ms", "value": 79.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.3, "unit": "ms", "value": 151.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.6, "unit": "ms", "value": 150.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.4, "unit": "ms", "value": 125.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.5, "unit": "ms", "value": 62.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.5, "unit": "ms", "value": 164.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.0, "unit": "ms", "value": 87.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447740025, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116193328", "branch": "Firefox", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.23671497584542], "Encrypt": [281.5315315315315], "NavierStokes": [4830.917874396136], "Decrypt": [5076.1421319796955], "Splay": [666.2225183211193], "Richards": [162.41676140977748], "RegExp": [25100.0], "Earley": [717.3601147776184], "Boyer": [12192.77108433735], "RayTrace": [1057.0824524312895]}, "summary": {"lowerIsBetter": false, "suite": 21229.904980523173, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.16064999999986, "unit": "score", "value": 342.16064999999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 945.4749119999998, "unit": "score", "value": 945.4749119999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.43765699999998, "unit": "score", "value": 52.43765699999998}, "Splay": {"lowerIsBetter": false, "filtered": 122.31799100000005, "unit": "score", "value": 122.31799100000005}, "RegExp": {"lowerIsBetter": false, "filtered": 36.294223107569735, "unit": "score", "value": 36.294223107569735}, "Richards": {"lowerIsBetter": false, "filtered": 217.35441400000002, "unit": "score", "value": 217.35441400000002}, "Earley": {"lowerIsBetter": false, "filtered": 929.0494220000003, "unit": "score", "value": 929.0494220000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.66050296442688, "unit": "score", "value": 54.66050296442688}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.0295939999999, "unit": "score", "value": 700.0295939999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447740025, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116193328", "branch": "Firefox", "revision": "a2f83cbe53ac4009afa4cb2b0b8f549289b23eeb"}}] 22:20:34 INFO - RETURN: dromaeo_css: 6755.90 22:20:34 INFO - RETURN: kraken: 1527.10 22:20:34 INFO - RETURN: v8_7: 21229.90 22:20:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21229.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1527.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6755.90"}}} 22:20:34 INFO - Return code: 0 22:20:34 INFO - # TBPL SUCCESS # 22:20:34 INFO - Running post-action listener: _resource_record_post_action 22:20:34 INFO - Running post-run listener: _resource_record_post_run 22:20:36 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 528461824; Read time: 0; Write time: 604896 22:20:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245878784; Read time: 0; Write time: 343084 22:20:36 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 282267648; Read time: 0; Write time: 254256 22:20:36 INFO - Running post-run listener: _upload_blobber_files 22:20:36 INFO - Blob upload gear active. 22:20:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:20:36 INFO - Copying logs to upload dir... 22:20:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.726700 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-16 22:20:35.710926) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:20:35.714341) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010023 build_url: 'https://queue.taskcluster.net/v1/task/2pWcTd4wR_6oVDE4vEx2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:20:35.765727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:20:35.766067) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447738342.356552-571242947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:20:35.815681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:20:35.816003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:20:35.816306) ========= ========= Total master_lag: 0.26 =========