builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1447685984.21 results: success (0) buildid: 20151116043001 builduid: 7724e2f2551a49978b8608042f38806d revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.212236) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.213204) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.213918) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006398 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.264607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.264948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.286892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.287566) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018741 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.341926) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.342649) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.343555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.344289) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 06:59:44-- 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% 30.9M=0s 2015-11-16 06:59:44 (30.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.593348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.594027) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.095618 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.705587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:44.706417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --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 48d636f678b0e5162ab868dc9024a5ffe350460c --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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 06:59:44,797 truncating revision to first 12 chars 2015-11-16 06:59:44,797 Setting DEBUG logging. 2015-11-16 06:59:44,797 attempt 1/10 2015-11-16 06:59:44,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 06:59:45,049 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:45.284456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:45.285208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:45.295603) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:45.296252) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:45.297221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-16 06:59:45.297960) ========= /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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:45 INFO - MultiFileLogger online at 20151116 06:59:45 in /builds/slave/test-pgo 06:59:45 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 06:59:45 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:59:45 INFO - {'append_to_log': False, 06:59:45 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:59:45 INFO - 'blob_upload_branch': 'Firefox', 06:59:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:59:45 INFO - 'branch': 'Firefox', 06:59:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:45 INFO - 'config_files': ('talos/linux_config.py',), 06:59:45 INFO - 'default_actions': ('clobber', 06:59:45 INFO - 'read-buildbot-config', 06:59:45 INFO - 'download-and-extract', 06:59:45 INFO - 'populate-webroot', 06:59:45 INFO - 'create-virtualenv', 06:59:45 INFO - 'install', 06:59:45 INFO - 'run-tests'), 06:59:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:45 INFO - 'download_minidump_stackwalk': True, 06:59:45 INFO - 'download_symbols': 'ondemand', 06:59:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:45 INFO - 'installer_path': 'installer.exe', 06:59:45 INFO - 'log_level': 'info', 06:59:45 INFO - 'log_name': 'talos', 06:59:45 INFO - 'log_to_console': True, 06:59:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:45 INFO - 'opt_config_files': (), 06:59:45 INFO - 'pip_index': False, 06:59:45 INFO - 'sps_profile': False, 06:59:45 INFO - 'sps_profile_interval': 0, 06:59:45 INFO - 'suite': 'dromaeojs-e10s', 06:59:45 INFO - 'system_bits': '64', 06:59:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:45 INFO - 'title': 'talos-linux64-ix-048', 06:59:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:45 INFO - 'use_talos_json': True, 06:59:45 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:59:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:45 INFO - 'work_dir': 'build'} 06:59:45 INFO - ##### 06:59:45 INFO - ##### Running clobber step. 06:59:45 INFO - ##### 06:59:45 INFO - Running pre-action listener: _resource_record_pre_action 06:59:45 INFO - Running main action method: clobber 06:59:45 INFO - rmtree: /builds/slave/test-pgo/build 06:59:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - ##### 06:59:49 INFO - ##### Running read-buildbot-config step. 06:59:49 INFO - ##### 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: read_buildbot_config 06:59:49 INFO - Using buildbot properties: 06:59:49 INFO - { 06:59:49 INFO - "properties": { 06:59:49 INFO - "buildnumber": 28, 06:59:49 INFO - "product": "firefox", 06:59:49 INFO - "script_repo_revision": "production", 06:59:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:59:49 INFO - "repository": "", 06:59:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:59:49 INFO - "buildid": "20151116043001", 06:59:49 INFO - "slavename": "talos-linux64-ix-048", 06:59:49 INFO - "pgo_build": "True", 06:59:49 INFO - "basedir": "/builds/slave/test-pgo", 06:59:49 INFO - "project": "", 06:59:49 INFO - "platform": "ubuntu64_hw", 06:59:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:59:49 INFO - "slavebuilddir": "test", 06:59:49 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:59:49 INFO - "branch": "mozilla-central", 06:59:49 INFO - "repo_path": "mozilla-central", 06:59:49 INFO - "stage_platform": "linux64-pgo", 06:59:49 INFO - "builduid": "7724e2f2551a49978b8608042f38806d", 06:59:49 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:49 INFO - }, 06:59:49 INFO - "sourcestamp": { 06:59:49 INFO - "repository": "", 06:59:49 INFO - "hasPatch": false, 06:59:49 INFO - "project": "", 06:59:49 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:59:49 INFO - "changes": [ 06:59:49 INFO - { 06:59:49 INFO - "category": null, 06:59:49 INFO - "files": [ 06:59:49 INFO - { 06:59:49 INFO - "url": null, 06:59:49 INFO - "name": "https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:59:49 INFO - } 06:59:49 INFO - ], 06:59:49 INFO - "repository": "", 06:59:49 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 06:59:49 INFO - "who": "sendchange", 06:59:49 INFO - "when": 1447685925, 06:59:49 INFO - "number": 6666018, 06:59:49 INFO - "comments": "", 06:59:49 INFO - "project": "", 06:59:49 INFO - "at": "Mon 16 Nov 2015 06:58:45", 06:59:49 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:59:49 INFO - "revlink": "", 06:59:49 INFO - "properties": [ 06:59:49 INFO - [ 06:59:49 INFO - "buildid", 06:59:49 INFO - "20151116043001", 06:59:49 INFO - "Change" 06:59:49 INFO - ], 06:59:49 INFO - [ 06:59:49 INFO - "builduid", 06:59:49 INFO - "7724e2f2551a49978b8608042f38806d", 06:59:49 INFO - "Change" 06:59:49 INFO - ], 06:59:49 INFO - [ 06:59:49 INFO - "pgo_build", 06:59:49 INFO - "True", 06:59:49 INFO - "Change" 06:59:49 INFO - ] 06:59:49 INFO - ], 06:59:49 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:49 INFO - } 06:59:49 INFO - ], 06:59:49 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:49 INFO - } 06:59:49 INFO - } 06:59:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - ##### 06:59:49 INFO - ##### Running download-and-extract step. 06:59:49 INFO - ##### 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: download_and_extract 06:59:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:49 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json 06:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json 06:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:59:50 INFO - Downloaded 1302 bytes. 06:59:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:59:50 INFO - Using the following test package requirements: 06:59:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'jsshell-linux-x86_64.zip'], 06:59:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06: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')]} 06:59:50 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:55 INFO - Downloaded 22462077 bytes. 06:59:55 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 06:59:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:55 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 06:59:57 INFO - Return code: 0 06:59:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:57 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:58 INFO - Downloaded 22462077 bytes. 06:59:58 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 06:59:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:58 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 07:00:00 INFO - Return code: 0 07: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')]} 07:00:00 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 07:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 07:00:01 INFO - Downloaded 11131693 bytes. 07:00:01 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 07:00:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:01 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 07:00:02 INFO - Return code: 0 07:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:02 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 07:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 07:00:04 INFO - Downloaded 57132176 bytes. 07:00:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - mkdir: /builds/slave/test-pgo/properties 07:00:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:00:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:00:04 INFO - Contents: 07:00:04 INFO - build_url:https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - Running post-action listener: _resource_record_post_action 07:00:04 INFO - Running post-action listener: set_extra_try_arguments 07:00:04 INFO - ##### 07:00:04 INFO - ##### Running populate-webroot step. 07:00:04 INFO - ##### 07:00:04 INFO - Running pre-action listener: _resource_record_pre_action 07:00:04 INFO - Running main action method: populate_webroot 07:00:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:00:04 INFO - '../fennec_ids.txt'], 07:00:04 INFO - 'tests': ['tcheck2']}, 07:00:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:04 INFO - '--tppagecycles', 07:00:04 INFO - '7'], 07:00:04 INFO - 'tests': ['tsvgm']}}, 07:00:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:00:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:00:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:00:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'tests': ['damp', 'tps']}, 07:00:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['damp', 'tps']}, 07:00:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:00:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:04 INFO - 'other': {'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'other_l64': {'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'other_nol64': {'tests': ['a11yr', 07:00:04 INFO - 'ts_paint', 07:00:04 INFO - 'tpaint', 07:00:04 INFO - 'sessionrestore', 07:00:04 INFO - 'sessionrestore_no_auto_restore']}, 07:00:04 INFO - 'svgr': {'tests': ['tsvgx', 07:00:04 INFO - 'tsvgr_opacity', 07:00:04 INFO - 'tart', 07:00:04 INFO - 'tscrollx', 07:00:04 INFO - 'cart']}, 07:00:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['tsvgx', 07:00:04 INFO - 'tsvgr_opacity', 07:00:04 INFO - 'tart', 07:00:04 INFO - 'tscrollx', 07:00:04 INFO - 'cart']}, 07:00:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'tests': ['tp5o']}, 07:00:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'talos_options': ['--e10s'], 07:00:04 INFO - 'tests': ['tp5o']}, 07:00:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'talos_options': ['--xperf_path', 07:00:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:04 INFO - 'tests': ['tp5n']}, 07:00:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:04 INFO - 'talos_options': ['--e10s', 07:00:04 INFO - '--xperf_path', 07:00:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:04 INFO - 'tests': ['tp5n']}}, 07:00:04 INFO - 'talos.zip': {'path': '', 07:00:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:04 INFO - Running post-action listener: _resource_record_post_action 07:00:04 INFO - ##### 07:00:04 INFO - ##### Running create-virtualenv step. 07:00:04 INFO - ##### 07:00:04 INFO - Running pre-action listener: _resource_record_pre_action 07:00:04 INFO - Running main action method: create_virtualenv 07:00:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:00:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:00:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:00:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:04 INFO - Using real prefix '/usr' 07:00:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:00:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:06 INFO - Installing pip.................done. 07:00:06 INFO - Return code: 0 07:00:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07: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')]} 07:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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', '--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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07: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', '--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 07: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 --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 07:00:06 INFO - Using env: {'DISPLAY': ':0', 07:00:06 INFO - 'HOME': '/home/cltbld', 07:00:06 INFO - 'LANG': 'en_US.UTF-8', 07:00:06 INFO - 'LANGUAGE': 'en_US:en', 07:00:06 INFO - 'LOGNAME': 'cltbld', 07:00:06 INFO - 'MAIL': '/var/mail/cltbld', 07:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:06 INFO - 'MOZ_NO_REMOTE': '1', 07:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:06 INFO - 'NO_EM_RESTART': '1', 07:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:06 INFO - 'SHELL': '/bin/bash', 07:00:06 INFO - 'SHLVL': '1', 07:00:06 INFO - 'TERM': 'linux', 07:00:06 INFO - 'TMOUT': '86400', 07:00:06 INFO - 'USER': 'cltbld', 07:00:06 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:06 INFO - '_': '/tools/buildbot/bin/python'} 07:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:00:07 INFO - Cleaning up... 07:00:07 INFO - Return code: 0 07:00:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:00:07 INFO - Using env: {'DISPLAY': ':0', 07:00:07 INFO - 'HOME': '/home/cltbld', 07:00:07 INFO - 'LANG': 'en_US.UTF-8', 07:00:07 INFO - 'LANGUAGE': 'en_US:en', 07:00:07 INFO - 'LOGNAME': 'cltbld', 07:00:07 INFO - 'MAIL': '/var/mail/cltbld', 07:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:07 INFO - 'MOZ_NO_REMOTE': '1', 07:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:07 INFO - 'NO_EM_RESTART': '1', 07:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:07 INFO - 'SHELL': '/bin/bash', 07:00:07 INFO - 'SHLVL': '1', 07:00:07 INFO - 'TERM': 'linux', 07:00:07 INFO - 'TMOUT': '86400', 07:00:07 INFO - 'USER': 'cltbld', 07:00:07 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:07 INFO - '_': '/tools/buildbot/bin/python'} 07:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:08 INFO - Downloading/unpacking psutil>=0.7.1 07:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:08 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 07:00:08 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 07:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:09 INFO - Installing collected packages: psutil 07:00:09 INFO - Running setup.py install for psutil 07:00:10 INFO - building 'psutil._psutil_linux' extension 07:00:10 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 07:00:11 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 07:00:11 INFO - building 'psutil._psutil_posix' extension 07:00:11 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 07:00:11 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 07:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:11 INFO - Successfully installed psutil 07:00:11 INFO - Cleaning up... 07:00:11 INFO - Return code: 0 07:00:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:00:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:00:11 INFO - Using env: {'DISPLAY': ':0', 07:00:11 INFO - 'HOME': '/home/cltbld', 07:00:11 INFO - 'LANG': 'en_US.UTF-8', 07:00:11 INFO - 'LANGUAGE': 'en_US:en', 07:00:11 INFO - 'LOGNAME': 'cltbld', 07:00:11 INFO - 'MAIL': '/var/mail/cltbld', 07:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:11 INFO - 'MOZ_NO_REMOTE': '1', 07:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:11 INFO - 'NO_EM_RESTART': '1', 07:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:11 INFO - 'SHELL': '/bin/bash', 07:00:11 INFO - 'SHLVL': '1', 07:00:11 INFO - 'TERM': 'linux', 07:00:11 INFO - 'TMOUT': '86400', 07:00:11 INFO - 'USER': 'cltbld', 07:00:11 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:11 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:00:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:13 INFO - Installing collected packages: mozsystemmonitor 07:00:13 INFO - Running setup.py install for mozsystemmonitor 07:00:13 INFO - Successfully installed mozsystemmonitor 07:00:13 INFO - Cleaning up... 07:00:13 INFO - Return code: 0 07:00:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:00:13 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')]} 07:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:13 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')]} 07:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:13 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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:13 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 07:00:13 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 07:00:13 INFO - Using env: {'DISPLAY': ':0', 07:00:13 INFO - 'HOME': '/home/cltbld', 07:00:13 INFO - 'LANG': 'en_US.UTF-8', 07:00:13 INFO - 'LANGUAGE': 'en_US:en', 07:00:13 INFO - 'LOGNAME': 'cltbld', 07:00:13 INFO - 'MAIL': '/var/mail/cltbld', 07:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:13 INFO - 'MOZ_NO_REMOTE': '1', 07:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:13 INFO - 'NO_EM_RESTART': '1', 07:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:13 INFO - 'SHELL': '/bin/bash', 07:00:13 INFO - 'SHLVL': '1', 07:00:13 INFO - 'TERM': 'linux', 07:00:13 INFO - 'TMOUT': '86400', 07:00:13 INFO - 'USER': 'cltbld', 07:00:13 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:13 INFO - '_': '/tools/buildbot/bin/python'} 07:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:00:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:00:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:00:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 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 07:00:16 INFO - Downloading docopt-0.6.1.tar.gz 07:00:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:00:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:16 INFO - Running setup.py install for blobuploader 07:00:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:00:16 INFO - Running setup.py install for requests 07:00:17 INFO - Running setup.py install for docopt 07:00:17 INFO - Successfully installed blobuploader requests docopt 07:00:17 INFO - Cleaning up... 07:00:17 INFO - Return code: 0 07:00:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:17 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 07:00:17 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 07:00:17 INFO - Using env: {'DISPLAY': ':0', 07:00:17 INFO - 'HOME': '/home/cltbld', 07:00:17 INFO - 'LANG': 'en_US.UTF-8', 07:00:17 INFO - 'LANGUAGE': 'en_US:en', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MAIL': '/var/mail/cltbld', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SHLVL': '1', 07:00:17 INFO - 'TERM': 'linux', 07:00:17 INFO - 'TMOUT': '86400', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - '_': '/tools/buildbot/bin/python'} 07:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:17 INFO - Running setup.py (path:/tmp/pip-JqLgmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:17 INFO - Running setup.py (path:/tmp/pip-7jmARu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:17 INFO - Running setup.py (path:/tmp/pip-1laUIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:17 INFO - Running setup.py (path:/tmp/pip-t7aQ0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:17 INFO - Running setup.py (path:/tmp/pip-9u1mKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:17 INFO - Running setup.py (path:/tmp/pip-N0Rbtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:18 INFO - Running setup.py (path:/tmp/pip-Dn61Gg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:18 INFO - Running setup.py (path:/tmp/pip-I68xGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:18 INFO - Running setup.py (path:/tmp/pip-qGEY9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:18 INFO - Running setup.py (path:/tmp/pip-xMzBNP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:18 INFO - Running setup.py (path:/tmp/pip-2LibNM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:18 INFO - Running setup.py (path:/tmp/pip-t1aBxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:18 INFO - Running setup.py (path:/tmp/pip-2KXhKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:18 INFO - Running setup.py (path:/tmp/pip-DWDiin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:18 INFO - Running setup.py (path:/tmp/pip-4DKrXg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:18 INFO - Running setup.py (path:/tmp/pip-eMhuUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:18 INFO - Running setup.py (path:/tmp/pip-YYwUGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:18 INFO - Running setup.py install for manifestparser 07:00:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:00:18 INFO - Running setup.py install for mozcrash 07:00:18 INFO - Running setup.py install for mozdebug 07:00:19 INFO - Running setup.py install for mozdevice 07:00:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for mozfile 07:00:19 INFO - Running setup.py install for mozhttpd 07:00:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for mozinfo 07:00:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for mozInstall 07:00:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for mozleak 07:00:19 INFO - Running setup.py install for mozlog 07:00:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for moznetwork 07:00:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:00:19 INFO - Running setup.py install for mozprocess 07:00:20 INFO - Running setup.py install for mozprofile 07:00:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:00:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:00:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:00:20 INFO - Running setup.py install for mozrunner 07:00:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:00:20 INFO - Running setup.py install for mozscreenshot 07:00:20 INFO - Running setup.py install for moztest 07:00:20 INFO - Running setup.py install for mozversion 07:00:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:00:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:20 INFO - Cleaning up... 07:00:20 INFO - Return code: 0 07:00:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:20 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')]} 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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')]} 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:20 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 07:00:20 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 07:00:20 INFO - Using env: {'DISPLAY': ':0', 07:00:20 INFO - 'HOME': '/home/cltbld', 07:00:20 INFO - 'LANG': 'en_US.UTF-8', 07:00:20 INFO - 'LANGUAGE': 'en_US:en', 07:00:20 INFO - 'LOGNAME': 'cltbld', 07:00:20 INFO - 'MAIL': '/var/mail/cltbld', 07:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:20 INFO - 'MOZ_NO_REMOTE': '1', 07:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:20 INFO - 'NO_EM_RESTART': '1', 07:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:20 INFO - 'SHELL': '/bin/bash', 07:00:20 INFO - 'SHLVL': '1', 07:00:20 INFO - 'TERM': 'linux', 07:00:20 INFO - 'TMOUT': '86400', 07:00:20 INFO - 'USER': 'cltbld', 07:00:20 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:20 INFO - '_': '/tools/buildbot/bin/python'} 07:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:20 INFO - Running setup.py (path:/tmp/pip-xBAQYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:20 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)) 07:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:20 INFO - Running setup.py (path:/tmp/pip-lEddUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:20 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)) 07:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:20 INFO - Running setup.py (path:/tmp/pip-CmJne2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:20 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)) 07:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:20 INFO - Running setup.py (path:/tmp/pip-ARhAEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:21 INFO - Running setup.py (path:/tmp/pip-zlEbYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:21 INFO - Running setup.py (path:/tmp/pip-YoEvnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:21 INFO - Running setup.py (path:/tmp/pip-jAOuEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:21 INFO - Running setup.py (path:/tmp/pip-w1a11b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:21 INFO - Running setup.py (path:/tmp/pip-50X1EI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:21 INFO - Running setup.py (path:/tmp/pip-MCSLHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:21 INFO - Running setup.py (path:/tmp/pip-bPTuVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:21 INFO - Running setup.py (path:/tmp/pip-KDUOHv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:21 INFO - Running setup.py (path:/tmp/pip-dY3UXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:21 INFO - Running setup.py (path:/tmp/pip-3vUzuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:21 INFO - Running setup.py (path:/tmp/pip-7O_Pbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:21 INFO - Running setup.py (path:/tmp/pip-5_nCtL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:21 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)) 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:21 INFO - Running setup.py (path:/tmp/pip-fLmyac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:23 INFO - Downloading blessings-1.5.1.tar.gz 07:00:23 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 07:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:23 INFO - Installing collected packages: blessings 07:00:23 INFO - Running setup.py install for blessings 07:00:23 INFO - Successfully installed blessings 07:00:23 INFO - Cleaning up... 07:00:23 INFO - Return code: 0 07:00:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:00:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:24 INFO - Reading from file tmpfile_stdout 07:00:24 INFO - Current package versions: 07:00:24 INFO - argparse == 1.2.1 07:00:24 INFO - blessings == 1.5.1 07:00:24 INFO - blobuploader == 1.2.4 07:00:24 INFO - docopt == 0.6.1 07:00:24 INFO - manifestparser == 1.1 07:00:24 INFO - mozInstall == 1.12 07:00:24 INFO - mozcrash == 0.16 07:00:24 INFO - mozdebug == 0.1 07:00:24 INFO - mozdevice == 0.47 07:00:24 INFO - mozfile == 1.2 07:00:24 INFO - mozhttpd == 0.7 07:00:24 INFO - mozinfo == 0.9 07:00:24 INFO - mozleak == 0.1 07:00:24 INFO - mozlog == 3.0 07:00:24 INFO - moznetwork == 0.27 07:00:24 INFO - mozprocess == 0.22 07:00:24 INFO - mozprofile == 0.27 07:00:24 INFO - mozrunner == 6.11 07:00:24 INFO - mozscreenshot == 0.1 07:00:24 INFO - mozsystemmonitor == 0.0 07:00:24 INFO - moztest == 0.7 07:00:24 INFO - mozversion == 1.4 07:00:24 INFO - psutil == 3.1.1 07:00:24 INFO - requests == 1.2.3 07:00:24 INFO - wsgiref == 0.1.2 07:00:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07: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')]} 07:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:24 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 0x7fec0a5dbc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', '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 07:00:24 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 07:00:24 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 07:00:24 INFO - Using env: {'DISPLAY': ':0', 07:00:24 INFO - 'HOME': '/home/cltbld', 07:00:24 INFO - 'LANG': 'en_US.UTF-8', 07:00:24 INFO - 'LANGUAGE': 'en_US:en', 07:00:24 INFO - 'LOGNAME': 'cltbld', 07:00:24 INFO - 'MAIL': '/var/mail/cltbld', 07:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:24 INFO - 'MOZ_NO_REMOTE': '1', 07:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:24 INFO - 'NO_EM_RESTART': '1', 07:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:24 INFO - 'SHELL': '/bin/bash', 07:00:24 INFO - 'SHLVL': '1', 07:00:24 INFO - 'TERM': 'linux', 07:00:24 INFO - 'TMOUT': '86400', 07:00:24 INFO - 'USER': 'cltbld', 07:00:24 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:24 INFO - '_': '/tools/buildbot/bin/python'} 07:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 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)) 07:00:24 INFO - Cleaning up... 07:00:24 INFO - Return code: 0 07:00:24 INFO - Running post-action listener: _resource_record_post_action 07:00:24 INFO - Running post-action listener: _start_resource_monitoring 07:00:24 INFO - Starting resource monitoring. 07:00:24 INFO - ##### 07:00:24 INFO - ##### Running install step. 07:00:24 INFO - ##### 07:00:24 INFO - Running pre-action listener: _resource_record_pre_action 07:00:24 INFO - Running main action method: install 07:00:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:24 INFO - Reading from file tmpfile_stdout 07:00:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:00:24 INFO - Reading from file tmpfile_stdout 07:00:24 INFO - Output received: 07:00:24 INFO - Usage: mozinstall [options] installer 07:00:24 INFO - Options: 07:00:24 INFO - -h, --help show this help message and exit 07:00:24 INFO - -d DEST, --destination=DEST 07:00:24 INFO - Directory to install application into. [default: 07:00:24 INFO - "/builds/slave/test-pgo"] 07:00:24 INFO - --app=APP Application being installed. [default: firefox] 07:00:24 INFO - mkdir: /builds/slave/test-pgo/build/application 07:00:24 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'] 07:00:24 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 07:00:39 INFO - Reading from file tmpfile_stdout 07:00:39 INFO - Output received: 07:00:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:00:39 INFO - Running post-action listener: _resource_record_post_action 07:00:39 INFO - ##### 07:00:39 INFO - ##### Running run-tests step. 07:00:39 INFO - ##### 07:00:39 INFO - Running pre-action listener: _resource_record_pre_action 07:00:39 INFO - Running main action method: run_tests 07:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:00:39 INFO - Python 2.7.3 07:00:39 INFO - Return code: 0 07:00:39 INFO - grabbing minidump binary from tooltool 07:00:39 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')]} 07:00:39 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 0x2ad38c0>, '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 0x2a80420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a808b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:00:39 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 07:00:39 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 07:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:39 INFO - Return code: 0 07:00:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:00:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:39 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/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:00:39 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/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 07:00:39 INFO - Using env: {'DISPLAY': ':0', 07:00:39 INFO - 'HOME': '/home/cltbld', 07:00:39 INFO - 'LANG': 'en_US.UTF-8', 07:00:39 INFO - 'LANGUAGE': 'en_US:en', 07:00:39 INFO - 'LOGNAME': 'cltbld', 07:00:39 INFO - 'MAIL': '/var/mail/cltbld', 07:00:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:39 INFO - 'MOZ_NO_REMOTE': '1', 07:00:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:39 INFO - 'NO_EM_RESTART': '1', 07:00:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:00:39 INFO - 'SHELL': '/bin/bash', 07:00:39 INFO - 'SHLVL': '1', 07:00:39 INFO - 'TERM': 'linux', 07:00:39 INFO - 'TMOUT': '86400', 07:00:39 INFO - 'USER': 'cltbld', 07:00:39 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043', 07:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:39 INFO - '_': '/tools/buildbot/bin/python'} 07:00:39 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/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 07:00:39 INFO - mozversion INFO | application_buildid: 20151116043001 07:00:39 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 07:00:39 INFO - mozversion INFO | application_display_name: Nightly 07:00:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:39 INFO - mozversion INFO | application_name: Firefox 07:00:39 INFO - mozversion INFO | application_remotingname: firefox 07:00:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:00:39 INFO - mozversion INFO | application_vendor: Mozilla 07:00:39 INFO - mozversion INFO | application_version: 45.0a1 07:00:39 INFO - mozversion INFO | platform_buildid: 20151116043001 07:00:39 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 07:00:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:00:39 INFO - mozversion INFO | platform_version: 45.0a1 07:00:39 INFO - 2015-11-16 07:00:39,414 DEBUG : using testdate: 1447686039 07:00:39 INFO - 2015-11-16 07:00:39,414 DEBUG : actual date: 1447686039 07:00:39 INFO - 2015-11-16 07:00:39,463 INFO : starting webserver on 'localhost:52786' 07:00:39 INFO - 2015-11-16 07:00:39,464 INFO : Starting test suite talos-linux64-ix-048.e 07:00:39 INFO - 2015-11-16 07:00:39,464 INFO : Starting test dromaeo_css 07:00:39 INFO - 2015-11-16 07:00:39,464 DEBUG : operating with platform_type : linux_ 07:00:39 INFO - 2015-11-16 07:00:39,464 INFO : Initialising browser for dromaeo_css test... 07:00:39 INFO - 2015-11-16 07:00:39,484 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjfx4jL/profile http://localhost:52786/getInfo.html 07:00:46 INFO - 2015-11-16 07:00:46,334 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:00:46 INFO - 2015-11-16 07:00:46,334 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:00:46 INFO - 2015-11-16 07:00:46,334 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:00:46 INFO - 2015-11-16 07:00:46,334 DEBUG : BROWSER_OUTPUT: __metrics 07:00:47 INFO - 2015-11-16 07:00:47,577 INFO : Browser initialized. 07:00:47 INFO - 2015-11-16 07:00:47,578 INFO : Running cycle 1/1 for dromaeo_css test... 07:00:47 INFO - 2015-11-16 07:00:47,578 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjfx4jL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:00:59 INFO - 2015-11-16 07:00:59,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 141414400 07:00:59 INFO - 2015-11-16 07:00:59,373 DEBUG : BROWSER_OUTPUT: 07:01:49 INFO - 2015-11-16 07:01:49,010 DEBUG : BROWSER_OUTPUT: 1447686109007 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] 07:03:57 INFO - 2015-11-16 07:03:57,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52786/tests/dromaeo/cssquery-ext.html) 07:03:58 INFO - 2015-11-16 07:03:58,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 146862080 07:03:58 INFO - 2015-11-16 07:03:58,913 DEBUG : BROWSER_OUTPUT: 07:07:00 INFO - 2015-11-16 07:07:00,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-ext.html (next: http://localhost:52786/tests/dromaeo/cssquery-jquery.html) 07:07:01 INFO - 2015-11-16 07:07:01,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 140439552 07:07:01 INFO - 2015-11-16 07:07:01,473 DEBUG : BROWSER_OUTPUT: 07:10:03 INFO - 2015-11-16 07:10:03,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52786/tests/dromaeo/cssquery-mootools.html) 07:10:03 INFO - 2015-11-16 07:10:03,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 142536704 07:10:03 INFO - 2015-11-16 07:10:03,717 DEBUG : BROWSER_OUTPUT: 07:13:05 INFO - 2015-11-16 07:13:05,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52786/tests/dromaeo/cssquery-prototype.html) 07:13:05 INFO - 2015-11-16 07:13:05,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 07:13:05 INFO - 2015-11-16 07:13:05,928 DEBUG : BROWSER_OUTPUT: 07:16:08 INFO - 2015-11-16 07:16:08,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52786/tests/dromaeo/cssquery-yui.html) 07:16:08 INFO - 2015-11-16 07:16:08,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 141361152 07:16:08 INFO - 2015-11-16 07:16:08,838 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/dromaeo/cssquery-yui.html (next: http://localhost:52786/tests/dromaeo/cssquery-dojo.html) 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 143360000 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:19:11 INFO - 2015-11-16 07:19:11,545 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3267.297531030829;3296.9670303296975;3316.6351701312838;3339.031680812563;3341.8162001089936;5259.342582177228;5385.757640906154;5405.4324295948945;5440.700761458118;5459.535939445147;5395.10980688186;5430.429804870481;5453.563714902808;5480.561555075595;5553.222548843165;5006.774695138709;5072.898542029157;5129.307543481638;5168.3539557555305;5218;5024.84925452237;5138.075146473633;5163.483651634844;5187.170052791555;5259.947400526004;4965.975170124127;5007.123753343187;5073.873153171164;5074.06129865976;5160.432352441228;5017.2724954881705;5019.272205530214;5023.598112151056;5033.949660503385;5073.188289873602;5024.874378140539;5048.7980480780725;5063.569596584295;5082.440931497532;5091.1854103343285;5177.767000484987;5246.685198888079;5284.682919024871;5303.734813259361;5314.096603577401;6067.878642427171;6090.33006369299;6092.08618707193;6093.238345206849;6105.603135796159;6035.698215089272;6078.209832721762;6100.633961962297;6106.48094911933;6118.174046503709;5331.226972089025;5451.209574611698;5474.42518535552;5588.44115588446;5678.801241956512;6062.969685151546;6150.969245153746;6196;6213.937860621336;6216.44052035319;6008.24896887889;6012.278526576752;6012.488938440281;6012.6392416455155;6041.969790151021;5807.593468457252;5848.5321174305955;5943.375945525744;6024.608400453956;6078.665673387918;5873.236479257755;6023.3073196582955;6047.667378294236;6051.122587224916;6056.031035034373;5760.0783874579865;5987.43119403656;6002;6011.218541589566;6014.969925150346;4512.842050528216;4543.45478542577;4593.793279302373;4604.30935359692;4640.605548528345;4058.1680755445063;4066.837326506966;4085.5097388313593;4099.364598487239;4105.835766569364;5386.353637563439;5523.530499907552;5632.3804381518;5675.460831221028;5680.346760122557;5835.533157347402;5875.853103672443;5889.528837692974;5945.40545945402;6102.237220347457;5623.634463759842;5676.460736230051;5677.205191273225;5687.175359572839;5689.487946084872;5159.613029022838;5179.119549676564;5191.6625419348375;5215.400228973641;5221.817236396708;5913.349531551526;6059.151718759377;6105.755769769159;6179.134921111048;6179.196704428396;5980.252468441445;6047.818565443044;6067.029275315928;6069.36271691466;6075.088736689532;5968.4031596841705;6206.131141640264;6242.938700420848;6264.436200741955;6271.905921411091;5788.160716696139;5836.182934389274;5901.852453688693;5907.852303692442;5958.791442299499;5948.5538584605465;5951.404859514014;5958.433948774859;5966.403359664172;5983.37174596661;5579.386267510652;5712.742926568398;5826.796062137805;5828.446297601721;5838.94161058384;5793.362730099601;5850.210221620197;5863.73613187399;5868.794592189253;5941.732622032106;5797.333306669787;5798;5825.155352473952;5826.70866456684;5841.707914604338;5723.227364305932;5753.453421924911;5867.442592953663;5910.349861515316;5938.851528711644;5782.884342313214;5794.333651630117;5813.447722466359;5818.883622327445;5825.475707186373 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.7812479731787;590.0235110891475;596.8776400837829;608.6287364707528;610.0300522169749;37311;37879.81060094703;37970.620293797125;37981.810090949504;38096.23807523848;42440.36339454911;42917.14165716692;43017.56982430175;43169.136617267635;43291.35062974058;8710.477371357707;8848.734537963872;8872.15714507124;8877.378583499158;8888.111188881092;8665.610047547843;8699.347548933856;8742.825143497126;8752.431091979033;8789.912100878973;8650.783730406758;8759.430637008605;8777;8785.868211976825;8786.341024423162;8656.394052416303;8757;8769.07924667907;8771.517566533837;8781.1218878112;8616.26761725254;8694.478331300143;8738.30093592511;8755.78110547235;8768;39216.41175382372;39617.80191099026;39643.80178099091;39682.20635587301;39776.60223397758;3297.4394352959816;3316.3533111043357;3351.731861451078;3429.5198672185666;3803.2583646189005;29376;29753.25616859596;30144.698553014627;30273.69726302731;30441.847790760905;3389.8474568644224;3402.2004828865197;3413.0955296846355;3503.316853213624;3578.7494875358734;272836;273929;274967;275017;275161;54329.72835135799;55598.72200638971;55823.16265256024;55995.16007259894;57663.711681441324;54572.18141727877;54610.45389546054;54915.45084549183;54936.45063549393;55093.173602396;13945.372458239404;14102.365393557315;14120.929395353163;14123;14147;11002.614908478165;11032.338059716443;11055.447227638586;11066.336019838835;11091.057260132819;18733.718994215098;19191.424257272305;19203.807961920204;19229.615407691766;19258.325958591664;7694.230576942261;7876.4092693047105;7896.249856263646;7906.327962123169;8068.628333183256;902.4540153207346;982.2191357870367;1018.3431686562126;1078.7195329214303;1089.6676513663251;27988.16035518938;28053.66109570586;28490.572641410396;28566.571501427494;28725;1017.4200705597887;1053.3416614615865;1128.3963079752293;1128.9557159627475;1130.3669944830922;13094.803577946339;13324.933375333061;13460.663483412796;13478.123921945238;13515.662108447172;322377;326604;327801;328719;329029;51102.744486278076;51165.232521512204;51370.74314628403;51401.228981565306;51441.485585143666;1348.0630961481677;1360.0479664235074;1362.2984163155982;1378.4417310989065;1385.2935003148266;26098.478030438906;26833;27202.183934481996;27427.862860685567;27884.860575696992;45201.54798451973;45473.772631136635;45518.58610604284;45730.771346144385;45736;219970;220433;221054;221446;221722;31353;33935.3212935735;34006.80976165822;34394.484082739276;34667.306653866275;42015;42917.356239655805;43481.78259108811;43699.12601748011;44049;35337.293254135286;35972.82013589915;36019.81990090033;36746.63253367432;36751.448728269635;36696.41657167654;36894;36904.81547592245;37002.44496332503;37341;35294;35344.82327588346;35501.644983549835;35856;35859.82070089633;31343.84328078345;32879;33309.333813323115;33360.666393335756;33551;25450.490990179722;26184.155931152036;26372.472550549264;26456.470870582096;26567 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.8976651887693;347.9495473156392;349.4688074127325;349.50544978854924;351.89091381671676;12492.875071249286;12985.480580776757;16742.49772506824;17047.74428383574;17830.554236144086;11394.886051139487;11406.372649504294;11436.428178591057;11438.542458301657;11737.178397512156;4305.311150215966;4417.337399390101;4444.288913773797;4444.911101777962;4455.777211139446;4348.391225228471;4540.863774086766;4549.613282870943;4578.885527861797;4598.264277715566;4587.220172570671;4597.333386658949;4606.631469482433;4685.461171965217;4698.882527936795;4521.796519156645;4636.072785442908;4643.4892161862;4648.1168577970075;4651.62786977041;4243.490781106287;4250.808713607895;4258.041940563348;4260;4268.381084742726;13131.540396086186;13171.868281317256;13440.059195856295;13473.461061557526;13494.460221591125;2001.4696105532046;2033.4001469566513;2041.9591608167902;2064.834813214954;2085.343116918166;9920.454375009444;10022.047905448972;10051.396916185053;10213.948930255376;10283.640072597498;1694.5509439998411;1698.1169791708242;1722.922468488921;1743.5205318537378;1759.1995641982867;59449;60818.087728684106;60906;61390.69304653493;62448;6857.55425897315;6878.518503704692;6959.547629404174;6992.3357281058215;7039.54242974205;8390;8412.663493460193;8470.576471176417;8488.236058754741;8495.74512764618;5570.053090974544;5574.358948720868;5589.273394458694;5623.803166889139;5657.4059723728415;5711.257536520309;5732.656040637492;5738.512226460714;5749.971250143806;5752.33848107473;3169.904902852918;3171.4925611901986;3217.8551965161623;3220.4847224443974;3244.286257023451;1120.4845770945456;1123.752774389633;1124.3197865291381;1128.2722643894806;1171.8066519024435;461.0847467776461;463.6985959126527;467.51145053418577;477.87814107403085;487.6026038778384;11555.942220288845;11960.521579136737;12240.44917978693;12246.755064898653;12295.4467048983;509.8495943696618;516.553181498009;520.6277511579239;523.1577160771155;530.0485628297216;6529.542931994714;6598.571092878948;6723.260441351447;6748.29142939994;6803.217629972518;533068;538836;542529.8735063231;543034;547498;77066;77177;77637.61181194057;80623;82438.17561824305;549.0391814324931;554.4510934175138;555.1118210862668;555.8082461550758;557.3590371073217;10634.840477393;11176.105911526896;11208.383538905438;11295.096392288433;11363.090952723927;31916;32275.35449290954;32680.50979235361;33312.50031249485;33573.992780216635;40954;41804.58195418007;42055.36916946187;46401.53598463972;47394.28908566443;6583.868322633616;6867.622280774405;6945.965270173617;6998.230194678683;7012.719491220498;11986.160968732105;12056.51773929033;12353.32056736888;12431.129820912449;12494;9965.701028968853;10380.740481488023;10680.092192163442;10720.571177152826;11022.779544408906;10383.2212584055;10818.891811082103;10820.513076911715;10882.673519794418;10886.346819190874;10744.785104298027;10836.566537338733;11192.1605879561;11193.72015699614;11209.327440353605;6913.688884000131;6920.792376228721;6990.335918087773;7003.5797852129035;7008.894866576903;10128.493575321058;10728.781365590448;10804.40575768309;10964.396958167377;11026.614068507564 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.4191844221525;1705.2411676803824;1771.3800169940523;1774.5297496163519;1778.9681984449016;6267.529935254851;6317.74729010839;7066.611336376497;7505.849883002336;7522.473426860122;7159.570425774457;7317.1219453665635;7412.18465968743;7428.554286742799;7454.366378857803;2177.6080305544997;2215.8670479771185;2226.1318085946496;2226.588081204974;2228.242397584821;2234.709487766588;2249.80876625487;2272.6363781794835;2278.031836469502;2279.0428020231543;2203.0526873444414;2216.0581752755097;2231.553689262146;2232.620454522727;2255.639097744361;2174.739031316244;2187.5187458759046;2218.4786575154826;2218.955620887581;2221.48905751678;2222.75549689534;2261.8869056547105;2266.9886650566805;2268.739095004079;2270.545890821842;7255.05684261048;7369.4472914531625;7376.114866216089;7383.040204773399;7386.482946193769;4440.866773996785;4479.328100784908;4488.708233964782;4515.571020753023;4540.841070562515;2897.3046468847538;2969.331900322432;2970.5841182234503;2979.6722360540325;2987.223321936312;1000.8148492528833;1008.2186305613135;1014.467404612577;1040.4017689828304;1043.3896170740127;9960.651377201762;9981.90018099817;9998.350107243079;10009.399436033862;10024.398536087785;4033.092554175346;4048.6153815387493;4058.1072164123843;4075.633193012643;4095.5904409558807;8659.090795466385;8690.130986901258;8695.782605434915;8696.391252612382;8698.826023479494;4577.771111444415;4578.771061446914;4580.0152967112235;4589.036302376471;4620.075984803053;4038.818253178614;4120.134771697977;4133.04939863833;4203.306454435045;4240.85157019509;3418.162550175223;3429.0741499794917;3463.0649724574223;3463.6709512596262;3478.8782392616135;1040.5213601743133;1042.202201202934;1053.1732589916878;1058.2962330050584;1058.9258751887448;1292.3667402972665;1298.5130576033987;1327.6548097494722;1344.099453366247;1368.6646771541036;6989.860202795916;7039.401650859631;7120;7215.891761623579;7215.891761623579;426.74608607878264;432.4961419945791;434.9195398851159;436.41084535876945;457.8969731810316;5667.348254950651;5704;5755;5765.221695071195;5785.479306862402;8909.599068041955;8965.148310910454;9302.813943721088;9333.626654933862;9383;9045.095490451034;9088.909110908939;9128.771780705403;9170.67902623405;9219.76950576241;6964.26875178099;6989;6989.650517474208;7029.718811247595;7048.506604537633;6739;6818.829529261808;6836.897446538206;6840.9657951711915;6852.074969879002;7900;8125.71559995421;8143.389245806469;8253.587320633824;8256.876146857681;8150.551719655476;8311.625976831177;8321.83356332882;8342.666293348198;8344.123866993878;6408.327125651739;6492.123563319081;6565.409113179646;6916.308369163044;6919.100516932766;7285.125784905846;7306.634668266672;7325.340719335285;7338.70645174187;7341.559506429631;6785;6850.862982740217;6917.481188910952;6963.303669632996;7002.474814389043;6722.05891175226;6733.091032710521;6801.421879140328;6814.557053791487;6845.589264643938;6691.866162676816;6741.1910570731825;6773.729050837911;6801.353871382211;6930.168379794457;6292.402221788922;6340.858645443865;6346.587471814318;6347.365263473615;6355.269144048493;6335.873282534416;6354.52341074412;6362.745490180341;6395.232572091379;6402.6158430494315 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.331553870332;310.5698607428712;310.77779387737763;312.6935603108952;312.79355625287315;6194.101855230989;6296.212973378328;6344.397282258184;6392.137061496696;6490.643014634194;6295.811125666238;6325.557210995232;6346.873062538758;6354.968225158879;6356.9046464302955;4539.863804085882;4659.930101048487;4688.835890743816;4740.90518189636;4755.2153894607345;4653.557911998355;4683.437987441494;4687.484376718558;4708.034852855174;4710.835120770774;4593.081383723269;4628.606568441686;4630.583247507724;4636.304554316863;4639.8376056838015;4642;4646.233371493699;4647.163510568096;4656.976715116402;4660.091282199938;3907.7459965102175;3962.306596345657;3962.6829853611644;3966.8214930328204;3969.6625786808154;5886.117082437626;5983.341832398432;5998.310194327664;6004.369541198155;6015.488683461911;5418.133098704188;5425.9728701356635;5431.51116399522;5438.428964958702;5449.155380915964;6687.364700353459;6707.228668703113;6726.192856857159;6728.428083612899;6730.32696730323;4336.176126535979;4362.650987920959;4394.231009573344;4394.60448559628;4397.890052748675;6926.619035953021;7000.894986575206;7002.649867506655;7033.6483175841;7036.296370362974;4490;4494.797734101973;4502.054568540643;4514.548545145459;4522.163399771053;4478.865634030984;4546.704464209815;4548.340490628841;4552.089582083597;4566.3150527420485;5342.679439233659;5387.272718183073;5390.380106287748;5394.8381548552825;5405.4324295949145;6763.458923286224;6767.864642707118;6775.254721980578;6775.898361524581;6793.45652347811;1585.0964949978402;1598.009234274757;1599.5601209667202;1600.1759094066565;1603.9839601603835;1040.3341861208833;1045.440689231273;1049.8740151181755;1061.2040969273046;1062.9627963021258;6490.643014634241;6499.057636642755;6503.967480162663;6507.9023814642815;6517.543771936013;6935.098437203132;6986.231514533397;6994.230634630187;6995.160580730345;6999.12510936133;6313.77901773445;6462.612243265419;6467.547271691031;6496.22045354551;6499.155109835691;3799.259144466858;3809.5619003814363;3845.8461661533784;3858.054776579756;3858.8070596470066;7191.316824901626;7346.449016323797;7347.08161479815;7347.963260183772;7386.963065184747;7264.891026634605;7275.527090739085;7276.7089316426745;7279.927200728031;7306;7149.285071492809;7368.336849683555;7370.815729606696;7371.520851144658;7390.187079421259;7053.823654408681;7057.788266352018;7061.71753129869;7087.291270872872;7096.858062838611;6918.342757438036;6957.408620267334;6999.440044796303;7018.087648605649;7018.947157926352;7212.74755383559;7333.853322933618;7364.631768411665;7385.335319821242;7400.111986561647;4499.91000179988;4546.340780586863;4546.568076032771;4557.270836666117;4558.247889098262;6993.4055605274125;7000.264972177848;7001.8249543759775;7013.859722805413;7015.8952314306525;6633.767818126343;6793.286704895915;6815.33024409023;6833.863322733617;6849.383555480031;6776.559523630948;6804;6805.081314022544;6818.829529261808;6828.248892621907;6677.799666010027;6694.29709880475;6696.363845434871;6697.09589205451;6698.497612678971;6539.738410463528;6751.898721519279;6779.762708305186;6853.9314606853295;6865.759698410531;6618.602883826986;6629.270780214076;6654.500912431684;6667.99980002984;6683.131192944886 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: |5;yui.html;766.9156392796788;793.8769490728937;831.5343407691693;835.5195762436597;853.0403296291672;13907.026508144421;14016;14106.083104598207;14130.505432309872;14133.222672752994;11915;12054.276743395381;12101.878981210186;12109.515619375214;12127.393630318471;802.1817745899194;816.9101398846152;817.3665409307804;819.5328662662284;823;808.1151139502265;812.3744716568239;815.1074573342181;816.3713940265992;816.6733306677318;839.3704721458906;848.0417128644623;849.7195925344653;850.7022542110274;855.7432770168956;843.7679638099511;844.6072576252042;845.0408786027841;845.0788640381952;847.4152834544145;615.7660089166133;616.5714828194407;617.3486971245335;618.9972244963144;619.2383368456823;13594.38825252866;13687.589372318846;13698.726025479435;13788.724225515534;13844.10013349139;10252.487375631263;10554.155667546578;10710.357378557312;10722.731931701692;10758.623448179354;10156.339837910586;10240.436775977318;10303.896961030368;10417.895821041768;10439.739006524822;3109.518024706174;3150.6376766671897;3219.919502012445;3258.934821303584;3264.265540253448;46116.53883461156;47279.527204727856;47383.76308118437;47433;47481.5251847484;7331.376832969151;7352.889706654404;7380.446466515033;7386.926130738731;7518.699252029857;12248.693782655504;12300.692482688004;12305.32320722351;12338.753224935452;12376.257424554555;6791.93208067913;6818.931810681929;6833.794986150423;6940.826479338057;7104.644767761694;4330.956690433055;4332.025294308818;4466.196084704719;4501.077279157765;4714.104320179155;2752.3669556002233;2763.1710486853863;2784.220418282884;2790.41401305724;2793.594928735322;424.8682908298437;433.3478115436248;437.47502996404444;446.7877758064893;450.25707582489156;507.73090262161116;517.362547537041;592.4726992976255;655.7245956698198;705.2559549675142;8153.184681531918;8728.170823771732;8801.339899507562;9524.714258572254;9891.653792117242;582.408855012163;605.0621536618224;648.7632014314836;663.6084710021111;672.1329484964439;4062.614051665087;4199.748015119103;4244.3209086546;4257.531671516131;4349.717268377545;60262.698686506286;60991.695041525396;61314;61818;61831;53967.46032539703;55186.448135518134;55332;55419;56329;50316.74841625769;50888.23667644988;50893.74553127211;50895;51324.48675513197;8391.496510209407;8472.44929079608;8724.69463568772;8899.377043607145;8926.419782714103;33648;34150.82924585361;34541.30917381689;36090.4586431209;38352.04119897025;46736.53263467322;46921;47700;48539;48609.756951216434;7766.262205090507;8016.957795486783;8073.475224110414;8276.379271554537;8327.292180164754;12072;12363.32001739913;12579.559715409916;12708.428120734774;12778.552750653682;11298.887011129784;11419.486123124314;11765.352905590275;12128.9690376319;12150.939245303716;11450.541978320774;11664.825027624762;11905.46425410876;12473.5010599575;12480.687982800502;9717.17404020666;10741;10981;11723.824142637697;12112.394380281126;9349.953250233977;9403.34176607631;9407.341486096182;9533.904660953302;9763.218942484726;8750.47497150173;8891.777705557413;9249.352545322032;9277.257819374568;9618.326717129734 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,273 07:19:11 INFO - 2015-11-16 07:19:11,546 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687151538__endTimestamp 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5542.92 Median:5793.36 stddev:630.37 (10.9%) stddev-sans-first:606.50 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: Values: 3267.3 3297.0 3316.6 3339.0 3341.8 5259.3 5385.8 5405.4 5440.7 5459.5 5395.1 5430.4 5453.6 5480.6 5553.2 5006.8 5072.9 5129.3 5168.4 5218.0 5024.8 5138.1 5163.5 5187.2 5259.9 4966.0 5007.1 5073.9 5074.1 5160.4 5017.3 5019.3 5023.6 5033.9 5073.2 5024.9 5048.8 5063.6 5082.4 5091.2 5177.8 5246.7 5284.7 5303.7 5314.1 6067.9 6090.3 6092.1 6093.2 6105.6 6035.7 6078.2 6100.6 6106.5 6118.2 5331.2 5451.2 5474.4 5588.4 5678.8 6063.0 6151.0 6196.0 6213.9 6216.4 6008.2 6012.3 6012.5 6012.6 6042.0 5807.6 5848.5 5943.4 6024.6 6078.7 5873.2 6023.3 6047.7 6051.1 6056.0 5760.1 5987.4 6002.0 6011.2 6015.0 4512.8 4543.5 4593.8 4604.3 4640.6 4058.2 4066.8 4085.5 4099.4 4105.8 5386.4 5523.5 5632.4 5675.5 5680.3 5835.5 5875.9 5889.5 5945.4 6102.2 5623.6 5676.5 5677.2 5687.2 5689.5 5159.6 5179.1 5191.7 5215.4 5221.8 5913.3 6059.2 6105.8 6179.1 6179.2 5980.3 6047.8 6067.0 6069.4 6075.1 5968.4 6206.1 6242.9 6264.4 6271.9 5788.2 5836.2 5901.9 5907.9 5958.8 5948.6 5951.4 5958.4 5966.4 5983.4 5579.4 5712.7 5826.8 5828.4 5838.9 5793.4 5850.2 5863.7 5868.8 5941.7 5797.3 5798.0 5825.2 5826.7 5841.7 5723.2 5753.5 5867.4 5910.3 5938.9 5782.9 5794.3 5813.4 5818.9 5825.5 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,547 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44460.45 Median:19717.37 stddev:72462.32 (367.5%) stddev-sans-first:72590.61 07:19:11 INFO - 2015-11-16 07:19:11,549 DEBUG : BROWSER_OUTPUT: Values: 557.8 590.0 596.9 608.6 610.0 37311.0 37879.8 37970.6 37981.8 38096.2 42440.4 42917.1 43017.6 43169.1 43291.4 8710.5 8848.7 8872.2 8877.4 8888.1 8665.6 8699.3 8742.8 8752.4 8789.9 8650.8 8759.4 8777.0 8785.9 8786.3 8656.4 8757.0 8769.1 8771.5 8781.1 8616.3 8694.5 8738.3 8755.8 8768.0 39216.4 39617.8 39643.8 39682.2 39776.6 3297.4 3316.4 3351.7 3429.5 3803.3 29376.0 29753.3 30144.7 30273.7 30441.8 3389.8 3402.2 3413.1 3503.3 3578.7 272836.0 273929.0 274967.0 275017.0 275161.0 54329.7 55598.7 55823.2 55995.2 57663.7 54572.2 54610.5 54915.5 54936.5 55093.2 13945.4 14102.4 14120.9 14123.0 14147.0 11002.6 11032.3 11055.4 11066.3 11091.1 18733.7 19191.4 19203.8 19229.6 19258.3 7694.2 7876.4 7896.2 7906.3 8068.6 902.5 982.2 1018.3 1078.7 1089.7 27988.2 28053.7 28490.6 28566.6 28725.0 1017.4 1053.3 1128.4 1129.0 1130.4 13094.8 13324.9 13460.7 13478.1 13515.7 322377.0 326604.0 327801.0 328719.0 329029.0 51102.7 51165.2 51370.7 51401.2 51441.5 1348.1 1360.0 1362.3 1378.4 1385.3 26098.5 26833.0 27202.2 27427.9 27884.9 45201.5 45473.8 45518.6 45730.8 45736.0 219970.0 220433.0 221054.0 221446.0 221722.0 31353.0 33935.3 34006.8 34394.5 34667.3 42015.0 42917.4 43481.8 43699.1 44049.0 35337.3 35972.8 36019.8 36746.6 36751.4 36696.4 36894.0 36904.8 37002.4 37341.0 35294.0 35344.8 35501.6 35856.0 35859.8 31343.8 32879.0 33309.3 33360.7 33551.0 25450.5 26184.2 26372.5 26456.5 26567.0 07:19:11 INFO - 2015-11-16 07:19:11,549 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,549 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26834.88 Median:4286.85 stddev:88708.09 (2069.3%) stddev-sans-first:88934.64 07:19:11 INFO - 2015-11-16 07:19:11,549 DEBUG : BROWSER_OUTPUT: Values: 346.9 347.9 349.5 349.5 351.9 12492.9 12985.5 16742.5 17047.7 17830.6 11394.9 11406.4 11436.4 11438.5 11737.2 4305.3 4417.3 4444.3 4444.9 4455.8 4348.4 4540.9 4549.6 4578.9 4598.3 4587.2 4597.3 4606.6 4685.5 4698.9 4521.8 4636.1 4643.5 4648.1 4651.6 4243.5 4250.8 4258.0 4260.0 4268.4 13131.5 13171.9 13440.1 13473.5 13494.5 2001.5 2033.4 2042.0 2064.8 2085.3 9920.5 10022.0 10051.4 10213.9 10283.6 1694.6 1698.1 1722.9 1743.5 1759.2 59449.0 60818.1 60906.0 61390.7 62448.0 6857.6 6878.5 6959.5 6992.3 7039.5 8390.0 8412.7 8470.6 8488.2 8495.7 5570.1 5574.4 5589.3 5623.8 5657.4 5711.3 5732.7 5738.5 5750.0 5752.3 3169.9 3171.5 3217.9 3220.5 3244.3 1120.5 1123.8 1124.3 1128.3 1171.8 461.1 463.7 467.5 477.9 487.6 11555.9 11960.5 12240.4 12246.8 12295.4 509.8 516.6 520.6 523.2 530.0 6529.5 6598.6 6723.3 6748.3 6803.2 533068.0 538836.0 542529.9 543034.0 547498.0 77066.0 77177.0 77637.6 80623.0 82438.2 549.0 554.5 555.1 555.8 557.4 10634.8 11176.1 11208.4 11295.1 11363.1 31916.0 32275.4 32680.5 33312.5 33574.0 40954.0 41804.6 42055.4 46401.5 47394.3 6583.9 6867.6 6946.0 6998.2 7012.7 11986.2 12056.5 12353.3 12431.1 12494.0 9965.7 10380.7 10680.1 10720.6 11022.8 10383.2 10818.9 10820.5 10882.7 10886.3 10744.8 10836.6 11192.2 11193.7 11209.3 6913.7 6920.8 6990.3 7003.6 7008.9 10128.5 10728.8 10804.4 10964.4 11026.6 07:19:11 INFO - 2015-11-16 07:19:11,549 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,550 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5258.58 Median:6338.37 stddev:2717.10 (42.9%) stddev-sans-first:2709.80 07:19:11 INFO - 2015-11-16 07:19:11,550 DEBUG : BROWSER_OUTPUT: Values: 1470.4 1705.2 1771.4 1774.5 1779.0 6267.5 6317.7 7066.6 7505.8 7522.5 7159.6 7317.1 7412.2 7428.6 7454.4 2177.6 2215.9 2226.1 2226.6 2228.2 2234.7 2249.8 2272.6 2278.0 2279.0 2203.1 2216.1 2231.6 2232.6 2255.6 2174.7 2187.5 2218.5 2219.0 2221.5 2222.8 2261.9 2267.0 2268.7 2270.5 7255.1 7369.4 7376.1 7383.0 7386.5 4440.9 4479.3 4488.7 4515.6 4540.8 2897.3 2969.3 2970.6 2979.7 2987.2 1000.8 1008.2 1014.5 1040.4 1043.4 9960.7 9981.9 9998.4 10009.4 10024.4 4033.1 4048.6 4058.1 4075.6 4095.6 8659.1 8690.1 8695.8 8696.4 8698.8 4577.8 4578.8 4580.0 4589.0 4620.1 4038.8 4120.1 4133.0 4203.3 4240.9 3418.2 3429.1 3463.1 3463.7 3478.9 1040.5 1042.2 1053.2 1058.3 1058.9 1292.4 1298.5 1327.7 1344.1 1368.7 6989.9 7039.4 7120.0 7215.9 7215.9 426.7 432.5 434.9 436.4 457.9 5667.3 5704.0 5755.0 5765.2 5785.5 8909.6 8965.1 9302.8 9333.6 9383.0 9045.1 9088.9 9128.8 9170.7 9219.8 6964.3 6989.0 6989.7 7029.7 7048.5 6739.0 6818.8 6836.9 6841.0 6852.1 7900.0 8125.7 8143.4 8253.6 8256.9 8150.6 8311.6 8321.8 8342.7 8344.1 6408.3 6492.1 6565.4 6916.3 6919.1 7285.1 7306.6 7325.3 7338.7 7341.6 6785.0 6850.9 6917.5 6963.3 7002.5 6722.1 6733.1 6801.4 6814.6 6845.6 6691.9 6741.2 6773.7 6801.4 6930.2 6292.4 6340.9 6346.6 6347.4 6355.3 6335.9 6354.5 6362.7 6395.2 6402.6 07:19:11 INFO - 2015-11-16 07:19:11,551 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,551 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5591.03 Median:6465.08 stddev:1774.75 (27.5%) stddev-sans-first:1734.85 07:19:11 INFO - 2015-11-16 07:19:11,551 DEBUG : BROWSER_OUTPUT: Values: 307.3 310.6 310.8 312.7 312.8 6194.1 6296.2 6344.4 6392.1 6490.6 6295.8 6325.6 6346.9 6355.0 6356.9 4539.9 4659.9 4688.8 4740.9 4755.2 4653.6 4683.4 4687.5 4708.0 4710.8 4593.1 4628.6 4630.6 4636.3 4639.8 4642.0 4646.2 4647.2 4657.0 4660.1 3907.7 3962.3 3962.7 3966.8 3969.7 5886.1 5983.3 5998.3 6004.4 6015.5 5418.1 5426.0 5431.5 5438.4 5449.2 6687.4 6707.2 6726.2 6728.4 6730.3 4336.2 4362.7 4394.2 4394.6 4397.9 6926.6 7000.9 7002.6 7033.6 7036.3 4490.0 4494.8 4502.1 4514.5 4522.2 4478.9 4546.7 4548.3 4552.1 4566.3 5342.7 5387.3 5390.4 5394.8 5405.4 6763.5 6767.9 6775.3 6775.9 6793.5 1585.1 1598.0 1599.6 1600.2 1604.0 1040.3 1045.4 1049.9 1061.2 1063.0 6490.6 6499.1 6504.0 6507.9 6517.5 6935.1 6986.2 6994.2 6995.2 6999.1 6313.8 6462.6 6467.5 6496.2 6499.2 3799.3 3809.6 3845.8 3858.1 3858.8 7191.3 7346.4 7347.1 7348.0 7387.0 7264.9 7275.5 7276.7 7279.9 7306.0 7149.3 7368.3 7370.8 7371.5 7390.2 7053.8 7057.8 7061.7 7087.3 7096.9 6918.3 6957.4 6999.4 7018.1 7018.9 7212.7 7333.9 7364.6 7385.3 7400.1 4499.9 4546.3 4546.6 4557.3 4558.2 6993.4 7000.3 7001.8 7013.9 7015.9 6633.8 6793.3 6815.3 6833.9 6849.4 6776.6 6804.0 6805.1 6818.8 6828.2 6677.8 6694.3 6696.4 6697.1 6698.5 6539.7 6751.9 6779.8 6853.9 6865.8 6618.6 6629.3 6654.5 6668.0 6683.1 07:19:11 INFO - 2015-11-16 07:19:11,551 DEBUG : BROWSER_OUTPUT: 07:19:11 INFO - 2015-11-16 07:19:11,551 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13826.46 Median:25697.98 stddev:16948.20 (66.0%) stddev-sans-first:16967.37 07:19:11 INFO - 2015-11-16 07:19:11,552 DEBUG : BROWSER_OUTPUT: Values: 766.9 793.9 831.5 835.5 853.0 13907.0 14016.0 14106.1 14130.5 14133.2 11915.0 12054.3 12101.9 12109.5 12127.4 802.2 816.9 817.4 819.5 823.0 808.1 812.4 815.1 816.4 816.7 839.4 848.0 849.7 850.7 855.7 843.8 844.6 845.0 845.1 847.4 615.8 616.6 617.3 619.0 619.2 13594.4 13687.6 13698.7 13788.7 13844.1 10252.5 10554.2 10710.4 10722.7 10758.6 10156.3 10240.4 10303.9 10417.9 10439.7 3109.5 3150.6 3219.9 3258.9 3264.3 46116.5 47279.5 47383.8 47433.0 47481.5 7331.4 7352.9 7380.4 7386.9 7518.7 12248.7 12300.7 12305.3 12338.8 12376.3 6791.9 6818.9 6833.8 6940.8 7104.6 4331.0 4332.0 4466.2 4501.1 4714.1 2752.4 2763.2 2784.2 2790.4 2793.6 424.9 433.3 437.5 446.8 450.3 507.7 517.4 592.5 655.7 705.3 8153.2 8728.2 8801.3 9524.7 9891.7 582.4 605.1 648.8 663.6 672.1 4062.6 4199.7 4244.3 4257.5 4349.7 60262.7 60991.7 61314.0 61818.0 61831.0 53967.5 55186.4 55332.0 55419.0 56329.0 50316.7 50888.2 50893.7 50895.0 51324.5 8391.5 8472.4 8724.7 8899.4 8926.4 33648.0 34150.8 34541.3 36090.5 38352.0 46736.5 46921.0 47700.0 48539.0 48609.8 7766.3 8017.0 8073.5 8276.4 8327.3 12072.0 12363.3 12579.6 12708.4 12778.6 11298.9 11419.5 11765.4 12129.0 12150.9 11450.5 11664.8 11905.5 12473.5 12480.7 9717.2 10741.0 10981.0 11723.8 12112.4 9350.0 9403.3 9407.3 9533.9 9763.2 8750.5 8891.8 9249.4 9277.3 9618.3 07:19:11 INFO - 2015-11-16 07:19:11,552 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:19:11 INFO - 2015-11-16 07:19:11,552 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2015-11-16 07:19:12,185 INFO : Browser exited with error code: 0 07:19:12 INFO - 2015-11-16 07:19:12,206 INFO : Completed test dromaeo_css (00:18:32) 07:19:12 INFO - 2015-11-16 07:19:12,206 INFO : Starting test kraken 07:19:12 INFO - 2015-11-16 07:19:12,206 DEBUG : operating with platform_type : linux_ 07:19:12 INFO - 2015-11-16 07:19:12,207 INFO : Initialising browser for kraken test... 07:19:12 INFO - 2015-11-16 07:19:12,212 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm4r1pP/profile http://localhost:52786/getInfo.html 07:19:16 INFO - 2015-11-16 07:19:16,208 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:19:16 INFO - 2015-11-16 07:19:16,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:19:16 INFO - 2015-11-16 07:19:16,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:19:16 INFO - 2015-11-16 07:19:16,209 DEBUG : BROWSER_OUTPUT: __metrics 07:19:17 INFO - 2015-11-16 07:19:17,245 INFO : Browser initialized. 07:19:17 INFO - 2015-11-16 07:19:17,246 INFO : Running cycle 1/1 for kraken test... 07:19:17 INFO - 2015-11-16 07:19:17,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm4r1pP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:19:29 INFO - 2015-11-16 07:19:29,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 07:19:29 INFO - 2015-11-16 07:19:29,057 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-16 07:19:31,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52786/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:32 INFO - 2015-11-16 07:19:32,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 07:19:32 INFO - 2015-11-16 07:19:32,201 DEBUG : BROWSER_OUTPUT: 07:19:34 INFO - 2015-11-16 07:19:34,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52786/tests/kraken/driver.html?testName=audio-dft) 07:19:35 INFO - 2015-11-16 07:19:35,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 07:19:35 INFO - 2015-11-16 07:19:35,415 DEBUG : BROWSER_OUTPUT: 07:19:38 INFO - 2015-11-16 07:19:38,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52786/tests/kraken/driver.html?testName=audio-fft) 07:19:38 INFO - 2015-11-16 07:19:38,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 136998912 07:19:38 INFO - 2015-11-16 07:19:38,857 DEBUG : BROWSER_OUTPUT: 07:19:40 INFO - 2015-11-16 07:19:40,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52786/tests/kraken/driver.html?testName=audio-oscillator) 07:19:41 INFO - 2015-11-16 07:19:41,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 137424896 07:19:41 INFO - 2015-11-16 07:19:41,469 DEBUG : BROWSER_OUTPUT: 07:19:43 INFO - 2015-11-16 07:19:43,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:44 INFO - 2015-11-16 07:19:44,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 136617984 07:19:44 INFO - 2015-11-16 07:19:44,216 DEBUG : BROWSER_OUTPUT: 07:19:47 INFO - 2015-11-16 07:19:47,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52786/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:47 INFO - 2015-11-16 07:19:47,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 07:19:47 INFO - 2015-11-16 07:19:47,979 DEBUG : BROWSER_OUTPUT: 07:19:51 INFO - 2015-11-16 07:19:51,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52786/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:52 INFO - 2015-11-16 07:19:52,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 137375744 07:19:52 INFO - 2015-11-16 07:19:52,128 DEBUG : BROWSER_OUTPUT: 07:19:55 INFO - 2015-11-16 07:19:55,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52786/tests/kraken/driver.html?testName=json-parse-financial) 07:19:55 INFO - 2015-11-16 07:19:55,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 136351744 07:19:55 INFO - 2015-11-16 07:19:55,677 DEBUG : BROWSER_OUTPUT: 07:19:57 INFO - 2015-11-16 07:19:57,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:57 INFO - 2015-11-16 07:19:57,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 07:19:57 INFO - 2015-11-16 07:19:57,848 DEBUG : BROWSER_OUTPUT: 07:19:59 INFO - 2015-11-16 07:19:59,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:00 INFO - 2015-11-16 07:20:00,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 138018816 07:20:00 INFO - 2015-11-16 07:20:00,274 DEBUG : BROWSER_OUTPUT: 07:20:02 INFO - 2015-11-16 07:20:02,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:02 INFO - 2015-11-16 07:20:02,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 138887168 07:20:02 INFO - 2015-11-16 07:20:02,936 DEBUG : BROWSER_OUTPUT: 07:20:05 INFO - 2015-11-16 07:20:05,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:05 INFO - 2015-11-16 07:20:05,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 138637312 07:20:05 INFO - 2015-11-16 07:20:05,969 DEBUG : BROWSER_OUTPUT: 07:20:08 INFO - 2015-11-16 07:20:08,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:09 INFO - 2015-11-16 07:20:09,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 137711616 07:20:09 INFO - 2015-11-16 07:20:09,147 DEBUG : BROWSER_OUTPUT: 07:20:10 INFO - 2015-11-16 07:20:10,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52786/tests/kraken/driver.html?testName=ai-astar) 07:20:11 INFO - 2015-11-16 07:20:11,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 140365824 07:20:11 INFO - 2015-11-16 07:20:11,082 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;105;111;111;111;123;110;111;111;111 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;150;183;124;151;152;126;159;127 07:20:11 INFO - 2015-11-16 07:20:11,084 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;164;163;160;162;170;166;161 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;71;73;72;72;163;72;72;72 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;90;131;89;91;91;146;90;91;143 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;109;110 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;147;147;145;147;147;147 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;98;97;96;96;97;96;96 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;63;63;64;62;62;62;68;64 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;69;70;69;70;69;71 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;86;93;88;85;85;85;86;85 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;124;116;124;123;122;125;116;123;129 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;156;149;150;149;152;152;148;151;153 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;69;66;67;66;69;69;69;70 07:20:11 INFO - 2015-11-16 07:20:11,085 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:20:11 INFO - 2015-11-16 07:20:11,086 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:20:11 INFO - 2015-11-16 07:20:11,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 07:20:11 INFO - 2015-11-16 07:20:11,086 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:20:11 INFO - 2015-11-16 07:20:11,086 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687211083__endTimestamp 07:20:11 INFO - 2015-11-16 07:20:11,086 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,089 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:20:11 INFO - 2015-11-16 07:20:11,089 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:20:11 INFO - 2015-11-16 07:20:11,089 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.58 (4.1%) stddev-sans-first:4.72 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: Values: 115.0 105.0 111.0 111.0 111.0 123.0 110.0 111.0 111.0 111.0 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.50 stddev:19.24 (12.8%) stddev-sans-first:20.33 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 150.0 183.0 124.0 151.0 152.0 126.0 159.0 127.0 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,090 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.87 (1.8%) stddev-sans-first:3.00 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 164.0 163.0 160.0 162.0 170.0 166.0 161.0 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:72.00 stddev:28.75 (39.9%) stddev-sans-first:30.30 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 71.0 73.0 72.0 72.0 163.0 72.0 72.0 72.0 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:90.50 stddev:24.12 (26.7%) stddev-sans-first:25.16 07:20:11 INFO - 2015-11-16 07:20:11,091 DEBUG : BROWSER_OUTPUT: Values: 93.0 90.0 131.0 89.0 91.0 91.0 146.0 90.0 91.0 143.0 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 147.0 147.0 145.0 147.0 147.0 147.0 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 98.0 97.0 96.0 96.0 97.0 96.0 96.0 07:20:11 INFO - 2015-11-16 07:20:11,092 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.50 stddev:1.78 (2.8%) stddev-sans-first:1.88 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 64.0 62.0 62.0 62.0 68.0 64.0 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 69.0 70.0 69.0 70.0 69.0 71.0 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.62 (3.1%) stddev-sans-first:2.74 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 86.0 93.0 88.0 85.0 85.0 85.0 86.0 85.0 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:4.16 (3.4%) stddev-sans-first:4.16 07:20:11 INFO - 2015-11-16 07:20:11,093 DEBUG : BROWSER_OUTPUT: Values: 118.0 124.0 116.0 124.0 123.0 122.0 125.0 116.0 123.0 129.0 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.50 stddev:3.96 (2.6%) stddev-sans-first:2.47 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: Values: 141.0 156.0 149.0 150.0 149.0 152.0 152.0 148.0 151.0 153.0 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.48 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 69.0 66.0 67.0 66.0 69.0 69.0 69.0 70.0 07:20:11 INFO - 2015-11-16 07:20:11,094 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:20:11 INFO - 2015-11-16 07:20:11,095 DEBUG : BROWSER_OUTPUT: 07:20:11 INFO - 2015-11-16 07:20:11,949 INFO : Browser exited with error code: 0 07:20:11 INFO - 2015-11-16 07:20:11,997 INFO : Completed test kraken (00:00:59) 07:20:11 INFO - 2015-11-16 07:20:11,998 INFO : Starting test v8_7 07:20:11 INFO - 2015-11-16 07:20:11,998 DEBUG : operating with platform_type : linux_ 07:20:11 INFO - 2015-11-16 07:20:11,998 INFO : Initialising browser for v8_7 test... 07:20:12 INFO - 2015-11-16 07:20:12,004 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprihFTq/profile http://localhost:52786/getInfo.html 07:20:15 INFO - 2015-11-16 07:20:15,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:20:15 INFO - 2015-11-16 07:20:15,937 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:20:15 INFO - 2015-11-16 07:20:15,937 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:20:15 INFO - 2015-11-16 07:20:15,937 DEBUG : BROWSER_OUTPUT: __metrics 07:20:16 INFO - 2015-11-16 07:20:16,889 INFO : Browser initialized. 07:20:16 INFO - 2015-11-16 07:20:16,890 INFO : Running cycle 1/1 for v8_7 test... 07:20:16 INFO - 2015-11-16 07:20:16,890 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprihFTq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:20:28 INFO - 2015-11-16 07:20:28,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 07:20:28 INFO - 2015-11-16 07:20:28,642 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52786/tests/v8_7/run.html (next: http://localhost:52786/tests/v8_7/run.html) 07:20:50 INFO - 2015-11-16 07:20:50,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 138571776 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:20:50 INFO - 2015-11-16 07:20:50,312 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5858007524947 07:20:50 INFO - 2015-11-16 07:20:50,313 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.4557351809084 07:20:50 INFO - 2015-11-16 07:20:50,313 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 07:20:50 INFO - 2015-11-16 07:20:50,313 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 07:20:50 INFO - 2015-11-16 07:20:50,314 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 07:20:50 INFO - 2015-11-16 07:20:50,314 DEBUG : BROWSER_OUTPUT: |5;Earley;716.3323782234957 07:20:50 INFO - 2015-11-16 07:20:50,314 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 07:20:50 INFO - 2015-11-16 07:20:50,314 DEBUG : BROWSER_OUTPUT: |7;RegExp;25050 07:20:50 INFO - 2015-11-16 07:20:50,314 DEBUG : BROWSER_OUTPUT: |8;Splay;679.2452830188679 07:20:50 INFO - 2015-11-16 07:20:50,315 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 07:20:50 INFO - 2015-11-16 07:20:50,315 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:20:50 INFO - 2015-11-16 07:20:50,315 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687250310__endTimestamp 07:20:50 INFO - 2015-11-16 07:20:50,315 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,315 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:20:50 INFO - 2015-11-16 07:20:50,316 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:20:50 INFO - 2015-11-16 07:20:50,316 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,316 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.59 Median:163.59 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,316 DEBUG : BROWSER_OUTPUT: Values: 163.6 07:20:50 INFO - 2015-11-16 07:20:50,316 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,317 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.46 Median:192.46 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,317 DEBUG : BROWSER_OUTPUT: Values: 192.5 07:20:50 INFO - 2015-11-16 07:20:50,317 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,317 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,318 DEBUG : BROWSER_OUTPUT: Values: 280.3 07:20:50 INFO - 2015-11-16 07:20:50,318 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,318 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,318 DEBUG : BROWSER_OUTPUT: Values: 5065.7 07:20:50 INFO - 2015-11-16 07:20:50,319 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,319 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,319 DEBUG : BROWSER_OUTPUT: Values: 1058.2 07:20:50 INFO - 2015-11-16 07:20:50,319 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,319 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,320 DEBUG : BROWSER_OUTPUT: Values: 716.3 07:20:50 INFO - 2015-11-16 07:20:50,320 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,320 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,320 DEBUG : BROWSER_OUTPUT: Values: 12096.4 07:20:50 INFO - 2015-11-16 07:20:50,320 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,321 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25050.00 Median:25050.00 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,321 DEBUG : BROWSER_OUTPUT: Values: 25050.0 07:20:50 INFO - 2015-11-16 07:20:50,321 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,321 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:679.25 Median:679.25 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,321 DEBUG : BROWSER_OUTPUT: Values: 679.2 07:20:50 INFO - 2015-11-16 07:20:50,323 DEBUG : BROWSER_OUTPUT: 07:20:50 INFO - 2015-11-16 07:20:50,323 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:20:50 INFO - 2015-11-16 07:20:50,323 DEBUG : BROWSER_OUTPUT: Values: 4822.1 07:20:50 INFO - 2015-11-16 07:20:50,323 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:20:50 INFO - 2015-11-16 07:20:50,323 DEBUG : BROWSER_OUTPUT: 07:20:51 INFO - 2015-11-16 07:20:51,229 INFO : Browser exited with error code: 0 07:20:51 INFO - 2015-11-16 07:20:51,241 INFO : Completed test v8_7 (00:00:39) 07:20:51 INFO - 2015-11-16 07:20:51,352 INFO : Completed test suite (00:20:11) 07:20:51 INFO - 2015-11-16 07:20:51,352 DEBUG : Working with test: dromaeo_css 07:20:51 INFO - 2015-11-16 07:20:51,352 DEBUG : Generating results file: dromaeo_css 07:20:51 INFO - 2015-11-16 07:20:51,353 DEBUG : Working with test: kraken 07:20:51 INFO - 2015-11-16 07:20:51,353 DEBUG : Generating results file: kraken 07:20:51 INFO - 2015-11-16 07:20:51,353 INFO : javascript benchmark 07:20:51 INFO - 2015-11-16 07:20:51,354 DEBUG : Working with test: v8_7 07:20:51 INFO - 2015-11-16 07:20:51,354 DEBUG : Generating results file: v8_7 07:20:51 INFO - 2015-11-16 07:20:51,354 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:51 INFO - 2015-11-16 07:20:51,407 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:20:51 INFO - 2015-11-16 07:20:51,407 DEBUG : process_Request line: dromaeo_css 6678.44 graph.html#tests=[[72,1,43]] 07:20:51 INFO - 2015-11-16 07:20:51,407 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:51 INFO - 2015-11-16 07:20:51,451 DEBUG : process_Request line: kraken 1518.40 graph.html#tests=[[232,1,43]] 07:20:51 INFO - 2015-11-16 07:20:51,451 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:51 INFO - 2015-11-16 07:20:51,481 DEBUG : process_Request line: v8_7 21221.69 graph.html#tests=[[230,1,43]] 07:20:51 INFO - 2015-11-16 07:20:51,483 INFO : javascript benchmark 07:20:51 INFO - 2015-11-16 07:20:51,486 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [346.8976651887693, 347.9495473156392, 349.4688074127325, 349.50544978854924, 351.89091381671676, 12492.875071249286, 12985.480580776757, 16742.49772506824, 17047.74428383574, 17830.554236144086, 11394.886051139487, 11406.372649504294, 11436.428178591057, 11438.542458301657, 11737.178397512156, 4305.311150215966, 4417.337399390101, 4444.288913773797, 4444.911101777962, 4455.777211139446, 4348.391225228471, 4540.863774086766, 4549.613282870943, 4578.885527861797, 4598.264277715566, 4587.220172570671, 4597.333386658949, 4606.631469482433, 4685.461171965217, 4698.882527936795, 4521.796519156645, 4636.072785442908, 4643.4892161862, 4648.1168577970075, 4651.62786977041, 4243.490781106287, 4250.808713607895, 4258.041940563348, 4260.0, 4268.381084742726, 13131.540396086186, 13171.868281317256, 13440.059195856295, 13473.461061557526, 13494.460221591125, 2001.4696105532046, 2033.4001469566513, 2041.9591608167902, 2064.834813214954, 2085.343116918166, 9920.454375009444, 10022.047905448972, 10051.396916185053, 10213.948930255376, 10283.640072597498, 1694.5509439998411, 1698.1169791708242, 1722.922468488921, 1743.5205318537378, 1759.1995641982867, 59449.0, 60818.087728684106, 60906.0, 61390.69304653493, 62448.0, 6857.55425897315, 6878.518503704692, 6959.547629404174, 6992.3357281058215, 7039.54242974205, 8390.0, 8412.663493460193, 8470.576471176417, 8488.236058754741, 8495.74512764618, 5570.053090974544, 5574.358948720868, 5589.273394458694, 5623.803166889139, 5657.4059723728415, 5711.257536520309, 5732.656040637492, 5738.512226460714, 5749.971250143806, 5752.33848107473, 3169.904902852918, 3171.4925611901986, 3217.8551965161623, 3220.4847224443974, 3244.286257023451, 1120.4845770945456, 1123.752774389633, 1124.3197865291381, 1128.2722643894806, 1171.8066519024435, 461.0847467776461, 463.6985959126527, 467.51145053418577, 477.87814107403085, 487.6026038778384, 11555.942220288845, 11960.521579136737, 12240.44917978693, 12246.755064898653, 12295.4467048983, 509.8495943696618, 516.553181498009, 520.6277511579239, 523.1577160771155, 530.0485628297216, 6529.542931994714, 6598.571092878948, 6723.260441351447, 6748.29142939994, 6803.217629972518, 533068.0, 538836.0, 542529.8735063231, 543034.0, 547498.0, 77066.0, 77177.0, 77637.61181194057, 80623.0, 82438.17561824305, 549.0391814324931, 554.4510934175138, 555.1118210862668, 555.8082461550758, 557.3590371073217, 10634.840477393, 11176.105911526896, 11208.383538905438, 11295.096392288433, 11363.090952723927, 31916.0, 32275.35449290954, 32680.50979235361, 33312.50031249485, 33573.992780216635, 40954.0, 41804.58195418007, 42055.36916946187, 46401.53598463972, 47394.28908566443, 6583.868322633616, 6867.622280774405, 6945.965270173617, 6998.230194678683, 7012.719491220498, 11986.160968732105, 12056.51773929033, 12353.32056736888, 12431.129820912449, 12494.0, 9965.701028968853, 10380.740481488023, 10680.092192163442, 10720.571177152826, 11022.779544408906, 10383.2212584055, 10818.891811082103, 10820.513076911715, 10882.673519794418, 10886.346819190874, 10744.785104298027, 10836.566537338733, 11192.1605879561, 11193.72015699614, 11209.327440353605, 6913.688884000131, 6920.792376228721, 6990.335918087773, 7003.5797852129035, 7008.894866576903, 10128.493575321058, 10728.781365590448, 10804.40575768309, 10964.396958167377, 11026.614068507564], "dojo.html": [3267.297531030829, 3296.9670303296975, 3316.6351701312838, 3339.031680812563, 3341.8162001089936, 5259.342582177228, 5385.757640906154, 5405.4324295948945, 5440.700761458118, 5459.535939445147, 5395.10980688186, 5430.429804870481, 5453.563714902808, 5480.561555075595, 5553.222548843165, 5006.774695138709, 5072.898542029157, 5129.307543481638, 5168.3539557555305, 5218.0, 5024.84925452237, 5138.075146473633, 5163.483651634844, 5187.170052791555, 5259.947400526004, 4965.975170124127, 5007.123753343187, 5073.873153171164, 5074.06129865976, 5160.432352441228, 5017.2724954881705, 5019.272205530214, 5023.598112151056, 5033.949660503385, 5073.188289873602, 5024.874378140539, 5048.7980480780725, 5063.569596584295, 5082.440931497532, 5091.1854103343285, 5177.767000484987, 5246.685198888079, 5284.682919024871, 5303.734813259361, 5314.096603577401, 6067.878642427171, 6090.33006369299, 6092.08618707193, 6093.238345206849, 6105.603135796159, 6035.698215089272, 6078.209832721762, 6100.633961962297, 6106.48094911933, 6118.174046503709, 5331.226972089025, 5451.209574611698, 5474.42518535552, 5588.44115588446, 5678.801241956512, 6062.969685151546, 6150.969245153746, 6196.0, 6213.937860621336, 6216.44052035319, 6008.24896887889, 6012.278526576752, 6012.488938440281, 6012.6392416455155, 6041.969790151021, 5807.593468457252, 5848.5321174305955, 5943.375945525744, 6024.608400453956, 6078.665673387918, 5873.236479257755, 6023.3073196582955, 6047.667378294236, 6051.122587224916, 6056.031035034373, 5760.0783874579865, 5987.43119403656, 6002.0, 6011.218541589566, 6014.969925150346, 4512.842050528216, 4543.45478542577, 4593.793279302373, 4604.30935359692, 4640.605548528345, 4058.1680755445063, 4066.837326506966, 4085.5097388313593, 4099.364598487239, 4105.835766569364, 5386.353637563439, 5523.530499907552, 5632.3804381518, 5675.460831221028, 5680.346760122557, 5835.533157347402, 5875.853103672443, 5889.528837692974, 5945.40545945402, 6102.237220347457, 5623.634463759842, 5676.460736230051, 5677.205191273225, 5687.175359572839, 5689.487946084872, 5159.613029022838, 5179.119549676564, 5191.6625419348375, 5215.400228973641, 5221.817236396708, 5913.349531551526, 6059.151718759377, 6105.755769769159, 6179.134921111048, 6179.196704428396, 5980.252468441445, 6047.818565443044, 6067.029275315928, 6069.36271691466, 6075.088736689532, 5968.4031596841705, 6206.131141640264, 6242.938700420848, 6264.436200741955, 6271.905921411091, 5788.160716696139, 5836.182934389274, 5901.852453688693, 5907.852303692442, 5958.791442299499, 5948.5538584605465, 5951.404859514014, 5958.433948774859, 5966.403359664172, 5983.37174596661, 5579.386267510652, 5712.742926568398, 5826.796062137805, 5828.446297601721, 5838.94161058384, 5793.362730099601, 5850.210221620197, 5863.73613187399, 5868.794592189253, 5941.732622032106, 5797.333306669787, 5798.0, 5825.155352473952, 5826.70866456684, 5841.707914604338, 5723.227364305932, 5753.453421924911, 5867.442592953663, 5910.349861515316, 5938.851528711644, 5782.884342313214, 5794.333651630117, 5813.447722466359, 5818.883622327445, 5825.475707186373], "mootools.html": [1470.4191844221525, 1705.2411676803824, 1771.3800169940523, 1774.5297496163519, 1778.9681984449016, 6267.529935254851, 6317.74729010839, 7066.611336376497, 7505.849883002336, 7522.473426860122, 7159.570425774457, 7317.1219453665635, 7412.18465968743, 7428.554286742799, 7454.366378857803, 2177.6080305544997, 2215.8670479771185, 2226.1318085946496, 2226.588081204974, 2228.242397584821, 2234.709487766588, 2249.80876625487, 2272.6363781794835, 2278.031836469502, 2279.0428020231543, 2203.0526873444414, 2216.0581752755097, 2231.553689262146, 2232.620454522727, 2255.639097744361, 2174.739031316244, 2187.5187458759046, 2218.4786575154826, 2218.955620887581, 2221.48905751678, 2222.75549689534, 2261.8869056547105, 2266.9886650566805, 2268.739095004079, 2270.545890821842, 7255.05684261048, 7369.4472914531625, 7376.114866216089, 7383.040204773399, 7386.482946193769, 4440.866773996785, 4479.328100784908, 4488.708233964782, 4515.571020753023, 4540.841070562515, 2897.3046468847538, 2969.331900322432, 2970.5841182234503, 2979.6722360540325, 2987.223321936312, 1000.8148492528833, 1008.2186305613135, 1014.467404612577, 1040.4017689828304, 1043.3896170740127, 9960.651377201762, 9981.90018099817, 9998.350107243079, 10009.399436033862, 10024.398536087785, 4033.092554175346, 4048.6153815387493, 4058.1072164123843, 4075.633193012643, 4095.5904409558807, 8659.090795466385, 8690.130986901258, 8695.782605434915, 8696.391252612382, 8698.826023479494, 4577.771111444415, 4578.771061446914, 4580.0152967112235, 4589.036302376471, 4620.075984803053, 4038.818253178614, 4120.134771697977, 4133.04939863833, 4203.306454435045, 4240.85157019509, 3418.162550175223, 3429.0741499794917, 3463.0649724574223, 3463.6709512596262, 3478.8782392616135, 1040.5213601743133, 1042.202201202934, 1053.1732589916878, 1058.2962330050584, 1058.9258751887448, 1292.3667402972665, 1298.5130576033987, 1327.6548097494722, 1344.099453366247, 1368.6646771541036, 6989.860202795916, 7039.401650859631, 7120.0, 7215.891761623579, 7215.891761623579, 426.74608607878264, 432.4961419945791, 434.9195398851159, 436.41084535876945, 457.8969731810316, 5667.348254950651, 5704.0, 5755.0, 5765.221695071195, 5785.479306862402, 8909.599068041955, 8965.148310910454, 9302.813943721088, 9333.626654933862, 9383.0, 9045.095490451034, 9088.909110908939, 9128.771780705403, 9170.67902623405, 9219.76950576241, 6964.26875178099, 6989.0, 6989.650517474208, 7029.718811247595, 7048.506604537633, 6739.0, 6818.829529261808, 6836.897446538206, 6840.9657951711915, 6852.074969879002, 7900.0, 8125.71559995421, 8143.389245806469, 8253.587320633824, 8256.876146857681, 8150.551719655476, 8311.625976831177, 8321.83356332882, 8342.666293348198, 8344.123866993878, 6408.327125651739, 6492.123563319081, 6565.409113179646, 6916.308369163044, 6919.100516932766, 7285.125784905846, 7306.634668266672, 7325.340719335285, 7338.70645174187, 7341.559506429631, 6785.0, 6850.862982740217, 6917.481188910952, 6963.303669632996, 7002.474814389043, 6722.05891175226, 6733.091032710521, 6801.421879140328, 6814.557053791487, 6845.589264643938, 6691.866162676816, 6741.1910570731825, 6773.729050837911, 6801.353871382211, 6930.168379794457, 6292.402221788922, 6340.858645443865, 6346.587471814318, 6347.365263473615, 6355.269144048493, 6335.873282534416, 6354.52341074412, 6362.745490180341, 6395.232572091379, 6402.6158430494315], "ext.html": [557.7812479731787, 590.0235110891475, 596.8776400837829, 608.6287364707528, 610.0300522169749, 37311.0, 37879.81060094703, 37970.620293797125, 37981.810090949504, 38096.23807523848, 42440.36339454911, 42917.14165716692, 43017.56982430175, 43169.136617267635, 43291.35062974058, 8710.477371357707, 8848.734537963872, 8872.15714507124, 8877.378583499158, 8888.111188881092, 8665.610047547843, 8699.347548933856, 8742.825143497126, 8752.431091979033, 8789.912100878973, 8650.783730406758, 8759.430637008605, 8777.0, 8785.868211976825, 8786.341024423162, 8656.394052416303, 8757.0, 8769.07924667907, 8771.517566533837, 8781.1218878112, 8616.26761725254, 8694.478331300143, 8738.30093592511, 8755.78110547235, 8768.0, 39216.41175382372, 39617.80191099026, 39643.80178099091, 39682.20635587301, 39776.60223397758, 3297.4394352959816, 3316.3533111043357, 3351.731861451078, 3429.5198672185666, 3803.2583646189005, 29376.0, 29753.25616859596, 30144.698553014627, 30273.69726302731, 30441.847790760905, 3389.8474568644224, 3402.2004828865197, 3413.0955296846355, 3503.316853213624, 3578.7494875358734, 272836.0, 273929.0, 274967.0, 275017.0, 275161.0, 54329.72835135799, 55598.72200638971, 55823.16265256024, 55995.16007259894, 57663.711681441324, 54572.18141727877, 54610.45389546054, 54915.45084549183, 54936.45063549393, 55093.173602396, 13945.372458239404, 14102.365393557315, 14120.929395353163, 14123.0, 14147.0, 11002.614908478165, 11032.338059716443, 11055.447227638586, 11066.336019838835, 11091.057260132819, 18733.718994215098, 19191.424257272305, 19203.807961920204, 19229.615407691766, 19258.325958591664, 7694.230576942261, 7876.4092693047105, 7896.249856263646, 7906.327962123169, 8068.628333183256, 902.4540153207346, 982.2191357870367, 1018.3431686562126, 1078.7195329214303, 1089.6676513663251, 27988.16035518938, 28053.66109570586, 28490.572641410396, 28566.571501427494, 28725.0, 1017.4200705597887, 1053.3416614615865, 1128.3963079752293, 1128.9557159627475, 1130.3669944830922, 13094.803577946339, 13324.933375333061, 13460.663483412796, 13478.123921945238, 13515.662108447172, 322377.0, 326604.0, 327801.0, 328719.0, 329029.0, 51102.744486278076, 51165.232521512204, 51370.74314628403, 51401.228981565306, 51441.485585143666, 1348.0630961481677, 1360.0479664235074, 1362.2984163155982, 1378.4417310989065, 1385.2935003148266, 26098.478030438906, 26833.0, 27202.183934481996, 27427.862860685567, 27884.860575696992, 45201.54798451973, 45473.772631136635, 45518.58610604284, 45730.771346144385, 45736.0, 219970.0, 220433.0, 221054.0, 221446.0, 221722.0, 31353.0, 33935.3212935735, 34006.80976165822, 34394.484082739276, 34667.306653866275, 42015.0, 42917.356239655805, 43481.78259108811, 43699.12601748011, 44049.0, 35337.293254135286, 35972.82013589915, 36019.81990090033, 36746.63253367432, 36751.448728269635, 36696.41657167654, 36894.0, 36904.81547592245, 37002.44496332503, 37341.0, 35294.0, 35344.82327588346, 35501.644983549835, 35856.0, 35859.82070089633, 31343.84328078345, 32879.0, 33309.333813323115, 33360.666393335756, 33551.0, 25450.490990179722, 26184.155931152036, 26372.472550549264, 26456.470870582096, 26567.0], "prototype.html": [307.331553870332, 310.5698607428712, 310.77779387737763, 312.6935603108952, 312.79355625287315, 6194.101855230989, 6296.212973378328, 6344.397282258184, 6392.137061496696, 6490.643014634194, 6295.811125666238, 6325.557210995232, 6346.873062538758, 6354.968225158879, 6356.9046464302955, 4539.863804085882, 4659.930101048487, 4688.835890743816, 4740.90518189636, 4755.2153894607345, 4653.557911998355, 4683.437987441494, 4687.484376718558, 4708.034852855174, 4710.835120770774, 4593.081383723269, 4628.606568441686, 4630.583247507724, 4636.304554316863, 4639.8376056838015, 4642.0, 4646.233371493699, 4647.163510568096, 4656.976715116402, 4660.091282199938, 3907.7459965102175, 3962.306596345657, 3962.6829853611644, 3966.8214930328204, 3969.6625786808154, 5886.117082437626, 5983.341832398432, 5998.310194327664, 6004.369541198155, 6015.488683461911, 5418.133098704188, 5425.9728701356635, 5431.51116399522, 5438.428964958702, 5449.155380915964, 6687.364700353459, 6707.228668703113, 6726.192856857159, 6728.428083612899, 6730.32696730323, 4336.176126535979, 4362.650987920959, 4394.231009573344, 4394.60448559628, 4397.890052748675, 6926.619035953021, 7000.894986575206, 7002.649867506655, 7033.6483175841, 7036.296370362974, 4490.0, 4494.797734101973, 4502.054568540643, 4514.548545145459, 4522.163399771053, 4478.865634030984, 4546.704464209815, 4548.340490628841, 4552.089582083597, 4566.3150527420485, 5342.679439233659, 5387.272718183073, 5390.380106287748, 5394.8381548552825, 5405.4324295949145, 6763.458923286224, 6767.864642707118, 6775.254721980578, 6775.898361524581, 6793.45652347811, 1585.0964949978402, 1598.009234274757, 1599.5601209667202, 1600.1759094066565, 1603.9839601603835, 1040.3341861208833, 1045.440689231273, 1049.8740151181755, 1061.2040969273046, 1062.9627963021258, 6490.643014634241, 6499.057636642755, 6503.967480162663, 6507.9023814642815, 6517.543771936013, 6935.098437203132, 6986.231514533397, 6994.230634630187, 6995.160580730345, 6999.12510936133, 6313.77901773445, 6462.612243265419, 6467.547271691031, 6496.22045354551, 6499.155109835691, 3799.259144466858, 3809.5619003814363, 3845.8461661533784, 3858.054776579756, 3858.8070596470066, 7191.316824901626, 7346.449016323797, 7347.08161479815, 7347.963260183772, 7386.963065184747, 7264.891026634605, 7275.527090739085, 7276.7089316426745, 7279.927200728031, 7306.0, 7149.285071492809, 7368.336849683555, 7370.815729606696, 7371.520851144658, 7390.187079421259, 7053.823654408681, 7057.788266352018, 7061.71753129869, 7087.291270872872, 7096.858062838611, 6918.342757438036, 6957.408620267334, 6999.440044796303, 7018.087648605649, 7018.947157926352, 7212.74755383559, 7333.853322933618, 7364.631768411665, 7385.335319821242, 7400.111986561647, 4499.91000179988, 4546.340780586863, 4546.568076032771, 4557.270836666117, 4558.247889098262, 6993.4055605274125, 7000.264972177848, 7001.8249543759775, 7013.859722805413, 7015.8952314306525, 6633.767818126343, 6793.286704895915, 6815.33024409023, 6833.863322733617, 6849.383555480031, 6776.559523630948, 6804.0, 6805.081314022544, 6818.829529261808, 6828.248892621907, 6677.799666010027, 6694.29709880475, 6696.363845434871, 6697.09589205451, 6698.497612678971, 6539.738410463528, 6751.898721519279, 6779.762708305186, 6853.9314606853295, 6865.759698410531, 6618.602883826986, 6629.270780214076, 6654.500912431684, 6667.99980002984, 6683.131192944886], "yui.html": [766.9156392796788, 793.8769490728937, 831.5343407691693, 835.5195762436597, 853.0403296291672, 13907.026508144421, 14016.0, 14106.083104598207, 14130.505432309872, 14133.222672752994, 11915.0, 12054.276743395381, 12101.878981210186, 12109.515619375214, 12127.393630318471, 802.1817745899194, 816.9101398846152, 817.3665409307804, 819.5328662662284, 823.0, 808.1151139502265, 812.3744716568239, 815.1074573342181, 816.3713940265992, 816.6733306677318, 839.3704721458906, 848.0417128644623, 849.7195925344653, 850.7022542110274, 855.7432770168956, 843.7679638099511, 844.6072576252042, 845.0408786027841, 845.0788640381952, 847.4152834544145, 615.7660089166133, 616.5714828194407, 617.3486971245335, 618.9972244963144, 619.2383368456823, 13594.38825252866, 13687.589372318846, 13698.726025479435, 13788.724225515534, 13844.10013349139, 10252.487375631263, 10554.155667546578, 10710.357378557312, 10722.731931701692, 10758.623448179354, 10156.339837910586, 10240.436775977318, 10303.896961030368, 10417.895821041768, 10439.739006524822, 3109.518024706174, 3150.6376766671897, 3219.919502012445, 3258.934821303584, 3264.265540253448, 46116.53883461156, 47279.527204727856, 47383.76308118437, 47433.0, 47481.5251847484, 7331.376832969151, 7352.889706654404, 7380.446466515033, 7386.926130738731, 7518.699252029857, 12248.693782655504, 12300.692482688004, 12305.32320722351, 12338.753224935452, 12376.257424554555, 6791.93208067913, 6818.931810681929, 6833.794986150423, 6940.826479338057, 7104.644767761694, 4330.956690433055, 4332.025294308818, 4466.196084704719, 4501.077279157765, 4714.104320179155, 2752.3669556002233, 2763.1710486853863, 2784.220418282884, 2790.41401305724, 2793.594928735322, 424.8682908298437, 433.3478115436248, 437.47502996404444, 446.7877758064893, 450.25707582489156, 507.73090262161116, 517.362547537041, 592.4726992976255, 655.7245956698198, 705.2559549675142, 8153.184681531918, 8728.170823771732, 8801.339899507562, 9524.714258572254, 9891.653792117242, 582.408855012163, 605.0621536618224, 648.7632014314836, 663.6084710021111, 672.1329484964439, 4062.614051665087, 4199.748015119103, 4244.3209086546, 4257.531671516131, 4349.717268377545, 60262.698686506286, 60991.695041525396, 61314.0, 61818.0, 61831.0, 53967.46032539703, 55186.448135518134, 55332.0, 55419.0, 56329.0, 50316.74841625769, 50888.23667644988, 50893.74553127211, 50895.0, 51324.48675513197, 8391.496510209407, 8472.44929079608, 8724.69463568772, 8899.377043607145, 8926.419782714103, 33648.0, 34150.82924585361, 34541.30917381689, 36090.4586431209, 38352.04119897025, 46736.53263467322, 46921.0, 47700.0, 48539.0, 48609.756951216434, 7766.262205090507, 8016.957795486783, 8073.475224110414, 8276.379271554537, 8327.292180164754, 12072.0, 12363.32001739913, 12579.559715409916, 12708.428120734774, 12778.552750653682, 11298.887011129784, 11419.486123124314, 11765.352905590275, 12128.9690376319, 12150.939245303716, 11450.541978320774, 11664.825027624762, 11905.46425410876, 12473.5010599575, 12480.687982800502, 9717.17404020666, 10741.0, 10981.0, 11723.824142637697, 12112.394380281126, 9349.953250233977, 9403.34176607631, 9407.341486096182, 9533.904660953302, 9763.218942484726, 8750.47497150173, 8891.777705557413, 9249.352545322032, 9277.257819374568, 9618.326717129734]}, "summary": {"lowerIsBetter": false, "suite": 6678.443614508119, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6867.153795151363, "unit": "ms", "value": 6867.153795151363}, "dojo.html": {"lowerIsBetter": false, "filtered": 5501.291358223125, "unit": "ms", "value": 5501.291358223125}, "mootools.html": {"lowerIsBetter": false, "filtered": 4263.858622095563, "unit": "ms", "value": 4263.858622095563}, "ext.html": {"lowerIsBetter": false, "filtered": 18170.784267853778, "unit": "ms", "value": 18170.784267853778}, "prototype.html": {"lowerIsBetter": false, "filtered": 4992.233805084063, "unit": "ms", "value": 4992.233805084063}, "yui.html": {"lowerIsBetter": false, "filtered": 6071.590833970337, "unit": "ms", "value": 6071.590833970337}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-048.e"}, "testrun": {"date": 1447686039, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 163.0, 164.0, 163.0, 160.0, 162.0, 170.0, 166.0, 161.0], "ai-astar": [115.0, 105.0, 111.0, 111.0, 111.0, 123.0, 110.0, 111.0, 111.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "audio-beat-detection": [149.0, 124.0, 150.0, 183.0, 124.0, 151.0, 152.0, 126.0, 159.0, 127.0], "json-stringify-tinderbox": [69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 71.0], "stanford-crypto-pbkdf2": [141.0, 156.0, 149.0, 150.0, 149.0, 152.0, 152.0, 148.0, 151.0, 153.0], "json-parse-financial": [63.0, 64.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0, 68.0, 64.0], "stanford-crypto-sha256-iterative": [66.0, 69.0, 69.0, 66.0, 67.0, 66.0, 69.0, 69.0, 69.0, 70.0], "audio-fft": [72.0, 73.0, 71.0, 73.0, 72.0, 72.0, 163.0, 72.0, 72.0, 72.0], "imaging-darkroom": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [118.0, 124.0, 116.0, 124.0, 123.0, 122.0, 125.0, 116.0, 123.0, 129.0], "audio-oscillator": [93.0, 90.0, 131.0, 89.0, 91.0, 91.0, 146.0, 90.0, 91.0, 143.0], "stanford-crypto-aes": [85.0, 84.0, 86.0, 93.0, 88.0, 85.0, 85.0, 85.0, 86.0, 85.0], "imaging-desaturate": [96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1518.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.2, "unit": "ms", "value": 81.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 150.1, "unit": "ms", "value": 150.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.5, "unit": "ms", "value": 144.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.0, "unit": "ms", "value": 122.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.5, "unit": "ms", "value": 146.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.5, "unit": "ms", "value": 63.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.5, "unit": "ms", "value": 105.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.9, "unit": "ms", "value": 111.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.3, "unit": "ms", "value": 163.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.2, "unit": "ms", "value": 86.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.4, "unit": "ms", "value": 96.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-048.e"}, "testrun": {"date": 1447686039, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.4557351809084], "Encrypt": [280.2690582959641], "NavierStokes": [4822.115384615385], "Decrypt": [5065.656565656565], "Splay": [679.2452830188679], "Richards": [163.5858007524947], "RegExp": [25050.0], "Earley": [716.3323782234957], "Boyer": [12096.385542168675], "RayTrace": [1058.2010582010582]}, "summary": {"lowerIsBetter": false, "suite": 21221.68743089829, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 343.54912799999994, "unit": "score", "value": 343.54912799999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.7338080000005, "unit": "score", "value": 949.7338080000005}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 119.97286111111107, "unit": "score", "value": 119.97286111111107}, "RegExp": {"lowerIsBetter": false, "filtered": 36.36666666666668, "unit": "score", "value": 36.36666666666668}, "Richards": {"lowerIsBetter": false, "filtered": 215.80112600000007, "unit": "score", "value": 215.80112600000007}, "Earley": {"lowerIsBetter": false, "filtered": 930.3823479999999, "unit": "score", "value": 930.3823479999999}, "Boyer": {"lowerIsBetter": false, "filtered": 55.096044820717125, "unit": "score", "value": 55.096044820717125}, "RayTrace": {"lowerIsBetter": false, "filtered": 699.2896049999997, "unit": "score", "value": 699.2896049999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-048.e"}, "testrun": {"date": 1447686039, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 07:20:51 INFO - RETURN: dromaeo_css: 6678.44 07:20:51 INFO - RETURN: kraken: 1518.40 07:20:51 INFO - RETURN: v8_7: 21221.69 07:20:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21221.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1518.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6678.44"}}} 07:20:51 INFO - Return code: 0 07:20:51 INFO - # TBPL SUCCESS # 07:20:51 INFO - Running post-action listener: _resource_record_post_action 07:20:51 INFO - Running post-run listener: _resource_record_post_run 07:20:52 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 10567680; Write bytes: 402464768; Read time: 3060; Write time: 364708 07:20:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 475136; Read time: 0; Write time: 40 07:20:52 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8413184; Write bytes: 401989632; Read time: 2948; Write time: 364668 07:20:52 INFO - Running post-run listener: _upload_blobber_files 07:20:52 INFO - Blob upload gear active. 07:20:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:20:52 INFO - Copying logs to upload dir... 07:20:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.369820 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-16 07:20:52.680370) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:52.683555) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010104 build_url: 'https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 07:20:52.736470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:52.736849) ========= 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=fdc9337702648c539b2c5dbe000001aa-1447684437.272638-632410043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:52.787479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:20:52.787800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:20:52.788125) ========= ========= Total master_lag: 0.23 =========