builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1448052755.37 results: success (0) buildid: 20151120103030 builduid: 8acaad21b7844ac4bbbfd3d6e0ef3603 revision: 0b2b0570777f82dc37a2af2e49e170114ff28e2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.367496) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.367921) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.368216) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006488 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.417297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.417567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.443784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.444057) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.493459) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.493727) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.494100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.494369) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 12:52:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-20 12:52:35 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.628722) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.628997) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.677635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:35.677983) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b2b0570777f82dc37a2af2e49e170114ff28e2b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0b2b0570777f82dc37a2af2e49e170114ff28e2b --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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 12:52:35,890 truncating revision to first 12 chars 2015-11-20 12:52:35,890 Setting DEBUG logging. 2015-11-20 12:52:35,890 attempt 1/10 2015-11-20 12:52:35,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b2b0570777f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 12:52:36,134 unpacking tar archive at: mozilla-central-0b2b0570777f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.229894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.230187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.273302) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.273570) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:52:36.273938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-20 12:52:36.274228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:52:36 INFO - MultiFileLogger online at 20151120 12:52:36 in /builds/slave/test-pgo 12:52:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:52:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:52:36 INFO - {'append_to_log': False, 12:52:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:52:36 INFO - 'blob_upload_branch': 'Firefox', 12:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:52:36 INFO - 'branch': 'Firefox', 12:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:36 INFO - 'config_files': ('talos/linux_config.py',), 12:52:36 INFO - 'default_actions': ('clobber', 12:52:36 INFO - 'read-buildbot-config', 12:52:36 INFO - 'download-and-extract', 12:52:36 INFO - 'populate-webroot', 12:52:36 INFO - 'create-virtualenv', 12:52:36 INFO - 'install', 12:52:36 INFO - 'run-tests'), 12:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:36 INFO - 'download_minidump_stackwalk': True, 12:52:36 INFO - 'download_symbols': 'ondemand', 12:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:36 INFO - 'installer_path': 'installer.exe', 12:52:36 INFO - 'log_level': 'info', 12:52:36 INFO - 'log_name': 'talos', 12:52:36 INFO - 'log_to_console': True, 12:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:52:36 INFO - 'opt_config_files': (), 12:52:36 INFO - 'pip_index': False, 12:52:36 INFO - 'sps_profile': False, 12:52:36 INFO - 'sps_profile_interval': 0, 12:52:36 INFO - 'suite': 'dromaeojs', 12:52:36 INFO - 'system_bits': '64', 12:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:36 INFO - 'title': 'talos-linux64-ix-042', 12:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:36 INFO - 'use_talos_json': True, 12:52:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:36 INFO - 'work_dir': 'build'} 12:52:36 INFO - ##### 12:52:36 INFO - ##### Running clobber step. 12:52:36 INFO - ##### 12:52:36 INFO - Running pre-action listener: _resource_record_pre_action 12:52:36 INFO - Running main action method: clobber 12:52:36 INFO - rmtree: /builds/slave/test-pgo/build 12:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:52:37 INFO - Running post-action listener: _resource_record_post_action 12:52:37 INFO - ##### 12:52:37 INFO - ##### Running read-buildbot-config step. 12:52:37 INFO - ##### 12:52:37 INFO - Running pre-action listener: _resource_record_pre_action 12:52:37 INFO - Running main action method: read_buildbot_config 12:52:37 INFO - Using buildbot properties: 12:52:37 INFO - { 12:52:37 INFO - "properties": { 12:52:37 INFO - "buildnumber": 572, 12:52:37 INFO - "product": "firefox", 12:52:37 INFO - "script_repo_revision": "production", 12:52:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:52:37 INFO - "repository": "", 12:52:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:52:37 INFO - "buildid": "20151120103030", 12:52:37 INFO - "slavename": "talos-linux64-ix-042", 12:52:37 INFO - "pgo_build": "True", 12:52:37 INFO - "basedir": "/builds/slave/test-pgo", 12:52:37 INFO - "project": "", 12:52:37 INFO - "platform": "ubuntu64_hw", 12:52:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:52:37 INFO - "slavebuilddir": "test", 12:52:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:52:37 INFO - "branch": "mozilla-central", 12:52:37 INFO - "repo_path": "mozilla-central", 12:52:37 INFO - "stage_platform": "linux64-pgo", 12:52:37 INFO - "builduid": "8acaad21b7844ac4bbbfd3d6e0ef3603", 12:52:37 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:37 INFO - }, 12:52:37 INFO - "sourcestamp": { 12:52:37 INFO - "repository": "", 12:52:37 INFO - "hasPatch": false, 12:52:37 INFO - "project": "", 12:52:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:52:37 INFO - "changes": [ 12:52:37 INFO - { 12:52:37 INFO - "category": null, 12:52:37 INFO - "files": [ 12:52:37 INFO - { 12:52:37 INFO - "url": null, 12:52:37 INFO - "name": "https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:52:37 INFO - } 12:52:37 INFO - ], 12:52:37 INFO - "repository": "", 12:52:37 INFO - "rev": "0b2b0570777f82dc37a2af2e49e170114ff28e2b", 12:52:37 INFO - "who": "sendchange", 12:52:37 INFO - "when": 1448052730, 12:52:37 INFO - "number": 6690469, 12:52:37 INFO - "comments": "", 12:52:37 INFO - "project": "", 12:52:37 INFO - "at": "Fri 20 Nov 2015 12:52:10", 12:52:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 12:52:37 INFO - "revlink": "", 12:52:37 INFO - "properties": [ 12:52:37 INFO - [ 12:52:37 INFO - "buildid", 12:52:37 INFO - "20151120103030", 12:52:37 INFO - "Change" 12:52:37 INFO - ], 12:52:37 INFO - [ 12:52:37 INFO - "builduid", 12:52:37 INFO - "8acaad21b7844ac4bbbfd3d6e0ef3603", 12:52:37 INFO - "Change" 12:52:37 INFO - ], 12:52:37 INFO - [ 12:52:37 INFO - "pgo_build", 12:52:37 INFO - "True", 12:52:37 INFO - "Change" 12:52:37 INFO - ] 12:52:37 INFO - ], 12:52:37 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:37 INFO - } 12:52:37 INFO - ], 12:52:37 INFO - "revision": "0b2b0570777f82dc37a2af2e49e170114ff28e2b" 12:52:37 INFO - } 12:52:37 INFO - } 12:52:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:52:37 INFO - Running post-action listener: _resource_record_post_action 12:52:37 INFO - ##### 12:52:37 INFO - ##### Running download-and-extract step. 12:52:37 INFO - ##### 12:52:37 INFO - Running pre-action listener: _resource_record_pre_action 12:52:37 INFO - Running main action method: download_and_extract 12:52:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:52:37 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')]} 12:52:37 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json 12:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json 12:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:52:40 INFO - Downloaded 1302 bytes. 12:52:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:52:40 INFO - Using the following test package requirements: 12:52:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:52:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'jsshell-linux-x86_64.zip'], 12:52:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:52:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:52:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:52:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:52:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:52:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:40 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:48 INFO - Downloaded 22524569 bytes. 12:52:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:52:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:52:49 INFO - Return code: 0 12:52:49 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 12:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:49 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:50 INFO - Downloaded 22524569 bytes. 12:52:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:52:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:52:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:52:51 INFO - Return code: 0 12:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:51 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:53 INFO - Downloaded 11130997 bytes. 12:52:53 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 12:52:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:53 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 12:52:53 INFO - Return code: 0 12:52: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')]} 12:52:53 INFO - https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROlZscn1Rva0zbuR9-55lg/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 12:52:57 INFO - Downloaded 57346809 bytes. 12:52:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:57 INFO - mkdir: /builds/slave/test-pgo/properties 12:52:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:52:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:52:57 INFO - Contents: 12:52:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:52:57 INFO - Running post-action listener: _resource_record_post_action 12:52:57 INFO - Running post-action listener: set_extra_try_arguments 12:52:57 INFO - ##### 12:52:57 INFO - ##### Running populate-webroot step. 12:52:57 INFO - ##### 12:52:57 INFO - Running pre-action listener: _resource_record_pre_action 12:52:57 INFO - Running main action method: populate_webroot 12:52:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:52:57 INFO - '../fennec_ids.txt'], 12:52:57 INFO - 'tests': ['tcheck2']}, 12:52:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:57 INFO - '--tppagecycles', 12:52:57 INFO - '7'], 12:52:57 INFO - 'tests': ['tsvgm']}}, 12:52:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:52:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'tests': ['damp', 'tps']}, 12:52:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['damp', 'tps']}, 12:52:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:52:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:57 INFO - 'other': {'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'other_l64': {'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'other_nol64': {'tests': ['a11yr', 12:52:57 INFO - 'ts_paint', 12:52:57 INFO - 'tpaint', 12:52:57 INFO - 'sessionrestore', 12:52:57 INFO - 'sessionrestore_no_auto_restore']}, 12:52:57 INFO - 'svgr': {'tests': ['tsvgx', 12:52:57 INFO - 'tsvgr_opacity', 12:52:57 INFO - 'tart', 12:52:57 INFO - 'tscrollx', 12:52:57 INFO - 'cart']}, 12:52:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['tsvgx', 12:52:57 INFO - 'tsvgr_opacity', 12:52:57 INFO - 'tart', 12:52:57 INFO - 'tscrollx', 12:52:57 INFO - 'cart']}, 12:52:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'tests': ['tp5o']}, 12:52:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'talos_options': ['--e10s'], 12:52:57 INFO - 'tests': ['tp5o']}, 12:52:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'talos_options': ['--xperf_path', 12:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:57 INFO - 'tests': ['tp5n']}, 12:52:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:57 INFO - 'talos_options': ['--e10s', 12:52:57 INFO - '--xperf_path', 12:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:57 INFO - 'tests': ['tp5n']}}, 12:52:57 INFO - 'talos.zip': {'path': '', 12:52:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:57 INFO - Running post-action listener: _resource_record_post_action 12:52:57 INFO - ##### 12:52:57 INFO - ##### Running create-virtualenv step. 12:52:57 INFO - ##### 12:52:57 INFO - Running pre-action listener: _resource_record_pre_action 12:52:57 INFO - Running main action method: create_virtualenv 12:52:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:52:57 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 12:52:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:52:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:58 INFO - Using real prefix '/usr' 12:52:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:52:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:00 INFO - Installing pip.................done. 12:53:00 INFO - Return code: 0 12:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:53:00 INFO - Using env: {'DISPLAY': ':0', 12:53:00 INFO - 'HOME': '/home/cltbld', 12:53:00 INFO - 'LANG': 'en_US.UTF-8', 12:53:00 INFO - 'LANGUAGE': 'en_US:en', 12:53:00 INFO - 'LOGNAME': 'cltbld', 12:53:00 INFO - 'MAIL': '/var/mail/cltbld', 12:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:00 INFO - 'MOZ_NO_REMOTE': '1', 12:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:00 INFO - 'NO_EM_RESTART': '1', 12:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:00 INFO - 'SHELL': '/bin/bash', 12:53:00 INFO - 'SHLVL': '1', 12:53:00 INFO - 'TERM': 'linux', 12:53:00 INFO - 'TMOUT': '86400', 12:53:00 INFO - 'USER': 'cltbld', 12:53:00 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:00 INFO - '_': '/tools/buildbot/bin/python'} 12:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:00 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 12:53:00 INFO - Cleaning up... 12:53:00 INFO - Return code: 0 12:53:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:53:00 INFO - Using env: {'DISPLAY': ':0', 12:53:00 INFO - 'HOME': '/home/cltbld', 12:53:00 INFO - 'LANG': 'en_US.UTF-8', 12:53:00 INFO - 'LANGUAGE': 'en_US:en', 12:53:00 INFO - 'LOGNAME': 'cltbld', 12:53:00 INFO - 'MAIL': '/var/mail/cltbld', 12:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:00 INFO - 'MOZ_NO_REMOTE': '1', 12:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:00 INFO - 'NO_EM_RESTART': '1', 12:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:00 INFO - 'SHELL': '/bin/bash', 12:53:00 INFO - 'SHLVL': '1', 12:53:00 INFO - 'TERM': 'linux', 12:53:00 INFO - 'TMOUT': '86400', 12:53:00 INFO - 'USER': 'cltbld', 12:53:00 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:00 INFO - '_': '/tools/buildbot/bin/python'} 12:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:00 INFO - Downloading/unpacking psutil>=0.7.1 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:02 INFO - Installing collected packages: psutil 12:53:02 INFO - Running setup.py install for psutil 12:53:02 INFO - building 'psutil._psutil_linux' extension 12:53:02 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 12:53:02 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 12:53:02 INFO - building 'psutil._psutil_posix' extension 12:53:02 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 12:53:03 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 12:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:03 INFO - Successfully installed psutil 12:53:03 INFO - Cleaning up... 12:53:03 INFO - Return code: 0 12:53:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:53: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')]} 12:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:03 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 12:53:03 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 12:53:03 INFO - Using env: {'DISPLAY': ':0', 12:53:03 INFO - 'HOME': '/home/cltbld', 12:53:03 INFO - 'LANG': 'en_US.UTF-8', 12:53:03 INFO - 'LANGUAGE': 'en_US:en', 12:53:03 INFO - 'LOGNAME': 'cltbld', 12:53:03 INFO - 'MAIL': '/var/mail/cltbld', 12:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:03 INFO - 'MOZ_NO_REMOTE': '1', 12:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:03 INFO - 'NO_EM_RESTART': '1', 12:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:03 INFO - 'SHELL': '/bin/bash', 12:53:03 INFO - 'SHLVL': '1', 12:53:03 INFO - 'TERM': 'linux', 12:53:03 INFO - 'TMOUT': '86400', 12:53:03 INFO - 'USER': 'cltbld', 12:53:03 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:03 INFO - '_': '/tools/buildbot/bin/python'} 12:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:53:05 INFO - Installing collected packages: mozsystemmonitor 12:53:05 INFO - Running setup.py install for mozsystemmonitor 12:53:05 INFO - Successfully installed mozsystemmonitor 12:53:05 INFO - Cleaning up... 12:53:05 INFO - Return code: 0 12:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:53: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')]} 12:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:05 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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:05 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 12:53:05 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 12:53:05 INFO - Using env: {'DISPLAY': ':0', 12:53:05 INFO - 'HOME': '/home/cltbld', 12:53:05 INFO - 'LANG': 'en_US.UTF-8', 12:53:05 INFO - 'LANGUAGE': 'en_US:en', 12:53:05 INFO - 'LOGNAME': 'cltbld', 12:53:05 INFO - 'MAIL': '/var/mail/cltbld', 12:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:05 INFO - 'MOZ_NO_REMOTE': '1', 12:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:05 INFO - 'NO_EM_RESTART': '1', 12:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:05 INFO - 'SHELL': '/bin/bash', 12:53:05 INFO - 'SHLVL': '1', 12:53:05 INFO - 'TERM': 'linux', 12:53:05 INFO - 'TMOUT': '86400', 12:53:05 INFO - 'USER': 'cltbld', 12:53:05 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:05 INFO - '_': '/tools/buildbot/bin/python'} 12:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:05 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 12:53:05 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 12:53:05 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 12:53:05 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 12:53:05 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 12:53:05 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 12:53:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:53:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:07 INFO - Downloading docopt-0.6.1.tar.gz 12:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:07 INFO - Running setup.py install for blobuploader 12:53:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:53:07 INFO - Running setup.py install for requests 12:53:08 INFO - Running setup.py install for docopt 12:53:08 INFO - Successfully installed blobuploader requests docopt 12:53:08 INFO - Cleaning up... 12:53:08 INFO - Return code: 0 12:53:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:08 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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:08 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 12:53:08 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 12:53:08 INFO - Using env: {'DISPLAY': ':0', 12:53:08 INFO - 'HOME': '/home/cltbld', 12:53:08 INFO - 'LANG': 'en_US.UTF-8', 12:53:08 INFO - 'LANGUAGE': 'en_US:en', 12:53:08 INFO - 'LOGNAME': 'cltbld', 12:53:08 INFO - 'MAIL': '/var/mail/cltbld', 12:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:08 INFO - 'MOZ_NO_REMOTE': '1', 12:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:08 INFO - 'NO_EM_RESTART': '1', 12:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:08 INFO - 'SHELL': '/bin/bash', 12:53:08 INFO - 'SHLVL': '1', 12:53:08 INFO - 'TERM': 'linux', 12:53:08 INFO - 'TMOUT': '86400', 12:53:08 INFO - 'USER': 'cltbld', 12:53:08 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:08 INFO - '_': '/tools/buildbot/bin/python'} 12:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:08 INFO - Running setup.py (path:/tmp/pip-wcWxqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:08 INFO - Running setup.py (path:/tmp/pip-jWkjtc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:08 INFO - Running setup.py (path:/tmp/pip-hEe3Ne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:08 INFO - Running setup.py (path:/tmp/pip-DqMzyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:08 INFO - Running setup.py (path:/tmp/pip-IbglHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:09 INFO - Running setup.py (path:/tmp/pip-ftZZr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:09 INFO - Running setup.py (path:/tmp/pip-qumoMl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:09 INFO - Running setup.py (path:/tmp/pip-0fwFgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:09 INFO - Running setup.py (path:/tmp/pip-cnqRVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:09 INFO - Running setup.py (path:/tmp/pip-omeTcg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:09 INFO - Running setup.py (path:/tmp/pip-qWPr90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:09 INFO - Running setup.py (path:/tmp/pip-8Zp_KP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:09 INFO - Running setup.py (path:/tmp/pip-IJN5pB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:09 INFO - Running setup.py (path:/tmp/pip-meap_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:09 INFO - Running setup.py (path:/tmp/pip-Zk3jyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:09 INFO - Running setup.py (path:/tmp/pip-TLZ7Ol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:09 INFO - Running setup.py (path:/tmp/pip-eL4ZmQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:09 INFO - Running setup.py install for manifestparser 12:53:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:53:09 INFO - Running setup.py install for mozcrash 12:53:10 INFO - Running setup.py install for mozdebug 12:53:10 INFO - Running setup.py install for mozdevice 12:53:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Running setup.py install for mozfile 12:53:10 INFO - Running setup.py install for mozhttpd 12:53:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Running setup.py install for mozinfo 12:53:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Running setup.py install for mozInstall 12:53:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Running setup.py install for mozleak 12:53:10 INFO - Running setup.py install for mozlog 12:53:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:53:10 INFO - Running setup.py install for moznetwork 12:53:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Running setup.py install for mozprocess 12:53:11 INFO - Running setup.py install for mozprofile 12:53:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Running setup.py install for mozrunner 12:53:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Running setup.py install for mozscreenshot 12:53:11 INFO - Running setup.py install for moztest 12:53:11 INFO - Running setup.py install for mozversion 12:53:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:53:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:11 INFO - Cleaning up... 12:53:11 INFO - Return code: 0 12:53:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53: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')]} 12:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 12:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 12:53:11 INFO - Using env: {'DISPLAY': ':0', 12:53:11 INFO - 'HOME': '/home/cltbld', 12:53:11 INFO - 'LANG': 'en_US.UTF-8', 12:53:11 INFO - 'LANGUAGE': 'en_US:en', 12:53:11 INFO - 'LOGNAME': 'cltbld', 12:53:11 INFO - 'MAIL': '/var/mail/cltbld', 12:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:11 INFO - 'MOZ_NO_REMOTE': '1', 12:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:11 INFO - 'NO_EM_RESTART': '1', 12:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:11 INFO - 'SHELL': '/bin/bash', 12:53:11 INFO - 'SHLVL': '1', 12:53:11 INFO - 'TERM': 'linux', 12:53:11 INFO - 'TMOUT': '86400', 12:53:11 INFO - 'USER': 'cltbld', 12:53:11 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:11 INFO - '_': '/tools/buildbot/bin/python'} 12:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:11 INFO - Running setup.py (path:/tmp/pip-aQOtBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:11 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)) 12:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:11 INFO - Running setup.py (path:/tmp/pip-SWodbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:12 INFO - Running setup.py (path:/tmp/pip-Y51lZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:12 INFO - Running setup.py (path:/tmp/pip-y6DCfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:12 INFO - Running setup.py (path:/tmp/pip-iwLRl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:12 INFO - Running setup.py (path:/tmp/pip-PayUwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:12 INFO - Running setup.py (path:/tmp/pip-4NAoYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:12 INFO - Running setup.py (path:/tmp/pip-YNvRQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:12 INFO - Running setup.py (path:/tmp/pip-K2CVXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:12 INFO - Running setup.py (path:/tmp/pip-GCNA1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:12 INFO - Running setup.py (path:/tmp/pip-ZSmyFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:12 INFO - Running setup.py (path:/tmp/pip-60X8AM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:12 INFO - Running setup.py (path:/tmp/pip-w8arBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:12 INFO - Running setup.py (path:/tmp/pip-NVlBbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:12 INFO - Running setup.py (path:/tmp/pip-6iGFWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:12 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)) 12:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:12 INFO - Running setup.py (path:/tmp/pip-OghOfk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:13 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)) 12:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:13 INFO - Running setup.py (path:/tmp/pip-TPzc3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:13 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)) 12:53:13 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)) 12:53:13 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)) 12:53:13 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)) 12:53:13 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)) 12:53:13 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)) 12:53:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:15 INFO - Downloading blessings-1.5.1.tar.gz 12:53:15 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 12:53:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:15 INFO - Installing collected packages: blessings 12:53:15 INFO - Running setup.py install for blessings 12:53:15 INFO - Successfully installed blessings 12:53:15 INFO - Cleaning up... 12:53:15 INFO - Return code: 0 12:53:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:53:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:16 INFO - Reading from file tmpfile_stdout 12:53:16 INFO - Current package versions: 12:53:16 INFO - argparse == 1.2.1 12:53:16 INFO - blessings == 1.5.1 12:53:16 INFO - blobuploader == 1.2.4 12:53:16 INFO - docopt == 0.6.1 12:53:16 INFO - manifestparser == 1.1 12:53:16 INFO - mozInstall == 1.12 12:53:16 INFO - mozcrash == 0.16 12:53:16 INFO - mozdebug == 0.1 12:53:16 INFO - mozdevice == 0.47 12:53:16 INFO - mozfile == 1.2 12:53:16 INFO - mozhttpd == 0.7 12:53:16 INFO - mozinfo == 0.9 12:53:16 INFO - mozleak == 0.1 12:53:16 INFO - mozlog == 3.0 12:53:16 INFO - moznetwork == 0.27 12:53:16 INFO - mozprocess == 0.22 12:53:16 INFO - mozprofile == 0.27 12:53:16 INFO - mozrunner == 6.11 12:53:16 INFO - mozscreenshot == 0.1 12:53:16 INFO - mozsystemmonitor == 0.0 12:53:16 INFO - moztest == 0.7 12:53:16 INFO - mozversion == 1.4 12:53:16 INFO - psutil == 3.1.1 12:53:16 INFO - requests == 1.2.3 12:53:16 INFO - wsgiref == 0.1.2 12:53:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53: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')]} 12:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:16 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 0x7f63f7818c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, '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': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', '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 12:53:16 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 12:53:16 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 12:53:16 INFO - Using env: {'DISPLAY': ':0', 12:53:16 INFO - 'HOME': '/home/cltbld', 12:53:16 INFO - 'LANG': 'en_US.UTF-8', 12:53:16 INFO - 'LANGUAGE': 'en_US:en', 12:53:16 INFO - 'LOGNAME': 'cltbld', 12:53:16 INFO - 'MAIL': '/var/mail/cltbld', 12:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:16 INFO - 'MOZ_NO_REMOTE': '1', 12:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:16 INFO - 'NO_EM_RESTART': '1', 12:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:16 INFO - 'SHELL': '/bin/bash', 12:53:16 INFO - 'SHLVL': '1', 12:53:16 INFO - 'TERM': 'linux', 12:53:16 INFO - 'TMOUT': '86400', 12:53:16 INFO - 'USER': 'cltbld', 12:53:16 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:16 INFO - '_': '/tools/buildbot/bin/python'} 12:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 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)) 12:53:16 INFO - Cleaning up... 12:53:16 INFO - Return code: 0 12:53:16 INFO - Running post-action listener: _resource_record_post_action 12:53:16 INFO - Running post-action listener: _start_resource_monitoring 12:53:16 INFO - Starting resource monitoring. 12:53:16 INFO - ##### 12:53:16 INFO - ##### Running install step. 12:53:16 INFO - ##### 12:53:16 INFO - Running pre-action listener: _resource_record_pre_action 12:53:16 INFO - Running main action method: install 12:53:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:16 INFO - Reading from file tmpfile_stdout 12:53:16 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:53:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:53:16 INFO - Reading from file tmpfile_stdout 12:53:16 INFO - Output received: 12:53:16 INFO - Usage: mozinstall [options] installer 12:53:16 INFO - Options: 12:53:16 INFO - -h, --help show this help message and exit 12:53:16 INFO - -d DEST, --destination=DEST 12:53:16 INFO - Directory to install application into. [default: 12:53:16 INFO - "/builds/slave/test-pgo"] 12:53:16 INFO - --app=APP Application being installed. [default: firefox] 12:53:16 INFO - mkdir: /builds/slave/test-pgo/build/application 12:53:16 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'] 12:53:16 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 12:53:31 INFO - Reading from file tmpfile_stdout 12:53:31 INFO - Output received: 12:53:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:53:31 INFO - Running post-action listener: _resource_record_post_action 12:53:31 INFO - ##### 12:53:31 INFO - ##### Running run-tests step. 12:53:31 INFO - ##### 12:53:31 INFO - Running pre-action listener: _resource_record_pre_action 12:53:31 INFO - Running main action method: run_tests 12:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:53:31 INFO - Python 2.7.3 12:53:31 INFO - Return code: 0 12:53:31 INFO - grabbing minidump binary from tooltool 12:53:31 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')]} 12:53:31 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 0x11f2a90>, '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 0x1244f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12452e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:53:31 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 12:53:31 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 12:53:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:31 INFO - Return code: 0 12:53:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:53:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:53:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 12:53:31 INFO - Using env: {'DISPLAY': ':0', 12:53:31 INFO - 'HOME': '/home/cltbld', 12:53:31 INFO - 'LANG': 'en_US.UTF-8', 12:53:31 INFO - 'LANGUAGE': 'en_US:en', 12:53:31 INFO - 'LOGNAME': 'cltbld', 12:53:31 INFO - 'MAIL': '/var/mail/cltbld', 12:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:31 INFO - 'MOZ_NO_REMOTE': '1', 12:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:31 INFO - 'NO_EM_RESTART': '1', 12:53:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:53:31 INFO - 'SHELL': '/bin/bash', 12:53:31 INFO - 'SHLVL': '1', 12:53:31 INFO - 'TERM': 'linux', 12:53:31 INFO - 'TMOUT': '86400', 12:53:31 INFO - 'USER': 'cltbld', 12:53:31 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902', 12:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:31 INFO - '_': '/tools/buildbot/bin/python'} 12:53:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 12:53:31 INFO - mozversion INFO | application_buildid: 20151120103030 12:53:31 INFO - mozversion INFO | application_changeset: 0b2b0570777f82dc37a2af2e49e170114ff28e2b 12:53:31 INFO - mozversion INFO | application_display_name: Nightly 12:53:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:31 INFO - mozversion INFO | application_name: Firefox 12:53:31 INFO - mozversion INFO | application_remotingname: firefox 12:53:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 12:53:31 INFO - mozversion INFO | application_vendor: Mozilla 12:53:31 INFO - mozversion INFO | application_version: 45.0a1 12:53:31 INFO - mozversion INFO | platform_buildid: 20151120103030 12:53:31 INFO - mozversion INFO | platform_changeset: 0b2b0570777f82dc37a2af2e49e170114ff28e2b 12:53:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 12:53:31 INFO - mozversion INFO | platform_version: 45.0a1 12:53:31 INFO - 2015-11-20 12:53:31,419 DEBUG : using testdate: 1448052811 12:53:31 INFO - 2015-11-20 12:53:31,419 DEBUG : actual date: 1448052811 12:53:31 INFO - 2015-11-20 12:53:31,429 INFO : starting webserver on 'localhost:59888' 12:53:31 INFO - 2015-11-20 12:53:31,430 INFO : Starting test suite talos-linux64-ix-042 12:53:31 INFO - 2015-11-20 12:53:31,430 INFO : Starting test dromaeo_css 12:53:31 INFO - 2015-11-20 12:53:31,430 DEBUG : operating with platform_type : linux_ 12:53:31 INFO - 2015-11-20 12:53:31,431 INFO : Initialising browser for dromaeo_css test... 12:53:31 INFO - 2015-11-20 12:53:31,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyAy8c1/profile http://localhost:59888/getInfo.html 12:53:35 INFO - 2015-11-20 12:53:35,952 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:53:35 INFO - 2015-11-20 12:53:35,953 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:53:35 INFO - 2015-11-20 12:53:35,953 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:53:35 INFO - 2015-11-20 12:53:35,953 DEBUG : BROWSER_OUTPUT: __metrics 12:53:36 INFO - 2015-11-20 12:53:36,049 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:37 INFO - 2015-11-20 12:53:37,565 INFO : Browser initialized. 12:53:37 INFO - 2015-11-20 12:53:37,565 INFO : Running cycle 1/1 for dromaeo_css test... 12:53:37 INFO - 2015-11-20 12:53:37,566 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyAy8c1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:53:49 INFO - 2015-11-20 12:53:49,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 142409728 12:53:49 INFO - 2015-11-20 12:53:49,344 DEBUG : BROWSER_OUTPUT: 12:54:40 INFO - 2015-11-20 12:54:40,060 DEBUG : BROWSER_OUTPUT: 1448052880058 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] 12:56:49 INFO - 2015-11-20 12:56:49,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59888/tests/dromaeo/cssquery-ext.html) 12:56:51 INFO - 2015-11-20 12:56:51,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 278220800 12:56:51 INFO - 2015-11-20 12:56:51,376 DEBUG : BROWSER_OUTPUT: 12:59:53 INFO - 2015-11-20 12:59:53,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-ext.html (next: http://localhost:59888/tests/dromaeo/cssquery-jquery.html) 12:59:54 INFO - 2015-11-20 12:59:54,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 212299776 12:59:54 INFO - 2015-11-20 12:59:54,342 DEBUG : BROWSER_OUTPUT: 13:02:56 INFO - 2015-11-20 13:02:56,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59888/tests/dromaeo/cssquery-mootools.html) 13:02:56 INFO - 2015-11-20 13:02:56,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 209301504 13:02:56 INFO - 2015-11-20 13:02:56,871 DEBUG : BROWSER_OUTPUT: 13:05:58 INFO - 2015-11-20 13:05:58,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59888/tests/dromaeo/cssquery-prototype.html) 13:05:59 INFO - 2015-11-20 13:05:59,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 198815744 13:05:59 INFO - 2015-11-20 13:05:59,261 DEBUG : BROWSER_OUTPUT: 13:09:01 INFO - 2015-11-20 13:09:01,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59888/tests/dromaeo/cssquery-yui.html) 13:09:02 INFO - 2015-11-20 13:09:02,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 202240000 13:09:02 INFO - 2015-11-20 13:09:02,219 DEBUG : BROWSER_OUTPUT: 13:12:04 INFO - 2015-11-20 13:12:04,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/dromaeo/cssquery-yui.html (next: http://localhost:59888/tests/dromaeo/cssquery-dojo.html) 13:12:05 INFO - 2015-11-20 13:12:05,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 295497728 13:12:05 INFO - 2015-11-20 13:12:05,058 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,058 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:05 INFO - 2015-11-20 13:12:05,058 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:05 INFO - 2015-11-20 13:12:05,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:05 INFO - 2015-11-20 13:12:05,059 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:05 INFO - 2015-11-20 13:12:05,059 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3166.809991400516;3256.055743834288;3300.3234336960927;3306.785058971165;3314.6022477302727;5275.736213189335;5384.623076384654;5400.83797486075;5417.26866872972;5430.647007944481;5310.15037593985;5348.090824559825;5355.437679043703;5420.566354691625;5424.349078110632;4942.406911170656;4969.080720066781;4993.550580447759;5013.749312534377;5063.594912406998;4860.878478038042;5083.949160508403;5092.618053645972;5110.744462776865;5153.845384638467;4794.065157294312;4925.655204135712;4937.901241975141;4948.851534453972;5000.024995125952;4972.254161875748;4988.8503344899345;5005.724685142316;5008.223725322581;5039.596832253411;4832.275158726219;4926.1379258629595;4973.303737476756;4980.576650984671;5003.049420610072;5243.659162154448;5303.840884773463;5310.893782124374;5314.229436731653;5322.148456246982;5953.464188223081;5954.851128721816;5956;5956.851078723023;5958.910616340759;5848.766049358021;5906.557008224358;5994.220751302347;6007.128966299906;6041.335453100155;5580.693061881554;5581.10702287632;5583.246261754693;5587.217789509472;5630.211770352154;6011.368806275365;6029.698515074228;6032.245969253843;6035;6035.456808887221;5686.914696279559;5799.043157878987;5799.159121927381;5834.854128646818;5894.528437724972;5890.263717035371;5943.910841337383;5946.226990491208;5962;5966.194563733927;5845.181674565564;5862.8534286642325;5911.586188966817;5921.940780592225;5925.40745925404;5804.535637149018;5813.244278243801;5822.301323841166;5907.2911250650195;5926.2295901532525;4517.75152366623;4547.8635640930825;4567;4570.7257564546235;4616.422947131608;3938.212357528506;4042.636162745367;4064.5935406459116;4074.7351422157467;4105.44576482177;5511.476409741068;5537.972310138504;5573.275474188411;5590.105583106683;5654.717264136777;5938.584299099108;5943.70281485924;5946.70266486674;5956.225690660186;5969.701514924236;5394.083005889008;5508.807191748269;5597.412271711493;5601.439856014366;5602.52378547828;4976.751162441863;5054.342935418372;5079.74601269935;5082.2122571001555;5102.744862756847;6140.692965351804;6148.938510614837;6165.753369865155;6165.876682466325;6170.136180934673;5909.468147866713;5921.259842519685;5947.881042379215;5961.195238642727;5970.552208584287;5991.191189189403;6042.758289668364;6128.846778830565;6132.540059495466;6135.07973803933;5793.304803423616;5816.534677225896;5830.7959221427045;5841.532677385884;5928.970355148197;5879.941200587939;5884.7940322088525;5897.321807992136;5901.852453688693;5902.557308201816;5653.010723123519;5699.800506982236;5753.338366087954;5772.826815195551;5873.970630146822;5728.828135155952;5731.398203188772;5732.856678583069;5737.454941780524;5741.081426971831;5620.072688006597;5620.522255608319;5631.8592035199445;5635.126555383922;5637.154426836008;5605.159226116115;5681.886362272814;5729.2265544151005;5744.626599271034;5790.768369265183;5697.971510142423;5747.7413516391025;5751.1085781703905;5759.193712880116;5768.423157684198 13:12:05 INFO - 2015-11-20 13:12:05,059 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.7721638002113;594.8988671925772;595.214317101426;596.3350863786877;599.322765275239;31457.370852582964;32257.51613725796;32272.838635806816;40114.19771604566;40845.795771021105;42980.570194298045;43488.347674784905;43642.12715745683;43783.562164378345;44098;6644.900326495106;6648.966755166218;6654.43437307827;6658.034584985175;6659.7003134858805;7668.156502784717;7831.451798374116;10425.687229383131;10642.78714425711;10647.52086156121;10417.218708596847;10451;10540.472976351151;10544.578216871316;10549.367037977747;7687.231276872324;7869.64586593599;10294;10400.79198416035;10402.427866467342;10177.440240786755;10537.683869483928;10576.471176441148;10582.99461551159;10612.469376531142;40411.191776164604;40801.4917986071;40832.591674083174;40868.59131408678;40881.182376352604;3267.2158681916408;3315.1049216711594;3383.441732114198;3398.575178102737;3401.098708842159;30429.391412171855;30825.882165096544;30868;31336.843315783502;31869.362612747846;3733.4773131761576;3778.527684039495;3792.677622402099;3794.582595914447;3803.790791506466;272203.1118755267;272666;273128;273449;273630;58504;58826.411735882946;58853;58896.705516473;58960.70519647374;57920.710396448594;60000;60052.09921851176;61007.38992610106;66735.66632166808;15827.68344633101;15873.603159920864;16003.27985240667;16013.199340032952;16016.279267432994;12230.266184028987;12288.078394120477;12299;12308.81536776949;12315.876841231653;19143.2342706293;19421;19459.4162175135;19504.512387190432;19516.90241548783;8146.959265203636;8290.212429819157;8313.792155196048;8361.665533378718;8369.455985360932;963.330485312701;973.756560859785;1001.884783249921;1029.6910926721953;1072.126217133034;24864.751352486604;25099.37251568689;25401.74598254031;25601.359966001;27524.58713119305;1001.2441201691112;1035.16151916946;1105.4969988655143;1117.1230583991528;1173.8708742038368;14224.075435096685;14227;14441.49454769078;14457.277136143151;15153.242337883283;258632;262612;262937;263099;263563;49719.25421118686;49929.251061234114;50003.749981249865;50069.499305007215;50156.498435015914;1350.4058214385639;1358.660334916271;1361.8501964783866;1376.6902446949557;1393.2685340196276;26019.739802601733;27323.72676273212;28690.56964145581;29216.853915731135;29334;45169.54830451653;45602.31596526121;45635;45646.77176614229;45758;300809;301831;302147;302897;303382;26769.86615066912;27962.300942475787;28619.28451788722;31841.840790795897;32384.67615323911;36933.44599830951;37025;37590.06024849401;38052.42921356237;38168.42747358736;35264.29471410609;35293.294134117685;35339.64660353467;35433.46849797203;36250.63749362472;28247.57628635531;34744.478832817025;35508.112297192776;35659.46510802288;36121.45817812682;32276.515852261764;32467.350652986337;32588.511172332906;32616.673833262314;32625;25861.48277034411;29807.403851923274;30231;30385.696143038287;30463.390732185675;23150.652740209247;23213.88393058024;23214.25893058061;23520.647190291817;23536.176233831735 13:12:05 INFO - 2015-11-20 13:12:05,059 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.8993729501252;356.70928193522275;356.7752316040894;357.3424898187335;360.4413159602616;14286.928565357184;14356.13863168208;16330.83669163308;17494.125293735327;18912.716309255356;16018.679626407466;16236.431724889631;16577.254023568938;16634.58413539659;16701.582460438494;5365.731713414333;5520.696361700105;5529.419410961851;5530.087535556629;5533.584981126432;4057.5333836608725;4157;5479.04116779564;5523.143912693519;5853.707314634251;5940.316863560681;5992.7902523411685;5994.340622531518;6032.758689652431;6033.758649654031;5253.553447956928;5426.864328391802;5431.728413579305;5434.347878254595;5977.790777322773;5172.948270517322;5199.4800519948085;5215.817446389358;5217.739113044333;5428.511433970922;11475.942620286929;11678.124140689397;11731.824022639667;11744.471498782576;11849.526018959232;1971.7338159348592;1995.720599116125;2044.4479990402656;2105.084288334564;2154.138344662132;9680.95159524205;9708.951455242679;10008.349457285325;10020.69937901864;10124.443155626437;1731.333436626895;1757.4376199616129;1820.4629634257926;1835.5411147213197;1875.1186942137174;56060.43939560593;56118.43881561173;63074.68462657657;67056.66471667611;68127.31872681259;9955.452450115314;10232;10312.793744125076;10320.071193592612;10408.635697750693;13510.324483775772;13525.59423217305;13556.186628802303;13559.728805423836;13565.660858478419;7712.228777122243;7722.073351197892;7821.687132514636;7823.921760782319;7995.840083198304;7612.429067819825;7657.119431265364;7666.769996900102;7712.460127791113;7713.3443657288635;4437.2234858899565;4542.931856022163;4555.681102322806;4560.95439045612;4578.931316030262;1751.20320254284;1769.1066011664027;1792.8834625749284;1794.698843338569;1869.560653246486;946.1815529566875;955.1403736637083;995.5022488755623;1025.3335332034237;1030.0523518363125;16272.43046493367;16999.40502082421;18053.368132115313;18379.356722514647;18454.35409760652;911.9042500537481;920.3557509743207;930.06993006993;959.2469911119738;982.2044144243043;9583.185429238454;10445.68662940113;10460.372377657364;10483;10526.368417894952;486114;494073;496750;497387;505148;76475.61762191153;78732.6063369691;78980.70702576262;79279;79783.20216797874;1205.3852535207106;1217.0567809947186;1217.2635555488978;1221.267239656199;1236.863944966053;15758.842411576195;15775.447859324868;15980.840191597936;16088.356465741239;16375.59061023484;35621;35698.286034279685;35862.820685896404;36102.4584631236;36706;45094;47031.76484117557;47485.762571186926;47647;47664.52335476601;9645.42127472354;9761.951190244003;9902.158316543175;9902.702918912444;9920.751981200528;11335.489902954221;11419;11419.25774824667;11499.885001150216;15760.290786914387;11721.531138754355;12215.69460763488;13521.256330901895;14846.257687115816;15044.569312622389;13855.16868987864;13861.445542178604;13866.445342186604;14376.653603612498;14677.412903484168;11604.477798499256;13099.934500327437;14353.354099065358;14767.556973290819;15250.694986100438;9595.23238140933;9632.22942164611;9728.562214700498;9799.706008819747;9814.312998090065;10335.22485813582;13874.236916969663;14426.85573144255;14441.277936103363;14581.052231604912 13:12:05 INFO - 2015-11-20 13:12:05,061 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1599.5603956439195;1740.434358833379;1790.5255107396533;1799.0824679413495;1835.807240239774;6942.687579058942;7530.35991940685;7735.961320193405;7740.071191457026;7770.96114519428;7601.809954751134;7709.922900770991;7713.961430192841;7714.922850771491;7715.884261736079;2288.2220045184636;2312.283192210412;2318.6290193569034;2319.257837492003;2321.431249343913;2330.265966220635;2354.9175778847743;2359.551685179819;2360;2364.148906393697;2276.5105502316997;2294.33464295355;2298.6437102249092;2302.297799171252;2315.6758053872472;2225.1989283857797;2230.4535388829677;2232.0290673556974;2236.1055577768943;2246.2924178883763;2313.884305784704;2319.420144963759;2327.0459111764094;2330.394097534653;2330.941726456835;6863.073485079501;7029.789106326818;7656.808579785495;7683.462157648967;7688.077430708351;4566.360709500673;4696.694714843558;4702.3181638662545;4713.764311784397;4714.457837348715;3070.355225402668;3106.130283520618;3166.2401023754132;3171.6035495563056;3175.412548678502;976.4483067067084;977.3549457358109;986.8174387738292;1012.2256473797551;1028.7428142964259;10347.896521034843;10401.79196416075;10463.581456741646;10474.895251047468;10495.685129446128;4063.756174629532;4154.584541545882;4210.32634778434;4224.387463817729;4243.787810609457;8516.61675224604;8523.872141917876;8544.359173061921;8604;8611.569421528899;4601.677882548256;4631.583157515773;4637.188492013952;4663.743494107789;4678.976605116953;4283.485981682155;4303.978480107579;4314.115606300701;4347.673924455678;4362.432883725095;3404.3361544498584;3445.9655403445645;3455.1362159460136;3461.0828130545424;3472.6700963408434;1049.5539395756773;1057.3285963413289;1059.7085801404676;1062.946852657364;1068.2095249515303;1052.4737631184407;1209.4376115106518;1363.222962911151;1388.632012516684;1395.3860301467525;7222.927770722331;7254.96372518134;7258.455615828834;7270.63646817657;7290.854182916312;499.597823751876;499.8850264439199;1190.9344986025678;1211.7091897944606;1219.688979310288;5458.536024437888;5535.335759708861;5822.854428639318;5889.293284805851;5895.941040589625;8309.293710034593;8918.598663060178;9138.68014619485;9202.861957070649;9236.491992940453;8958.19376256127;9087.409318394415;9089.81820363589;9188;9321.533923303943;7146.2496437874315;7218.963905180441;7221.494495385273;7236.34872861445;7271.854562908818;7037.120359955005;7164.104486939133;7169.318914703095;7170;7191.676374563262;8000.199980001953;8176.632051557575;8207.302379297587;8218.58907054633;8243.505389676639;8268.875966860382;8418;8428.45215061019;8450.873236901329;8529.402941794264;6568.27748947625;6591.143151390289;6597;6621.569597976116;6642.302558231316;7326.084239470067;7438.107427108782;7463.701451941862;7467.813304667427;7516.398688105048;6977.267386924503;7007.614581198083;7088.645567721696;7135.750248741269;7163.964180179066;6873.862522749417;6953.548019378724;7000.719971201299;7079.8938015930835;7121.715131394686;6877.9656101721175;6942.479314051366;6949.444044476329;6956.79129626112;6967.0246165535855;6157.507399408126;6166.260048794174;6210.192674952227;6257.1240026395435;6304.495640348853;6370.58591191571;6400.743970241325;6401;6401.263854656588;6402.519811014099 13:12:05 INFO - 2015-11-20 13:12:05,064 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.3568979885129;322.48724528000474;331.8838406557704;336.23338787564364;340.91988382730057;6043.728032238554;6066.696665166735;6085.513158947285;6110.17512635794;6201.3178550359535;5817.767289308433;5831.446012628804;5963.463288304052;6025.7948410318;6049.697515124249;4628.69913455626;4651.674382793206;4661.86014419568;4683.836065737708;4688.437387513486;4434.490033646123;4676.836310729125;4677.111348843726;4687.273472611751;4687.9531204687855;4493.213687604656;4533.410656614636;4652.023075154221;4652.441706995149;4666.393368862043;4621.607163391116;4623.74569398683;4638.026014536951;4640.280756482751;4641.489436162003;4047.028713108862;4070.7761073140964;4076;4080.5307389650275;4081.5306239782212;5620.241267428885;5743.971280143573;5744.454276843735;5749.741261643236;5751.942480575224;5269.578433725293;5341.519263266325;5355.116405793078;5355.544778693816;5358.571314294847;6465.288818229991;6468.191476065492;6481.28705842357;6482.157319548475;6486.610803351767;4410.75740834254;4411.845585404495;4414.53647367025;4421.646268298528;4426.203283408985;6552.705128269192;6623.370779775913;6688.4649228061635;6704.966475167642;6710.698018589175;4495.235809912323;4505.256632655575;4506.391637128946;4510.616597589176;4510.797014134372;4554.567316104964;4555.9772201138785;4556.498785133633;4560.1335746208115;4560.8175672973375;5323.441038690959;5324.094903866352;5329.493698098674;5333.57331413486;5345.625806193607;6345.270293916166;6505.284418713938;6507.154069970874;6513.381228783258;6525.249596296392;1598.5763772600271;1630.4945466905297;1631.3474610155795;1631.6899789040044;1635.860951819085;1039.3504059962524;1043.0612448796144;1048.7168464514539;1050.1283934334483;1067.5214827463863;6288.056791481315;6293.024581189923;6293.465055470337;6293.653849038347;6295.842603934847;6512.73949042033;6678.232003319583;6722.159730033746;6727.394534491919;6731.764388246485;6146.631202127886;6216.813495595139;6296.6851657417865;6298.212723409574;6303.495720342362;3586.4620306953643;3639.79981101042;3640.4175331946763;3647.1976165243605;3652.123490362347;6823.249442561314;7005.5796652200015;7005.649717514104;7020.333068358498;7022.227554968949;6886.552374095668;6906.861862762717;6916.619585922722;6917.89623155653;6920.9653951729915;7013.228544860061;7016.5790052597;7016.859662806715;7017.122859642544;7020.157581090302;6598.274189839018;6734.292899245509;6738.59568425896;6741.494387921024;6746.494012949147;6667.766628167991;6670.566413183127;6673.1992160941;6679.732810687518;6681.76613818514;6890.655467226718;6902.240753517009;6907.309269073053;6916.585004899722;7025.789226323219;4441.666874984325;4544.522825103317;4547.567981041796;4547.886302842456;4552.226121559276;6717.026031225542;6723.630200339028;6724.4284235840505;6730.966345168439;6734.528582999143;6544.083828264142;6552.868942621216;6553.934460655332;6555.508336874849;6560.212774467094;6397.8720425592155;6515.087887695821;6544.28012918569;6552.213734351908;6558.278589355072;6399.392057754506;6399.648019358794;6399.8080057598345;6407.8718425630295;6410.519211059096;6567.408933196035;6567.704453299518;6575.704093315717;6580.5722628029025;6582.243042050225;6303.054541818764;6411.71147298382;6426.903596446151;6426.967865160645;6437.195350581177 13:12:05 INFO - 2015-11-20 13:12:05,065 DEBUG : BROWSER_OUTPUT: |5;yui.html;780.918003609621;859.3369693718395;859.5873980489368;861.2980420956919;897.7127319257836;12048.397580120993;12603.684907877308;12614.621561353162;12628.747425051493;12681.239125652455;12015.879841201586;12131.514739410413;12143.878561214386;12145.817812732794;12163.148579599409;688.2876223109083;692.0207905813268;804.0712976512137;828.8549503836834;829.9792505187388;822.9670813167467;826.8263664630434;831.9500829950192;832.488019867783;832.8167803083312;725.7314793526376;866.4108406283724;873.2839071960994;875.0330884372772;875.2691502595341;727.4725823777745;867.483847110968;871.9084496127879;872.6640243506264;874.8556488179443;640.7917426836296;640.817367050393;642.0593830038969;643.234550884446;643.4016364780751;12768;12868.742625147539;12887.93556032214;12891.935540322238;12932.935335323264;12481.937590312082;13094.083414161012;13112;13483.258420786853;13496.730065398735;10598.68203953875;10599.735006624818;10657.200709946708;10761.461926903623;10847.783044339149;3627.4014787560022;3640.253747981684;3694.408894576855;3712.6101759315425;3795.1840354323676;47940;48068.27897581539;48401.27398089031;50044.74977625125;50083.24875126876;10496.26526143178;10539.156867450585;10568.256237720843;10616.150707943347;10965.671029869116;19579.11893964775;19589;19598;19603.803961960482;19607.607847842963;7783.571903545246;7786.844263114819;7801.414893882981;7802.258785415376;8010.839783204303;4338.436003319548;4354.085642015212;4363.0401311712;4399.14216727735;4471.530489298577;3019.9396012079637;3072.60056192698;3072.6466456357357;3072.6927307269543;3078.1381213260324;545.8553483326922;558.611764823452;562.103445005216;566.9518090962232;573.0744847071949;519.5064688545897;587.3275100010464;628.8710814283061;686.5647914472464;693.3586432549871;8761.167689069656;8921.643134274686;8973.641054357753;8982.505962172012;9101.908980910239;546.4098773324799;684.7979845945458;716.0691101567941;725.2964624314407;727.0729819480205;3622.3117607654463;4152.854650087233;4209.221294060609;4212.662986961036;4309.5044069932355;55102.44897550973;55688;55752.72123639356;56345;56644.71677641668;53048.77743949617;53391.46608533942;53671.46328536743;53683.19475207875;54073.45926540684;47482.76258618685;47721;47866.9999999993;48070.75964620154;48072.519274807506;8091.919080809116;8267.545285009142;8394.328453723809;8471.110533393905;8536.103709110454;34645.826770865984;35173.47239791354;35279.470807938415;35777;35914;42772.786136069124;42902.570974291106;47449.28826067543;48194.036119276716;48308.27537586869;9937.900620993987;9982.35114717541;10332.690019299433;10453.686389408025;10574.788504229718;11467.713307167387;11731.824022639497;11818.527258909548;12069.57756478519;12099;10240.231982601485;10415.94792026035;10480.318779279323;10546;11164.553417863195;10749.140068794633;11152.832707509557;11193.944030279796;11199.328040317607;11480.942595287304;10808.837867432152;10898.836517452086;11073.5570577176;11186.440677966231;11190.272632278877;9211.447313161232;9754.463504507321;9854.26093043039;10018.39889606626;10079.798404032024;8829.558522074;8933.374663773473;9263;9614.18279446255;9671.177949874058 13:12:05 INFO - 2015-11-20 13:12:05,065 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1167 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053925051__endTimestamp 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,066 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5469.69 Median:5681.89 stddev:619.52 (10.9%) stddev-sans-first:594.49 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: Values: 3166.8 3256.1 3300.3 3306.8 3314.6 5275.7 5384.6 5400.8 5417.3 5430.6 5310.2 5348.1 5355.4 5420.6 5424.3 4942.4 4969.1 4993.6 5013.7 5063.6 4860.9 5083.9 5092.6 5110.7 5153.8 4794.1 4925.7 4937.9 4948.9 5000.0 4972.3 4988.9 5005.7 5008.2 5039.6 4832.3 4926.1 4973.3 4980.6 5003.0 5243.7 5303.8 5310.9 5314.2 5322.1 5953.5 5954.9 5956.0 5956.9 5958.9 5848.8 5906.6 5994.2 6007.1 6041.3 5580.7 5581.1 5583.2 5587.2 5630.2 6011.4 6029.7 6032.2 6035.0 6035.5 5686.9 5799.0 5799.2 5834.9 5894.5 5890.3 5943.9 5946.2 5962.0 5966.2 5845.2 5862.9 5911.6 5921.9 5925.4 5804.5 5813.2 5822.3 5907.3 5926.2 4517.8 4547.9 4567.0 4570.7 4616.4 3938.2 4042.6 4064.6 4074.7 4105.4 5511.5 5538.0 5573.3 5590.1 5654.7 5938.6 5943.7 5946.7 5956.2 5969.7 5394.1 5508.8 5597.4 5601.4 5602.5 4976.8 5054.3 5079.7 5082.2 5102.7 6140.7 6148.9 6165.8 6165.9 6170.1 5909.5 5921.3 5947.9 5961.2 5970.6 5991.2 6042.8 6128.8 6132.5 6135.1 5793.3 5816.5 5830.8 5841.5 5929.0 5879.9 5884.8 5897.3 5901.9 5902.6 5653.0 5699.8 5753.3 5772.8 5874.0 5728.8 5731.4 5732.9 5737.5 5741.1 5620.1 5620.5 5631.9 5635.1 5637.2 5605.2 5681.9 5729.2 5744.6 5790.8 5698.0 5747.7 5751.1 5759.2 5768.4 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44649.94 Median:31102.42 stddev:72963.04 (234.6%) stddev-sans-first:73092.58 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: Values: 546.8 594.9 595.2 596.3 599.3 31457.4 32257.5 32272.8 40114.2 40845.8 42980.6 43488.3 43642.1 43783.6 44098.0 6644.9 6649.0 6654.4 6658.0 6659.7 7668.2 7831.5 10425.7 10642.8 10647.5 10417.2 10451.0 10540.5 10544.6 10549.4 7687.2 7869.6 10294.0 10400.8 10402.4 10177.4 10537.7 10576.5 10583.0 10612.5 40411.2 40801.5 40832.6 40868.6 40881.2 3267.2 3315.1 3383.4 3398.6 3401.1 30429.4 30825.9 30868.0 31336.8 31869.4 3733.5 3778.5 3792.7 3794.6 3803.8 272203.1 272666.0 273128.0 273449.0 273630.0 58504.0 58826.4 58853.0 58896.7 58960.7 57920.7 60000.0 60052.1 61007.4 66735.7 15827.7 15873.6 16003.3 16013.2 16016.3 12230.3 12288.1 12299.0 12308.8 12315.9 19143.2 19421.0 19459.4 19504.5 19516.9 8147.0 8290.2 8313.8 8361.7 8369.5 963.3 973.8 1001.9 1029.7 1072.1 24864.8 25099.4 25401.7 25601.4 27524.6 1001.2 1035.2 1105.5 1117.1 1173.9 14224.1 14227.0 14441.5 14457.3 15153.2 258632.0 262612.0 262937.0 263099.0 263563.0 49719.3 49929.3 50003.7 50069.5 50156.5 1350.4 1358.7 1361.9 1376.7 1393.3 26019.7 27323.7 28690.6 29216.9 29334.0 45169.5 45602.3 45635.0 45646.8 45758.0 300809.0 301831.0 302147.0 302897.0 303382.0 26769.9 27962.3 28619.3 31841.8 32384.7 36933.4 37025.0 37590.1 38052.4 38168.4 35264.3 35293.3 35339.6 35433.5 36250.6 28247.6 34744.5 35508.1 35659.5 36121.5 32276.5 32467.4 32588.5 32616.7 32625.0 25861.5 29807.4 30231.0 30385.7 30463.4 23150.7 23213.9 23214.3 23520.6 23536.2 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,067 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27357.29 Median:17988.89 stddev:81144.94 (451.1%) stddev-sans-first:81347.24 13:12:05 INFO - 2015-11-20 13:12:05,068 DEBUG : BROWSER_OUTPUT: Values: 353.9 356.7 356.8 357.3 360.4 14286.9 14356.1 16330.8 17494.1 18912.7 16018.7 16236.4 16577.3 16634.6 16701.6 5365.7 5520.7 5529.4 5530.1 5533.6 4057.5 4157.0 5479.0 5523.1 5853.7 5940.3 5992.8 5994.3 6032.8 6033.8 5253.6 5426.9 5431.7 5434.3 5977.8 5172.9 5199.5 5215.8 5217.7 5428.5 11475.9 11678.1 11731.8 11744.5 11849.5 1971.7 1995.7 2044.4 2105.1 2154.1 9681.0 9709.0 10008.3 10020.7 10124.4 1731.3 1757.4 1820.5 1835.5 1875.1 56060.4 56118.4 63074.7 67056.7 68127.3 9955.5 10232.0 10312.8 10320.1 10408.6 13510.3 13525.6 13556.2 13559.7 13565.7 7712.2 7722.1 7821.7 7823.9 7995.8 7612.4 7657.1 7666.8 7712.5 7713.3 4437.2 4542.9 4555.7 4561.0 4578.9 1751.2 1769.1 1792.9 1794.7 1869.6 946.2 955.1 995.5 1025.3 1030.1 16272.4 16999.4 18053.4 18379.4 18454.4 911.9 920.4 930.1 959.2 982.2 9583.2 10445.7 10460.4 10483.0 10526.4 486114.0 494073.0 496750.0 497387.0 505148.0 76475.6 78732.6 78980.7 79279.0 79783.2 1205.4 1217.1 1217.3 1221.3 1236.9 15758.8 15775.4 15980.8 16088.4 16375.6 35621.0 35698.3 35862.8 36102.5 36706.0 45094.0 47031.8 47485.8 47647.0 47664.5 9645.4 9762.0 9902.2 9902.7 9920.8 11335.5 11419.0 11419.3 11499.9 15760.3 11721.5 12215.7 13521.3 14846.3 15044.6 13855.2 13861.4 13866.4 14376.7 14677.4 11604.5 13099.9 14353.4 14767.6 15250.7 9595.2 9632.2 9728.6 9799.7 9814.3 10335.2 13874.2 14426.9 14441.3 14581.1 13:12:05 INFO - 2015-11-20 13:12:05,069 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,069 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5368.50 Median:6280.81 stddev:2731.72 (43.5%) stddev-sans-first:2724.69 13:12:05 INFO - 2015-11-20 13:12:05,069 DEBUG : BROWSER_OUTPUT: Values: 1599.6 1740.4 1790.5 1799.1 1835.8 6942.7 7530.4 7736.0 7740.1 7771.0 7601.8 7709.9 7714.0 7714.9 7715.9 2288.2 2312.3 2318.6 2319.3 2321.4 2330.3 2354.9 2359.6 2360.0 2364.1 2276.5 2294.3 2298.6 2302.3 2315.7 2225.2 2230.5 2232.0 2236.1 2246.3 2313.9 2319.4 2327.0 2330.4 2330.9 6863.1 7029.8 7656.8 7683.5 7688.1 4566.4 4696.7 4702.3 4713.8 4714.5 3070.4 3106.1 3166.2 3171.6 3175.4 976.4 977.4 986.8 1012.2 1028.7 10347.9 10401.8 10463.6 10474.9 10495.7 4063.8 4154.6 4210.3 4224.4 4243.8 8516.6 8523.9 8544.4 8604.0 8611.6 4601.7 4631.6 4637.2 4663.7 4679.0 4283.5 4304.0 4314.1 4347.7 4362.4 3404.3 3446.0 3455.1 3461.1 3472.7 1049.6 1057.3 1059.7 1062.9 1068.2 1052.5 1209.4 1363.2 1388.6 1395.4 7222.9 7255.0 7258.5 7270.6 7290.9 499.6 499.9 1190.9 1211.7 1219.7 5458.5 5535.3 5822.9 5889.3 5895.9 8309.3 8918.6 9138.7 9202.9 9236.5 8958.2 9087.4 9089.8 9188.0 9321.5 7146.2 7219.0 7221.5 7236.3 7271.9 7037.1 7164.1 7169.3 7170.0 7191.7 8000.2 8176.6 8207.3 8218.6 8243.5 8268.9 8418.0 8428.5 8450.9 8529.4 6568.3 6591.1 6597.0 6621.6 6642.3 7326.1 7438.1 7463.7 7467.8 7516.4 6977.3 7007.6 7088.6 7135.8 7164.0 6873.9 6953.5 7000.7 7079.9 7121.7 6878.0 6942.5 6949.4 6956.8 6967.0 6157.5 6166.3 6210.2 6257.1 6304.5 6370.6 6400.7 6401.0 6401.3 6402.5 13:12:05 INFO - 2015-11-20 13:12:05,069 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,069 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5413.75 Median:6209.07 stddev:1655.68 (26.7%) stddev-sans-first:1615.62 13:12:05 INFO - 2015-11-20 13:12:05,070 DEBUG : BROWSER_OUTPUT: Values: 322.4 322.5 331.9 336.2 340.9 6043.7 6066.7 6085.5 6110.2 6201.3 5817.8 5831.4 5963.5 6025.8 6049.7 4628.7 4651.7 4661.9 4683.8 4688.4 4434.5 4676.8 4677.1 4687.3 4688.0 4493.2 4533.4 4652.0 4652.4 4666.4 4621.6 4623.7 4638.0 4640.3 4641.5 4047.0 4070.8 4076.0 4080.5 4081.5 5620.2 5744.0 5744.5 5749.7 5751.9 5269.6 5341.5 5355.1 5355.5 5358.6 6465.3 6468.2 6481.3 6482.2 6486.6 4410.8 4411.8 4414.5 4421.6 4426.2 6552.7 6623.4 6688.5 6705.0 6710.7 4495.2 4505.3 4506.4 4510.6 4510.8 4554.6 4556.0 4556.5 4560.1 4560.8 5323.4 5324.1 5329.5 5333.6 5345.6 6345.3 6505.3 6507.2 6513.4 6525.2 1598.6 1630.5 1631.3 1631.7 1635.9 1039.4 1043.1 1048.7 1050.1 1067.5 6288.1 6293.0 6293.5 6293.7 6295.8 6512.7 6678.2 6722.2 6727.4 6731.8 6146.6 6216.8 6296.7 6298.2 6303.5 3586.5 3639.8 3640.4 3647.2 3652.1 6823.2 7005.6 7005.6 7020.3 7022.2 6886.6 6906.9 6916.6 6917.9 6921.0 7013.2 7016.6 7016.9 7017.1 7020.2 6598.3 6734.3 6738.6 6741.5 6746.5 6667.8 6670.6 6673.2 6679.7 6681.8 6890.7 6902.2 6907.3 6916.6 7025.8 4441.7 4544.5 4547.6 4547.9 4552.2 6717.0 6723.6 6724.4 6731.0 6734.5 6544.1 6552.9 6553.9 6555.5 6560.2 6397.9 6515.1 6544.3 6552.2 6558.3 6399.4 6399.6 6399.8 6407.9 6410.5 6567.4 6567.7 6575.7 6580.6 6582.2 6303.1 6411.7 6426.9 6427.0 6437.2 13:12:05 INFO - 2015-11-20 13:12:05,070 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,070 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13888.82 Median:47903.50 stddev:16215.67 (33.9%) stddev-sans-first:16231.29 13:12:05 INFO - 2015-11-20 13:12:05,070 DEBUG : BROWSER_OUTPUT: Values: 780.9 859.3 859.6 861.3 897.7 12048.4 12603.7 12614.6 12628.7 12681.2 12015.9 12131.5 12143.9 12145.8 12163.1 688.3 692.0 804.1 828.9 830.0 823.0 826.8 832.0 832.5 832.8 725.7 866.4 873.3 875.0 875.3 727.5 867.5 871.9 872.7 874.9 640.8 640.8 642.1 643.2 643.4 12768.0 12868.7 12887.9 12891.9 12932.9 12481.9 13094.1 13112.0 13483.3 13496.7 10598.7 10599.7 10657.2 10761.5 10847.8 3627.4 3640.3 3694.4 3712.6 3795.2 47940.0 48068.3 48401.3 50044.7 50083.2 10496.3 10539.2 10568.3 10616.2 10965.7 19579.1 19589.0 19598.0 19603.8 19607.6 7783.6 7786.8 7801.4 7802.3 8010.8 4338.4 4354.1 4363.0 4399.1 4471.5 3019.9 3072.6 3072.6 3072.7 3078.1 545.9 558.6 562.1 567.0 573.1 519.5 587.3 628.9 686.6 693.4 8761.2 8921.6 8973.6 8982.5 9101.9 546.4 684.8 716.1 725.3 727.1 3622.3 4152.9 4209.2 4212.7 4309.5 55102.4 55688.0 55752.7 56345.0 56644.7 53048.8 53391.5 53671.5 53683.2 54073.5 47482.8 47721.0 47867.0 48070.8 48072.5 8091.9 8267.5 8394.3 8471.1 8536.1 34645.8 35173.5 35279.5 35777.0 35914.0 42772.8 42902.6 47449.3 48194.0 48308.3 9937.9 9982.4 10332.7 10453.7 10574.8 11467.7 11731.8 11818.5 12069.6 12099.0 10240.2 10415.9 10480.3 10546.0 11164.6 10749.1 11152.8 11193.9 11199.3 11480.9 10808.8 10898.8 11073.6 11186.4 11190.3 9211.4 9754.5 9854.3 10018.4 10079.8 8829.6 8933.4 9263.0 9614.2 9671.2 13:12:05 INFO - 2015-11-20 13:12:05,070 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:05 INFO - 2015-11-20 13:12:05,071 DEBUG : BROWSER_OUTPUT: 13:12:05 INFO - 2015-11-20 13:12:05,752 INFO : Browser exited with error code: 0 13:12:05 INFO - 2015-11-20 13:12:05,768 INFO : Completed test dromaeo_css (00:18:34) 13:12:05 INFO - 2015-11-20 13:12:05,768 INFO : Starting test kraken 13:12:05 INFO - 2015-11-20 13:12:05,769 DEBUG : operating with platform_type : linux_ 13:12:05 INFO - 2015-11-20 13:12:05,769 INFO : Initialising browser for kraken test... 13:12:05 INFO - 2015-11-20 13:12:05,775 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW86S3O/profile http://localhost:59888/getInfo.html 13:12:09 INFO - 2015-11-20 13:12:09,905 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:12:09 INFO - 2015-11-20 13:12:09,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:12:09 INFO - 2015-11-20 13:12:09,906 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:12:09 INFO - 2015-11-20 13:12:09,906 DEBUG : BROWSER_OUTPUT: __metrics 13:12:10 INFO - 2015-11-20 13:12:10,010 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:11 INFO - 2015-11-20 13:12:11,445 INFO : Browser initialized. 13:12:11 INFO - 2015-11-20 13:12:11,446 INFO : Running cycle 1/1 for kraken test... 13:12:11 INFO - 2015-11-20 13:12:11,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW86S3O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:12:23 INFO - 2015-11-20 13:12:23,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 13:12:23 INFO - 2015-11-20 13:12:23,185 DEBUG : BROWSER_OUTPUT: 13:12:25 INFO - 2015-11-20 13:12:25,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59888/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:26 INFO - 2015-11-20 13:12:26,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 176480256 13:12:26 INFO - 2015-11-20 13:12:26,201 DEBUG : BROWSER_OUTPUT: 13:12:28 INFO - 2015-11-20 13:12:28,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59888/tests/kraken/driver.html?testName=audio-dft) 13:12:29 INFO - 2015-11-20 13:12:29,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 168300544 13:12:29 INFO - 2015-11-20 13:12:29,384 DEBUG : BROWSER_OUTPUT: 13:12:32 INFO - 2015-11-20 13:12:32,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59888/tests/kraken/driver.html?testName=audio-fft) 13:12:32 INFO - 2015-11-20 13:12:32,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 151408640 13:12:32 INFO - 2015-11-20 13:12:32,844 DEBUG : BROWSER_OUTPUT: 13:12:34 INFO - 2015-11-20 13:12:34,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59888/tests/kraken/driver.html?testName=audio-oscillator) 13:12:35 INFO - 2015-11-20 13:12:35,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 155107328 13:12:35 INFO - 2015-11-20 13:12:35,382 DEBUG : BROWSER_OUTPUT: 13:12:37 INFO - 2015-11-20 13:12:37,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59888/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:38 INFO - 2015-11-20 13:12:38,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 155705344 13:12:38 INFO - 2015-11-20 13:12:38,110 DEBUG : BROWSER_OUTPUT: 13:12:41 INFO - 2015-11-20 13:12:41,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59888/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:41 INFO - 2015-11-20 13:12:41,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 155410432 13:12:41 INFO - 2015-11-20 13:12:41,618 DEBUG : BROWSER_OUTPUT: 13:12:45 INFO - 2015-11-20 13:12:45,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59888/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:45 INFO - 2015-11-20 13:12:45,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 156782592 13:12:45 INFO - 2015-11-20 13:12:45,574 DEBUG : BROWSER_OUTPUT: 13:12:48 INFO - 2015-11-20 13:12:48,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59888/tests/kraken/driver.html?testName=json-parse-financial) 13:12:48 INFO - 2015-11-20 13:12:48,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 155807744 13:12:48 INFO - 2015-11-20 13:12:48,913 DEBUG : BROWSER_OUTPUT: 13:12:50 INFO - 2015-11-20 13:12:50,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59888/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:51 INFO - 2015-11-20 13:12:51,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 165560320 13:12:51 INFO - 2015-11-20 13:12:51,009 DEBUG : BROWSER_OUTPUT: 13:12:52 INFO - 2015-11-20 13:12:52,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:53 INFO - 2015-11-20 13:12:53,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 164659200 13:12:53 INFO - 2015-11-20 13:12:53,420 DEBUG : BROWSER_OUTPUT: 13:12:55 INFO - 2015-11-20 13:12:55,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:56 INFO - 2015-11-20 13:12:56,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 168460288 13:12:56 INFO - 2015-11-20 13:12:56,091 DEBUG : BROWSER_OUTPUT: 13:12:58 INFO - 2015-11-20 13:12:58,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:59 INFO - 2015-11-20 13:12:59,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 177942528 13:12:59 INFO - 2015-11-20 13:12:59,050 DEBUG : BROWSER_OUTPUT: 13:13:01 INFO - 2015-11-20 13:13:01,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:02 INFO - 2015-11-20 13:13:02,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 177512448 13:13:02 INFO - 2015-11-20 13:13:02,150 DEBUG : BROWSER_OUTPUT: 13:13:03 INFO - 2015-11-20 13:13:03,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59888/tests/kraken/driver.html?testName=ai-astar) 13:13:04 INFO - 2015-11-20 13:13:04,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 237367296 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:13:04 INFO - 2015-11-20 13:13:04,063 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;104;110;109;110;100;112;110;100 13:13:04 INFO - 2015-11-20 13:13:04,064 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;153;163;133;162;155;128;161;124 13:13:04 INFO - 2015-11-20 13:13:04,064 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;161;160;160;159;162;161;161 13:13:04 INFO - 2015-11-20 13:13:04,064 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;86;98;71;73;73;129;90;72 13:13:04 INFO - 2015-11-20 13:13:04,064 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;137;90;91;90;132;90;91;134 13:13:04 INFO - 2015-11-20 13:13:04,064 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 13:13:04 INFO - 2015-11-20 13:13:04,065 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;147;145;145;145;145;145;145;146 13:13:04 INFO - 2015-11-20 13:13:04,065 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;95;96;95 13:13:04 INFO - 2015-11-20 13:13:04,065 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;57;58;57;56;57;65;55;55 13:13:04 INFO - 2015-11-20 13:13:04,065 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;77;68;69;69;69;69;70;68 13:13:04 INFO - 2015-11-20 13:13:04,066 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;87;84;85;85;84;93;94;85;85 13:13:04 INFO - 2015-11-20 13:13:04,066 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;122;117;113;118;116;123;124;121;126 13:13:04 INFO - 2015-11-20 13:13:04,066 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;155;150;148;150;139;161;140;147;137 13:13:04 INFO - 2015-11-20 13:13:04,067 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;67;66;67;64;66;66;65;66 13:13:04 INFO - 2015-11-20 13:13:04,067 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:13:04 INFO - 2015-11-20 13:13:04,067 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:13:04 INFO - 2015-11-20 13:13:04,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 13:13:04 INFO - 2015-11-20 13:13:04,067 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:13:04 INFO - 2015-11-20 13:13:04,068 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053984057__endTimestamp 13:13:04 INFO - 2015-11-20 13:13:04,068 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,068 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:110.00 stddev:4.37 (4.0%) stddev-sans-first:4.63 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 104.0 110.0 109.0 110.0 100.0 112.0 110.0 100.0 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.50 Median:154.00 stddev:16.51 (10.7%) stddev-sans-first:17.28 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 153.0 163.0 133.0 162.0 155.0 128.0 161.0 124.0 13:13:04 INFO - 2015-11-20 13:13:04,069 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 161.0 160.0 160.0 159.0 162.0 161.0 161.0 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.50 Median:73.00 stddev:18.64 (25.5%) stddev-sans-first:19.30 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 86.0 98.0 71.0 73.0 73.0 129.0 90.0 72.0 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:90.50 stddev:21.18 (23.4%) stddev-sans-first:21.96 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 137.0 90.0 91.0 90.0 132.0 90.0 91.0 134.0 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:13:04 INFO - 2015-11-20 13:13:04,070 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.88 (5.0%) stddev-sans-first:3.00 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 57.0 58.0 57.0 56.0 57.0 65.0 55.0 55.0 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,071 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:2.67 (3.9%) stddev-sans-first:2.77 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 77.0 68.0 69.0 69.0 69.0 69.0 70.0 68.0 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.00 stddev:3.98 (4.6%) stddev-sans-first:3.86 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: Values: 92.0 87.0 84.0 85.0 85.0 84.0 93.0 94.0 85.0 85.0 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.50 stddev:4.43 (3.6%) stddev-sans-first:4.24 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: Values: 114.0 122.0 117.0 113.0 118.0 116.0 123.0 124.0 121.0 126.0 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.00 stddev:7.75 (5.2%) stddev-sans-first:7.83 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: Values: 140.0 155.0 150.0 148.0 150.0 139.0 161.0 140.0 147.0 137.0 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 67.0 66.0 67.0 64.0 66.0 66.0 65.0 66.0 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:13:04 INFO - 2015-11-20 13:13:04,073 DEBUG : BROWSER_OUTPUT: 13:13:04 INFO - 2015-11-20 13:13:04,865 INFO : Browser exited with error code: 0 13:13:04 INFO - 2015-11-20 13:13:04,913 INFO : Completed test kraken (00:00:59) 13:13:04 INFO - 2015-11-20 13:13:04,913 INFO : Starting test v8_7 13:13:04 INFO - 2015-11-20 13:13:04,913 DEBUG : operating with platform_type : linux_ 13:13:04 INFO - 2015-11-20 13:13:04,913 INFO : Initialising browser for v8_7 test... 13:13:04 INFO - 2015-11-20 13:13:04,919 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbs4vVK/profile http://localhost:59888/getInfo.html 13:13:08 INFO - 2015-11-20 13:13:08,944 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:13:08 INFO - 2015-11-20 13:13:08,944 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:13:08 INFO - 2015-11-20 13:13:08,944 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:13:08 INFO - 2015-11-20 13:13:08,944 DEBUG : BROWSER_OUTPUT: __metrics 13:13:09 INFO - 2015-11-20 13:13:09,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] 13:13:10 INFO - 2015-11-20 13:13:10,439 INFO : Browser initialized. 13:13:10 INFO - 2015-11-20 13:13:10,440 INFO : Running cycle 1/1 for v8_7 test... 13:13:10 INFO - 2015-11-20 13:13:10,440 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbs4vVK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:13:22 INFO - 2015-11-20 13:13:22,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 142426112 13:13:22 INFO - 2015-11-20 13:13:22,226 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59888/tests/v8_7/run.html (next: http://localhost:59888/tests/v8_7/run.html) 13:13:43 INFO - 2015-11-20 13:13:43,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 626843648 13:13:43 INFO - 2015-11-20 13:13:43,985 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: |0;Richards;162.89297931259162 13:13:43 INFO - 2015-11-20 13:13:43,987 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.32568985619898 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.2737719046251 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |5;Earley;753.0120481927711 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 13:13:43 INFO - 2015-11-20 13:13:43,988 DEBUG : BROWSER_OUTPUT: |8;Splay;595.2380952380952 13:13:43 INFO - 2015-11-20 13:13:43,989 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:13:43 INFO - 2015-11-20 13:13:43,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:13:43 INFO - 2015-11-20 13:13:43,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1448054023986__endTimestamp 13:13:43 INFO - 2015-11-20 13:13:43,989 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,989 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:13:43 INFO - 2015-11-20 13:13:43,990 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.89 Median:162.89 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: Values: 162.9 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.33 Median:194.33 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: Values: 194.3 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.27 Median:287.27 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: Values: 287.3 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: Values: 5025.1 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,991 DEBUG : BROWSER_OUTPUT: Values: 1992.0 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:753.01 Median:753.01 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: Values: 753.0 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: Values: 12156.6 13:13:43 INFO - 2015-11-20 13:13:43,992 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: Values: 26128.2 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.24 Median:595.24 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: Values: 595.2 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:13:43 INFO - 2015-11-20 13:13:43,993 DEBUG : BROWSER_OUTPUT: 13:13:44 INFO - 2015-11-20 13:13:44,829 INFO : Browser exited with error code: 0 13:13:44 INFO - 2015-11-20 13:13:44,847 INFO : Completed test v8_7 (00:00:39) 13:13:44 INFO - 2015-11-20 13:13:44,893 INFO : Completed test suite (00:20:13) 13:13:44 INFO - 2015-11-20 13:13:44,893 DEBUG : Working with test: dromaeo_css 13:13:44 INFO - 2015-11-20 13:13:44,893 DEBUG : Generating results file: dromaeo_css 13:13:44 INFO - 2015-11-20 13:13:44,894 DEBUG : Working with test: kraken 13:13:44 INFO - 2015-11-20 13:13:44,894 DEBUG : Generating results file: kraken 13:13:44 INFO - 2015-11-20 13:13:44,894 INFO : javascript benchmark 13:13:44 INFO - 2015-11-20 13:13:44,895 DEBUG : Working with test: v8_7 13:13:44 INFO - 2015-11-20 13:13:44,895 DEBUG : Generating results file: v8_7 13:13:44 INFO - 2015-11-20 13:13:44,895 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:44 INFO - 2015-11-20 13:13:44,945 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 13:13:44 INFO - 2015-11-20 13:13:44,945 DEBUG : process_Request line: dromaeo_css 7001.30 graph.html#tests=[[72,1,35]] 13:13:44 INFO - 2015-11-20 13:13:44,945 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:44 INFO - 2015-11-20 13:13:44,978 DEBUG : process_Request line: kraken 1497.30 graph.html#tests=[[232,1,35]] 13:13:44 INFO - 2015-11-20 13:13:44,978 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:45 INFO - 2015-11-20 13:13:45,007 DEBUG : process_Request line: v8_7 19939.71 graph.html#tests=[[230,1,35]] 13:13:45 INFO - 2015-11-20 13:13:45,008 INFO : javascript benchmark 13:13:45 INFO - 2015-11-20 13:13:45,012 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.809991400516, 3256.055743834288, 3300.3234336960927, 3306.785058971165, 3314.6022477302727, 5275.736213189335, 5384.623076384654, 5400.83797486075, 5417.26866872972, 5430.647007944481, 5310.15037593985, 5348.090824559825, 5355.437679043703, 5420.566354691625, 5424.349078110632, 4942.406911170656, 4969.080720066781, 4993.550580447759, 5013.749312534377, 5063.594912406998, 4860.878478038042, 5083.949160508403, 5092.618053645972, 5110.744462776865, 5153.845384638467, 4794.065157294312, 4925.655204135712, 4937.901241975141, 4948.851534453972, 5000.024995125952, 4972.254161875748, 4988.8503344899345, 5005.724685142316, 5008.223725322581, 5039.596832253411, 4832.275158726219, 4926.1379258629595, 4973.303737476756, 4980.576650984671, 5003.049420610072, 5243.659162154448, 5303.840884773463, 5310.893782124374, 5314.229436731653, 5322.148456246982, 5953.464188223081, 5954.851128721816, 5956.0, 5956.851078723023, 5958.910616340759, 5848.766049358021, 5906.557008224358, 5994.220751302347, 6007.128966299906, 6041.335453100155, 5580.693061881554, 5581.10702287632, 5583.246261754693, 5587.217789509472, 5630.211770352154, 6011.368806275365, 6029.698515074228, 6032.245969253843, 6035.0, 6035.456808887221, 5686.914696279559, 5799.043157878987, 5799.159121927381, 5834.854128646818, 5894.528437724972, 5890.263717035371, 5943.910841337383, 5946.226990491208, 5962.0, 5966.194563733927, 5845.181674565564, 5862.8534286642325, 5911.586188966817, 5921.940780592225, 5925.40745925404, 5804.535637149018, 5813.244278243801, 5822.301323841166, 5907.2911250650195, 5926.2295901532525, 4517.75152366623, 4547.8635640930825, 4567.0, 4570.7257564546235, 4616.422947131608, 3938.212357528506, 4042.636162745367, 4064.5935406459116, 4074.7351422157467, 4105.44576482177, 5511.476409741068, 5537.972310138504, 5573.275474188411, 5590.105583106683, 5654.717264136777, 5938.584299099108, 5943.70281485924, 5946.70266486674, 5956.225690660186, 5969.701514924236, 5394.083005889008, 5508.807191748269, 5597.412271711493, 5601.439856014366, 5602.52378547828, 4976.751162441863, 5054.342935418372, 5079.74601269935, 5082.2122571001555, 5102.744862756847, 6140.692965351804, 6148.938510614837, 6165.753369865155, 6165.876682466325, 6170.136180934673, 5909.468147866713, 5921.259842519685, 5947.881042379215, 5961.195238642727, 5970.552208584287, 5991.191189189403, 6042.758289668364, 6128.846778830565, 6132.540059495466, 6135.07973803933, 5793.304803423616, 5816.534677225896, 5830.7959221427045, 5841.532677385884, 5928.970355148197, 5879.941200587939, 5884.7940322088525, 5897.321807992136, 5901.852453688693, 5902.557308201816, 5653.010723123519, 5699.800506982236, 5753.338366087954, 5772.826815195551, 5873.970630146822, 5728.828135155952, 5731.398203188772, 5732.856678583069, 5737.454941780524, 5741.081426971831, 5620.072688006597, 5620.522255608319, 5631.8592035199445, 5635.126555383922, 5637.154426836008, 5605.159226116115, 5681.886362272814, 5729.2265544151005, 5744.626599271034, 5790.768369265183, 5697.971510142423, 5747.7413516391025, 5751.1085781703905, 5759.193712880116, 5768.423157684198], "unit": "ms", "name": "dojo.html", "value": 5428.762473846334}, {"lowerIsBetter": false, "replicates": [546.7721638002113, 594.8988671925772, 595.214317101426, 596.3350863786877, 599.322765275239, 31457.370852582964, 32257.51613725796, 32272.838635806816, 40114.19771604566, 40845.795771021105, 42980.570194298045, 43488.347674784905, 43642.12715745683, 43783.562164378345, 44098.0, 6644.900326495106, 6648.966755166218, 6654.43437307827, 6658.034584985175, 6659.7003134858805, 7668.156502784717, 7831.451798374116, 10425.687229383131, 10642.78714425711, 10647.52086156121, 10417.218708596847, 10451.0, 10540.472976351151, 10544.578216871316, 10549.367037977747, 7687.231276872324, 7869.64586593599, 10294.0, 10400.79198416035, 10402.427866467342, 10177.440240786755, 10537.683869483928, 10576.471176441148, 10582.99461551159, 10612.469376531142, 40411.191776164604, 40801.4917986071, 40832.591674083174, 40868.59131408678, 40881.182376352604, 3267.2158681916408, 3315.1049216711594, 3383.441732114198, 3398.575178102737, 3401.098708842159, 30429.391412171855, 30825.882165096544, 30868.0, 31336.843315783502, 31869.362612747846, 3733.4773131761576, 3778.527684039495, 3792.677622402099, 3794.582595914447, 3803.790791506466, 272203.1118755267, 272666.0, 273128.0, 273449.0, 273630.0, 58504.0, 58826.411735882946, 58853.0, 58896.705516473, 58960.70519647374, 57920.710396448594, 60000.0, 60052.09921851176, 61007.38992610106, 66735.66632166808, 15827.68344633101, 15873.603159920864, 16003.27985240667, 16013.199340032952, 16016.279267432994, 12230.266184028987, 12288.078394120477, 12299.0, 12308.81536776949, 12315.876841231653, 19143.2342706293, 19421.0, 19459.4162175135, 19504.512387190432, 19516.90241548783, 8146.959265203636, 8290.212429819157, 8313.792155196048, 8361.665533378718, 8369.455985360932, 963.330485312701, 973.756560859785, 1001.884783249921, 1029.6910926721953, 1072.126217133034, 24864.751352486604, 25099.37251568689, 25401.74598254031, 25601.359966001, 27524.58713119305, 1001.2441201691112, 1035.16151916946, 1105.4969988655143, 1117.1230583991528, 1173.8708742038368, 14224.075435096685, 14227.0, 14441.49454769078, 14457.277136143151, 15153.242337883283, 258632.0, 262612.0, 262937.0, 263099.0, 263563.0, 49719.25421118686, 49929.251061234114, 50003.749981249865, 50069.499305007215, 50156.498435015914, 1350.4058214385639, 1358.660334916271, 1361.8501964783866, 1376.6902446949557, 1393.2685340196276, 26019.739802601733, 27323.72676273212, 28690.56964145581, 29216.853915731135, 29334.0, 45169.54830451653, 45602.31596526121, 45635.0, 45646.77176614229, 45758.0, 300809.0, 301831.0, 302147.0, 302897.0, 303382.0, 26769.86615066912, 27962.300942475787, 28619.28451788722, 31841.840790795897, 32384.67615323911, 36933.44599830951, 37025.0, 37590.06024849401, 38052.42921356237, 38168.42747358736, 35264.29471410609, 35293.294134117685, 35339.64660353467, 35433.46849797203, 36250.63749362472, 28247.57628635531, 34744.478832817025, 35508.112297192776, 35659.46510802288, 36121.45817812682, 32276.515852261764, 32467.350652986337, 32588.511172332906, 32616.673833262314, 32625.0, 25861.48277034411, 29807.403851923274, 30231.0, 30385.696143038287, 30463.390732185675, 23150.652740209247, 23213.88393058024, 23214.25893058061, 23520.647190291817, 23536.176233831735], "unit": "ms", "name": "ext.html", "value": 18234.939692229284}, {"lowerIsBetter": false, "replicates": [353.8993729501252, 356.70928193522275, 356.7752316040894, 357.3424898187335, 360.4413159602616, 14286.928565357184, 14356.13863168208, 16330.83669163308, 17494.125293735327, 18912.716309255356, 16018.679626407466, 16236.431724889631, 16577.254023568938, 16634.58413539659, 16701.582460438494, 5365.731713414333, 5520.696361700105, 5529.419410961851, 5530.087535556629, 5533.584981126432, 4057.5333836608725, 4157.0, 5479.04116779564, 5523.143912693519, 5853.707314634251, 5940.316863560681, 5992.7902523411685, 5994.340622531518, 6032.758689652431, 6033.758649654031, 5253.553447956928, 5426.864328391802, 5431.728413579305, 5434.347878254595, 5977.790777322773, 5172.948270517322, 5199.4800519948085, 5215.817446389358, 5217.739113044333, 5428.511433970922, 11475.942620286929, 11678.124140689397, 11731.824022639667, 11744.471498782576, 11849.526018959232, 1971.7338159348592, 1995.720599116125, 2044.4479990402656, 2105.084288334564, 2154.138344662132, 9680.95159524205, 9708.951455242679, 10008.349457285325, 10020.69937901864, 10124.443155626437, 1731.333436626895, 1757.4376199616129, 1820.4629634257926, 1835.5411147213197, 1875.1186942137174, 56060.43939560593, 56118.43881561173, 63074.68462657657, 67056.66471667611, 68127.31872681259, 9955.452450115314, 10232.0, 10312.793744125076, 10320.071193592612, 10408.635697750693, 13510.324483775772, 13525.59423217305, 13556.186628802303, 13559.728805423836, 13565.660858478419, 7712.228777122243, 7722.073351197892, 7821.687132514636, 7823.921760782319, 7995.840083198304, 7612.429067819825, 7657.119431265364, 7666.769996900102, 7712.460127791113, 7713.3443657288635, 4437.2234858899565, 4542.931856022163, 4555.681102322806, 4560.95439045612, 4578.931316030262, 1751.20320254284, 1769.1066011664027, 1792.8834625749284, 1794.698843338569, 1869.560653246486, 946.1815529566875, 955.1403736637083, 995.5022488755623, 1025.3335332034237, 1030.0523518363125, 16272.43046493367, 16999.40502082421, 18053.368132115313, 18379.356722514647, 18454.35409760652, 911.9042500537481, 920.3557509743207, 930.06993006993, 959.2469911119738, 982.2044144243043, 9583.185429238454, 10445.68662940113, 10460.372377657364, 10483.0, 10526.368417894952, 486114.0, 494073.0, 496750.0, 497387.0, 505148.0, 76475.61762191153, 78732.6063369691, 78980.70702576262, 79279.0, 79783.20216797874, 1205.3852535207106, 1217.0567809947186, 1217.2635555488978, 1221.267239656199, 1236.863944966053, 15758.842411576195, 15775.447859324868, 15980.840191597936, 16088.356465741239, 16375.59061023484, 35621.0, 35698.286034279685, 35862.820685896404, 36102.4584631236, 36706.0, 45094.0, 47031.76484117557, 47485.762571186926, 47647.0, 47664.52335476601, 9645.42127472354, 9761.951190244003, 9902.158316543175, 9902.702918912444, 9920.751981200528, 11335.489902954221, 11419.0, 11419.25774824667, 11499.885001150216, 15760.290786914387, 11721.531138754355, 12215.69460763488, 13521.256330901895, 14846.257687115816, 15044.569312622389, 13855.16868987864, 13861.445542178604, 13866.445342186604, 14376.653603612498, 14677.412903484168, 11604.477798499256, 13099.934500327437, 14353.354099065358, 14767.556973290819, 15250.694986100438, 9595.23238140933, 9632.22942164611, 9728.562214700498, 9799.706008819747, 9814.312998090065, 10335.22485813582, 13874.236916969663, 14426.85573144255, 14441.277936103363, 14581.052231604912], "unit": "ms", "name": "jquery.html", "value": 8730.108111272819}, {"lowerIsBetter": false, "replicates": [1599.5603956439195, 1740.434358833379, 1790.5255107396533, 1799.0824679413495, 1835.807240239774, 6942.687579058942, 7530.35991940685, 7735.961320193405, 7740.071191457026, 7770.96114519428, 7601.809954751134, 7709.922900770991, 7713.961430192841, 7714.922850771491, 7715.884261736079, 2288.2220045184636, 2312.283192210412, 2318.6290193569034, 2319.257837492003, 2321.431249343913, 2330.265966220635, 2354.9175778847743, 2359.551685179819, 2360.0, 2364.148906393697, 2276.5105502316997, 2294.33464295355, 2298.6437102249092, 2302.297799171252, 2315.6758053872472, 2225.1989283857797, 2230.4535388829677, 2232.0290673556974, 2236.1055577768943, 2246.2924178883763, 2313.884305784704, 2319.420144963759, 2327.0459111764094, 2330.394097534653, 2330.941726456835, 6863.073485079501, 7029.789106326818, 7656.808579785495, 7683.462157648967, 7688.077430708351, 4566.360709500673, 4696.694714843558, 4702.3181638662545, 4713.764311784397, 4714.457837348715, 3070.355225402668, 3106.130283520618, 3166.2401023754132, 3171.6035495563056, 3175.412548678502, 976.4483067067084, 977.3549457358109, 986.8174387738292, 1012.2256473797551, 1028.7428142964259, 10347.896521034843, 10401.79196416075, 10463.581456741646, 10474.895251047468, 10495.685129446128, 4063.756174629532, 4154.584541545882, 4210.32634778434, 4224.387463817729, 4243.787810609457, 8516.61675224604, 8523.872141917876, 8544.359173061921, 8604.0, 8611.569421528899, 4601.677882548256, 4631.583157515773, 4637.188492013952, 4663.743494107789, 4678.976605116953, 4283.485981682155, 4303.978480107579, 4314.115606300701, 4347.673924455678, 4362.432883725095, 3404.3361544498584, 3445.9655403445645, 3455.1362159460136, 3461.0828130545424, 3472.6700963408434, 1049.5539395756773, 1057.3285963413289, 1059.7085801404676, 1062.946852657364, 1068.2095249515303, 1052.4737631184407, 1209.4376115106518, 1363.222962911151, 1388.632012516684, 1395.3860301467525, 7222.927770722331, 7254.96372518134, 7258.455615828834, 7270.63646817657, 7290.854182916312, 499.597823751876, 499.8850264439199, 1190.9344986025678, 1211.7091897944606, 1219.688979310288, 5458.536024437888, 5535.335759708861, 5822.854428639318, 5889.293284805851, 5895.941040589625, 8309.293710034593, 8918.598663060178, 9138.68014619485, 9202.861957070649, 9236.491992940453, 8958.19376256127, 9087.409318394415, 9089.81820363589, 9188.0, 9321.533923303943, 7146.2496437874315, 7218.963905180441, 7221.494495385273, 7236.34872861445, 7271.854562908818, 7037.120359955005, 7164.104486939133, 7169.318914703095, 7170.0, 7191.676374563262, 8000.199980001953, 8176.632051557575, 8207.302379297587, 8218.58907054633, 8243.505389676639, 8268.875966860382, 8418.0, 8428.45215061019, 8450.873236901329, 8529.402941794264, 6568.27748947625, 6591.143151390289, 6597.0, 6621.569597976116, 6642.302558231316, 7326.084239470067, 7438.107427108782, 7463.701451941862, 7467.813304667427, 7516.398688105048, 6977.267386924503, 7007.614581198083, 7088.645567721696, 7135.750248741269, 7163.964180179066, 6873.862522749417, 6953.548019378724, 7000.719971201299, 7079.8938015930835, 7121.715131394686, 6877.9656101721175, 6942.479314051366, 6949.444044476329, 6956.79129626112, 6967.0246165535855, 6157.507399408126, 6166.260048794174, 6210.192674952227, 6257.1240026395435, 6304.495640348853, 6370.58591191571, 6400.743970241325, 6401.0, 6401.263854656588, 6402.519811014099], "unit": "ms", "name": "mootools.html", "value": 4431.007198688057}, {"lowerIsBetter": false, "replicates": [322.3568979885129, 322.48724528000474, 331.8838406557704, 336.23338787564364, 340.91988382730057, 6043.728032238554, 6066.696665166735, 6085.513158947285, 6110.17512635794, 6201.3178550359535, 5817.767289308433, 5831.446012628804, 5963.463288304052, 6025.7948410318, 6049.697515124249, 4628.69913455626, 4651.674382793206, 4661.86014419568, 4683.836065737708, 4688.437387513486, 4434.490033646123, 4676.836310729125, 4677.111348843726, 4687.273472611751, 4687.9531204687855, 4493.213687604656, 4533.410656614636, 4652.023075154221, 4652.441706995149, 4666.393368862043, 4621.607163391116, 4623.74569398683, 4638.026014536951, 4640.280756482751, 4641.489436162003, 4047.028713108862, 4070.7761073140964, 4076.0, 4080.5307389650275, 4081.5306239782212, 5620.241267428885, 5743.971280143573, 5744.454276843735, 5749.741261643236, 5751.942480575224, 5269.578433725293, 5341.519263266325, 5355.116405793078, 5355.544778693816, 5358.571314294847, 6465.288818229991, 6468.191476065492, 6481.28705842357, 6482.157319548475, 6486.610803351767, 4410.75740834254, 4411.845585404495, 4414.53647367025, 4421.646268298528, 4426.203283408985, 6552.705128269192, 6623.370779775913, 6688.4649228061635, 6704.966475167642, 6710.698018589175, 4495.235809912323, 4505.256632655575, 4506.391637128946, 4510.616597589176, 4510.797014134372, 4554.567316104964, 4555.9772201138785, 4556.498785133633, 4560.1335746208115, 4560.8175672973375, 5323.441038690959, 5324.094903866352, 5329.493698098674, 5333.57331413486, 5345.625806193607, 6345.270293916166, 6505.284418713938, 6507.154069970874, 6513.381228783258, 6525.249596296392, 1598.5763772600271, 1630.4945466905297, 1631.3474610155795, 1631.6899789040044, 1635.860951819085, 1039.3504059962524, 1043.0612448796144, 1048.7168464514539, 1050.1283934334483, 1067.5214827463863, 6288.056791481315, 6293.024581189923, 6293.465055470337, 6293.653849038347, 6295.842603934847, 6512.73949042033, 6678.232003319583, 6722.159730033746, 6727.394534491919, 6731.764388246485, 6146.631202127886, 6216.813495595139, 6296.6851657417865, 6298.212723409574, 6303.495720342362, 3586.4620306953643, 3639.79981101042, 3640.4175331946763, 3647.1976165243605, 3652.123490362347, 6823.249442561314, 7005.5796652200015, 7005.649717514104, 7020.333068358498, 7022.227554968949, 6886.552374095668, 6906.861862762717, 6916.619585922722, 6917.89623155653, 6920.9653951729915, 7013.228544860061, 7016.5790052597, 7016.859662806715, 7017.122859642544, 7020.157581090302, 6598.274189839018, 6734.292899245509, 6738.59568425896, 6741.494387921024, 6746.494012949147, 6667.766628167991, 6670.566413183127, 6673.1992160941, 6679.732810687518, 6681.76613818514, 6890.655467226718, 6902.240753517009, 6907.309269073053, 6916.585004899722, 7025.789226323219, 4441.666874984325, 4544.522825103317, 4547.567981041796, 4547.886302842456, 4552.226121559276, 6717.026031225542, 6723.630200339028, 6724.4284235840505, 6730.966345168439, 6734.528582999143, 6544.083828264142, 6552.868942621216, 6553.934460655332, 6555.508336874849, 6560.212774467094, 6397.8720425592155, 6515.087887695821, 6544.28012918569, 6552.213734351908, 6558.278589355072, 6399.392057754506, 6399.648019358794, 6399.8080057598345, 6407.8718425630295, 6410.519211059096, 6567.408933196035, 6567.704453299518, 6575.704093315717, 6580.5722628029025, 6582.243042050225, 6303.054541818764, 6411.71147298382, 6426.903596446151, 6426.967865160645, 6437.195350581177], "unit": "ms", "name": "prototype.html", "value": 4868.174581453018}, {"lowerIsBetter": false, "replicates": [780.918003609621, 859.3369693718395, 859.5873980489368, 861.2980420956919, 897.7127319257836, 12048.397580120993, 12603.684907877308, 12614.621561353162, 12628.747425051493, 12681.239125652455, 12015.879841201586, 12131.514739410413, 12143.878561214386, 12145.817812732794, 12163.148579599409, 688.2876223109083, 692.0207905813268, 804.0712976512137, 828.8549503836834, 829.9792505187388, 822.9670813167467, 826.8263664630434, 831.9500829950192, 832.488019867783, 832.8167803083312, 725.7314793526376, 866.4108406283724, 873.2839071960994, 875.0330884372772, 875.2691502595341, 727.4725823777745, 867.483847110968, 871.9084496127879, 872.6640243506264, 874.8556488179443, 640.7917426836296, 640.817367050393, 642.0593830038969, 643.234550884446, 643.4016364780751, 12768.0, 12868.742625147539, 12887.93556032214, 12891.935540322238, 12932.935335323264, 12481.937590312082, 13094.083414161012, 13112.0, 13483.258420786853, 13496.730065398735, 10598.68203953875, 10599.735006624818, 10657.200709946708, 10761.461926903623, 10847.783044339149, 3627.4014787560022, 3640.253747981684, 3694.408894576855, 3712.6101759315425, 3795.1840354323676, 47940.0, 48068.27897581539, 48401.27398089031, 50044.74977625125, 50083.24875126876, 10496.26526143178, 10539.156867450585, 10568.256237720843, 10616.150707943347, 10965.671029869116, 19579.11893964775, 19589.0, 19598.0, 19603.803961960482, 19607.607847842963, 7783.571903545246, 7786.844263114819, 7801.414893882981, 7802.258785415376, 8010.839783204303, 4338.436003319548, 4354.085642015212, 4363.0401311712, 4399.14216727735, 4471.530489298577, 3019.9396012079637, 3072.60056192698, 3072.6466456357357, 3072.6927307269543, 3078.1381213260324, 545.8553483326922, 558.611764823452, 562.103445005216, 566.9518090962232, 573.0744847071949, 519.5064688545897, 587.3275100010464, 628.8710814283061, 686.5647914472464, 693.3586432549871, 8761.167689069656, 8921.643134274686, 8973.641054357753, 8982.505962172012, 9101.908980910239, 546.4098773324799, 684.7979845945458, 716.0691101567941, 725.2964624314407, 727.0729819480205, 3622.3117607654463, 4152.854650087233, 4209.221294060609, 4212.662986961036, 4309.5044069932355, 55102.44897550973, 55688.0, 55752.72123639356, 56345.0, 56644.71677641668, 53048.77743949617, 53391.46608533942, 53671.46328536743, 53683.19475207875, 54073.45926540684, 47482.76258618685, 47721.0, 47866.9999999993, 48070.75964620154, 48072.519274807506, 8091.919080809116, 8267.545285009142, 8394.328453723809, 8471.110533393905, 8536.103709110454, 34645.826770865984, 35173.47239791354, 35279.470807938415, 35777.0, 35914.0, 42772.786136069124, 42902.570974291106, 47449.28826067543, 48194.036119276716, 48308.27537586869, 9937.900620993987, 9982.35114717541, 10332.690019299433, 10453.686389408025, 10574.788504229718, 11467.713307167387, 11731.824022639497, 11818.527258909548, 12069.57756478519, 12099.0, 10240.231982601485, 10415.94792026035, 10480.318779279323, 10546.0, 11164.553417863195, 10749.140068794633, 11152.832707509557, 11193.944030279796, 11199.328040317607, 11480.942595287304, 10808.837867432152, 10898.836517452086, 11073.5570577176, 11186.440677966231, 11190.272632278877, 9211.447313161232, 9754.463504507321, 9854.26093043039, 10018.39889606626, 10079.798404032024, 8829.558522074, 8933.374663773473, 9263.0, 9614.18279446255, 9671.177949874058], "unit": "ms", "name": "yui.html", "value": 6317.441043981697}], "name": "dromaeo_css", "value": 7001.299477759201}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 110.0, 109.0, 110.0, 100.0, 112.0, 110.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 153.0, 163.0, 133.0, 162.0, 155.0, 128.0, 161.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 159.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 86.0, 98.0, 71.0, 73.0, 73.0, 129.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 137.0, 90.0, 91.0, 90.0, 132.0, 90.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 58.0, 57.0, 56.0, 57.0, 65.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 77.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [92.0, 87.0, 84.0, 85.0, 85.0, 84.0, 93.0, 94.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [114.0, 122.0, 117.0, 113.0, 118.0, 116.0, 123.0, 124.0, 121.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [140.0, 155.0, 150.0, 148.0, 150.0, 139.0, 161.0, 140.0, 147.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 64.0, 66.0, 66.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1497.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.89297931259162], "unit": "score", "name": "Richards", "value": 216.71897800000008}, {"lowerIsBetter": false, "replicates": [194.32568985619898], "unit": "score", "name": "DeltaBlue", "value": 340.2432279999999}, {"lowerIsBetter": false, "replicates": [287.2737719046251], "unit": "score", "name": "Encrypt", "value": 926.5760610000003}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [753.0120481927711], "unit": "score", "name": "Earley", "value": 885.0628639999996}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [595.2380952380952], "unit": "score", "name": "Splay", "value": 136.90488}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19939.711586999947}]} 13:13:45 INFO - RETURN: dromaeo_css: 7001.30 13:13:45 INFO - RETURN: kraken: 1497.30 13:13:45 INFO - RETURN: v8_7: 19939.71 13:13:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19939.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1497.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "7001.30"}}} 13:13:45 INFO - Return code: 0 13:13:45 INFO - # TBPL SUCCESS # 13:13:45 INFO - Running post-action listener: _resource_record_post_action 13:13:45 INFO - Running post-run listener: _resource_record_post_run 13:13:46 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507883520; Read time: 44; Write time: 575608 13:13:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221577216; Read time: 0; Write time: 366308 13:13:46 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286306304; Read time: 44; Write time: 209300 13:13:46 INFO - Running post-run listener: _upload_blobber_files 13:13:46 INFO - Blob upload gear active. 13:13:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:13:46 INFO - Copying logs to upload dir... 13:13:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.744308 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-20 13:13:46.026487) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:46.030535) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009929 build_url: 'https://queue.taskcluster.net/v1/task/ROlZscn1Rva0zbuR9-55lg/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-20 13:13:46.080909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:46.081274) ========= 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=c402a24d74c70935940d60dd000001de-1448051395.137919-1999987902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:13:46.131226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:13:46.131539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:13:46.131852) ========= ========= Total master_lag: 0.23 =========