builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1447912608.85 results: success (0) buildid: 20151118203114 builduid: 230ea67b005f47afa8fa77ec69f9fb89 revision: cae56980cbec07da0f7c28be592bff3461086520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.853745) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.854344) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.854936) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006483 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.881799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.882160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.916060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.916353) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004782 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.970033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.970346) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.970741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:48.971082) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 21:56:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2015-11-18 21:56:49 (18.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:49.132708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:49.133469) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016060 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:49.190558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 21:56:49.190942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae56980cbec07da0f7c28be592bff3461086520 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cae56980cbec07da0f7c28be592bff3461086520 --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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 21:56:49,702 truncating revision to first 12 chars 2015-11-18 21:56:49,702 Setting DEBUG logging. 2015-11-18 21:56:49,702 attempt 1/10 2015-11-18 21:56:49,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae56980cbec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 21:56:50,916 unpacking tar archive at: fx-team-cae56980cbec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.479554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 21:56:50.684791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:50.685150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:50.695586) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:50.695905) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:56:50.696334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-18 21:56:50.696679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:51 INFO - MultiFileLogger online at 20151118 21:56:51 in /builds/slave/test-pgo 21:56:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:56:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:51 INFO - {'append_to_log': False, 21:56:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:51 INFO - 'blob_upload_branch': 'Fx-Team', 21:56:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:51 INFO - 'branch': 'Fx-Team', 21:56:51 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:51 INFO - 'config_files': ('talos/linux_config.py',), 21:56:51 INFO - 'default_actions': ('clobber', 21:56:51 INFO - 'read-buildbot-config', 21:56:51 INFO - 'download-and-extract', 21:56:51 INFO - 'populate-webroot', 21:56:51 INFO - 'create-virtualenv', 21:56:51 INFO - 'install', 21:56:51 INFO - 'run-tests'), 21:56:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:51 INFO - 'download_minidump_stackwalk': True, 21:56:51 INFO - 'download_symbols': 'ondemand', 21:56:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:51 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:51 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:51 INFO - 'installer_path': 'installer.exe', 21:56:51 INFO - 'log_level': 'info', 21:56:51 INFO - 'log_name': 'talos', 21:56:51 INFO - 'log_to_console': True, 21:56:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:51 INFO - 'opt_config_files': (), 21:56:51 INFO - 'pip_index': False, 21:56:51 INFO - 'sps_profile': False, 21:56:51 INFO - 'sps_profile_interval': 0, 21:56:51 INFO - 'suite': 'dromaeojs', 21:56:51 INFO - 'system_bits': '64', 21:56:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:51 INFO - 'title': 'talos-linux64-ix-002', 21:56:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:51 INFO - 'use_talos_json': True, 21:56:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:51 INFO - 'work_dir': 'build'} 21:56:51 INFO - ##### 21:56:51 INFO - ##### Running clobber step. 21:56:51 INFO - ##### 21:56:51 INFO - Running pre-action listener: _resource_record_pre_action 21:56:51 INFO - Running main action method: clobber 21:56:51 INFO - rmtree: /builds/slave/test-pgo/build 21:56:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:52 INFO - Running post-action listener: _resource_record_post_action 21:56:52 INFO - ##### 21:56:52 INFO - ##### Running read-buildbot-config step. 21:56:52 INFO - ##### 21:56:52 INFO - Running pre-action listener: _resource_record_pre_action 21:56:52 INFO - Running main action method: read_buildbot_config 21:56:52 INFO - Using buildbot properties: 21:56:52 INFO - { 21:56:52 INFO - "properties": { 21:56:52 INFO - "buildnumber": 500, 21:56:52 INFO - "product": "firefox", 21:56:52 INFO - "script_repo_revision": "production", 21:56:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:56:52 INFO - "repository": "", 21:56:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:56:52 INFO - "buildid": "20151118203114", 21:56:52 INFO - "slavename": "talos-linux64-ix-002", 21:56:52 INFO - "pgo_build": "True", 21:56:52 INFO - "basedir": "/builds/slave/test-pgo", 21:56:52 INFO - "project": "", 21:56:52 INFO - "platform": "ubuntu64_hw", 21:56:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:56:52 INFO - "slavebuilddir": "test", 21:56:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:56:52 INFO - "branch": "fx-team", 21:56:52 INFO - "repo_path": "integration/fx-team", 21:56:52 INFO - "stage_platform": "linux64-pgo", 21:56:52 INFO - "builduid": "230ea67b005f47afa8fa77ec69f9fb89", 21:56:52 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:52 INFO - }, 21:56:52 INFO - "sourcestamp": { 21:56:52 INFO - "repository": "", 21:56:52 INFO - "hasPatch": false, 21:56:52 INFO - "project": "", 21:56:52 INFO - "branch": "fx-team-linux64-pgo-talos", 21:56:52 INFO - "changes": [ 21:56:52 INFO - { 21:56:52 INFO - "category": null, 21:56:52 INFO - "files": [ 21:56:52 INFO - { 21:56:52 INFO - "url": null, 21:56:52 INFO - "name": "https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:56:52 INFO - } 21:56:52 INFO - ], 21:56:52 INFO - "repository": "", 21:56:52 INFO - "rev": "cae56980cbec07da0f7c28be592bff3461086520", 21:56:52 INFO - "who": "sendchange", 21:56:52 INFO - "when": 1447912536, 21:56:52 INFO - "number": 6681145, 21:56:52 INFO - "comments": "", 21:56:52 INFO - "project": "", 21:56:52 INFO - "at": "Wed 18 Nov 2015 21:55:36", 21:56:52 INFO - "branch": "fx-team-linux64-pgo-talos", 21:56:52 INFO - "revlink": "", 21:56:52 INFO - "properties": [ 21:56:52 INFO - [ 21:56:52 INFO - "buildid", 21:56:52 INFO - "20151118203114", 21:56:52 INFO - "Change" 21:56:52 INFO - ], 21:56:52 INFO - [ 21:56:52 INFO - "builduid", 21:56:52 INFO - "230ea67b005f47afa8fa77ec69f9fb89", 21:56:52 INFO - "Change" 21:56:52 INFO - ], 21:56:52 INFO - [ 21:56:52 INFO - "pgo_build", 21:56:52 INFO - "True", 21:56:52 INFO - "Change" 21:56:52 INFO - ] 21:56:52 INFO - ], 21:56:52 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:52 INFO - } 21:56:52 INFO - ], 21:56:52 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 21:56:52 INFO - } 21:56:52 INFO - } 21:56:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:56:52 INFO - Running post-action listener: _resource_record_post_action 21:56:52 INFO - ##### 21:56:52 INFO - ##### Running download-and-extract step. 21:56:52 INFO - ##### 21:56:52 INFO - Running pre-action listener: _resource_record_pre_action 21:56:52 INFO - Running main action method: download_and_extract 21:56:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:52 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:56:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json 21:56:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json 21:56:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:56:53 INFO - Downloaded 1302 bytes. 21:56:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:56:53 INFO - Using the following test package requirements: 21:56:53 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'jsshell-linux-x86_64.zip'], 21:56:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:53 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:53 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:57 INFO - Downloaded 22475893 bytes. 21:56:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:58 INFO - Return code: 0 21:56:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:58 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:57:02 INFO - Downloaded 22475893 bytes. 21:57:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:57:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:57:03 INFO - Return code: 0 21:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:03 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:57:04 INFO - Downloaded 11130997 bytes. 21:57:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:57:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:57:05 INFO - Return code: 0 21:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:05 INFO - https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:57:06 INFO - Downloaded 57209453 bytes. 21:57:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:06 INFO - mkdir: /builds/slave/test-pgo/properties 21:57:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:57:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:57:06 INFO - Contents: 21:57:06 INFO - build_url:https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:06 INFO - Running post-action listener: _resource_record_post_action 21:57:06 INFO - Running post-action listener: set_extra_try_arguments 21:57:06 INFO - ##### 21:57:06 INFO - ##### Running populate-webroot step. 21:57:06 INFO - ##### 21:57:06 INFO - Running pre-action listener: _resource_record_pre_action 21:57:06 INFO - Running main action method: populate_webroot 21:57:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:57:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:57:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:57:06 INFO - '../fennec_ids.txt'], 21:57:06 INFO - 'tests': ['tcheck2']}, 21:57:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:57:06 INFO - '--tppagecycles', 21:57:06 INFO - '7'], 21:57:06 INFO - 'tests': ['tsvgm']}}, 21:57:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:57:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:57:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'tests': ['damp', 'tps']}, 21:57:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['damp', 'tps']}, 21:57:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:57:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:57:06 INFO - 'other': {'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'other_l64': {'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'other_nol64': {'tests': ['a11yr', 21:57:06 INFO - 'ts_paint', 21:57:06 INFO - 'tpaint', 21:57:06 INFO - 'sessionrestore', 21:57:06 INFO - 'sessionrestore_no_auto_restore']}, 21:57:06 INFO - 'svgr': {'tests': ['tsvgx', 21:57:06 INFO - 'tsvgr_opacity', 21:57:06 INFO - 'tart', 21:57:06 INFO - 'tscrollx', 21:57:06 INFO - 'cart']}, 21:57:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['tsvgx', 21:57:06 INFO - 'tsvgr_opacity', 21:57:06 INFO - 'tart', 21:57:06 INFO - 'tscrollx', 21:57:06 INFO - 'cart']}, 21:57:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'tests': ['tp5o']}, 21:57:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'talos_options': ['--e10s'], 21:57:06 INFO - 'tests': ['tp5o']}, 21:57:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'talos_options': ['--xperf_path', 21:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:06 INFO - 'tests': ['tp5n']}, 21:57:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:06 INFO - 'talos_options': ['--e10s', 21:57:06 INFO - '--xperf_path', 21:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:06 INFO - 'tests': ['tp5n']}}, 21:57:06 INFO - 'talos.zip': {'path': '', 21:57:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:57:06 INFO - Running post-action listener: _resource_record_post_action 21:57:06 INFO - ##### 21:57:06 INFO - ##### Running create-virtualenv step. 21:57:06 INFO - ##### 21:57:06 INFO - Running pre-action listener: _resource_record_pre_action 21:57:06 INFO - Running main action method: create_virtualenv 21:57:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:57:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:57:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:57:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:57:06 INFO - Using real prefix '/usr' 21:57:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:57:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:57:09 INFO - Installing pip.................done. 21:57:09 INFO - Return code: 0 21:57:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:57:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:57:09 INFO - Using env: {'DISPLAY': ':0', 21:57:09 INFO - 'HOME': '/home/cltbld', 21:57:09 INFO - 'LANG': 'en_US.UTF-8', 21:57:09 INFO - 'LANGUAGE': 'en_US:en', 21:57:09 INFO - 'LOGNAME': 'cltbld', 21:57:09 INFO - 'MAIL': '/var/mail/cltbld', 21:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:09 INFO - 'MOZ_NO_REMOTE': '1', 21:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:09 INFO - 'NO_EM_RESTART': '1', 21:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:09 INFO - 'SHELL': '/bin/bash', 21:57:09 INFO - 'SHLVL': '1', 21:57:09 INFO - 'TERM': 'linux', 21:57:09 INFO - 'TMOUT': '86400', 21:57:09 INFO - 'USER': 'cltbld', 21:57:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:09 INFO - '_': '/tools/buildbot/bin/python'} 21:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:57:09 INFO - Cleaning up... 21:57:09 INFO - Return code: 0 21:57:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:57:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:57:09 INFO - Using env: {'DISPLAY': ':0', 21:57:09 INFO - 'HOME': '/home/cltbld', 21:57:09 INFO - 'LANG': 'en_US.UTF-8', 21:57:09 INFO - 'LANGUAGE': 'en_US:en', 21:57:09 INFO - 'LOGNAME': 'cltbld', 21:57:09 INFO - 'MAIL': '/var/mail/cltbld', 21:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:09 INFO - 'MOZ_NO_REMOTE': '1', 21:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:09 INFO - 'NO_EM_RESTART': '1', 21:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:09 INFO - 'SHELL': '/bin/bash', 21:57:09 INFO - 'SHLVL': '1', 21:57:09 INFO - 'TERM': 'linux', 21:57:09 INFO - 'TMOUT': '86400', 21:57:09 INFO - 'USER': 'cltbld', 21:57:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:09 INFO - '_': '/tools/buildbot/bin/python'} 21:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:09 INFO - Downloading/unpacking psutil>=0.7.1 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:57:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:57:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:11 INFO - Installing collected packages: psutil 21:57:11 INFO - Running setup.py install for psutil 21:57:11 INFO - building 'psutil._psutil_linux' extension 21:57:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:57: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 21:57:11 INFO - building 'psutil._psutil_posix' extension 21:57: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 21:57: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 21:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:11 INFO - Successfully installed psutil 21:57:11 INFO - Cleaning up... 21:57:11 INFO - Return code: 0 21:57:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57: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 21:57: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 21:57:11 INFO - Using env: {'DISPLAY': ':0', 21:57:11 INFO - 'HOME': '/home/cltbld', 21:57:11 INFO - 'LANG': 'en_US.UTF-8', 21:57:11 INFO - 'LANGUAGE': 'en_US:en', 21:57:11 INFO - 'LOGNAME': 'cltbld', 21:57:11 INFO - 'MAIL': '/var/mail/cltbld', 21:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:11 INFO - 'MOZ_NO_REMOTE': '1', 21:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:11 INFO - 'NO_EM_RESTART': '1', 21:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:11 INFO - 'SHELL': '/bin/bash', 21:57:11 INFO - 'SHLVL': '1', 21:57:11 INFO - 'TERM': 'linux', 21:57:11 INFO - 'TMOUT': '86400', 21:57:11 INFO - 'USER': 'cltbld', 21:57:11 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:11 INFO - '_': '/tools/buildbot/bin/python'} 21:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57: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) 21:57:13 INFO - Installing collected packages: mozsystemmonitor 21:57:13 INFO - Running setup.py install for mozsystemmonitor 21:57:13 INFO - Successfully installed mozsystemmonitor 21:57:13 INFO - Cleaning up... 21:57:13 INFO - Return code: 0 21:57:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:57: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')]} 21:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57: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 21:57: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 21:57:13 INFO - Using env: {'DISPLAY': ':0', 21:57:13 INFO - 'HOME': '/home/cltbld', 21:57:13 INFO - 'LANG': 'en_US.UTF-8', 21:57:13 INFO - 'LANGUAGE': 'en_US:en', 21:57:13 INFO - 'LOGNAME': 'cltbld', 21:57:13 INFO - 'MAIL': '/var/mail/cltbld', 21:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:13 INFO - 'MOZ_NO_REMOTE': '1', 21:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:13 INFO - 'NO_EM_RESTART': '1', 21:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:13 INFO - 'SHELL': '/bin/bash', 21:57:13 INFO - 'SHLVL': '1', 21:57:13 INFO - 'TERM': 'linux', 21:57:13 INFO - 'TMOUT': '86400', 21:57:13 INFO - 'USER': 'cltbld', 21:57:13 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:13 INFO - '_': '/tools/buildbot/bin/python'} 21:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:14 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:57:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:57:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:57:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:16 INFO - Downloading docopt-0.6.1.tar.gz 21:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:16 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:16 INFO - Running setup.py install for blobuploader 21:57:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:57:16 INFO - Running setup.py install for requests 21:57:16 INFO - Running setup.py install for docopt 21:57:16 INFO - Successfully installed blobuploader requests docopt 21:57:16 INFO - Cleaning up... 21:57:16 INFO - Return code: 0 21:57:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:16 INFO - Using env: {'DISPLAY': ':0', 21:57:16 INFO - 'HOME': '/home/cltbld', 21:57:16 INFO - 'LANG': 'en_US.UTF-8', 21:57:16 INFO - 'LANGUAGE': 'en_US:en', 21:57:16 INFO - 'LOGNAME': 'cltbld', 21:57:16 INFO - 'MAIL': '/var/mail/cltbld', 21:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:16 INFO - 'MOZ_NO_REMOTE': '1', 21:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:16 INFO - 'NO_EM_RESTART': '1', 21:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:16 INFO - 'SHELL': '/bin/bash', 21:57:16 INFO - 'SHLVL': '1', 21:57:16 INFO - 'TERM': 'linux', 21:57:16 INFO - 'TMOUT': '86400', 21:57:16 INFO - 'USER': 'cltbld', 21:57:16 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:16 INFO - '_': '/tools/buildbot/bin/python'} 21:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:17 INFO - Running setup.py (path:/tmp/pip-HF43rx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:17 INFO - Running setup.py (path:/tmp/pip-Xty1ue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:17 INFO - Running setup.py (path:/tmp/pip-Z7Tgqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:17 INFO - Running setup.py (path:/tmp/pip-uHJJEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:17 INFO - Running setup.py (path:/tmp/pip-dto23s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:17 INFO - Running setup.py (path:/tmp/pip-SooYV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:17 INFO - Running setup.py (path:/tmp/pip-qmBta6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:17 INFO - Running setup.py (path:/tmp/pip-DTuABF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:17 INFO - Running setup.py (path:/tmp/pip-xaXIQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:17 INFO - Running setup.py (path:/tmp/pip-2bf9F3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:17 INFO - Running setup.py (path:/tmp/pip-HoHZe6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:17 INFO - Running setup.py (path:/tmp/pip-orGiIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:18 INFO - Running setup.py (path:/tmp/pip-eV11Dt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:18 INFO - Running setup.py (path:/tmp/pip-CMV9VV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:18 INFO - Running setup.py (path:/tmp/pip-UpTfU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:18 INFO - Running setup.py (path:/tmp/pip-K67S8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:18 INFO - Running setup.py (path:/tmp/pip-tMcq1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:18 INFO - Running setup.py install for manifestparser 21:57:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:57:18 INFO - Running setup.py install for mozcrash 21:57:18 INFO - Running setup.py install for mozdebug 21:57:18 INFO - Running setup.py install for mozdevice 21:57:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:57:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:57:18 INFO - Running setup.py install for mozfile 21:57:18 INFO - Running setup.py install for mozhttpd 21:57:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozinfo 21:57:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozInstall 21:57:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozleak 21:57:19 INFO - Running setup.py install for mozlog 21:57:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for moznetwork 21:57:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozprocess 21:57:19 INFO - Running setup.py install for mozprofile 21:57:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozrunner 21:57:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:57:19 INFO - Running setup.py install for mozscreenshot 21:57:19 INFO - Running setup.py install for moztest 21:57:20 INFO - Running setup.py install for mozversion 21:57:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:57:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:57:20 INFO - Cleaning up... 21:57:20 INFO - Return code: 0 21:57:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57: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')]} 21:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57: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 21:57: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 21:57:20 INFO - Using env: {'DISPLAY': ':0', 21:57:20 INFO - 'HOME': '/home/cltbld', 21:57:20 INFO - 'LANG': 'en_US.UTF-8', 21:57:20 INFO - 'LANGUAGE': 'en_US:en', 21:57:20 INFO - 'LOGNAME': 'cltbld', 21:57:20 INFO - 'MAIL': '/var/mail/cltbld', 21:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:20 INFO - 'MOZ_NO_REMOTE': '1', 21:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:20 INFO - 'NO_EM_RESTART': '1', 21:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:20 INFO - 'SHELL': '/bin/bash', 21:57:20 INFO - 'SHLVL': '1', 21:57:20 INFO - 'TERM': 'linux', 21:57:20 INFO - 'TMOUT': '86400', 21:57:20 INFO - 'USER': 'cltbld', 21:57:20 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:20 INFO - '_': '/tools/buildbot/bin/python'} 21:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:20 INFO - Running setup.py (path:/tmp/pip-4jdATX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57: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)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:20 INFO - Running setup.py (path:/tmp/pip-bIJk3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57: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)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:20 INFO - Running setup.py (path:/tmp/pip-e5QWWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57: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)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:20 INFO - Running setup.py (path:/tmp/pip-l7ifVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:20 INFO - Running setup.py (path:/tmp/pip-zGSXDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:20 INFO - Running setup.py (path:/tmp/pip-vvtpTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:20 INFO - Running setup.py (path:/tmp/pip-gm03jQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:20 INFO - Running setup.py (path:/tmp/pip-6liWE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:57:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:20 INFO - Running setup.py (path:/tmp/pip-DoWhzH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:21 INFO - Running setup.py (path:/tmp/pip-d_XADL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:21 INFO - Running setup.py (path:/tmp/pip-3oWoOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:21 INFO - Running setup.py (path:/tmp/pip-UvYrem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:21 INFO - Running setup.py (path:/tmp/pip-R1iUCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:21 INFO - Running setup.py (path:/tmp/pip-hSH6J3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:21 INFO - Running setup.py (path:/tmp/pip-60lwXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:21 INFO - Running setup.py (path:/tmp/pip-nKHbFB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57: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)) 21:57:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:21 INFO - Running setup.py (path:/tmp/pip-5ZZdhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57: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)) 21:57: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)) 21:57: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)) 21:57: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)) 21:57: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)) 21:57: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)) 21:57:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:57: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 21:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57: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 21:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:23 INFO - Downloading blessings-1.5.1.tar.gz 21:57: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 21:57:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:57:23 INFO - Installing collected packages: blessings 21:57:23 INFO - Running setup.py install for blessings 21:57:23 INFO - Successfully installed blessings 21:57:23 INFO - Cleaning up... 21:57:23 INFO - Return code: 0 21:57:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:57:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:23 INFO - Reading from file tmpfile_stdout 21:57:23 INFO - Current package versions: 21:57:23 INFO - argparse == 1.2.1 21:57:23 INFO - blessings == 1.5.1 21:57:23 INFO - blobuploader == 1.2.4 21:57:23 INFO - docopt == 0.6.1 21:57:23 INFO - manifestparser == 1.1 21:57:23 INFO - mozInstall == 1.12 21:57:23 INFO - mozcrash == 0.16 21:57:23 INFO - mozdebug == 0.1 21:57:23 INFO - mozdevice == 0.47 21:57:23 INFO - mozfile == 1.2 21:57:23 INFO - mozhttpd == 0.7 21:57:23 INFO - mozinfo == 0.9 21:57:23 INFO - mozleak == 0.1 21:57:23 INFO - mozlog == 3.0 21:57:23 INFO - moznetwork == 0.27 21:57:23 INFO - mozprocess == 0.22 21:57:23 INFO - mozprofile == 0.27 21:57:23 INFO - mozrunner == 6.11 21:57:23 INFO - mozscreenshot == 0.1 21:57:23 INFO - mozsystemmonitor == 0.0 21:57:23 INFO - moztest == 0.7 21:57:23 INFO - mozversion == 1.4 21:57:23 INFO - psutil == 3.1.1 21:57:23 INFO - requests == 1.2.3 21:57:23 INFO - wsgiref == 0.1.2 21:57:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23c338ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b716e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, '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': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:57:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:57:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:23 INFO - Using env: {'DISPLAY': ':0', 21:57:23 INFO - 'HOME': '/home/cltbld', 21:57:23 INFO - 'LANG': 'en_US.UTF-8', 21:57:23 INFO - 'LANGUAGE': 'en_US:en', 21:57:23 INFO - 'LOGNAME': 'cltbld', 21:57:23 INFO - 'MAIL': '/var/mail/cltbld', 21:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:23 INFO - 'MOZ_NO_REMOTE': '1', 21:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:23 INFO - 'NO_EM_RESTART': '1', 21:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:23 INFO - 'SHELL': '/bin/bash', 21:57:23 INFO - 'SHLVL': '1', 21:57:23 INFO - 'TERM': 'linux', 21:57:23 INFO - 'TMOUT': '86400', 21:57:23 INFO - 'USER': 'cltbld', 21:57:23 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:23 INFO - '_': '/tools/buildbot/bin/python'} 21:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:57:23 INFO - Cleaning up... 21:57:23 INFO - Return code: 0 21:57:23 INFO - Running post-action listener: _resource_record_post_action 21:57:23 INFO - Running post-action listener: _start_resource_monitoring 21:57:23 INFO - Starting resource monitoring. 21:57:23 INFO - ##### 21:57:23 INFO - ##### Running install step. 21:57:23 INFO - ##### 21:57:23 INFO - Running pre-action listener: _resource_record_pre_action 21:57:23 INFO - Running main action method: install 21:57:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:24 INFO - Reading from file tmpfile_stdout 21:57:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:24 INFO - Reading from file tmpfile_stdout 21:57:24 INFO - Output received: 21:57:24 INFO - Usage: mozinstall [options] installer 21:57:24 INFO - Options: 21:57:24 INFO - -h, --help show this help message and exit 21:57:24 INFO - -d DEST, --destination=DEST 21:57:24 INFO - Directory to install application into. [default: 21:57:24 INFO - "/builds/slave/test-pgo"] 21:57:24 INFO - --app=APP Application being installed. [default: firefox] 21:57:24 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57: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'] 21:57: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 21:57:38 INFO - Reading from file tmpfile_stdout 21:57:38 INFO - Output received: 21:57:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:38 INFO - Running post-action listener: _resource_record_post_action 21:57:38 INFO - ##### 21:57:38 INFO - ##### Running run-tests step. 21:57:38 INFO - ##### 21:57:38 INFO - Running pre-action listener: _resource_record_pre_action 21:57:38 INFO - Running main action method: run_tests 21:57:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:38 INFO - Python 2.7.3 21:57:38 INFO - Return code: 0 21:57:38 INFO - grabbing minidump binary from tooltool 21:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:38 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 0x2ba7a90>, '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 0x2bf9f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:57:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:57:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:38 INFO - Return code: 0 21:57:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:57:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 21:57:38 INFO - Using env: {'DISPLAY': ':0', 21:57:38 INFO - 'HOME': '/home/cltbld', 21:57:38 INFO - 'LANG': 'en_US.UTF-8', 21:57:38 INFO - 'LANGUAGE': 'en_US:en', 21:57:38 INFO - 'LOGNAME': 'cltbld', 21:57:38 INFO - 'MAIL': '/var/mail/cltbld', 21:57:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:38 INFO - 'MOZ_NO_REMOTE': '1', 21:57:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:38 INFO - 'NO_EM_RESTART': '1', 21:57:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:38 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:38 INFO - 'SHELL': '/bin/bash', 21:57:38 INFO - 'SHLVL': '1', 21:57:38 INFO - 'TERM': 'linux', 21:57:38 INFO - 'TMOUT': '86400', 21:57:38 INFO - 'USER': 'cltbld', 21:57:38 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447909244.529382-875045288', 21:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:38 INFO - '_': '/tools/buildbot/bin/python'} 21:57:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 21:57:38 INFO - mozversion INFO | application_buildid: 20151118203114 21:57:38 INFO - mozversion INFO | application_changeset: cae56980cbec07da0f7c28be592bff3461086520 21:57:38 INFO - mozversion INFO | application_display_name: Nightly 21:57:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:38 INFO - mozversion INFO | application_name: Firefox 21:57:38 INFO - mozversion INFO | application_remotingname: firefox 21:57:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:57:38 INFO - mozversion INFO | application_vendor: Mozilla 21:57:38 INFO - mozversion INFO | application_version: 45.0a1 21:57:38 INFO - mozversion INFO | platform_buildid: 20151118203114 21:57:38 INFO - mozversion INFO | platform_changeset: cae56980cbec07da0f7c28be592bff3461086520 21:57:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:57:38 INFO - mozversion INFO | platform_version: 45.0a1 21:57:38 INFO - 2015-11-18 21:57:38,932 DEBUG : using testdate: 1447912658 21:57:38 INFO - 2015-11-18 21:57:38,932 DEBUG : actual date: 1447912658 21:57:38 INFO - 2015-11-18 21:57:38,944 INFO : starting webserver on 'localhost:35010' 21:57:38 INFO - 2015-11-18 21:57:38,945 INFO : Starting test suite talos-linux64-ix-002 21:57:38 INFO - 2015-11-18 21:57:38,945 INFO : Starting test dromaeo_css 21:57:38 INFO - 2015-11-18 21:57:38,945 DEBUG : operating with platform_type : linux_ 21:57:38 INFO - 2015-11-18 21:57:38,946 INFO : Initialising browser for dromaeo_css test... 21:57:38 INFO - 2015-11-18 21:57:38,958 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaXavTy/profile http://localhost:35010/getInfo.html 21:57:43 INFO - 2015-11-18 21:57:43,787 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:57:43 INFO - 2015-11-18 21:57:43,787 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:57:43 INFO - 2015-11-18 21:57:43,787 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:57:43 INFO - 2015-11-18 21:57:43,787 DEBUG : BROWSER_OUTPUT: __metrics 21:57:43 INFO - 2015-11-18 21:57:43,948 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:45 INFO - 2015-11-18 21:57:45,127 INFO : Browser initialized. 21:57:45 INFO - 2015-11-18 21:57:45,127 INFO : Running cycle 1/1 for dromaeo_css test... 21:57:45 INFO - 2015-11-18 21:57:45,127 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaXavTy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:57:56 INFO - 2015-11-18 21:57:56,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 140226560 21:57:56 INFO - 2015-11-18 21:57:56,961 DEBUG : BROWSER_OUTPUT: 21:58:48 INFO - 2015-11-18 21:58:48,468 DEBUG : BROWSER_OUTPUT: 1447912728465 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:00:56 INFO - 2015-11-18 22:00:56,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35010/tests/dromaeo/cssquery-ext.html) 22:00:58 INFO - 2015-11-18 22:00:58,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 221790208 22:00:58 INFO - 2015-11-18 22:00:58,013 DEBUG : BROWSER_OUTPUT: 22:04:00 INFO - 2015-11-18 22:04:00,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-ext.html (next: http://localhost:35010/tests/dromaeo/cssquery-jquery.html) 22:04:00 INFO - 2015-11-18 22:04:00,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 216174592 22:04:00 INFO - 2015-11-18 22:04:00,953 DEBUG : BROWSER_OUTPUT: 22:07:02 INFO - 2015-11-18 22:07:02,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35010/tests/dromaeo/cssquery-mootools.html) 22:07:03 INFO - 2015-11-18 22:07:03,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 220585984 22:07:03 INFO - 2015-11-18 22:07:03,374 DEBUG : BROWSER_OUTPUT: 22:10:05 INFO - 2015-11-18 22:10:05,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35010/tests/dromaeo/cssquery-prototype.html) 22:10:05 INFO - 2015-11-18 22:10:05,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 200454144 22:10:05 INFO - 2015-11-18 22:10:05,877 DEBUG : BROWSER_OUTPUT: 22:13:08 INFO - 2015-11-18 22:13:08,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35010/tests/dromaeo/cssquery-yui.html) 22:13:08 INFO - 2015-11-18 22:13:08,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 203304960 22:13:08 INFO - 2015-11-18 22:13:08,899 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/dromaeo/cssquery-yui.html (next: http://localhost:35010/tests/dromaeo/cssquery-dojo.html) 22:16:11 INFO - 2015-11-18 22:16:11,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 285790208 22:16:11 INFO - 2015-11-18 22:16:11,527 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,528 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:16:11 INFO - 2015-11-18 22:16:11,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:16:11 INFO - 2015-11-18 22:16:11,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:16:11 INFO - 2015-11-18 22:16:11,528 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:16:11 INFO - 2015-11-18 22:16:11,528 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3208.165876872013;3248.058063161685;3264.314493956269;3293.3248684019763;3300.0429875336154;5378.924215156965;5434.918476222855;5500.559955203584;5504.64219825711;5520.475554822296;5437.211604317372;5469.206964990074;5507.5593952483805;5508.724563771805;5556.361018482876;4999.225120106371;5009.649324547283;5087.058894104603;5169.741512924357;5196.454372290893;5145.434002259748;5167.044096842096;5200.21996700496;5205.947940520584;5206.869828254286;4945.381827271591;4948.282499037656;5049.798008079672;5054.090263752523;5063.772130254148;5030.496950304977;5102.030614183331;5102.974485127551;5111.897762044776;5149.098907691139;4846.975765121152;5030.421501527335;5087.720175390389;5096.362954630671;5099.388073431212;5243.842684719464;5268;5322.520973112439;5342.759575819097;5362;5967.224260846106;6010.75956961721;6022.728977195993;6026.54800889935;6027.246594175728;5798.362180160179;6004.549658775566;6042.486388656969;6048.364921683204;6054.061620448838;5496.477834605706;5541.639793413416;5567.192757050246;5630.746616402272;5675.063614503602;5946.226990491295;5970.253718285215;5974.731137098841;5989.940100598938;6035.366286539938;5800.796972105956;5804.88390232193;5805.796797112081;5841.094630332305;5858.765649373977;5873.530117590582;5940.673262970492;6079.452849243501;6080.2399700037495;6096.055111457731;6031.698415079229;6051.788187413507;6053.364396738279;6058.818235452944;6061.484773794189;5812.88374232513;5948.226730525091;6032.939670603326;6049.364816694184;6050.818475445743;4441.378207051015;4477.686561940698;4486.551344865553;4492.326151077365;4512.390827238347;4107.938380924288;4113.095119073799;4121.093359460914;4126.958730412717;4134.193832202752;5619.072852979212;5686.317641882918;5732.856678582985;5737.110747834093;5756.1653560233535;5887.970560147171;5969.134475501028;5980.162777211194;5990.341062483123;6035.909461358083;5634.859128521738;5637.408072152447;5642.520385767174;5660.490555849993;5685.431456854364;4892.730899800474;4901.705897646153;4984.028114517707;5033.748312584356;5034.270030845507;6106.429470938715;6159.1069294951985;6173.382661733791;6173.9073913891325;6178.474829639441;6010.248718910137;6013.789517366871;6027.60820546663;6060.757569697339;6073.331933487225;6038.456538911519;6104.664198625831;6127.816165515042;6169.074638804215;6189.35011823752;6008.24896887889;6009.7295621698;6010.038393856962;6011.819645410645;6019.6990150493175;6091.908621370594;6091.939080609137;6098.512119030378;6100.054491553638;6103.938960610337;5562.332520097452;5709.942900570941;5722.62802917809;5901.380355062828;5940.287165540163;5832.3292821326095;5886.499647530008;5902.61632993854;5904.557158213065;5905.143754155538;5761.740721667451;5790.884182316414;5804.361520232856;5809.796657116981;5822.854428639318;5610.663360198401;5732.398098199796;5758.856028599319;5771.451712087345;5873.442023007808;5602.243697100839;5602.4957753802355;5602.691851948182;5645.774169033357;5760.423957604206 22:16:11 INFO - 2015-11-18 22:16:11,529 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.1843739293274;579.6493121661395;583.2010146099842;593.6378808926554;597.1252115650572;32335.67664323356;33109.834450827744;33153.668463315356;40768.59231407685;41350.37974430386;43990;44522;44570.33144502835;44626;44626.107477850426;8751.606177722002;8939.64241430342;8941.418807777474;8941.418807777507;8943.686970956018;7751.496152750054;7920.524768513878;8728.738137855875;10291.331063480888;10510.947445262802;10182;10270.435126068063;10276.53755580997;10276.948615256913;10279.794404111914;10017.549210285519;10185.38887666735;10188.541515631778;10195.79608407835;10203.846942295871;7731.845363092762;7934.841303173905;10289.948550257275;10493;10506.684799455952;37377;37666.24667506662;37774.24451510982;37779;37842.43236351457;3247.3667634811222;3247.9350412991607;3306.404847127516;3635.4728564358284;3820.789856557888;29938.85030574855;29968.550471742943;30390.936317228792;30783.384332313228;30861.228469288224;3552.1652411683235;3567.161716996504;3601.7478776485655;3637.6726094651344;3644.5808731995894;277339;279248;279579.99999999796;280410;280651;51021.48978510167;60839.69580152159;61240.56974017664;61241.38758612357;61283.387166127766;54166.45833541693;71077;72522;72547.27452725405;72574;14940.252987350588;15085.698286034218;15174.393024278905;15210;15327;11274.887251127548;11384.089272858151;11507.88492115085;11597.014253788522;11622.128340374506;20194.899025505074;20241.493962651053;20267.594648106955;20480.487987800127;20504.69242961357;7876.448648594658;8115.75652730419;8128.878066829002;8151.470154440061;8270.172982701682;986.9358491698017;987.5802783816849;997.1324947295899;1024.8411496218098;1063.5107850388754;28221.858890705826;28798.460378556174;28874.711252887624;28912;29354.706452935196;1027.337367398039;1043.1550444140119;1074.8119079161115;1077.5959015369237;1146.2091157101572;15005.69988600222;15040.398384064734;15264.618384540254;15365.692686146214;15399.769003464957;314330;318656;319583;319632;320110;52524;52592.47407525876;52694.209586856225;52797.7360113197;53000.73499632477;1294.2364005236955;1325.8143859859626;1359.2659963619535;1362.5980335800962;1368.753624347607;27134.321641959108;28399.020930116058;28453.43093138167;28457.573136403385;28565.14304570866;45751.542484574726;46043.539564603925;46057.07885842198;46102.53897460982;46163.538364615924;300939;304578;304888;305945;307639;27901.720982790725;31265.68734312628;31741.889033883705;32009.519857202627;32222.83888580542;40335.79832100821;41223;41321.79339103285;41444.378334325615;41898.58101418947;35011.47482787709;35071.87551171231;35605;35819.82090089533;35976.64023359733;29177.062314245137;35656.4651530222;35844;36319.27361452809;37672.43491347687;34118.14704632305;34893;35118.29763404666;35185.47221791726;35222.47166292457;30319;32245.838770805996;32683.673163268064;32688.50967235446;32914;24958.251252462454;25018.874905625355;25426.65598264035;25536.10623628164;25698.35754106162 22:16:11 INFO - 2015-11-18 22:16:11,529 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.3103909454753;359.19540229885064;365.24212259561415;366.19985332049464;366.43751840924176;14265.786013209785;14287.285635718199;16572.502824915256;17291.39480118196;18032.098395080244;11555.30668159911;11765.588204412847;16539;16962.236699348527;16977.15114244286;4522.163399771036;4626;4626.05165940983;4628.352030715702;4633.096546173498;3583.964160358389;3685.0418891088375;4567.200739870526;4603.171429142753;4970.453250142499;5000.924986125193;5006.3241462402475;5030.044291584605;5045.293658887758;5048.242763585455;4894.388201474816;4975.601951843843;5010.974945125269;5013.298138260629;5020.221865610836;4305.13897220554;4337.761423121727;4347.369631403429;4347.413099231595;4347.630451411634;13558.864411355858;13730.65673358164;13732.382042808098;13737.107088039245;13882.4447022119;2024.736784218057;2044.5399785048394;2080.906359213839;2152.257471172443;2273.829462790281;9850.90149098507;9969.40183588987;9993.100620944077;10055.899441005642;10185.388876667424;1727.2486468386292;1735.245168351771;1735.947921562355;1744.7644567983286;1770.9380171694058;53650.73174634141;53944;54219.72890135524;54576.45423545753;59469.107963380586;6844.28135045823;7003.719851205997;7021.824454388579;7060.0468936693915;7068.0811494506415;8450.577471126418;8451.154884511623;8452.197041281068;8452.78868028292;8468.40721149526;5573.832785016456;5576.10782274834;5576.275084239023;5598.832035038955;5601.29983752031;5720.570957178228;5753.88492230153;5780.653160810365;5788.044972579477;5795.130730390475;3295.950560741591;3334.216459132102;3336.199312165063;3350.6816852398983;3357.1439282982683;1114.9665510034713;1159.4956194055612;1162.0935670177275;1178.648596050884;1214.2775048845922;445.10533827007947;464.2201102148356;468.32327287070535;474.4591166070682;509.1039770004744;11619.302841829349;11902.107341949215;12105.394730263451;12141.939290303491;12228.082893783001;455.6969615205851;476.3022172517279;498.5637567128762;515.7008934817796;516;5755.827325180251;6371.872562548723;6592.80221593353;6839.589624622439;6869.587824730532;558399;560294;569790;572225;599081;72764.63617681984;75057.62471187719;75934.62032689912;76079.61960190164;77563.61218193985;555.097965805566;565.5842955427757;569.1803802524435;571.5627544928134;572.6649909802728;11190.608328708457;11308.660740177807;11536.538538458703;11608.6517404478;11630.592929247436;34016;34406.483902740976;34900;35543;35582.644173557936;46317.768411157725;46319.53680463152;47763.28355074607;47985.28022079602;48252.758736206095;6794.082798822294;6901.620410877249;6923.134608173978;6925.480588955949;6927.965360173167;11968.401579920795;12113.212641178296;12214.633560993185;12242.265464071828;12486.750264994831;10856.348619082564;10864.402457864577;10957.50691218913;11104.888951110386;11227.66317010491;10514.894851051391;10864.837027444437;10875;10925.453727313761;11131.83302250483;10852.45737713127;10996.890031099907;11060.557577696802;11159.051480624237;11164.385958772345;6707.865842683216;6749.696263668048;6785.219699734594;6801.387875091265;6804.6257455840405;10729.46352682347;10754.569817207537;10924.563017479211;11009.779804403706;11041.613543525938 22:16:11 INFO - 2015-11-18 22:16:11,532 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1351.3513513513508;1528.0831501099337;1549.9925048718335;1711.7432385142226;1821.0985562146748;6913.585184888911;7549.886751698729;7783.64973576189;7808.336291415237;7816.8827467588035;7610.961945190266;7630.618469076552;7697.499662521932;7707.267809558097;7713.5757533335645;1981.4154824326786;2022.130483891926;2250.1224522436264;2278.692376529164;2290.919817806373;2254.0420321363436;2263.0608297556496;2265.818734501236;2267.682524446579;2267.716535433071;2203.460152262698;2287.0965968442456;2287.645414960675;2291.0950174680993;2291.4385975436044;2022.5145964968376;2070.171931227506;2245.708057952464;2283.0639437830578;2289.5764283607587;2261.479859632277;2279.430142464384;2283.7830406111393;2304.481491664379;2308.7344955330186;7869.409794265396;7870.606469676493;7895;7902.644381002869;7930.048394192676;4683.250679891201;4792.904141917177;4800.423949126092;4805.135075686375;4809.78355973982;3174.8095114293214;3191.281961558654;3217.581714377116;3242.3515296940473;3286.8356582170795;1104.138771758022;1768.7258474936405;1788.4277031349973;1823.8996855173093;1909.1313452379272;10745.946270268676;10796.082333001705;10931.836022459669;10939.343639381583;10952.397618130999;4168.583141685807;4209.473815773028;4310.762908040025;4349.195398851222;4382.123575284956;8943.955280223558;8950.597223124845;8957.552122393985;8961.731148065568;8962.417442866323;4652.790624421909;4665.043666048452;4689.742064186435;4692.507286734912;4694.201985662446;4277.037666525007;4290.82836686529;4305.763183024964;4318.784060796947;4328.588784065509;3490.6334834842482;3512.051746028558;3512.332656795201;3538.752287339913;3548.7161027118286;1095.70963694621;1112.9054030407506;1113.660333598244;1114.7881902438673;1130.7286251299793;1307.8169056332122;1309.463120120746;1336.251699048536;1347.47448495087;1362.434589645286;6876.415504682158;7152.356287934007;7682.116556596063;7688.692452301845;7699.037620297463;676.4250387170865;679.9252082270946;684.3327755438407;690.1063123255396;690.4648897104784;5860.062390017662;5873.559483038789;5884.470397664145;5933.2880054393745;5934.376890426443;8942.955285223532;9087.22758565516;9162.67930622425;9253.814923701488;9279.396839205565;9169.541522923828;9180.724578262663;9181.632734690671;9262.351635385457;9267.165955064076;7225.89161162583;7304;7333.853322933512;7380.815479613053;7401.5189012714;7395.149557800706;7436.219196984239;7466.029416175862;7473.738419155304;7474.402047836269;8258.050324212792;8353.874691879748;8389.454685445426;8391.16088391156;8401.201885820838;7939.84120317602;8106.554139522147;8132.064812546633;8254.958725206336;8272.090070092405;6722.697478613572;7023.578585284695;7053.0830991970715;7074.398676112382;7104.857902842017;7680.6543705534505;7720.691172353043;7739.92260077392;7757.224277572198;7764.534127952115;7129.857402852018;7289.854202915806;7338.774982984512;7360.742374016883;7407.8148046299275;7108.182559005573;7162.212156662658;7197.280271972971;7245.927540724525;7292.197858235484;6344.175257216532;6667.966660166668;6956.130483689539;7263.237360077116;7263.382612477999;6634.170728658918;6667.599944003376;6674.499412543982;6700.3969642730435;6708.26209116987;6593.604383736991;6610.338966103352;6646.8005959821285;6702.865942681022;6704.932950670626 22:16:11 INFO - 2015-11-18 22:16:11,532 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.3306089047898;337.83952622504313;343.08054414170044;347.87302634538383;350.1578703218758;5959.195508606343;6063.848403789907;6120.326764055951;6178.783742569011;6181.412765787254;5759.712014399284;5901.616394934326;5923.437273459014;6028.788992385267;6037.909431358522;4554.726716397018;4664.416947881515;4680;4691.319758635013;4692.06158768246;4648.325992731052;4671.065786842645;4677.4620918594455;4679.204535229002;4679.485256621786;4399.846005389812;4466.486354069291;4514.938989337503;4595.264757638778;4620.468646105691;4625.838095666652;4632.976835115836;4646.790894409726;4651.953480465186;4653.767311634405;4085.6935729820384;4088.897777555555;4089.407035979766;4092.1406504634065;4102;5679.176519404705;5680.8863822723315;5683.857903552444;5685.829425117253;5686.829395118153;5301.602379821529;5382.650127741724;5415.350157981028;5417.810376636839;5420.214068960018;6367.395097465734;6413.486921046305;6413.583117097421;6416.427975146119;6422.325655806167;4535.637149028103;4544.363789069533;4544.409226800528;4545.431821022372;4548.226801443762;6519.315471875432;6668.466522678223;6676.666166691646;6682.431993280626;6683.832904177386;4632.25883858581;4659.44086709597;4663.253879379283;4664.883377915511;4665.2302370108555;4711.575958163782;4716.127516409475;4724.244120940633;4727.314539391838;4729.314249433882;5391.110466773017;5400.973814975142;5410.594205434608;5414.160805075219;5417.187421886749;6316.747330106744;6468.3855033771715;6468.611883287018;6472.417482426604;6483.805485835433;1648.1841488463288;1668.2826384654472;1668.7580300856307;1669.7328427451791;1670.983290167107;1124.4434005167332;1124.6063877642923;1125.870524889648;1144.8168293073068;1151.6545036489188;6253;6256.530760192913;6261.342559031327;6261.812145635638;6267.905981410283;6628.701708423133;6646.335366463411;6655.73377064912;6655.900161497581;6656.567323124078;6063.8484037898525;6163.260408750979;6215.440610345091;6248.968755156195;6254.21822272216;3612.7651702639246;3637.5998640149564;3643.2349206666368;3644.890653280406;3655.6161603031833;6810.62541560219;6860.862782744417;6875.518713689994;6893.724251029903;6903.792886213421;6696.330366963265;6875.621840798804;6887.965560172167;6933.375996160269;6939.895901561481;6932.688029038705;6935.965320173367;6942.340477654615;6945.687444065029;6950.652467376611;6727.93272067273;6745.5952642841585;6754.831129221809;6754.898676519954;6760.121184246016;6507.414332710079;6638.90041649366;6656.600603963778;6658.300878407891;6681.231658359351;6870.828229294308;6877.3810357068105;6881.931180688129;6884.793456196322;6889.621070841152;4540.432445944257;4562.247229207143;4588.908221835612;4591.311303304531;4592.586667199968;6394.904076438764;6565.770198043046;6581.605103693793;6676.566023208476;6712.127423434922;6440.9033864493;6527.086207930988;6527.379898909596;6531.967340163269;6539.149910511603;6528.575642583217;6529.608223506605;6534.117894084237;6534.346565343428;6541.771038013647;6254.687265636791;6437.163168788027;6438.259600145856;6438.3883531064475;6446.871062578816;6567.9671601641685;6581.3747693969;6592.17597800275;6592.24189218246;6596.373344532261;6415.230172379344;6425.228972523327;6427.357264273723;6428.550001500037;6429.32492088324 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: |5;yui.html;862.2584577263552;867.9479231246125;874.7987962768563;895.9328050396219;899.4827973914993;14107.576772696822;14420.351084201237;14421.92789036056;14442.061266017701;14475;13402.195868247913;13527.526536571197;13527.864721352784;13540.119892207;13541.93229033856;688.3632639808183;702.034702284359;819.045811629451;831.6382373667444;834.090840983328;827.9130691277419;838.1074156023815;839.8446287436843;839.8866153069349;840.470503582742;874.8818909447239;878.9472631642122;879.0286733159862;879.3229213505597;879.5162660536711;713.0730050933792;727.1637616740737;854.9102344253888;872.0930232558195;873.10506730601;628.4406877878691;629.3674856768964;635.2218532297944;635.3075148088606;635.3455940381415;11990.880091199151;12238.571649992296;12297.69255768604;12298.262104273772;12308.26150430977;10197.337173083726;10223.335483193569;10348.79302413955;10406.791864162675;10855.294405863593;9740.025997400275;9958.452285124315;9979.30144889858;10174.186065114773;10988.670339889815;3142.4186525492855;3182.2839861031316;3230.644629090798;3231.1922019495128;3239.5950506186728;45219.321710174045;45562;45602.31596526055;45895;45918.540814592096;7479.476436649491;8083.7170699025255;8112.148224436467;8146.2261085196815;8174.019117705913;12450;12452.626421207378;12454.065945054157;12467.251964882136;12545.31000794965;6569.178852643419;6790.660466976631;6931.445484361239;7037.085178926707;7157.964210178916;4277;4313.460817397825;4321.978390108092;4372.584604462634;4512.2329204035395;2797.8740956656998;2824.661040675091;2831.631887854566;2831.631887854566;2833.744962953344;505.6435213174703;518.4841083122318;519.9090159222121;528.7171363320605;529.282821776495;622.7726879688881;643.9871202576016;698.5459451356659;701.0990876723386;712.3695529456364;8643.178898004806;8643.827123457495;8651.307895368356;8814.955925220333;8844.601992910335;524.8241838983984;579.4697851465861;670.8160097428043;680.9148856392951;693.2651389527117;3758.8872333830027;3909.7458665186673;3933.567307596162;3963.128111815396;3983.701222408331;59679.70160149172;59721;60104;60127.39872601218;60176.39823601796;51565.484345156816;52025.73987130116;52260.21609675858;52917.470825292025;53133;46224.07551849011;46798.298025528966;46967;47005.29492057622;48460.5153948456;7857.4499785014505;7986.8801967971685;7994.2805147537;8045.195480451908;8219.219174178443;34694.82652586721;35614;35981.820090899375;36037.81981090078;36163.81918090498;42584.5741542593;42661;45907.54092459166;46609.53390466052;47057.76471117623;7504.272308445645;7657.9617101916365;7751.41864360164;7800.882986755089;8012.559309238048;12341.568045118378;12435;12642.683932901384;12766.234025958473;12822;11505.942470287595;11938.383818293727;12226.410566626282;12347.13570050088;12615.116941814353;11353.82928895331;11787.882121179022;11857.940710296394;11951.641450756491;12224.87775122273;11726.355050472306;12160.331181784733;12181.634550963485;12531.812022819848;12548.30984295836;9936.552855121392;10060.69817905464;10293.691189264335;10460.020546823564;10870.293430926964;9528.333016688764;9631.43357785627;9924.206063514757;10515.421651809223;10570.365778053034 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913771521__endTimestamp 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5532.28 Median:5737.11 stddev:636.12 (11.1%) stddev-sans-first:611.39 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: Values: 3208.2 3248.1 3264.3 3293.3 3300.0 5378.9 5434.9 5500.6 5504.6 5520.5 5437.2 5469.2 5507.6 5508.7 5556.4 4999.2 5009.6 5087.1 5169.7 5196.5 5145.4 5167.0 5200.2 5205.9 5206.9 4945.4 4948.3 5049.8 5054.1 5063.8 5030.5 5102.0 5103.0 5111.9 5149.1 4847.0 5030.4 5087.7 5096.4 5099.4 5243.8 5268.0 5322.5 5342.8 5362.0 5967.2 6010.8 6022.7 6026.5 6027.2 5798.4 6004.5 6042.5 6048.4 6054.1 5496.5 5541.6 5567.2 5630.7 5675.1 5946.2 5970.3 5974.7 5989.9 6035.4 5800.8 5804.9 5805.8 5841.1 5858.8 5873.5 5940.7 6079.5 6080.2 6096.1 6031.7 6051.8 6053.4 6058.8 6061.5 5812.9 5948.2 6032.9 6049.4 6050.8 4441.4 4477.7 4486.6 4492.3 4512.4 4107.9 4113.1 4121.1 4127.0 4134.2 5619.1 5686.3 5732.9 5737.1 5756.2 5888.0 5969.1 5980.2 5990.3 6035.9 5634.9 5637.4 5642.5 5660.5 5685.4 4892.7 4901.7 4984.0 5033.7 5034.3 6106.4 6159.1 6173.4 6173.9 6178.5 6010.2 6013.8 6027.6 6060.8 6073.3 6038.5 6104.7 6127.8 6169.1 6189.4 6008.2 6009.7 6010.0 6011.8 6019.7 6091.9 6091.9 6098.5 6100.1 6103.9 5562.3 5709.9 5722.6 5901.4 5940.3 5832.3 5886.5 5902.6 5904.6 5905.1 5761.7 5790.9 5804.4 5809.8 5822.9 5610.7 5732.4 5758.9 5771.5 5873.4 5602.2 5602.5 5602.7 5645.8 5760.4 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,535 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47196.71 Median:17791.52 stddev:78796.76 (442.9%) stddev-sans-first:78939.96 22:16:11 INFO - 2015-11-18 22:16:11,536 DEBUG : BROWSER_OUTPUT: Values: 548.2 579.6 583.2 593.6 597.1 32335.7 33109.8 33153.7 40768.6 41350.4 43990.0 44522.0 44570.3 44626.0 44626.1 8751.6 8939.6 8941.4 8941.4 8943.7 7751.5 7920.5 8728.7 10291.3 10510.9 10182.0 10270.4 10276.5 10276.9 10279.8 10017.5 10185.4 10188.5 10195.8 10203.8 7731.8 7934.8 10289.9 10493.0 10506.7 37377.0 37666.2 37774.2 37779.0 37842.4 3247.4 3247.9 3306.4 3635.5 3820.8 29938.9 29968.6 30390.9 30783.4 30861.2 3552.2 3567.2 3601.7 3637.7 3644.6 277339.0 279248.0 279580.0 280410.0 280651.0 51021.5 60839.7 61240.6 61241.4 61283.4 54166.5 71077.0 72522.0 72547.3 72574.0 14940.3 15085.7 15174.4 15210.0 15327.0 11274.9 11384.1 11507.9 11597.0 11622.1 20194.9 20241.5 20267.6 20480.5 20504.7 7876.4 8115.8 8128.9 8151.5 8270.2 986.9 987.6 997.1 1024.8 1063.5 28221.9 28798.5 28874.7 28912.0 29354.7 1027.3 1043.2 1074.8 1077.6 1146.2 15005.7 15040.4 15264.6 15365.7 15399.8 314330.0 318656.0 319583.0 319632.0 320110.0 52524.0 52592.5 52694.2 52797.7 53000.7 1294.2 1325.8 1359.3 1362.6 1368.8 27134.3 28399.0 28453.4 28457.6 28565.1 45751.5 46043.5 46057.1 46102.5 46163.5 300939.0 304578.0 304888.0 305945.0 307639.0 27901.7 31265.7 31741.9 32009.5 32222.8 40335.8 41223.0 41321.8 41444.4 41898.6 35011.5 35071.9 35605.0 35819.8 35976.6 29177.1 35656.5 35844.0 36319.3 37672.4 34118.1 34893.0 35118.3 35185.5 35222.5 30319.0 32245.8 32683.7 32688.5 32914.0 24958.3 25018.9 25426.7 25536.1 25698.4 22:16:11 INFO - 2015-11-18 22:16:11,536 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,536 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27759.02 Median:2488.93 stddev:93644.81 (3762.5%) stddev-sans-first:93884.90 22:16:11 INFO - 2015-11-18 22:16:11,536 DEBUG : BROWSER_OUTPUT: Values: 357.3 359.2 365.2 366.2 366.4 14265.8 14287.3 16572.5 17291.4 18032.1 11555.3 11765.6 16539.0 16962.2 16977.2 4522.2 4626.0 4626.1 4628.4 4633.1 3584.0 3685.0 4567.2 4603.2 4970.5 5000.9 5006.3 5030.0 5045.3 5048.2 4894.4 4975.6 5011.0 5013.3 5020.2 4305.1 4337.8 4347.4 4347.4 4347.6 13558.9 13730.7 13732.4 13737.1 13882.4 2024.7 2044.5 2080.9 2152.3 2273.8 9850.9 9969.4 9993.1 10055.9 10185.4 1727.2 1735.2 1735.9 1744.8 1770.9 53650.7 53944.0 54219.7 54576.5 59469.1 6844.3 7003.7 7021.8 7060.0 7068.1 8450.6 8451.2 8452.2 8452.8 8468.4 5573.8 5576.1 5576.3 5598.8 5601.3 5720.6 5753.9 5780.7 5788.0 5795.1 3296.0 3334.2 3336.2 3350.7 3357.1 1115.0 1159.5 1162.1 1178.6 1214.3 445.1 464.2 468.3 474.5 509.1 11619.3 11902.1 12105.4 12141.9 12228.1 455.7 476.3 498.6 515.7 516.0 5755.8 6371.9 6592.8 6839.6 6869.6 558399.0 560294.0 569790.0 572225.0 599081.0 72764.6 75057.6 75934.6 76079.6 77563.6 555.1 565.6 569.2 571.6 572.7 11190.6 11308.7 11536.5 11608.7 11630.6 34016.0 34406.5 34900.0 35543.0 35582.6 46317.8 46319.5 47763.3 47985.3 48252.8 6794.1 6901.6 6923.1 6925.5 6928.0 11968.4 12113.2 12214.6 12242.3 12486.8 10856.3 10864.4 10957.5 11104.9 11227.7 10514.9 10864.8 10875.0 10925.5 11131.8 10852.5 10996.9 11060.6 11159.1 11164.4 6707.9 6749.7 6785.2 6801.4 6804.6 10729.5 10754.6 10924.6 11009.8 11041.6 22:16:11 INFO - 2015-11-18 22:16:11,536 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,537 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5492.89 Median:6667.78 stddev:2814.72 (42.2%) stddev-sans-first:2805.40 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: Values: 1351.4 1528.1 1550.0 1711.7 1821.1 6913.6 7549.9 7783.6 7808.3 7816.9 7611.0 7630.6 7697.5 7707.3 7713.6 1981.4 2022.1 2250.1 2278.7 2290.9 2254.0 2263.1 2265.8 2267.7 2267.7 2203.5 2287.1 2287.6 2291.1 2291.4 2022.5 2070.2 2245.7 2283.1 2289.6 2261.5 2279.4 2283.8 2304.5 2308.7 7869.4 7870.6 7895.0 7902.6 7930.0 4683.3 4792.9 4800.4 4805.1 4809.8 3174.8 3191.3 3217.6 3242.4 3286.8 1104.1 1768.7 1788.4 1823.9 1909.1 10745.9 10796.1 10931.8 10939.3 10952.4 4168.6 4209.5 4310.8 4349.2 4382.1 8944.0 8950.6 8957.6 8961.7 8962.4 4652.8 4665.0 4689.7 4692.5 4694.2 4277.0 4290.8 4305.8 4318.8 4328.6 3490.6 3512.1 3512.3 3538.8 3548.7 1095.7 1112.9 1113.7 1114.8 1130.7 1307.8 1309.5 1336.3 1347.5 1362.4 6876.4 7152.4 7682.1 7688.7 7699.0 676.4 679.9 684.3 690.1 690.5 5860.1 5873.6 5884.5 5933.3 5934.4 8943.0 9087.2 9162.7 9253.8 9279.4 9169.5 9180.7 9181.6 9262.4 9267.2 7225.9 7304.0 7333.9 7380.8 7401.5 7395.1 7436.2 7466.0 7473.7 7474.4 8258.1 8353.9 8389.5 8391.2 8401.2 7939.8 8106.6 8132.1 8255.0 8272.1 6722.7 7023.6 7053.1 7074.4 7104.9 7680.7 7720.7 7739.9 7757.2 7764.5 7129.9 7289.9 7338.8 7360.7 7407.8 7108.2 7162.2 7197.3 7245.9 7292.2 6344.2 6668.0 6956.1 7263.2 7263.4 6634.2 6667.6 6674.5 6700.4 6708.3 6593.6 6610.3 6646.8 6702.9 6704.9 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5415.05 Median:6180.10 stddev:1624.74 (26.3%) stddev-sans-first:1583.79 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: Values: 327.3 337.8 343.1 347.9 350.2 5959.2 6063.8 6120.3 6178.8 6181.4 5759.7 5901.6 5923.4 6028.8 6037.9 4554.7 4664.4 4680.0 4691.3 4692.1 4648.3 4671.1 4677.5 4679.2 4679.5 4399.8 4466.5 4514.9 4595.3 4620.5 4625.8 4633.0 4646.8 4652.0 4653.8 4085.7 4088.9 4089.4 4092.1 4102.0 5679.2 5680.9 5683.9 5685.8 5686.8 5301.6 5382.7 5415.4 5417.8 5420.2 6367.4 6413.5 6413.6 6416.4 6422.3 4535.6 4544.4 4544.4 4545.4 4548.2 6519.3 6668.5 6676.7 6682.4 6683.8 4632.3 4659.4 4663.3 4664.9 4665.2 4711.6 4716.1 4724.2 4727.3 4729.3 5391.1 5401.0 5410.6 5414.2 5417.2 6316.7 6468.4 6468.6 6472.4 6483.8 1648.2 1668.3 1668.8 1669.7 1671.0 1124.4 1124.6 1125.9 1144.8 1151.7 6253.0 6256.5 6261.3 6261.8 6267.9 6628.7 6646.3 6655.7 6655.9 6656.6 6063.8 6163.3 6215.4 6249.0 6254.2 3612.8 3637.6 3643.2 3644.9 3655.6 6810.6 6860.9 6875.5 6893.7 6903.8 6696.3 6875.6 6888.0 6933.4 6939.9 6932.7 6936.0 6942.3 6945.7 6950.7 6727.9 6745.6 6754.8 6754.9 6760.1 6507.4 6638.9 6656.6 6658.3 6681.2 6870.8 6877.4 6881.9 6884.8 6889.6 4540.4 4562.2 4588.9 4591.3 4592.6 6394.9 6565.8 6581.6 6676.6 6712.1 6440.9 6527.1 6527.4 6532.0 6539.1 6528.6 6529.6 6534.1 6534.3 6541.8 6254.7 6437.2 6438.3 6438.4 6446.9 6568.0 6581.4 6592.2 6592.2 6596.4 6415.2 6425.2 6427.4 6428.6 6429.3 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: 22:16:11 INFO - 2015-11-18 22:16:11,538 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13565.57 Median:47031.53 stddev:16199.82 (34.4%) stddev-sans-first:16217.18 22:16:11 INFO - 2015-11-18 22:16:11,540 DEBUG : BROWSER_OUTPUT: Values: 862.3 867.9 874.8 895.9 899.5 14107.6 14420.4 14421.9 14442.1 14475.0 13402.2 13527.5 13527.9 13540.1 13541.9 688.4 702.0 819.0 831.6 834.1 827.9 838.1 839.8 839.9 840.5 874.9 878.9 879.0 879.3 879.5 713.1 727.2 854.9 872.1 873.1 628.4 629.4 635.2 635.3 635.3 11990.9 12238.6 12297.7 12298.3 12308.3 10197.3 10223.3 10348.8 10406.8 10855.3 9740.0 9958.5 9979.3 10174.2 10988.7 3142.4 3182.3 3230.6 3231.2 3239.6 45219.3 45562.0 45602.3 45895.0 45918.5 7479.5 8083.7 8112.1 8146.2 8174.0 12450.0 12452.6 12454.1 12467.3 12545.3 6569.2 6790.7 6931.4 7037.1 7158.0 4277.0 4313.5 4322.0 4372.6 4512.2 2797.9 2824.7 2831.6 2831.6 2833.7 505.6 518.5 519.9 528.7 529.3 622.8 644.0 698.5 701.1 712.4 8643.2 8643.8 8651.3 8815.0 8844.6 524.8 579.5 670.8 680.9 693.3 3758.9 3909.7 3933.6 3963.1 3983.7 59679.7 59721.0 60104.0 60127.4 60176.4 51565.5 52025.7 52260.2 52917.5 53133.0 46224.1 46798.3 46967.0 47005.3 48460.5 7857.4 7986.9 7994.3 8045.2 8219.2 34694.8 35614.0 35981.8 36037.8 36163.8 42584.6 42661.0 45907.5 46609.5 47057.8 7504.3 7658.0 7751.4 7800.9 8012.6 12341.6 12435.0 12642.7 12766.2 12822.0 11505.9 11938.4 12226.4 12347.1 12615.1 11353.8 11787.9 11857.9 11951.6 12224.9 11726.4 12160.3 12181.6 12531.8 12548.3 9936.6 10060.7 10293.7 10460.0 10870.3 9528.3 9631.4 9924.2 10515.4 10570.4 22:16:11 INFO - 2015-11-18 22:16:11,540 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:16:11 INFO - 2015-11-18 22:16:11,540 DEBUG : BROWSER_OUTPUT: 22:16:12 INFO - 2015-11-18 22:16:12,200 INFO : Browser exited with error code: 0 22:16:12 INFO - 2015-11-18 22:16:12,221 INFO : Completed test dromaeo_css (00:18:33) 22:16:12 INFO - 2015-11-18 22:16:12,221 INFO : Starting test kraken 22:16:12 INFO - 2015-11-18 22:16:12,221 DEBUG : operating with platform_type : linux_ 22:16:12 INFO - 2015-11-18 22:16:12,221 INFO : Initialising browser for kraken test... 22:16:12 INFO - 2015-11-18 22:16:12,227 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpst7uj5/profile http://localhost:35010/getInfo.html 22:16:16 INFO - 2015-11-18 22:16:16,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:16:16 INFO - 2015-11-18 22:16:16,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:16:16 INFO - 2015-11-18 22:16:16,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:16:16 INFO - 2015-11-18 22:16:16,065 DEBUG : BROWSER_OUTPUT: __metrics 22:16:16 INFO - 2015-11-18 22:16:16,130 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:16:17 INFO - 2015-11-18 22:16:17,446 INFO : Browser initialized. 22:16:17 INFO - 2015-11-18 22:16:17,447 INFO : Running cycle 1/1 for kraken test... 22:16:17 INFO - 2015-11-18 22:16:17,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpst7uj5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:16:29 INFO - 2015-11-18 22:16:29,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 22:16:29 INFO - 2015-11-18 22:16:29,250 DEBUG : BROWSER_OUTPUT: 22:16:31 INFO - 2015-11-18 22:16:31,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35010/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:32 INFO - 2015-11-18 22:16:32,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 180883456 22:16:32 INFO - 2015-11-18 22:16:32,296 DEBUG : BROWSER_OUTPUT: 22:16:34 INFO - 2015-11-18 22:16:34,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35010/tests/kraken/driver.html?testName=audio-dft) 22:16:35 INFO - 2015-11-18 22:16:35,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 169656320 22:16:35 INFO - 2015-11-18 22:16:35,470 DEBUG : BROWSER_OUTPUT: 22:16:38 INFO - 2015-11-18 22:16:38,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35010/tests/kraken/driver.html?testName=audio-fft) 22:16:38 INFO - 2015-11-18 22:16:38,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 151875584 22:16:38 INFO - 2015-11-18 22:16:38,948 DEBUG : BROWSER_OUTPUT: 22:16:40 INFO - 2015-11-18 22:16:40,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35010/tests/kraken/driver.html?testName=audio-oscillator) 22:16:41 INFO - 2015-11-18 22:16:41,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 154775552 22:16:41 INFO - 2015-11-18 22:16:41,505 DEBUG : BROWSER_OUTPUT: 22:16:43 INFO - 2015-11-18 22:16:43,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:44 INFO - 2015-11-18 22:16:44,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 156590080 22:16:44 INFO - 2015-11-18 22:16:44,261 DEBUG : BROWSER_OUTPUT: 22:16:47 INFO - 2015-11-18 22:16:47,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35010/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:47 INFO - 2015-11-18 22:16:47,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 157298688 22:16:47 INFO - 2015-11-18 22:16:47,704 DEBUG : BROWSER_OUTPUT: 22:16:51 INFO - 2015-11-18 22:16:51,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35010/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:51 INFO - 2015-11-18 22:16:51,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 156938240 22:16:51 INFO - 2015-11-18 22:16:51,637 DEBUG : BROWSER_OUTPUT: 22:16:54 INFO - 2015-11-18 22:16:54,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35010/tests/kraken/driver.html?testName=json-parse-financial) 22:16:54 INFO - 2015-11-18 22:16:54,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 156753920 22:16:54 INFO - 2015-11-18 22:16:54,959 DEBUG : BROWSER_OUTPUT: 22:16:56 INFO - 2015-11-18 22:16:56,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:57 INFO - 2015-11-18 22:16:57,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 168001536 22:16:57 INFO - 2015-11-18 22:16:57,073 DEBUG : BROWSER_OUTPUT: 22:16:58 INFO - 2015-11-18 22:16:58,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:59 INFO - 2015-11-18 22:16:59,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 167219200 22:16:59 INFO - 2015-11-18 22:16:59,436 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-18 22:17:01,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:02 INFO - 2015-11-18 22:17:02,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 172646400 22:17:02 INFO - 2015-11-18 22:17:02,089 DEBUG : BROWSER_OUTPUT: 22:17:04 INFO - 2015-11-18 22:17:04,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:17:05 INFO - 2015-11-18 22:17:05,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 181063680 22:17:05 INFO - 2015-11-18 22:17:05,097 DEBUG : BROWSER_OUTPUT: 22:17:07 INFO - 2015-11-18 22:17:07,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:08 INFO - 2015-11-18 22:17:08,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 179396608 22:17:08 INFO - 2015-11-18 22:17:08,301 DEBUG : BROWSER_OUTPUT: 22:17:09 INFO - 2015-11-18 22:17:09,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35010/tests/kraken/driver.html?testName=ai-astar) 22:17:10 INFO - 2015-11-18 22:17:10,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 238141440 22:17:10 INFO - 2015-11-18 22:17:10,240 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,240 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:10 INFO - 2015-11-18 22:17:10,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:10 INFO - 2015-11-18 22:17:10,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:10 INFO - 2015-11-18 22:17:10,241 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:10 INFO - 2015-11-18 22:17:10,241 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;112;110;109;118;110;110;109;108 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;154;166;130;154;154;125;166;126 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;161;159;162;160;163;162;163 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;91;72;72;71;93;93;72 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;137;90;91;92;136;91;90;135 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;109;109;110;110 22:17:10 INFO - 2015-11-18 22:17:10,242 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;144;145;145;145;145;146;145 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;58;58;57;57;66;56;55 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;69;68;68;69;68;69 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;84;85;85;86;93;85;84 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;130;121;116;134;119;121;126;126;125 22:17:10 INFO - 2015-11-18 22:17:10,243 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;146;151;156;156;141;152;155;153;163 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;66;66;71;66;67;67;66;67 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913830239__endTimestamp 22:17:10 INFO - 2015-11-18 22:17:10,244 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:3.51 (3.2%) stddev-sans-first:3.71 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 112.0 110.0 109.0 118.0 110.0 110.0 109.0 108.0 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.80 Median:154.00 stddev:16.89 (11.0%) stddev-sans-first:17.85 22:17:10 INFO - 2015-11-18 22:17:10,248 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 154.0 166.0 130.0 154.0 154.0 125.0 166.0 126.0 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 161.0 159.0 162.0 160.0 163.0 162.0 163.0 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:79.00 stddev:9.96 (12.6%) stddev-sans-first:10.20 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 91.0 72.0 72.0 71.0 93.0 93.0 72.0 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:90.50 stddev:21.82 (24.1%) stddev-sans-first:22.52 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 137.0 90.0 91.0 92.0 136.0 91.0 90.0 135.0 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 22:17:10 INFO - 2015-11-18 22:17:10,249 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 144.0 145.0 145.0 145.0 145.0 146.0 145.0 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:3.01 (5.3%) stddev-sans-first:3.18 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 58.0 58.0 57.0 57.0 66.0 56.0 55.0 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 69.0 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.96 (3.5%) stddev-sans-first:3.04 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 84.0 85.0 85.0 86.0 93.0 85.0 84.0 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,250 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.50 stddev:5.29 (4.2%) stddev-sans-first:5.61 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: Values: 125.0 130.0 121.0 116.0 134.0 119.0 121.0 126.0 126.0 125.0 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:154.00 stddev:6.67 (4.3%) stddev-sans-first:6.31 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: Values: 143.0 146.0 151.0 156.0 156.0 141.0 152.0 155.0 153.0 163.0 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.62 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 66.0 66.0 71.0 66.0 67.0 67.0 66.0 67.0 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:10 INFO - 2015-11-18 22:17:10,251 DEBUG : BROWSER_OUTPUT: 22:17:11 INFO - 2015-11-18 22:17:11,120 INFO : Browser exited with error code: 0 22:17:11 INFO - 2015-11-18 22:17:11,173 INFO : Completed test kraken (00:00:58) 22:17:11 INFO - 2015-11-18 22:17:11,173 INFO : Starting test v8_7 22:17:11 INFO - 2015-11-18 22:17:11,173 DEBUG : operating with platform_type : linux_ 22:17:11 INFO - 2015-11-18 22:17:11,173 INFO : Initialising browser for v8_7 test... 22:17:11 INFO - 2015-11-18 22:17:11,180 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUHeS2u/profile http://localhost:35010/getInfo.html 22:17:15 INFO - 2015-11-18 22:17:15,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:17:15 INFO - 2015-11-18 22:17:15,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:17:15 INFO - 2015-11-18 22:17:15,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:17:15 INFO - 2015-11-18 22:17:15,059 DEBUG : BROWSER_OUTPUT: __metrics 22:17:15 INFO - 2015-11-18 22:17:15,127 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:17:16 INFO - 2015-11-18 22:17:16,398 INFO : Browser initialized. 22:17:16 INFO - 2015-11-18 22:17:16,399 INFO : Running cycle 1/1 for v8_7 test... 22:17:16 INFO - 2015-11-18 22:17:16,399 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUHeS2u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:17:28 INFO - 2015-11-18 22:17:28,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 140394496 22:17:28 INFO - 2015-11-18 22:17:28,165 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35010/tests/v8_7/run.html (next: http://localhost:35010/tests/v8_7/run.html) 22:17:49 INFO - 2015-11-18 22:17:49,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 510484480 22:17:49 INFO - 2015-11-18 22:17:49,777 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,777 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:49 INFO - 2015-11-18 22:17:49,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:49 INFO - 2015-11-18 22:17:49,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |0;Richards;163.7465203864418 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.86398647379298 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 22:17:49 INFO - 2015-11-18 22:17:49,778 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 22:17:49 INFO - 2015-11-18 22:17:49,779 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 22:17:49 INFO - 2015-11-18 22:17:49,779 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 22:17:49 INFO - 2015-11-18 22:17:49,779 DEBUG : BROWSER_OUTPUT: |8;Splay;610.8735491753207 22:17:49 INFO - 2015-11-18 22:17:49,779 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 22:17:49 INFO - 2015-11-18 22:17:49,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: __startTimestamp1447913869776__endTimestamp 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,780 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.75 Median:163.75 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,781 DEBUG : BROWSER_OUTPUT: Values: 163.7 22:17:49 INFO - 2015-11-18 22:17:49,781 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,781 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.86 Median:187.86 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,781 DEBUG : BROWSER_OUTPUT: Values: 187.9 22:17:49 INFO - 2015-11-18 22:17:49,781 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: Values: 280.9 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: Values: 5025.1 22:17:49 INFO - 2015-11-18 22:17:49,783 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: Values: 1986.1 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: Values: 781.3 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,784 DEBUG : BROWSER_OUTPUT: Values: 12370.4 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: Values: 25897.4 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.87 Median:610.87 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: Values: 610.9 22:17:49 INFO - 2015-11-18 22:17:49,785 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-18 22:17:49,786 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 22:17:49 INFO - 2015-11-18 22:17:49,786 DEBUG : BROWSER_OUTPUT: Values: 4826.9 22:17:49 INFO - 2015-11-18 22:17:49,786 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:49 INFO - 2015-11-18 22:17:49,786 DEBUG : BROWSER_OUTPUT: 22:17:50 INFO - 2015-11-18 22:17:50,584 INFO : Browser exited with error code: 0 22:17:50 INFO - 2015-11-18 22:17:50,602 INFO : Completed test v8_7 (00:00:39) 22:17:50 INFO - 2015-11-18 22:17:50,849 INFO : Completed test suite (00:20:11) 22:17:50 INFO - 2015-11-18 22:17:50,849 DEBUG : Working with test: dromaeo_css 22:17:50 INFO - 2015-11-18 22:17:50,850 DEBUG : Generating results file: dromaeo_css 22:17:50 INFO - 2015-11-18 22:17:50,851 DEBUG : Working with test: kraken 22:17:50 INFO - 2015-11-18 22:17:50,851 DEBUG : Generating results file: kraken 22:17:50 INFO - 2015-11-18 22:17:50,851 INFO : javascript benchmark 22:17:50 INFO - 2015-11-18 22:17:50,851 DEBUG : Working with test: v8_7 22:17:50 INFO - 2015-11-18 22:17:50,851 DEBUG : Generating results file: v8_7 22:17:50 INFO - 2015-11-18 22:17:50,852 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:50 INFO - 2015-11-18 22:17:50,912 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 22:17:50 INFO - 2015-11-18 22:17:50,913 DEBUG : process_Request line: dromaeo_css 6781.51 graph.html#tests=[[72,64,35]] 22:17:50 INFO - 2015-11-18 22:17:50,913 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:50 INFO - 2015-11-18 22:17:50,945 DEBUG : process_Request line: kraken 1504.90 graph.html#tests=[[232,64,35]] 22:17:50 INFO - 2015-11-18 22:17:50,945 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:50 INFO - 2015-11-18 22:17:50,977 DEBUG : process_Request line: v8_7 19907.13 graph.html#tests=[[230,64,35]] 22:17:50 INFO - 2015-11-18 22:17:50,979 INFO : javascript benchmark 22:17:51 INFO - 2015-11-18 22:17:50,982 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3208.165876872013, 3248.058063161685, 3264.314493956269, 3293.3248684019763, 3300.0429875336154, 5378.924215156965, 5434.918476222855, 5500.559955203584, 5504.64219825711, 5520.475554822296, 5437.211604317372, 5469.206964990074, 5507.5593952483805, 5508.724563771805, 5556.361018482876, 4999.225120106371, 5009.649324547283, 5087.058894104603, 5169.741512924357, 5196.454372290893, 5145.434002259748, 5167.044096842096, 5200.21996700496, 5205.947940520584, 5206.869828254286, 4945.381827271591, 4948.282499037656, 5049.798008079672, 5054.090263752523, 5063.772130254148, 5030.496950304977, 5102.030614183331, 5102.974485127551, 5111.897762044776, 5149.098907691139, 4846.975765121152, 5030.421501527335, 5087.720175390389, 5096.362954630671, 5099.388073431212, 5243.842684719464, 5268.0, 5322.520973112439, 5342.759575819097, 5362.0, 5967.224260846106, 6010.75956961721, 6022.728977195993, 6026.54800889935, 6027.246594175728, 5798.362180160179, 6004.549658775566, 6042.486388656969, 6048.364921683204, 6054.061620448838, 5496.477834605706, 5541.639793413416, 5567.192757050246, 5630.746616402272, 5675.063614503602, 5946.226990491295, 5970.253718285215, 5974.731137098841, 5989.940100598938, 6035.366286539938, 5800.796972105956, 5804.88390232193, 5805.796797112081, 5841.094630332305, 5858.765649373977, 5873.530117590582, 5940.673262970492, 6079.452849243501, 6080.2399700037495, 6096.055111457731, 6031.698415079229, 6051.788187413507, 6053.364396738279, 6058.818235452944, 6061.484773794189, 5812.88374232513, 5948.226730525091, 6032.939670603326, 6049.364816694184, 6050.818475445743, 4441.378207051015, 4477.686561940698, 4486.551344865553, 4492.326151077365, 4512.390827238347, 4107.938380924288, 4113.095119073799, 4121.093359460914, 4126.958730412717, 4134.193832202752, 5619.072852979212, 5686.317641882918, 5732.856678582985, 5737.110747834093, 5756.1653560233535, 5887.970560147171, 5969.134475501028, 5980.162777211194, 5990.341062483123, 6035.909461358083, 5634.859128521738, 5637.408072152447, 5642.520385767174, 5660.490555849993, 5685.431456854364, 4892.730899800474, 4901.705897646153, 4984.028114517707, 5033.748312584356, 5034.270030845507, 6106.429470938715, 6159.1069294951985, 6173.382661733791, 6173.9073913891325, 6178.474829639441, 6010.248718910137, 6013.789517366871, 6027.60820546663, 6060.757569697339, 6073.331933487225, 6038.456538911519, 6104.664198625831, 6127.816165515042, 6169.074638804215, 6189.35011823752, 6008.24896887889, 6009.7295621698, 6010.038393856962, 6011.819645410645, 6019.6990150493175, 6091.908621370594, 6091.939080609137, 6098.512119030378, 6100.054491553638, 6103.938960610337, 5562.332520097452, 5709.942900570941, 5722.62802917809, 5901.380355062828, 5940.287165540163, 5832.3292821326095, 5886.499647530008, 5902.61632993854, 5904.557158213065, 5905.143754155538, 5761.740721667451, 5790.884182316414, 5804.361520232856, 5809.796657116981, 5822.854428639318, 5610.663360198401, 5732.398098199796, 5758.856028599319, 5771.451712087345, 5873.442023007808, 5602.243697100839, 5602.4957753802355, 5602.691851948182, 5645.774169033357, 5760.423957604206], "unit": "ms", "name": "dojo.html", "value": 5489.451030045875}, {"lowerIsBetter": false, "replicates": [548.1843739293274, 579.6493121661395, 583.2010146099842, 593.6378808926554, 597.1252115650572, 32335.67664323356, 33109.834450827744, 33153.668463315356, 40768.59231407685, 41350.37974430386, 43990.0, 44522.0, 44570.33144502835, 44626.0, 44626.107477850426, 8751.606177722002, 8939.64241430342, 8941.418807777474, 8941.418807777507, 8943.686970956018, 7751.496152750054, 7920.524768513878, 8728.738137855875, 10291.331063480888, 10510.947445262802, 10182.0, 10270.435126068063, 10276.53755580997, 10276.948615256913, 10279.794404111914, 10017.549210285519, 10185.38887666735, 10188.541515631778, 10195.79608407835, 10203.846942295871, 7731.845363092762, 7934.841303173905, 10289.948550257275, 10493.0, 10506.684799455952, 37377.0, 37666.24667506662, 37774.24451510982, 37779.0, 37842.43236351457, 3247.3667634811222, 3247.9350412991607, 3306.404847127516, 3635.4728564358284, 3820.789856557888, 29938.85030574855, 29968.550471742943, 30390.936317228792, 30783.384332313228, 30861.228469288224, 3552.1652411683235, 3567.161716996504, 3601.7478776485655, 3637.6726094651344, 3644.5808731995894, 277339.0, 279248.0, 279579.99999999796, 280410.0, 280651.0, 51021.48978510167, 60839.69580152159, 61240.56974017664, 61241.38758612357, 61283.387166127766, 54166.45833541693, 71077.0, 72522.0, 72547.27452725405, 72574.0, 14940.252987350588, 15085.698286034218, 15174.393024278905, 15210.0, 15327.0, 11274.887251127548, 11384.089272858151, 11507.88492115085, 11597.014253788522, 11622.128340374506, 20194.899025505074, 20241.493962651053, 20267.594648106955, 20480.487987800127, 20504.69242961357, 7876.448648594658, 8115.75652730419, 8128.878066829002, 8151.470154440061, 8270.172982701682, 986.9358491698017, 987.5802783816849, 997.1324947295899, 1024.8411496218098, 1063.5107850388754, 28221.858890705826, 28798.460378556174, 28874.711252887624, 28912.0, 29354.706452935196, 1027.337367398039, 1043.1550444140119, 1074.8119079161115, 1077.5959015369237, 1146.2091157101572, 15005.69988600222, 15040.398384064734, 15264.618384540254, 15365.692686146214, 15399.769003464957, 314330.0, 318656.0, 319583.0, 319632.0, 320110.0, 52524.0, 52592.47407525876, 52694.209586856225, 52797.7360113197, 53000.73499632477, 1294.2364005236955, 1325.8143859859626, 1359.2659963619535, 1362.5980335800962, 1368.753624347607, 27134.321641959108, 28399.020930116058, 28453.43093138167, 28457.573136403385, 28565.14304570866, 45751.542484574726, 46043.539564603925, 46057.07885842198, 46102.53897460982, 46163.538364615924, 300939.0, 304578.0, 304888.0, 305945.0, 307639.0, 27901.720982790725, 31265.68734312628, 31741.889033883705, 32009.519857202627, 32222.83888580542, 40335.79832100821, 41223.0, 41321.79339103285, 41444.378334325615, 41898.58101418947, 35011.47482787709, 35071.87551171231, 35605.0, 35819.82090089533, 35976.64023359733, 29177.062314245137, 35656.4651530222, 35844.0, 36319.27361452809, 37672.43491347687, 34118.14704632305, 34893.0, 35118.29763404666, 35185.47221791726, 35222.47166292457, 30319.0, 32245.838770805996, 32683.673163268064, 32688.50967235446, 32914.0, 24958.251252462454, 25018.874905625355, 25426.65598264035, 25536.10623628164, 25698.35754106162], "unit": "ms", "name": "ext.html", "value": 18735.466421895668}, {"lowerIsBetter": false, "replicates": [357.3103909454753, 359.19540229885064, 365.24212259561415, 366.19985332049464, 366.43751840924176, 14265.786013209785, 14287.285635718199, 16572.502824915256, 17291.39480118196, 18032.098395080244, 11555.30668159911, 11765.588204412847, 16539.0, 16962.236699348527, 16977.15114244286, 4522.163399771036, 4626.0, 4626.05165940983, 4628.352030715702, 4633.096546173498, 3583.964160358389, 3685.0418891088375, 4567.200739870526, 4603.171429142753, 4970.453250142499, 5000.924986125193, 5006.3241462402475, 5030.044291584605, 5045.293658887758, 5048.242763585455, 4894.388201474816, 4975.601951843843, 5010.974945125269, 5013.298138260629, 5020.221865610836, 4305.13897220554, 4337.761423121727, 4347.369631403429, 4347.413099231595, 4347.630451411634, 13558.864411355858, 13730.65673358164, 13732.382042808098, 13737.107088039245, 13882.4447022119, 2024.736784218057, 2044.5399785048394, 2080.906359213839, 2152.257471172443, 2273.829462790281, 9850.90149098507, 9969.40183588987, 9993.100620944077, 10055.899441005642, 10185.388876667424, 1727.2486468386292, 1735.245168351771, 1735.947921562355, 1744.7644567983286, 1770.9380171694058, 53650.73174634141, 53944.0, 54219.72890135524, 54576.45423545753, 59469.107963380586, 6844.28135045823, 7003.719851205997, 7021.824454388579, 7060.0468936693915, 7068.0811494506415, 8450.577471126418, 8451.154884511623, 8452.197041281068, 8452.78868028292, 8468.40721149526, 5573.832785016456, 5576.10782274834, 5576.275084239023, 5598.832035038955, 5601.29983752031, 5720.570957178228, 5753.88492230153, 5780.653160810365, 5788.044972579477, 5795.130730390475, 3295.950560741591, 3334.216459132102, 3336.199312165063, 3350.6816852398983, 3357.1439282982683, 1114.9665510034713, 1159.4956194055612, 1162.0935670177275, 1178.648596050884, 1214.2775048845922, 445.10533827007947, 464.2201102148356, 468.32327287070535, 474.4591166070682, 509.1039770004744, 11619.302841829349, 11902.107341949215, 12105.394730263451, 12141.939290303491, 12228.082893783001, 455.6969615205851, 476.3022172517279, 498.5637567128762, 515.7008934817796, 516.0, 5755.827325180251, 6371.872562548723, 6592.80221593353, 6839.589624622439, 6869.587824730532, 558399.0, 560294.0, 569790.0, 572225.0, 599081.0, 72764.63617681984, 75057.62471187719, 75934.62032689912, 76079.61960190164, 77563.61218193985, 555.097965805566, 565.5842955427757, 569.1803802524435, 571.5627544928134, 572.6649909802728, 11190.608328708457, 11308.660740177807, 11536.538538458703, 11608.6517404478, 11630.592929247436, 34016.0, 34406.483902740976, 34900.0, 35543.0, 35582.644173557936, 46317.768411157725, 46319.53680463152, 47763.28355074607, 47985.28022079602, 48252.758736206095, 6794.082798822294, 6901.620410877249, 6923.134608173978, 6925.480588955949, 6927.965360173167, 11968.401579920795, 12113.212641178296, 12214.633560993185, 12242.265464071828, 12486.750264994831, 10856.348619082564, 10864.402457864577, 10957.50691218913, 11104.888951110386, 11227.66317010491, 10514.894851051391, 10864.837027444437, 10875.0, 10925.453727313761, 11131.83302250483, 10852.45737713127, 10996.890031099907, 11060.557577696802, 11159.051480624237, 11164.385958772345, 6707.865842683216, 6749.696263668048, 6785.219699734594, 6801.387875091265, 6804.6257455840405, 10729.46352682347, 10754.569817207537, 10924.563017479211, 11009.779804403706, 11041.613543525938], "unit": "ms", "name": "jquery.html", "value": 6999.801945893613}, {"lowerIsBetter": false, "replicates": [1351.3513513513508, 1528.0831501099337, 1549.9925048718335, 1711.7432385142226, 1821.0985562146748, 6913.585184888911, 7549.886751698729, 7783.64973576189, 7808.336291415237, 7816.8827467588035, 7610.961945190266, 7630.618469076552, 7697.499662521932, 7707.267809558097, 7713.5757533335645, 1981.4154824326786, 2022.130483891926, 2250.1224522436264, 2278.692376529164, 2290.919817806373, 2254.0420321363436, 2263.0608297556496, 2265.818734501236, 2267.682524446579, 2267.716535433071, 2203.460152262698, 2287.0965968442456, 2287.645414960675, 2291.0950174680993, 2291.4385975436044, 2022.5145964968376, 2070.171931227506, 2245.708057952464, 2283.0639437830578, 2289.5764283607587, 2261.479859632277, 2279.430142464384, 2283.7830406111393, 2304.481491664379, 2308.7344955330186, 7869.409794265396, 7870.606469676493, 7895.0, 7902.644381002869, 7930.048394192676, 4683.250679891201, 4792.904141917177, 4800.423949126092, 4805.135075686375, 4809.78355973982, 3174.8095114293214, 3191.281961558654, 3217.581714377116, 3242.3515296940473, 3286.8356582170795, 1104.138771758022, 1768.7258474936405, 1788.4277031349973, 1823.8996855173093, 1909.1313452379272, 10745.946270268676, 10796.082333001705, 10931.836022459669, 10939.343639381583, 10952.397618130999, 4168.583141685807, 4209.473815773028, 4310.762908040025, 4349.195398851222, 4382.123575284956, 8943.955280223558, 8950.597223124845, 8957.552122393985, 8961.731148065568, 8962.417442866323, 4652.790624421909, 4665.043666048452, 4689.742064186435, 4692.507286734912, 4694.201985662446, 4277.037666525007, 4290.82836686529, 4305.763183024964, 4318.784060796947, 4328.588784065509, 3490.6334834842482, 3512.051746028558, 3512.332656795201, 3538.752287339913, 3548.7161027118286, 1095.70963694621, 1112.9054030407506, 1113.660333598244, 1114.7881902438673, 1130.7286251299793, 1307.8169056332122, 1309.463120120746, 1336.251699048536, 1347.47448495087, 1362.434589645286, 6876.415504682158, 7152.356287934007, 7682.116556596063, 7688.692452301845, 7699.037620297463, 676.4250387170865, 679.9252082270946, 684.3327755438407, 690.1063123255396, 690.4648897104784, 5860.062390017662, 5873.559483038789, 5884.470397664145, 5933.2880054393745, 5934.376890426443, 8942.955285223532, 9087.22758565516, 9162.67930622425, 9253.814923701488, 9279.396839205565, 9169.541522923828, 9180.724578262663, 9181.632734690671, 9262.351635385457, 9267.165955064076, 7225.89161162583, 7304.0, 7333.853322933512, 7380.815479613053, 7401.5189012714, 7395.149557800706, 7436.219196984239, 7466.029416175862, 7473.738419155304, 7474.402047836269, 8258.050324212792, 8353.874691879748, 8389.454685445426, 8391.16088391156, 8401.201885820838, 7939.84120317602, 8106.554139522147, 8132.064812546633, 8254.958725206336, 8272.090070092405, 6722.697478613572, 7023.578585284695, 7053.0830991970715, 7074.398676112382, 7104.857902842017, 7680.6543705534505, 7720.691172353043, 7739.92260077392, 7757.224277572198, 7764.534127952115, 7129.857402852018, 7289.854202915806, 7338.774982984512, 7360.742374016883, 7407.8148046299275, 7108.182559005573, 7162.212156662658, 7197.280271972971, 7245.927540724525, 7292.197858235484, 6344.175257216532, 6667.966660166668, 6956.130483689539, 7263.237360077116, 7263.382612477999, 6634.170728658918, 6667.599944003376, 6674.499412543982, 6700.3969642730435, 6708.26209116987, 6593.604383736991, 6610.338966103352, 6646.8005959821285, 6702.865942681022, 6704.932950670626], "unit": "ms", "name": "mootools.html", "value": 4517.644597819635}, {"lowerIsBetter": false, "replicates": [327.3306089047898, 337.83952622504313, 343.08054414170044, 347.87302634538383, 350.1578703218758, 5959.195508606343, 6063.848403789907, 6120.326764055951, 6178.783742569011, 6181.412765787254, 5759.712014399284, 5901.616394934326, 5923.437273459014, 6028.788992385267, 6037.909431358522, 4554.726716397018, 4664.416947881515, 4680.0, 4691.319758635013, 4692.06158768246, 4648.325992731052, 4671.065786842645, 4677.4620918594455, 4679.204535229002, 4679.485256621786, 4399.846005389812, 4466.486354069291, 4514.938989337503, 4595.264757638778, 4620.468646105691, 4625.838095666652, 4632.976835115836, 4646.790894409726, 4651.953480465186, 4653.767311634405, 4085.6935729820384, 4088.897777555555, 4089.407035979766, 4092.1406504634065, 4102.0, 5679.176519404705, 5680.8863822723315, 5683.857903552444, 5685.829425117253, 5686.829395118153, 5301.602379821529, 5382.650127741724, 5415.350157981028, 5417.810376636839, 5420.214068960018, 6367.395097465734, 6413.486921046305, 6413.583117097421, 6416.427975146119, 6422.325655806167, 4535.637149028103, 4544.363789069533, 4544.409226800528, 4545.431821022372, 4548.226801443762, 6519.315471875432, 6668.466522678223, 6676.666166691646, 6682.431993280626, 6683.832904177386, 4632.25883858581, 4659.44086709597, 4663.253879379283, 4664.883377915511, 4665.2302370108555, 4711.575958163782, 4716.127516409475, 4724.244120940633, 4727.314539391838, 4729.314249433882, 5391.110466773017, 5400.973814975142, 5410.594205434608, 5414.160805075219, 5417.187421886749, 6316.747330106744, 6468.3855033771715, 6468.611883287018, 6472.417482426604, 6483.805485835433, 1648.1841488463288, 1668.2826384654472, 1668.7580300856307, 1669.7328427451791, 1670.983290167107, 1124.4434005167332, 1124.6063877642923, 1125.870524889648, 1144.8168293073068, 1151.6545036489188, 6253.0, 6256.530760192913, 6261.342559031327, 6261.812145635638, 6267.905981410283, 6628.701708423133, 6646.335366463411, 6655.73377064912, 6655.900161497581, 6656.567323124078, 6063.8484037898525, 6163.260408750979, 6215.440610345091, 6248.968755156195, 6254.21822272216, 3612.7651702639246, 3637.5998640149564, 3643.2349206666368, 3644.890653280406, 3655.6161603031833, 6810.62541560219, 6860.862782744417, 6875.518713689994, 6893.724251029903, 6903.792886213421, 6696.330366963265, 6875.621840798804, 6887.965560172167, 6933.375996160269, 6939.895901561481, 6932.688029038705, 6935.965320173367, 6942.340477654615, 6945.687444065029, 6950.652467376611, 6727.93272067273, 6745.5952642841585, 6754.831129221809, 6754.898676519954, 6760.121184246016, 6507.414332710079, 6638.90041649366, 6656.600603963778, 6658.300878407891, 6681.231658359351, 6870.828229294308, 6877.3810357068105, 6881.931180688129, 6884.793456196322, 6889.621070841152, 4540.432445944257, 4562.247229207143, 4588.908221835612, 4591.311303304531, 4592.586667199968, 6394.904076438764, 6565.770198043046, 6581.605103693793, 6676.566023208476, 6712.127423434922, 6440.9033864493, 6527.086207930988, 6527.379898909596, 6531.967340163269, 6539.149910511603, 6528.575642583217, 6529.608223506605, 6534.117894084237, 6534.346565343428, 6541.771038013647, 6254.687265636791, 6437.163168788027, 6438.259600145856, 6438.3883531064475, 6446.871062578816, 6567.9671601641685, 6581.3747693969, 6592.17597800275, 6592.24189218246, 6596.373344532261, 6415.230172379344, 6425.228972523327, 6427.357264273723, 6428.550001500037, 6429.32492088324], "unit": "ms", "name": "prototype.html", "value": 4889.365356967633}, {"lowerIsBetter": false, "replicates": [862.2584577263552, 867.9479231246125, 874.7987962768563, 895.9328050396219, 899.4827973914993, 14107.576772696822, 14420.351084201237, 14421.92789036056, 14442.061266017701, 14475.0, 13402.195868247913, 13527.526536571197, 13527.864721352784, 13540.119892207, 13541.93229033856, 688.3632639808183, 702.034702284359, 819.045811629451, 831.6382373667444, 834.090840983328, 827.9130691277419, 838.1074156023815, 839.8446287436843, 839.8866153069349, 840.470503582742, 874.8818909447239, 878.9472631642122, 879.0286733159862, 879.3229213505597, 879.5162660536711, 713.0730050933792, 727.1637616740737, 854.9102344253888, 872.0930232558195, 873.10506730601, 628.4406877878691, 629.3674856768964, 635.2218532297944, 635.3075148088606, 635.3455940381415, 11990.880091199151, 12238.571649992296, 12297.69255768604, 12298.262104273772, 12308.26150430977, 10197.337173083726, 10223.335483193569, 10348.79302413955, 10406.791864162675, 10855.294405863593, 9740.025997400275, 9958.452285124315, 9979.30144889858, 10174.186065114773, 10988.670339889815, 3142.4186525492855, 3182.2839861031316, 3230.644629090798, 3231.1922019495128, 3239.5950506186728, 45219.321710174045, 45562.0, 45602.31596526055, 45895.0, 45918.540814592096, 7479.476436649491, 8083.7170699025255, 8112.148224436467, 8146.2261085196815, 8174.019117705913, 12450.0, 12452.626421207378, 12454.065945054157, 12467.251964882136, 12545.31000794965, 6569.178852643419, 6790.660466976631, 6931.445484361239, 7037.085178926707, 7157.964210178916, 4277.0, 4313.460817397825, 4321.978390108092, 4372.584604462634, 4512.2329204035395, 2797.8740956656998, 2824.661040675091, 2831.631887854566, 2831.631887854566, 2833.744962953344, 505.6435213174703, 518.4841083122318, 519.9090159222121, 528.7171363320605, 529.282821776495, 622.7726879688881, 643.9871202576016, 698.5459451356659, 701.0990876723386, 712.3695529456364, 8643.178898004806, 8643.827123457495, 8651.307895368356, 8814.955925220333, 8844.601992910335, 524.8241838983984, 579.4697851465861, 670.8160097428043, 680.9148856392951, 693.2651389527117, 3758.8872333830027, 3909.7458665186673, 3933.567307596162, 3963.128111815396, 3983.701222408331, 59679.70160149172, 59721.0, 60104.0, 60127.39872601218, 60176.39823601796, 51565.484345156816, 52025.73987130116, 52260.21609675858, 52917.470825292025, 53133.0, 46224.07551849011, 46798.298025528966, 46967.0, 47005.29492057622, 48460.5153948456, 7857.4499785014505, 7986.8801967971685, 7994.2805147537, 8045.195480451908, 8219.219174178443, 34694.82652586721, 35614.0, 35981.820090899375, 36037.81981090078, 36163.81918090498, 42584.5741542593, 42661.0, 45907.54092459166, 46609.53390466052, 47057.76471117623, 7504.272308445645, 7657.9617101916365, 7751.41864360164, 7800.882986755089, 8012.559309238048, 12341.568045118378, 12435.0, 12642.683932901384, 12766.234025958473, 12822.0, 11505.942470287595, 11938.383818293727, 12226.410566626282, 12347.13570050088, 12615.116941814353, 11353.82928895331, 11787.882121179022, 11857.940710296394, 11951.641450756491, 12224.87775122273, 11726.355050472306, 12160.331181784733, 12181.634550963485, 12531.812022819848, 12548.30984295836, 9936.552855121392, 10060.69817905464, 10293.691189264335, 10460.020546823564, 10870.293430926964, 9528.333016688764, 9631.43357785627, 9924.206063514757, 10515.421651809223, 10570.365778053034], "unit": "ms", "name": "yui.html", "value": 6116.169333246792}], "name": "dromaeo_css", "value": 6781.512185985018}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 110.0, 109.0, 118.0, 110.0, 110.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 154.0, 166.0, 130.0, 154.0, 154.0, 125.0, 166.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 159.0, 162.0, 160.0, 163.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 91.0, 72.0, 72.0, 71.0, 93.0, 93.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 137.0, 90.0, 91.0, 92.0, 136.0, 91.0, 90.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 66.0, 56.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 85.0, 85.0, 86.0, 93.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [125.0, 130.0, 121.0, 116.0, 134.0, 119.0, 121.0, 126.0, 126.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 151.0, 156.0, 156.0, 141.0, 152.0, 155.0, 153.0, 163.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 66.0, 66.0, 71.0, 66.0, 67.0, 67.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1504.8999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.7465203864418], "unit": "score", "name": "Richards", "value": 215.58931399999992}, {"lowerIsBetter": false, "replicates": [187.86398647379298], "unit": "score", "name": "DeltaBlue", "value": 351.946114}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [610.8735491753207], "unit": "score", "name": "Splay", "value": 133.40076699999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19907.13081729509}]} 22:17:51 INFO - RETURN: dromaeo_css: 6781.51 22:17:51 INFO - RETURN: kraken: 1504.90 22:17:51 INFO - RETURN: v8_7: 19907.13 22:17:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19907.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6781.51"}}} 22:17:51 INFO - Return code: 0 22:17:51 INFO - # TBPL SUCCESS # 22:17:51 INFO - Running post-action listener: _resource_record_post_action 22:17:51 INFO - Running post-run listener: _resource_record_post_run 22:17:52 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 135168; Write bytes: 515473408; Read time: 524; Write time: 415964 22:17:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 131072; Write bytes: 181555200; Read time: 512; Write time: 149740 22:17:52 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329965568; Read time: 12; Write time: 265876 22:17:52 INFO - Running post-run listener: _upload_blobber_files 22:17:52 INFO - Blob upload gear active. 22:17:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:17:52 INFO - Copying logs to upload dir... 22:17:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.028656 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-18 22:17:51.743600) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:51.747258) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010085 build_url: 'https://queue.taskcluster.net/v1/task/CErmCG5HTHKhzBTZefmrLQ/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-18 22:17:51.798895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:51.799245) ========= 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=dd132779db58144225c4cf24000001c8-1447909244.529382-875045288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 22:17:51.848452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 22:17:51.848785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 22:17:51.849096) ========= ========= Total master_lag: 0.25 =========